builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0080 starttime: 1486602273.26 results: success (0) buildid: 20170208154822 builduid: aca3930e4184426fa445d5cd9b194885 revision: 438b18daff7aa9a760f2435c1d89f188c7c4c13e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 17:04:33.257337) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 17:04:33.257845) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 17:04:33.258153) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 17:04:33.282698) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 17:04:33.283085) ========= 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.8b8eORm3kX/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.Qp0tdMomKV/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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-02-08 17:04:33-- 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% 7.92M=0.001s 2017-02-08 17:04:33 (7.92 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105746 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 17:04:33.411734) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 17:04:33.412046) ========= 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.8b8eORm3kX/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.Qp0tdMomKV/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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.019775 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 17:04:33.461685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-08 17:04:33.462037) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 438b18daff7aa9a760f2435c1d89f188c7c4c13e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 438b18daff7aa9a760f2435c1d89f188c7c4c13e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8b8eORm3kX/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.Qp0tdMomKV/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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-02-08 17:04:33,537 truncating revision to first 12 chars 2017-02-08 17:04:33,537 Setting DEBUG logging. 2017-02-08 17:04:33,538 attempt 1/10 2017-02-08 17:04:33,538 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/438b18daff7a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-08 17:04:34,556 unpacking tar archive at: mozilla-central-438b18daff7a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.274262 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-08 17:04:34.759599) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 17:04:34.759922) ========= script_repo_revision: 438b18daff7aa9a760f2435c1d89f188c7c4c13e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 17:04:34.760316) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 17:04:34.760582) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 17:04:34.780148) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-08 17:04:34.780595) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8b8eORm3kX/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.Qp0tdMomKV/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 17:04:34 INFO - MultiFileLogger online at 20170208 17:04:34 in /builds/slave/test 17:04:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:04:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:04:34 INFO - {'append_to_log': False, 17:04:34 INFO - 'base_work_dir': '/builds/slave/test', 17:04:34 INFO - 'blob_upload_branch': 'Firefox', 17:04:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:04:34 INFO - 'branch': 'Firefox', 17:04:34 INFO - 'buildbot_json_path': 'buildprops.json', 17:04:34 INFO - 'config_files': ('talos/mac_config.py',), 17:04:34 INFO - 'default_actions': ('clobber', 17:04:34 INFO - 'read-buildbot-config', 17:04:34 INFO - 'download-and-extract', 17:04:34 INFO - 'populate-webroot', 17:04:34 INFO - 'create-virtualenv', 17:04:34 INFO - 'install', 17:04:34 INFO - 'run-tests'), 17:04:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:04:34 INFO - 'download_minidump_stackwalk': True, 17:04:34 INFO - 'download_symbols': 'ondemand', 17:04:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:04:34 INFO - 'tooltool.py': '/tools/tooltool.py', 17:04:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:04:34 INFO - '/tools/misc-python/virtualenv.py')}, 17:04:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:04:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:04:34 INFO - 'installer_path': 'installer.exe', 17:04:34 INFO - 'log_level': 'info', 17:04:34 INFO - 'log_name': 'talos', 17:04:34 INFO - 'log_to_console': True, 17:04:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:04:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:04:34 INFO - 'opt_config_files': (), 17:04:34 INFO - 'pip_index': False, 17:04:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:04:34 INFO - 'cmd': ('bash', 17:04:34 INFO - '-c', 17:04:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:04:34 INFO - 'enabled': True, 17:04:34 INFO - 'halt_on_failure': False, 17:04:34 INFO - 'name': 'check_screen_resolution'},), 17:04:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:04:34 INFO - 'cmd': ('bash', 17:04:34 INFO - '-c', 17:04:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:04:34 INFO - 'enabled': True, 17:04:34 INFO - 'halt_on_failure': False, 17:04:34 INFO - 'name': 'check_screen_resolution'},), 17:04:34 INFO - 'run_cmd_checks_enabled': True, 17:04:34 INFO - 'sps_profile': False, 17:04:34 INFO - 'sps_profile_interval': 0, 17:04:34 INFO - 'suite': 'dromaeojs-e10s', 17:04:34 INFO - 'system_bits': '32', 17:04:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:04:34 INFO - 'title': 't-yosemite-r7-0080', 17:04:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:04:34 INFO - 'use_talos_json': True, 17:04:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:04:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:04:34 INFO - 'work_dir': 'build'} 17:04:34 INFO - [mozharness: 2017-02-09 01:04:34.984615Z] Running clobber step. 17:04:34 INFO - Running pre-action listener: _resource_record_pre_action 17:04:34 INFO - Running main action method: clobber 17:04:34 INFO - rmtree: /builds/slave/test/build 17:04:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:04:36 INFO - Running post-action listener: _resource_record_post_action 17:04:36 INFO - [mozharness: 2017-02-09 01:04:36.683768Z] Finished clobber step (success) 17:04:36 INFO - [mozharness: 2017-02-09 01:04:36.683910Z] Running read-buildbot-config step. 17:04:36 INFO - Running pre-action listener: _resource_record_pre_action 17:04:36 INFO - Running main action method: read_buildbot_config 17:04:36 INFO - Using buildbot properties: 17:04:36 INFO - { 17:04:36 INFO - "project": "", 17:04:36 INFO - "product": "firefox", 17:04:36 INFO - "script_repo_revision": "production", 17:04:36 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:04:36 INFO - "repository": "", 17:04:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:04:36 INFO - "buildid": "20170208154822", 17:04:36 INFO - "pgo_build": "False", 17:04:36 INFO - "basedir": "/builds/slave/test", 17:04:36 INFO - "buildnumber": 136, 17:04:36 INFO - "slavename": "t-yosemite-r7-0080", 17:04:36 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 17:04:36 INFO - "platform": "yosemite_r7", 17:04:36 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:04:36 INFO - "branch": "mozilla-central", 17:04:36 INFO - "repo_path": "mozilla-central", 17:04:36 INFO - "revision": "438b18daff7aa9a760f2435c1d89f188c7c4c13e", 17:04:36 INFO - "stage_platform": "macosx64", 17:04:36 INFO - "builduid": "aca3930e4184426fa445d5cd9b194885", 17:04:36 INFO - "slavebuilddir": "test" 17:04:36 INFO - } 17:04:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 17:04:36 INFO - Running post-action listener: _resource_record_post_action 17:04:36 INFO - [mozharness: 2017-02-09 01:04:36.687319Z] Finished read-buildbot-config step (success) 17:04:36 INFO - [mozharness: 2017-02-09 01:04:36.687441Z] Running download-and-extract step. 17:04:36 INFO - Running pre-action listener: _resource_record_pre_action 17:04:36 INFO - Running main action method: download_and_extract 17:04:36 INFO - mkdir: /builds/slave/test/build/tests 17:04:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:36 INFO - trying https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 17:04:36 INFO - Downloading https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 17:04:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 17:04:37 INFO - Downloaded 1199 bytes. 17:04:37 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 17:04:37 INFO - Using the following test package requirements: 17:04:37 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 17:04:37 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:04:37 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 17:04:37 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:04:37 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 17:04:37 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:04:37 INFO - u'jsshell-mac.zip'], 17:04:37 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:04:37 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 17:04:37 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 17:04:37 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:04:37 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 17:04:37 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:04:37 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 17:04:37 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:04:37 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 17:04:37 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 17:04:37 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 17:04:37 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:04:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 17:04:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:04:37 INFO - Fetch https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 17:04:38 INFO - Expected file size: 34939103 17:04:38 INFO - Obtained file size: 34939103 17:04:45 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:04:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 17:04:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:04:45 INFO - Fetch https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 17:04:47 INFO - Expected file size: 34939103 17:04:47 INFO - Obtained file size: 34939103 17:04:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 17:04:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:04:53 INFO - Fetch https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 17:04:54 INFO - Expected file size: 14403454 17:04:54 INFO - Obtained file size: 14403454 17:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:04:55 INFO - trying https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:04:55 INFO - Downloading https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 17:04:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 17:04:57 INFO - Downloaded 70364462 bytes. 17:04:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:04:57 INFO - mkdir: /builds/slave/test/properties 17:04:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:04:57 INFO - Writing to file /builds/slave/test/properties/build_url 17:04:57 INFO - Contents: 17:04:57 INFO - build_url:https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 17:04:57 INFO - Running post-action listener: _resource_record_post_action 17:04:57 INFO - Running post-action listener: set_extra_try_arguments 17:04:57 INFO - [mozharness: 2017-02-09 01:04:57.817229Z] Finished download-and-extract step (success) 17:04:57 INFO - [mozharness: 2017-02-09 01:04:57.817362Z] Running populate-webroot step. 17:04:57 INFO - Running pre-action listener: _resource_record_pre_action 17:04:57 INFO - Running main action method: populate_webroot 17:04:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:04:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:04:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:04:57 INFO - '--tppagecycles', 17:04:57 INFO - '7'], 17:04:57 INFO - 'tests': ['tsvgm']}}, 17:04:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:04:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:04:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:04:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:04:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:04:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:04:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:04:57 INFO - 'talos_options': ['--disable-e10s'], 17:04:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:04:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:04:57 INFO - 'talos_options': ['--disable-e10s'], 17:04:57 INFO - 'tests': ['damp', 'tps']}, 17:04:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:04:57 INFO - 'tests': ['damp', 'tps']}, 17:04:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:04:57 INFO - 'tests': ['dromaeo_dom']}, 17:04:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:04:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:04:57 INFO - 'tests': ['basic_compositor_video']}, 17:04:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:04:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:04:57 INFO - 'tests': ['a11yr', 17:04:57 INFO - 'ts_paint', 17:04:57 INFO - 'tpaint', 17:04:57 INFO - 'sessionrestore', 17:04:57 INFO - 'sessionrestore_no_auto_restore', 17:04:57 INFO - 'tabpaint']}, 17:04:57 INFO - 'other-e10s': {'tests': ['a11yr', 17:04:57 INFO - 'ts_paint', 17:04:57 INFO - 'tpaint', 17:04:57 INFO - 'sessionrestore', 17:04:57 INFO - 'sessionrestore_no_auto_restore', 17:04:57 INFO - 'tabpaint']}, 17:04:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:04:57 INFO - 'ts_paint', 17:04:57 INFO - 'tpaint', 17:04:57 INFO - 'sessionrestore', 17:04:57 INFO - 'sessionrestore_no_auto_restore', 17:04:57 INFO - 'tabpaint']}, 17:04:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:04:57 INFO - 'ts_paint', 17:04:57 INFO - 'tpaint', 17:04:57 INFO - 'sessionrestore', 17:04:57 INFO - 'sessionrestore_no_auto_restore', 17:04:57 INFO - 'tabpaint']}, 17:04:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:04:57 INFO - 'tests': ['a11yr', 17:04:57 INFO - 'ts_paint', 17:04:57 INFO - 'tpaint', 17:04:57 INFO - 'sessionrestore', 17:04:57 INFO - 'sessionrestore_no_auto_restore', 17:04:57 INFO - 'tabpaint']}, 17:04:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:04:57 INFO - 'tests': ['a11yr', 17:04:57 INFO - 'ts_paint', 17:04:57 INFO - 'tpaint', 17:04:57 INFO - 'sessionrestore', 17:04:57 INFO - 'sessionrestore_no_auto_restore', 17:04:57 INFO - 'tabpaint']}, 17:04:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:04:57 INFO - 'tests': ['tsvgx', 17:04:57 INFO - 'tsvgr_opacity', 17:04:57 INFO - 'tart', 17:04:57 INFO - 'tscrollx', 17:04:57 INFO - 'cart', 17:04:57 INFO - 'tsvg_static']}, 17:04:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:04:57 INFO - 'tsvgr_opacity', 17:04:57 INFO - 'tart', 17:04:57 INFO - 'tscrollx', 17:04:57 INFO - 'cart', 17:04:57 INFO - 'tsvg_static']}, 17:04:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:04:57 INFO - 'talos_options': ['--disable-e10s'], 17:04:57 INFO - 'tests': ['tp5o']}, 17:04:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:04:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:04:57 INFO - 'talos_options': ['--disable-e10s', 17:04:57 INFO - '--xperf_path', 17:04:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:57 INFO - 'tests': ['tp5n']}, 17:04:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:04:57 INFO - 'talos_options': ['--xperf_path', 17:04:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:57 INFO - 'tests': ['tp5n']}}, 17:04:57 INFO - 'talos.zip': {'path': '', 17:04:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:04:57 INFO - Running post-action listener: _resource_record_post_action 17:04:57 INFO - [mozharness: 2017-02-09 01:04:57.835502Z] Finished populate-webroot step (success) 17:04:57 INFO - [mozharness: 2017-02-09 01:04:57.835639Z] Running create-virtualenv step. 17:04:57 INFO - Running pre-action listener: _resource_record_pre_action 17:04:57 INFO - Running main action method: create_virtualenv 17:04:57 INFO - Creating virtualenv /builds/slave/test/build/venv 17:04:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:04:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:04:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:04:57 INFO - Using real prefix '/tools/python27' 17:04:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:04:58 INFO - Installing distribute.............................................................................................................................................................................................done. 17:05:01 INFO - Installing pip.................done. 17:05:01 INFO - Return code: 0 17:05:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:05:01 INFO - Reading from file tmpfile_stdout 17:05:01 INFO - Output received: 17:05:01 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 17:05:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:01 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 0x10f72ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f72d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe670466480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f508d30>, '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 0x10f42fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fdbe8>, '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.8b8eORm3kX/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.Qp0tdMomKV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:05:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:05:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8b8eORm3kX/Render', 17:05:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:05:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:05:01 INFO - 'HOME': '/Users/cltbld', 17:05:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:05:01 INFO - 'LOGNAME': 'cltbld', 17:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:01 INFO - 'MOZ_NO_REMOTE': '1', 17:05:01 INFO - 'NO_EM_RESTART': '1', 17:05:01 INFO - 'PAGER': '/bin/cat', 17:05:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:01 INFO - 'PWD': '/builds/slave/test', 17:05:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:05:01 INFO - 'SHELL': '/bin/bash', 17:05:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qp0tdMomKV/Listeners', 17:05:01 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 17:05:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:05:01 INFO - 'USER': 'cltbld', 17:05:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:05:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:01 INFO - 'XPC_FLAGS': '0x0', 17:05:01 INFO - 'XPC_SERVICE_NAME': '0', 17:05:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:05:02 INFO - Cleaning up... 17:05:02 INFO - Return code: 0 17:05:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:02 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 0x10f72ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f72d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe670466480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f508d30>, '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 0x10f42fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fdbe8>, '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.8b8eORm3kX/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.Qp0tdMomKV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:05:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:05:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8b8eORm3kX/Render', 17:05:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:05:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:05:02 INFO - 'HOME': '/Users/cltbld', 17:05:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:05:02 INFO - 'LOGNAME': 'cltbld', 17:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:02 INFO - 'MOZ_NO_REMOTE': '1', 17:05:02 INFO - 'NO_EM_RESTART': '1', 17:05:02 INFO - 'PAGER': '/bin/cat', 17:05:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:02 INFO - 'PWD': '/builds/slave/test', 17:05:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:05:02 INFO - 'SHELL': '/bin/bash', 17:05:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qp0tdMomKV/Listeners', 17:05:02 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 17:05:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:05:02 INFO - 'USER': 'cltbld', 17:05:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:05:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:02 INFO - 'XPC_FLAGS': '0x0', 17:05:02 INFO - 'XPC_SERVICE_NAME': '0', 17:05:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:02 INFO - Downloading/unpacking psutil>=3.1.1 17:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:05:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:05:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:05:05 INFO - Installing collected packages: psutil 17:05:05 INFO - Running setup.py install for psutil 17:05:05 INFO - building 'psutil._psutil_osx' extension 17:05:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:05:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:05:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:05:06 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 17:05:06 INFO - building 'psutil._psutil_posix' extension 17:05:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:05:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:05:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:05:06 INFO - ^ 17:05:06 INFO - 1 warning generated. 17:05:06 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:05:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:05:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:05:06 INFO - Successfully installed psutil 17:05:06 INFO - Cleaning up... 17:05:06 INFO - Return code: 0 17:05:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:06 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 0x10f72ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f72d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe670466480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f508d30>, '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 0x10f42fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fdbe8>, '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.8b8eORm3kX/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.Qp0tdMomKV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:05:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:05:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8b8eORm3kX/Render', 17:05:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:05:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:05:06 INFO - 'HOME': '/Users/cltbld', 17:05:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:05:06 INFO - 'LOGNAME': 'cltbld', 17:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:06 INFO - 'MOZ_NO_REMOTE': '1', 17:05:06 INFO - 'NO_EM_RESTART': '1', 17:05:06 INFO - 'PAGER': '/bin/cat', 17:05:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:06 INFO - 'PWD': '/builds/slave/test', 17:05:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:05:06 INFO - 'SHELL': '/bin/bash', 17:05:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qp0tdMomKV/Listeners', 17:05:06 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 17:05:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:05:06 INFO - 'USER': 'cltbld', 17:05:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:05:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:06 INFO - 'XPC_FLAGS': '0x0', 17:05:06 INFO - 'XPC_SERVICE_NAME': '0', 17:05:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:05:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:05:09 INFO - Installing collected packages: mozsystemmonitor 17:05:09 INFO - Running setup.py install for mozsystemmonitor 17:05:09 INFO - Successfully installed mozsystemmonitor 17:05:09 INFO - Cleaning up... 17:05:09 INFO - Return code: 0 17:05:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:09 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 0x10f72ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f72d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe670466480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f508d30>, '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 0x10f42fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fdbe8>, '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.8b8eORm3kX/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.Qp0tdMomKV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:05:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:05:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:05:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8b8eORm3kX/Render', 17:05:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:05:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:05:09 INFO - 'HOME': '/Users/cltbld', 17:05:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:05:09 INFO - 'LOGNAME': 'cltbld', 17:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:09 INFO - 'MOZ_NO_REMOTE': '1', 17:05:09 INFO - 'NO_EM_RESTART': '1', 17:05:09 INFO - 'PAGER': '/bin/cat', 17:05:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:09 INFO - 'PWD': '/builds/slave/test', 17:05:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:05:09 INFO - 'SHELL': '/bin/bash', 17:05:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qp0tdMomKV/Listeners', 17:05:09 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 17:05:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:05:09 INFO - 'USER': 'cltbld', 17:05:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:05:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:09 INFO - 'XPC_FLAGS': '0x0', 17:05:09 INFO - 'XPC_SERVICE_NAME': '0', 17:05:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:10 INFO - Downloading/unpacking jsonschema==2.5.1 17:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:05:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:13 INFO - Downloading functools32-3.2.3-2.tar.gz 17:05:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:05:13 INFO - warning: no files found matching '*.txt' 17:05:13 INFO - no previously-included directories found matching 'build' 17:05:13 INFO - no previously-included directories found matching 'dist' 17:05:13 INFO - no previously-included directories found matching '.git*' 17:05:13 INFO - Installing collected packages: jsonschema, functools32 17:05:13 INFO - Running setup.py install for functools32 17:05:13 INFO - warning: no files found matching '*.txt' 17:05:13 INFO - no previously-included directories found matching 'build' 17:05:13 INFO - no previously-included directories found matching 'dist' 17:05:13 INFO - no previously-included directories found matching '.git*' 17:05:13 INFO - Successfully installed jsonschema functools32 17:05:13 INFO - Cleaning up... 17:05:13 INFO - Return code: 0 17:05:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:13 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 0x10f72ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f72d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe670466480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f508d30>, '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 0x10f42fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fdbe8>, '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.8b8eORm3kX/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.Qp0tdMomKV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:05:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:05:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:05:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8b8eORm3kX/Render', 17:05:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:05:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:05:13 INFO - 'HOME': '/Users/cltbld', 17:05:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:05:13 INFO - 'LOGNAME': 'cltbld', 17:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:13 INFO - 'MOZ_NO_REMOTE': '1', 17:05:13 INFO - 'NO_EM_RESTART': '1', 17:05:13 INFO - 'PAGER': '/bin/cat', 17:05:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:13 INFO - 'PWD': '/builds/slave/test', 17:05:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:05:13 INFO - 'SHELL': '/bin/bash', 17:05:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qp0tdMomKV/Listeners', 17:05:13 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 17:05:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:05:13 INFO - 'USER': 'cltbld', 17:05:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:05:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:13 INFO - 'XPC_FLAGS': '0x0', 17:05:13 INFO - 'XPC_SERVICE_NAME': '0', 17:05:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:05:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:05:13 INFO - Cleaning up... 17:05:13 INFO - Return code: 0 17:05:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:13 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 0x10f72ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f72d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe670466480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f508d30>, '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 0x10f42fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fdbe8>, '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.8b8eORm3kX/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.Qp0tdMomKV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:05:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:05:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:05:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8b8eORm3kX/Render', 17:05:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:05:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:05:13 INFO - 'HOME': '/Users/cltbld', 17:05:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:05:13 INFO - 'LOGNAME': 'cltbld', 17:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:13 INFO - 'MOZ_NO_REMOTE': '1', 17:05:13 INFO - 'NO_EM_RESTART': '1', 17:05:13 INFO - 'PAGER': '/bin/cat', 17:05:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:13 INFO - 'PWD': '/builds/slave/test', 17:05:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:05:13 INFO - 'SHELL': '/bin/bash', 17:05:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qp0tdMomKV/Listeners', 17:05:13 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 17:05:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:05:13 INFO - 'USER': 'cltbld', 17:05:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:05:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:13 INFO - 'XPC_FLAGS': '0x0', 17:05:13 INFO - 'XPC_SERVICE_NAME': '0', 17:05:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:14 INFO - Downloading/unpacking blobuploader==1.2.4 17:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:16 INFO - Downloading blobuploader-1.2.4.tar.gz 17:05:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:05:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:05: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 17:05: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 17:05: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 17:05: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 17:05: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 17:05: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 17:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:05:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:17 INFO - Downloading docopt-0.6.1.tar.gz 17:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:05:17 INFO - Installing collected packages: blobuploader, requests, docopt 17:05:17 INFO - Running setup.py install for blobuploader 17:05:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:05:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:05:18 INFO - Running setup.py install for requests 17:05:18 INFO - Running setup.py install for docopt 17:05:18 INFO - Successfully installed blobuploader requests docopt 17:05:18 INFO - Cleaning up... 17:05:18 INFO - Return code: 0 17:05:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:18 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 0x10f72ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f72d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe670466480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f508d30>, '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 0x10f42fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fdbe8>, '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.8b8eORm3kX/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.Qp0tdMomKV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:05:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:05:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8b8eORm3kX/Render', 17:05:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:05:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:05:18 INFO - 'HOME': '/Users/cltbld', 17:05:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:05:18 INFO - 'LOGNAME': 'cltbld', 17:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:18 INFO - 'MOZ_NO_REMOTE': '1', 17:05:18 INFO - 'NO_EM_RESTART': '1', 17:05:18 INFO - 'PAGER': '/bin/cat', 17:05:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:18 INFO - 'PWD': '/builds/slave/test', 17:05:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:05:18 INFO - 'SHELL': '/bin/bash', 17:05:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qp0tdMomKV/Listeners', 17:05:18 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 17:05:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:05:18 INFO - 'USER': 'cltbld', 17:05:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:05:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:18 INFO - 'XPC_FLAGS': '0x0', 17:05:18 INFO - 'XPC_SERVICE_NAME': '0', 17:05:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:05:19 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-8h6mLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:05:19 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-sjkVZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:05:19 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-DF9nMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:05:19 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-xnlydd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:05:19 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-HumLAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:05:19 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-rSwLo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:05:19 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-DgxK1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:05:19 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-NZxnYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:05:19 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-DBbxmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:05:20 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-2VLnJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:05:20 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-XwFcbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:05:20 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-l3nLKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:05:20 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-PfBXND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:05:20 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-7FLqIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:05:20 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-ivRhrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:05:20 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-93xxbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:05:20 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-9ByJAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:05:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:05:20 INFO - Running setup.py install for manifestparser 17:05:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:05:20 INFO - Running setup.py install for mozcrash 17:05:21 INFO - Running setup.py install for mozdebug 17:05:21 INFO - Running setup.py install for mozdevice 17:05:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:05:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:05:21 INFO - Running setup.py install for mozfile 17:05:21 INFO - Running setup.py install for mozhttpd 17:05:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:05:21 INFO - Running setup.py install for mozinfo 17:05:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:05:21 INFO - Running setup.py install for mozInstall 17:05:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:05:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:05:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:05:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:05:22 INFO - Running setup.py install for mozleak 17:05:22 INFO - Running setup.py install for mozlog 17:05:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:05:22 INFO - Running setup.py install for moznetwork 17:05:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:05:22 INFO - Running setup.py install for mozprocess 17:05:22 INFO - Running setup.py install for mozprofile 17:05:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:05:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:05:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:05:22 INFO - Running setup.py install for mozrunner 17:05:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:05:22 INFO - Running setup.py install for mozscreenshot 17:05:23 INFO - Running setup.py install for moztest 17:05:23 INFO - Running setup.py install for mozversion 17:05:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:05:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:05:23 INFO - Cleaning up... 17:05:23 INFO - Return code: 0 17:05:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:23 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 0x10f72ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f72d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe670466480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f508d30>, '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 0x10f42fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fdbe8>, '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.8b8eORm3kX/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.Qp0tdMomKV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:05:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:05:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8b8eORm3kX/Render', 17:05:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:05:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:05:23 INFO - 'HOME': '/Users/cltbld', 17:05:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:05:23 INFO - 'LOGNAME': 'cltbld', 17:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:23 INFO - 'MOZ_NO_REMOTE': '1', 17:05:23 INFO - 'NO_EM_RESTART': '1', 17:05:23 INFO - 'PAGER': '/bin/cat', 17:05:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:23 INFO - 'PWD': '/builds/slave/test', 17:05:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:05:23 INFO - 'SHELL': '/bin/bash', 17:05:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qp0tdMomKV/Listeners', 17:05:23 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 17:05:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:05:23 INFO - 'USER': 'cltbld', 17:05:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:05:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:23 INFO - 'XPC_FLAGS': '0x0', 17:05:23 INFO - 'XPC_SERVICE_NAME': '0', 17:05:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:05:23 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-LreMwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:05:23 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:05:23 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-ii0vFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:05: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)) 17:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:05:23 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-uKZh63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:05:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:05:24 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-uv2xwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:05:24 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)) 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:05:24 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-9Qg6oq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:05:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:05:24 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-hlnXmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:05:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:05:24 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-yJsYrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:05:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:05:24 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-IrayEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:05:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:05:24 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-DE3tWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:05:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:05:24 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-mNBhDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:05:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:05:24 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-frVRrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:05:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:05:24 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-ppxTQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:05:25 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-EGbU5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:05:25 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-0ubDZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:05:25 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-3o3Se7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:05:25 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-tEtRnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:05:25 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-e0Mt_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:05:25 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)) 17:05:25 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)) 17:05:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:05:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:05:28 INFO - Downloading blessings-1.6.tar.gz 17:05:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:05:28 INFO - Installing collected packages: blessings 17:05:28 INFO - Running setup.py install for blessings 17:05:28 INFO - Successfully installed blessings 17:05:28 INFO - Cleaning up... 17:05:28 INFO - Return code: 0 17:05:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:05:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:05:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:05:28 INFO - Reading from file tmpfile_stdout 17:05:28 INFO - Current package versions: 17:05:28 INFO - blessings == 1.6 17:05:28 INFO - blobuploader == 1.2.4 17:05:28 INFO - docopt == 0.6.1 17:05:28 INFO - functools32 == 3.2.3-2 17:05:28 INFO - jsonschema == 2.5.1 17:05:28 INFO - manifestparser == 1.1 17:05:28 INFO - mozInstall == 1.12 17:05:28 INFO - mozcrash == 1.0 17:05:28 INFO - mozdebug == 0.1 17:05:28 INFO - mozdevice == 0.49 17:05:28 INFO - mozfile == 1.2 17:05:28 INFO - mozhttpd == 0.7 17:05:28 INFO - mozinfo == 0.9 17:05:28 INFO - mozleak == 0.1 17:05:28 INFO - mozlog == 3.4 17:05:28 INFO - moznetwork == 0.27 17:05:28 INFO - mozprocess == 0.24 17:05:28 INFO - mozprofile == 0.28 17:05:28 INFO - mozrunner == 6.13 17:05:28 INFO - mozscreenshot == 0.1 17:05:28 INFO - mozsystemmonitor == 0.3 17:05:28 INFO - moztest == 0.8 17:05:28 INFO - mozversion == 1.4 17:05:28 INFO - psutil == 3.1.1 17:05:28 INFO - requests == 1.2.3 17:05:28 INFO - wsgiref == 0.1.2 17:05:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:28 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 0x10f72ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f72d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe670466480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f508d30>, '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 0x10f42fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fdbe8>, '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.8b8eORm3kX/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.Qp0tdMomKV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:05:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:05:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:05:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8b8eORm3kX/Render', 17:05:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:05:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:05:28 INFO - 'HOME': '/Users/cltbld', 17:05:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:05:28 INFO - 'LOGNAME': 'cltbld', 17:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:28 INFO - 'MOZ_NO_REMOTE': '1', 17:05:28 INFO - 'NO_EM_RESTART': '1', 17:05:28 INFO - 'PAGER': '/bin/cat', 17:05:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:28 INFO - 'PWD': '/builds/slave/test', 17:05:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:05:28 INFO - 'SHELL': '/bin/bash', 17:05:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qp0tdMomKV/Listeners', 17:05:28 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 17:05:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:05:28 INFO - 'USER': 'cltbld', 17:05:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:05:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:28 INFO - 'XPC_FLAGS': '0x0', 17:05:28 INFO - 'XPC_SERVICE_NAME': '0', 17:05:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:05:29 INFO - Cleaning up... 17:05:29 INFO - Return code: 0 17:05:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:05:29 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 0x10f72ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f72d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe670466480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f508d30>, '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 0x10f42fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fdbe8>, '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.8b8eORm3kX/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.Qp0tdMomKV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 17:05:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:05:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8b8eORm3kX/Render', 17:05:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:05:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:05:29 INFO - 'HOME': '/Users/cltbld', 17:05:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:05:29 INFO - 'LOGNAME': 'cltbld', 17:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:29 INFO - 'MOZ_NO_REMOTE': '1', 17:05:29 INFO - 'NO_EM_RESTART': '1', 17:05:29 INFO - 'PAGER': '/bin/cat', 17:05:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:29 INFO - 'PWD': '/builds/slave/test', 17:05:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:05:29 INFO - 'SHELL': '/bin/bash', 17:05:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qp0tdMomKV/Listeners', 17:05:29 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 17:05:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:05:29 INFO - 'USER': 'cltbld', 17:05:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:05:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:29 INFO - 'XPC_FLAGS': '0x0', 17:05:29 INFO - 'XPC_SERVICE_NAME': '0', 17:05:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:05:29 INFO - Cleaning up... 17:05:29 INFO - Return code: 0 17:05:29 INFO - Running post-action listener: _resource_record_post_action 17:05:29 INFO - Running post-action listener: _start_resource_monitoring 17:05:29 INFO - Starting resource monitoring. 17:05:29 INFO - [mozharness: 2017-02-09 01:05:29.383991Z] Finished create-virtualenv step (success) 17:05:29 INFO - [mozharness: 2017-02-09 01:05:29.384960Z] Running install step. 17:05:29 INFO - Running pre-action listener: _resource_record_pre_action 17:05:29 INFO - Running main action method: install 17:05:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:05:29 INFO - Reading from file tmpfile_stdout 17:05:29 INFO - Detecting whether we're running mozinstall >=1.0... 17:05:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:05:29 INFO - Reading from file tmpfile_stdout 17:05:29 INFO - Output received: 17:05:29 INFO - Usage: mozinstall [options] installer 17:05:29 INFO - Options: 17:05:29 INFO - -h, --help show this help message and exit 17:05:29 INFO - -d DEST, --destination=DEST 17:05:29 INFO - Directory to install application into. [default: 17:05:29 INFO - "/builds/slave/test"] 17:05:29 INFO - --app=APP Application being installed. [default: firefox] 17:05:29 INFO - mkdir: /builds/slave/test/build/application 17:05:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:05:52 INFO - Reading from file tmpfile_stdout 17:05:52 INFO - Output received: 17:05:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:05:52 INFO - Running post-action listener: _resource_record_post_action 17:05:52 INFO - [mozharness: 2017-02-09 01:05:52.505140Z] Finished install step (success) 17:05:52 INFO - [mozharness: 2017-02-09 01:05:52.505274Z] Running run-tests step. 17:05:52 INFO - Running pre-action listener: _resource_record_pre_action 17:05:52 INFO - Running main action method: run_tests 17:05:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:05:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:05:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:05:52 INFO - 2017-02-08 17:05:52.519 screenresolution[1897:17261] starting screenresolution argv=screenresolution get 17:05:52 INFO - 2017-02-08 17:05:52.521 screenresolution[1897:17261] Display 0: 1600x1200x32@60 17:05:52 INFO - 2017-02-08 17:05:52.527 screenresolution[1898:17263] starting screenresolution argv=screenresolution list 17:05:52 INFO - Available Modes on Display 0 17:05:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:05:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:05:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:05:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:05:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:05:52 INFO - Intel Iris: 17:05:52 INFO - Chipset Model: Intel Iris 17:05:52 INFO - Type: GPU 17:05:52 INFO - Bus: Built-In 17:05:52 INFO - VRAM (Dynamic, Max): 1536 MB 17:05:52 INFO - Vendor: Intel (0x8086) 17:05:52 INFO - Device ID: 0x0a2e 17:05:52 INFO - Revision ID: 0x0009 17:05:52 INFO - Displays: 17:05:52 INFO - Display: 17:05:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:05:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:05:52 INFO - Display Serial Number: 1600x1200 60 17:05:52 INFO - Main Display: Yes 17:05:52 INFO - Mirror: Off 17:05:52 INFO - Online: Yes 17:05:52 INFO - Rotation: Supported 17:05:52 INFO - Return code: 0 17:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:05:52 INFO - Python 2.7.3 17:05:52 INFO - Return code: 0 17:05:52 INFO - grabbing minidump binary from tooltool 17:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:05:52 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 0x10f508d30>, '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 0x10f42fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4fdbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:05:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:05:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 17:05:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:05:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:05:52 INFO - Return code: 0 17:05:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:05:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:05:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:05:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:05:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0080 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:05:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8b8eORm3kX/Render', 17:05:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:05:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:05:52 INFO - 'HOME': '/Users/cltbld', 17:05:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:05:52 INFO - 'LOGNAME': 'cltbld', 17:05:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:05:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:05:52 INFO - 'MOZ_NO_REMOTE': '1', 17:05:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:05:52 INFO - 'NO_EM_RESTART': '1', 17:05:52 INFO - 'PAGER': '/bin/cat', 17:05:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:05:52 INFO - 'PWD': '/builds/slave/test', 17:05:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:05:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:05:52 INFO - 'SHELL': '/bin/bash', 17:05:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Qp0tdMomKV/Listeners', 17:05:52 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 17:05:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:05:52 INFO - 'USER': 'cltbld', 17:05:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:05:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:05:52 INFO - 'XPC_FLAGS': '0x0', 17:05:52 INFO - 'XPC_SERVICE_NAME': '0', 17:05:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:05:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:05:53 INFO - mozversion application_buildid: 20170208154822 17:05:53 INFO - mozversion application_changeset: 438b18daff7aa9a760f2435c1d89f188c7c4c13e 17:05:53 INFO - mozversion application_display_name: Nightly 17:05:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:05:53 INFO - mozversion application_name: Firefox 17:05:53 INFO - mozversion application_remotingname: firefox 17:05:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:05:53 INFO - mozversion application_vendor: Mozilla 17:05:53 INFO - mozversion application_version: 54.0a1 17:05:53 INFO - mozversion platform_buildid: 20170208154822 17:05:53 INFO - mozversion platform_changeset: 438b18daff7aa9a760f2435c1d89f188c7c4c13e 17:05:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:05:53 INFO - mozversion platform_version: 54.0a1 17:05:53 INFO - using testdate: 1486602353 17:05:53 INFO - actual date: 1486602353 17:05:53 INFO - starting webserver on 'localhost:54080' 17:05:53 INFO - SUITE-START | Running 2 tests 17:05:53 INFO - TEST-START | dromaeo_css 17:05:53 INFO - operating with platform_type : mac_ 17:05:53 INFO - Initialising browser for dromaeo_css test... 17:05:53 INFO - TEST-INFO | started process 1908 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpFtoTtV/profile http://localhost:54080/getInfo.html) 17:05:55 INFO - PROCESS | 1908 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 17:05:55 INFO - PROCESS | 1908 | 2017-02-08 17:05:55.893 plugin-container[1910:17416] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 17:05:55 INFO - PROCESS | 1908 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:05:55 INFO - PROCESS | 1908 | 2017-02-08 17:05:55.896 plugin-container[1910:17416] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 17:05:55 INFO - PROCESS | 1908 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:05:55 INFO - PROCESS | 1908 | 2017-02-08 17:05:55.896 plugin-container[1910:17416] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:05:55 INFO - PROCESS | 1908 | __metrics Screen width/height:1600/1200 17:05:55 INFO - PROCESS | 1908 | colorDepth:24 17:05:55 INFO - PROCESS | 1908 | Browser inner width/height: 1024/689 17:05:55 INFO - PROCESS | 1908 | __metrics 17:05:56 ERROR - PROCESS | 1908 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 17:05:56 INFO - TEST-INFO | 1908: exit 0 17:05:56 INFO - Browser initialized. 17:05:56 INFO - Running cycle 1/1 for dromaeo_css test... 17:05:56 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpFtoTtV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:05:59 INFO - PROCESS | 1911 | 2017-02-08 17:05:59.086 plugin-container[1912:17534] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 17:05:59 INFO - PROCESS | 1911 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:05:59 INFO - PROCESS | 1911 | 2017-02-08 17:05:59.087 plugin-container[1912:17534] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 17:05:59 INFO - PROCESS | 1911 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:05:59 INFO - PROCESS | 1911 | 2017-02-08 17:05:59.087 plugin-container[1912:17534] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:06:08 INFO - PROCESS | 1911 | RSS: Main: 233463808 17:06:08 INFO - PROCESS | 1911 | 17:09:11 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:54080/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54080/tests/dromaeo/cssquery-ext.html) 17:09:12 INFO - PROCESS | 1911 | RSS: Main: 252174336 17:09:12 INFO - PROCESS | 1911 | 17:10:57 INFO - PROCESS | 1911 | ************************* 17:10:57 INFO - PROCESS | 1911 | A coding exception was thrown and uncaught in a Task. 17:10:57 INFO - PROCESS | 1911 | 17:10:57 ERROR - PROCESS | 1911 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:10:57 INFO - PROCESS | 1911 | Full stack: 17:10:57 INFO - PROCESS | 1911 | ************************* 17:12:14 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:54080/tests/dromaeo/cssquery-ext.html (next: http://localhost:54080/tests/dromaeo/cssquery-jquery.html) 17:12:15 INFO - PROCESS | 1911 | RSS: Main: 260476928 17:12:15 INFO - PROCESS | 1911 | 17:15:17 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:54080/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54080/tests/dromaeo/cssquery-mootools.html) 17:15:18 INFO - PROCESS | 1911 | RSS: Main: 277741568 17:15:18 INFO - PROCESS | 1911 | 17:18:20 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:54080/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54080/tests/dromaeo/cssquery-prototype.html) 17:18:20 INFO - PROCESS | 1911 | RSS: Main: 271761408 17:18:20 INFO - PROCESS | 1911 | 17:21:23 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:54080/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54080/tests/dromaeo/cssquery-yui.html) 17:21:24 INFO - PROCESS | 1911 | RSS: Main: 276758528 17:21:24 INFO - PROCESS | 1911 | 17:24:26 INFO - PROCESS | 1911 | Cycle 1(1): loaded http://localhost:54080/tests/dromaeo/cssquery-yui.html (next: http://localhost:54080/tests/dromaeo/cssquery-dojo.html) 17:24:27 INFO - PROCESS | 1911 | RSS: Main: 278556672 17:24:27 INFO - PROCESS | 1911 | 17:24:27 INFO - PROCESS | 1911 | __start_tp_report 17:24:27 INFO - PROCESS | 1911 | _x_x_mozilla_page_load 17:24:27 INFO - PROCESS | 1911 | _x_x_mozilla_page_load_details 17:24:27 INFO - PROCESS | 1911 | |i|pagename|runs| 17:24:27 INFO - PROCESS | 1911 | |0;dojo.html;3294.7034766870993;3323.268880846214;3343.414902392081;3343.7325013998866;3349.7822641528282;4415.448068991376;5397.082495975684;5520.641158324706;5540.030494663433;5553.083741182705;4943.036107958949;5055.393352797661;5097.878466737312;5423.159410291401;5556.99999999999;5014.648974571782;5050.570701490377;5077.669951453162;5160.56135228506;5164.096283150452;4997.175466048097;5184.740762961856;5211.3746350438005;5213.957208558303;5252.107141785887;4964.528369804862;4969.254611808222;5191.0656081905245;5200.985807767487;5207.375114986207;5017.297578339036;5065.961477897059;5122.590192784568;5191.766370513336;5202.06362854686;5071.644984851062;5079.492050794928;5080.695158290478;5115.155999260118;5118.897622047575;5467.125259958388;5558.666480011212;5627.409122042168;5710.371859095496;5717.571182161355;5938.910916336258;5962.165296858443;6028.065649824284;6088.512918966472;6088.939110608926;6033.9396606033815;6062.484688801457;6062.666553339564;6071.969640151815;6109.541784366191;5725;5745.85635359111;5750.07998720207;5766.423357664284;5780.364159942445;5853.590248682552;5874;5967.104934259895;6012.428819262251;6136.969315153396;5593.161025846074;5621.213030175779;5642.520385767174;5658.434156584309;5678.858028549237;5731.083026715705;5772.134179873053;5780.277465316835;5789.160571717078;5794;5909.734061967221;5976.402359764076;6009.128676341906;6052.122442245938;6090.878182436327;6051.425114614105;6064.302605200459;6081.996470582393;6087;6126.540509461808;4792.161371759928;4797.136515427256;4801.4718380978065;4808.9901120765035;4826.517348265145;3828.4065969774174;4117.600015994576;4230.978845105755;4258.701890867609;4279.828806847691;5728.570357223141;5729.455701708331;5739.799107031317;5743.798967036134;5786.71066446676;6081.726322315506;6147.631142131397;6162.291336496271;6172.814815555541;6184.752609895644;5515.227868098469;5578.0517312057045;5627.352854421712;5701;5708.286464191976;4602.815887364535;5203.453637368022;5288.471152884757;5322.201669749568;5338.8665283367445;6160.353162917919;6160.568760186744;6166.660833654102;6171.413715697002;6177.81466556004;5922.7927022554;6018.157457955802;6109.175261339662;6140.662263575547;6149.815505534841;5534.335879694462;5546.278983732251;5954.493868021266;6028.6736917878;6120.143179954899;5113.15632920564;5934.109883517507;6045.879082418239;6049.213602231682;6080.787172448943;5978.8206353809455;6139.26328840542;6144.38556144382;6150.261968563801;6158.476529494864;5760.452756988079;5952;5956.434138756811;6072.666003369857;6090.908636370369;5129.692218466755;5989.64062156272;6039.758409663565;6058.303295121117;6071.150038994632;4809.470958194665;5021.49785021495;5678.119891416837;5756.136579513107;5911;5995.490383317292;6011.6994150293185;6018.3680713524445;6051.152838602688;6065.181200537871;5697.914531281951;5870.618409803349;5884.705764711662;5896.174535564938;5914.704264786657 17:24:27 INFO - PROCESS | 1911 | |1;ext.html;436.7379572256646;466.83660718748433;488.68724016629363;507.7055307921406;508.5067484539995;37328.81335593321;39970.60102896399;40126.79619611416;40243.59756402431;40322.395164072565;33165.83417082911;40577.391339129936;40643;41047.79476102623;41057.38413923786;9239.491827949443;9496.66761663342;9509;10644.57421703131;10911.908809119064;10934.125269978382;10959.232853700245;10985.835212471779;11009.944950275238;11017.228793984425;10965.945170274137;11009.394483303415;11021.118310535177;11037.061849742782;11045.447727613628;10930.234883558154;11008.449577521133;11012.339259644366;11017.228793984425;11018.834717479243;10839.458027098692;10894.237403381767;10925.781484370347;10939.234253602252;10943.945280273547;36426.635733642586;36458;36499.452508212395;36513.26973460516;37039.07402314937;3722.3485889969147;3747.400415933465;3780.527434070741;3794.867179648699;3876.0116170376655;27789.583156252673;28056.298592535146;28450.715492845222;28452.146435606966;28618.427631447255;3081.3837232553356;3111;3208.6951739584933;3245.237369218232;3249.4800831866787;434924.99999999686;435675;438677;439523;441437;44576.10847783091;46444;54459;54846.451535484935;55441;55243.72378138164;58380.41619583835;58837;58844.4115558839;58867;14370.065945713495;14512.637184070483;14521.636959076108;14546.927265363605;14566.708665826623;10783.622573210057;10862.945685271523;10912.50893709785;10924.672259832218;10945.179111566664;14684.559463216121;17675.646487070444;17720.734188987175;17720.9113954432;17723.822761772473;6590.637514936724;6611.371919667624;7645.464817462725;7657.540547567164;7776.92223077762;783.9686412543434;834.5576844272546;847.6185716427632;858.2876212743408;864.6152462154281;28891.85554072216;29264.122076337742;29383;29989.850050749606;30030.94891678781;1005.2460654509118;1020.6682828080903;1041.6874937518864;1059.2161800267747;1162.1980833225216;13543;15276.312565934337;15299.235038248044;15374.461893833663;15602.453914112952;576525;577232;577893;578198;578217;49875.75062124666;50619.74690126526;58344;59069.40930590639;59159.112613310834;1337.9866201337861;1374.5463996881006;1378.7449321875486;1379.3379177994418;1380.4409214268237;27460;28020.71979280181;28058.2985425366;28407;29884.551731724478;50374.74812625913;50383.24425133553;50553;50578.49421505738;50594;495762;496458;497520;497899.51050244516;498101;24465.143719969714;25240.495190096462;25459.36351591225;26084.869575652;26546.336341591614;34155.82922085374;42305.365419519345;42427.363589545566;42906.1418771629;42999.355009674255;31209.53185702171;34510.30979380449;34768.30463390768;35543.82228088843;35919;31388.372232555677;33935.490967635014;33941.151471213416;35144.824275878455;35392.29215415626;33807.49288760621;34427.76219545722;34469.82765086158;34647.82676086603;34940.47589286112;29853.402931940804;30975.845120775153;31089.689103108678;31176;31259.374812504077;21691.56616867622;22295;23232.186873459348;23627.29118126459;23779.524409511367 17:24:27 INFO - PROCESS | 1911 | |2;jquery.html;354.2277834321182;390.4884601172464;392.4466502231854;402.29999800347395;420.11565654297704;16612.501624951256;17238.655226895455;18059.819401805977;19820;20201.696974545393;19187.61624767504;19889.900550497263;19943.10256038478;20252.797472025275;20266.885321307323;4446.9994251293365;5269.499397557245;5512.503874651281;5673.971630141844;5920.792772252972;5469.371022332443;5860.882782344351;5862.798126384081;5868.4424979626865;5870.031444811622;5511.063119269734;5799.449052340021;5807.128930660414;5812.099124635688;5813.82558523245;5844.473997340238;5890.911636325459;5894.616849904743;5895.322037965624;5900.793472228473;4775.212090005145;4991.450940396553;5774.422557744192;5809.7676092956235;5840.211571437844;12370.44333005017;12767.72322767725;12796.424160912782;22752.886235568883;24872.3781905452;2673.331667083229;2756.0904901382696;2937.4859399605198;2942.1614839770564;2961.6890226526334;9769.804603907953;11665.475053622607;11872.584459543961;13457;14800.925995370062;1775.7247626617766;1790.0870556016396;1793.7847458304957;1796.463928580332;1830.1581272614612;77505.99999999943;107790;118907;119479;120683;11431.771364572829;11636.476358563716;11721.179517433868;11776.352300623377;11947.701307467383;15274.541763747106;15288.159151246566;15358.846411535966;15383;15433.45982890616;7944.563049032358;8242.629081691339;8296.170382961776;8391.580420978926;8413.789655258668;7797.259260370256;7841.607919604111;7851.646675899598;7911.248431399123;7963.960180199178;4042.3532234842874;4658.627309815207;4696.839453851198;4701.95298047022;4823.469418363977;1982.3557343863301;2014.939551813448;2014.9697754533693;2024.9493762655757;2025.3518873960486;941.4586612697726;985.2708995343394;991.1525645573075;998.5656239535825;1038.9740256493649;20506.692399614018;20691;20752.72845333545;20804.271850485162;21099.261525846523;1017.9236557258236;1028.4703377760459;1040.4485622620023;1043.7703705184847;1048.564845589072;8233.752987410388;10808.891911080946;10830;10845.349279043125;10850;612088;671437;689035;691405;712451;117156;130889.69110308775;131626.34186829004;140921;146233.53766462198;896.7533928169805;915.5742579700471;939.2579861909152;946.9242460603135;950.5817440326095;18836.811631883505;18967.33614323492;19209.03954802282;19310.71033934464;19329.93685347263;50954.49045509646;54017.91964160773;56712;58491;58800.70599646975;74044;77454;77641;82148.58925705333;82826;7686.730964416219;8000.559969201517;8163.1428699985645;8250.504969701837;8261.339092872435;10326.896731032894;10526.68416447944;11710.12174086964;12052.397380131133;12106.334151621746;9922.950385248028;10191.643292484727;10604.363738175734;10740.087092597218;10742.677719668422;10343;10609.840852387066;10654.73363165927;10764.192685548458;10797.514111864828;10751.462426878468;10959.232853700165;11024.393658348868;11084.944575277072;11219.60731374398;7882.172371901097;7998.240167184108;8046.597670116354;8052.677892884219;8305.418620696735;7978.162292959156;9753.51232438361;10264.794704106025;10744.677659670222;10793.514291856729 17:24:27 INFO - PROCESS | 1911 | |3;mootools.html;1382.8824549913256;1432.348281531903;1436.4558100042457;1442.92785360732;1456.1845366594707;8134.227248411399;8199.22107399796;8430.620622072007;8566.957165214173;8653.177948094937;8380.28767554757;8513.574321283926;8515.829683406328;8517.574121293941;8580.270676992463;2248.168177774226;2275.84069115162;2280.623697089978;2287.0394434337536;2288.8054515366216;2240.7423146338137;2270.71616047994;2272.136588096521;2276.169198242638;2288.0275882749847;2219.8002179803816;2232.274510784002;2264;2265.8753768542724;2269.9886500567472;2163.751168615598;2222.255544392622;2237.183428048767;2245.5733410651924;2251.448395143184;1924.9711254331196;2010.3064442767368;2196;2271.5116250006326;2276.9544609107893;7900.960495197487;8498.405111642187;8534.786630334229;8569.871451928226;8599.269062129726;5076.619253555961;5185.55922746567;5201.375834899798;5228.581713462914;5235.55497782689;3104.5653608494827;3416.538767266412;3479.764683537333;3493.8427770750377;3571.1250743567994;1204.861440934295;1211.745533437979;1240.4542001519303;1262.236347010055;1267.7084270617718;10948.616798412017;10960.12319014477;11046.889531104667;11087.778244435067;11096.445177741081;3604.711623070148;4113.670906327487;4439.689221754511;4464.620507256855;4464.754438505914;8629.395942284105;8751.168638979287;8777.034526202113;8777.981064355234;8797.604107815163;4573;5058.266551350107;5068.949310506848;5079.314292570456;5089.796408143633;4552.271636538138;4564.863054108382;4676.789544470507;4721.598664113589;4743.762811859393;3164.351307981858;3604.819759012039;3622.8007459589976;3652.908677283089;3679.2089700714473;1131.7283851875654;1132.6262333429947;1141.6004398460473;1146.6388087752332;1149.3046706742468;865.3985480091276;880.5333173418098;888.1651247827022;905.3526728389234;909.8589718593629;5467.45325467458;5541.947030064275;5551.916721249185;5615.747291371898;5809.099589563624;548.7530611224885;549.3078720811806;554.6117717597617;569.7265312649869;571.1974675580816;3600.567931848195;3700.481932529448;3722.683571896365;3731.5149030625844;3822.751521151172;9617.326787124834;9940.204783617293;10054.798904021878;10217.284790064625;10263.794724105626;9940.701778946643;10056.547455364525;10159.593616255266;10167.440790756431;10170.288079834341;7700.768976930701;7888.32949199313;7907.644156013108;7920.643571039317;7931.2068793120225;5467.316585426822;5472.91790623133;5504.587155963239;5531.197976293334;5568.220449137043;7311.744088956861;8820.5589720515;8842.823143537222;9215;9243.075692430702;9131.0412406699;9216.815663686555;9331.813363732823;9357.06429357059;9404.482753448627;6152.354002829818;7144.892826607709;7270.563766174047;7285.4900156990625;7288.489805713549;7783.688652453839;7853.8036549084445;7948.16544262844;7962.163972782774;7985.680572777024;7104.147502299757;7134.785956421316;7179.210286868545;7193.964030179815;7242.3843973262865;7087.433005359456;7124.964375178299;7145.21402645719;7156.892646610409;7190.640467976685;6256.092866534418;6275.795276763909;6280.403361680633;6321.367863213826;6355.110284560073;4799.568038876518;4867.269909513601;4873.780679869344;4956.801727930842;5070.340855688737;4805.327254184487;4989.525995030466;5005.224190250517;5033.394444083622;5166.173412254172 17:24:27 INFO - PROCESS | 1911 | |4;prototype.html;299.69580875411464;353.93983022886124;363.7326564974743;365.7896709392097;369.39234958493273;5020.523050310224;5111.258867464216;5128.9230661540105;5317.468253174686;5439.211314359421;5051.019898260026;5183.585313174946;5228.111221092414;5252.6848389096585;5299.205119232108;4103.569125241851;4117.402976568411;4131.710780245384;4140.151268989865;4165.958340416602;3989.501312335958;4076.7350122242105;4121.319982202933;4128.772917489552;4143.958560414402;3515.209077957452;3759.3797023491093;3789.6399842015103;3977.7016723745833;4069.1861627674434;3409.488576713488;4082.9795851020854;4087.652549533293;4108.1783643271465;4112.1626078006375;2805.9158225253277;3454.136465883529;3544.8404821783083;3614.5120408744747;3653.4472849039053;4275.764832934187;4900.627824209227;5040.560216321151;5066.645334826564;5104.345740215067;4726.66913316068;4732.739699316537;4751.239801631722;4759.381280433556;4784.755963449494;5526.889462210774;5531.2809334786625;5541.947030064275;5552.139418390156;5563.191962612127;3480.721542276637;3780.9980355205894;3814.2180852925085;4004.0570180917002;4004.619561141687;5531;5754.597178197486;5797.710114494258;5838.970805145989;5871.588988770788;3305.801651900894;3799.8220551629083;3832.693384529287;3841.7887016213817;3845.8846234613006;3909.4526766252748;3913.0804260998643;3921.274564205631;3922.764634121962;3926.9410958835642;4519.457665080211;4561.840335588305;4588.908221835544;4598.471175814757;4667.276572131325;4806.7836947336755;5177.456367081478;5336.226247194135;5582.264690301804;5584.52531534816;1091.51553886714;1207.2454715802623;1217.184486394118;1272.5175170925768;1283.6149155253574;810.9756707298791;858.772425307294;865.8398196333699;878.7978764883985;879.3448880584006;4249.830006799755;4313.590208930146;4882.658213924991;4914.378255175783;5021.347224860745;4613.538646135359;5253.4221235664045;5514.779408823602;5531.502164805106;5547.667139971614;4478.776061196927;4771.832985845479;4967.379077615298;5002.449730529639;5031.798728050837;2508.548461276988;2694.9383721453105;2784.874680639376;2826.915192544227;2892.3224529772683;5040.404191841205;5660.943390566124;5678.432156784371;5685.516731077904;5721.884232574608;4666.346711460398;5272.098647001269;5444.128939369761;5588.21764952907;5646;4670.95329046712;5462.8361149165585;5545.722713864371;5649.502881736343;5682.37493875665;5054.949450505448;5236.528712415901;5279.380542025728;5389.517882582321;5455.3453585568395;4727.456342520517;5184.662996905189;5440.8846186532455;5548.9722551388595;5597.356304025089;5593.496585307342;5638.436156384329;5745.482906538432;5888.352281248974;5892.204552385545;3770.830312635993;3850.3839385699275;3851.7111216659423;3852.287326844543;3868.613138686109;5129.2819005340025;5709.628874123168;5734.99637563433;5736.627119237236;5737.942620573741;4722.645801564965;5451.64564303319;5537.363203231519;5554;5708.57185711065;4751.382320298339;5144.588432925282;5218.008578370098;5537.723113844372;5567.582431317748;4600.447946246338;5030.949690503195;5447.863803404946;5487.311217503475;5506.577106073315;4821.783019764049;5106.591472682102;5511.366192887709;5589.021921163861;5635.267415235993;5475.342958844964;5502.752376143003;5510.421405752339;5536.695481748381;5551.833444996657 17:24:27 INFO - PROCESS | 1911 | |5;yui.html;689.8275431142215;700.4396482813747;756.0511557994719;795.4312666443493;802.9211605046365;11718.589849355274;14821.481248156317;15149.242537873117;15201.619959501018;15203.543893683194;14766;15423.845761542381;15455.22723863808;15796;15867.127307998084;853.7822855171922;873.6112429968666;875.8598624220126;879.3141349747208;879.3624622148955;846.1073567386405;869.9130086991313;880.4057261348596;883.8011447424342;883.9823203535925;900.3652425040364;918.4030380252823;919.3610440743686;920.2867777472445;920.7928216151379;905.1175104273347;916.2074805293406;916.2761418479394;917.495377542349;919.2416256588308;681.4105798484325;684.3737979748524;685.116200101868;685.2633419074465;685.2804555217052;14031.368588413443;14432.061915975533;15106.54680359591;15139.091654500766;15158.924205378902;13510.189388636614;13750.449982000708;13865.237411942338;13911.513097041656;13937.442502299897;9693.321467497279;11516.251443656136;11639.47622356996;11762.529498820037;12118.697032574257;3554.697850682695;3586.3006713690843;3593.2633810068874;3605.693516051139;3624.7281453891064;74701.5059698803;82011.17988820095;83029.75455368175;84870.72693909597;86100.56949715274;10183.32991890313;10302.278840481244;10437.425941573134;10440.216983726252;10485.26603137773;21480.4629884251;21759.129634814748;21789;21801;21840.781592183874;7414.369778568775;7510.699572017058;7512.39900807934;7515.398768098539;7700.961495192488;3860.7876566788536;3972.0069982504374;4045.0898547826505;4115.36211887158;4171.290880550314;3484.2508860595094;3581.8209089545417;3633.0190848470766;3640.7269454791;3648.8175591220333;653.4380432827764;660.5013215022627;661.0447902780436;674.436845234235;676.7834293026184;664.6178447392768;666.0974379715512;673.2493270003911;690.0305071374627;707.4234498883394;9305.953470232605;9681.51592420376;9916.057974492413;9987.705286726632;10086.899131008597;626.8620903401245;662.0301258656092;666.6866572710818;668.6322522612544;676.8797639905963;4831.95168048315;5060.443351231435;5205.45342739007;5357.223202635596;5426.945730542723;79208.60395697984;79480;96307.51846240724;98853.50573247088;102741;56936.43063569394;73931;74838.62580687062;83206.3358732822;85820.57089714511;59124.11313830296;64135;64943.35056649373;66211;73451.26548734552;9836.803263934538;10073.244506661884;10380.273380863267;10574.947125264325;10580.682579522627;40985.565505207174;44287.33568996532;45054;45190.32214516719;48464.788380290775;54349;54384;62326;62363.37636623576;63386.68306658437;10491.422971736627;12403.8836504715;12456.750864982469;12463.439145238668;13234.602961911158;13805.861941380457;13837.308134593432;13953.419123668173;14035.789463157857;14685.19231442281;12508.624741257778;12543.029366458946;12555.93722031384;12571.559995400117;13242.801357979446;12858;13123.671908202372;13517.526886558922;13584.25286609246;13660.611554687883;12457.750844982867;12919.741605168032;13305.86694133085;13435.932820335836;13441.462341506622;10172.593096276067;10430.791384172426;10544.789104218025;10573.89426105729;10806.029191784357;8153.6112414047;8869.334799889904;10314.742131446774;10321.690349289232;10330.793384132125 17:24:27 INFO - PROCESS | 1911 | __end_tp_report 17:24:27 INFO - PROCESS | 1911 | __start_cc_report 17:24:27 INFO - PROCESS | 1911 | _x_x_mozilla_cycle_collect,411 17:24:27 INFO - PROCESS | 1911 | __end_cc_report 17:24:27 INFO - PROCESS | 1911 | __startTimestamp1486603467074__endTimestamp 17:24:27 INFO - PROCESS | 1911 | 17:24:27 INFO - PROCESS | 1911 | ------- Summary: start ------- 17:24:27 INFO - PROCESS | 1911 | Number of tests: 6 17:24:27 INFO - PROCESS | 1911 | 17:24:27 INFO - PROCESS | 1911 | [#0] dojo.html Cycles:165 Average:5549.68 Median:5739.80 stddev:632.46 (11.0%) stddev-sans-first:609.16 17:24:27 INFO - PROCESS | 1911 | Values: 3294.7 3323.3 3343.4 3343.7 3349.8 4415.4 5397.1 5520.6 5540.0 5553.1 4943.0 5055.4 5097.9 5423.2 5557.0 5014.6 5050.6 5077.7 5160.6 5164.1 4997.2 5184.7 5211.4 5214.0 5252.1 4964.5 4969.3 5191.1 5201.0 5207.4 5017.3 5066.0 5122.6 5191.8 5202.1 5071.6 5079.5 5080.7 5115.2 5118.9 5467.1 5558.7 5627.4 5710.4 5717.6 5938.9 5962.2 6028.1 6088.5 6088.9 6033.9 6062.5 6062.7 6072.0 6109.5 5725.0 5745.9 5750.1 5766.4 5780.4 5853.6 5874.0 5967.1 6012.4 6137.0 5593.2 5621.2 5642.5 5658.4 5678.9 5731.1 5772.1 5780.3 5789.2 5794.0 5909.7 5976.4 6009.1 6052.1 6090.9 6051.4 6064.3 6082.0 6087.0 6126.5 4792.2 4797.1 4801.5 4809.0 4826.5 3828.4 4117.6 4231.0 4258.7 4279.8 5728.6 5729.5 5739.8 5743.8 5786.7 6081.7 6147.6 6162.3 6172.8 6184.8 5515.2 5578.1 5627.4 5701.0 5708.3 4602.8 5203.5 5288.5 5322.2 5338.9 6160.4 6160.6 6166.7 6171.4 6177.8 5922.8 6018.2 6109.2 6140.7 6149.8 5534.3 5546.3 5954.5 6028.7 6120.1 5113.2 5934.1 6045.9 6049.2 6080.8 5978.8 6139.3 6144.4 6150.3 6158.5 5760.5 5952.0 5956.4 6072.7 6090.9 5129.7 5989.6 6039.8 6058.3 6071.2 4809.5 5021.5 5678.1 5756.1 5911.0 5995.5 6011.7 6018.4 6051.2 6065.2 5697.9 5870.6 5884.7 5896.2 5914.7 17:24:27 INFO - PROCESS | 1911 | 17:24:27 INFO - PROCESS | 1911 | [#1] ext.html Cycles:180 Average:63389.16 Median:33871.49 stddev:135312.42 (399.5%) stddev-sans-first:135609.46 17:24:27 INFO - PROCESS | 1911 | Values: 436.7 466.8 488.7 507.7 508.5 37328.8 39970.6 40126.8 40243.6 40322.4 33165.8 40577.4 40643.0 41047.8 41057.4 9239.5 9496.7 9509.0 10644.6 10911.9 10934.1 10959.2 10985.8 11009.9 11017.2 10965.9 11009.4 11021.1 11037.1 11045.4 10930.2 11008.4 11012.3 11017.2 11018.8 10839.5 10894.2 10925.8 10939.2 10943.9 36426.6 36458.0 36499.5 36513.3 37039.1 3722.3 3747.4 3780.5 3794.9 3876.0 27789.6 28056.3 28450.7 28452.1 28618.4 3081.4 3111.0 3208.7 3245.2 3249.5 434925.0 435675.0 438677.0 439523.0 441437.0 44576.1 46444.0 54459.0 54846.5 55441.0 55243.7 58380.4 58837.0 58844.4 58867.0 14370.1 14512.6 14521.6 14546.9 14566.7 10783.6 10862.9 10912.5 10924.7 10945.2 14684.6 17675.6 17720.7 17720.9 17723.8 6590.6 6611.4 7645.5 7657.5 7776.9 784.0 834.6 847.6 858.3 864.6 28891.9 29264.1 29383.0 29989.9 30030.9 1005.2 1020.7 1041.7 1059.2 1162.2 13543.0 15276.3 15299.2 15374.5 15602.5 576525.0 577232.0 577893.0 578198.0 578217.0 49875.8 50619.7 58344.0 59069.4 59159.1 1338.0 1374.5 1378.7 1379.3 1380.4 27460.0 28020.7 28058.3 28407.0 29884.6 50374.7 50383.2 50553.0 50578.5 50594.0 495762.0 496458.0 497520.0 497899.5 498101.0 24465.1 25240.5 25459.4 26084.9 26546.3 34155.8 42305.4 42427.4 42906.1 42999.4 31209.5 34510.3 34768.3 35543.8 35919.0 31388.4 33935.5 33941.2 35144.8 35392.3 33807.5 34427.8 34469.8 34647.8 34940.5 29853.4 30975.8 31089.7 31176.0 31259.4 21691.6 22295.0 23232.2 23627.3 23779.5 17:24:27 INFO - PROCESS | 1911 | 17:24:27 INFO - PROCESS | 1911 | [#2] jquery.html Cycles:180 Average:36820.53 Median:2714.71 stddev:112270.05 (4135.6%) stddev-sans-first:112551.61 17:24:27 INFO - PROCESS | 1911 | Values: 354.2 390.5 392.4 402.3 420.1 16612.5 17238.7 18059.8 19820.0 20201.7 19187.6 19889.9 19943.1 20252.8 20266.9 4447.0 5269.5 5512.5 5674.0 5920.8 5469.4 5860.9 5862.8 5868.4 5870.0 5511.1 5799.4 5807.1 5812.1 5813.8 5844.5 5890.9 5894.6 5895.3 5900.8 4775.2 4991.5 5774.4 5809.8 5840.2 12370.4 12767.7 12796.4 22752.9 24872.4 2673.3 2756.1 2937.5 2942.2 2961.7 9769.8 11665.5 11872.6 13457.0 14800.9 1775.7 1790.1 1793.8 1796.5 1830.2 77506.0 107790.0 118907.0 119479.0 120683.0 11431.8 11636.5 11721.2 11776.4 11947.7 15274.5 15288.2 15358.8 15383.0 15433.5 7944.6 8242.6 8296.2 8391.6 8413.8 7797.3 7841.6 7851.6 7911.2 7964.0 4042.4 4658.6 4696.8 4702.0 4823.5 1982.4 2014.9 2015.0 2024.9 2025.4 941.5 985.3 991.2 998.6 1039.0 20506.7 20691.0 20752.7 20804.3 21099.3 1017.9 1028.5 1040.4 1043.8 1048.6 8233.8 10808.9 10830.0 10845.3 10850.0 612088.0 671437.0 689035.0 691405.0 712451.0 117156.0 130889.7 131626.3 140921.0 146233.5 896.8 915.6 939.3 946.9 950.6 18836.8 18967.3 19209.0 19310.7 19329.9 50954.5 54017.9 56712.0 58491.0 58800.7 74044.0 77454.0 77641.0 82148.6 82826.0 7686.7 8000.6 8163.1 8250.5 8261.3 10326.9 10526.7 11710.1 12052.4 12106.3 9923.0 10191.6 10604.4 10740.1 10742.7 10343.0 10609.8 10654.7 10764.2 10797.5 10751.5 10959.2 11024.4 11084.9 11219.6 7882.2 7998.2 8046.6 8052.7 8305.4 7978.2 9753.5 10264.8 10744.7 10793.5 17:24:27 INFO - PROCESS | 1911 | 17:24:27 INFO - PROCESS | 1911 | [#3] mootools.html Cycles:180 Average:5381.53 Median:5084.56 stddev:2995.42 (58.9%) stddev-sans-first:2988.75 17:24:27 INFO - PROCESS | 1911 | Values: 1382.9 1432.3 1436.5 1442.9 1456.2 8134.2 8199.2 8430.6 8567.0 8653.2 8380.3 8513.6 8515.8 8517.6 8580.3 2248.2 2275.8 2280.6 2287.0 2288.8 2240.7 2270.7 2272.1 2276.2 2288.0 2219.8 2232.3 2264.0 2265.9 2270.0 2163.8 2222.3 2237.2 2245.6 2251.4 1925.0 2010.3 2196.0 2271.5 2277.0 7901.0 8498.4 8534.8 8569.9 8599.3 5076.6 5185.6 5201.4 5228.6 5235.6 3104.6 3416.5 3479.8 3493.8 3571.1 1204.9 1211.7 1240.5 1262.2 1267.7 10948.6 10960.1 11046.9 11087.8 11096.4 3604.7 4113.7 4439.7 4464.6 4464.8 8629.4 8751.2 8777.0 8778.0 8797.6 4573.0 5058.3 5068.9 5079.3 5089.8 4552.3 4564.9 4676.8 4721.6 4743.8 3164.4 3604.8 3622.8 3652.9 3679.2 1131.7 1132.6 1141.6 1146.6 1149.3 865.4 880.5 888.2 905.4 909.9 5467.5 5541.9 5551.9 5615.7 5809.1 548.8 549.3 554.6 569.7 571.2 3600.6 3700.5 3722.7 3731.5 3822.8 9617.3 9940.2 10054.8 10217.3 10263.8 9940.7 10056.5 10159.6 10167.4 10170.3 7700.8 7888.3 7907.6 7920.6 7931.2 5467.3 5472.9 5504.6 5531.2 5568.2 7311.7 8820.6 8842.8 9215.0 9243.1 9131.0 9216.8 9331.8 9357.1 9404.5 6152.4 7144.9 7270.6 7285.5 7288.5 7783.7 7853.8 7948.2 7962.2 7985.7 7104.1 7134.8 7179.2 7194.0 7242.4 7087.4 7125.0 7145.2 7156.9 7190.6 6256.1 6275.8 6280.4 6321.4 6355.1 4799.6 4867.3 4873.8 4956.8 5070.3 4805.3 4989.5 5005.2 5033.4 5166.2 17:24:27 INFO - PROCESS | 1911 | 17:24:27 INFO - PROCESS | 1911 | [#4] prototype.html Cycles:180 Average:4468.19 Median:5026.15 stddev:1354.97 (27.0%) stddev-sans-first:1322.16 17:24:27 INFO - PROCESS | 1911 | Values: 299.7 353.9 363.7 365.8 369.4 5020.5 5111.3 5128.9 5317.5 5439.2 5051.0 5183.6 5228.1 5252.7 5299.2 4103.6 4117.4 4131.7 4140.2 4166.0 3989.5 4076.7 4121.3 4128.8 4144.0 3515.2 3759.4 3789.6 3977.7 4069.2 3409.5 4083.0 4087.7 4108.2 4112.2 2805.9 3454.1 3544.8 3614.5 3653.4 4275.8 4900.6 5040.6 5066.6 5104.3 4726.7 4732.7 4751.2 4759.4 4784.8 5526.9 5531.3 5541.9 5552.1 5563.2 3480.7 3781.0 3814.2 4004.1 4004.6 5531.0 5754.6 5797.7 5839.0 5871.6 3305.8 3799.8 3832.7 3841.8 3845.9 3909.5 3913.1 3921.3 3922.8 3926.9 4519.5 4561.8 4588.9 4598.5 4667.3 4806.8 5177.5 5336.2 5582.3 5584.5 1091.5 1207.2 1217.2 1272.5 1283.6 811.0 858.8 865.8 878.8 879.3 4249.8 4313.6 4882.7 4914.4 5021.3 4613.5 5253.4 5514.8 5531.5 5547.7 4478.8 4771.8 4967.4 5002.4 5031.8 2508.5 2694.9 2784.9 2826.9 2892.3 5040.4 5660.9 5678.4 5685.5 5721.9 4666.3 5272.1 5444.1 5588.2 5646.0 4671.0 5462.8 5545.7 5649.5 5682.4 5054.9 5236.5 5279.4 5389.5 5455.3 4727.5 5184.7 5440.9 5549.0 5597.4 5593.5 5638.4 5745.5 5888.4 5892.2 3770.8 3850.4 3851.7 3852.3 3868.6 5129.3 5709.6 5735.0 5736.6 5737.9 4722.6 5451.6 5537.4 5554.0 5708.6 4751.4 5144.6 5218.0 5537.7 5567.6 4600.4 5030.9 5447.9 5487.3 5506.6 4821.8 5106.6 5511.4 5589.0 5635.3 5475.3 5502.8 5510.4 5536.7 5551.8 17:24:27 INFO - PROCESS | 1911 | 17:24:27 INFO - PROCESS | 1911 | [#5] yui.html Cycles:180 Average:18238.63 Median:45122.16 stddev:24667.15 (54.7%) stddev-sans-first:24701.15 17:24:27 INFO - PROCESS | 1911 | Values: 689.8 700.4 756.1 795.4 802.9 11718.6 14821.5 15149.2 15201.6 15203.5 14766.0 15423.8 15455.2 15796.0 15867.1 853.8 873.6 875.9 879.3 879.4 846.1 869.9 880.4 883.8 884.0 900.4 918.4 919.4 920.3 920.8 905.1 916.2 916.3 917.5 919.2 681.4 684.4 685.1 685.3 685.3 14031.4 14432.1 15106.5 15139.1 15158.9 13510.2 13750.4 13865.2 13911.5 13937.4 9693.3 11516.3 11639.5 11762.5 12118.7 3554.7 3586.3 3593.3 3605.7 3624.7 74701.5 82011.2 83029.8 84870.7 86100.6 10183.3 10302.3 10437.4 10440.2 10485.3 21480.5 21759.1 21789.0 21801.0 21840.8 7414.4 7510.7 7512.4 7515.4 7701.0 3860.8 3972.0 4045.1 4115.4 4171.3 3484.3 3581.8 3633.0 3640.7 3648.8 653.4 660.5 661.0 674.4 676.8 664.6 666.1 673.2 690.0 707.4 9306.0 9681.5 9916.1 9987.7 10086.9 626.9 662.0 666.7 668.6 676.9 4832.0 5060.4 5205.5 5357.2 5426.9 79208.6 79480.0 96307.5 98853.5 102741.0 56936.4 73931.0 74838.6 83206.3 85820.6 59124.1 64135.0 64943.4 66211.0 73451.3 9836.8 10073.2 10380.3 10574.9 10580.7 40985.6 44287.3 45054.0 45190.3 48464.8 54349.0 54384.0 62326.0 62363.4 63386.7 10491.4 12403.9 12456.8 12463.4 13234.6 13805.9 13837.3 13953.4 14035.8 14685.2 12508.6 12543.0 12555.9 12571.6 13242.8 12858.0 13123.7 13517.5 13584.3 13660.6 12457.8 12919.7 13305.9 13435.9 13441.5 10172.6 10430.8 10544.8 10573.9 10806.0 8153.6 8869.3 10314.7 10321.7 10330.8 17:24:27 INFO - PROCESS | 1911 | -------- Summary: end -------- 17:24:27 INFO - PROCESS | 1911 | 17:24:27 INFO - TEST-INFO | 1911: exit 0 17:24:27 INFO - TEST-OK | dromaeo_css | took 1114621ms 17:24:27 INFO - TEST-START | kraken 17:24:27 INFO - operating with platform_type : mac_ 17:24:27 INFO - Initialising browser for kraken test... 17:24:27 INFO - TEST-INFO | started process 1919 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpWJE_du/profile http://localhost:54080/getInfo.html) 17:24:30 INFO - PROCESS | 1919 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 17:24:30 INFO - PROCESS | 1919 | 2017-02-08 17:24:30.641 plugin-container[1920:19478] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 17:24:30 INFO - PROCESS | 1919 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:24:30 INFO - PROCESS | 1919 | 2017-02-08 17:24:30.645 plugin-container[1920:19478] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x460b, name = 'com.apple.CFPasteboardClient' 17:24:30 INFO - PROCESS | 1919 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:24:30 INFO - PROCESS | 1919 | 2017-02-08 17:24:30.645 plugin-container[1920:19478] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:24:30 INFO - PROCESS | 1919 | __metrics Screen width/height:1600/1200 17:24:30 INFO - PROCESS | 1919 | colorDepth:24 17:24:30 INFO - PROCESS | 1919 | Browser inner width/height: 1024/689 17:24:30 INFO - PROCESS | 1919 | __metrics 17:24:30 ERROR - PROCESS | 1919 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 17:24:31 INFO - TEST-INFO | 1919: exit 0 17:24:31 INFO - Browser initialized. 17:24:31 INFO - Running cycle 1/1 for kraken test... 17:24:31 INFO - TEST-INFO | started process 1921 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpWJE_du/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:24:33 INFO - PROCESS | 1921 | 2017-02-08 17:24:33.982 plugin-container[1922:19594] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4f, name = 'com.apple.tsm.portname' 17:24:33 INFO - PROCESS | 1921 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:24:33 INFO - PROCESS | 1921 | 2017-02-08 17:24:33.983 plugin-container[1922:19594] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 17:24:33 INFO - PROCESS | 1921 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:24:33 INFO - PROCESS | 1921 | 2017-02-08 17:24:33.983 plugin-container[1922:19594] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:24:43 INFO - PROCESS | 1921 | RSS: Main: 233320448 17:24:43 INFO - PROCESS | 1921 | 17:24:47 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:54080/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54080/tests/kraken/driver.html?testName=audio-beat-detection) 17:24:48 INFO - PROCESS | 1921 | RSS: Main: 247328768 17:24:48 INFO - PROCESS | 1921 | 17:24:50 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:54080/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54080/tests/kraken/driver.html?testName=audio-dft) 17:24:51 INFO - PROCESS | 1921 | RSS: Main: 255131648 17:24:51 INFO - PROCESS | 1921 | 17:24:54 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:54080/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54080/tests/kraken/driver.html?testName=audio-fft) 17:24:55 INFO - PROCESS | 1921 | RSS: Main: 257699840 17:24:55 INFO - PROCESS | 1921 | 17:24:57 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:54080/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54080/tests/kraken/driver.html?testName=audio-oscillator) 17:24:58 INFO - PROCESS | 1921 | RSS: Main: 258945024 17:24:58 INFO - PROCESS | 1921 | 17:25:00 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:54080/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54080/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:25:00 INFO - PROCESS | 1921 | RSS: Main: 260632576 17:25:00 INFO - PROCESS | 1921 | 17:25:03 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:54080/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54080/tests/kraken/driver.html?testName=imaging-darkroom) 17:25:04 INFO - PROCESS | 1921 | RSS: Main: 266125312 17:25:04 INFO - PROCESS | 1921 | 17:25:07 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:54080/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54080/tests/kraken/driver.html?testName=imaging-desaturate) 17:25:08 INFO - PROCESS | 1921 | RSS: Main: 265580544 17:25:08 INFO - PROCESS | 1921 | 17:25:10 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:54080/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54080/tests/kraken/driver.html?testName=json-parse-financial) 17:25:11 INFO - PROCESS | 1921 | RSS: Main: 265617408 17:25:11 INFO - PROCESS | 1921 | 17:25:13 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:54080/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54080/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:25:13 INFO - PROCESS | 1921 | RSS: Main: 265052160 17:25:13 INFO - PROCESS | 1921 | 17:25:15 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:54080/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54080/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:25:16 INFO - PROCESS | 1921 | RSS: Main: 265056256 17:25:16 INFO - PROCESS | 1921 | 17:25:18 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:54080/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54080/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:25:19 INFO - PROCESS | 1921 | RSS: Main: 265068544 17:25:19 INFO - PROCESS | 1921 | 17:25:22 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:54080/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54080/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:25:23 INFO - PROCESS | 1921 | RSS: Main: 265367552 17:25:23 INFO - PROCESS | 1921 | 17:25:26 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:54080/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54080/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:25:27 INFO - PROCESS | 1921 | RSS: Main: 265375744 17:25:27 INFO - PROCESS | 1921 | 17:25:28 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:54080/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54080/tests/kraken/driver.html?testName=ai-astar) 17:25:29 INFO - PROCESS | 1921 | RSS: Main: 267141120 17:25:29 INFO - PROCESS | 1921 | 17:25:29 INFO - PROCESS | 1921 | __start_tp_report 17:25:29 INFO - PROCESS | 1921 | _x_x_mozilla_page_load 17:25:29 INFO - PROCESS | 1921 | _x_x_mozilla_page_load_details 17:25:29 INFO - PROCESS | 1921 | |i|pagename|runs| 17:25:29 INFO - PROCESS | 1921 | |0;ai-astar;143;150;132;160;168;97;168;171;151;169 17:25:29 INFO - PROCESS | 1921 | |1;audio-beat-detection;154;116;114;155;120;131;140;141;120;141 17:25:29 INFO - PROCESS | 1921 | |2;audio-dft;216;226;195;197;196;201;194;198;195;195 17:25:29 INFO - PROCESS | 1921 | |3;audio-fft;83;60;85;107;84;72;63;60;75;62 17:25:29 INFO - PROCESS | 1921 | |4;audio-oscillator;94;71;85;71;71;98;68;75;97;111 17:25:29 INFO - PROCESS | 1921 | |5;imaging-gaussian-blur;89;87;94;85;90;75;133;125;89;85 17:25:29 INFO - PROCESS | 1921 | |6;imaging-darkroom;150;151;96;98;97;96;95;105;120;96 17:25:29 INFO - PROCESS | 1921 | |7;imaging-desaturate;93;99;94;94;97;91;94;94;94;93 17:25:29 INFO - PROCESS | 1921 | |8;json-parse-financial;64;64;63;71;77;93;94;78;64;63 17:25:29 INFO - PROCESS | 1921 | |9;json-stringify-tinderbox;70;72;70;116;111;82;68;69;71;71 17:25:29 INFO - PROCESS | 1921 | |10;stanford-crypto-aes;91;92;105;103;105;91;108;112;106;91 17:25:29 INFO - PROCESS | 1921 | |11;stanford-crypto-ccm;150;160;171;154;154;151;154;149;178;169 17:25:29 INFO - PROCESS | 1921 | |12;stanford-crypto-pbkdf2;177;182;176;204;229;197;178;179;178;179 17:25:29 INFO - PROCESS | 1921 | |13;stanford-crypto-sha256-iterative;67;69;66;70;68;68;69;66;67;67 17:25:29 INFO - PROCESS | 1921 | __end_tp_report 17:25:29 INFO - PROCESS | 1921 | __start_cc_report 17:25:29 INFO - PROCESS | 1921 | _x_x_mozilla_cycle_collect,982 17:25:29 INFO - PROCESS | 1921 | __end_cc_report 17:25:29 INFO - PROCESS | 1921 | __startTimestamp1486603529008__endTimestamp 17:25:29 INFO - PROCESS | 1921 | 17:25:29 INFO - PROCESS | 1921 | ------- Summary: start ------- 17:25:29 INFO - PROCESS | 1921 | Number of tests: 14 17:25:29 INFO - PROCESS | 1921 | 17:25:29 INFO - PROCESS | 1921 | [#0] ai-astar Cycles:10 Average:150.90 Median:168.00 stddev:22.91 (13.6%) stddev-sans-first:24.12 17:25:29 INFO - PROCESS | 1921 | Values: 143.0 150.0 132.0 160.0 168.0 97.0 168.0 171.0 151.0 169.0 17:25:29 INFO - PROCESS | 1921 | 17:25:29 INFO - PROCESS | 1921 | [#1] audio-beat-detection Cycles:10 Average:133.20 Median:140.50 stddev:15.25 (10.9%) stddev-sans-first:14.20 17:25:29 INFO - PROCESS | 1921 | Values: 154.0 116.0 114.0 155.0 120.0 131.0 140.0 141.0 120.0 141.0 17:25:29 INFO - PROCESS | 1921 | 17:25:29 INFO - PROCESS | 1921 | [#2] audio-dft Cycles:10 Average:201.30 Median:197.50 stddev:10.83 (5.5%) stddev-sans-first:10.10 17:25:29 INFO - PROCESS | 1921 | Values: 216.0 226.0 195.0 197.0 196.0 201.0 194.0 198.0 195.0 195.0 17:25:29 INFO - PROCESS | 1921 | 17:25:29 INFO - PROCESS | 1921 | [#3] audio-fft Cycles:10 Average:75.10 Median:73.50 stddev:15.06 (20.5%) stddev-sans-first:15.70 17:25:29 INFO - PROCESS | 1921 | Values: 83.0 60.0 85.0 107.0 84.0 72.0 63.0 60.0 75.0 62.0 17:25:29 INFO - PROCESS | 1921 | 17:25:29 INFO - PROCESS | 1921 | [#4] audio-oscillator Cycles:10 Average:84.10 Median:80.00 stddev:15.05 (18.8%) stddev-sans-first:15.53 17:25:29 INFO - PROCESS | 1921 | Values: 94.0 71.0 85.0 71.0 71.0 98.0 68.0 75.0 97.0 111.0 17:25:29 INFO - PROCESS | 1921 | 17:25:29 INFO - PROCESS | 1921 | [#5] imaging-gaussian-blur Cycles:10 Average:95.20 Median:88.00 stddev:18.58 (21.1%) stddev-sans-first:19.57 17:25:29 INFO - PROCESS | 1921 | Values: 89.0 87.0 94.0 85.0 90.0 75.0 133.0 125.0 89.0 85.0 17:25:29 INFO - PROCESS | 1921 | 17:25:29 INFO - PROCESS | 1921 | [#6] imaging-darkroom Cycles:10 Average:110.40 Median:96.00 stddev:22.44 (23.4%) stddev-sans-first:18.67 17:25:29 INFO - PROCESS | 1921 | Values: 150.0 151.0 96.0 98.0 97.0 96.0 95.0 105.0 120.0 96.0 17:25:29 INFO - PROCESS | 1921 | 17:25:29 INFO - PROCESS | 1921 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:2.21 (2.4%) stddev-sans-first:2.30 17:25:29 INFO - PROCESS | 1921 | Values: 93.0 99.0 94.0 94.0 97.0 91.0 94.0 94.0 94.0 93.0 17:25:29 INFO - PROCESS | 1921 | 17:25:29 INFO - PROCESS | 1921 | [#8] json-parse-financial Cycles:10 Average:73.10 Median:74.00 stddev:12.15 (16.4%) stddev-sans-first:12.43 17:25:29 INFO - PROCESS | 1921 | Values: 64.0 64.0 63.0 71.0 77.0 93.0 94.0 78.0 64.0 63.0 17:25:29 INFO - PROCESS | 1921 | 17:25:29 INFO - PROCESS | 1921 | [#9] json-stringify-tinderbox Cycles:10 Average:80.00 Median:70.50 stddev:18.11 (25.7%) stddev-sans-first:18.84 17:25:29 INFO - PROCESS | 1921 | Values: 70.0 72.0 70.0 116.0 111.0 82.0 68.0 69.0 71.0 71.0 17:25:29 INFO - PROCESS | 1921 | 17:25:29 INFO - PROCESS | 1921 | [#10] stanford-crypto-aes Cycles:10 Average:100.40 Median:101.50 stddev:8.22 (8.1%) stddev-sans-first:7.99 17:25:29 INFO - PROCESS | 1921 | Values: 91.0 92.0 105.0 103.0 105.0 91.0 108.0 112.0 106.0 91.0 17:25:29 INFO - PROCESS | 1921 | 17:25:29 INFO - PROCESS | 1921 | [#11] stanford-crypto-ccm Cycles:10 Average:159.00 Median:157.00 stddev:10.14 (6.5%) stddev-sans-first:10.22 17:25:29 INFO - PROCESS | 1921 | Values: 150.0 160.0 171.0 154.0 154.0 151.0 154.0 149.0 178.0 169.0 17:25:29 INFO - PROCESS | 1921 | 17:25:29 INFO - PROCESS | 1921 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.90 Median:180.50 stddev:17.26 (9.6%) stddev-sans-first:17.85 17:25:29 INFO - PROCESS | 1921 | Values: 177.0 182.0 176.0 204.0 229.0 197.0 178.0 179.0 178.0 179.0 17:25:29 INFO - PROCESS | 1921 | 17:25:29 INFO - PROCESS | 1921 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.34 (2.0%) stddev-sans-first:1.39 17:25:29 INFO - PROCESS | 1921 | Values: 67.0 69.0 66.0 70.0 68.0 68.0 69.0 66.0 67.0 67.0 17:25:29 INFO - PROCESS | 1921 | -------- Summary: end -------- 17:25:29 INFO - PROCESS | 1921 | 17:25:30 INFO - TEST-INFO | 1921: exit 0 17:25:30 INFO - TEST-OK | kraken | took 62323ms 17:25:30 INFO - SUITE-END | took 1176s 17:25:30 INFO - Completed test suite (00:19:37) 17:25:30 INFO - javascript benchmark 17:25:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7074.650753299927, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3294.7034766870993, 3323.268880846214, 3343.414902392081, 3343.7325013998866, 3349.7822641528282, 4415.448068991376, 5397.082495975684, 5520.641158324706, 5540.030494663433, 5553.083741182705, 4943.036107958949, 5055.393352797661, 5097.878466737312, 5423.159410291401, 5556.99999999999, 5014.648974571782, 5050.570701490377, 5077.669951453162, 5160.56135228506, 5164.096283150452, 4997.175466048097, 5184.740762961856, 5211.3746350438005, 5213.957208558303, 5252.107141785887, 4964.528369804862, 4969.254611808222, 5191.0656081905245, 5200.985807767487, 5207.375114986207, 5017.297578339036, 5065.961477897059, 5122.590192784568, 5191.766370513336, 5202.06362854686, 5071.644984851062, 5079.492050794928, 5080.695158290478, 5115.155999260118, 5118.897622047575, 5467.125259958388, 5558.666480011212, 5627.409122042168, 5710.371859095496, 5717.571182161355, 5938.910916336258, 5962.165296858443, 6028.065649824284, 6088.512918966472, 6088.939110608926, 6033.9396606033815, 6062.484688801457, 6062.666553339564, 6071.969640151815, 6109.541784366191, 5725.0, 5745.85635359111, 5750.07998720207, 5766.423357664284, 5780.364159942445, 5853.590248682552, 5874.0, 5967.104934259895, 6012.428819262251, 6136.969315153396, 5593.161025846074, 5621.213030175779, 5642.520385767174, 5658.434156584309, 5678.858028549237, 5731.083026715705, 5772.134179873053, 5780.277465316835, 5789.160571717078, 5794.0, 5909.734061967221, 5976.402359764076, 6009.128676341906, 6052.122442245938, 6090.878182436327, 6051.425114614105, 6064.302605200459, 6081.996470582393, 6087.0, 6126.540509461808, 4792.161371759928, 4797.136515427256, 4801.4718380978065, 4808.9901120765035, 4826.517348265145, 3828.4065969774174, 4117.600015994576, 4230.978845105755, 4258.701890867609, 4279.828806847691, 5728.570357223141, 5729.455701708331, 5739.799107031317, 5743.798967036134, 5786.71066446676, 6081.726322315506, 6147.631142131397, 6162.291336496271, 6172.814815555541, 6184.752609895644, 5515.227868098469, 5578.0517312057045, 5627.352854421712, 5701.0, 5708.286464191976, 4602.815887364535, 5203.453637368022, 5288.471152884757, 5322.201669749568, 5338.8665283367445, 6160.353162917919, 6160.568760186744, 6166.660833654102, 6171.413715697002, 6177.81466556004, 5922.7927022554, 6018.157457955802, 6109.175261339662, 6140.662263575547, 6149.815505534841, 5534.335879694462, 5546.278983732251, 5954.493868021266, 6028.6736917878, 6120.143179954899, 5113.15632920564, 5934.109883517507, 6045.879082418239, 6049.213602231682, 6080.787172448943, 5978.8206353809455, 6139.26328840542, 6144.38556144382, 6150.261968563801, 6158.476529494864, 5760.452756988079, 5952.0, 5956.434138756811, 6072.666003369857, 6090.908636370369, 5129.692218466755, 5989.64062156272, 6039.758409663565, 6058.303295121117, 6071.150038994632, 4809.470958194665, 5021.49785021495, 5678.119891416837, 5756.136579513107, 5911.0, 5995.490383317292, 6011.6994150293185, 6018.3680713524445, 6051.152838602688, 6065.181200537871, 5697.914531281951, 5870.618409803349, 5884.705764711662, 5896.174535564938, 5914.704264786657], "value": 5510.53793924142, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [436.7379572256646, 466.83660718748433, 488.68724016629363, 507.7055307921406, 508.5067484539995, 37328.81335593321, 39970.60102896399, 40126.79619611416, 40243.59756402431, 40322.395164072565, 33165.83417082911, 40577.391339129936, 40643.0, 41047.79476102623, 41057.38413923786, 9239.491827949443, 9496.66761663342, 9509.0, 10644.57421703131, 10911.908809119064, 10934.125269978382, 10959.232853700245, 10985.835212471779, 11009.944950275238, 11017.228793984425, 10965.945170274137, 11009.394483303415, 11021.118310535177, 11037.061849742782, 11045.447727613628, 10930.234883558154, 11008.449577521133, 11012.339259644366, 11017.228793984425, 11018.834717479243, 10839.458027098692, 10894.237403381767, 10925.781484370347, 10939.234253602252, 10943.945280273547, 36426.635733642586, 36458.0, 36499.452508212395, 36513.26973460516, 37039.07402314937, 3722.3485889969147, 3747.400415933465, 3780.527434070741, 3794.867179648699, 3876.0116170376655, 27789.583156252673, 28056.298592535146, 28450.715492845222, 28452.146435606966, 28618.427631447255, 3081.3837232553356, 3111.0, 3208.6951739584933, 3245.237369218232, 3249.4800831866787, 434924.99999999686, 435675.0, 438677.0, 439523.0, 441437.0, 44576.10847783091, 46444.0, 54459.0, 54846.451535484935, 55441.0, 55243.72378138164, 58380.41619583835, 58837.0, 58844.4115558839, 58867.0, 14370.065945713495, 14512.637184070483, 14521.636959076108, 14546.927265363605, 14566.708665826623, 10783.622573210057, 10862.945685271523, 10912.50893709785, 10924.672259832218, 10945.179111566664, 14684.559463216121, 17675.646487070444, 17720.734188987175, 17720.9113954432, 17723.822761772473, 6590.637514936724, 6611.371919667624, 7645.464817462725, 7657.540547567164, 7776.92223077762, 783.9686412543434, 834.5576844272546, 847.6185716427632, 858.2876212743408, 864.6152462154281, 28891.85554072216, 29264.122076337742, 29383.0, 29989.850050749606, 30030.94891678781, 1005.2460654509118, 1020.6682828080903, 1041.6874937518864, 1059.2161800267747, 1162.1980833225216, 13543.0, 15276.312565934337, 15299.235038248044, 15374.461893833663, 15602.453914112952, 576525.0, 577232.0, 577893.0, 578198.0, 578217.0, 49875.75062124666, 50619.74690126526, 58344.0, 59069.40930590639, 59159.112613310834, 1337.9866201337861, 1374.5463996881006, 1378.7449321875486, 1379.3379177994418, 1380.4409214268237, 27460.0, 28020.71979280181, 28058.2985425366, 28407.0, 29884.551731724478, 50374.74812625913, 50383.24425133553, 50553.0, 50578.49421505738, 50594.0, 495762.0, 496458.0, 497520.0, 497899.51050244516, 498101.0, 24465.143719969714, 25240.495190096462, 25459.36351591225, 26084.869575652, 26546.336341591614, 34155.82922085374, 42305.365419519345, 42427.363589545566, 42906.1418771629, 42999.355009674255, 31209.53185702171, 34510.30979380449, 34768.30463390768, 35543.82228088843, 35919.0, 31388.372232555677, 33935.490967635014, 33941.151471213416, 35144.824275878455, 35392.29215415626, 33807.49288760621, 34427.76219545722, 34469.82765086158, 34647.82676086603, 34940.47589286112, 29853.402931940804, 30975.845120775153, 31089.689103108678, 31176.0, 31259.374812504077, 21691.56616867622, 22295.0, 23232.186873459348, 23627.29118126459, 23779.524409511367], "value": 19080.834409000276, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.2277834321182, 390.4884601172464, 392.4466502231854, 402.29999800347395, 420.11565654297704, 16612.501624951256, 17238.655226895455, 18059.819401805977, 19820.0, 20201.696974545393, 19187.61624767504, 19889.900550497263, 19943.10256038478, 20252.797472025275, 20266.885321307323, 4446.9994251293365, 5269.499397557245, 5512.503874651281, 5673.971630141844, 5920.792772252972, 5469.371022332443, 5860.882782344351, 5862.798126384081, 5868.4424979626865, 5870.031444811622, 5511.063119269734, 5799.449052340021, 5807.128930660414, 5812.099124635688, 5813.82558523245, 5844.473997340238, 5890.911636325459, 5894.616849904743, 5895.322037965624, 5900.793472228473, 4775.212090005145, 4991.450940396553, 5774.422557744192, 5809.7676092956235, 5840.211571437844, 12370.44333005017, 12767.72322767725, 12796.424160912782, 22752.886235568883, 24872.3781905452, 2673.331667083229, 2756.0904901382696, 2937.4859399605198, 2942.1614839770564, 2961.6890226526334, 9769.804603907953, 11665.475053622607, 11872.584459543961, 13457.0, 14800.925995370062, 1775.7247626617766, 1790.0870556016396, 1793.7847458304957, 1796.463928580332, 1830.1581272614612, 77505.99999999943, 107790.0, 118907.0, 119479.0, 120683.0, 11431.771364572829, 11636.476358563716, 11721.179517433868, 11776.352300623377, 11947.701307467383, 15274.541763747106, 15288.159151246566, 15358.846411535966, 15383.0, 15433.45982890616, 7944.563049032358, 8242.629081691339, 8296.170382961776, 8391.580420978926, 8413.789655258668, 7797.259260370256, 7841.607919604111, 7851.646675899598, 7911.248431399123, 7963.960180199178, 4042.3532234842874, 4658.627309815207, 4696.839453851198, 4701.95298047022, 4823.469418363977, 1982.3557343863301, 2014.939551813448, 2014.9697754533693, 2024.9493762655757, 2025.3518873960486, 941.4586612697726, 985.2708995343394, 991.1525645573075, 998.5656239535825, 1038.9740256493649, 20506.692399614018, 20691.0, 20752.72845333545, 20804.271850485162, 21099.261525846523, 1017.9236557258236, 1028.4703377760459, 1040.4485622620023, 1043.7703705184847, 1048.564845589072, 8233.752987410388, 10808.891911080946, 10830.0, 10845.349279043125, 10850.0, 612088.0, 671437.0, 689035.0, 691405.0, 712451.0, 117156.0, 130889.69110308775, 131626.34186829004, 140921.0, 146233.53766462198, 896.7533928169805, 915.5742579700471, 939.2579861909152, 946.9242460603135, 950.5817440326095, 18836.811631883505, 18967.33614323492, 19209.03954802282, 19310.71033934464, 19329.93685347263, 50954.49045509646, 54017.91964160773, 56712.0, 58491.0, 58800.70599646975, 74044.0, 77454.0, 77641.0, 82148.58925705333, 82826.0, 7686.730964416219, 8000.559969201517, 8163.1428699985645, 8250.504969701837, 8261.339092872435, 10326.896731032894, 10526.68416447944, 11710.12174086964, 12052.397380131133, 12106.334151621746, 9922.950385248028, 10191.643292484727, 10604.363738175734, 10740.087092597218, 10742.677719668422, 10343.0, 10609.840852387066, 10654.73363165927, 10764.192685548458, 10797.514111864828, 10751.462426878468, 10959.232853700165, 11024.393658348868, 11084.944575277072, 11219.60731374398, 7882.172371901097, 7998.240167184108, 8046.597670116354, 8052.677892884219, 8305.418620696735, 7978.162292959156, 9753.51232438361, 10264.794704106025, 10744.677659670222, 10793.514291856729], "value": 9477.073611428837, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1382.8824549913256, 1432.348281531903, 1436.4558100042457, 1442.92785360732, 1456.1845366594707, 8134.227248411399, 8199.22107399796, 8430.620622072007, 8566.957165214173, 8653.177948094937, 8380.28767554757, 8513.574321283926, 8515.829683406328, 8517.574121293941, 8580.270676992463, 2248.168177774226, 2275.84069115162, 2280.623697089978, 2287.0394434337536, 2288.8054515366216, 2240.7423146338137, 2270.71616047994, 2272.136588096521, 2276.169198242638, 2288.0275882749847, 2219.8002179803816, 2232.274510784002, 2264.0, 2265.8753768542724, 2269.9886500567472, 2163.751168615598, 2222.255544392622, 2237.183428048767, 2245.5733410651924, 2251.448395143184, 1924.9711254331196, 2010.3064442767368, 2196.0, 2271.5116250006326, 2276.9544609107893, 7900.960495197487, 8498.405111642187, 8534.786630334229, 8569.871451928226, 8599.269062129726, 5076.619253555961, 5185.55922746567, 5201.375834899798, 5228.581713462914, 5235.55497782689, 3104.5653608494827, 3416.538767266412, 3479.764683537333, 3493.8427770750377, 3571.1250743567994, 1204.861440934295, 1211.745533437979, 1240.4542001519303, 1262.236347010055, 1267.7084270617718, 10948.616798412017, 10960.12319014477, 11046.889531104667, 11087.778244435067, 11096.445177741081, 3604.711623070148, 4113.670906327487, 4439.689221754511, 4464.620507256855, 4464.754438505914, 8629.395942284105, 8751.168638979287, 8777.034526202113, 8777.981064355234, 8797.604107815163, 4573.0, 5058.266551350107, 5068.949310506848, 5079.314292570456, 5089.796408143633, 4552.271636538138, 4564.863054108382, 4676.789544470507, 4721.598664113589, 4743.762811859393, 3164.351307981858, 3604.819759012039, 3622.8007459589976, 3652.908677283089, 3679.2089700714473, 1131.7283851875654, 1132.6262333429947, 1141.6004398460473, 1146.6388087752332, 1149.3046706742468, 865.3985480091276, 880.5333173418098, 888.1651247827022, 905.3526728389234, 909.8589718593629, 5467.45325467458, 5541.947030064275, 5551.916721249185, 5615.747291371898, 5809.099589563624, 548.7530611224885, 549.3078720811806, 554.6117717597617, 569.7265312649869, 571.1974675580816, 3600.567931848195, 3700.481932529448, 3722.683571896365, 3731.5149030625844, 3822.751521151172, 9617.326787124834, 9940.204783617293, 10054.798904021878, 10217.284790064625, 10263.794724105626, 9940.701778946643, 10056.547455364525, 10159.593616255266, 10167.440790756431, 10170.288079834341, 7700.768976930701, 7888.32949199313, 7907.644156013108, 7920.643571039317, 7931.2068793120225, 5467.316585426822, 5472.91790623133, 5504.587155963239, 5531.197976293334, 5568.220449137043, 7311.744088956861, 8820.5589720515, 8842.823143537222, 9215.0, 9243.075692430702, 9131.0412406699, 9216.815663686555, 9331.813363732823, 9357.06429357059, 9404.482753448627, 6152.354002829818, 7144.892826607709, 7270.563766174047, 7285.4900156990625, 7288.489805713549, 7783.688652453839, 7853.8036549084445, 7948.16544262844, 7962.163972782774, 7985.680572777024, 7104.147502299757, 7134.785956421316, 7179.210286868545, 7193.964030179815, 7242.3843973262865, 7087.433005359456, 7124.964375178299, 7145.21402645719, 7156.892646610409, 7190.640467976685, 6256.092866534418, 6275.795276763909, 6280.403361680633, 6321.367863213826, 6355.110284560073, 4799.568038876518, 4867.269909513601, 4873.780679869344, 4956.801727930842, 5070.340855688737, 4805.327254184487, 4989.525995030466, 5005.224190250517, 5033.394444083622, 5166.173412254172], "value": 4300.288096436704, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.69580875411464, 353.93983022886124, 363.7326564974743, 365.7896709392097, 369.39234958493273, 5020.523050310224, 5111.258867464216, 5128.9230661540105, 5317.468253174686, 5439.211314359421, 5051.019898260026, 5183.585313174946, 5228.111221092414, 5252.6848389096585, 5299.205119232108, 4103.569125241851, 4117.402976568411, 4131.710780245384, 4140.151268989865, 4165.958340416602, 3989.501312335958, 4076.7350122242105, 4121.319982202933, 4128.772917489552, 4143.958560414402, 3515.209077957452, 3759.3797023491093, 3789.6399842015103, 3977.7016723745833, 4069.1861627674434, 3409.488576713488, 4082.9795851020854, 4087.652549533293, 4108.1783643271465, 4112.1626078006375, 2805.9158225253277, 3454.136465883529, 3544.8404821783083, 3614.5120408744747, 3653.4472849039053, 4275.764832934187, 4900.627824209227, 5040.560216321151, 5066.645334826564, 5104.345740215067, 4726.66913316068, 4732.739699316537, 4751.239801631722, 4759.381280433556, 4784.755963449494, 5526.889462210774, 5531.2809334786625, 5541.947030064275, 5552.139418390156, 5563.191962612127, 3480.721542276637, 3780.9980355205894, 3814.2180852925085, 4004.0570180917002, 4004.619561141687, 5531.0, 5754.597178197486, 5797.710114494258, 5838.970805145989, 5871.588988770788, 3305.801651900894, 3799.8220551629083, 3832.693384529287, 3841.7887016213817, 3845.8846234613006, 3909.4526766252748, 3913.0804260998643, 3921.274564205631, 3922.764634121962, 3926.9410958835642, 4519.457665080211, 4561.840335588305, 4588.908221835544, 4598.471175814757, 4667.276572131325, 4806.7836947336755, 5177.456367081478, 5336.226247194135, 5582.264690301804, 5584.52531534816, 1091.51553886714, 1207.2454715802623, 1217.184486394118, 1272.5175170925768, 1283.6149155253574, 810.9756707298791, 858.772425307294, 865.8398196333699, 878.7978764883985, 879.3448880584006, 4249.830006799755, 4313.590208930146, 4882.658213924991, 4914.378255175783, 5021.347224860745, 4613.538646135359, 5253.4221235664045, 5514.779408823602, 5531.502164805106, 5547.667139971614, 4478.776061196927, 4771.832985845479, 4967.379077615298, 5002.449730529639, 5031.798728050837, 2508.548461276988, 2694.9383721453105, 2784.874680639376, 2826.915192544227, 2892.3224529772683, 5040.404191841205, 5660.943390566124, 5678.432156784371, 5685.516731077904, 5721.884232574608, 4666.346711460398, 5272.098647001269, 5444.128939369761, 5588.21764952907, 5646.0, 4670.95329046712, 5462.8361149165585, 5545.722713864371, 5649.502881736343, 5682.37493875665, 5054.949450505448, 5236.528712415901, 5279.380542025728, 5389.517882582321, 5455.3453585568395, 4727.456342520517, 5184.662996905189, 5440.8846186532455, 5548.9722551388595, 5597.356304025089, 5593.496585307342, 5638.436156384329, 5745.482906538432, 5888.352281248974, 5892.204552385545, 3770.830312635993, 3850.3839385699275, 3851.7111216659423, 3852.287326844543, 3868.613138686109, 5129.2819005340025, 5709.628874123168, 5734.99637563433, 5736.627119237236, 5737.942620573741, 4722.645801564965, 5451.64564303319, 5537.363203231519, 5554.0, 5708.57185711065, 4751.382320298339, 5144.588432925282, 5218.008578370098, 5537.723113844372, 5567.582431317748, 4600.447946246338, 5030.949690503195, 5447.863803404946, 5487.311217503475, 5506.577106073315, 4821.783019764049, 5106.591472682102, 5511.366192887709, 5589.021921163861, 5635.267415235993, 5475.342958844964, 5502.752376143003, 5510.421405752339, 5536.695481748381, 5551.833444996657], "value": 4041.9630032930704, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.8275431142215, 700.4396482813747, 756.0511557994719, 795.4312666443493, 802.9211605046365, 11718.589849355274, 14821.481248156317, 15149.242537873117, 15201.619959501018, 15203.543893683194, 14766.0, 15423.845761542381, 15455.22723863808, 15796.0, 15867.127307998084, 853.7822855171922, 873.6112429968666, 875.8598624220126, 879.3141349747208, 879.3624622148955, 846.1073567386405, 869.9130086991313, 880.4057261348596, 883.8011447424342, 883.9823203535925, 900.3652425040364, 918.4030380252823, 919.3610440743686, 920.2867777472445, 920.7928216151379, 905.1175104273347, 916.2074805293406, 916.2761418479394, 917.495377542349, 919.2416256588308, 681.4105798484325, 684.3737979748524, 685.116200101868, 685.2633419074465, 685.2804555217052, 14031.368588413443, 14432.061915975533, 15106.54680359591, 15139.091654500766, 15158.924205378902, 13510.189388636614, 13750.449982000708, 13865.237411942338, 13911.513097041656, 13937.442502299897, 9693.321467497279, 11516.251443656136, 11639.47622356996, 11762.529498820037, 12118.697032574257, 3554.697850682695, 3586.3006713690843, 3593.2633810068874, 3605.693516051139, 3624.7281453891064, 74701.5059698803, 82011.17988820095, 83029.75455368175, 84870.72693909597, 86100.56949715274, 10183.32991890313, 10302.278840481244, 10437.425941573134, 10440.216983726252, 10485.26603137773, 21480.4629884251, 21759.129634814748, 21789.0, 21801.0, 21840.781592183874, 7414.369778568775, 7510.699572017058, 7512.39900807934, 7515.398768098539, 7700.961495192488, 3860.7876566788536, 3972.0069982504374, 4045.0898547826505, 4115.36211887158, 4171.290880550314, 3484.2508860595094, 3581.8209089545417, 3633.0190848470766, 3640.7269454791, 3648.8175591220333, 653.4380432827764, 660.5013215022627, 661.0447902780436, 674.436845234235, 676.7834293026184, 664.6178447392768, 666.0974379715512, 673.2493270003911, 690.0305071374627, 707.4234498883394, 9305.953470232605, 9681.51592420376, 9916.057974492413, 9987.705286726632, 10086.899131008597, 626.8620903401245, 662.0301258656092, 666.6866572710818, 668.6322522612544, 676.8797639905963, 4831.95168048315, 5060.443351231435, 5205.45342739007, 5357.223202635596, 5426.945730542723, 79208.60395697984, 79480.0, 96307.51846240724, 98853.50573247088, 102741.0, 56936.43063569394, 73931.0, 74838.62580687062, 83206.3358732822, 85820.57089714511, 59124.11313830296, 64135.0, 64943.35056649373, 66211.0, 73451.26548734552, 9836.803263934538, 10073.244506661884, 10380.273380863267, 10574.947125264325, 10580.682579522627, 40985.565505207174, 44287.33568996532, 45054.0, 45190.32214516719, 48464.788380290775, 54349.0, 54384.0, 62326.0, 62363.37636623576, 63386.68306658437, 10491.422971736627, 12403.8836504715, 12456.750864982469, 12463.439145238668, 13234.602961911158, 13805.861941380457, 13837.308134593432, 13953.419123668173, 14035.789463157857, 14685.19231442281, 12508.624741257778, 12543.029366458946, 12555.93722031384, 12571.559995400117, 13242.801357979446, 12858.0, 13123.671908202372, 13517.526886558922, 13584.25286609246, 13660.611554687883, 12457.750844982867, 12919.741605168032, 13305.86694133085, 13435.932820335836, 13441.462341506622, 10172.593096276067, 10430.791384172426, 10544.789104218025, 10573.89426105729, 10806.029191784357, 8153.6112414047, 8869.334799889904, 10314.742131446774, 10321.690349289232, 10330.793384132125], "value": 7238.14090534866, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1612.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 150.0, 132.0, 160.0, 168.0, 97.0, 168.0, 171.0, 151.0, 169.0], "value": 150.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 116.0, 114.0, 155.0, 120.0, 131.0, 140.0, 141.0, 120.0, 141.0], "value": 133.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [216.0, 226.0, 195.0, 197.0, 196.0, 201.0, 194.0, 198.0, 195.0, 195.0], "value": 201.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 85.0, 107.0, 84.0, 72.0, 63.0, 60.0, 75.0, 62.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 71.0, 85.0, 71.0, 71.0, 98.0, 68.0, 75.0, 97.0, 111.0], "value": 84.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 94.0, 85.0, 90.0, 75.0, 133.0, 125.0, 89.0, 85.0], "value": 95.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 96.0, 98.0, 97.0, 96.0, 95.0, 105.0, 120.0, 96.0], "value": 110.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 99.0, 94.0, 94.0, 97.0, 91.0, 94.0, 94.0, 94.0, 93.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 71.0, 77.0, 93.0, 94.0, 78.0, 64.0, 63.0], "value": 73.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 70.0, 116.0, 111.0, 82.0, 68.0, 69.0, 71.0, 71.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 105.0, 103.0, 105.0, 91.0, 108.0, 112.0, 106.0, 91.0], "value": 100.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 160.0, 171.0, 154.0, 154.0, 151.0, 154.0, 149.0, 178.0, 169.0], "value": 159.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 182.0, 176.0, 204.0, 229.0, 197.0, 178.0, 179.0, 178.0, 179.0], "value": 187.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 66.0, 70.0, 68.0, 68.0, 69.0, 66.0, 67.0, 67.0], "value": 67.7, "unit": "score"}]}]} 17:25:30 INFO - Return code: 0 17:25:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:25:30 ERROR - # TBPL SUCCESS # 17:25:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:25:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:25:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:25:30 INFO - 2017-02-08 17:25:30.344 screenresolution[1926:19989] starting screenresolution argv=screenresolution get 17:25:30 INFO - 2017-02-08 17:25:30.347 screenresolution[1926:19989] Display 0: 1600x1200x32@60 17:25:30 INFO - 2017-02-08 17:25:30.353 screenresolution[1927:19992] starting screenresolution argv=screenresolution list 17:25:30 INFO - Available Modes on Display 0 17:25:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:25:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:25:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:25:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:25:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:25:30 INFO - Intel Iris: 17:25:30 INFO - Chipset Model: Intel Iris 17:25:30 INFO - Type: GPU 17:25:30 INFO - Bus: Built-In 17:25:30 INFO - VRAM (Dynamic, Max): 1536 MB 17:25:30 INFO - Vendor: Intel (0x8086) 17:25:30 INFO - Device ID: 0x0a2e 17:25:30 INFO - Revision ID: 0x0009 17:25:30 INFO - Displays: 17:25:30 INFO - Display: 17:25:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:25:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:25:30 INFO - Display Serial Number: 1600x1200 60 17:25:30 INFO - Main Display: Yes 17:25:30 INFO - Mirror: Off 17:25:30 INFO - Online: Yes 17:25:30 INFO - Rotation: Supported 17:25:30 INFO - Return code: 0 17:25:30 INFO - Running post-action listener: _resource_record_post_action 17:25:30 INFO - [mozharness: 2017-02-09 01:25:30.595399Z] Finished run-tests step (success) 17:25:30 INFO - Running post-run listener: _resource_record_post_run 17:25:30 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 1644032; Write bytes: 555661312; Read time: 18; Write time: 2029 17:25:30 INFO - TinderboxPrint: CPU usage
54.6% 17:25:30 INFO - TinderboxPrint: I/O read bytes / time
1,644,032 / 18 17:25:30 INFO - TinderboxPrint: I/O write bytes / time
555,661,312 / 2,029 17:25:30 INFO - TinderboxPrint: CPU idle
2,178.2 (45.4%) 17:25:30 INFO - TinderboxPrint: CPU system
969.5 (20.2%) 17:25:30 INFO - TinderboxPrint: CPU user
1,654.0 (34.4%) 17:25:30 INFO - TinderboxPrint: Swap in / out
254,554,112 / 0 17:25:30 INFO - install - Wall time: 23s; CPU: 55.0%; Read bytes: 253209088; Write bytes: 255620608; Read time: 19244; Write time: 559 17:25:30 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 1562112; Write bytes: 298762752; Read time: 17; Write time: 1463 17:25:31 INFO - Running post-run listener: _upload_blobber_files 17:25:31 INFO - Blob upload gear active. 17:25:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:25:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:25:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:25:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:25:31 INFO - (blobuploader) - INFO - Open directory for files ... 17:25:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:25:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:25:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:32 INFO - (blobuploader) - INFO - Done attempting. 17:25:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:25:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:25:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:33 INFO - (blobuploader) - INFO - Done attempting. 17:25:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:25:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:25:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:34 INFO - (blobuploader) - INFO - Done attempting. 17:25:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:25:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:25:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:36 INFO - (blobuploader) - INFO - Done attempting. 17:25:36 INFO - (blobuploader) - INFO - Iteration through files over. 17:25:36 INFO - Return code: 0 17:25:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:25:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:25:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0137bb217931edc8072b68d8751090fd3b6fac95502a73a0d9b71c0e003f212c7542c62896fb56a6313382b219159d2dcf2b596e7568f815ac9d3f699cc1a84", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/672607ea9c316e3bc61f842c93453ef58a221c52b009dd537490341f7ddc05e1bc02d0042226fe8578e83f20cbc6d905346b6f2829aa774f81e6bb19b0dfee31", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7a294586d0bf68f882219d4c099ef821d8c59072d9c3be99fc062fc8cd1de1a8e97fdc8d7da89e1bce0a511f8203e6b387ec2f6b70bbddff4aac6e1eaffdd38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cfe5ea307afba75aacf116d30c6c3a4f2c3338444a50433549dd0082aa678f05967a33c3ad1c3b4bea97434ae6af2c525300c7fdba5dba627922e2e708ed796"} 17:25:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:25:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:25:36 INFO - Contents: 17:25:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0137bb217931edc8072b68d8751090fd3b6fac95502a73a0d9b71c0e003f212c7542c62896fb56a6313382b219159d2dcf2b596e7568f815ac9d3f699cc1a84", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/672607ea9c316e3bc61f842c93453ef58a221c52b009dd537490341f7ddc05e1bc02d0042226fe8578e83f20cbc6d905346b6f2829aa774f81e6bb19b0dfee31", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7a294586d0bf68f882219d4c099ef821d8c59072d9c3be99fc062fc8cd1de1a8e97fdc8d7da89e1bce0a511f8203e6b387ec2f6b70bbddff4aac6e1eaffdd38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cfe5ea307afba75aacf116d30c6c3a4f2c3338444a50433549dd0082aa678f05967a33c3ad1c3b4bea97434ae6af2c525300c7fdba5dba627922e2e708ed796"} 17:25:36 INFO - Running post-run listener: copy_logs_to_upload_dir 17:25:36 INFO - Copying logs to upload dir... 17:25:36 INFO - mkdir: /builds/slave/test/build/upload/logs 17:25:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.650344 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-08 17:25:36.473662) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 17:25:36.477739) ========= 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.8b8eORm3kX/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.Qp0tdMomKV/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0137bb217931edc8072b68d8751090fd3b6fac95502a73a0d9b71c0e003f212c7542c62896fb56a6313382b219159d2dcf2b596e7568f815ac9d3f699cc1a84", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/672607ea9c316e3bc61f842c93453ef58a221c52b009dd537490341f7ddc05e1bc02d0042226fe8578e83f20cbc6d905346b6f2829aa774f81e6bb19b0dfee31", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7a294586d0bf68f882219d4c099ef821d8c59072d9c3be99fc062fc8cd1de1a8e97fdc8d7da89e1bce0a511f8203e6b387ec2f6b70bbddff4aac6e1eaffdd38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cfe5ea307afba75aacf116d30c6c3a4f2c3338444a50433549dd0082aa678f05967a33c3ad1c3b4bea97434ae6af2c525300c7fdba5dba627922e2e708ed796"} build_url:https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/MmURUfi0RIafyQaC7sKtWA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0137bb217931edc8072b68d8751090fd3b6fac95502a73a0d9b71c0e003f212c7542c62896fb56a6313382b219159d2dcf2b596e7568f815ac9d3f699cc1a84", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/672607ea9c316e3bc61f842c93453ef58a221c52b009dd537490341f7ddc05e1bc02d0042226fe8578e83f20cbc6d905346b6f2829aa774f81e6bb19b0dfee31", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7a294586d0bf68f882219d4c099ef821d8c59072d9c3be99fc062fc8cd1de1a8e97fdc8d7da89e1bce0a511f8203e6b387ec2f6b70bbddff4aac6e1eaffdd38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6cfe5ea307afba75aacf116d30c6c3a4f2c3338444a50433549dd0082aa678f05967a33c3ad1c3b4bea97434ae6af2c525300c7fdba5dba627922e2e708ed796"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 17:25:36.512946) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 17:25:36.513331) ========= 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.8b8eORm3kX/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.Qp0tdMomKV/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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.005181 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 17:25:36.562303) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 17:25:36.562633) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 17:25:36.562996) ========= ========= Total master_lag: 0.19 =========