builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0253 starttime: 1490175671.5 results: success (0) buildid: 20170322014835 builduid: 54440e30b0444d46a45f8d4dc6cbe85b revision: 908962e98a39fbc9655928f651e59df577de9f91 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 02:41:11.504472) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 02:41:11.504919) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 02:41:11.505195) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 02:41:11.531895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 02:41:11.532267) ========= 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.IFUIUl4IHY/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.2UB14kjP4x/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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-22 02:41:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.1M=0.001s 2017-03-22 02:41:11 (15.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144485 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 02:41:11.701202) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 02:41:11.701518) ========= 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.IFUIUl4IHY/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.2UB14kjP4x/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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.040273 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 02:41:11.763543) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-22 02:41:11.763900) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 908962e98a39fbc9655928f651e59df577de9f91 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 908962e98a39fbc9655928f651e59df577de9f91 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IFUIUl4IHY/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.2UB14kjP4x/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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-22 02:41:11,872 truncating revision to first 12 chars 2017-03-22 02:41:11,872 Setting DEBUG logging. 2017-03-22 02:41:11,872 attempt 1/10 2017-03-22 02:41:11,872 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/908962e98a39?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-22 02:41:12,936 unpacking tar archive at: mozilla-aurora-908962e98a39/testing/mozharness/ program finished with exit code 0 elapsedTime=1.340419 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-22 02:41:13.127517) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 02:41:13.127864) ========= script_repo_revision: 908962e98a39fbc9655928f651e59df577de9f91 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 02:41:13.128259) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 02:41:13.128522) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 02:41:13.148671) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-03-22 02:41:13.149070) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IFUIUl4IHY/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.2UB14kjP4x/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 02:41:13 INFO - MultiFileLogger online at 20170322 02:41:13 in /builds/slave/test 02:41:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:41:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:41:13 INFO - {'append_to_log': False, 02:41:13 INFO - 'base_work_dir': '/builds/slave/test', 02:41:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:41:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:41:13 INFO - 'branch': 'Mozilla-Aurora', 02:41:13 INFO - 'buildbot_json_path': 'buildprops.json', 02:41:13 INFO - 'config_files': ('talos/mac_config.py',), 02:41:13 INFO - 'default_actions': ('clobber', 02:41:13 INFO - 'read-buildbot-config', 02:41:13 INFO - 'download-and-extract', 02:41:13 INFO - 'populate-webroot', 02:41:13 INFO - 'create-virtualenv', 02:41:13 INFO - 'install', 02:41:13 INFO - 'run-tests'), 02:41:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:41:13 INFO - 'download_minidump_stackwalk': True, 02:41:13 INFO - 'download_symbols': 'ondemand', 02:41:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:41:13 INFO - 'tooltool.py': '/tools/tooltool.py', 02:41:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:41:13 INFO - '/tools/misc-python/virtualenv.py')}, 02:41:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:41:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:41:13 INFO - 'gecko_profile': False, 02:41:13 INFO - 'gecko_profile_interval': 0, 02:41:13 INFO - 'installer_path': 'installer.exe', 02:41:13 INFO - 'log_level': 'info', 02:41:13 INFO - 'log_name': 'talos', 02:41:13 INFO - 'log_to_console': True, 02:41:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:41:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:41:13 INFO - 'opt_config_files': (), 02:41:13 INFO - 'pip_index': False, 02:41:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:41:13 INFO - 'cmd': ('bash', 02:41:13 INFO - '-c', 02:41:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:41:13 INFO - 'enabled': True, 02:41:13 INFO - 'halt_on_failure': False, 02:41:13 INFO - 'name': 'check_screen_resolution'},), 02:41:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:41:13 INFO - 'cmd': ('bash', 02:41:13 INFO - '-c', 02:41:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:41:13 INFO - 'enabled': True, 02:41:13 INFO - 'halt_on_failure': False, 02:41:13 INFO - 'name': 'check_screen_resolution'},), 02:41:13 INFO - 'run_cmd_checks_enabled': True, 02:41:13 INFO - 'suite': 'dromaeojs-e10s', 02:41:13 INFO - 'system_bits': '32', 02:41:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:41:13 INFO - 'title': 't-yosemite-r7-0253', 02:41:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:41:13 INFO - 'use_talos_json': True, 02:41:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:41:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:41:13 INFO - 'work_dir': 'build'} 02:41:13 INFO - [mozharness: 2017-03-22 09:41:13.362916Z] Running clobber step. 02:41:13 INFO - Running pre-action listener: _resource_record_pre_action 02:41:13 INFO - Running main action method: clobber 02:41:13 INFO - rmtree: /builds/slave/test/build 02:41:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:41:15 INFO - Running post-action listener: _resource_record_post_action 02:41:15 INFO - [mozharness: 2017-03-22 09:41:15.840670Z] Finished clobber step (success) 02:41:15 INFO - [mozharness: 2017-03-22 09:41:15.840811Z] Running read-buildbot-config step. 02:41:15 INFO - Running pre-action listener: _resource_record_pre_action 02:41:15 INFO - Running main action method: read_buildbot_config 02:41:15 INFO - Using buildbot properties: 02:41:15 INFO - { 02:41:15 INFO - "project": "", 02:41:15 INFO - "product": "firefox", 02:41:15 INFO - "script_repo_revision": "production", 02:41:15 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:41:15 INFO - "repository": "", 02:41:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:41:15 INFO - "buildid": "20170322014835", 02:41:15 INFO - "pgo_build": "False", 02:41:15 INFO - "basedir": "/builds/slave/test", 02:41:15 INFO - "buildnumber": 2, 02:41:15 INFO - "slavename": "t-yosemite-r7-0253", 02:41:15 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:41:15 INFO - "platform": "yosemite_r7", 02:41:15 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:41:15 INFO - "branch": "mozilla-aurora", 02:41:15 INFO - "repo_path": "releases/mozilla-aurora", 02:41:15 INFO - "revision": "908962e98a39fbc9655928f651e59df577de9f91", 02:41:15 INFO - "stage_platform": "macosx64", 02:41:15 INFO - "builduid": "54440e30b0444d46a45f8d4dc6cbe85b", 02:41:15 INFO - "slavebuilddir": "test" 02:41:15 INFO - } 02:41:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 02:41:15 INFO - Running post-action listener: _resource_record_post_action 02:41:15 INFO - [mozharness: 2017-03-22 09:41:15.846270Z] Finished read-buildbot-config step (success) 02:41:15 INFO - [mozharness: 2017-03-22 09:41:15.846470Z] Running download-and-extract step. 02:41:15 INFO - Running pre-action listener: _resource_record_pre_action 02:41:15 INFO - Running main action method: download_and_extract 02:41:15 INFO - mkdir: /builds/slave/test/build/tests 02:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:41:15 INFO - trying https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 02:41:15 INFO - Downloading https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:41:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 02:41:16 INFO - Downloaded 1199 bytes. 02:41:16 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:41:16 INFO - Using the following test package requirements: 02:41:16 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:41:16 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:41:16 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 02:41:16 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:41:16 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 02:41:16 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:41:16 INFO - u'jsshell-mac.zip'], 02:41:16 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:41:16 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 02:41:16 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:41:16 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:41:16 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 02:41:16 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:41:16 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 02:41:16 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:41:16 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 02:41:16 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:41:16 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 02:41:16 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:41:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:41:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:41:16 INFO - Fetch https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:41:18 INFO - Expected file size: 51781898 02:41:18 INFO - Obtained file size: 51781898 02:41:33 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:41:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:41:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:41:33 INFO - Fetch https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:41:35 INFO - Expected file size: 51781898 02:41:35 INFO - Obtained file size: 51781898 02:41:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 02:41:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:41:50 INFO - Fetch https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 02:41:51 INFO - Expected file size: 14404438 02:41:51 INFO - Obtained file size: 14404438 02:41:51 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')]} 02:41:51 INFO - trying https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:41:51 INFO - Downloading https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 02:41:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 02:41:53 INFO - Downloaded 74705234 bytes. 02:41:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:41:53 INFO - mkdir: /builds/slave/test/properties 02:41:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:41:53 INFO - Writing to file /builds/slave/test/properties/build_url 02:41:53 INFO - Contents: 02:41:53 INFO - build_url:https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:41:55 INFO - Running post-action listener: _resource_record_post_action 02:41:55 INFO - Running post-action listener: set_extra_try_arguments 02:41:55 INFO - [mozharness: 2017-03-22 09:41:55.057985Z] Finished download-and-extract step (success) 02:41:55 INFO - [mozharness: 2017-03-22 09:41:55.058113Z] Running populate-webroot step. 02:41:55 INFO - Running pre-action listener: _resource_record_pre_action 02:41:55 INFO - Running main action method: populate_webroot 02:41:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:41:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:41:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:41:55 INFO - '--tppagecycles', 02:41:55 INFO - '7'], 02:41:55 INFO - 'tests': ['tsvgm']}}, 02:41:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:41:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:41:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:41:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:41:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:41:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:41:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:41:55 INFO - 'talos_options': ['--disable-e10s'], 02:41:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:41:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:41:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:41:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:41:55 INFO - 'talos_options': ['--disable-e10s'], 02:41:55 INFO - 'tests': ['damp', 'tps']}, 02:41:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:41:55 INFO - 'tests': ['damp', 'tps']}, 02:41:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:41:55 INFO - 'tests': ['dromaeo_dom']}, 02:41:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:41:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:41:55 INFO - 'tests': ['basic_compositor_video']}, 02:41:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:41:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:41:55 INFO - 'tests': ['a11yr', 02:41:55 INFO - 'ts_paint', 02:41:55 INFO - 'tpaint', 02:41:55 INFO - 'sessionrestore', 02:41:55 INFO - 'sessionrestore_no_auto_restore', 02:41:55 INFO - 'tabpaint']}, 02:41:55 INFO - 'other-e10s': {'tests': ['a11yr', 02:41:55 INFO - 'ts_paint', 02:41:55 INFO - 'tpaint', 02:41:55 INFO - 'sessionrestore', 02:41:55 INFO - 'sessionrestore_no_auto_restore', 02:41:55 INFO - 'tabpaint']}, 02:41:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:41:55 INFO - 'ts_paint', 02:41:55 INFO - 'tpaint', 02:41:55 INFO - 'sessionrestore', 02:41:55 INFO - 'sessionrestore_no_auto_restore', 02:41:55 INFO - 'tabpaint']}, 02:41:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:41:55 INFO - 'ts_paint', 02:41:55 INFO - 'tpaint', 02:41:55 INFO - 'sessionrestore', 02:41:55 INFO - 'sessionrestore_no_auto_restore', 02:41:55 INFO - 'tabpaint']}, 02:41:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:41:55 INFO - 'tests': ['a11yr', 02:41:55 INFO - 'ts_paint', 02:41:55 INFO - 'tpaint', 02:41:55 INFO - 'sessionrestore', 02:41:55 INFO - 'sessionrestore_no_auto_restore', 02:41:55 INFO - 'tabpaint']}, 02:41:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:41:55 INFO - 'tests': ['a11yr', 02:41:55 INFO - 'ts_paint', 02:41:55 INFO - 'tpaint', 02:41:55 INFO - 'sessionrestore', 02:41:55 INFO - 'sessionrestore_no_auto_restore', 02:41:55 INFO - 'tabpaint']}, 02:41:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:41:55 INFO - 'tests': ['tsvgx', 02:41:55 INFO - 'tsvgr_opacity', 02:41:55 INFO - 'tart', 02:41:55 INFO - 'tscrollx', 02:41:55 INFO - 'cart', 02:41:55 INFO - 'tsvg_static']}, 02:41:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:41:55 INFO - 'tsvgr_opacity', 02:41:55 INFO - 'tart', 02:41:55 INFO - 'tscrollx', 02:41:55 INFO - 'cart', 02:41:55 INFO - 'tsvg_static']}, 02:41:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:41:55 INFO - 'talos_options': ['--disable-e10s'], 02:41:55 INFO - 'tests': ['tp5o']}, 02:41:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:41:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:41:55 INFO - 'talos_options': ['--disable-e10s', 02:41:55 INFO - '--xperf_path', 02:41:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:41:55 INFO - 'tests': ['tp5n']}, 02:41:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:41:55 INFO - 'talos_options': ['--xperf_path', 02:41:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:41:55 INFO - 'tests': ['tp5n']}}, 02:41:55 INFO - 'talos.zip': {'path': '', 02:41:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:41:55 INFO - Running post-action listener: _resource_record_post_action 02:41:55 INFO - [mozharness: 2017-03-22 09:41:55.076638Z] Finished populate-webroot step (success) 02:41:55 INFO - [mozharness: 2017-03-22 09:41:55.076749Z] Running create-virtualenv step. 02:41:55 INFO - Running pre-action listener: _resource_record_pre_action 02:41:55 INFO - Running main action method: create_virtualenv 02:41:55 INFO - Creating virtualenv /builds/slave/test/build/venv 02:41:55 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 02:41:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:41:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:41:55 INFO - Using real prefix '/tools/python27' 02:41:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:41:55 INFO - Installing distribute.............................................................................................................................................................................................done. 02:41:58 INFO - Installing pip.................done. 02:41:58 INFO - Return code: 0 02:41:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:41:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:41:59 INFO - Reading from file tmpfile_stdout 02:41:59 INFO - Output received: 02:41:59 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) 02:41:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:41:59 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')]} 02:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:59 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')]} 02:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:59 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 0x108bc2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea635a4660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089a0d30>, '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 0x1088c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108995be8>, '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.IFUIUl4IHY/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.2UB14kjP4x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 02:41:59 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 02:41:59 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 02:41:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFUIUl4IHY/Render', 02:41:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:41:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:41:59 INFO - 'HOME': '/Users/cltbld', 02:41:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:41:59 INFO - 'LOGNAME': 'cltbld', 02:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:59 INFO - 'MOZ_NO_REMOTE': '1', 02:41:59 INFO - 'NO_EM_RESTART': '1', 02:41:59 INFO - 'PAGER': '/bin/cat', 02:41:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:59 INFO - 'PWD': '/builds/slave/test', 02:41:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:41:59 INFO - 'SHELL': '/bin/bash', 02:41:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2UB14kjP4x/Listeners', 02:41:59 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 02:41:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:41:59 INFO - 'USER': 'cltbld', 02:41:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:41:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:59 INFO - 'XPC_FLAGS': '0x0', 02:41:59 INFO - 'XPC_SERVICE_NAME': '0', 02:41:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:59 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 02:41:59 INFO - Cleaning up... 02:41:59 INFO - Return code: 0 02:41:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:41:59 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')]} 02:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:41:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:59 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')]} 02:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:41:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:41:59 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 0x108bc2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea635a4660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089a0d30>, '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 0x1088c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108995be8>, '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.IFUIUl4IHY/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.2UB14kjP4x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 02:41:59 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 02:41:59 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 02:41:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFUIUl4IHY/Render', 02:41:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:41:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:41:59 INFO - 'HOME': '/Users/cltbld', 02:41:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:41:59 INFO - 'LOGNAME': 'cltbld', 02:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:41:59 INFO - 'MOZ_NO_REMOTE': '1', 02:41:59 INFO - 'NO_EM_RESTART': '1', 02:41:59 INFO - 'PAGER': '/bin/cat', 02:41:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:41:59 INFO - 'PWD': '/builds/slave/test', 02:41:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:41:59 INFO - 'SHELL': '/bin/bash', 02:41:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2UB14kjP4x/Listeners', 02:41:59 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 02:41:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:41:59 INFO - 'USER': 'cltbld', 02:41:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:41:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:41:59 INFO - 'XPC_FLAGS': '0x0', 02:41:59 INFO - 'XPC_SERVICE_NAME': '0', 02:41:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:41:59 INFO - Downloading/unpacking psutil>=3.1.1 02:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:41:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:41:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:42:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:42:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:42:03 INFO - Installing collected packages: psutil 02:42:03 INFO - Running setup.py install for psutil 02:42:03 INFO - building 'psutil._psutil_osx' extension 02:42:03 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 02:42:03 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 02:42:03 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 02:42:03 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 02:42:04 INFO - building 'psutil._psutil_posix' extension 02:42:04 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 02:42:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:42:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:42:04 INFO - ^ 02:42:04 INFO - 1 warning generated. 02:42:04 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 02:42:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:42:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:42:04 INFO - Successfully installed psutil 02:42:04 INFO - Cleaning up... 02:42:04 INFO - Return code: 0 02:42:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108bc2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea635a4660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089a0d30>, '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 0x1088c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108995be8>, '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.IFUIUl4IHY/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.2UB14kjP4x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 02:42:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:42:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:42:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFUIUl4IHY/Render', 02:42:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:04 INFO - 'HOME': '/Users/cltbld', 02:42:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:04 INFO - 'LOGNAME': 'cltbld', 02:42:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:04 INFO - 'MOZ_NO_REMOTE': '1', 02:42:04 INFO - 'NO_EM_RESTART': '1', 02:42:04 INFO - 'PAGER': '/bin/cat', 02:42:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:04 INFO - 'PWD': '/builds/slave/test', 02:42:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:04 INFO - 'SHELL': '/bin/bash', 02:42:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2UB14kjP4x/Listeners', 02:42:04 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 02:42:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:04 INFO - 'USER': 'cltbld', 02:42:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:04 INFO - 'XPC_FLAGS': '0x0', 02:42:04 INFO - 'XPC_SERVICE_NAME': '0', 02:42:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:42: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 02:42: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 02:42: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 02:42: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 02:42: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 02:42: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 02:42:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:42:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:42:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:42:07 INFO - Installing collected packages: mozsystemmonitor 02:42:07 INFO - Running setup.py install for mozsystemmonitor 02:42:07 INFO - Successfully installed mozsystemmonitor 02:42:07 INFO - Cleaning up... 02:42:07 INFO - Return code: 0 02:42:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:42: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')]} 02:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42: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')]} 02:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:08 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 0x108bc2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea635a4660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089a0d30>, '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 0x1088c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108995be8>, '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.IFUIUl4IHY/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.2UB14kjP4x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 02:42:08 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 02:42:08 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 02:42:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFUIUl4IHY/Render', 02:42:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:08 INFO - 'HOME': '/Users/cltbld', 02:42:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:08 INFO - 'LOGNAME': 'cltbld', 02:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:08 INFO - 'MOZ_NO_REMOTE': '1', 02:42:08 INFO - 'NO_EM_RESTART': '1', 02:42:08 INFO - 'PAGER': '/bin/cat', 02:42:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:08 INFO - 'PWD': '/builds/slave/test', 02:42:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:08 INFO - 'SHELL': '/bin/bash', 02:42:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2UB14kjP4x/Listeners', 02:42:08 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 02:42:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:08 INFO - 'USER': 'cltbld', 02:42:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:08 INFO - 'XPC_FLAGS': '0x0', 02:42:08 INFO - 'XPC_SERVICE_NAME': '0', 02:42:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:08 INFO - Downloading/unpacking jsonschema==2.5.1 02:42:08 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 02:42:08 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 02:42:08 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 02:42:08 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 02:42:08 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 02:42:08 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 02:42:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:42:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:42: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 02:42: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 02:42: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 02:42: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 02:42: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 02:42: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 02:42:12 INFO - Downloading functools32-3.2.3-2.tar.gz 02:42:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:42:12 INFO - warning: no files found matching '*.txt' 02:42:12 INFO - no previously-included directories found matching 'build' 02:42:12 INFO - no previously-included directories found matching 'dist' 02:42:12 INFO - no previously-included directories found matching '.git*' 02:42:12 INFO - Installing collected packages: jsonschema, functools32 02:42:12 INFO - Running setup.py install for functools32 02:42:12 INFO - warning: no files found matching '*.txt' 02:42:12 INFO - no previously-included directories found matching 'build' 02:42:12 INFO - no previously-included directories found matching 'dist' 02:42:12 INFO - no previously-included directories found matching '.git*' 02:42:12 INFO - Successfully installed jsonschema functools32 02:42:12 INFO - Cleaning up... 02:42:12 INFO - Return code: 0 02:42:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:42: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')]} 02:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42: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')]} 02:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:12 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 0x108bc2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea635a4660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089a0d30>, '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 0x1088c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108995be8>, '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.IFUIUl4IHY/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.2UB14kjP4x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 02:42:12 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 02:42:12 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 02:42:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFUIUl4IHY/Render', 02:42:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:12 INFO - 'HOME': '/Users/cltbld', 02:42:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:12 INFO - 'LOGNAME': 'cltbld', 02:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:12 INFO - 'MOZ_NO_REMOTE': '1', 02:42:12 INFO - 'NO_EM_RESTART': '1', 02:42:12 INFO - 'PAGER': '/bin/cat', 02:42:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:12 INFO - 'PWD': '/builds/slave/test', 02:42:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:12 INFO - 'SHELL': '/bin/bash', 02:42:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2UB14kjP4x/Listeners', 02:42:12 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 02:42:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:12 INFO - 'USER': 'cltbld', 02:42:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:12 INFO - 'XPC_FLAGS': '0x0', 02:42:12 INFO - 'XPC_SERVICE_NAME': '0', 02:42:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:42:12 INFO - Cleaning up... 02:42:12 INFO - Return code: 0 02:42:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:42: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')]} 02:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42: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')]} 02:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:12 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 0x108bc2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea635a4660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089a0d30>, '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 0x1088c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108995be8>, '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.IFUIUl4IHY/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.2UB14kjP4x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 02:42:12 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 02:42:12 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 02:42:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFUIUl4IHY/Render', 02:42:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:12 INFO - 'HOME': '/Users/cltbld', 02:42:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:12 INFO - 'LOGNAME': 'cltbld', 02:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:12 INFO - 'MOZ_NO_REMOTE': '1', 02:42:12 INFO - 'NO_EM_RESTART': '1', 02:42:12 INFO - 'PAGER': '/bin/cat', 02:42:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:12 INFO - 'PWD': '/builds/slave/test', 02:42:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:12 INFO - 'SHELL': '/bin/bash', 02:42:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2UB14kjP4x/Listeners', 02:42:12 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 02:42:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:12 INFO - 'USER': 'cltbld', 02:42:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:12 INFO - 'XPC_FLAGS': '0x0', 02:42:12 INFO - 'XPC_SERVICE_NAME': '0', 02:42:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:12 INFO - Downloading/unpacking blobuploader==1.2.4 02:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:15 INFO - Downloading blobuploader-1.2.4.tar.gz 02:42:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:42:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:42:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:42:16 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 02:42:16 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 02:42:16 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 02:42:16 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 02:42:16 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 02:42:16 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 02:42:16 INFO - Downloading docopt-0.6.1.tar.gz 02:42:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:42:17 INFO - Installing collected packages: blobuploader, requests, docopt 02:42:17 INFO - Running setup.py install for blobuploader 02:42:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:42:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:42:17 INFO - Running setup.py install for requests 02:42:17 INFO - Running setup.py install for docopt 02:42:17 INFO - Successfully installed blobuploader requests docopt 02:42:17 INFO - Cleaning up... 02:42:17 INFO - Return code: 0 02:42:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:42: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')]} 02:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42: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')]} 02:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:17 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 0x108bc2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea635a4660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089a0d30>, '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 0x1088c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108995be8>, '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.IFUIUl4IHY/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.2UB14kjP4x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 02:42:17 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 02:42:17 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 02:42:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFUIUl4IHY/Render', 02:42:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:17 INFO - 'HOME': '/Users/cltbld', 02:42:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:17 INFO - 'LOGNAME': 'cltbld', 02:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:17 INFO - 'MOZ_NO_REMOTE': '1', 02:42:17 INFO - 'NO_EM_RESTART': '1', 02:42:17 INFO - 'PAGER': '/bin/cat', 02:42:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:17 INFO - 'PWD': '/builds/slave/test', 02:42:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:17 INFO - 'SHELL': '/bin/bash', 02:42:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2UB14kjP4x/Listeners', 02:42:17 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 02:42:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:17 INFO - 'USER': 'cltbld', 02:42:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:17 INFO - 'XPC_FLAGS': '0x0', 02:42:17 INFO - 'XPC_SERVICE_NAME': '0', 02:42:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:42:18 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-5wor6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:42:18 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-XroHFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:42:18 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-vLnLNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:42:18 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-7n4ZO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:42:18 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-PJqncP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:42:18 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-au5PMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:42:18 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-zBK7WG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:42:18 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-PxFB5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:42:19 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-_T7LJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:42:19 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-zzujj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:42:19 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-Fc82aQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:42:19 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-QV6IjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:42:19 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-7O2TVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:42:19 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-owQmY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:19 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-nXTxd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:42:19 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-r30R_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:42:19 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-ifjn7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:42:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:42:19 INFO - Running setup.py install for manifestparser 02:42:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:42:20 INFO - Running setup.py install for mozcrash 02:42:20 INFO - Running setup.py install for mozdebug 02:42:20 INFO - Running setup.py install for mozdevice 02:42:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:42:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:42:20 INFO - Running setup.py install for mozfile 02:42:20 INFO - Running setup.py install for mozhttpd 02:42:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:42:20 INFO - Running setup.py install for mozinfo 02:42:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:42:20 INFO - Running setup.py install for mozInstall 02:42:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:42:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:42:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:42:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:42:21 INFO - Running setup.py install for mozleak 02:42:21 INFO - Running setup.py install for mozlog 02:42:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:42:21 INFO - Running setup.py install for moznetwork 02:42:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:42:21 INFO - Running setup.py install for mozprocess 02:42:21 INFO - Running setup.py install for mozprofile 02:42:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:42:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:42:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:42:21 INFO - Running setup.py install for mozrunner 02:42:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:42:22 INFO - Running setup.py install for mozscreenshot 02:42:22 INFO - Running setup.py install for moztest 02:42:22 INFO - Running setup.py install for mozversion 02:42:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:42:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:42:22 INFO - Cleaning up... 02:42:22 INFO - Return code: 0 02:42:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:42: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')]} 02:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42: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')]} 02:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:22 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 0x108bc2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea635a4660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089a0d30>, '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 0x1088c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108995be8>, '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.IFUIUl4IHY/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.2UB14kjP4x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 02:42:22 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 02:42:22 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 02:42:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFUIUl4IHY/Render', 02:42:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:22 INFO - 'HOME': '/Users/cltbld', 02:42:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:22 INFO - 'LOGNAME': 'cltbld', 02:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:22 INFO - 'MOZ_NO_REMOTE': '1', 02:42:22 INFO - 'NO_EM_RESTART': '1', 02:42:22 INFO - 'PAGER': '/bin/cat', 02:42:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:22 INFO - 'PWD': '/builds/slave/test', 02:42:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:22 INFO - 'SHELL': '/bin/bash', 02:42:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2UB14kjP4x/Listeners', 02:42:22 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 02:42:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:22 INFO - 'USER': 'cltbld', 02:42:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:22 INFO - 'XPC_FLAGS': '0x0', 02:42:22 INFO - 'XPC_SERVICE_NAME': '0', 02:42:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:42:22 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-Nul7jQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:42:22 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)) 02:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:42:22 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-MqSeXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:42:23 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)) 02:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:42:23 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-j_uXte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:42:23 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)) 02:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:42:23 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-PZ1ru6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:42:23 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)) 02:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:42:23 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-IqHHqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:42:23 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)) 02:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:42:23 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-OTOeXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:42:23 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)) 02:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:42:23 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-PiCO9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:42:23 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)) 02:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:42:23 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-YxrKZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:42:23 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)) 02:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:42:23 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-gYLCvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:42:23 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)) 02:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:42:23 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-2Oef53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:42:23 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)) 02:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:42:23 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-jJ6oMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:42:23 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)) 02:42:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:42:23 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-QBMPnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:42:24 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)) 02:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:42:24 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-gUYHEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:42:24 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)) 02:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:42:24 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-taRxjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:42:24 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)) 02:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:24 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-mkOhrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:24 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)) 02:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:42:24 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-48JP8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:42:24 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)) 02:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:42:24 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-FeV7GV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:42:24 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)) 02:42:24 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)) 02:42:24 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)) 02:42:24 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)) 02:42:24 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)) 02:42:24 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)) 02:42:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:42:24 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 02:42:24 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 02:42:24 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 02:42:24 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 02:42:24 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 02:42:24 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 02:42:27 INFO - Downloading blessings-1.6.tar.gz 02:42:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:42:27 INFO - Installing collected packages: blessings 02:42:27 INFO - Running setup.py install for blessings 02:42:27 INFO - Successfully installed blessings 02:42:27 INFO - Cleaning up... 02:42:27 INFO - Return code: 0 02:42:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:42:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:42:27 INFO - Reading from file tmpfile_stdout 02:42:27 INFO - Current package versions: 02:42:27 INFO - blessings == 1.6 02:42:27 INFO - blobuploader == 1.2.4 02:42:27 INFO - docopt == 0.6.1 02:42:27 INFO - functools32 == 3.2.3-2 02:42:27 INFO - jsonschema == 2.5.1 02:42:27 INFO - manifestparser == 1.1 02:42:27 INFO - mozInstall == 1.12 02:42:27 INFO - mozcrash == 1.0 02:42:27 INFO - mozdebug == 0.1 02:42:27 INFO - mozdevice == 0.49 02:42:27 INFO - mozfile == 1.2 02:42:27 INFO - mozhttpd == 0.7 02:42:27 INFO - mozinfo == 0.9 02:42:27 INFO - mozleak == 0.1 02:42:27 INFO - mozlog == 3.4 02:42:27 INFO - moznetwork == 0.27 02:42:27 INFO - mozprocess == 0.25 02:42:27 INFO - mozprofile == 0.28 02:42:27 INFO - mozrunner == 6.13 02:42:27 INFO - mozscreenshot == 0.1 02:42:27 INFO - mozsystemmonitor == 0.3 02:42:27 INFO - moztest == 0.8 02:42:27 INFO - mozversion == 1.4 02:42:27 INFO - psutil == 3.1.1 02:42:27 INFO - requests == 1.2.3 02:42:27 INFO - wsgiref == 0.1.2 02:42:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:42:27 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')]} 02:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:27 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')]} 02:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:27 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 0x108bc2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea635a4660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089a0d30>, '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 0x1088c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108995be8>, '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.IFUIUl4IHY/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.2UB14kjP4x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 02:42:27 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 02:42:27 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 02:42:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFUIUl4IHY/Render', 02:42:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:27 INFO - 'HOME': '/Users/cltbld', 02:42:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:27 INFO - 'LOGNAME': 'cltbld', 02:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:27 INFO - 'MOZ_NO_REMOTE': '1', 02:42:27 INFO - 'NO_EM_RESTART': '1', 02:42:27 INFO - 'PAGER': '/bin/cat', 02:42:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:27 INFO - 'PWD': '/builds/slave/test', 02:42:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:27 INFO - 'SHELL': '/bin/bash', 02:42:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2UB14kjP4x/Listeners', 02:42:27 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 02:42:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:27 INFO - 'USER': 'cltbld', 02:42:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:27 INFO - 'XPC_FLAGS': '0x0', 02:42:27 INFO - 'XPC_SERVICE_NAME': '0', 02:42:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:28 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)) 02:42:28 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)) 02:42:28 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)) 02:42:28 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)) 02:42:28 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)) 02:42:28 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)) 02:42:28 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)) 02:42:28 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)) 02:42:28 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)) 02:42:28 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)) 02:42:28 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)) 02:42:28 INFO - Cleaning up... 02:42:28 INFO - Return code: 0 02:42:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108bc2b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108bc5768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea635a4660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1089a0d30>, '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 0x1088c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108995be8>, '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.IFUIUl4IHY/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.2UB14kjP4x/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 02:42:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:42:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFUIUl4IHY/Render', 02:42:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:28 INFO - 'HOME': '/Users/cltbld', 02:42:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:28 INFO - 'LOGNAME': 'cltbld', 02:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:28 INFO - 'MOZ_NO_REMOTE': '1', 02:42:28 INFO - 'NO_EM_RESTART': '1', 02:42:28 INFO - 'PAGER': '/bin/cat', 02:42:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:28 INFO - 'PWD': '/builds/slave/test', 02:42:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:28 INFO - 'SHELL': '/bin/bash', 02:42:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2UB14kjP4x/Listeners', 02:42:28 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 02:42:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:28 INFO - 'USER': 'cltbld', 02:42:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:28 INFO - 'XPC_FLAGS': '0x0', 02:42:28 INFO - 'XPC_SERVICE_NAME': '0', 02:42:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:42:28 INFO - Cleaning up... 02:42:28 INFO - Return code: 0 02:42:28 INFO - Running post-action listener: _resource_record_post_action 02:42:28 INFO - Running post-action listener: _start_resource_monitoring 02:42:28 INFO - Starting resource monitoring. 02:42:28 INFO - [mozharness: 2017-03-22 09:42:28.436076Z] Finished create-virtualenv step (success) 02:42:28 INFO - [mozharness: 2017-03-22 09:42:28.436869Z] Running install step. 02:42:28 INFO - Running pre-action listener: _resource_record_pre_action 02:42:28 INFO - Running main action method: install 02:42:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:42:28 INFO - Reading from file tmpfile_stdout 02:42:28 INFO - Detecting whether we're running mozinstall >=1.0... 02:42:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:42:28 INFO - Reading from file tmpfile_stdout 02:42:28 INFO - Output received: 02:42:28 INFO - Usage: mozinstall [options] installer 02:42:28 INFO - Options: 02:42:28 INFO - -h, --help show this help message and exit 02:42:28 INFO - -d DEST, --destination=DEST 02:42:28 INFO - Directory to install application into. [default: 02:42:28 INFO - "/builds/slave/test"] 02:42:28 INFO - --app=APP Application being installed. [default: firefox] 02:42:28 INFO - mkdir: /builds/slave/test/build/application 02:42:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:42:48 INFO - Reading from file tmpfile_stdout 02:42:48 INFO - Output received: 02:42:48 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:42:48 INFO - Running post-action listener: _resource_record_post_action 02:42:48 INFO - [mozharness: 2017-03-22 09:42:48.928369Z] Finished install step (success) 02:42:48 INFO - [mozharness: 2017-03-22 09:42:48.928537Z] Running run-tests step. 02:42:48 INFO - Running pre-action listener: _resource_record_pre_action 02:42:48 INFO - Running main action method: run_tests 02:42:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:42:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:42:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:42:48 INFO - 2017-03-22 02:42:48.943 screenresolution[1624:7272] starting screenresolution argv=screenresolution get 02:42:48 INFO - 2017-03-22 02:42:48.945 screenresolution[1624:7272] Display 0: 1600x1200x32@60 02:42:48 INFO - 2017-03-22 02:42:48.951 screenresolution[1625:7275] starting screenresolution argv=screenresolution list 02:42:48 INFO - Available Modes on Display 0 02:42:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:42:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:42:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:42:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:42:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:42:49 INFO - Intel Iris: 02:42:49 INFO - Chipset Model: Intel Iris 02:42:49 INFO - Type: GPU 02:42:49 INFO - Bus: Built-In 02:42:49 INFO - VRAM (Dynamic, Max): 1536 MB 02:42:49 INFO - Vendor: Intel (0x8086) 02:42:49 INFO - Device ID: 0x0a2e 02:42:49 INFO - Revision ID: 0x0009 02:42:49 INFO - Displays: 02:42:49 INFO - Display: 02:42:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:42:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:42:49 INFO - Display Serial Number: 1600x1200 60 02:42:49 INFO - Main Display: Yes 02:42:49 INFO - Mirror: Off 02:42:49 INFO - Online: Yes 02:42:49 INFO - Rotation: Supported 02:42:49 INFO - Return code: 0 02:42:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:42:49 INFO - Python 2.7.3 02:42:49 INFO - Return code: 0 02:42:49 INFO - grabbing minidump binary from tooltool 02:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:42:49 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 0x1089a0d30>, '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 0x1088c7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108995be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:42:49 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 02:42:49 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 02:42:49 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 02:42:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:42:49 INFO - Return code: 0 02:42:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:42:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:42:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:42:49 INFO - ENV: RUST_BACKTRACE is now 1 02:42:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:42:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:42:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0253', '--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 02:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0253 --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 02:42:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IFUIUl4IHY/Render', 02:42:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:49 INFO - 'HOME': '/Users/cltbld', 02:42:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:49 INFO - 'LOGNAME': 'cltbld', 02:42:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:42:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:49 INFO - 'MOZ_NO_REMOTE': '1', 02:42:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:42:49 INFO - 'NO_EM_RESTART': '1', 02:42:49 INFO - 'PAGER': '/bin/cat', 02:42:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:49 INFO - 'PWD': '/builds/slave/test', 02:42:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:42:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:49 INFO - 'RUST_BACKTRACE': '1', 02:42:49 INFO - 'SHELL': '/bin/bash', 02:42:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2UB14kjP4x/Listeners', 02:42:49 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 02:42:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:49 INFO - 'USER': 'cltbld', 02:42:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:49 INFO - 'XPC_FLAGS': '0x0', 02:42:49 INFO - 'XPC_SERVICE_NAME': '0', 02:42:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0253', '--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 02:42:49 INFO - mozversion application_buildid: 20170322014835 02:42:49 INFO - mozversion application_changeset: 908962e98a39fbc9655928f651e59df577de9f91 02:42:49 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:42:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:42:49 INFO - mozversion application_name: Firefox 02:42:49 INFO - mozversion application_remotingname: firefox-dev 02:42:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:42:49 INFO - mozversion application_vendor: Mozilla 02:42:49 INFO - mozversion application_version: 54.0a2 02:42:49 INFO - mozversion platform_buildid: 20170322014835 02:42:49 INFO - mozversion platform_changeset: 908962e98a39fbc9655928f651e59df577de9f91 02:42:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:42:49 INFO - mozversion platform_version: 54.0a2 02:42:49 INFO - using testdate: 1490175769 02:42:49 INFO - actual date: 1490175769 02:42:49 INFO - starting webserver on 'localhost:49239' 02:42:49 INFO - SUITE-START | Running 2 tests 02:42:49 INFO - TEST-START | dromaeo_css 02:42:49 INFO - operating with platform_type : mac_ 02:42:49 INFO - Initialising browser for dromaeo_css test... 02:42:49 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpB8l_v6/profile http://localhost:49239/getInfo.html) 02:42:52 INFO - PROCESS | 1635 | 2017-03-22 02:42:52.289 plugin-container[1637:7457] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 02:42:52 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:42:52 INFO - PROCESS | 1635 | 2017-03-22 02:42:52.292 plugin-container[1637:7457] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 02:42:52 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:42:52 INFO - PROCESS | 1635 | 2017-03-22 02:42:52.292 plugin-container[1637:7457] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:42:52 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 02:42:52 INFO - PROCESS | 1635 | colorDepth:24 02:42:52 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 02:42:52 INFO - PROCESS | 1635 | __metrics 02:42:52 ERROR - PROCESS | 1635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 02:42:53 INFO - TEST-INFO | 1635: exit 0 02:42:53 INFO - Browser initialized. 02:42:53 INFO - Running cycle 1/1 for dromaeo_css test... 02:42:53 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpB8l_v6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:42:55 INFO - PROCESS | 1638 | 2017-03-22 02:42:55.717 plugin-container[1639:7583] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 02:42:55 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:42:55 INFO - PROCESS | 1638 | 2017-03-22 02:42:55.718 plugin-container[1639:7583] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x920b, name = 'com.apple.CFPasteboardClient' 02:42:55 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:42:55 INFO - PROCESS | 1638 | 2017-03-22 02:42:55.718 plugin-container[1639:7583] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:43:05 INFO - PROCESS | 1638 | RSS: Main: 220745728 02:43:05 INFO - PROCESS | 1638 | 02:46:08 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49239/tests/dromaeo/cssquery-ext.html) 02:46:10 INFO - PROCESS | 1638 | RSS: Main: 239112192 02:46:10 INFO - PROCESS | 1638 | 02:47:53 INFO - PROCESS | 1638 | ************************* 02:47:53 INFO - PROCESS | 1638 | A coding exception was thrown and uncaught in a Task. 02:47:53 INFO - PROCESS | 1638 | 02:47:53 ERROR - PROCESS | 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:47:53 INFO - PROCESS | 1638 | Full stack: 02:47:53 INFO - PROCESS | 1638 | ************************* 02:49:12 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-ext.html (next: http://localhost:49239/tests/dromaeo/cssquery-jquery.html) 02:49:13 INFO - PROCESS | 1638 | RSS: Main: 248074240 02:49:13 INFO - PROCESS | 1638 | 02:52:15 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49239/tests/dromaeo/cssquery-mootools.html) 02:52:15 INFO - PROCESS | 1638 | RSS: Main: 255557632 02:52:15 INFO - PROCESS | 1638 | 02:55:17 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49239/tests/dromaeo/cssquery-prototype.html) 02:55:18 INFO - PROCESS | 1638 | RSS: Main: 251723776 02:55:18 INFO - PROCESS | 1638 | 02:58:21 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49239/tests/dromaeo/cssquery-yui.html) 02:58:22 INFO - PROCESS | 1638 | RSS: Main: 257093632 02:58:22 INFO - PROCESS | 1638 | 03:01:24 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-yui.html (next: http://localhost:49239/tests/dromaeo/cssquery-dojo.html) 03:01:25 INFO - PROCESS | 1638 | RSS: Main: 253227008 03:01:25 INFO - PROCESS | 1638 | 03:01:25 INFO - PROCESS | 1638 | __start_tp_report 03:01:25 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 03:01:25 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 03:01:25 INFO - PROCESS | 1638 | |i|pagename|runs| 03:01:25 INFO - PROCESS | 1638 | |0;dojo.html;2836.361818590817;3208.374366998435;3306.6693330666935;3424.7088997435217;3476.1483436558046;5809;5893.939090963625;5908.911366329503;5944.673042982639;5948.524118070555;5853.5902486825835;5938;5938.792142275021;5948.88102237955;5966.8806623867495;5288.550473209782;5314.309139811829;5384.326959130109;5418.376886658026;5419.485148910847;5434.673919564819;5447.101228297326;5454.1102789385;5461.344638643349;5466.289382380285;5260.526552610264;5264.789408423659;5452.2094296327205;5462.126059830408;5521.199426083215;5365.436629153941;5386.057439947994;5413.512783849433;5422.620416570841;5441.673499589998;5241.9737901310245;5345.1714984177515;5363.731813409314;5384.353877534721;5395.78416863325;5630.887382252332;5815.912761308584;5928.64428134309;5978.8505287367725;5994.550408719363;6285.277193122758;6287.371262873722;6287.874242515124;6335.3981371769605;6392.808215753488;6372.776952806629;6392.1370614966845;6400.967995160041;6407.295197528269;6420.582662126947;6017.856607244609;6069.787557435468;6089.543284253655;6116.96941515294;6119.602225855394;6305.274893387227;6345.777897773556;6365.840853978595;6484.416402523795;6487.967560162169;6245.5628106033055;6272.090546870678;6303.432691057735;6312.715927783261;6335.619862808247;5097.949020509747;6339.904901426482;6374.840628984312;6404.071409645669;6408.03879418091;6139.9828168395225;6217.316095229521;6351.364863513704;6394.648294343763;6408.1349017881985;6171.814845554641;6293.213348331458;6341.619502829845;6378.138951241523;6379.106925030499;4971.90056198874;4998;5012.774425150877;5084.313617661568;5093.719845408538;4516.932246016312;4538.183127037165;4558.156741002858;4558.407407037131;4582.725036497821;5754.74103665336;5995;6027.095935609694;6047.183630209954;6055.394460553997;6297.4332310091395;6329.7468101275435;6359.904601430982;6400;6404.23149222087;6050.485708714808;6074.271087469444;6082.434169232198;6092.299385570716;6093.756249750049;4755.83354582588;5397.136458166675;5554.1946417769195;5594.104943209067;5624.240727501817;6357.046443033582;6412.97392417211;6460.773872914426;6475.158229430144;6501.707423166064;6027.517798576016;6353.332900045429;6354.936450635434;6397.040443933447;6398.488120950406;6486.5459417842185;6506.577072490273;6559.245686746085;6565.770198043046;6574.145361103026;6127.036821038878;6214.627122372672;6293.276273228637;6303.432691057827;6374.585651932795;6364.07720880479;6382.106505089198;6387.1696679433235;6393.200849893763;6402.839929001812;6191.380861913773;6289.182406287154;6293.276273228455;6317.052442133717;6341.334159913143;5437.613408580786;5866.735996880236;6140.385961403824;6181.103739957771;6186.81439556814;6065.938460769259;6162.22972128484;6177.876442471215;6212.4408803207925;6213.440790328892;6327.841803954938;6336.429721325103;6338.90491642635;6349.07938348946;6375.4262116409745;5907.556933230111;5917.437843404869;6011.579189456871;6015.187949626745;6102.816915492543 03:01:25 INFO - PROCESS | 1638 | |1;ext.html;738.2064280898032;808.7007807111368;826.0500424511811;957.7174733453626;963.1957315641439;38845.41731874024;39938.20123597526;40027;40058.79970600147;40097.1980560389;38467.65363212288;38645.42031869517;38704;38714.22571548567;38747.806260968726;7754.728584499544;7918.920810791876;10540.156787457023;10793;10948.233623646347;10662.573497060108;10698.893011069906;10761.354318740901;10761.62334318299;10765.1926105542;10717.249792514527;10729.08802751767;10782.838257426145;10788.892111078907;10791.352518848855;10739.83890241647;10745.194110441747;10760.946195269053;10765.3540787553;10773.83839242412;10556.313839600401;10572.259941804077;10576.841347379795;10617.097546708539;10625;33776.49335259973;33978.660213397794;34036.31927361464;34063;34091.488627670355;3710.2579484103017;3749.737518373715;3750.6624403803517;3809.8095095245126;3818.7517811342173;25578;26487.602685959726;26536.938522459077;26546.33634159142;26546.73453265462;2998.700129986984;3125.234317592182;3138.686131386866;3222.8388580571113;3227.080282119608;340906;341362;347976;356432;418953;39546.2090758189;41102;44148;44196.55803441989;44251;38472.61527384746;41192.764217073534;45340.319895201596;45459.636210913726;45540.3168952466;13667.589972300846;13767.518136865161;13772.10481318711;13773.966952478604;13812.723745525032;11845.466953987092;12059.939700301442;12091.093168012434;12094.697632559257;12098.637040888787;10022.749431264278;11499.735029146786;11870.703232419259;11908.88091119095;11948.581799636971;4934.4572097069295;5614.691191984399;5687.317521897398;5709.885802284014;5727.684977326204;980.9705708828747;1023.902729240721;1030.294248439821;1045.3309881675734;1049.9395610433517;21002.894985524974;26542.6018609721;26565.203043908714;26755.929762809657;26869.059582914506;931.5249222896372;974.668612671695;1085.9619913302997;1141.7887690777068;1164.988350116505;10576.365418074785;13658.317084145752;13743.350797904115;13920.02559820823;13980.370883310276;408236;413167;413699;414286;419555;54770.452295476534;55118;55142.448575514536;55147;55307.72346138243;1339.383883413621;1385.778275475919;1409.5559898631898;1457.985420145806;1460.116629439174;25690.35774105662;25755.871220643778;25996.74003259943;26063.071520461493;26429.735702642727;43205.783971079945;44268.335974961046;44493.33260001167;44546;44590;343598;385369;385383;385439;385592;31136;31227.53158702576;37239.81380093191;38454.846354609406;38493.42259866048;46346.53653463422;46751;46790.064198716515;47345;48096;36564;38567.42148867825;38884;39360;39773.40339894846;38486.84539463709;38914.610853892234;38935.02662433462;39561.406578900765;39664.60335396724;38410;38677.419838703005;39038.804805975786;39146;39339.80330098331;32746.181345466553;32798.67201328051;34473.48289775706;34734;34987.47518787271;25993;26028.73971260263;26270.21189364322;26491;26575.33561660974 03:01:25 INFO - PROCESS | 1638 | |2;jquery.html;387.91465877506954;412.56680485490267;421.559771153267;422.74212730234564;438.34686317387093;18894.90552547237;19736.901315493422;20973.951302434893;20996.790032099692;21039.68440473394;17822.376216832414;21151.365459036253;21718.674219886674;22333.44166395841;22343.888280558614;6385.39338762818;6597.63712995785;6651.900221496681;6656.334366563329;6669.866602667944;6281.309056003836;6505.902411463831;6506.479481641457;6573.441257493118;6588.978708300221;6490.188726409199;6552.803415897531;6584.637844918528;6594.802155935329;6629.535932484728;5714.371419143911;6261.874762504747;6595.439387652055;6605.867882642344;6605.976073708583;6056;6302.527310451688;6349.650769207692;6413.7434502619835;6440.645764482952;26040.218793436226;26406.86796566024;26409.207723768126;26540.33649158767;26756.331091722666;3249.382617302705;3317.800931944091;3352.597688277398;3443.139215196201;3453.1021934297014;15814;16152.919235403866;16215.837841621551;16306.347746090141;16549.420770273104;1650.4058538925976;1672.9163541822982;1775.5561109722569;1953.3749200255925;2047.846411519127;123636.38181809123;124207;124453;126784;128801;19247.1338789752;22141.778582214294;22533;22877.428064298525;23175.072997080264;34012.65987340144;35180.648193517736;35437.75967841113;35476.113097172776;35607.28785424277;11001.504932278067;11179.105671546256;11208.55165793359;11213.607523736793;11392.031677307521;9090.09099090099;9094.636214551476;9116.316276279305;9257.583408746488;9277.304202184729;9955.004499549987;10251.7437064074;10288.845667314996;10329.9483502582;10337.534810933526;3731.7201209909367;4335.631471324909;4391.8682439526865;4440.22296098188;4453.866384008485;894.2711689972651;1032.8915463876185;1040.193849766437;1052.1898138433364;1101.4602844606245;20457;21722.78277217239;21771;21792.019359128877;21949.561008779736;1056.3081181825917;1066.7599790047332;1075.58589942871;1079.7354648111263;1097.8133717267924;10987.945060274647;11471.598494052669;11574.958253757202;11618.477168527437;11685.240459370114;763487;769616;772553;773808;780127;120484.3975780133;124555;151660;155866.99999999773;165925;1270.7522033203436;1293.3856418201278;1344.731053789246;1349.406261245049;1353.9729205415836;18714.906425467787;18820.3412880554;19488.928108953576;19513.414597562096;19558.413247602595;61949;62251;62723;63494;64749.67625161844;71154.57690846258;88761.22477550543;90828.54585727029;90853;91660.54169729109;11438.94280528592;11471.770564588829;11562.710932226762;11666.650000499998;11843.763124737628;7640.274173953466;11980.35484802869;12192.390380481118;12872.485100595872;13224.867751322749;10188.745281368025;10486.737831554272;11116.110711142928;11157.44212789341;11249.887501124884;11051.778964420828;11057.944710276397;11269.323840569592;11276.436178190894;11293.491792869176;11253.7749245013;11359.034482069117;11365.488553015299;11491.080713543064;11696.47365868555;10453.895461045597;11513.251638643462;11793.705157371134;11838.408079595814;12128;10989.890101098887;11025.779484410106;11183.944080279547;11307.943460282646;11403 03:01:25 INFO - PROCESS | 1638 | |3;mootools.html;1286.0804524764792;1507.7361461744194;1508.509734336341;1518.3698765012527;1537.9541911500182;8048;9572.186364159055;10510.211734119943;11218.831717524243;11236.606718764844;10591.470426478683;10967.670969870896;10975.780484390327;11073.390963497004;11087.889121108787;2374.9287521374345;2432.391902024494;2434;2435.427674496492;2440.694913135858;1949.5028767664226;2387.271882075966;2412.6381042843536;2427.3324835670155;2428.6599876017285;2359.8584084954873;2386.6658667786437;2390.5099454611764;2395.9281221563383;2399.0403838464667;2341.332720174759;2360.893759780814;2363.7163540375177;2365.8817059146972;2366.19549353219;2341.6253399456177;2350.7061617297836;2363.137454828975;2374.8812559371963;2380.4286971126976;10820.513076911559;10978.231523793338;11034.062104721108;11060.391678457681;11061.889381106166;5757.136429535562;5833.270841144857;5924.940750592482;5927.673977931212;5942.346341902387;3521.559805024372;3571.571411430619;3609.458581212813;3665.6151104133946;3681.4845921571;1176.847009888709;1192.0642295797757;1192.7375977284983;1249.8750124987519;1255.9246445213316;15081.321340539593;15184.937054406197;15188.848111518964;15227.61930951724;15227.923860380737;4130.297849365615;4866.270059491034;5008.624353173526;5039.067772462106;5047.9495205048215;11287.94356028231;11291.322520648788;11335;11372.14708896836;11375.658730238107;5746.511546518509;5748.48263656273;5749;5749.482546570829;5753.88492230153;4445.82216711328;4847.80608775645;5060.51925067118;5116.334876466036;5310.044192045391;3887;3947.822347994347;3988.720789544762;4017.7187596868525;4030.9596904031173;1055;1056.989430105689;1063.4976485105606;1073.613499140309;1076.4671487613682;918.8254231695956;924.6671198368582;936.686210119604;942.0861764088822;977.3109957480102;6273.529485288622;6343.904841427382;6409.551331406757;6583.045458408504;6754.898676519856;793.6547601793238;904.8869890035294;968.1528662420383;980.9705708828747;1011.5903059261011;4041.8585349512628;4153.273177193979;4267.103908179255;4295.78521073945;4366.628836548865;13040.54358097462;13355.399007044707;13470.730585388237;13511.05422620407;13617.795733064011;10845.240833141763;10937.945310273397;11017.504212310465;11779.234349767237;13562.254076025913;9007.81984360309;10035.448050357301;10073.445960472245;10119.988001199821;10277.229207809294;6064.939350606437;6365.586236894587;6461.870762584816;6470.158879345655;6584.308647591934;10086.89913100889;11945.581904633644;12216.938915305367;12239.938800306298;12247.448864800926;12070.879291207328;12181.939090304491;12420.316882571546;12486.37568121572;12492.312922789333;7057.788266352018;7260.745873894389;8132.471389359909;8158.673653053811;8347.582620869054;10338.172946164439;10363.533640986023;10464.843027354747;10474.057334839596;10515.369077855354;9136.04071572502;9166;9204.401713888576;9262;9388.24894008464;8707.47755134694;8753.562321884008;8806.559672016501;8958.328125390752;8997.32520060985;6684.699188536625;7820.569868657279;7835;7941.761747147595;7975.7607271781935;5572.554195664256;5750.568707347049;5922.697006658528;5969.910451343147;6051.939480605138;5901.409859014236;5909.143174239797;5928.8814223716145;6017.939820601913;6116 03:01:25 INFO - PROCESS | 1638 | |4;prototype.html;365.94510823376476;380.93524100902846;384.48671024182715;391.69252137072397;393.4118492853185;4583.862484125473;4640.195040067142;4772.379590653219;5205.557527610148;5375.704336261504;5180.766865491052;5202.583793296537;5210.791568337271;5220.5382492902045;5279.947200527993;4057.8782636520805;4207.684423668237;4348.325894530605;4348.826046958118;4391.165678521087;3688.9341968497592;3982.820773065219;4329.9567004329865;4339.652827773771;4384.912301753963;4118.938215926763;4399.208142534342;4411.580899814512;4413.536578659243;4420.690551661385;3363.5459213006175;3650.8357123929486;4372;4421.867343979686;4431.335299705038;3688.9077773055888;3812;3937.5078115235597;4022.3966405039187;4045.6358927696647;4034.798260087013;4927.728974906378;5143.3570803649545;5152.330197074394;5186.325777648882;4206.520056140201;4351.43431353922;4861.2222044473065;4973.52751488608;5002.3492247558215;5353.197020446964;5472.199468563335;5560;5646.463585959327;5651.802186923479;3890.824912878927;4176.91646167078;4251.787410629487;4489.149390137253;4505.639548836085;5141.948580514184;5177.948220517785;5357.383900851374;5665.943340566583;5685.289338832646;4100.876973690794;4391.802368893407;4397.538258482813;4541.84103556374;4590.8163673453355;3962.3848260148166;4033.0119120815;4556.134334476439;4652.2088995736885;4684.8360307389075;4132.462779838602;4545.4545454545005;4713.252963893713;4760.714357138583;5115.616328775357;4752.572268495852;5199.48005199477;5467.4532546745;5548.91676624851;5601.9552863204635;1384.0104325407383;1541.8744316648908;1579.3208920164438;1579.778830963666;1590.9284082216327;1083.469100140941;1120.9327440353604;1124.2186680257144;1175.753091850721;1189.8929096381366;4333.972591793505;4462.799174037176;5243.764030618631;5288.312519372457;5409.161579955114;5744.770209191669;5859.589828711949;5868;5889.646621202742;5911.3201981772645;4746.288056791509;4971.483697472306;5305.045091883421;5317.059273365194;5344.679319240858;2673.1555226893383;2674.9331266718486;2701.783857291412;2947.3663162419753;3057.6636569977286;5487.204355368449;5766.250387449605;5801.767929282866;6069.484093852072;6092.51259899207;5421.728913554307;5623.325200975827;5937.554683398763;5939.762409503658;6051.425114614105;5363.597730170175;5656.1798539212405;5868.706564671749;5912.615679980788;6055.273367195965;5245.554127899171;5832.650040997553;5840.2991641003355;5881.264841894763;5911.91132133027;5247.842564723064;5297.318363737166;5442.700651464207;5758.539316854558;5789.421057894177;5510.713054082671;5807.245058142415;6098.725557350019;6106.358832322542;6117.204763380732;4118.755278373354;4372.688193541861;4491.236489796677;4633.374494443207;4680.929786053144;5005.649604527648;5738.225339579103;5809.302883653989;5825.533957283492;5838.649681019152;5440.483154100354;5463.514101083918;5630.5214056805635;5657.943420565906;5664.830055098354;4267.30877790715;5584.525315348241;5647.6893770843;5666.886662266649;5676.829695109153;5189.1837856749835;5423.779649578813;5482.451754824645;5484.409521238956;5509.917351239815;5282.47175282484;5359.283830229373;5621.325440947113;5650.350209725934;5678.416320574046;5159.638825282344;5451.754671039734;5457.290552228185;5510;5511.917321240265 03:01:25 INFO - PROCESS | 1638 | |5;yui.html;704.3238491048596;707.1761397971363;738.6085374751381;792.2236208515654;851.5316575883264;15192.848071519282;16130;16132.19339033048;16169.43406980756;16171;14907.92546037271;15103.773443398359;15116.622084447894;15123.092614443114;15139.015963962334;912.1790388650218;927.7680579855037;941.1529623338981;952.2429668413594;957.4638202606562;963.4749061761322;966.0580933589764;966.2897770138977;969.0212884986145;972.2270794718216;891.5675897189858;1003.8694969653935;1004.2518323848743;1010.9494525273743;1017.1506791828832;982.3516479123743;995.4873240281261;998.2313618513776;999.9150072243868;1000.489750227382;738.5199620246882;741.4179868802963;745.1542499263321;747.9626018699043;748.5359077372065;16106.953048051839;16319.673606527804;16362.263698133613;16650.916745416318;16923.3230670773;11980.221285616493;14007.929960350235;14295.78556321656;14332.355044023045;14357.497487587885;11729.4135293235;11933;11967.940160299142;11969.222000570022;12012.39938003105;3633.4913112164318;3654.671079602822;3700.093477098128;3711.5731690855628;3853.8823741115043;102340;111796.76406471906;119544.99999999913;122874.54250914932;124807.75192248051;8790;9178.586963586655;9507.144357007764;10773.569057237779;10918.399488028235;17820.643587128445;18571.72142417865;21977.34067977963;22287.665685014737;22552.872356382115;6809.897851532231;6939.861202775916;7758.844823103506;7787.3770098392;7790.727324543727;4347.500037495728;4351.673624478177;4453.3320001999955;4516.299973504112;4532.750698711602;3466.6013408457848;3518.7536872419196;3540.8760693376125;3576.7675101118343;3580.785152890835;581.1863391252197;646.2438946432685;651.5081113759177;653.9084528166061;655.2464665634558;656.4190691238193;663.2935923241732;683.4122654517112;697.7801992372387;714.6462501061903;9961.55173017216;10061.849072263922;10278.588856445658;10312.742181445374;10601.098906593026;689.2211800665216;690.9136357955256;691.4917535611322;691.989620155698;707.1549498349526;4676.55572720591;4974.253861920741;4994.450610432849;5002.174641184237;5007.624428167902;83342.58328708318;85774;98202.50898745461;99487;106220;76954.6152269235;77778.61110694523;88412;88918;94526.52736736272;68002.29994250085;70146;74511.25488745043;75588.62205688936;77361;9298.535073246447;10432.947835260775;11079.335239885633;11319.377434241196;11363.090952723596;42836.35745463758;44544;45535.77232113818;46811.29783053189;47389.76305118452;50111.74944125256;59916.10125848029;66429;67902.66048669725;68606.28484287932;11673.416329183678;13718.65703357424;13927.651808704459;13952.860471395155;14098;14504.782428263796;14563.927180364455;14768.18774967387;15230.086194828345;15359.539213823604;11516.424178791194;12098.516059357527;13465.798013029616;13636.973470412171;14026.088304260598;13432.664183395102;14363.56909292723;14594.124352538882;14806;14856.33146508388;13184.736305274033;13459.865401345862;13587.932060339635;13610.115342502706;13905.23521206303;10889.401082940514;11139.72150696239;11450.828237576276;11460.197786155222;11865.703357415789;9561.282903782105;10501.31741436804;10536.525856336637;11377.772444551229;11716.179867409199 03:01:25 INFO - PROCESS | 1638 | __end_tp_report 03:01:25 INFO - PROCESS | 1638 | __start_cc_report 03:01:25 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,424 03:01:25 INFO - PROCESS | 1638 | __end_cc_report 03:01:25 INFO - PROCESS | 1638 | __startTimestamp1490176885118__endTimestamp 03:01:25 INFO - PROCESS | 1638 | 03:01:25 INFO - PROCESS | 1638 | ------- Summary: start ------- 03:01:25 INFO - PROCESS | 1638 | Number of tests: 6 03:01:25 INFO - PROCESS | 1638 | 03:01:25 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5885.18 Median:6102.82 stddev:674.76 (11.1%) stddev-sans-first:633.02 03:01:25 INFO - PROCESS | 1638 | Values: 2836.4 3208.4 3306.7 3424.7 3476.1 5809.0 5893.9 5908.9 5944.7 5948.5 5853.6 5938.0 5938.8 5948.9 5966.9 5288.6 5314.3 5384.3 5418.4 5419.5 5434.7 5447.1 5454.1 5461.3 5466.3 5260.5 5264.8 5452.2 5462.1 5521.2 5365.4 5386.1 5413.5 5422.6 5441.7 5242.0 5345.2 5363.7 5384.4 5395.8 5630.9 5815.9 5928.6 5978.9 5994.6 6285.3 6287.4 6287.9 6335.4 6392.8 6372.8 6392.1 6401.0 6407.3 6420.6 6017.9 6069.8 6089.5 6117.0 6119.6 6305.3 6345.8 6365.8 6484.4 6488.0 6245.6 6272.1 6303.4 6312.7 6335.6 5097.9 6339.9 6374.8 6404.1 6408.0 6140.0 6217.3 6351.4 6394.6 6408.1 6171.8 6293.2 6341.6 6378.1 6379.1 4971.9 4998.0 5012.8 5084.3 5093.7 4516.9 4538.2 4558.2 4558.4 4582.7 5754.7 5995.0 6027.1 6047.2 6055.4 6297.4 6329.7 6359.9 6400.0 6404.2 6050.5 6074.3 6082.4 6092.3 6093.8 4755.8 5397.1 5554.2 5594.1 5624.2 6357.0 6413.0 6460.8 6475.2 6501.7 6027.5 6353.3 6354.9 6397.0 6398.5 6486.5 6506.6 6559.2 6565.8 6574.1 6127.0 6214.6 6293.3 6303.4 6374.6 6364.1 6382.1 6387.2 6393.2 6402.8 6191.4 6289.2 6293.3 6317.1 6341.3 5437.6 5866.7 6140.4 6181.1 6186.8 6065.9 6162.2 6177.9 6212.4 6213.4 6327.8 6336.4 6338.9 6349.1 6375.4 5907.6 5917.4 6011.6 6015.2 6102.8 03:01:25 INFO - PROCESS | 1638 | 03:01:25 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:52955.07 Median:342480.00 stddev:101674.07 (29.7%) stddev-sans-first:101883.71 03:01:25 INFO - PROCESS | 1638 | Values: 738.2 808.7 826.1 957.7 963.2 38845.4 39938.2 40027.0 40058.8 40097.2 38467.7 38645.4 38704.0 38714.2 38747.8 7754.7 7918.9 10540.2 10793.0 10948.2 10662.6 10698.9 10761.4 10761.6 10765.2 10717.2 10729.1 10782.8 10788.9 10791.4 10739.8 10745.2 10760.9 10765.4 10773.8 10556.3 10572.3 10576.8 10617.1 10625.0 33776.5 33978.7 34036.3 34063.0 34091.5 3710.3 3749.7 3750.7 3809.8 3818.8 25578.0 26487.6 26536.9 26546.3 26546.7 2998.7 3125.2 3138.7 3222.8 3227.1 340906.0 341362.0 347976.0 356432.0 418953.0 39546.2 41102.0 44148.0 44196.6 44251.0 38472.6 41192.8 45340.3 45459.6 45540.3 13667.6 13767.5 13772.1 13774.0 13812.7 11845.5 12059.9 12091.1 12094.7 12098.6 10022.7 11499.7 11870.7 11908.9 11948.6 4934.5 5614.7 5687.3 5709.9 5727.7 981.0 1023.9 1030.3 1045.3 1049.9 21002.9 26542.6 26565.2 26755.9 26869.1 931.5 974.7 1086.0 1141.8 1165.0 10576.4 13658.3 13743.4 13920.0 13980.4 408236.0 413167.0 413699.0 414286.0 419555.0 54770.5 55118.0 55142.4 55147.0 55307.7 1339.4 1385.8 1409.6 1458.0 1460.1 25690.4 25755.9 25996.7 26063.1 26429.7 43205.8 44268.3 44493.3 44546.0 44590.0 343598.0 385369.0 385383.0 385439.0 385592.0 31136.0 31227.5 37239.8 38454.8 38493.4 46346.5 46751.0 46790.1 47345.0 48096.0 36564.0 38567.4 38884.0 39360.0 39773.4 38486.8 38914.6 38935.0 39561.4 39664.6 38410.0 38677.4 39038.8 39146.0 39339.8 32746.2 32798.7 34473.5 34734.0 34987.5 25993.0 26028.7 26270.2 26491.0 26575.3 03:01:25 INFO - PROCESS | 1638 | 03:01:25 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:42774.02 Median:11252.42 stddev:127752.77 (1135.3%) stddev-sans-first:128071.50 03:01:25 INFO - PROCESS | 1638 | Values: 387.9 412.6 421.6 422.7 438.3 18894.9 19736.9 20974.0 20996.8 21039.7 17822.4 21151.4 21718.7 22333.4 22343.9 6385.4 6597.6 6651.9 6656.3 6669.9 6281.3 6505.9 6506.5 6573.4 6589.0 6490.2 6552.8 6584.6 6594.8 6629.5 5714.4 6261.9 6595.4 6605.9 6606.0 6056.0 6302.5 6349.7 6413.7 6440.6 26040.2 26406.9 26409.2 26540.3 26756.3 3249.4 3317.8 3352.6 3443.1 3453.1 15814.0 16152.9 16215.8 16306.3 16549.4 1650.4 1672.9 1775.6 1953.4 2047.8 123636.4 124207.0 124453.0 126784.0 128801.0 19247.1 22141.8 22533.0 22877.4 23175.1 34012.7 35180.6 35437.8 35476.1 35607.3 11001.5 11179.1 11208.6 11213.6 11392.0 9090.1 9094.6 9116.3 9257.6 9277.3 9955.0 10251.7 10288.8 10329.9 10337.5 3731.7 4335.6 4391.9 4440.2 4453.9 894.3 1032.9 1040.2 1052.2 1101.5 20457.0 21722.8 21771.0 21792.0 21949.6 1056.3 1066.8 1075.6 1079.7 1097.8 10987.9 11471.6 11575.0 11618.5 11685.2 763487.0 769616.0 772553.0 773808.0 780127.0 120484.4 124555.0 151660.0 155867.0 165925.0 1270.8 1293.4 1344.7 1349.4 1354.0 18714.9 18820.3 19488.9 19513.4 19558.4 61949.0 62251.0 62723.0 63494.0 64749.7 71154.6 88761.2 90828.5 90853.0 91660.5 11438.9 11471.8 11562.7 11666.7 11843.8 7640.3 11980.4 12192.4 12872.5 13224.9 10188.7 10486.7 11116.1 11157.4 11249.9 11051.8 11057.9 11269.3 11276.4 11293.5 11253.8 11359.0 11365.5 11491.1 11696.5 10453.9 11513.3 11793.7 11838.4 12128.0 10989.9 11025.8 11183.9 11307.9 11403.0 03:01:25 INFO - PROCESS | 1638 | 03:01:25 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:6580.44 Median:2434.71 stddev:4063.16 (166.9%) stddev-sans-first:4055.08 03:01:25 INFO - PROCESS | 1638 | Values: 1286.1 1507.7 1508.5 1518.4 1538.0 8048.0 9572.2 10510.2 11218.8 11236.6 10591.5 10967.7 10975.8 11073.4 11087.9 2374.9 2432.4 2434.0 2435.4 2440.7 1949.5 2387.3 2412.6 2427.3 2428.7 2359.9 2386.7 2390.5 2395.9 2399.0 2341.3 2360.9 2363.7 2365.9 2366.2 2341.6 2350.7 2363.1 2374.9 2380.4 10820.5 10978.2 11034.1 11060.4 11061.9 5757.1 5833.3 5924.9 5927.7 5942.3 3521.6 3571.6 3609.5 3665.6 3681.5 1176.8 1192.1 1192.7 1249.9 1255.9 15081.3 15184.9 15188.8 15227.6 15227.9 4130.3 4866.3 5008.6 5039.1 5047.9 11287.9 11291.3 11335.0 11372.1 11375.7 5746.5 5748.5 5749.0 5749.5 5753.9 4445.8 4847.8 5060.5 5116.3 5310.0 3887.0 3947.8 3988.7 4017.7 4031.0 1055.0 1057.0 1063.5 1073.6 1076.5 918.8 924.7 936.7 942.1 977.3 6273.5 6343.9 6409.6 6583.0 6754.9 793.7 904.9 968.2 981.0 1011.6 4041.9 4153.3 4267.1 4295.8 4366.6 13040.5 13355.4 13470.7 13511.1 13617.8 10845.2 10937.9 11017.5 11779.2 13562.3 9007.8 10035.4 10073.4 10120.0 10277.2 6064.9 6365.6 6461.9 6470.2 6584.3 10086.9 11945.6 12216.9 12239.9 12247.4 12070.9 12181.9 12420.3 12486.4 12492.3 7057.8 7260.7 8132.5 8158.7 8347.6 10338.2 10363.5 10464.8 10474.1 10515.4 9136.0 9166.0 9204.4 9262.0 9388.2 8707.5 8753.6 8806.6 8958.3 8997.3 6684.7 7820.6 7835.0 7941.8 7975.8 5572.6 5750.6 5922.7 5969.9 6051.9 5901.4 5909.1 5928.9 6017.9 6116.0 03:01:25 INFO - PROCESS | 1638 | 03:01:25 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4671.32 Median:5168.79 stddev:1332.03 (25.8%) stddev-sans-first:1295.97 03:01:25 INFO - PROCESS | 1638 | Values: 365.9 380.9 384.5 391.7 393.4 4583.9 4640.2 4772.4 5205.6 5375.7 5180.8 5202.6 5210.8 5220.5 5279.9 4057.9 4207.7 4348.3 4348.8 4391.2 3688.9 3982.8 4330.0 4339.7 4384.9 4118.9 4399.2 4411.6 4413.5 4420.7 3363.5 3650.8 4372.0 4421.9 4431.3 3688.9 3812.0 3937.5 4022.4 4045.6 4034.8 4927.7 5143.4 5152.3 5186.3 4206.5 4351.4 4861.2 4973.5 5002.3 5353.2 5472.2 5560.0 5646.5 5651.8 3890.8 4176.9 4251.8 4489.1 4505.6 5141.9 5177.9 5357.4 5665.9 5685.3 4100.9 4391.8 4397.5 4541.8 4590.8 3962.4 4033.0 4556.1 4652.2 4684.8 4132.5 4545.5 4713.3 4760.7 5115.6 4752.6 5199.5 5467.5 5548.9 5602.0 1384.0 1541.9 1579.3 1579.8 1590.9 1083.5 1120.9 1124.2 1175.8 1189.9 4334.0 4462.8 5243.8 5288.3 5409.2 5744.8 5859.6 5868.0 5889.6 5911.3 4746.3 4971.5 5305.0 5317.1 5344.7 2673.2 2674.9 2701.8 2947.4 3057.7 5487.2 5766.3 5801.8 6069.5 6092.5 5421.7 5623.3 5937.6 5939.8 6051.4 5363.6 5656.2 5868.7 5912.6 6055.3 5245.6 5832.7 5840.3 5881.3 5911.9 5247.8 5297.3 5442.7 5758.5 5789.4 5510.7 5807.2 6098.7 6106.4 6117.2 4118.8 4372.7 4491.2 4633.4 4680.9 5005.6 5738.2 5809.3 5825.5 5838.6 5440.5 5463.5 5630.5 5657.9 5664.8 4267.3 5584.5 5647.7 5666.9 5676.8 5189.2 5423.8 5482.5 5484.4 5509.9 5282.5 5359.3 5621.3 5650.4 5678.4 5159.6 5451.8 5457.3 5510.0 5511.9 03:01:25 INFO - PROCESS | 1638 | 03:01:25 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20132.98 Median:3644.08 stddev:28906.46 (793.2%) stddev-sans-first:28950.74 03:01:25 INFO - PROCESS | 1638 | Values: 704.3 707.2 738.6 792.2 851.5 15192.8 16130.0 16132.2 16169.4 16171.0 14907.9 15103.8 15116.6 15123.1 15139.0 912.2 927.8 941.2 952.2 957.5 963.5 966.1 966.3 969.0 972.2 891.6 1003.9 1004.3 1010.9 1017.2 982.4 995.5 998.2 999.9 1000.5 738.5 741.4 745.2 748.0 748.5 16107.0 16319.7 16362.3 16650.9 16923.3 11980.2 14007.9 14295.8 14332.4 14357.5 11729.4 11933.0 11967.9 11969.2 12012.4 3633.5 3654.7 3700.1 3711.6 3853.9 102340.0 111796.8 119545.0 122874.5 124807.8 8790.0 9178.6 9507.1 10773.6 10918.4 17820.6 18571.7 21977.3 22287.7 22552.9 6809.9 6939.9 7758.8 7787.4 7790.7 4347.5 4351.7 4453.3 4516.3 4532.8 3466.6 3518.8 3540.9 3576.8 3580.8 581.2 646.2 651.5 653.9 655.2 656.4 663.3 683.4 697.8 714.6 9961.6 10061.8 10278.6 10312.7 10601.1 689.2 690.9 691.5 692.0 707.2 4676.6 4974.3 4994.5 5002.2 5007.6 83342.6 85774.0 98202.5 99487.0 106220.0 76954.6 77778.6 88412.0 88918.0 94526.5 68002.3 70146.0 74511.3 75588.6 77361.0 9298.5 10432.9 11079.3 11319.4 11363.1 42836.4 44544.0 45535.8 46811.3 47389.8 50111.7 59916.1 66429.0 67902.7 68606.3 11673.4 13718.7 13927.7 13952.9 14098.0 14504.8 14563.9 14768.2 15230.1 15359.5 11516.4 12098.5 13465.8 13637.0 14026.1 13432.7 14363.6 14594.1 14806.0 14856.3 13184.7 13459.9 13587.9 13610.1 13905.2 10889.4 11139.7 11450.8 11460.2 11865.7 9561.3 10501.3 10536.5 11377.8 11716.2 03:01:25 INFO - PROCESS | 1638 | -------- Summary: end -------- 03:01:25 INFO - PROCESS | 1638 | 03:01:25 INFO - TEST-INFO | 1638: exit 0 03:01:25 INFO - TEST-OK | dromaeo_css | took 1116258ms 03:01:25 INFO - TEST-START | kraken 03:01:25 INFO - operating with platform_type : mac_ 03:01:25 INFO - Initialising browser for kraken test... 03:01:25 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpGWJ7hg/profile http://localhost:49239/getInfo.html) 03:01:28 INFO - PROCESS | 1649 | 2017-03-22 03:01:28.629 plugin-container[1650:10012] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8937, name = 'com.apple.tsm.portname' 03:01:28 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:01:28 INFO - PROCESS | 1649 | 2017-03-22 03:01:28.632 plugin-container[1650:10012] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x430f, name = 'com.apple.CFPasteboardClient' 03:01:28 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:01:28 INFO - PROCESS | 1649 | 2017-03-22 03:01:28.632 plugin-container[1650:10012] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:01:28 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 03:01:28 INFO - PROCESS | 1649 | colorDepth:24 03:01:28 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 03:01:28 INFO - PROCESS | 1649 | __metrics 03:01:28 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 03:01:29 INFO - TEST-INFO | 1649: exit 0 03:01:29 INFO - Browser initialized. 03:01:29 INFO - Running cycle 1/1 for kraken test... 03:01:29 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpGWJ7hg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:01:32 INFO - PROCESS | 1651 | 2017-03-22 03:01:32.236 plugin-container[1652:10140] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3f, name = 'com.apple.tsm.portname' 03:01:32 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:01:32 INFO - PROCESS | 1651 | 2017-03-22 03:01:32.236 plugin-container[1652:10140] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x440f, name = 'com.apple.CFPasteboardClient' 03:01:32 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:01:32 INFO - PROCESS | 1651 | 2017-03-22 03:01:32.236 plugin-container[1652:10140] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:01:42 INFO - PROCESS | 1651 | RSS: Main: 220901376 03:01:42 INFO - PROCESS | 1651 | 03:01:45 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection) 03:01:46 INFO - PROCESS | 1651 | RSS: Main: 235474944 03:01:46 INFO - PROCESS | 1651 | 03:01:48 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-dft) 03:01:49 INFO - PROCESS | 1651 | RSS: Main: 243552256 03:01:49 INFO - PROCESS | 1651 | 03:01:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-fft) 03:01:53 INFO - PROCESS | 1651 | RSS: Main: 245170176 03:01:53 INFO - PROCESS | 1651 | 03:01:55 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator) 03:01:56 INFO - PROCESS | 1651 | RSS: Main: 246992896 03:01:56 INFO - PROCESS | 1651 | 03:01:58 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:01:58 INFO - PROCESS | 1651 | RSS: Main: 248619008 03:01:58 INFO - PROCESS | 1651 | 03:02:01 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom) 03:02:02 INFO - PROCESS | 1651 | RSS: Main: 252522496 03:02:02 INFO - PROCESS | 1651 | 03:02:05 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate) 03:02:06 INFO - PROCESS | 1651 | RSS: Main: 252444672 03:02:06 INFO - PROCESS | 1651 | 03:02:09 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial) 03:02:09 INFO - PROCESS | 1651 | RSS: Main: 252358656 03:02:09 INFO - PROCESS | 1651 | 03:02:11 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:02:12 INFO - PROCESS | 1651 | RSS: Main: 252219392 03:02:12 INFO - PROCESS | 1651 | 03:02:14 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:02:14 INFO - PROCESS | 1651 | RSS: Main: 252223488 03:02:14 INFO - PROCESS | 1651 | 03:02:17 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:02:17 INFO - PROCESS | 1651 | RSS: Main: 252497920 03:02:17 INFO - PROCESS | 1651 | 03:02:20 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:02:21 INFO - PROCESS | 1651 | RSS: Main: 252694528 03:02:21 INFO - PROCESS | 1651 | 03:02:24 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:02:24 INFO - PROCESS | 1651 | RSS: Main: 252436480 03:02:24 INFO - PROCESS | 1651 | 03:02:26 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49239/tests/kraken/driver.html?testName=ai-astar) 03:02:26 INFO - PROCESS | 1651 | RSS: Main: 254431232 03:02:26 INFO - PROCESS | 1651 | 03:02:26 INFO - PROCESS | 1651 | __start_tp_report 03:02:26 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 03:02:26 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 03:02:26 INFO - PROCESS | 1651 | |i|pagename|runs| 03:02:26 INFO - PROCESS | 1651 | |0;ai-astar;139;108;170;122;120;120;125;126;121;122 03:02:26 INFO - PROCESS | 1651 | |1;audio-beat-detection;145;143;140;142;116;112;111;115;132;111 03:02:26 INFO - PROCESS | 1651 | |2;audio-dft;202;201;198;237;251;204;267;290;199;196 03:02:26 INFO - PROCESS | 1651 | |3;audio-fft;90;57;51;97;76;51;52;60;97;84 03:02:26 INFO - PROCESS | 1651 | |4;audio-oscillator;99;57;73;59;74;102;114;103;91;82 03:02:26 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;89;80;136;98;137;105;93;92;82;135 03:02:26 INFO - PROCESS | 1651 | |6;imaging-darkroom;106;98;99;151;98;96;99;98;97;98 03:02:26 INFO - PROCESS | 1651 | |7;imaging-desaturate;147;120;91;93;89;91;101;91;90;92 03:02:26 INFO - PROCESS | 1651 | |8;json-parse-financial;67;64;66;67;69;69;85;103;106;76 03:02:26 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;61;60;58;71;67;63;58;59;58;62 03:02:26 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;90;105;110;88;92;96;111;105;75;72 03:02:26 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;139;140;139;139;140;163;162;156;185;151 03:02:26 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;171;172;172;165;171;192;171;167;169;165 03:02:26 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;67;66;66;63;75;85;86;87;69;65 03:02:26 INFO - PROCESS | 1651 | __end_tp_report 03:02:26 INFO - PROCESS | 1651 | __start_cc_report 03:02:26 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1025 03:02:26 INFO - PROCESS | 1651 | __end_cc_report 03:02:26 INFO - PROCESS | 1651 | __startTimestamp1490176946956__endTimestamp 03:02:26 INFO - PROCESS | 1651 | 03:02:26 INFO - PROCESS | 1651 | ------- Summary: start ------- 03:02:26 INFO - PROCESS | 1651 | Number of tests: 14 03:02:26 INFO - PROCESS | 1651 | 03:02:26 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:127.30 Median:123.50 stddev:16.81 (13.6%) stddev-sans-first:17.28 03:02:26 INFO - PROCESS | 1651 | Values: 139.0 108.0 170.0 122.0 120.0 120.0 125.0 126.0 121.0 122.0 03:02:26 INFO - PROCESS | 1651 | 03:02:26 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:126.70 Median:136.00 stddev:14.91 (11.0%) stddev-sans-first:14.27 03:02:26 INFO - PROCESS | 1651 | Values: 145.0 143.0 140.0 142.0 116.0 112.0 111.0 115.0 132.0 111.0 03:02:26 INFO - PROCESS | 1651 | 03:02:26 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:224.50 Median:220.50 stddev:34.32 (15.6%) stddev-sans-first:35.42 03:02:26 INFO - PROCESS | 1651 | Values: 202.0 201.0 198.0 237.0 251.0 204.0 267.0 290.0 199.0 196.0 03:02:26 INFO - PROCESS | 1651 | 03:02:26 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:71.50 Median:80.00 stddev:19.39 (24.2%) stddev-sans-first:19.37 03:02:26 INFO - PROCESS | 1651 | Values: 90.0 57.0 51.0 97.0 76.0 51.0 52.0 60.0 97.0 84.0 03:02:26 INFO - PROCESS | 1651 | 03:02:26 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:85.40 Median:73.50 stddev:19.49 (26.5%) stddev-sans-first:20.04 03:02:26 INFO - PROCESS | 1651 | Values: 99.0 57.0 73.0 59.0 74.0 102.0 114.0 103.0 91.0 82.0 03:02:26 INFO - PROCESS | 1651 | 03:02:26 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:104.70 Median:85.50 stddev:22.75 (26.6%) stddev-sans-first:23.40 03:02:26 INFO - PROCESS | 1651 | Values: 89.0 80.0 136.0 98.0 137.0 105.0 93.0 92.0 82.0 135.0 03:02:26 INFO - PROCESS | 1651 | 03:02:26 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:104.00 Median:98.00 stddev:16.73 (17.1%) stddev-sans-first:17.73 03:02:26 INFO - PROCESS | 1651 | Values: 106.0 98.0 99.0 151.0 98.0 96.0 99.0 98.0 97.0 98.0 03:02:26 INFO - PROCESS | 1651 | 03:02:26 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:100.50 Median:91.00 stddev:18.81 (20.7%) stddev-sans-first:9.89 03:02:26 INFO - PROCESS | 1651 | Values: 147.0 120.0 91.0 93.0 89.0 91.0 101.0 91.0 90.0 92.0 03:02:26 INFO - PROCESS | 1651 | 03:02:26 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:77.20 Median:68.00 stddev:15.63 (23.0%) stddev-sans-first:16.14 03:02:26 INFO - PROCESS | 1651 | Values: 67.0 64.0 66.0 67.0 69.0 69.0 85.0 103.0 106.0 76.0 03:02:26 INFO - PROCESS | 1651 | 03:02:26 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:61.50 stddev:4.32 (7.0%) stddev-sans-first:4.58 03:02:26 INFO - PROCESS | 1651 | Values: 61.0 60.0 58.0 71.0 67.0 63.0 58.0 59.0 58.0 62.0 03:02:26 INFO - PROCESS | 1651 | 03:02:26 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:94.40 Median:81.50 stddev:13.70 (16.8%) stddev-sans-first:14.44 03:02:26 INFO - PROCESS | 1651 | Values: 90.0 105.0 110.0 88.0 92.0 96.0 111.0 105.0 75.0 72.0 03:02:26 INFO - PROCESS | 1651 | 03:02:26 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:151.40 Median:153.50 stddev:15.34 (10.0%) stddev-sans-first:15.60 03:02:26 INFO - PROCESS | 1651 | Values: 139.0 140.0 139.0 139.0 140.0 163.0 162.0 156.0 185.0 151.0 03:02:26 INFO - PROCESS | 1651 | 03:02:26 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:171.00 stddev:7.69 (4.5%) stddev-sans-first:8.16 03:02:26 INFO - PROCESS | 1651 | Values: 171.0 172.0 172.0 165.0 171.0 192.0 171.0 167.0 169.0 165.0 03:02:26 INFO - PROCESS | 1651 | 03:02:26 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.90 Median:72.00 stddev:9.59 (13.3%) stddev-sans-first:9.93 03:02:26 INFO - PROCESS | 1651 | Values: 67.0 66.0 66.0 63.0 75.0 85.0 86.0 87.0 69.0 65.0 03:02:26 INFO - PROCESS | 1651 | -------- Summary: end -------- 03:02:26 INFO - PROCESS | 1651 | 03:02:27 INFO - TEST-INFO | 1651: exit 0 03:02:27 INFO - TEST-OK | kraken | took 62065ms 03:02:27 INFO - SUITE-END | took 1178s 03:02:28 INFO - Completed test suite (00:19:38) 03:02:28 INFO - javascript benchmark 03:02:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7702.78126233806, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2836.361818590817, 3208.374366998435, 3306.6693330666935, 3424.7088997435217, 3476.1483436558046, 5809.0, 5893.939090963625, 5908.911366329503, 5944.673042982639, 5948.524118070555, 5853.5902486825835, 5938.0, 5938.792142275021, 5948.88102237955, 5966.8806623867495, 5288.550473209782, 5314.309139811829, 5384.326959130109, 5418.376886658026, 5419.485148910847, 5434.673919564819, 5447.101228297326, 5454.1102789385, 5461.344638643349, 5466.289382380285, 5260.526552610264, 5264.789408423659, 5452.2094296327205, 5462.126059830408, 5521.199426083215, 5365.436629153941, 5386.057439947994, 5413.512783849433, 5422.620416570841, 5441.673499589998, 5241.9737901310245, 5345.1714984177515, 5363.731813409314, 5384.353877534721, 5395.78416863325, 5630.887382252332, 5815.912761308584, 5928.64428134309, 5978.8505287367725, 5994.550408719363, 6285.277193122758, 6287.371262873722, 6287.874242515124, 6335.3981371769605, 6392.808215753488, 6372.776952806629, 6392.1370614966845, 6400.967995160041, 6407.295197528269, 6420.582662126947, 6017.856607244609, 6069.787557435468, 6089.543284253655, 6116.96941515294, 6119.602225855394, 6305.274893387227, 6345.777897773556, 6365.840853978595, 6484.416402523795, 6487.967560162169, 6245.5628106033055, 6272.090546870678, 6303.432691057735, 6312.715927783261, 6335.619862808247, 5097.949020509747, 6339.904901426482, 6374.840628984312, 6404.071409645669, 6408.03879418091, 6139.9828168395225, 6217.316095229521, 6351.364863513704, 6394.648294343763, 6408.1349017881985, 6171.814845554641, 6293.213348331458, 6341.619502829845, 6378.138951241523, 6379.106925030499, 4971.90056198874, 4998.0, 5012.774425150877, 5084.313617661568, 5093.719845408538, 4516.932246016312, 4538.183127037165, 4558.156741002858, 4558.407407037131, 4582.725036497821, 5754.74103665336, 5995.0, 6027.095935609694, 6047.183630209954, 6055.394460553997, 6297.4332310091395, 6329.7468101275435, 6359.904601430982, 6400.0, 6404.23149222087, 6050.485708714808, 6074.271087469444, 6082.434169232198, 6092.299385570716, 6093.756249750049, 4755.83354582588, 5397.136458166675, 5554.1946417769195, 5594.104943209067, 5624.240727501817, 6357.046443033582, 6412.97392417211, 6460.773872914426, 6475.158229430144, 6501.707423166064, 6027.517798576016, 6353.332900045429, 6354.936450635434, 6397.040443933447, 6398.488120950406, 6486.5459417842185, 6506.577072490273, 6559.245686746085, 6565.770198043046, 6574.145361103026, 6127.036821038878, 6214.627122372672, 6293.276273228637, 6303.432691057827, 6374.585651932795, 6364.07720880479, 6382.106505089198, 6387.1696679433235, 6393.200849893763, 6402.839929001812, 6191.380861913773, 6289.182406287154, 6293.276273228455, 6317.052442133717, 6341.334159913143, 5437.613408580786, 5866.735996880236, 6140.385961403824, 6181.103739957771, 6186.81439556814, 6065.938460769259, 6162.22972128484, 6177.876442471215, 6212.4408803207925, 6213.440790328892, 6327.841803954938, 6336.429721325103, 6338.90491642635, 6349.07938348946, 6375.4262116409745, 5907.556933230111, 5917.437843404869, 6011.579189456871, 6015.187949626745, 6102.816915492543], "value": 5839.555204845503, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.2064280898032, 808.7007807111368, 826.0500424511811, 957.7174733453626, 963.1957315641439, 38845.41731874024, 39938.20123597526, 40027.0, 40058.79970600147, 40097.1980560389, 38467.65363212288, 38645.42031869517, 38704.0, 38714.22571548567, 38747.806260968726, 7754.728584499544, 7918.920810791876, 10540.156787457023, 10793.0, 10948.233623646347, 10662.573497060108, 10698.893011069906, 10761.354318740901, 10761.62334318299, 10765.1926105542, 10717.249792514527, 10729.08802751767, 10782.838257426145, 10788.892111078907, 10791.352518848855, 10739.83890241647, 10745.194110441747, 10760.946195269053, 10765.3540787553, 10773.83839242412, 10556.313839600401, 10572.259941804077, 10576.841347379795, 10617.097546708539, 10625.0, 33776.49335259973, 33978.660213397794, 34036.31927361464, 34063.0, 34091.488627670355, 3710.2579484103017, 3749.737518373715, 3750.6624403803517, 3809.8095095245126, 3818.7517811342173, 25578.0, 26487.602685959726, 26536.938522459077, 26546.33634159142, 26546.73453265462, 2998.700129986984, 3125.234317592182, 3138.686131386866, 3222.8388580571113, 3227.080282119608, 340906.0, 341362.0, 347976.0, 356432.0, 418953.0, 39546.2090758189, 41102.0, 44148.0, 44196.55803441989, 44251.0, 38472.61527384746, 41192.764217073534, 45340.319895201596, 45459.636210913726, 45540.3168952466, 13667.589972300846, 13767.518136865161, 13772.10481318711, 13773.966952478604, 13812.723745525032, 11845.466953987092, 12059.939700301442, 12091.093168012434, 12094.697632559257, 12098.637040888787, 10022.749431264278, 11499.735029146786, 11870.703232419259, 11908.88091119095, 11948.581799636971, 4934.4572097069295, 5614.691191984399, 5687.317521897398, 5709.885802284014, 5727.684977326204, 980.9705708828747, 1023.902729240721, 1030.294248439821, 1045.3309881675734, 1049.9395610433517, 21002.894985524974, 26542.6018609721, 26565.203043908714, 26755.929762809657, 26869.059582914506, 931.5249222896372, 974.668612671695, 1085.9619913302997, 1141.7887690777068, 1164.988350116505, 10576.365418074785, 13658.317084145752, 13743.350797904115, 13920.02559820823, 13980.370883310276, 408236.0, 413167.0, 413699.0, 414286.0, 419555.0, 54770.452295476534, 55118.0, 55142.448575514536, 55147.0, 55307.72346138243, 1339.383883413621, 1385.778275475919, 1409.5559898631898, 1457.985420145806, 1460.116629439174, 25690.35774105662, 25755.871220643778, 25996.74003259943, 26063.071520461493, 26429.735702642727, 43205.783971079945, 44268.335974961046, 44493.33260001167, 44546.0, 44590.0, 343598.0, 385369.0, 385383.0, 385439.0, 385592.0, 31136.0, 31227.53158702576, 37239.81380093191, 38454.846354609406, 38493.42259866048, 46346.53653463422, 46751.0, 46790.064198716515, 47345.0, 48096.0, 36564.0, 38567.42148867825, 38884.0, 39360.0, 39773.40339894846, 38486.84539463709, 38914.610853892234, 38935.02662433462, 39561.406578900765, 39664.60335396724, 38410.0, 38677.419838703005, 39038.804805975786, 39146.0, 39339.80330098331, 32746.181345466553, 32798.67201328051, 34473.48289775706, 34734.0, 34987.47518787271, 25993.0, 26028.73971260263, 26270.21189364322, 26491.0, 26575.33561660974], "value": 18645.79414292155, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.91465877506954, 412.56680485490267, 421.559771153267, 422.74212730234564, 438.34686317387093, 18894.90552547237, 19736.901315493422, 20973.951302434893, 20996.790032099692, 21039.68440473394, 17822.376216832414, 21151.365459036253, 21718.674219886674, 22333.44166395841, 22343.888280558614, 6385.39338762818, 6597.63712995785, 6651.900221496681, 6656.334366563329, 6669.866602667944, 6281.309056003836, 6505.902411463831, 6506.479481641457, 6573.441257493118, 6588.978708300221, 6490.188726409199, 6552.803415897531, 6584.637844918528, 6594.802155935329, 6629.535932484728, 5714.371419143911, 6261.874762504747, 6595.439387652055, 6605.867882642344, 6605.976073708583, 6056.0, 6302.527310451688, 6349.650769207692, 6413.7434502619835, 6440.645764482952, 26040.218793436226, 26406.86796566024, 26409.207723768126, 26540.33649158767, 26756.331091722666, 3249.382617302705, 3317.800931944091, 3352.597688277398, 3443.139215196201, 3453.1021934297014, 15814.0, 16152.919235403866, 16215.837841621551, 16306.347746090141, 16549.420770273104, 1650.4058538925976, 1672.9163541822982, 1775.5561109722569, 1953.3749200255925, 2047.846411519127, 123636.38181809123, 124207.0, 124453.0, 126784.0, 128801.0, 19247.1338789752, 22141.778582214294, 22533.0, 22877.428064298525, 23175.072997080264, 34012.65987340144, 35180.648193517736, 35437.75967841113, 35476.113097172776, 35607.28785424277, 11001.504932278067, 11179.105671546256, 11208.55165793359, 11213.607523736793, 11392.031677307521, 9090.09099090099, 9094.636214551476, 9116.316276279305, 9257.583408746488, 9277.304202184729, 9955.004499549987, 10251.7437064074, 10288.845667314996, 10329.9483502582, 10337.534810933526, 3731.7201209909367, 4335.631471324909, 4391.8682439526865, 4440.22296098188, 4453.866384008485, 894.2711689972651, 1032.8915463876185, 1040.193849766437, 1052.1898138433364, 1101.4602844606245, 20457.0, 21722.78277217239, 21771.0, 21792.019359128877, 21949.561008779736, 1056.3081181825917, 1066.7599790047332, 1075.58589942871, 1079.7354648111263, 1097.8133717267924, 10987.945060274647, 11471.598494052669, 11574.958253757202, 11618.477168527437, 11685.240459370114, 763487.0, 769616.0, 772553.0, 773808.0, 780127.0, 120484.3975780133, 124555.0, 151660.0, 155866.99999999773, 165925.0, 1270.7522033203436, 1293.3856418201278, 1344.731053789246, 1349.406261245049, 1353.9729205415836, 18714.906425467787, 18820.3412880554, 19488.928108953576, 19513.414597562096, 19558.413247602595, 61949.0, 62251.0, 62723.0, 63494.0, 64749.67625161844, 71154.57690846258, 88761.22477550543, 90828.54585727029, 90853.0, 91660.54169729109, 11438.94280528592, 11471.770564588829, 11562.710932226762, 11666.650000499998, 11843.763124737628, 7640.274173953466, 11980.35484802869, 12192.390380481118, 12872.485100595872, 13224.867751322749, 10188.745281368025, 10486.737831554272, 11116.110711142928, 11157.44212789341, 11249.887501124884, 11051.778964420828, 11057.944710276397, 11269.323840569592, 11276.436178190894, 11293.491792869176, 11253.7749245013, 11359.034482069117, 11365.488553015299, 11491.080713543064, 11696.47365868555, 10453.895461045597, 11513.251638643462, 11793.705157371134, 11838.408079595814, 12128.0, 10989.890101098887, 11025.779484410106, 11183.944080279547, 11307.943460282646, 11403.0], "value": 11634.564772098345, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.0804524764792, 1507.7361461744194, 1508.509734336341, 1518.3698765012527, 1537.9541911500182, 8048.0, 9572.186364159055, 10510.211734119943, 11218.831717524243, 11236.606718764844, 10591.470426478683, 10967.670969870896, 10975.780484390327, 11073.390963497004, 11087.889121108787, 2374.9287521374345, 2432.391902024494, 2434.0, 2435.427674496492, 2440.694913135858, 1949.5028767664226, 2387.271882075966, 2412.6381042843536, 2427.3324835670155, 2428.6599876017285, 2359.8584084954873, 2386.6658667786437, 2390.5099454611764, 2395.9281221563383, 2399.0403838464667, 2341.332720174759, 2360.893759780814, 2363.7163540375177, 2365.8817059146972, 2366.19549353219, 2341.6253399456177, 2350.7061617297836, 2363.137454828975, 2374.8812559371963, 2380.4286971126976, 10820.513076911559, 10978.231523793338, 11034.062104721108, 11060.391678457681, 11061.889381106166, 5757.136429535562, 5833.270841144857, 5924.940750592482, 5927.673977931212, 5942.346341902387, 3521.559805024372, 3571.571411430619, 3609.458581212813, 3665.6151104133946, 3681.4845921571, 1176.847009888709, 1192.0642295797757, 1192.7375977284983, 1249.8750124987519, 1255.9246445213316, 15081.321340539593, 15184.937054406197, 15188.848111518964, 15227.61930951724, 15227.923860380737, 4130.297849365615, 4866.270059491034, 5008.624353173526, 5039.067772462106, 5047.9495205048215, 11287.94356028231, 11291.322520648788, 11335.0, 11372.14708896836, 11375.658730238107, 5746.511546518509, 5748.48263656273, 5749.0, 5749.482546570829, 5753.88492230153, 4445.82216711328, 4847.80608775645, 5060.51925067118, 5116.334876466036, 5310.044192045391, 3887.0, 3947.822347994347, 3988.720789544762, 4017.7187596868525, 4030.9596904031173, 1055.0, 1056.989430105689, 1063.4976485105606, 1073.613499140309, 1076.4671487613682, 918.8254231695956, 924.6671198368582, 936.686210119604, 942.0861764088822, 977.3109957480102, 6273.529485288622, 6343.904841427382, 6409.551331406757, 6583.045458408504, 6754.898676519856, 793.6547601793238, 904.8869890035294, 968.1528662420383, 980.9705708828747, 1011.5903059261011, 4041.8585349512628, 4153.273177193979, 4267.103908179255, 4295.78521073945, 4366.628836548865, 13040.54358097462, 13355.399007044707, 13470.730585388237, 13511.05422620407, 13617.795733064011, 10845.240833141763, 10937.945310273397, 11017.504212310465, 11779.234349767237, 13562.254076025913, 9007.81984360309, 10035.448050357301, 10073.445960472245, 10119.988001199821, 10277.229207809294, 6064.939350606437, 6365.586236894587, 6461.870762584816, 6470.158879345655, 6584.308647591934, 10086.89913100889, 11945.581904633644, 12216.938915305367, 12239.938800306298, 12247.448864800926, 12070.879291207328, 12181.939090304491, 12420.316882571546, 12486.37568121572, 12492.312922789333, 7057.788266352018, 7260.745873894389, 8132.471389359909, 8158.673653053811, 8347.582620869054, 10338.172946164439, 10363.533640986023, 10464.843027354747, 10474.057334839596, 10515.369077855354, 9136.04071572502, 9166.0, 9204.401713888576, 9262.0, 9388.24894008464, 8707.47755134694, 8753.562321884008, 8806.559672016501, 8958.328125390752, 8997.32520060985, 6684.699188536625, 7820.569868657279, 7835.0, 7941.761747147595, 7975.7607271781935, 5572.554195664256, 5750.568707347049, 5922.697006658528, 5969.910451343147, 6051.939480605138, 5901.409859014236, 5909.143174239797, 5928.8814223716145, 6017.939820601913, 6116.0], "value": 5051.288455840742, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.94510823376476, 380.93524100902846, 384.48671024182715, 391.69252137072397, 393.4118492853185, 4583.862484125473, 4640.195040067142, 4772.379590653219, 5205.557527610148, 5375.704336261504, 5180.766865491052, 5202.583793296537, 5210.791568337271, 5220.5382492902045, 5279.947200527993, 4057.8782636520805, 4207.684423668237, 4348.325894530605, 4348.826046958118, 4391.165678521087, 3688.9341968497592, 3982.820773065219, 4329.9567004329865, 4339.652827773771, 4384.912301753963, 4118.938215926763, 4399.208142534342, 4411.580899814512, 4413.536578659243, 4420.690551661385, 3363.5459213006175, 3650.8357123929486, 4372.0, 4421.867343979686, 4431.335299705038, 3688.9077773055888, 3812.0, 3937.5078115235597, 4022.3966405039187, 4045.6358927696647, 4034.798260087013, 4927.728974906378, 5143.3570803649545, 5152.330197074394, 5186.325777648882, 4206.520056140201, 4351.43431353922, 4861.2222044473065, 4973.52751488608, 5002.3492247558215, 5353.197020446964, 5472.199468563335, 5560.0, 5646.463585959327, 5651.802186923479, 3890.824912878927, 4176.91646167078, 4251.787410629487, 4489.149390137253, 4505.639548836085, 5141.948580514184, 5177.948220517785, 5357.383900851374, 5665.943340566583, 5685.289338832646, 4100.876973690794, 4391.802368893407, 4397.538258482813, 4541.84103556374, 4590.8163673453355, 3962.3848260148166, 4033.0119120815, 4556.134334476439, 4652.2088995736885, 4684.8360307389075, 4132.462779838602, 4545.4545454545005, 4713.252963893713, 4760.714357138583, 5115.616328775357, 4752.572268495852, 5199.48005199477, 5467.4532546745, 5548.91676624851, 5601.9552863204635, 1384.0104325407383, 1541.8744316648908, 1579.3208920164438, 1579.778830963666, 1590.9284082216327, 1083.469100140941, 1120.9327440353604, 1124.2186680257144, 1175.753091850721, 1189.8929096381366, 4333.972591793505, 4462.799174037176, 5243.764030618631, 5288.312519372457, 5409.161579955114, 5744.770209191669, 5859.589828711949, 5868.0, 5889.646621202742, 5911.3201981772645, 4746.288056791509, 4971.483697472306, 5305.045091883421, 5317.059273365194, 5344.679319240858, 2673.1555226893383, 2674.9331266718486, 2701.783857291412, 2947.3663162419753, 3057.6636569977286, 5487.204355368449, 5766.250387449605, 5801.767929282866, 6069.484093852072, 6092.51259899207, 5421.728913554307, 5623.325200975827, 5937.554683398763, 5939.762409503658, 6051.425114614105, 5363.597730170175, 5656.1798539212405, 5868.706564671749, 5912.615679980788, 6055.273367195965, 5245.554127899171, 5832.650040997553, 5840.2991641003355, 5881.264841894763, 5911.91132133027, 5247.842564723064, 5297.318363737166, 5442.700651464207, 5758.539316854558, 5789.421057894177, 5510.713054082671, 5807.245058142415, 6098.725557350019, 6106.358832322542, 6117.204763380732, 4118.755278373354, 4372.688193541861, 4491.236489796677, 4633.374494443207, 4680.929786053144, 5005.649604527648, 5738.225339579103, 5809.302883653989, 5825.533957283492, 5838.649681019152, 5440.483154100354, 5463.514101083918, 5630.5214056805635, 5657.943420565906, 5664.830055098354, 4267.30877790715, 5584.525315348241, 5647.6893770843, 5666.886662266649, 5676.829695109153, 5189.1837856749835, 5423.779649578813, 5482.451754824645, 5484.409521238956, 5509.917351239815, 5282.47175282484, 5359.283830229373, 5621.325440947113, 5650.350209725934, 5678.416320574046, 5159.638825282344, 5451.754671039734, 5457.290552228185, 5510.0, 5511.917321240265], "value": 4281.2942652585525, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.3238491048596, 707.1761397971363, 738.6085374751381, 792.2236208515654, 851.5316575883264, 15192.848071519282, 16130.0, 16132.19339033048, 16169.43406980756, 16171.0, 14907.92546037271, 15103.773443398359, 15116.622084447894, 15123.092614443114, 15139.015963962334, 912.1790388650218, 927.7680579855037, 941.1529623338981, 952.2429668413594, 957.4638202606562, 963.4749061761322, 966.0580933589764, 966.2897770138977, 969.0212884986145, 972.2270794718216, 891.5675897189858, 1003.8694969653935, 1004.2518323848743, 1010.9494525273743, 1017.1506791828832, 982.3516479123743, 995.4873240281261, 998.2313618513776, 999.9150072243868, 1000.489750227382, 738.5199620246882, 741.4179868802963, 745.1542499263321, 747.9626018699043, 748.5359077372065, 16106.953048051839, 16319.673606527804, 16362.263698133613, 16650.916745416318, 16923.3230670773, 11980.221285616493, 14007.929960350235, 14295.78556321656, 14332.355044023045, 14357.497487587885, 11729.4135293235, 11933.0, 11967.940160299142, 11969.222000570022, 12012.39938003105, 3633.4913112164318, 3654.671079602822, 3700.093477098128, 3711.5731690855628, 3853.8823741115043, 102340.0, 111796.76406471906, 119544.99999999913, 122874.54250914932, 124807.75192248051, 8790.0, 9178.586963586655, 9507.144357007764, 10773.569057237779, 10918.399488028235, 17820.643587128445, 18571.72142417865, 21977.34067977963, 22287.665685014737, 22552.872356382115, 6809.897851532231, 6939.861202775916, 7758.844823103506, 7787.3770098392, 7790.727324543727, 4347.500037495728, 4351.673624478177, 4453.3320001999955, 4516.299973504112, 4532.750698711602, 3466.6013408457848, 3518.7536872419196, 3540.8760693376125, 3576.7675101118343, 3580.785152890835, 581.1863391252197, 646.2438946432685, 651.5081113759177, 653.9084528166061, 655.2464665634558, 656.4190691238193, 663.2935923241732, 683.4122654517112, 697.7801992372387, 714.6462501061903, 9961.55173017216, 10061.849072263922, 10278.588856445658, 10312.742181445374, 10601.098906593026, 689.2211800665216, 690.9136357955256, 691.4917535611322, 691.989620155698, 707.1549498349526, 4676.55572720591, 4974.253861920741, 4994.450610432849, 5002.174641184237, 5007.624428167902, 83342.58328708318, 85774.0, 98202.50898745461, 99487.0, 106220.0, 76954.6152269235, 77778.61110694523, 88412.0, 88918.0, 94526.52736736272, 68002.29994250085, 70146.0, 74511.25488745043, 75588.62205688936, 77361.0, 9298.535073246447, 10432.947835260775, 11079.335239885633, 11319.377434241196, 11363.090952723596, 42836.35745463758, 44544.0, 45535.77232113818, 46811.29783053189, 47389.76305118452, 50111.74944125256, 59916.10125848029, 66429.0, 67902.66048669725, 68606.28484287932, 11673.416329183678, 13718.65703357424, 13927.651808704459, 13952.860471395155, 14098.0, 14504.782428263796, 14563.927180364455, 14768.18774967387, 15230.086194828345, 15359.539213823604, 11516.424178791194, 12098.516059357527, 13465.798013029616, 13636.973470412171, 14026.088304260598, 13432.664183395102, 14363.56909292723, 14594.124352538882, 14806.0, 14856.33146508388, 13184.736305274033, 13459.865401345862, 13587.932060339635, 13610.115342502706, 13905.23521206303, 10889.401082940514, 11139.72150696239, 11450.828237576276, 11460.197786155222, 11865.703357415789, 9561.282903782105, 10501.31741436804, 10536.525856336637, 11377.772444551229, 11716.179867409199], "value": 7623.532774543744, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 108.0, 170.0, 122.0, 120.0, 120.0, 125.0, 126.0, 121.0, 122.0], "value": 127.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 143.0, 140.0, 142.0, 116.0, 112.0, 111.0, 115.0, 132.0, 111.0], "value": 126.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 201.0, 198.0, 237.0, 251.0, 204.0, 267.0, 290.0, 199.0, 196.0], "value": 224.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 57.0, 51.0, 97.0, 76.0, 51.0, 52.0, 60.0, 97.0, 84.0], "value": 71.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 57.0, 73.0, 59.0, 74.0, 102.0, 114.0, 103.0, 91.0, 82.0], "value": 85.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 80.0, 136.0, 98.0, 137.0, 105.0, 93.0, 92.0, 82.0, 135.0], "value": 104.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 98.0, 99.0, 151.0, 98.0, 96.0, 99.0, 98.0, 97.0, 98.0], "value": 104.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 120.0, 91.0, 93.0, 89.0, 91.0, 101.0, 91.0, 90.0, 92.0], "value": 100.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 66.0, 67.0, 69.0, 69.0, 85.0, 103.0, 106.0, 76.0], "value": 77.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 58.0, 71.0, 67.0, 63.0, 58.0, 59.0, 58.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 105.0, 110.0, 88.0, 92.0, 96.0, 111.0, 105.0, 75.0, 72.0], "value": 94.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 139.0, 139.0, 140.0, 163.0, 162.0, 156.0, 185.0, 151.0], "value": 151.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 172.0, 165.0, 171.0, 192.0, 171.0, 167.0, 169.0, 165.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 63.0, 75.0, 85.0, 86.0, 87.0, 69.0, 65.0], "value": 72.9, "unit": "score"}]}]} 03:02:28 INFO - Return code: 0 03:02:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:02:28 ERROR - # TBPL SUCCESS # 03:02:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:02:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:02:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:02:28 INFO - 2017-03-22 03:02:28.307 screenresolution[1656:10531] starting screenresolution argv=screenresolution get 03:02:28 INFO - 2017-03-22 03:02:28.310 screenresolution[1656:10531] Display 0: 1600x1200x32@60 03:02:28 INFO - 2017-03-22 03:02:28.316 screenresolution[1657:10534] starting screenresolution argv=screenresolution list 03:02:28 INFO - Available Modes on Display 0 03:02:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:02:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:02:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:02:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:02:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:02:28 INFO - Intel Iris: 03:02:28 INFO - Chipset Model: Intel Iris 03:02:28 INFO - Type: GPU 03:02:28 INFO - Bus: Built-In 03:02:28 INFO - VRAM (Dynamic, Max): 1536 MB 03:02:28 INFO - Vendor: Intel (0x8086) 03:02:28 INFO - Device ID: 0x0a2e 03:02:28 INFO - Revision ID: 0x0009 03:02:28 INFO - Displays: 03:02:28 INFO - Display: 03:02:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:02:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:02:28 INFO - Display Serial Number: 1600x1200 60 03:02:28 INFO - Main Display: Yes 03:02:28 INFO - Mirror: Off 03:02:28 INFO - Online: Yes 03:02:28 INFO - Rotation: Supported 03:02:28 INFO - Return code: 0 03:02:28 INFO - Running post-action listener: _resource_record_post_action 03:02:28 INFO - [mozharness: 2017-03-22 10:02:28.549766Z] Finished run-tests step (success) 03:02:28 INFO - Running post-run listener: _resource_record_post_run 03:02:28 INFO - Total resource usage - Wall time: 1199s; CPU: 55.0%; Read bytes: 39033344; Write bytes: 514763776; Read time: 246; Write time: 1599 03:02:28 INFO - TinderboxPrint: CPU usage
54.6% 03:02:28 INFO - TinderboxPrint: I/O read bytes / time
39,033,344 / 246 03:02:28 INFO - TinderboxPrint: I/O write bytes / time
514,763,776 / 1,599 03:02:28 INFO - TinderboxPrint: CPU idle
2,177.5 (45.4%) 03:02:28 INFO - TinderboxPrint: CPU system
966.5 (20.1%) 03:02:28 INFO - TinderboxPrint: CPU user
1,653.7 (34.5%) 03:02:28 INFO - TinderboxPrint: Swap in / out
247,922,688 / 0 03:02:28 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 204380672; Write bytes: 202770432; Read time: 15727; Write time: 419 03:02:28 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 37034496; Write bytes: 301216768; Read time: 226; Write time: 1145 03:02:29 INFO - Running post-run listener: _upload_blobber_files 03:02:29 INFO - Blob upload gear active. 03:02:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:02:29 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 03:02:29 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:02:29 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:02:29 INFO - (blobuploader) - INFO - Open directory for files ... 03:02:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:02:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:02:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:02:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:02:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:02:30 INFO - (blobuploader) - INFO - Done attempting. 03:02:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:02:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:02:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:02:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:02:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:02:31 INFO - (blobuploader) - INFO - Done attempting. 03:02:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:02:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:02:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:02:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:02:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:02:32 INFO - (blobuploader) - INFO - Done attempting. 03:02:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:02:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:02:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:02:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:02:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:02:34 INFO - (blobuploader) - INFO - Done attempting. 03:02:34 INFO - (blobuploader) - INFO - Iteration through files over. 03:02:34 INFO - Return code: 0 03:02:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:02:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:02:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/236506e42a0f016d435c8a9ee80cfc97f5b56d8fd17a04bebc979c8bed83556be662eb70e31e21f8c7ba19ddad2d790df45f09f4526fad68fe65d0dde13f9d0d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a4830b0091d02e22906acc370bd89d270c058365c738008fd66d7de73cba9d99c43949a3457c58ddb1fcb6b9b0b79a5f4d9bbc0175bd0cb012cf75d62481331", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/baff5bf5c029368e663635a850a781f8809a8a65c83dd53146c280e257ff10b686be65abc14a1cb20f45afdbd6a5fd081b6b27be83fefe555e5e0869bcc26aaf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1f8accd7e6495ad4180a9212537f13edfc5936d81a28bd370d30f265607789d478c4072f7e531669d4201b6474d077b6d27083d3dceac40c6475716997b7d72"} 03:02:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:02:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:02:34 INFO - Contents: 03:02:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/236506e42a0f016d435c8a9ee80cfc97f5b56d8fd17a04bebc979c8bed83556be662eb70e31e21f8c7ba19ddad2d790df45f09f4526fad68fe65d0dde13f9d0d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a4830b0091d02e22906acc370bd89d270c058365c738008fd66d7de73cba9d99c43949a3457c58ddb1fcb6b9b0b79a5f4d9bbc0175bd0cb012cf75d62481331", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/baff5bf5c029368e663635a850a781f8809a8a65c83dd53146c280e257ff10b686be65abc14a1cb20f45afdbd6a5fd081b6b27be83fefe555e5e0869bcc26aaf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1f8accd7e6495ad4180a9212537f13edfc5936d81a28bd370d30f265607789d478c4072f7e531669d4201b6474d077b6d27083d3dceac40c6475716997b7d72"} 03:02:34 INFO - Running post-run listener: copy_logs_to_upload_dir 03:02:34 INFO - Copying logs to upload dir... 03:02:34 INFO - mkdir: /builds/slave/test/build/upload/logs 03:02:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.761923 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-03-22 03:02:34.950885) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 03:02:34.953965) ========= 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.IFUIUl4IHY/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.2UB14kjP4x/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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/Mozilla-Aurora/sha512/236506e42a0f016d435c8a9ee80cfc97f5b56d8fd17a04bebc979c8bed83556be662eb70e31e21f8c7ba19ddad2d790df45f09f4526fad68fe65d0dde13f9d0d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a4830b0091d02e22906acc370bd89d270c058365c738008fd66d7de73cba9d99c43949a3457c58ddb1fcb6b9b0b79a5f4d9bbc0175bd0cb012cf75d62481331", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/baff5bf5c029368e663635a850a781f8809a8a65c83dd53146c280e257ff10b686be65abc14a1cb20f45afdbd6a5fd081b6b27be83fefe555e5e0869bcc26aaf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1f8accd7e6495ad4180a9212537f13edfc5936d81a28bd370d30f265607789d478c4072f7e531669d4201b6474d077b6d27083d3dceac40c6475716997b7d72"} build_url:https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010977 build_url: 'https://queue.taskcluster.net/v1/task/GUxQBNQ9RPWM_6yF3tCUuw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/236506e42a0f016d435c8a9ee80cfc97f5b56d8fd17a04bebc979c8bed83556be662eb70e31e21f8c7ba19ddad2d790df45f09f4526fad68fe65d0dde13f9d0d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0a4830b0091d02e22906acc370bd89d270c058365c738008fd66d7de73cba9d99c43949a3457c58ddb1fcb6b9b0b79a5f4d9bbc0175bd0cb012cf75d62481331", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/baff5bf5c029368e663635a850a781f8809a8a65c83dd53146c280e257ff10b686be65abc14a1cb20f45afdbd6a5fd081b6b27be83fefe555e5e0869bcc26aaf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b1f8accd7e6495ad4180a9212537f13edfc5936d81a28bd370d30f265607789d478c4072f7e531669d4201b6474d077b6d27083d3dceac40c6475716997b7d72"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 03:02:34.987708) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 03:02:34.988039) ========= 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.IFUIUl4IHY/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.2UB14kjP4x/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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.005119 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 03:02:35.036562) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 03:02:35.036902) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 03:02:35.037233) ========= ========= Total master_lag: 0.18 =========