builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0185 starttime: 1481938663.63 results: success (0) buildid: 20161216161549 builduid: fc77eca18fb1403baaf435e43b89bcf9 revision: 74f4edb0d09dbb7809eadaff9d321d61203bbaf1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-16 17:37:43.630586) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-16 17:37:43.631034) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-16 17:37:43.631325) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-16 17:37:43.659604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 17:37:43.660011) ========= 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.wrKZObUc10/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.KM6c3gMWlQ/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 --2016-12-16 17:37:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 147M=0s 2016-12-16 17:37:43 (147 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148438 ========= master_lag: 0.55 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 17:37:44.354537) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 17:37:44.354884) ========= 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.wrKZObUc10/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.KM6c3gMWlQ/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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.019987 ========= master_lag: 0.70 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 17:37:45.070708) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-16 17:37:45.071141) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 74f4edb0d09dbb7809eadaff9d321d61203bbaf1 --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 74f4edb0d09dbb7809eadaff9d321d61203bbaf1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wrKZObUc10/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.KM6c3gMWlQ/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 2016-12-16 17:37:45,151 truncating revision to first 12 chars 2016-12-16 17:37:45,151 Setting DEBUG logging. 2016-12-16 17:37:45,151 attempt 1/10 2016-12-16 17:37:45,151 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/74f4edb0d09d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-16 17:37:46,338 unpacking tar archive at: mozilla-central-74f4edb0d09d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.461448 ========= master_lag: 0.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-16 17:37:46.745311) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-16 17:37:46.745624) ========= script_repo_revision: 74f4edb0d09dbb7809eadaff9d321d61203bbaf1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-16 17:37:46.746046) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-16 17:37:46.746325) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-16 17:37:46.766468) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-12-16 17:37:46.766805) ========= /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.wrKZObUc10/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.KM6c3gMWlQ/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:37:46 INFO - MultiFileLogger online at 20161216 17:37:46 in /builds/slave/test 17:37:46 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:37:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:37:46 INFO - {'append_to_log': False, 17:37:46 INFO - 'base_work_dir': '/builds/slave/test', 17:37:46 INFO - 'blob_upload_branch': 'Firefox', 17:37:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:37:46 INFO - 'branch': 'Firefox', 17:37:46 INFO - 'buildbot_json_path': 'buildprops.json', 17:37:46 INFO - 'config_files': ('talos/mac_config.py',), 17:37:46 INFO - 'default_actions': ('clobber', 17:37:46 INFO - 'read-buildbot-config', 17:37:46 INFO - 'download-and-extract', 17:37:46 INFO - 'populate-webroot', 17:37:46 INFO - 'create-virtualenv', 17:37:46 INFO - 'install', 17:37:46 INFO - 'run-tests'), 17:37:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:37:46 INFO - 'download_minidump_stackwalk': True, 17:37:46 INFO - 'download_symbols': 'ondemand', 17:37:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:37:46 INFO - 'tooltool.py': '/tools/tooltool.py', 17:37:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:37:46 INFO - '/tools/misc-python/virtualenv.py')}, 17:37:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:37:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:37:46 INFO - 'installer_path': 'installer.exe', 17:37:46 INFO - 'log_level': 'info', 17:37:46 INFO - 'log_name': 'talos', 17:37:46 INFO - 'log_to_console': True, 17:37:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:37:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:37:46 INFO - 'opt_config_files': (), 17:37:46 INFO - 'pip_index': False, 17:37:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:37:46 INFO - 'cmd': ('bash', 17:37:46 INFO - '-c', 17:37:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:37:46 INFO - 'enabled': True, 17:37:46 INFO - 'halt_on_failure': False, 17:37:46 INFO - 'name': 'check_screen_resolution'},), 17:37:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:37:46 INFO - 'cmd': ('bash', 17:37:46 INFO - '-c', 17:37:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:37:46 INFO - 'enabled': True, 17:37:46 INFO - 'halt_on_failure': False, 17:37:46 INFO - 'name': 'check_screen_resolution'},), 17:37:46 INFO - 'run_cmd_checks_enabled': True, 17:37:46 INFO - 'sps_profile': False, 17:37:46 INFO - 'sps_profile_interval': 0, 17:37:46 INFO - 'suite': 'dromaeojs-e10s', 17:37:46 INFO - 'system_bits': '32', 17:37:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:37:46 INFO - 'title': 't-yosemite-r7-0185', 17:37:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:37:46 INFO - 'use_talos_json': True, 17:37:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:37:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:37:46 INFO - 'work_dir': 'build'} 17:37:46 INFO - [mozharness: 2016-12-17 01:37:46.970146Z] Running clobber step. 17:37:46 INFO - Running pre-action listener: _resource_record_pre_action 17:37:46 INFO - Running main action method: clobber 17:37:46 INFO - rmtree: /builds/slave/test/build 17:37:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:37:47 INFO - Running post-action listener: _resource_record_post_action 17:37:47 INFO - [mozharness: 2016-12-17 01:37:47.293690Z] Finished clobber step (success) 17:37:47 INFO - [mozharness: 2016-12-17 01:37:47.293856Z] Running read-buildbot-config step. 17:37:47 INFO - Running pre-action listener: _resource_record_pre_action 17:37:47 INFO - Running main action method: read_buildbot_config 17:37:47 INFO - Using buildbot properties: 17:37:47 INFO - { 17:37:47 INFO - "project": "", 17:37:47 INFO - "product": "firefox", 17:37:47 INFO - "script_repo_revision": "production", 17:37:47 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 17:37:47 INFO - "repository": "", 17:37:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 17:37:47 INFO - "buildid": "20161216161549", 17:37:47 INFO - "pgo_build": "False", 17:37:47 INFO - "basedir": "/builds/slave/test", 17:37:47 INFO - "buildnumber": 20, 17:37:47 INFO - "slavename": "t-yosemite-r7-0185", 17:37:47 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 17:37:47 INFO - "platform": "yosemite_r7", 17:37:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:37:47 INFO - "branch": "mozilla-central", 17:37:47 INFO - "repo_path": "mozilla-central", 17:37:47 INFO - "revision": "74f4edb0d09dbb7809eadaff9d321d61203bbaf1", 17:37:47 INFO - "stage_platform": "macosx64", 17:37:47 INFO - "builduid": "fc77eca18fb1403baaf435e43b89bcf9", 17:37:47 INFO - "slavebuilddir": "test" 17:37:47 INFO - } 17:37:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 17:37:47 INFO - Running post-action listener: _resource_record_post_action 17:37:47 INFO - [mozharness: 2016-12-17 01:37:47.297159Z] Finished read-buildbot-config step (success) 17:37:47 INFO - [mozharness: 2016-12-17 01:37:47.297286Z] Running download-and-extract step. 17:37:47 INFO - Running pre-action listener: _resource_record_pre_action 17:37:47 INFO - Running main action method: download_and_extract 17:37:47 INFO - mkdir: /builds/slave/test/build/tests 17:37:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:37:47 INFO - trying https://queue.taskcluster.net/v1/task/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 17:37:47 INFO - Downloading https://queue.taskcluster.net/v1/task/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 17:37:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 17:37:47 INFO - Downloaded 1199 bytes. 17:37:47 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 17:37:47 INFO - Using the following test package requirements: 17:37:47 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 17:37:47 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:37:47 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 17:37:47 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:37:47 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 17:37:47 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:37:47 INFO - u'jsshell-mac.zip'], 17:37:47 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:37:47 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 17:37:47 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 17:37:47 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:37:47 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 17:37:47 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:37:47 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 17:37:47 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:37:47 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 17:37:47 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 17:37:47 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 17:37:47 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:37:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 17:37:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:37:47 INFO - Fetch https://queue.taskcluster.net/v1/task/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 17:37:48 INFO - Expected file size: 16277463 17:37:48 INFO - Obtained file size: 16277463 17:37:55 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:37:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 17:37:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:37:55 INFO - Fetch https://queue.taskcluster.net/v1/task/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 17:37:56 INFO - Expected file size: 16277463 17:37:56 INFO - Obtained file size: 16277463 17:38:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 17:38:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:38:02 INFO - Fetch https://queue.taskcluster.net/v1/task/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 17:38:04 INFO - Expected file size: 14409734 17:38:04 INFO - Obtained file size: 14409734 17:38:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:04 INFO - trying https://queue.taskcluster.net/v1/task/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 17:38:04 INFO - Downloading https://queue.taskcluster.net/v1/task/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 17:38:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 17:38:07 INFO - Downloaded 69586668 bytes. 17:38:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 17:38:07 INFO - mkdir: /builds/slave/test/properties 17:38:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:38:07 INFO - Writing to file /builds/slave/test/properties/build_url 17:38:07 INFO - Contents: 17:38:07 INFO - build_url:https://queue.taskcluster.net/v1/task/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 17:38:08 INFO - Running post-action listener: _resource_record_post_action 17:38:08 INFO - Running post-action listener: set_extra_try_arguments 17:38:08 INFO - [mozharness: 2016-12-17 01:38:08.640497Z] Finished download-and-extract step (success) 17:38:08 INFO - [mozharness: 2016-12-17 01:38:08.640620Z] Running populate-webroot step. 17:38:08 INFO - Running pre-action listener: _resource_record_pre_action 17:38:08 INFO - Running main action method: populate_webroot 17:38:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:38:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:38:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:38:08 INFO - '--tppagecycles', 17:38:08 INFO - '7'], 17:38:08 INFO - 'tests': ['tsvgm']}}, 17:38:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:38:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:38:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:38:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:38:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:38:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:38:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:38:08 INFO - 'talos_options': ['--disable-e10s'], 17:38:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:38:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:38:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:38:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:38:08 INFO - 'talos_options': ['--disable-e10s'], 17:38:08 INFO - 'tests': ['damp', 'tps']}, 17:38:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:38:08 INFO - 'tests': ['damp', 'tps']}, 17:38:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:38:08 INFO - 'tests': ['dromaeo_dom']}, 17:38:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:38:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:38:08 INFO - 'tests': ['basic_compositor_video']}, 17:38:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:38:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:38:08 INFO - 'tests': ['a11yr', 17:38:08 INFO - 'ts_paint', 17:38:08 INFO - 'tpaint', 17:38:08 INFO - 'sessionrestore', 17:38:08 INFO - 'sessionrestore_no_auto_restore', 17:38:08 INFO - 'tabpaint']}, 17:38:08 INFO - 'other-e10s': {'tests': ['a11yr', 17:38:08 INFO - 'ts_paint', 17:38:08 INFO - 'tpaint', 17:38:08 INFO - 'sessionrestore', 17:38:08 INFO - 'sessionrestore_no_auto_restore', 17:38:08 INFO - 'tabpaint']}, 17:38:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:38:08 INFO - 'ts_paint', 17:38:08 INFO - 'tpaint', 17:38:08 INFO - 'sessionrestore', 17:38:08 INFO - 'sessionrestore_no_auto_restore', 17:38:08 INFO - 'tabpaint']}, 17:38:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:38:08 INFO - 'ts_paint', 17:38:08 INFO - 'tpaint', 17:38:08 INFO - 'sessionrestore', 17:38:08 INFO - 'sessionrestore_no_auto_restore', 17:38:08 INFO - 'tabpaint']}, 17:38:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:38:08 INFO - 'tests': ['a11yr', 17:38:08 INFO - 'ts_paint', 17:38:08 INFO - 'tpaint', 17:38:08 INFO - 'sessionrestore', 17:38:08 INFO - 'sessionrestore_no_auto_restore', 17:38:08 INFO - 'tabpaint']}, 17:38:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:38:08 INFO - 'tests': ['a11yr', 17:38:08 INFO - 'ts_paint', 17:38:08 INFO - 'tpaint', 17:38:08 INFO - 'sessionrestore', 17:38:08 INFO - 'sessionrestore_no_auto_restore', 17:38:08 INFO - 'tabpaint']}, 17:38:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:38:08 INFO - 'tests': ['tsvgx', 17:38:08 INFO - 'tsvgr_opacity', 17:38:08 INFO - 'tart', 17:38:08 INFO - 'tscrollx', 17:38:08 INFO - 'cart', 17:38:08 INFO - 'tsvg_static']}, 17:38:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:38:08 INFO - 'tsvgr_opacity', 17:38:08 INFO - 'tart', 17:38:08 INFO - 'tscrollx', 17:38:08 INFO - 'cart', 17:38:08 INFO - 'tsvg_static']}, 17:38:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:38:08 INFO - 'talos_options': ['--disable-e10s'], 17:38:08 INFO - 'tests': ['tp5o']}, 17:38:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:38:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:38:08 INFO - 'talos_options': ['--disable-e10s', 17:38:08 INFO - '--xperf_path', 17:38:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:38:08 INFO - 'tests': ['tp5n']}, 17:38:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:38:08 INFO - 'talos_options': ['--xperf_path', 17:38:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:38:08 INFO - 'tests': ['tp5n']}}, 17:38:08 INFO - 'talos.zip': {'path': '', 17:38:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:38:08 INFO - Running post-action listener: _resource_record_post_action 17:38:08 INFO - [mozharness: 2016-12-17 01:38:08.658883Z] Finished populate-webroot step (success) 17:38:08 INFO - [mozharness: 2016-12-17 01:38:08.658991Z] Running create-virtualenv step. 17:38:08 INFO - Running pre-action listener: _resource_record_pre_action 17:38:08 INFO - Running main action method: create_virtualenv 17:38:08 INFO - Creating virtualenv /builds/slave/test/build/venv 17:38:08 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:38:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:38:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:38:08 INFO - Using real prefix '/tools/python27' 17:38:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:38:09 INFO - Installing distribute.............................................................................................................................................................................................done. 17:38:12 INFO - Installing pip.................done. 17:38:12 INFO - Return code: 0 17:38:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:38:12 INFO - Reading from file tmpfile_stdout 17:38:12 INFO - Output received: 17:38:12 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:38:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108edb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e51570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb25546f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cf0d30>, '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 0x108b57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ce8b20>, '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.wrKZObUc10/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.KM6c3gMWlQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:38:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:38:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrKZObUc10/Render', 17:38:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:12 INFO - 'HOME': '/Users/cltbld', 17:38:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:12 INFO - 'LOGNAME': 'cltbld', 17:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:12 INFO - 'MOZ_NO_REMOTE': '1', 17:38:12 INFO - 'NO_EM_RESTART': '1', 17:38:12 INFO - 'PAGER': '/bin/cat', 17:38:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:12 INFO - 'PWD': '/builds/slave/test', 17:38:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:12 INFO - 'SHELL': '/bin/bash', 17:38:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM6c3gMWlQ/Listeners', 17:38:12 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 17:38:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:12 INFO - 'USER': 'cltbld', 17:38:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:12 INFO - 'XPC_FLAGS': '0x0', 17:38:12 INFO - 'XPC_SERVICE_NAME': '0', 17:38:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:12 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:38:12 INFO - Cleaning up... 17:38:12 INFO - Return code: 0 17:38:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108edb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e51570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb25546f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cf0d30>, '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 0x108b57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ce8b20>, '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.wrKZObUc10/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.KM6c3gMWlQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:38:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:38:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrKZObUc10/Render', 17:38:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:12 INFO - 'HOME': '/Users/cltbld', 17:38:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:12 INFO - 'LOGNAME': 'cltbld', 17:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:12 INFO - 'MOZ_NO_REMOTE': '1', 17:38:12 INFO - 'NO_EM_RESTART': '1', 17:38:12 INFO - 'PAGER': '/bin/cat', 17:38:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:12 INFO - 'PWD': '/builds/slave/test', 17:38:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:12 INFO - 'SHELL': '/bin/bash', 17:38:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM6c3gMWlQ/Listeners', 17:38:12 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 17:38:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:12 INFO - 'USER': 'cltbld', 17:38:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:12 INFO - 'XPC_FLAGS': '0x0', 17:38:12 INFO - 'XPC_SERVICE_NAME': '0', 17:38:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:13 INFO - Downloading/unpacking psutil>=3.1.1 17:38:13 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:38:13 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:38:13 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:38:13 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:38:13 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:38:13 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:38:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:38:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:38:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:38:16 INFO - Installing collected packages: psutil 17:38:16 INFO - Running setup.py install for psutil 17:38:16 INFO - building 'psutil._psutil_osx' extension 17:38:16 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:38:16 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:38:16 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:38:17 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:38:17 INFO - building 'psutil._psutil_posix' extension 17:38:17 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:38:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:38:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:38:17 INFO - ^ 17:38:17 INFO - 1 warning generated. 17:38:17 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:38:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:38:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:38:17 INFO - Successfully installed psutil 17:38:17 INFO - Cleaning up... 17:38:17 INFO - Return code: 0 17:38:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:38:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:17 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 0x108edb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e51570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb25546f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cf0d30>, '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 0x108b57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ce8b20>, '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.wrKZObUc10/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.KM6c3gMWlQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:38:17 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:38:17 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:38:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrKZObUc10/Render', 17:38:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:17 INFO - 'HOME': '/Users/cltbld', 17:38:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:17 INFO - 'LOGNAME': 'cltbld', 17:38:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:17 INFO - 'MOZ_NO_REMOTE': '1', 17:38:17 INFO - 'NO_EM_RESTART': '1', 17:38:17 INFO - 'PAGER': '/bin/cat', 17:38:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:17 INFO - 'PWD': '/builds/slave/test', 17:38:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:17 INFO - 'SHELL': '/bin/bash', 17:38:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM6c3gMWlQ/Listeners', 17:38:17 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 17:38:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:17 INFO - 'USER': 'cltbld', 17:38:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:17 INFO - 'XPC_FLAGS': '0x0', 17:38:17 INFO - 'XPC_SERVICE_NAME': '0', 17:38:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:38: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:38: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:38: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:38: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:38: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:38: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:38:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:38:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:38:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:38:20 INFO - Installing collected packages: mozsystemmonitor 17:38:20 INFO - Running setup.py install for mozsystemmonitor 17:38:20 INFO - Successfully installed mozsystemmonitor 17:38:20 INFO - Cleaning up... 17:38:20 INFO - Return code: 0 17:38:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:38:20 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:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:20 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:38:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:21 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 0x108edb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e51570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb25546f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cf0d30>, '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 0x108b57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ce8b20>, '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.wrKZObUc10/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.KM6c3gMWlQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:38:21 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:38:21 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:38:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrKZObUc10/Render', 17:38:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:21 INFO - 'HOME': '/Users/cltbld', 17:38:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:21 INFO - 'LOGNAME': 'cltbld', 17:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:21 INFO - 'MOZ_NO_REMOTE': '1', 17:38:21 INFO - 'NO_EM_RESTART': '1', 17:38:21 INFO - 'PAGER': '/bin/cat', 17:38:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:21 INFO - 'PWD': '/builds/slave/test', 17:38:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:21 INFO - 'SHELL': '/bin/bash', 17:38:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM6c3gMWlQ/Listeners', 17:38:21 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 17:38:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:21 INFO - 'USER': 'cltbld', 17:38:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:21 INFO - 'XPC_FLAGS': '0x0', 17:38:21 INFO - 'XPC_SERVICE_NAME': '0', 17:38:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:21 INFO - Downloading/unpacking jsonschema==2.5.1 17:38:21 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:38:21 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:38:21 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:38:21 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:38:21 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:38:21 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:38:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:38:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:38:24 INFO - Downloading functools32-3.2.3-2.tar.gz 17:38:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:38:25 INFO - warning: no files found matching '*.txt' 17:38:25 INFO - no previously-included directories found matching 'build' 17:38:25 INFO - no previously-included directories found matching 'dist' 17:38:25 INFO - no previously-included directories found matching '.git*' 17:38:25 INFO - Installing collected packages: jsonschema, functools32 17:38:25 INFO - Running setup.py install for functools32 17:38:25 INFO - warning: no files found matching '*.txt' 17:38:25 INFO - no previously-included directories found matching 'build' 17:38:25 INFO - no previously-included directories found matching 'dist' 17:38:25 INFO - no previously-included directories found matching '.git*' 17:38:25 INFO - Successfully installed jsonschema functools32 17:38:25 INFO - Cleaning up... 17:38:25 INFO - Return code: 0 17:38:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:38:25 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:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:25 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:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:25 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 0x108edb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e51570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb25546f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cf0d30>, '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 0x108b57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ce8b20>, '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.wrKZObUc10/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.KM6c3gMWlQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:38:25 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:38:25 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:38:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrKZObUc10/Render', 17:38:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:25 INFO - 'HOME': '/Users/cltbld', 17:38:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:25 INFO - 'LOGNAME': 'cltbld', 17:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:25 INFO - 'MOZ_NO_REMOTE': '1', 17:38:25 INFO - 'NO_EM_RESTART': '1', 17:38:25 INFO - 'PAGER': '/bin/cat', 17:38:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:25 INFO - 'PWD': '/builds/slave/test', 17:38:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:25 INFO - 'SHELL': '/bin/bash', 17:38:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM6c3gMWlQ/Listeners', 17:38:25 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 17:38:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:25 INFO - 'USER': 'cltbld', 17:38:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:25 INFO - 'XPC_FLAGS': '0x0', 17:38:25 INFO - 'XPC_SERVICE_NAME': '0', 17:38:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:38:25 INFO - Cleaning up... 17:38:25 INFO - Return code: 0 17:38:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:38:25 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:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:25 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:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:25 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 0x108edb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e51570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb25546f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cf0d30>, '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 0x108b57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ce8b20>, '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.wrKZObUc10/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.KM6c3gMWlQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:38:25 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:38:25 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:38:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrKZObUc10/Render', 17:38:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:25 INFO - 'HOME': '/Users/cltbld', 17:38:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:25 INFO - 'LOGNAME': 'cltbld', 17:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:25 INFO - 'MOZ_NO_REMOTE': '1', 17:38:25 INFO - 'NO_EM_RESTART': '1', 17:38:25 INFO - 'PAGER': '/bin/cat', 17:38:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:25 INFO - 'PWD': '/builds/slave/test', 17:38:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:25 INFO - 'SHELL': '/bin/bash', 17:38:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM6c3gMWlQ/Listeners', 17:38:25 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 17:38:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:25 INFO - 'USER': 'cltbld', 17:38:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:25 INFO - 'XPC_FLAGS': '0x0', 17:38:25 INFO - 'XPC_SERVICE_NAME': '0', 17:38:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:25 INFO - Downloading/unpacking blobuploader==1.2.4 17:38: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:38: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:38: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:38: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:38: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:38: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:38:28 INFO - Downloading blobuploader-1.2.4.tar.gz 17:38:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:38:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:38:28 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:38:28 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:38:28 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:38:28 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:38:28 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:38:28 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:38:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:38:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:38:29 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:38:29 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:38:29 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:38:29 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:38:29 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:38:29 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:38:29 INFO - Downloading docopt-0.6.1.tar.gz 17:38:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:38:29 INFO - Installing collected packages: blobuploader, requests, docopt 17:38:29 INFO - Running setup.py install for blobuploader 17:38:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:38:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:38:29 INFO - Running setup.py install for requests 17:38:30 INFO - Running setup.py install for docopt 17:38:30 INFO - Successfully installed blobuploader requests docopt 17:38:30 INFO - Cleaning up... 17:38:30 INFO - Return code: 0 17:38:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:38:30 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:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:30 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:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:30 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 0x108edb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e51570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb25546f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cf0d30>, '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 0x108b57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ce8b20>, '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.wrKZObUc10/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.KM6c3gMWlQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:38:30 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:38:30 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:38:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrKZObUc10/Render', 17:38:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:30 INFO - 'HOME': '/Users/cltbld', 17:38:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:30 INFO - 'LOGNAME': 'cltbld', 17:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:30 INFO - 'MOZ_NO_REMOTE': '1', 17:38:30 INFO - 'NO_EM_RESTART': '1', 17:38:30 INFO - 'PAGER': '/bin/cat', 17:38:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:30 INFO - 'PWD': '/builds/slave/test', 17:38:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:30 INFO - 'SHELL': '/bin/bash', 17:38:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM6c3gMWlQ/Listeners', 17:38:30 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 17:38:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:30 INFO - 'USER': 'cltbld', 17:38:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:30 INFO - 'XPC_FLAGS': '0x0', 17:38:30 INFO - 'XPC_SERVICE_NAME': '0', 17:38:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:38:30 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-mhXph_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:38:30 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-pVhCHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:38:31 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-3wZSd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:38:31 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-GXeiFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:38:31 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-GYRwd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:38:31 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-y3EynV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:38:31 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-WLlHvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:38:31 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-hfTBvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:38:31 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-4DqtRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:38:31 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-ybxjwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:38:31 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-5YqyrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:38:32 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-zO8B3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:38:32 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-H_DM0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:38:32 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-kcCgx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:32 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-_ibgXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:38:32 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-veMoPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:38:32 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-ct8bTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:38:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:38:32 INFO - Running setup.py install for manifestparser 17:38:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:38:32 INFO - Running setup.py install for mozcrash 17:38:32 INFO - Running setup.py install for mozdebug 17:38:33 INFO - Running setup.py install for mozdevice 17:38:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:38:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:38:33 INFO - Running setup.py install for mozfile 17:38:33 INFO - Running setup.py install for mozhttpd 17:38:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:38:33 INFO - Running setup.py install for mozinfo 17:38:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:38:33 INFO - Running setup.py install for mozInstall 17:38:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:38:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:38:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:38:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:38:33 INFO - Running setup.py install for mozleak 17:38:33 INFO - Running setup.py install for mozlog 17:38:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:38:34 INFO - Running setup.py install for moznetwork 17:38:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:38:34 INFO - Running setup.py install for mozprocess 17:38:34 INFO - Running setup.py install for mozprofile 17:38:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:38:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:38:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:38:34 INFO - Running setup.py install for mozrunner 17:38:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:38:34 INFO - Running setup.py install for mozscreenshot 17:38:34 INFO - Running setup.py install for moztest 17:38:35 INFO - Running setup.py install for mozversion 17:38:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:38:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:38:35 INFO - Cleaning up... 17:38:35 INFO - Return code: 0 17:38:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:38:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:35 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 0x108edb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e51570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb25546f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cf0d30>, '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 0x108b57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ce8b20>, '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.wrKZObUc10/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.KM6c3gMWlQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:38:35 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:38:35 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:38:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrKZObUc10/Render', 17:38:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:35 INFO - 'HOME': '/Users/cltbld', 17:38:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:35 INFO - 'LOGNAME': 'cltbld', 17:38:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:35 INFO - 'MOZ_NO_REMOTE': '1', 17:38:35 INFO - 'NO_EM_RESTART': '1', 17:38:35 INFO - 'PAGER': '/bin/cat', 17:38:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:35 INFO - 'PWD': '/builds/slave/test', 17:38:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:35 INFO - 'SHELL': '/bin/bash', 17:38:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM6c3gMWlQ/Listeners', 17:38:35 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 17:38:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:35 INFO - 'USER': 'cltbld', 17:38:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:35 INFO - 'XPC_FLAGS': '0x0', 17:38:35 INFO - 'XPC_SERVICE_NAME': '0', 17:38:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:38:35 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-KUioZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:38:35 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:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:38:35 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-Mf0FBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:38:35 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:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:38:35 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-gfVJha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:38:35 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:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:38:35 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-oRt5UR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:38:35 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:38:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:38:35 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-ASZZjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:38:36 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:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:38:36 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-ei1qKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:38:36 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:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:38:36 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-4c_Yhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:38:36 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:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:38:36 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-mhZCeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:38:36 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:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:38:36 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-EVf5Wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:38:36 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:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:38:36 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-9dfm3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:38:36 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:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:38:36 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-zQ9B_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:38:36 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:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:38:36 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-ZwIhkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:38:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:38:36 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-Bggrjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:38:36 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:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:38:36 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-HB6_UV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:38:36 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:38:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:36 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-bovcl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:38:37 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:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:38:37 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-EBROJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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:38:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:38:37 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-wpUysi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:38:37 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:38:37 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:38:37 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:38:37 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:38:37 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:38:37 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:38:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:38:37 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:38:37 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:38:37 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:38:37 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:38:37 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:38:37 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:38:39 INFO - Downloading blessings-1.6.tar.gz 17:38:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:38:39 INFO - Installing collected packages: blessings 17:38:39 INFO - Running setup.py install for blessings 17:38:40 INFO - Successfully installed blessings 17:38:40 INFO - Cleaning up... 17:38:40 INFO - Return code: 0 17:38:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:38:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:38:40 INFO - Reading from file tmpfile_stdout 17:38:40 INFO - Current package versions: 17:38:40 INFO - blessings == 1.6 17:38:40 INFO - blobuploader == 1.2.4 17:38:40 INFO - docopt == 0.6.1 17:38:40 INFO - functools32 == 3.2.3-2 17:38:40 INFO - jsonschema == 2.5.1 17:38:40 INFO - manifestparser == 1.1 17:38:40 INFO - mozInstall == 1.12 17:38:40 INFO - mozcrash == 1.0 17:38:40 INFO - mozdebug == 0.1 17:38:40 INFO - mozdevice == 0.49 17:38:40 INFO - mozfile == 1.2 17:38:40 INFO - mozhttpd == 0.7 17:38:40 INFO - mozinfo == 0.9 17:38:40 INFO - mozleak == 0.1 17:38:40 INFO - mozlog == 3.4 17:38:40 INFO - moznetwork == 0.27 17:38:40 INFO - mozprocess == 0.23 17:38:40 INFO - mozprofile == 0.28 17:38:40 INFO - mozrunner == 6.13 17:38:40 INFO - mozscreenshot == 0.1 17:38:40 INFO - mozsystemmonitor == 0.3 17:38:40 INFO - moztest == 0.7 17:38:40 INFO - mozversion == 1.4 17:38:40 INFO - psutil == 3.1.1 17:38:40 INFO - requests == 1.2.3 17:38:40 INFO - wsgiref == 0.1.2 17:38:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:40 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 0x108edb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e51570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb25546f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cf0d30>, '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 0x108b57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ce8b20>, '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.wrKZObUc10/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.KM6c3gMWlQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:38:40 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:38:40 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:38:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrKZObUc10/Render', 17:38:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:40 INFO - 'HOME': '/Users/cltbld', 17:38:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:40 INFO - 'LOGNAME': 'cltbld', 17:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:40 INFO - 'MOZ_NO_REMOTE': '1', 17:38:40 INFO - 'NO_EM_RESTART': '1', 17:38:40 INFO - 'PAGER': '/bin/cat', 17:38:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:40 INFO - 'PWD': '/builds/slave/test', 17:38:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:40 INFO - 'SHELL': '/bin/bash', 17:38:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM6c3gMWlQ/Listeners', 17:38:40 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 17:38:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:40 INFO - 'USER': 'cltbld', 17:38:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:40 INFO - 'XPC_FLAGS': '0x0', 17:38:40 INFO - 'XPC_SERVICE_NAME': '0', 17:38:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:40 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:38:40 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:38:40 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:38:40 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:38:40 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:38:40 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:38:40 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:38:40 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:38:40 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:38:40 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:38:40 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:38:40 INFO - Cleaning up... 17:38:40 INFO - Return code: 0 17:38:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:38:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108edb3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e51570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cb25546f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cf0d30>, '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 0x108b57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ce8b20>, '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.wrKZObUc10/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.KM6c3gMWlQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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:38:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:38:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrKZObUc10/Render', 17:38:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:38:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:38:40 INFO - 'HOME': '/Users/cltbld', 17:38:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:38:40 INFO - 'LOGNAME': 'cltbld', 17:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:38:40 INFO - 'MOZ_NO_REMOTE': '1', 17:38:40 INFO - 'NO_EM_RESTART': '1', 17:38:40 INFO - 'PAGER': '/bin/cat', 17:38:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:38:40 INFO - 'PWD': '/builds/slave/test', 17:38:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:38:40 INFO - 'SHELL': '/bin/bash', 17:38:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM6c3gMWlQ/Listeners', 17:38:40 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 17:38:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:38:40 INFO - 'USER': 'cltbld', 17:38:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:38:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:38:40 INFO - 'XPC_FLAGS': '0x0', 17:38:40 INFO - 'XPC_SERVICE_NAME': '0', 17:38:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:38:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:38:40 INFO - Cleaning up... 17:38:40 INFO - Return code: 0 17:38:40 INFO - Running post-action listener: _resource_record_post_action 17:38:40 INFO - Running post-action listener: _start_resource_monitoring 17:38:41 INFO - Starting resource monitoring. 17:38:41 INFO - [mozharness: 2016-12-17 01:38:41.019212Z] Finished create-virtualenv step (success) 17:38:41 INFO - [mozharness: 2016-12-17 01:38:41.020183Z] Running install step. 17:38:41 INFO - Running pre-action listener: _resource_record_pre_action 17:38:41 INFO - Running main action method: install 17:38:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:38:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:38:41 INFO - Reading from file tmpfile_stdout 17:38:41 INFO - Detecting whether we're running mozinstall >=1.0... 17:38:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:38:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:38:41 INFO - Reading from file tmpfile_stdout 17:38:41 INFO - Output received: 17:38:41 INFO - Usage: mozinstall [options] installer 17:38:41 INFO - Options: 17:38:41 INFO - -h, --help show this help message and exit 17:38:41 INFO - -d DEST, --destination=DEST 17:38:41 INFO - Directory to install application into. [default: 17:38:41 INFO - "/builds/slave/test"] 17:38:41 INFO - --app=APP Application being installed. [default: firefox] 17:38:41 INFO - mkdir: /builds/slave/test/build/application 17:38:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:38:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:39:03 INFO - Reading from file tmpfile_stdout 17:39:03 INFO - Output received: 17:39:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:39:03 INFO - Running post-action listener: _resource_record_post_action 17:39:03 INFO - [mozharness: 2016-12-17 01:39:03.252845Z] Finished install step (success) 17:39:03 INFO - [mozharness: 2016-12-17 01:39:03.252975Z] Running run-tests step. 17:39:03 INFO - Running pre-action listener: _resource_record_pre_action 17:39:03 INFO - Running main action method: run_tests 17:39:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:39:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:39:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:39:03 INFO - 2016-12-16 17:39:03.267 screenresolution[1984:20015] starting screenresolution argv=screenresolution get 17:39:03 INFO - 2016-12-16 17:39:03.270 screenresolution[1984:20015] Display 0: 1600x1200x32@60 17:39:03 INFO - 2016-12-16 17:39:03.275 screenresolution[1985:20018] starting screenresolution argv=screenresolution list 17:39:03 INFO - Available Modes on Display 0 17:39:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:39:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:39:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:39:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:39:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:39:03 INFO - Intel Iris: 17:39:03 INFO - Chipset Model: Intel Iris 17:39:03 INFO - Type: GPU 17:39:03 INFO - Bus: Built-In 17:39:03 INFO - VRAM (Dynamic, Max): 1536 MB 17:39:03 INFO - Vendor: Intel (0x8086) 17:39:03 INFO - Device ID: 0x0a2e 17:39:03 INFO - Revision ID: 0x0009 17:39:03 INFO - Displays: 17:39:03 INFO - Display: 17:39:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:39:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:39:03 INFO - Display Serial Number: 1600x1200 60 17:39:03 INFO - Main Display: Yes 17:39:03 INFO - Mirror: Off 17:39:03 INFO - Online: Yes 17:39:03 INFO - Rotation: Supported 17:39:03 INFO - Return code: 0 17:39:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:39:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:39:03 INFO - Python 2.7.3 17:39:03 INFO - Return code: 0 17:39:03 INFO - grabbing minidump binary from tooltool 17:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:39:03 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 0x108cf0d30>, '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 0x108b57db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ce8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:39:03 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:39:03 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:39:03 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:39:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:39:03 INFO - Return code: 0 17:39:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:39:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:39:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:39:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:39:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:39:03 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/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0185', '--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:39:03 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/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0185 --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:39:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrKZObUc10/Render', 17:39:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:39:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:39:03 INFO - 'HOME': '/Users/cltbld', 17:39:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:39:03 INFO - 'LOGNAME': 'cltbld', 17:39:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:39:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:03 INFO - 'MOZ_NO_REMOTE': '1', 17:39:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:39:03 INFO - 'NO_EM_RESTART': '1', 17:39:03 INFO - 'PAGER': '/bin/cat', 17:39:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:03 INFO - 'PWD': '/builds/slave/test', 17:39:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:39:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:39:03 INFO - 'SHELL': '/bin/bash', 17:39:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KM6c3gMWlQ/Listeners', 17:39:03 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 17:39:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:39:03 INFO - 'USER': 'cltbld', 17:39:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:39:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:03 INFO - 'XPC_FLAGS': '0x0', 17:39:03 INFO - 'XPC_SERVICE_NAME': '0', 17:39:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:39:03 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/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0185', '--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:39:03 INFO - mozversion application_buildid: 20161216161549 17:39:03 INFO - mozversion application_changeset: 74f4edb0d09dbb7809eadaff9d321d61203bbaf1 17:39:03 INFO - mozversion application_display_name: Nightly 17:39:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:39:03 INFO - mozversion application_name: Firefox 17:39:03 INFO - mozversion application_remotingname: firefox 17:39:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:39:03 INFO - mozversion application_vendor: Mozilla 17:39:03 INFO - mozversion application_version: 53.0a1 17:39:03 INFO - mozversion platform_buildid: 20161216161549 17:39:03 INFO - mozversion platform_changeset: 74f4edb0d09dbb7809eadaff9d321d61203bbaf1 17:39:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:39:03 INFO - mozversion platform_version: 53.0a1 17:39:03 INFO - using testdate: 1481938743 17:39:03 INFO - actual date: 1481938743 17:39:03 INFO - starting webserver on 'localhost:49294' 17:39:03 INFO - SUITE-START | Running 2 tests 17:39:03 INFO - TEST-START | dromaeo_css 17:39:03 INFO - operating with platform_type : mac_ 17:39:03 INFO - Initialising browser for dromaeo_css test... 17:39:03 INFO - TEST-INFO | started process 1995 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpoUE_so/profile http://localhost:49294/getInfo.html) 17:39:06 INFO - PROCESS | 1995 | __metrics Screen width/height:1600/1200 17:39:06 INFO - PROCESS | 1995 | colorDepth:24 17:39:06 INFO - PROCESS | 1995 | Browser inner width/height: 1024/689 17:39:06 INFO - PROCESS | 1995 | __metrics 17:39:06 INFO - PROCESS | 1995 | 2016-12-16 17:39:06.816 plugin-container[1998:20190] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f3f, name = 'com.apple.tsm.portname' 17:39:06 INFO - PROCESS | 1995 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:39:06 INFO - PROCESS | 1995 | 2016-12-16 17:39:06.822 plugin-container[1998:20190] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9503, name = 'com.apple.CFPasteboardClient' 17:39:06 INFO - PROCESS | 1995 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:39:06 INFO - PROCESS | 1995 | 2016-12-16 17:39:06.822 plugin-container[1998:20190] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:39:06 ERROR - PROCESS | 1995 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3232: TypeError: this.tabs is undefined 17:39:07 INFO - TEST-INFO | 1995: exit 0 17:39:07 INFO - Browser initialized. 17:39:07 INFO - Running cycle 1/1 for dromaeo_css test... 17:39:07 INFO - TEST-INFO | started process 1999 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpoUE_so/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:39:10 INFO - PROCESS | 1999 | 2016-12-16 17:39:10.060 plugin-container[2000:20312] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 17:39:10 INFO - PROCESS | 1999 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:39:10 INFO - PROCESS | 1999 | 2016-12-16 17:39:10.060 plugin-container[2000:20312] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 17:39:10 INFO - PROCESS | 1999 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:39:10 INFO - PROCESS | 1999 | 2016-12-16 17:39:10.061 plugin-container[2000:20312] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:39:19 INFO - PROCESS | 1999 | RSS: Main: 237064192 17:39:19 INFO - PROCESS | 1999 | 17:40:09 INFO - PROCESS | 1999 | 1481938809310 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:42:22 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:49294/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49294/tests/dromaeo/cssquery-ext.html) 17:42:24 INFO - PROCESS | 1999 | RSS: Main: 252264448 17:42:24 INFO - PROCESS | 1999 | 17:45:26 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:49294/tests/dromaeo/cssquery-ext.html (next: http://localhost:49294/tests/dromaeo/cssquery-jquery.html) 17:45:27 INFO - PROCESS | 1999 | RSS: Main: 263921664 17:45:27 INFO - PROCESS | 1999 | 17:48:29 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:49294/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49294/tests/dromaeo/cssquery-mootools.html) 17:48:29 INFO - PROCESS | 1999 | RSS: Main: 269983744 17:48:29 INFO - PROCESS | 1999 | 17:51:31 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:49294/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49294/tests/dromaeo/cssquery-prototype.html) 17:51:32 INFO - PROCESS | 1999 | RSS: Main: 268611584 17:51:32 INFO - PROCESS | 1999 | 17:54:35 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:49294/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49294/tests/dromaeo/cssquery-yui.html) 17:54:36 INFO - PROCESS | 1999 | RSS: Main: 273260544 17:54:36 INFO - PROCESS | 1999 | 17:57:38 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:49294/tests/dromaeo/cssquery-yui.html (next: http://localhost:49294/tests/dromaeo/cssquery-dojo.html) 17:57:39 INFO - PROCESS | 1999 | RSS: Main: 276082688 17:57:39 INFO - PROCESS | 1999 | 17:57:39 INFO - PROCESS | 1999 | __start_tp_report 17:57:39 INFO - PROCESS | 1999 | _x_x_mozilla_page_load 17:57:39 INFO - PROCESS | 1999 | _x_x_mozilla_page_load_details 17:57:39 INFO - PROCESS | 1999 | |i|pagename|runs| 17:57:39 INFO - PROCESS | 1999 | |0;dojo.html;3369.1240277527836;3373.207296285373;3396.1000334911237;3399;3410.1986033282174;5564.86087847804;5752.654840709555;5781.392953739854;5836.270466191726;5846.619969701972;5653.236813030239;5788.27646544182;5877.617954832933;5884.293884733827;5923.200367950325;5197.922031169526;5236.293100431431;5288.968651113035;5317.7607007684555;5374.838754837341;5121.052605268019;5231.189165679326;5331.440198779131;5353.946460535384;5401.162819762943;5087.516685914832;5112.565431938289;5291.312129423189;5316.521513063843;5316.9202461963105;4174.394712766662;5151.124308867464;5160.870978225575;5204.375474943031;5231.163013917793;5193.324867767204;5195.818146364859;5244.239585260116;5259.0796610593;5260.736963151865;5716.228309178249;5766.336871259775;5855.560832937546;5879.147523609053;5896.469317761379;5853.619514731571;5925.4963328117165;5949.583529152961;6244.718987645521;6247.187865577446;6106.48094911933;6197.349278325756;6212.534059945477;6240.687965601747;6309.0536419536975;5929.822105336761;5935.436133567304;5936.228290322274;5941.405859414024;5974.551908606828;6185.257769067651;6309.968450157719;6380.680965951684;6381.074744162071;6385.6487893165395;5965.910511342333;6056.878862422727;6060.606060606046;6072.483838873657;6079.756809727562;6151.96924015377;6189.690515474298;6197.628142311476;6219.284782250009;6235.875282494325;6195.008798592204;6212.502999760009;6259.061140828912;6267.717952692049;6298.118263443122;6226.844328891723;6303.212098487689;6304.653244071528;6321.1782468278825;6322.241331040304;4787.186178349689;4817.421909370828;4821.083994041121;4825.469198388175;4963.5780958618925;3611.5846677631885;3667.9266414672093;4335.393044973706;4465.508794032654;4516.345129956138;5168.405633352138;5223.895522089613;5598.10430331145;5908.881822363529;5951.077582974646;6119.502553941423;6203.689815509297;6261.467775239064;6268.4671802896355;6268.905966410507;4808.927866082012;5668.688222147739;5773.451522105393;5785.913211301834;5816.505597024216;5461.0716178249795;5475.67145971243;5487.314085739283;5493.615446918758;5499.395066542677;6368.713407896563;6375.776847810304;6384.744610215539;6388;6416.422521973045;6126.456603435028;6137.96931015342;6170.50635949132;6236.656983865931;6266.809306231801;6250.749970001331;6253.093301471352;6258.061290806416;6285.277193122849;6342.936570634234;6051.576389652682;6092.512598991982;6163.445289923929;6234.875302494015;6242.250929888442;6184.257889053162;6209.813705588839;6250.749970001149;6277.089821975879;6304.590201636879;5934.19888315072;6008.188894499187;6206.751729930752;6240.282367527792;6250.406211409909;6073.514118870391;6075.726592303446;6081.574289799849;6091.390860913873;6135.987562052212;5217.373915130209;6006.87986240264;6045.455908968214;6101.82280290701;6104.519788040188;6167.105769663463;6191.133241346125;6198.907016394848;6202.317745048132;6238.313785483684;5754.5684073695475;6008.03871380577;6065;6065.120557519223;6088.452039316483 17:57:39 INFO - PROCESS | 1999 | |1;ext.html;441.0759458933535;460.83870645274146;489.81387072912287;515.4793658405011;543.630331374665;35713.64286357136;39945.60054399455;40241.99395015126;40244.39633405501;40253.7987310063;40546.59453405465;40710.59289407105;40979.38530922031;41065;41165.17669646605;8370.204830541088;8721;9340.766480837965;9547.474888881108;9561.139497445229;11200.439978001108;11488.712782180428;11548.133889958244;11671.299722016705;11685.123615728811;11435.599754008612;11455.770884582304;11493.425328733572;11517.712057198596;11517.942410287937;11293.265937714023;11407.54369825206;11420.314781113118;11443.656690299304;11455.31268123907;11294.040006599449;11347.26242794224;11365.829512557319;11383.03244224242;11385.316880987168;38745.41881871774;38778.80610596957;38975.805120974495;39026.60973390258;39055.60944390548;3301.6863397977154;3444.50054742061;3447.77589456687;3501.842417091237;3936.9015774605577;29308;29765.107046788413;29955.850220748976;30052.54921176184;30330.84834575813;2756.710545392745;2850.330172409482;3171.540126681641;3193;3267.134209434502;339883;447988;452342;452362;454621.7268913667;52158.21762673487;52423.47576524262;52454.213186802226;52659.73670131625;56377.154342684895;57616.42383576195;57849.71075144597;57932;58006.129908051415;58103.70948145232;15184.620384490476;15612;15654.530364088867;15656.4520241791;15676.764848527282;11169.218154729253;11422.485988130555;12036.759264814655;12247.877521224673;12346.81479777804;14439.917006224576;14472.927635361966;14482.565523034325;14615.488457903923;14652.706945861022;6323.336049714806;7201.675924583406;7315.085614298213;7375.704971801175;7394.926050739424;823.3289868756943;934.5327336331834;950.2398081534744;1028.840529717895;1113.0383071510018;28130.578041329398;29398.41203175967;29645.851770741006;29891.103266902028;30137.69862301349;975.2393133355994;1044.3316277582353;1058.6339531147878;1066.2855886556026;1082.783443311325;13458.461661533429;14926;15476.535703928901;15485.612859678598;15593.376264949275;525249;556080;615145;616644;619362;57020;57376;57536.71231643815;57583.424165758646;57663.423365765804;1331.3542931678128;1365.487942021742;1392.8955328350414;1394.5955672854961;1397.4340392140996;28602.14193574196;29631.407371852874;29650.703492964793;30081.69918300789;30099.699003010566;39388.212235755695;44315.77842110769;48176.75911620419;48666.78333041702;48779;563440;565333;566283;567263;568182;23809.9285532148;24466.755332446446;24477.87761061183;38661.80669096637;38977.80511097427;40473.39289910595;41114.38328425136;41653;42089;42121.78939105407;28160.71839281663;34588.48117278293;34645;34814.65185348114;35533.289334212655;34378.312433751686;34489.65510344865;35173.12067198238;35362.823185883906;35694;33629.83185084059;33949.83025084859;34020.829895851355;34280.485792713625;34472.31055378828;31034.379312414076;31136.22159446032;31181.72591877911;31222.531662025543;31254;23471.530569388175;23670.52658946846;23862.403439914142;24129.276121716375;24285.271441856774 17:57:39 INFO - PROCESS | 1999 | |2;jquery.html;298.36448364982584;300.58369158715175;367.04751170712;367.9448082787582;391.23318296139564;18866.962317072557;19896.005199740008;20330.89834550827;20541.897290513563;20552.897235513803;11663.475143618536;16310.102944338058;18565.443036708886;19178.23287068519;19350.032498375094;4365.9563404365945;5338.893222135555;5352.732363381835;5354.437784032679;5360.115580929161;5249.947500525003;5331.333583302087;5468.56251499881;5760.452756988079;5806.303243610772;5808.3030036395485;5810.506106980912;5819.738111784959;5820.941790582104;5830.183774271605;5786.71066446676;5842.5910186286765;6000.129981152731;6005.519558435359;6058.787942421994;5593.496585307301;5854.590178687494;5858.2677165354335;5876.353601103875;5881.206037184968;12749;12974.962003039735;13083.280419576919;13087.934560327138;13091.607251782461;1987.6620974434381;2078.272604588397;2140.422086036777;2154.590627780732;2259.7853203945597;9713.36863103896;9851.261155413373;10042.748931276703;10248.74378140545;10250.179985601135;1542.6991736611365;1858.2659849359563;1895.9336423225259;1906.5996140810446;1912.8660993730443;108366;114993.42503287431;125050.74949250482;126339.10491342637;128472;9178.31162662803;9991.200703943667;11376.658700239006;11439.199256051996;11573.710657233469;14335.56993290203;14342.426302947973;14349.928250358682;14361.856381436051;14385.92807035979;7510.1363343215135;8091.919080809234;8204.825721183892;8333;8453.66185352579;8160.918390816135;8196.631151598192;8240.587970601446;8326.292265157408;8345.374096942754;4317.740935543878;4495.775211239425;4535.954640453553;4556.498785133633;4605.125026245069;1926.2776458827939;1956.31984181672;1981.5739615982634;2003.7094621279832;2004.2584243829585;823.818759872839;885.1677028550966;930.9162175404247;960.4477425480377;963.9252233759308;19451.51371215731;20120.798792012185;20208.29270975509;20269;20446.284380046625;924.2421214604094;935.2658163341744;962.2302158273493;967.9032096790264;986.9309148359689;10382.377057376581;10754.784904302027;10759.3544387337;10773.83839242412;10786.514606842555;440536;467585.66207168746;469171;509259;512154;78190.60904695553;103595;132316;134827.325863372;134993;893.6380765789866;1002.8867956568204;1035.963741269052;1043.8569766106102;1044.185535282481;17427.47717568475;18440.631187375908;18571.44285671432;18699.06504674788;18784;49914.00171996612;52506.73746631242;52524.474755251955;53500.4649953511;54240;65345.346546533925;77279;77629.22370776445;77983.2201677976;79980;6035.969820150871;7236.782896512902;7386.335229829341;7856.332211762065;8403.95798021006;12388.938055309665;12637;12988.155769874928;13228.801567976296;13259.812130998278;10666.040056394962;10757.031867131996;11129.610463633733;11307.717307067389;11397.202195846543;9877.567752675677;10017.69946901594;10575.259731818698;10873.673789786319;11118.221724479208;11224.38265895351;11254.21220514556;11543.595974140864;11620.012298954684;11733.120015998664;7207.459440541876;7336.7798966031105;7434.36807871337;7436.814079648052;7465.738699145504;10943;11184.552617895193;11274.162634401919;11325.433728313716;11331.773364532828 17:57:39 INFO - PROCESS | 1999 | |3;mootools.html;1360.224671936996;1511.9622009449765;1670.2734310574901;1776.3516316544465;1817.4638481647912;7381.483296169257;7593.468457207998;7862.685492580297;8292.792680182998;8300.460470069449;7789.6494657740395;8070.596470176482;8086.150954149818;8133.552654603995;8161.2246836550585;1809.9004554749483;1830.4508647405792;2024.1903238704563;2179.4769255378674;2216.1910902520626;1880.5956719305348;2029.7564292284947;2285.9657105143438;2307.7807608277185;2313.063209400187;2228.1533017453426;2236.9888150559304;2255.8984845681985;2269.8751568663715;2270.409693479699;1851.9722204166949;1898.933537326187;2238.731352237726;2271.931842044741;2275.7041584594062;2254.6472116729997;2266.5693518231647;2291.3126062181277;2301.0795681727277;2306.411864974421;8119.106898241189;8145.348372130275;8177.018757749108;8186.181381861826;8192.098869124391;4929.605631549467;4994.150994330972;5034.11902916988;5064.848054558369;5082.23766435034;3238.724708399789;3380.8140552269615;3398.320335932823;3406.7615266931325;3443.6212016678396;975.6195083917278;1014.9289549731521;1042.1402343067;1047.8218702820539;1050.7635781949;10403;10506.842397364046;10525.21060920434;10535.104516116216;10557.524911379007;3862.266169427856;4224.239636865394;4291.6566674665955;4556.24821904382;4596.724196548218;8968.820623587622;9054.139856713602;9087.409318394282;9136.360454768235;9178.495182764878;5072.112380333427;5080.568151707146;5089.389273287229;5092.312537807423;5095.082885080721;4496.853302407865;4558.270676691714;4646.3495110684535;4653.581177694024;4682.555157260055;3172.1118086935694;3654.6528079832374;3683.2265224303196;3745.756525825867;3764.0589852536864;1239.6528971887885;1246.1028059796931;1248.1574936917543;1252.3174869696038;1254.3352023427415;828.4656396624143;857.9227869491775;882.4881568690145;887.5207388010531;942.7643089227693;5499.670019798825;5574.609777315549;5666.603337766317;5716.1997320375185;5723.313202415654;881.6120906800987;891.3804905590682;905.5200743605899;917.27535247154;918.6049998500575;3604.441311596707;3751.662350388478;3784.7918364489665;3869.5356557212754;3886.0090676877217;9312.115349041831;9612.471314077653;9711.611535538499;9731.854022189673;9754.561044753003;9677.951610242044;9747.756306092404;9768.853467197998;9798.31411801167;9805;7265.963670181615;7522.172561018284;7563.924360756432;7668.731594394281;7675.846483070307;5456.536194423518;5491.0939694951485;5533.972330138324;5572.108462645957;5662.603617746719;7616;8906.332025098014;9039.819203616022;9054.230390416888;9144.954275228582;8001.8399632008195;9009.684661036832;9134.862977055482;9160.541972901196;9291.535423228946;5885.323187833454;6843.041974123527;7004.684789184397;7014.684339204646;7030.789076327718;6012.977793774981;6903.551269167488;7577.924220757722;7629.54222746637;7690;6688.3646053624825;6775.356341147583;6951.617661028692;7007.614581198083;7029;6627.37039981201;6642.4021838034805;6790.558613690095;6818.386345228953;6888.276730943179;6051.606645568024;6521.64130972801;6526.347365263436;6532.444742196776;6538.1500404947055;4170.957260684829;4198.181354635939;4595.908081838277;4750.667453278375;4755.857324280277;4668.883277917943;4670.696404733817;4728.054389122258;4819.204831202953;4901.387326584177 17:57:39 INFO - PROCESS | 1999 | |4;prototype.html;297.4051896207585;326.4026830899454;354.54618088846286;355.8576569372252;356.42081617371764;4397.758123303217;4510.278355463122;4557.065801510691;4923.82766603169;5104.494174218605;4637.443506779191;5087.694738315704;5351.57187425006;5358.2498450217;5415.404305526389;3645.65366290202;3944.9802750986205;4126.339785634299;4137.81379837908;4163.666906647476;3257.0066129830393;3463.6882680558747;4098.9590104099025;4154.97922510387;4163.666906647461;3595.6044835068124;3919.451276821233;3980.800959952005;3987.441758153861;3989.2819292527333;3326.76712630116;4011.29802284599;4013.899652508696;4026.859059932888;4056.6754659627454;3460.3425349183576;3464.9653503464897;3479.460683594047;3485.250671105699;3487.7907325560545;4825.986542826011;5171.612129090333;5259.947400526023;5306.3632364116165;5316.9202461963105;3806.467094606757;4020.175863947913;4034.677225821927;4218.831246750126;4386.517483076859;4162.708610397273;4805.111054454902;5029.5221953914315;5662.66024038559;5709;3237.530558069067;3642.8907132786057;3779.848806047755;3806.2958352704836;3826.245103525457;5305.867353316159;5770.394108618577;5805.970970145122;5866.354700982888;5888.705564721747;3674.622016743721;3681.5582130144016;3796.1648437343742;3834.7123965702685;3841.4814000109627;3409.5226668266464;3441.8451169697423;3899.6100389960775;3909.6090390961244;3920.843166273374;3931.5282166140246;4303.33298338758;4506.662000349987;4509.27851543758;4537;4434.800433980478;4869.586085182799;5520.06158952979;5600.831975040755;5622.184783206494;1059.4067322299536;1097.0729733375285;1143.6454699043156;1218.451696736472;1245.588955644635;796.7649543384715;834.5145640759458;848.5587494502824;856.6873091321747;857.6140736668399;4375.912481750347;5097.286379906816;5101.897962040813;5126.5898728101665;5186.521841275218;4685.929711054337;5248.606354523426;5314.362276526842;5543.334799823966;5595.356533998561;4528.46032349003;4561.68068235227;4713.528647135259;4950.727709975914;5055.494450554915;2903.535434330497;2918.7081291870645;2927.3413481966386;2932.780041496896;2937.485939960541;5621.662700237917;5672.9221447924765;5706.686132262683;5721.485066344049;5803.359471440484;5120.849243317741;5326.6005049621435;5458.6724796512335;5686.97156514223;5714.5999780015;4824.421069471686;5248.816291429782;5333.919991200135;5756.280464941882;6048.697565121726;4268.615824575803;4761.476237613929;4948.406191256928;5305.9469405307;5583.0787919992745;4905.386826646669;5229.947700523098;5232.659877107976;5267.23392774153;5699.800506982236;5289.867753306198;5770.480656740913;5871.328545511697;5963.642181469126;5967.283925928917;3206.903792886217;3615.457681347819;3810.714196435223;3811;3825.8660946866726;4693.366395536559;5683.488486036111;5732.856678583069;5750.568707347049;5782.681952492485;4640.559146881041;5364.222187782671;5501.697406642673;5508.283923090133;5664.0459041630575;4736.668433209642;4908.509149085063;5042.798288068436;5695.544356451391;5698.430156984268;4843.740627436962;4936.333594964777;4948.950510494849;5094.872628184325;5536.979002664079;4863.613870047161;5681.801136960186;5735.311762588516;5765.423457654201;5766.769329226784;5604.215409842707;5608.971955140199;5611.3266408031295;5612.550995920398;5638.85902852432 17:57:39 INFO - PROCESS | 1999 | |5;yui.html;696.5437638346884;727.4180655475618;743.2196193996303;752.7327798631486;821.4291067707943;15064.698706025887;15629.452969146083;15702.76445853313;15750.921245393785;15760.133192674399;11093.55625774968;11963.282203067822;12244.142909996304;12412.565560205394;14346.641333966656;683.6103421050003;703.989440158398;851.4167795060373;873.7335112790628;886.6320477002037;816.9019717633862;836.5817091454273;879.4679219072465;879.6041781198454;881.154092071612;915.4095608332622;928.2759447630858;938.5307346326837;939.4738946190155;941.7221919533754;928.308410234373;931.0689310689311;932.9626814927394;934.4720233068294;935.8175155844579;696.9372756451893;697.4211404534225;697.4559843322166;697.769735987123;698.7449580902985;14591.635209119751;15162;15218.163001034938;15577;15836.841631583651;13913.373898174606;14545.27273636314;14557.490487832874;14669;14678.412863485448;10850.620228292051;11758.706032349173;11802.704932376673;11818.231814932087;11854.466549005316;3749.793761343125;3770.7549009314307;3782.2624588205313;3795.810209489542;3913.412988051815;105943.47028264886;107828.66022031104;109628.15736643893;110223;111334.44332778447;9160.81678366429;11104.222704410613;11197.104231661448;11208.27146235492;11430.142739294586;23171.420714481934;23390.415239619146;23455.7654423457;23460.882695586413;23467.88266058693;7841.490303130278;7871.84256314882;7895.802604934923;8050.677972881019;8166.142555031636;4097.201045796041;4335.111302183108;4346.739195648272;4395.7142785718825;4464.638285323008;3443.362977849106;3520.4543295789194;3529;3687.815609219528;3873.922521549553;661.1240106858336;691.94810389221;697.7034760226883;707.9044329015517;708.3837061756202;572.8625129968777;632.7469012395079;637.4040272345372;656.1011414362259;656.8554917918051;8798.560071996375;9169.587368568431;9265.397749146285;9405.57674904631;9419.529023548796;578.8654237694083;622.2595111816923;635.7520566978882;654.6890227142069;668.5387082912774;4372.519022907478;4405.29515277554;4644.628429725682;4697.882552936136;4742.857714268577;108158;111542;112293;112707;112807.4359628213;89609.75975600531;96871;97323.02676973281;99104;100840;85506;87130;87589.12410875937;87595.56202218948;89584;8845.778855528662;8855.91144088551;8963.955180224319;8981.416207946462;9094.59074341643;44205;47545.76227118981;47596;49059;56624.716876417006;49740.25389619231;54924.725376372866;62895.742085158956;63223;64414.677926610064;10838;10872.238943273895;13141.110352015414;13220.206787592775;13554.322283885569;14464.059836110619;14476.493322733653;14653.487127950471;14804.777928330868;14824.332905019515;13482.393292301675;13585.932070339584;13618.93190534041;14405.351759170653;14427.134371937716;13448.865511344762;13536.120152190077;13628.591142265748;13631.591052268448;13674.658133546742;11341.206115571831;13215;13500;13744.587662370144;13847.169169849842;11218.382988935688;11249.718757030812;11289.37908415045;11318.547258109584;11459.713507162387;9436.52817359143;11188.135094862286;11504.137189710638;11560.768784624428;11576.36330001858 17:57:39 INFO - PROCESS | 1999 | __end_tp_report 17:57:39 INFO - PROCESS | 1999 | __start_cc_report 17:57:39 INFO - PROCESS | 1999 | _x_x_mozilla_cycle_collect,385 17:57:39 INFO - PROCESS | 1999 | __end_cc_report 17:57:39 INFO - PROCESS | 1999 | __startTimestamp1481939859152__endTimestamp 17:57:39 INFO - PROCESS | 1999 | 17:57:39 INFO - PROCESS | 1999 | ------- Summary: start ------- 17:57:39 INFO - PROCESS | 1999 | Number of tests: 6 17:57:39 INFO - PROCESS | 1999 | 17:57:39 INFO - PROCESS | 1999 | [#0] dojo.html Cycles:165 Average:5742.38 Median:6006.88 stddev:679.96 (11.3%) stddev-sans-first:656.06 17:57:39 INFO - PROCESS | 1999 | Values: 3369.1 3373.2 3396.1 3399.0 3410.2 5564.9 5752.7 5781.4 5836.3 5846.6 5653.2 5788.3 5877.6 5884.3 5923.2 5197.9 5236.3 5289.0 5317.8 5374.8 5121.1 5231.2 5331.4 5353.9 5401.2 5087.5 5112.6 5291.3 5316.5 5316.9 4174.4 5151.1 5160.9 5204.4 5231.2 5193.3 5195.8 5244.2 5259.1 5260.7 5716.2 5766.3 5855.6 5879.1 5896.5 5853.6 5925.5 5949.6 6244.7 6247.2 6106.5 6197.3 6212.5 6240.7 6309.1 5929.8 5935.4 5936.2 5941.4 5974.6 6185.3 6310.0 6380.7 6381.1 6385.6 5965.9 6056.9 6060.6 6072.5 6079.8 6152.0 6189.7 6197.6 6219.3 6235.9 6195.0 6212.5 6259.1 6267.7 6298.1 6226.8 6303.2 6304.7 6321.2 6322.2 4787.2 4817.4 4821.1 4825.5 4963.6 3611.6 3667.9 4335.4 4465.5 4516.3 5168.4 5223.9 5598.1 5908.9 5951.1 6119.5 6203.7 6261.5 6268.5 6268.9 4808.9 5668.7 5773.5 5785.9 5816.5 5461.1 5475.7 5487.3 5493.6 5499.4 6368.7 6375.8 6384.7 6388.0 6416.4 6126.5 6138.0 6170.5 6236.7 6266.8 6250.7 6253.1 6258.1 6285.3 6342.9 6051.6 6092.5 6163.4 6234.9 6242.3 6184.3 6209.8 6250.7 6277.1 6304.6 5934.2 6008.2 6206.8 6240.3 6250.4 6073.5 6075.7 6081.6 6091.4 6136.0 5217.4 6006.9 6045.5 6101.8 6104.5 6167.1 6191.1 6198.9 6202.3 6238.3 5754.6 6008.0 6065.0 6065.1 6088.5 17:57:39 INFO - PROCESS | 1999 | 17:57:39 INFO - PROCESS | 1999 | [#1] ext.html Cycles:180 Average:65641.86 Median:34329.40 stddev:142353.69 (414.7%) stddev-sans-first:142668.86 17:57:39 INFO - PROCESS | 1999 | Values: 441.1 460.8 489.8 515.5 543.6 35713.6 39945.6 40242.0 40244.4 40253.8 40546.6 40710.6 40979.4 41065.0 41165.2 8370.2 8721.0 9340.8 9547.5 9561.1 11200.4 11488.7 11548.1 11671.3 11685.1 11435.6 11455.8 11493.4 11517.7 11517.9 11293.3 11407.5 11420.3 11443.7 11455.3 11294.0 11347.3 11365.8 11383.0 11385.3 38745.4 38778.8 38975.8 39026.6 39055.6 3301.7 3444.5 3447.8 3501.8 3936.9 29308.0 29765.1 29955.9 30052.5 30330.8 2756.7 2850.3 3171.5 3193.0 3267.1 339883.0 447988.0 452342.0 452362.0 454621.7 52158.2 52423.5 52454.2 52659.7 56377.2 57616.4 57849.7 57932.0 58006.1 58103.7 15184.6 15612.0 15654.5 15656.5 15676.8 11169.2 11422.5 12036.8 12247.9 12346.8 14439.9 14472.9 14482.6 14615.5 14652.7 6323.3 7201.7 7315.1 7375.7 7394.9 823.3 934.5 950.2 1028.8 1113.0 28130.6 29398.4 29645.9 29891.1 30137.7 975.2 1044.3 1058.6 1066.3 1082.8 13458.5 14926.0 15476.5 15485.6 15593.4 525249.0 556080.0 615145.0 616644.0 619362.0 57020.0 57376.0 57536.7 57583.4 57663.4 1331.4 1365.5 1392.9 1394.6 1397.4 28602.1 29631.4 29650.7 30081.7 30099.7 39388.2 44315.8 48176.8 48666.8 48779.0 563440.0 565333.0 566283.0 567263.0 568182.0 23809.9 24466.8 24477.9 38661.8 38977.8 40473.4 41114.4 41653.0 42089.0 42121.8 28160.7 34588.5 34645.0 34814.7 35533.3 34378.3 34489.7 35173.1 35362.8 35694.0 33629.8 33949.8 34020.8 34280.5 34472.3 31034.4 31136.2 31181.7 31222.5 31254.0 23471.5 23670.5 23862.4 24129.3 24285.3 17:57:39 INFO - PROCESS | 1999 | 17:57:39 INFO - PROCESS | 1999 | [#2] jquery.html Cycles:180 Average:30828.19 Median:2147.51 stddev:81398.61 (3790.4%) stddev-sans-first:81594.68 17:57:39 INFO - PROCESS | 1999 | Values: 298.4 300.6 367.0 367.9 391.2 18867.0 19896.0 20330.9 20541.9 20552.9 11663.5 16310.1 18565.4 19178.2 19350.0 4366.0 5338.9 5352.7 5354.4 5360.1 5249.9 5331.3 5468.6 5760.5 5806.3 5808.3 5810.5 5819.7 5820.9 5830.2 5786.7 5842.6 6000.1 6005.5 6058.8 5593.5 5854.6 5858.3 5876.4 5881.2 12749.0 12975.0 13083.3 13087.9 13091.6 1987.7 2078.3 2140.4 2154.6 2259.8 9713.4 9851.3 10042.7 10248.7 10250.2 1542.7 1858.3 1895.9 1906.6 1912.9 108366.0 114993.4 125050.7 126339.1 128472.0 9178.3 9991.2 11376.7 11439.2 11573.7 14335.6 14342.4 14349.9 14361.9 14385.9 7510.1 8091.9 8204.8 8333.0 8453.7 8160.9 8196.6 8240.6 8326.3 8345.4 4317.7 4495.8 4536.0 4556.5 4605.1 1926.3 1956.3 1981.6 2003.7 2004.3 823.8 885.2 930.9 960.4 963.9 19451.5 20120.8 20208.3 20269.0 20446.3 924.2 935.3 962.2 967.9 986.9 10382.4 10754.8 10759.4 10773.8 10786.5 440536.0 467585.7 469171.0 509259.0 512154.0 78190.6 103595.0 132316.0 134827.3 134993.0 893.6 1002.9 1036.0 1043.9 1044.2 17427.5 18440.6 18571.4 18699.1 18784.0 49914.0 52506.7 52524.5 53500.5 54240.0 65345.3 77279.0 77629.2 77983.2 79980.0 6036.0 7236.8 7386.3 7856.3 8404.0 12388.9 12637.0 12988.2 13228.8 13259.8 10666.0 10757.0 11129.6 11307.7 11397.2 9877.6 10017.7 10575.3 10873.7 11118.2 11224.4 11254.2 11543.6 11620.0 11733.1 7207.5 7336.8 7434.4 7436.8 7465.7 10943.0 11184.6 11274.2 11325.4 11331.8 17:57:39 INFO - PROCESS | 1999 | 17:57:39 INFO - PROCESS | 1999 | [#3] mootools.html Cycles:180 Average:5249.81 Median:5495.38 stddev:2863.68 (52.1%) stddev-sans-first:2856.79 17:57:39 INFO - PROCESS | 1999 | Values: 1360.2 1512.0 1670.3 1776.4 1817.5 7381.5 7593.5 7862.7 8292.8 8300.5 7789.6 8070.6 8086.2 8133.6 8161.2 1809.9 1830.5 2024.2 2179.5 2216.2 1880.6 2029.8 2286.0 2307.8 2313.1 2228.2 2237.0 2255.9 2269.9 2270.4 1852.0 1898.9 2238.7 2271.9 2275.7 2254.6 2266.6 2291.3 2301.1 2306.4 8119.1 8145.3 8177.0 8186.2 8192.1 4929.6 4994.2 5034.1 5064.8 5082.2 3238.7 3380.8 3398.3 3406.8 3443.6 975.6 1014.9 1042.1 1047.8 1050.8 10403.0 10506.8 10525.2 10535.1 10557.5 3862.3 4224.2 4291.7 4556.2 4596.7 8968.8 9054.1 9087.4 9136.4 9178.5 5072.1 5080.6 5089.4 5092.3 5095.1 4496.9 4558.3 4646.3 4653.6 4682.6 3172.1 3654.7 3683.2 3745.8 3764.1 1239.7 1246.1 1248.2 1252.3 1254.3 828.5 857.9 882.5 887.5 942.8 5499.7 5574.6 5666.6 5716.2 5723.3 881.6 891.4 905.5 917.3 918.6 3604.4 3751.7 3784.8 3869.5 3886.0 9312.1 9612.5 9711.6 9731.9 9754.6 9678.0 9747.8 9768.9 9798.3 9805.0 7266.0 7522.2 7563.9 7668.7 7675.8 5456.5 5491.1 5534.0 5572.1 5662.6 7616.0 8906.3 9039.8 9054.2 9145.0 8001.8 9009.7 9134.9 9160.5 9291.5 5885.3 6843.0 7004.7 7014.7 7030.8 6013.0 6903.6 7577.9 7629.5 7690.0 6688.4 6775.4 6951.6 7007.6 7029.0 6627.4 6642.4 6790.6 6818.4 6888.3 6051.6 6521.6 6526.3 6532.4 6538.2 4171.0 4198.2 4595.9 4750.7 4755.9 4668.9 4670.7 4728.1 4819.2 4901.4 17:57:39 INFO - PROCESS | 1999 | 17:57:39 INFO - PROCESS | 1999 | [#4] prototype.html Cycles:180 Average:4405.93 Median:4866.60 stddev:1368.09 (28.1%) stddev-sans-first:1336.72 17:57:39 INFO - PROCESS | 1999 | Values: 297.4 326.4 354.5 355.9 356.4 4397.8 4510.3 4557.1 4923.8 5104.5 4637.4 5087.7 5351.6 5358.2 5415.4 3645.7 3945.0 4126.3 4137.8 4163.7 3257.0 3463.7 4099.0 4155.0 4163.7 3595.6 3919.5 3980.8 3987.4 3989.3 3326.8 4011.3 4013.9 4026.9 4056.7 3460.3 3465.0 3479.5 3485.3 3487.8 4826.0 5171.6 5259.9 5306.4 5316.9 3806.5 4020.2 4034.7 4218.8 4386.5 4162.7 4805.1 5029.5 5662.7 5709.0 3237.5 3642.9 3779.8 3806.3 3826.2 5305.9 5770.4 5806.0 5866.4 5888.7 3674.6 3681.6 3796.2 3834.7 3841.5 3409.5 3441.8 3899.6 3909.6 3920.8 3931.5 4303.3 4506.7 4509.3 4537.0 4434.8 4869.6 5520.1 5600.8 5622.2 1059.4 1097.1 1143.6 1218.5 1245.6 796.8 834.5 848.6 856.7 857.6 4375.9 5097.3 5101.9 5126.6 5186.5 4685.9 5248.6 5314.4 5543.3 5595.4 4528.5 4561.7 4713.5 4950.7 5055.5 2903.5 2918.7 2927.3 2932.8 2937.5 5621.7 5672.9 5706.7 5721.5 5803.4 5120.8 5326.6 5458.7 5687.0 5714.6 4824.4 5248.8 5333.9 5756.3 6048.7 4268.6 4761.5 4948.4 5305.9 5583.1 4905.4 5229.9 5232.7 5267.2 5699.8 5289.9 5770.5 5871.3 5963.6 5967.3 3206.9 3615.5 3810.7 3811.0 3825.9 4693.4 5683.5 5732.9 5750.6 5782.7 4640.6 5364.2 5501.7 5508.3 5664.0 4736.7 4908.5 5042.8 5695.5 5698.4 4843.7 4936.3 4949.0 5094.9 5537.0 4863.6 5681.8 5735.3 5765.4 5766.8 5604.2 5609.0 5611.3 5612.6 5638.9 17:57:39 INFO - PROCESS | 1999 | 17:57:39 INFO - PROCESS | 1999 | [#5] yui.html Cycles:180 Average:20990.34 Median:4340.93 stddev:31059.53 (715.5%) stddev-sans-first:31109.28 17:57:39 INFO - PROCESS | 1999 | Values: 696.5 727.4 743.2 752.7 821.4 15064.7 15629.5 15702.8 15750.9 15760.1 11093.6 11963.3 12244.1 12412.6 14346.6 683.6 704.0 851.4 873.7 886.6 816.9 836.6 879.5 879.6 881.2 915.4 928.3 938.5 939.5 941.7 928.3 931.1 933.0 934.5 935.8 696.9 697.4 697.5 697.8 698.7 14591.6 15162.0 15218.2 15577.0 15836.8 13913.4 14545.3 14557.5 14669.0 14678.4 10850.6 11758.7 11802.7 11818.2 11854.5 3749.8 3770.8 3782.3 3795.8 3913.4 105943.5 107828.7 109628.2 110223.0 111334.4 9160.8 11104.2 11197.1 11208.3 11430.1 23171.4 23390.4 23455.8 23460.9 23467.9 7841.5 7871.8 7895.8 8050.7 8166.1 4097.2 4335.1 4346.7 4395.7 4464.6 3443.4 3520.5 3529.0 3687.8 3873.9 661.1 691.9 697.7 707.9 708.4 572.9 632.7 637.4 656.1 656.9 8798.6 9169.6 9265.4 9405.6 9419.5 578.9 622.3 635.8 654.7 668.5 4372.5 4405.3 4644.6 4697.9 4742.9 108158.0 111542.0 112293.0 112707.0 112807.4 89609.8 96871.0 97323.0 99104.0 100840.0 85506.0 87130.0 87589.1 87595.6 89584.0 8845.8 8855.9 8964.0 8981.4 9094.6 44205.0 47545.8 47596.0 49059.0 56624.7 49740.3 54924.7 62895.7 63223.0 64414.7 10838.0 10872.2 13141.1 13220.2 13554.3 14464.1 14476.5 14653.5 14804.8 14824.3 13482.4 13585.9 13618.9 14405.4 14427.1 13448.9 13536.1 13628.6 13631.6 13674.7 11341.2 13215.0 13500.0 13744.6 13847.2 11218.4 11249.7 11289.4 11318.5 11459.7 9436.5 11188.1 11504.1 11560.8 11576.4 17:57:39 INFO - PROCESS | 1999 | -------- Summary: end -------- 17:57:39 INFO - PROCESS | 1999 | 17:57:39 INFO - TEST-INFO | 1999: exit 0 17:57:39 INFO - TEST-OK | dromaeo_css | took 1115990ms 17:57:39 INFO - TEST-START | kraken 17:57:39 INFO - operating with platform_type : mac_ 17:57:39 INFO - Initialising browser for kraken test... 17:57:39 INFO - TEST-INFO | started process 2006 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpHB8bwA/profile http://localhost:49294/getInfo.html) 17:57:42 INFO - PROCESS | 2006 | 2016-12-16 17:57:42.571 plugin-container[2007:22411] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454b, name = 'com.apple.tsm.portname' 17:57:42 INFO - PROCESS | 2006 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:57:42 INFO - PROCESS | 2006 | 2016-12-16 17:57:42.573 plugin-container[2007:22411] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 17:57:42 INFO - PROCESS | 2006 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:57:42 INFO - PROCESS | 2006 | 2016-12-16 17:57:42.574 plugin-container[2007:22411] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:57:42 INFO - PROCESS | 2006 | __metrics Screen width/height:1600/1200 17:57:42 INFO - PROCESS | 2006 | colorDepth:24 17:57:42 INFO - PROCESS | 2006 | Browser inner width/height: 1024/689 17:57:42 INFO - PROCESS | 2006 | __metrics 17:57:42 ERROR - PROCESS | 2006 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3232: TypeError: this.tabs is undefined 17:57:43 INFO - TEST-INFO | 2006: exit 0 17:57:43 INFO - Browser initialized. 17:57:43 INFO - Running cycle 1/1 for kraken test... 17:57:43 INFO - TEST-INFO | started process 2008 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpHB8bwA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:57:45 INFO - PROCESS | 2008 | 2016-12-16 17:57:45.815 plugin-container[2009:22530] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 17:57:45 INFO - PROCESS | 2008 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:57:45 INFO - PROCESS | 2008 | 2016-12-16 17:57:45.816 plugin-container[2009:22530] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 17:57:45 INFO - PROCESS | 2008 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:57:45 INFO - PROCESS | 2008 | 2016-12-16 17:57:45.816 plugin-container[2009:22530] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:57:55 INFO - PROCESS | 2008 | RSS: Main: 236793856 17:57:55 INFO - PROCESS | 2008 | 17:57:58 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49294/tests/kraken/driver.html?testName=audio-beat-detection) 17:57:59 INFO - PROCESS | 2008 | RSS: Main: 249180160 17:57:59 INFO - PROCESS | 2008 | 17:58:02 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49294/tests/kraken/driver.html?testName=audio-dft) 17:58:02 INFO - PROCESS | 2008 | RSS: Main: 256700416 17:58:02 INFO - PROCESS | 2008 | 17:58:06 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49294/tests/kraken/driver.html?testName=audio-fft) 17:58:06 INFO - PROCESS | 2008 | RSS: Main: 259469312 17:58:06 INFO - PROCESS | 2008 | 17:58:08 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49294/tests/kraken/driver.html?testName=audio-oscillator) 17:58:09 INFO - PROCESS | 2008 | RSS: Main: 260726784 17:58:09 INFO - PROCESS | 2008 | 17:58:11 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49294/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:58:11 INFO - PROCESS | 2008 | RSS: Main: 261046272 17:58:11 INFO - PROCESS | 2008 | 17:58:15 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49294/tests/kraken/driver.html?testName=imaging-darkroom) 17:58:15 INFO - PROCESS | 2008 | RSS: Main: 267304960 17:58:15 INFO - PROCESS | 2008 | 17:58:19 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49294/tests/kraken/driver.html?testName=imaging-desaturate) 17:58:19 INFO - PROCESS | 2008 | RSS: Main: 266121216 17:58:19 INFO - PROCESS | 2008 | 17:58:22 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49294/tests/kraken/driver.html?testName=json-parse-financial) 17:58:23 INFO - PROCESS | 2008 | RSS: Main: 266170368 17:58:23 INFO - PROCESS | 2008 | 17:58:24 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49294/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:58:25 INFO - PROCESS | 2008 | RSS: Main: 265461760 17:58:25 INFO - PROCESS | 2008 | 17:58:27 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49294/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:58:28 INFO - PROCESS | 2008 | RSS: Main: 266981376 17:58:28 INFO - PROCESS | 2008 | 17:58:30 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49294/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:58:30 INFO - PROCESS | 2008 | RSS: Main: 266895360 17:58:30 INFO - PROCESS | 2008 | 17:58:33 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49294/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:58:34 INFO - PROCESS | 2008 | RSS: Main: 267198464 17:58:34 INFO - PROCESS | 2008 | 17:58:37 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49294/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:58:38 INFO - PROCESS | 2008 | RSS: Main: 267030528 17:58:38 INFO - PROCESS | 2008 | 17:58:40 INFO - PROCESS | 2008 | Cycle 1(1): loaded http://localhost:49294/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49294/tests/kraken/driver.html?testName=ai-astar) 17:58:40 INFO - PROCESS | 2008 | RSS: Main: 267997184 17:58:40 INFO - PROCESS | 2008 | 17:58:40 INFO - PROCESS | 2008 | __start_tp_report 17:58:40 INFO - PROCESS | 2008 | _x_x_mozilla_page_load 17:58:40 INFO - PROCESS | 2008 | _x_x_mozilla_page_load_details 17:58:40 INFO - PROCESS | 2008 | |i|pagename|runs| 17:58:40 INFO - PROCESS | 2008 | |0;ai-astar;105;119;121;119;119;119;118;119;118;119 17:58:40 INFO - PROCESS | 2008 | |1;audio-beat-detection;150;106;115;146;112;144;143;112;131;114 17:58:40 INFO - PROCESS | 2008 | |2;audio-dft;198;202;212;259;248;198;194;196;199;193 17:58:40 INFO - PROCESS | 2008 | |3;audio-fft;85;60;62;83;60;64;74;51;91;51 17:58:40 INFO - PROCESS | 2008 | |4;audio-oscillator;92;97;115;84;70;72;81;70;71;103 17:58:40 INFO - PROCESS | 2008 | |5;imaging-gaussian-blur;111;113;166;112;160;162;113;164;144;113 17:58:40 INFO - PROCESS | 2008 | |6;imaging-darkroom;96;97;133;107;151;106;98;95;110;152 17:58:40 INFO - PROCESS | 2008 | |7;imaging-desaturate;76;151;91;93;93;91;94;91;93;93 17:58:40 INFO - PROCESS | 2008 | |8;json-parse-financial;58;57;57;58;59;59;58;59;58;58 17:58:40 INFO - PROCESS | 2008 | |9;json-stringify-tinderbox;69;106;68;78;74;70;68;71;76;71 17:58:40 INFO - PROCESS | 2008 | |10;stanford-crypto-aes;85;90;91;86;89;87;89;76;112;112 17:58:40 INFO - PROCESS | 2008 | |11;stanford-crypto-ccm;141;138;143;153;162;157;152;153;185;155 17:58:40 INFO - PROCESS | 2008 | |12;stanford-crypto-pbkdf2;172;172;184;239;211;175;175;188;181;239 17:58:40 INFO - PROCESS | 2008 | |13;stanford-crypto-sha256-iterative;67;68;70;66;68;67;68;68;66;69 17:58:40 INFO - PROCESS | 2008 | __end_tp_report 17:58:40 INFO - PROCESS | 2008 | __start_cc_report 17:58:40 INFO - PROCESS | 2008 | _x_x_mozilla_cycle_collect,954 17:58:40 INFO - PROCESS | 2008 | __end_cc_report 17:58:40 INFO - PROCESS | 2008 | __startTimestamp1481939920316__endTimestamp 17:58:40 INFO - PROCESS | 2008 | 17:58:40 INFO - PROCESS | 2008 | ------- Summary: start ------- 17:58:40 INFO - PROCESS | 2008 | Number of tests: 14 17:58:40 INFO - PROCESS | 2008 | 17:58:40 INFO - PROCESS | 2008 | [#0] ai-astar Cycles:10 Average:117.60 Median:119.00 stddev:4.50 (3.8%) stddev-sans-first:0.87 17:58:40 INFO - PROCESS | 2008 | Values: 105.0 119.0 121.0 119.0 119.0 119.0 118.0 119.0 118.0 119.0 17:58:40 INFO - PROCESS | 2008 | 17:58:40 INFO - PROCESS | 2008 | [#1] audio-beat-detection Cycles:10 Average:127.30 Median:137.00 stddev:17.17 (12.5%) stddev-sans-first:16.13 17:58:40 INFO - PROCESS | 2008 | Values: 150.0 106.0 115.0 146.0 112.0 144.0 143.0 112.0 131.0 114.0 17:58:40 INFO - PROCESS | 2008 | 17:58:40 INFO - PROCESS | 2008 | [#2] audio-dft Cycles:10 Average:209.90 Median:200.50 stddev:23.72 (11.8%) stddev-sans-first:24.76 17:58:40 INFO - PROCESS | 2008 | Values: 198.0 202.0 212.0 259.0 248.0 198.0 194.0 196.0 199.0 193.0 17:58:40 INFO - PROCESS | 2008 | 17:58:40 INFO - PROCESS | 2008 | [#3] audio-fft Cycles:10 Average:68.10 Median:69.00 stddev:14.29 (20.7%) stddev-sans-first:13.78 17:58:40 INFO - PROCESS | 2008 | Values: 85.0 60.0 62.0 83.0 60.0 64.0 74.0 51.0 91.0 51.0 17:58:40 INFO - PROCESS | 2008 | 17:58:40 INFO - PROCESS | 2008 | [#4] audio-oscillator Cycles:10 Average:85.50 Median:76.50 stddev:15.80 (20.7%) stddev-sans-first:16.58 17:58:40 INFO - PROCESS | 2008 | Values: 92.0 97.0 115.0 84.0 70.0 72.0 81.0 70.0 71.0 103.0 17:58:40 INFO - PROCESS | 2008 | 17:58:40 INFO - PROCESS | 2008 | [#5] imaging-gaussian-blur Cycles:10 Average:135.80 Median:152.00 stddev:25.36 (16.7%) stddev-sans-first:25.26 17:58:40 INFO - PROCESS | 2008 | Values: 111.0 113.0 166.0 112.0 160.0 162.0 113.0 164.0 144.0 113.0 17:58:40 INFO - PROCESS | 2008 | 17:58:40 INFO - PROCESS | 2008 | [#6] imaging-darkroom Cycles:10 Average:114.50 Median:123.50 stddev:22.44 (18.2%) stddev-sans-first:22.78 17:58:40 INFO - PROCESS | 2008 | Values: 96.0 97.0 133.0 107.0 151.0 106.0 98.0 95.0 110.0 152.0 17:58:40 INFO - PROCESS | 2008 | 17:58:40 INFO - PROCESS | 2008 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:93.00 stddev:19.82 (21.3%) stddev-sans-first:19.57 17:58:40 INFO - PROCESS | 2008 | Values: 76.0 151.0 91.0 93.0 93.0 91.0 94.0 91.0 93.0 93.0 17:58:40 INFO - PROCESS | 2008 | 17:58:40 INFO - PROCESS | 2008 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 17:58:40 INFO - PROCESS | 2008 | Values: 58.0 57.0 57.0 58.0 59.0 59.0 58.0 59.0 58.0 58.0 17:58:40 INFO - PROCESS | 2008 | 17:58:40 INFO - PROCESS | 2008 | [#9] json-stringify-tinderbox Cycles:10 Average:75.10 Median:71.00 stddev:11.37 (16.0%) stddev-sans-first:11.84 17:58:40 INFO - PROCESS | 2008 | Values: 69.0 106.0 68.0 78.0 74.0 70.0 68.0 71.0 76.0 71.0 17:58:40 INFO - PROCESS | 2008 | 17:58:40 INFO - PROCESS | 2008 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:88.00 stddev:11.49 (13.1%) stddev-sans-first:11.93 17:58:40 INFO - PROCESS | 2008 | Values: 85.0 90.0 91.0 86.0 89.0 87.0 89.0 76.0 112.0 112.0 17:58:40 INFO - PROCESS | 2008 | 17:58:40 INFO - PROCESS | 2008 | [#11] stanford-crypto-ccm Cycles:10 Average:153.90 Median:154.00 stddev:13.28 (8.6%) stddev-sans-first:13.24 17:58:40 INFO - PROCESS | 2008 | Values: 141.0 138.0 143.0 153.0 162.0 157.0 152.0 153.0 185.0 155.0 17:58:40 INFO - PROCESS | 2008 | 17:58:40 INFO - PROCESS | 2008 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.60 Median:186.00 stddev:26.53 (14.3%) stddev-sans-first:26.96 17:58:40 INFO - PROCESS | 2008 | Values: 172.0 172.0 184.0 239.0 211.0 175.0 175.0 188.0 181.0 239.0 17:58:40 INFO - PROCESS | 2008 | 17:58:40 INFO - PROCESS | 2008 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.25 (1.8%) stddev-sans-first:1.30 17:58:40 INFO - PROCESS | 2008 | Values: 67.0 68.0 70.0 66.0 68.0 67.0 68.0 68.0 66.0 69.0 17:58:40 INFO - PROCESS | 2008 | -------- Summary: end -------- 17:58:40 INFO - PROCESS | 2008 | 17:58:41 INFO - TEST-INFO | 2008: exit 0 17:58:41 INFO - TEST-OK | kraken | took 61477ms 17:58:41 INFO - SUITE-END | took 1177s 17:58:41 INFO - Completed test suite (00:19:37) 17:58:41 INFO - javascript benchmark 17:58:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7097.090268773247, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3369.1240277527836, 3373.207296285373, 3396.1000334911237, 3399.0, 3410.1986033282174, 5564.86087847804, 5752.654840709555, 5781.392953739854, 5836.270466191726, 5846.619969701972, 5653.236813030239, 5788.27646544182, 5877.617954832933, 5884.293884733827, 5923.200367950325, 5197.922031169526, 5236.293100431431, 5288.968651113035, 5317.7607007684555, 5374.838754837341, 5121.052605268019, 5231.189165679326, 5331.440198779131, 5353.946460535384, 5401.162819762943, 5087.516685914832, 5112.565431938289, 5291.312129423189, 5316.521513063843, 5316.9202461963105, 4174.394712766662, 5151.124308867464, 5160.870978225575, 5204.375474943031, 5231.163013917793, 5193.324867767204, 5195.818146364859, 5244.239585260116, 5259.0796610593, 5260.736963151865, 5716.228309178249, 5766.336871259775, 5855.560832937546, 5879.147523609053, 5896.469317761379, 5853.619514731571, 5925.4963328117165, 5949.583529152961, 6244.718987645521, 6247.187865577446, 6106.48094911933, 6197.349278325756, 6212.534059945477, 6240.687965601747, 6309.0536419536975, 5929.822105336761, 5935.436133567304, 5936.228290322274, 5941.405859414024, 5974.551908606828, 6185.257769067651, 6309.968450157719, 6380.680965951684, 6381.074744162071, 6385.6487893165395, 5965.910511342333, 6056.878862422727, 6060.606060606046, 6072.483838873657, 6079.756809727562, 6151.96924015377, 6189.690515474298, 6197.628142311476, 6219.284782250009, 6235.875282494325, 6195.008798592204, 6212.502999760009, 6259.061140828912, 6267.717952692049, 6298.118263443122, 6226.844328891723, 6303.212098487689, 6304.653244071528, 6321.1782468278825, 6322.241331040304, 4787.186178349689, 4817.421909370828, 4821.083994041121, 4825.469198388175, 4963.5780958618925, 3611.5846677631885, 3667.9266414672093, 4335.393044973706, 4465.508794032654, 4516.345129956138, 5168.405633352138, 5223.895522089613, 5598.10430331145, 5908.881822363529, 5951.077582974646, 6119.502553941423, 6203.689815509297, 6261.467775239064, 6268.4671802896355, 6268.905966410507, 4808.927866082012, 5668.688222147739, 5773.451522105393, 5785.913211301834, 5816.505597024216, 5461.0716178249795, 5475.67145971243, 5487.314085739283, 5493.615446918758, 5499.395066542677, 6368.713407896563, 6375.776847810304, 6384.744610215539, 6388.0, 6416.422521973045, 6126.456603435028, 6137.96931015342, 6170.50635949132, 6236.656983865931, 6266.809306231801, 6250.749970001331, 6253.093301471352, 6258.061290806416, 6285.277193122849, 6342.936570634234, 6051.576389652682, 6092.512598991982, 6163.445289923929, 6234.875302494015, 6242.250929888442, 6184.257889053162, 6209.813705588839, 6250.749970001149, 6277.089821975879, 6304.590201636879, 5934.19888315072, 6008.188894499187, 6206.751729930752, 6240.282367527792, 6250.406211409909, 6073.514118870391, 6075.726592303446, 6081.574289799849, 6091.390860913873, 6135.987562052212, 5217.373915130209, 6006.87986240264, 6045.455908968214, 6101.82280290701, 6104.519788040188, 6167.105769663463, 6191.133241346125, 6198.907016394848, 6202.317745048132, 6238.313785483684, 5754.5684073695475, 6008.03871380577, 6065.0, 6065.120557519223, 6088.452039316483], "value": 5697.228557783624, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.0759458933535, 460.83870645274146, 489.81387072912287, 515.4793658405011, 543.630331374665, 35713.64286357136, 39945.60054399455, 40241.99395015126, 40244.39633405501, 40253.7987310063, 40546.59453405465, 40710.59289407105, 40979.38530922031, 41065.0, 41165.17669646605, 8370.204830541088, 8721.0, 9340.766480837965, 9547.474888881108, 9561.139497445229, 11200.439978001108, 11488.712782180428, 11548.133889958244, 11671.299722016705, 11685.123615728811, 11435.599754008612, 11455.770884582304, 11493.425328733572, 11517.712057198596, 11517.942410287937, 11293.265937714023, 11407.54369825206, 11420.314781113118, 11443.656690299304, 11455.31268123907, 11294.040006599449, 11347.26242794224, 11365.829512557319, 11383.03244224242, 11385.316880987168, 38745.41881871774, 38778.80610596957, 38975.805120974495, 39026.60973390258, 39055.60944390548, 3301.6863397977154, 3444.50054742061, 3447.77589456687, 3501.842417091237, 3936.9015774605577, 29308.0, 29765.107046788413, 29955.850220748976, 30052.54921176184, 30330.84834575813, 2756.710545392745, 2850.330172409482, 3171.540126681641, 3193.0, 3267.134209434502, 339883.0, 447988.0, 452342.0, 452362.0, 454621.7268913667, 52158.21762673487, 52423.47576524262, 52454.213186802226, 52659.73670131625, 56377.154342684895, 57616.42383576195, 57849.71075144597, 57932.0, 58006.129908051415, 58103.70948145232, 15184.620384490476, 15612.0, 15654.530364088867, 15656.4520241791, 15676.764848527282, 11169.218154729253, 11422.485988130555, 12036.759264814655, 12247.877521224673, 12346.81479777804, 14439.917006224576, 14472.927635361966, 14482.565523034325, 14615.488457903923, 14652.706945861022, 6323.336049714806, 7201.675924583406, 7315.085614298213, 7375.704971801175, 7394.926050739424, 823.3289868756943, 934.5327336331834, 950.2398081534744, 1028.840529717895, 1113.0383071510018, 28130.578041329398, 29398.41203175967, 29645.851770741006, 29891.103266902028, 30137.69862301349, 975.2393133355994, 1044.3316277582353, 1058.6339531147878, 1066.2855886556026, 1082.783443311325, 13458.461661533429, 14926.0, 15476.535703928901, 15485.612859678598, 15593.376264949275, 525249.0, 556080.0, 615145.0, 616644.0, 619362.0, 57020.0, 57376.0, 57536.71231643815, 57583.424165758646, 57663.423365765804, 1331.3542931678128, 1365.487942021742, 1392.8955328350414, 1394.5955672854961, 1397.4340392140996, 28602.14193574196, 29631.407371852874, 29650.703492964793, 30081.69918300789, 30099.699003010566, 39388.212235755695, 44315.77842110769, 48176.75911620419, 48666.78333041702, 48779.0, 563440.0, 565333.0, 566283.0, 567263.0, 568182.0, 23809.9285532148, 24466.755332446446, 24477.87761061183, 38661.80669096637, 38977.80511097427, 40473.39289910595, 41114.38328425136, 41653.0, 42089.0, 42121.78939105407, 28160.71839281663, 34588.48117278293, 34645.0, 34814.65185348114, 35533.289334212655, 34378.312433751686, 34489.65510344865, 35173.12067198238, 35362.823185883906, 35694.0, 33629.83185084059, 33949.83025084859, 34020.829895851355, 34280.485792713625, 34472.31055378828, 31034.379312414076, 31136.22159446032, 31181.72591877911, 31222.531662025543, 31254.0, 23471.530569388175, 23670.52658946846, 23862.403439914142, 24129.276121716375, 24285.271441856774], "value": 19403.30158102242, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.36448364982584, 300.58369158715175, 367.04751170712, 367.9448082787582, 391.23318296139564, 18866.962317072557, 19896.005199740008, 20330.89834550827, 20541.897290513563, 20552.897235513803, 11663.475143618536, 16310.102944338058, 18565.443036708886, 19178.23287068519, 19350.032498375094, 4365.9563404365945, 5338.893222135555, 5352.732363381835, 5354.437784032679, 5360.115580929161, 5249.947500525003, 5331.333583302087, 5468.56251499881, 5760.452756988079, 5806.303243610772, 5808.3030036395485, 5810.506106980912, 5819.738111784959, 5820.941790582104, 5830.183774271605, 5786.71066446676, 5842.5910186286765, 6000.129981152731, 6005.519558435359, 6058.787942421994, 5593.496585307301, 5854.590178687494, 5858.2677165354335, 5876.353601103875, 5881.206037184968, 12749.0, 12974.962003039735, 13083.280419576919, 13087.934560327138, 13091.607251782461, 1987.6620974434381, 2078.272604588397, 2140.422086036777, 2154.590627780732, 2259.7853203945597, 9713.36863103896, 9851.261155413373, 10042.748931276703, 10248.74378140545, 10250.179985601135, 1542.6991736611365, 1858.2659849359563, 1895.9336423225259, 1906.5996140810446, 1912.8660993730443, 108366.0, 114993.42503287431, 125050.74949250482, 126339.10491342637, 128472.0, 9178.31162662803, 9991.200703943667, 11376.658700239006, 11439.199256051996, 11573.710657233469, 14335.56993290203, 14342.426302947973, 14349.928250358682, 14361.856381436051, 14385.92807035979, 7510.1363343215135, 8091.919080809234, 8204.825721183892, 8333.0, 8453.66185352579, 8160.918390816135, 8196.631151598192, 8240.587970601446, 8326.292265157408, 8345.374096942754, 4317.740935543878, 4495.775211239425, 4535.954640453553, 4556.498785133633, 4605.125026245069, 1926.2776458827939, 1956.31984181672, 1981.5739615982634, 2003.7094621279832, 2004.2584243829585, 823.818759872839, 885.1677028550966, 930.9162175404247, 960.4477425480377, 963.9252233759308, 19451.51371215731, 20120.798792012185, 20208.29270975509, 20269.0, 20446.284380046625, 924.2421214604094, 935.2658163341744, 962.2302158273493, 967.9032096790264, 986.9309148359689, 10382.377057376581, 10754.784904302027, 10759.3544387337, 10773.83839242412, 10786.514606842555, 440536.0, 467585.66207168746, 469171.0, 509259.0, 512154.0, 78190.60904695553, 103595.0, 132316.0, 134827.325863372, 134993.0, 893.6380765789866, 1002.8867956568204, 1035.963741269052, 1043.8569766106102, 1044.185535282481, 17427.47717568475, 18440.631187375908, 18571.44285671432, 18699.06504674788, 18784.0, 49914.00171996612, 52506.73746631242, 52524.474755251955, 53500.4649953511, 54240.0, 65345.346546533925, 77279.0, 77629.22370776445, 77983.2201677976, 79980.0, 6035.969820150871, 7236.782896512902, 7386.335229829341, 7856.332211762065, 8403.95798021006, 12388.938055309665, 12637.0, 12988.155769874928, 13228.801567976296, 13259.812130998278, 10666.040056394962, 10757.031867131996, 11129.610463633733, 11307.717307067389, 11397.202195846543, 9877.567752675677, 10017.69946901594, 10575.259731818698, 10873.673789786319, 11118.221724479208, 11224.38265895351, 11254.21220514556, 11543.595974140864, 11620.012298954684, 11733.120015998664, 7207.459440541876, 7336.7798966031105, 7434.36807871337, 7436.814079648052, 7465.738699145504, 10943.0, 11184.552617895193, 11274.162634401919, 11325.433728313716, 11331.773364532828], "value": 9075.7534109055, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.224671936996, 1511.9622009449765, 1670.2734310574901, 1776.3516316544465, 1817.4638481647912, 7381.483296169257, 7593.468457207998, 7862.685492580297, 8292.792680182998, 8300.460470069449, 7789.6494657740395, 8070.596470176482, 8086.150954149818, 8133.552654603995, 8161.2246836550585, 1809.9004554749483, 1830.4508647405792, 2024.1903238704563, 2179.4769255378674, 2216.1910902520626, 1880.5956719305348, 2029.7564292284947, 2285.9657105143438, 2307.7807608277185, 2313.063209400187, 2228.1533017453426, 2236.9888150559304, 2255.8984845681985, 2269.8751568663715, 2270.409693479699, 1851.9722204166949, 1898.933537326187, 2238.731352237726, 2271.931842044741, 2275.7041584594062, 2254.6472116729997, 2266.5693518231647, 2291.3126062181277, 2301.0795681727277, 2306.411864974421, 8119.106898241189, 8145.348372130275, 8177.018757749108, 8186.181381861826, 8192.098869124391, 4929.605631549467, 4994.150994330972, 5034.11902916988, 5064.848054558369, 5082.23766435034, 3238.724708399789, 3380.8140552269615, 3398.320335932823, 3406.7615266931325, 3443.6212016678396, 975.6195083917278, 1014.9289549731521, 1042.1402343067, 1047.8218702820539, 1050.7635781949, 10403.0, 10506.842397364046, 10525.21060920434, 10535.104516116216, 10557.524911379007, 3862.266169427856, 4224.239636865394, 4291.6566674665955, 4556.24821904382, 4596.724196548218, 8968.820623587622, 9054.139856713602, 9087.409318394282, 9136.360454768235, 9178.495182764878, 5072.112380333427, 5080.568151707146, 5089.389273287229, 5092.312537807423, 5095.082885080721, 4496.853302407865, 4558.270676691714, 4646.3495110684535, 4653.581177694024, 4682.555157260055, 3172.1118086935694, 3654.6528079832374, 3683.2265224303196, 3745.756525825867, 3764.0589852536864, 1239.6528971887885, 1246.1028059796931, 1248.1574936917543, 1252.3174869696038, 1254.3352023427415, 828.4656396624143, 857.9227869491775, 882.4881568690145, 887.5207388010531, 942.7643089227693, 5499.670019798825, 5574.609777315549, 5666.603337766317, 5716.1997320375185, 5723.313202415654, 881.6120906800987, 891.3804905590682, 905.5200743605899, 917.27535247154, 918.6049998500575, 3604.441311596707, 3751.662350388478, 3784.7918364489665, 3869.5356557212754, 3886.0090676877217, 9312.115349041831, 9612.471314077653, 9711.611535538499, 9731.854022189673, 9754.561044753003, 9677.951610242044, 9747.756306092404, 9768.853467197998, 9798.31411801167, 9805.0, 7265.963670181615, 7522.172561018284, 7563.924360756432, 7668.731594394281, 7675.846483070307, 5456.536194423518, 5491.0939694951485, 5533.972330138324, 5572.108462645957, 5662.603617746719, 7616.0, 8906.332025098014, 9039.819203616022, 9054.230390416888, 9144.954275228582, 8001.8399632008195, 9009.684661036832, 9134.862977055482, 9160.541972901196, 9291.535423228946, 5885.323187833454, 6843.041974123527, 7004.684789184397, 7014.684339204646, 7030.789076327718, 6012.977793774981, 6903.551269167488, 7577.924220757722, 7629.54222746637, 7690.0, 6688.3646053624825, 6775.356341147583, 6951.617661028692, 7007.614581198083, 7029.0, 6627.37039981201, 6642.4021838034805, 6790.558613690095, 6818.386345228953, 6888.276730943179, 6051.606645568024, 6521.64130972801, 6526.347365263436, 6532.444742196776, 6538.1500404947055, 4170.957260684829, 4198.181354635939, 4595.908081838277, 4750.667453278375, 4755.857324280277, 4668.883277917943, 4670.696404733817, 4728.054389122258, 4819.204831202953, 4901.387326584177], "value": 4266.81351630425, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.4051896207585, 326.4026830899454, 354.54618088846286, 355.8576569372252, 356.42081617371764, 4397.758123303217, 4510.278355463122, 4557.065801510691, 4923.82766603169, 5104.494174218605, 4637.443506779191, 5087.694738315704, 5351.57187425006, 5358.2498450217, 5415.404305526389, 3645.65366290202, 3944.9802750986205, 4126.339785634299, 4137.81379837908, 4163.666906647476, 3257.0066129830393, 3463.6882680558747, 4098.9590104099025, 4154.97922510387, 4163.666906647461, 3595.6044835068124, 3919.451276821233, 3980.800959952005, 3987.441758153861, 3989.2819292527333, 3326.76712630116, 4011.29802284599, 4013.899652508696, 4026.859059932888, 4056.6754659627454, 3460.3425349183576, 3464.9653503464897, 3479.460683594047, 3485.250671105699, 3487.7907325560545, 4825.986542826011, 5171.612129090333, 5259.947400526023, 5306.3632364116165, 5316.9202461963105, 3806.467094606757, 4020.175863947913, 4034.677225821927, 4218.831246750126, 4386.517483076859, 4162.708610397273, 4805.111054454902, 5029.5221953914315, 5662.66024038559, 5709.0, 3237.530558069067, 3642.8907132786057, 3779.848806047755, 3806.2958352704836, 3826.245103525457, 5305.867353316159, 5770.394108618577, 5805.970970145122, 5866.354700982888, 5888.705564721747, 3674.622016743721, 3681.5582130144016, 3796.1648437343742, 3834.7123965702685, 3841.4814000109627, 3409.5226668266464, 3441.8451169697423, 3899.6100389960775, 3909.6090390961244, 3920.843166273374, 3931.5282166140246, 4303.33298338758, 4506.662000349987, 4509.27851543758, 4537.0, 4434.800433980478, 4869.586085182799, 5520.06158952979, 5600.831975040755, 5622.184783206494, 1059.4067322299536, 1097.0729733375285, 1143.6454699043156, 1218.451696736472, 1245.588955644635, 796.7649543384715, 834.5145640759458, 848.5587494502824, 856.6873091321747, 857.6140736668399, 4375.912481750347, 5097.286379906816, 5101.897962040813, 5126.5898728101665, 5186.521841275218, 4685.929711054337, 5248.606354523426, 5314.362276526842, 5543.334799823966, 5595.356533998561, 4528.46032349003, 4561.68068235227, 4713.528647135259, 4950.727709975914, 5055.494450554915, 2903.535434330497, 2918.7081291870645, 2927.3413481966386, 2932.780041496896, 2937.485939960541, 5621.662700237917, 5672.9221447924765, 5706.686132262683, 5721.485066344049, 5803.359471440484, 5120.849243317741, 5326.6005049621435, 5458.6724796512335, 5686.97156514223, 5714.5999780015, 4824.421069471686, 5248.816291429782, 5333.919991200135, 5756.280464941882, 6048.697565121726, 4268.615824575803, 4761.476237613929, 4948.406191256928, 5305.9469405307, 5583.0787919992745, 4905.386826646669, 5229.947700523098, 5232.659877107976, 5267.23392774153, 5699.800506982236, 5289.867753306198, 5770.480656740913, 5871.328545511697, 5963.642181469126, 5967.283925928917, 3206.903792886217, 3615.457681347819, 3810.714196435223, 3811.0, 3825.8660946866726, 4693.366395536559, 5683.488486036111, 5732.856678583069, 5750.568707347049, 5782.681952492485, 4640.559146881041, 5364.222187782671, 5501.697406642673, 5508.283923090133, 5664.0459041630575, 4736.668433209642, 4908.509149085063, 5042.798288068436, 5695.544356451391, 5698.430156984268, 4843.740627436962, 4936.333594964777, 4948.950510494849, 5094.872628184325, 5536.979002664079, 4863.613870047161, 5681.801136960186, 5735.311762588516, 5765.423457654201, 5766.769329226784, 5604.215409842707, 5608.971955140199, 5611.3266408031295, 5612.550995920398, 5638.85902852432], "value": 3977.130570323385, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.5437638346884, 727.4180655475618, 743.2196193996303, 752.7327798631486, 821.4291067707943, 15064.698706025887, 15629.452969146083, 15702.76445853313, 15750.921245393785, 15760.133192674399, 11093.55625774968, 11963.282203067822, 12244.142909996304, 12412.565560205394, 14346.641333966656, 683.6103421050003, 703.989440158398, 851.4167795060373, 873.7335112790628, 886.6320477002037, 816.9019717633862, 836.5817091454273, 879.4679219072465, 879.6041781198454, 881.154092071612, 915.4095608332622, 928.2759447630858, 938.5307346326837, 939.4738946190155, 941.7221919533754, 928.308410234373, 931.0689310689311, 932.9626814927394, 934.4720233068294, 935.8175155844579, 696.9372756451893, 697.4211404534225, 697.4559843322166, 697.769735987123, 698.7449580902985, 14591.635209119751, 15162.0, 15218.163001034938, 15577.0, 15836.841631583651, 13913.373898174606, 14545.27273636314, 14557.490487832874, 14669.0, 14678.412863485448, 10850.620228292051, 11758.706032349173, 11802.704932376673, 11818.231814932087, 11854.466549005316, 3749.793761343125, 3770.7549009314307, 3782.2624588205313, 3795.810209489542, 3913.412988051815, 105943.47028264886, 107828.66022031104, 109628.15736643893, 110223.0, 111334.44332778447, 9160.81678366429, 11104.222704410613, 11197.104231661448, 11208.27146235492, 11430.142739294586, 23171.420714481934, 23390.415239619146, 23455.7654423457, 23460.882695586413, 23467.88266058693, 7841.490303130278, 7871.84256314882, 7895.802604934923, 8050.677972881019, 8166.142555031636, 4097.201045796041, 4335.111302183108, 4346.739195648272, 4395.7142785718825, 4464.638285323008, 3443.362977849106, 3520.4543295789194, 3529.0, 3687.815609219528, 3873.922521549553, 661.1240106858336, 691.94810389221, 697.7034760226883, 707.9044329015517, 708.3837061756202, 572.8625129968777, 632.7469012395079, 637.4040272345372, 656.1011414362259, 656.8554917918051, 8798.560071996375, 9169.587368568431, 9265.397749146285, 9405.57674904631, 9419.529023548796, 578.8654237694083, 622.2595111816923, 635.7520566978882, 654.6890227142069, 668.5387082912774, 4372.519022907478, 4405.29515277554, 4644.628429725682, 4697.882552936136, 4742.857714268577, 108158.0, 111542.0, 112293.0, 112707.0, 112807.4359628213, 89609.75975600531, 96871.0, 97323.02676973281, 99104.0, 100840.0, 85506.0, 87130.0, 87589.12410875937, 87595.56202218948, 89584.0, 8845.778855528662, 8855.91144088551, 8963.955180224319, 8981.416207946462, 9094.59074341643, 44205.0, 47545.76227118981, 47596.0, 49059.0, 56624.716876417006, 49740.25389619231, 54924.725376372866, 62895.742085158956, 63223.0, 64414.677926610064, 10838.0, 10872.238943273895, 13141.110352015414, 13220.206787592775, 13554.322283885569, 14464.059836110619, 14476.493322733653, 14653.487127950471, 14804.777928330868, 14824.332905019515, 13482.393292301675, 13585.932070339584, 13618.93190534041, 14405.351759170653, 14427.134371937716, 13448.865511344762, 13536.120152190077, 13628.591142265748, 13631.591052268448, 13674.658133546742, 11341.206115571831, 13215.0, 13500.0, 13744.587662370144, 13847.169169849842, 11218.382988935688, 11249.718757030812, 11289.37908415045, 11318.547258109584, 11459.713507162387, 9436.52817359143, 11188.135094862286, 11504.137189710638, 11560.768784624428, 11576.36330001858], "value": 7504.786777117564, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1595.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 119.0, 121.0, 119.0, 119.0, 119.0, 118.0, 119.0, 118.0, 119.0], "value": 117.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 106.0, 115.0, 146.0, 112.0, 144.0, 143.0, 112.0, 131.0, 114.0], "value": 127.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 202.0, 212.0, 259.0, 248.0, 198.0, 194.0, 196.0, 199.0, 193.0], "value": 209.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 60.0, 62.0, 83.0, 60.0, 64.0, 74.0, 51.0, 91.0, 51.0], "value": 68.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 97.0, 115.0, 84.0, 70.0, 72.0, 81.0, 70.0, 71.0, 103.0], "value": 85.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 166.0, 112.0, 160.0, 162.0, 113.0, 164.0, 144.0, 113.0], "value": 135.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 133.0, 107.0, 151.0, 106.0, 98.0, 95.0, 110.0, 152.0], "value": 114.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 151.0, 91.0, 93.0, 93.0, 91.0, 94.0, 91.0, 93.0, 93.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 57.0, 58.0, 59.0, 59.0, 58.0, 59.0, 58.0, 58.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 106.0, 68.0, 78.0, 74.0, 70.0, 68.0, 71.0, 76.0, 71.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 90.0, 91.0, 86.0, 89.0, 87.0, 89.0, 76.0, 112.0, 112.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 138.0, 143.0, 153.0, 162.0, 157.0, 152.0, 153.0, 185.0, 155.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 184.0, 239.0, 211.0, 175.0, 175.0, 188.0, 181.0, 239.0], "value": 193.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 70.0, 66.0, 68.0, 67.0, 68.0, 68.0, 66.0, 69.0], "value": 67.7, "unit": "score"}]}]} 17:58:41 INFO - Return code: 0 17:58:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:58:41 ERROR - # TBPL SUCCESS # 17:58:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:58:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:58:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:58:41 INFO - 2016-12-16 17:58:41.631 screenresolution[2013:22917] starting screenresolution argv=screenresolution get 17:58:41 INFO - 2016-12-16 17:58:41.634 screenresolution[2013:22917] Display 0: 1600x1200x32@60 17:58:41 INFO - 2016-12-16 17:58:41.640 screenresolution[2014:22920] starting screenresolution argv=screenresolution list 17:58:41 INFO - Available Modes on Display 0 17:58:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:58:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:58:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:58:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:58:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:58:41 INFO - Intel Iris: 17:58:41 INFO - Chipset Model: Intel Iris 17:58:41 INFO - Type: GPU 17:58:41 INFO - Bus: Built-In 17:58:41 INFO - VRAM (Dynamic, Max): 1536 MB 17:58:41 INFO - Vendor: Intel (0x8086) 17:58:41 INFO - Device ID: 0x0a2e 17:58:41 INFO - Revision ID: 0x0009 17:58:41 INFO - Displays: 17:58:41 INFO - Display: 17:58:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:58:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:58:41 INFO - Display Serial Number: 1600x1200 60 17:58:41 INFO - Main Display: Yes 17:58:41 INFO - Mirror: Off 17:58:41 INFO - Online: Yes 17:58:41 INFO - Rotation: Supported 17:58:41 INFO - Return code: 0 17:58:41 INFO - Running post-action listener: _resource_record_post_action 17:58:41 INFO - [mozharness: 2016-12-17 01:58:41.882222Z] Finished run-tests step (success) 17:58:41 INFO - Running post-run listener: _resource_record_post_run 17:58:41 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 31461888; Write bytes: 554844160; Read time: 292; Write time: 1752 17:58:41 INFO - TinderboxPrint: CPU usage
54.6% 17:58:41 INFO - TinderboxPrint: I/O read bytes / time
31,461,888 / 292 17:58:41 INFO - TinderboxPrint: I/O write bytes / time
554,844,160 / 1,752 17:58:41 INFO - TinderboxPrint: CPU idle
2,181.8 (45.4%) 17:58:41 INFO - TinderboxPrint: CPU system
970.4 (20.2%) 17:58:41 INFO - TinderboxPrint: CPU user
1,649.5 (34.4%) 17:58:41 INFO - TinderboxPrint: Swap in / out
275,275,776 / 0 17:58:41 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 247343616; Write bytes: 239915008; Read time: 18141; Write time: 434 17:58:41 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 29446656; Write bytes: 301967360; Read time: 279; Write time: 1260 17:58:42 INFO - Running post-run listener: _upload_blobber_files 17:58:42 INFO - Blob upload gear active. 17:58:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:58:42 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:58:42 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:58:42 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:58:42 INFO - (blobuploader) - INFO - Open directory for files ... 17:58:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:58:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:58:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:58:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:58:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:58:43 INFO - (blobuploader) - INFO - Done attempting. 17:58:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:58:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:58:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:58:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:58:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:58:44 INFO - (blobuploader) - INFO - Done attempting. 17:58:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:58:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:58:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:58:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:58:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:58:46 INFO - (blobuploader) - INFO - Done attempting. 17:58:46 INFO - (blobuploader) - INFO - Iteration through files over. 17:58:46 INFO - Return code: 0 17:58:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:58:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:58:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ac45872f8412b060caba260e4485fad25082bf4474a8fe7868746ebcce1db1428f4fc3023348050aad1dcee051d0a37bd8ccb18848bcc518d5809ff6caa9011", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/963eba7197e8f6d61d0b4fbf1c7a126612b1b898444b0cf420d00b8ff14f156f592a53bb2e2359ab91aa61490692768f57b41cd21bfc734661469868eaa51abd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16a66c3d17dcd4fce60955aba235541bb7e6c7827514c84069c3951265d276d833b7a51be4d2170b774c83759927af7e7b007ddc10793bd68d3a725ffa23f016"} 17:58:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:58:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:58:46 INFO - Contents: 17:58:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ac45872f8412b060caba260e4485fad25082bf4474a8fe7868746ebcce1db1428f4fc3023348050aad1dcee051d0a37bd8ccb18848bcc518d5809ff6caa9011", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/963eba7197e8f6d61d0b4fbf1c7a126612b1b898444b0cf420d00b8ff14f156f592a53bb2e2359ab91aa61490692768f57b41cd21bfc734661469868eaa51abd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16a66c3d17dcd4fce60955aba235541bb7e6c7827514c84069c3951265d276d833b7a51be4d2170b774c83759927af7e7b007ddc10793bd68d3a725ffa23f016"} 17:58:46 INFO - Running post-run listener: copy_logs_to_upload_dir 17:58:46 INFO - Copying logs to upload dir... 17:58:46 INFO - mkdir: /builds/slave/test/build/upload/logs 17:58:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.123703 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-12-16 17:58:46.935538) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-16 17:58:46.939327) ========= 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.wrKZObUc10/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.KM6c3gMWlQ/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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/8ac45872f8412b060caba260e4485fad25082bf4474a8fe7868746ebcce1db1428f4fc3023348050aad1dcee051d0a37bd8ccb18848bcc518d5809ff6caa9011", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/963eba7197e8f6d61d0b4fbf1c7a126612b1b898444b0cf420d00b8ff14f156f592a53bb2e2359ab91aa61490692768f57b41cd21bfc734661469868eaa51abd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16a66c3d17dcd4fce60955aba235541bb7e6c7827514c84069c3951265d276d833b7a51be4d2170b774c83759927af7e7b007ddc10793bd68d3a725ffa23f016"} build_url:https://queue.taskcluster.net/v1/task/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011201 build_url: 'https://queue.taskcluster.net/v1/task/NfPvPLMyRjqy60txOJdEYA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ac45872f8412b060caba260e4485fad25082bf4474a8fe7868746ebcce1db1428f4fc3023348050aad1dcee051d0a37bd8ccb18848bcc518d5809ff6caa9011", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/963eba7197e8f6d61d0b4fbf1c7a126612b1b898444b0cf420d00b8ff14f156f592a53bb2e2359ab91aa61490692768f57b41cd21bfc734661469868eaa51abd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/16a66c3d17dcd4fce60955aba235541bb7e6c7827514c84069c3951265d276d833b7a51be4d2170b774c83759927af7e7b007ddc10793bd68d3a725ffa23f016"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-16 17:58:46.973713) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 17:58:46.974083) ========= 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.wrKZObUc10/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.KM6c3gMWlQ/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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.005043 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-16 17:58:47.022956) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-16 17:58:47.023299) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-16 17:58:47.023643) ========= ========= Total master_lag: 1.57 =========