builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0309 starttime: 1480547010.11 results: success (0) buildid: 20161130125344 builduid: ef5ab7fcfcfe4e8b836d8c561d6c9051 revision: 8f1e420699832d42753c6503aa31861be6f5b186 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 15:03:30.111691) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 15:03:30.112115) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 15:03:30.112405) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 15:03:30.144816) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 15:03:30.145200) ========= 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.dh4MIzlSIG/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.mTptfWQ2wa/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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-11-30 15:03:30-- 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% 184M=0s 2016-11-30 15:03:30 (184 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.111725 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 15:03:30.280844) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 15:03:30.281151) ========= 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.dh4MIzlSIG/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.mTptfWQ2wa/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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.026450 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 15:03:30.333054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-30 15:03:30.333414) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8f1e420699832d42753c6503aa31861be6f5b186 --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 8f1e420699832d42753c6503aa31861be6f5b186 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dh4MIzlSIG/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.mTptfWQ2wa/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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-11-30 15:03:30,441 truncating revision to first 12 chars 2016-11-30 15:03:30,441 Setting DEBUG logging. 2016-11-30 15:03:30,441 attempt 1/10 2016-11-30 15:03:30,441 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8f1e42069983?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-30 15:03:31,870 unpacking tar archive at: mozilla-central-8f1e42069983/testing/mozharness/ program finished with exit code 0 elapsedTime=1.707240 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-30 15:03:32.067135) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 15:03:32.067467) ========= script_repo_revision: 8f1e420699832d42753c6503aa31861be6f5b186 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 15:03:32.067844) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 15:03:32.068106) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 15:03:32.089708) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-30 15:03:32.090090) ========= /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.dh4MIzlSIG/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.mTptfWQ2wa/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15:03:32 INFO - MultiFileLogger online at 20161130 15:03:32 in /builds/slave/test 15:03:32 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 15:03:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:03:32 INFO - {'append_to_log': False, 15:03:32 INFO - 'base_work_dir': '/builds/slave/test', 15:03:32 INFO - 'blob_upload_branch': 'Firefox', 15:03:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:03:32 INFO - 'branch': 'Firefox', 15:03:32 INFO - 'buildbot_json_path': 'buildprops.json', 15:03:32 INFO - 'config_files': ('talos/mac_config.py',), 15:03:32 INFO - 'default_actions': ('clobber', 15:03:32 INFO - 'read-buildbot-config', 15:03:32 INFO - 'download-and-extract', 15:03:32 INFO - 'populate-webroot', 15:03:32 INFO - 'create-virtualenv', 15:03:32 INFO - 'install', 15:03:32 INFO - 'run-tests'), 15:03:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:03:32 INFO - 'download_minidump_stackwalk': True, 15:03:32 INFO - 'download_symbols': 'ondemand', 15:03:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:03:32 INFO - 'tooltool.py': '/tools/tooltool.py', 15:03:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:03:32 INFO - '/tools/misc-python/virtualenv.py')}, 15:03:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:03:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:03:32 INFO - 'installer_path': 'installer.exe', 15:03:32 INFO - 'log_level': 'info', 15:03:32 INFO - 'log_name': 'talos', 15:03:32 INFO - 'log_to_console': True, 15:03:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:03:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:03:32 INFO - 'opt_config_files': (), 15:03:32 INFO - 'pip_index': False, 15:03:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:03:32 INFO - 'cmd': ('bash', 15:03:32 INFO - '-c', 15:03:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:03:32 INFO - 'enabled': True, 15:03:32 INFO - 'halt_on_failure': False, 15:03:32 INFO - 'name': 'check_screen_resolution'},), 15:03:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:03:32 INFO - 'cmd': ('bash', 15:03:32 INFO - '-c', 15:03:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:03:32 INFO - 'enabled': True, 15:03:32 INFO - 'halt_on_failure': False, 15:03:32 INFO - 'name': 'check_screen_resolution'},), 15:03:32 INFO - 'run_cmd_checks_enabled': True, 15:03:32 INFO - 'sps_profile': False, 15:03:32 INFO - 'sps_profile_interval': 0, 15:03:32 INFO - 'suite': 'dromaeojs-e10s', 15:03:32 INFO - 'system_bits': '32', 15:03:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:03:32 INFO - 'title': 't-yosemite-r7-0309', 15:03:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:03:32 INFO - 'use_talos_json': True, 15:03:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:03:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:03:32 INFO - 'work_dir': 'build'} 15:03:32 INFO - [mozharness: 2016-11-30 23:03:32.297215Z] Running clobber step. 15:03:32 INFO - Running pre-action listener: _resource_record_pre_action 15:03:32 INFO - Running main action method: clobber 15:03:32 INFO - rmtree: /builds/slave/test/build 15:03:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:03:34 INFO - Running post-action listener: _resource_record_post_action 15:03:34 INFO - [mozharness: 2016-11-30 23:03:34.281815Z] Finished clobber step (success) 15:03:34 INFO - [mozharness: 2016-11-30 23:03:34.281937Z] Running read-buildbot-config step. 15:03:34 INFO - Running pre-action listener: _resource_record_pre_action 15:03:34 INFO - Running main action method: read_buildbot_config 15:03:34 INFO - Using buildbot properties: 15:03:34 INFO - { 15:03:34 INFO - "project": "", 15:03:34 INFO - "product": "firefox", 15:03:34 INFO - "script_repo_revision": "production", 15:03:34 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 15:03:34 INFO - "repository": "", 15:03:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 15:03:34 INFO - "buildid": "20161130125344", 15:03:34 INFO - "pgo_build": "False", 15:03:34 INFO - "basedir": "/builds/slave/test", 15:03:34 INFO - "buildnumber": 184, 15:03:34 INFO - "slavename": "t-yosemite-r7-0309", 15:03:34 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 15:03:34 INFO - "platform": "yosemite_r7", 15:03:34 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 15:03:34 INFO - "branch": "mozilla-central", 15:03:34 INFO - "repo_path": "mozilla-central", 15:03:34 INFO - "revision": "8f1e420699832d42753c6503aa31861be6f5b186", 15:03:34 INFO - "stage_platform": "macosx64", 15:03:34 INFO - "builduid": "ef5ab7fcfcfe4e8b836d8c561d6c9051", 15:03:34 INFO - "slavebuilddir": "test" 15:03:34 INFO - } 15:03:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 15:03:34 INFO - Running post-action listener: _resource_record_post_action 15:03:34 INFO - [mozharness: 2016-11-30 23:03:34.285169Z] Finished read-buildbot-config step (success) 15:03:34 INFO - [mozharness: 2016-11-30 23:03:34.285290Z] Running download-and-extract step. 15:03:34 INFO - Running pre-action listener: _resource_record_pre_action 15:03:34 INFO - Running main action method: download_and_extract 15:03:34 INFO - mkdir: /builds/slave/test/build/tests 15:03:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:34 INFO - trying https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 15:03:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/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 15:03:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/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 15:03:35 INFO - Downloaded 1199 bytes. 15:03:35 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 15:03:35 INFO - Using the following test package requirements: 15:03:35 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 15:03:35 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:03:35 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 15:03:35 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:03:35 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 15:03:35 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:03:35 INFO - u'jsshell-mac.zip'], 15:03:35 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:03:35 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 15:03:35 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 15:03:35 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:03:35 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 15:03:35 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:03:35 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 15:03:35 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:03:35 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 15:03:35 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 15:03:35 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 15:03:35 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:03:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 15:03:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:03:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 15:03:36 INFO - Expected file size: 16275427 15:03:36 INFO - Obtained file size: 16275427 15:03:42 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 15:03:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 15:03:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:03:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 15:03:43 INFO - Expected file size: 16275427 15:03:43 INFO - Obtained file size: 16275427 15:03:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 15:03:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:03:49 INFO - Fetch https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 15:03:51 INFO - Expected file size: 14409702 15:03:51 INFO - Obtained file size: 14409702 15:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:51 INFO - trying https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:03:51 INFO - Downloading https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 15:03:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/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 15:03:54 INFO - Downloaded 107597768 bytes. 15:03:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:03:54 INFO - mkdir: /builds/slave/test/properties 15:03:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:03:54 INFO - Writing to file /builds/slave/test/properties/build_url 15:03:54 INFO - Contents: 15:03:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 15:03:54 INFO - Running post-action listener: _resource_record_post_action 15:03:54 INFO - Running post-action listener: set_extra_try_arguments 15:03:54 INFO - [mozharness: 2016-11-30 23:03:54.870204Z] Finished download-and-extract step (success) 15:03:54 INFO - [mozharness: 2016-11-30 23:03:54.870327Z] Running populate-webroot step. 15:03:54 INFO - Running pre-action listener: _resource_record_pre_action 15:03:54 INFO - Running main action method: populate_webroot 15:03:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:03:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:03:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:03:54 INFO - '--tppagecycles', 15:03:54 INFO - '7'], 15:03:54 INFO - 'tests': ['tsvgm']}}, 15:03:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:03:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:03:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:03:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:03:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:03:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:03:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:03:54 INFO - 'talos_options': ['--disable-e10s'], 15:03:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:03:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:03:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:03:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:03:54 INFO - 'talos_options': ['--disable-e10s'], 15:03:54 INFO - 'tests': ['damp', 'tps']}, 15:03:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:03:54 INFO - 'tests': ['damp', 'tps']}, 15:03:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:03:54 INFO - 'tests': ['dromaeo_dom']}, 15:03:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:03:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:03:54 INFO - 'tests': ['basic_compositor_video']}, 15:03:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:03:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:03:54 INFO - 'tests': ['a11yr', 15:03:54 INFO - 'ts_paint', 15:03:54 INFO - 'tpaint', 15:03:54 INFO - 'sessionrestore', 15:03:54 INFO - 'sessionrestore_no_auto_restore', 15:03:54 INFO - 'tabpaint']}, 15:03:54 INFO - 'other-e10s': {'tests': ['a11yr', 15:03:54 INFO - 'ts_paint', 15:03:54 INFO - 'tpaint', 15:03:54 INFO - 'sessionrestore', 15:03:54 INFO - 'sessionrestore_no_auto_restore', 15:03:54 INFO - 'tabpaint']}, 15:03:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:03:54 INFO - 'ts_paint', 15:03:54 INFO - 'tpaint', 15:03:54 INFO - 'sessionrestore', 15:03:54 INFO - 'sessionrestore_no_auto_restore', 15:03:54 INFO - 'tabpaint']}, 15:03:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:03:54 INFO - 'ts_paint', 15:03:54 INFO - 'tpaint', 15:03:54 INFO - 'sessionrestore', 15:03:54 INFO - 'sessionrestore_no_auto_restore', 15:03:54 INFO - 'tabpaint']}, 15:03:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:03:54 INFO - 'tests': ['a11yr', 15:03:54 INFO - 'ts_paint', 15:03:54 INFO - 'tpaint', 15:03:54 INFO - 'sessionrestore', 15:03:54 INFO - 'sessionrestore_no_auto_restore', 15:03:54 INFO - 'tabpaint']}, 15:03:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:03:54 INFO - 'tests': ['a11yr', 15:03:54 INFO - 'ts_paint', 15:03:54 INFO - 'tpaint', 15:03:54 INFO - 'sessionrestore', 15:03:54 INFO - 'sessionrestore_no_auto_restore', 15:03:54 INFO - 'tabpaint']}, 15:03:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:03:54 INFO - 'tests': ['tsvgx', 15:03:54 INFO - 'tsvgr_opacity', 15:03:54 INFO - 'tart', 15:03:54 INFO - 'tscrollx', 15:03:54 INFO - 'cart', 15:03:54 INFO - 'tsvg_static']}, 15:03:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:03:54 INFO - 'tsvgr_opacity', 15:03:54 INFO - 'tart', 15:03:54 INFO - 'tscrollx', 15:03:54 INFO - 'cart', 15:03:54 INFO - 'tsvg_static']}, 15:03:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:03:54 INFO - 'talos_options': ['--disable-e10s'], 15:03:54 INFO - 'tests': ['tp5o']}, 15:03:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:03:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:03:54 INFO - 'talos_options': ['--disable-e10s', 15:03:54 INFO - '--xperf_path', 15:03:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:03:54 INFO - 'tests': ['tp5n']}, 15:03:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:03:54 INFO - 'talos_options': ['--xperf_path', 15:03:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:03:54 INFO - 'tests': ['tp5n']}}, 15:03:54 INFO - 'talos.zip': {'path': '', 15:03:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:03:54 INFO - Running post-action listener: _resource_record_post_action 15:03:54 INFO - [mozharness: 2016-11-30 23:03:54.888853Z] Finished populate-webroot step (success) 15:03:54 INFO - [mozharness: 2016-11-30 23:03:54.888993Z] Running create-virtualenv step. 15:03:54 INFO - Running pre-action listener: _resource_record_pre_action 15:03:54 INFO - Running main action method: create_virtualenv 15:03:54 INFO - Creating virtualenv /builds/slave/test/build/venv 15:03:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:03:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:03:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:03:55 INFO - Using real prefix '/tools/python27' 15:03:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:03:55 INFO - Installing distribute.............................................................................................................................................................................................done. 15:03:58 INFO - Installing pip.................done. 15:03:58 INFO - Return code: 0 15:03:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:03:58 INFO - Reading from file tmpfile_stdout 15:03:58 INFO - Output received: 15:03:58 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:03:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:58 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 0x1102f13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110267570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2985ab880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110107d30>, '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 0x10ff6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100ffb20>, '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.dh4MIzlSIG/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.mTptfWQ2wa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:03:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dh4MIzlSIG/Render', 15:03:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:03:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:03:58 INFO - 'HOME': '/Users/cltbld', 15:03:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:03:58 INFO - 'LOGNAME': 'cltbld', 15:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:58 INFO - 'MOZ_NO_REMOTE': '1', 15:03:58 INFO - 'NO_EM_RESTART': '1', 15:03:58 INFO - 'PAGER': '/bin/cat', 15:03:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:58 INFO - 'PWD': '/builds/slave/test', 15:03:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:03:58 INFO - 'SHELL': '/bin/bash', 15:03:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mTptfWQ2wa/Listeners', 15:03:58 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 15:03:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:03:58 INFO - 'USER': 'cltbld', 15:03:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:03:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:58 INFO - 'XPC_FLAGS': '0x0', 15:03:58 INFO - 'XPC_SERVICE_NAME': '0', 15:03:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:03:59 INFO - Cleaning up... 15:03:59 INFO - Return code: 0 15:03:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:03:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:03:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:03:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:03:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1102f13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110267570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2985ab880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110107d30>, '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 0x10ff6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100ffb20>, '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.dh4MIzlSIG/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.mTptfWQ2wa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:03:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:03:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dh4MIzlSIG/Render', 15:03:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:03:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:03:59 INFO - 'HOME': '/Users/cltbld', 15:03:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:03:59 INFO - 'LOGNAME': 'cltbld', 15:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:03:59 INFO - 'MOZ_NO_REMOTE': '1', 15:03:59 INFO - 'NO_EM_RESTART': '1', 15:03:59 INFO - 'PAGER': '/bin/cat', 15:03:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:03:59 INFO - 'PWD': '/builds/slave/test', 15:03:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:03:59 INFO - 'SHELL': '/bin/bash', 15:03:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mTptfWQ2wa/Listeners', 15:03:59 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 15:03:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:03:59 INFO - 'USER': 'cltbld', 15:03:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:03:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:03:59 INFO - 'XPC_FLAGS': '0x0', 15:03:59 INFO - 'XPC_SERVICE_NAME': '0', 15:03:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:03:59 INFO - Downloading/unpacking psutil>=3.1.1 15:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:03:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:03:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:04:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:04:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:04:02 INFO - Installing collected packages: psutil 15:04:02 INFO - Running setup.py install for psutil 15:04:02 INFO - building 'psutil._psutil_osx' extension 15:04:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:04:03 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:04:03 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:04:03 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:04:03 INFO - building 'psutil._psutil_posix' extension 15:04:03 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:04:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:04:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:04:03 INFO - ^ 15:04:03 INFO - 1 warning generated. 15:04:03 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:04:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:04:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:04:03 INFO - Successfully installed psutil 15:04:03 INFO - Cleaning up... 15:04:03 INFO - Return code: 0 15:04:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1102f13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110267570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2985ab880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110107d30>, '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 0x10ff6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100ffb20>, '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.dh4MIzlSIG/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.mTptfWQ2wa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:04:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:04:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dh4MIzlSIG/Render', 15:04:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:04:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:04:03 INFO - 'HOME': '/Users/cltbld', 15:04:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:04:03 INFO - 'LOGNAME': 'cltbld', 15:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:03 INFO - 'MOZ_NO_REMOTE': '1', 15:04:03 INFO - 'NO_EM_RESTART': '1', 15:04:03 INFO - 'PAGER': '/bin/cat', 15:04:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:03 INFO - 'PWD': '/builds/slave/test', 15:04:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:04:03 INFO - 'SHELL': '/bin/bash', 15:04:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mTptfWQ2wa/Listeners', 15:04:03 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 15:04:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:04:03 INFO - 'USER': 'cltbld', 15:04:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:04:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:03 INFO - 'XPC_FLAGS': '0x0', 15:04:03 INFO - 'XPC_SERVICE_NAME': '0', 15:04:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:04:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:04:06 INFO - Installing collected packages: mozsystemmonitor 15:04:06 INFO - Running setup.py install for mozsystemmonitor 15:04:07 INFO - Successfully installed mozsystemmonitor 15:04:07 INFO - Cleaning up... 15:04:07 INFO - Return code: 0 15:04:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1102f13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110267570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2985ab880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110107d30>, '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 0x10ff6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100ffb20>, '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.dh4MIzlSIG/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.mTptfWQ2wa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:04:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:04:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:04:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dh4MIzlSIG/Render', 15:04:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:04:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:04:07 INFO - 'HOME': '/Users/cltbld', 15:04:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:04:07 INFO - 'LOGNAME': 'cltbld', 15:04:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:07 INFO - 'MOZ_NO_REMOTE': '1', 15:04:07 INFO - 'NO_EM_RESTART': '1', 15:04:07 INFO - 'PAGER': '/bin/cat', 15:04:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:04:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:07 INFO - 'PWD': '/builds/slave/test', 15:04:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:04:07 INFO - 'SHELL': '/bin/bash', 15:04:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mTptfWQ2wa/Listeners', 15:04:07 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 15:04:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:04:07 INFO - 'USER': 'cltbld', 15:04:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:04:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:04:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:07 INFO - 'XPC_FLAGS': '0x0', 15:04:07 INFO - 'XPC_SERVICE_NAME': '0', 15:04:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:04:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:07 INFO - Downloading/unpacking jsonschema==2.5.1 15:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:04:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:10 INFO - Downloading functools32-3.2.3-2.tar.gz 15:04:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:04:10 INFO - warning: no files found matching '*.txt' 15:04:10 INFO - no previously-included directories found matching 'build' 15:04:10 INFO - no previously-included directories found matching 'dist' 15:04:10 INFO - no previously-included directories found matching '.git*' 15:04:10 INFO - Installing collected packages: jsonschema, functools32 15:04:10 INFO - Running setup.py install for functools32 15:04:10 INFO - warning: no files found matching '*.txt' 15:04:10 INFO - no previously-included directories found matching 'build' 15:04:10 INFO - no previously-included directories found matching 'dist' 15:04:10 INFO - no previously-included directories found matching '.git*' 15:04:10 INFO - Successfully installed jsonschema functools32 15:04:10 INFO - Cleaning up... 15:04:10 INFO - Return code: 0 15:04:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:10 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 0x1102f13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110267570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2985ab880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110107d30>, '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 0x10ff6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100ffb20>, '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.dh4MIzlSIG/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.mTptfWQ2wa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:04:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:04:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dh4MIzlSIG/Render', 15:04:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:04:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:04:10 INFO - 'HOME': '/Users/cltbld', 15:04:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:04:10 INFO - 'LOGNAME': 'cltbld', 15:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:10 INFO - 'MOZ_NO_REMOTE': '1', 15:04:10 INFO - 'NO_EM_RESTART': '1', 15:04:10 INFO - 'PAGER': '/bin/cat', 15:04:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:10 INFO - 'PWD': '/builds/slave/test', 15:04:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:04:10 INFO - 'SHELL': '/bin/bash', 15:04:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mTptfWQ2wa/Listeners', 15:04:10 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 15:04:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:04:10 INFO - 'USER': 'cltbld', 15:04:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:04:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:10 INFO - 'XPC_FLAGS': '0x0', 15:04:10 INFO - 'XPC_SERVICE_NAME': '0', 15:04:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:04:11 INFO - Cleaning up... 15:04:11 INFO - Return code: 0 15:04:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:11 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 0x1102f13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110267570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2985ab880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110107d30>, '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 0x10ff6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100ffb20>, '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.dh4MIzlSIG/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.mTptfWQ2wa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:04:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:04:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dh4MIzlSIG/Render', 15:04:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:04:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:04:11 INFO - 'HOME': '/Users/cltbld', 15:04:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:04:11 INFO - 'LOGNAME': 'cltbld', 15:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:11 INFO - 'MOZ_NO_REMOTE': '1', 15:04:11 INFO - 'NO_EM_RESTART': '1', 15:04:11 INFO - 'PAGER': '/bin/cat', 15:04:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:11 INFO - 'PWD': '/builds/slave/test', 15:04:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:04:11 INFO - 'SHELL': '/bin/bash', 15:04:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mTptfWQ2wa/Listeners', 15:04:11 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 15:04:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:04:11 INFO - 'USER': 'cltbld', 15:04:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:04:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:11 INFO - 'XPC_FLAGS': '0x0', 15:04:11 INFO - 'XPC_SERVICE_NAME': '0', 15:04:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:04:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:11 INFO - Downloading/unpacking blobuploader==1.2.4 15:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:13 INFO - Downloading blobuploader-1.2.4.tar.gz 15:04:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:04:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:04:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:15 INFO - Downloading docopt-0.6.1.tar.gz 15:04:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:04:15 INFO - Installing collected packages: blobuploader, requests, docopt 15:04:15 INFO - Running setup.py install for blobuploader 15:04:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:04:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:04:15 INFO - Running setup.py install for requests 15:04:15 INFO - Running setup.py install for docopt 15:04:15 INFO - Successfully installed blobuploader requests docopt 15:04:15 INFO - Cleaning up... 15:04:16 INFO - Return code: 0 15:04:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:16 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 0x1102f13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110267570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2985ab880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110107d30>, '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 0x10ff6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100ffb20>, '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.dh4MIzlSIG/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.mTptfWQ2wa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:04:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:04:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:04:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dh4MIzlSIG/Render', 15:04:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:04:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:04:16 INFO - 'HOME': '/Users/cltbld', 15:04:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:04:16 INFO - 'LOGNAME': 'cltbld', 15:04:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:16 INFO - 'MOZ_NO_REMOTE': '1', 15:04:16 INFO - 'NO_EM_RESTART': '1', 15:04:16 INFO - 'PAGER': '/bin/cat', 15:04:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:04:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:16 INFO - 'PWD': '/builds/slave/test', 15:04:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:04:16 INFO - 'SHELL': '/bin/bash', 15:04:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mTptfWQ2wa/Listeners', 15:04:16 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 15:04:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:04:16 INFO - 'USER': 'cltbld', 15:04:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:04:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:04:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:16 INFO - 'XPC_FLAGS': '0x0', 15:04:16 INFO - 'XPC_SERVICE_NAME': '0', 15:04:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:04:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:04:16 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-01lLlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:04:16 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-bf8hAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:04:16 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-L9HAqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:04:16 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-SABADw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:04:16 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-sZGo57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:04:16 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-IgzZIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:04:16 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-kyYBnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:04:17 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-n2peqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:04:17 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-F_R83o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:04:17 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-Emc4bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:04:17 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-kb8eXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:04:17 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-Jpn3eJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:04:17 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-7vBDnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:04:17 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-MJhH_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:04:17 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-ycYGZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:04:17 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-F4vBaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:04:18 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-aGgEeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:04:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:04:18 INFO - Running setup.py install for manifestparser 15:04:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:04:18 INFO - Running setup.py install for mozcrash 15:04:18 INFO - Running setup.py install for mozdebug 15:04:18 INFO - Running setup.py install for mozdevice 15:04:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:04:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:04:18 INFO - Running setup.py install for mozfile 15:04:18 INFO - Running setup.py install for mozhttpd 15:04:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:04:19 INFO - Running setup.py install for mozinfo 15:04:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:04:19 INFO - Running setup.py install for mozInstall 15:04:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:04:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:04:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:04:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:04:19 INFO - Running setup.py install for mozleak 15:04:19 INFO - Running setup.py install for mozlog 15:04:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:04:19 INFO - Running setup.py install for moznetwork 15:04:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:04:19 INFO - Running setup.py install for mozprocess 15:04:19 INFO - Running setup.py install for mozprofile 15:04:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:04:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:04:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:04:20 INFO - Running setup.py install for mozrunner 15:04:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:04:20 INFO - Running setup.py install for mozscreenshot 15:04:20 INFO - Running setup.py install for moztest 15:04:20 INFO - Running setup.py install for mozversion 15:04:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:04:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:04:20 INFO - Cleaning up... 15:04:20 INFO - Return code: 0 15:04:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:04: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')]} 15:04:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04: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')]} 15:04:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:20 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 0x1102f13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110267570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2985ab880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110107d30>, '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 0x10ff6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100ffb20>, '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.dh4MIzlSIG/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.mTptfWQ2wa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:04:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:04:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:04:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dh4MIzlSIG/Render', 15:04:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:04:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:04:20 INFO - 'HOME': '/Users/cltbld', 15:04:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:04:20 INFO - 'LOGNAME': 'cltbld', 15:04:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:20 INFO - 'MOZ_NO_REMOTE': '1', 15:04:20 INFO - 'NO_EM_RESTART': '1', 15:04:20 INFO - 'PAGER': '/bin/cat', 15:04:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:04:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:20 INFO - 'PWD': '/builds/slave/test', 15:04:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:04:20 INFO - 'SHELL': '/bin/bash', 15:04:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mTptfWQ2wa/Listeners', 15:04:20 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 15:04:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:04:20 INFO - 'USER': 'cltbld', 15:04:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:04:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:04:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:20 INFO - 'XPC_FLAGS': '0x0', 15:04:20 INFO - 'XPC_SERVICE_NAME': '0', 15:04:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:04:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:04:21 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-zIMJtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:04:21 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-xCUBwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:04:21 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-C_PGwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:04:21 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-pNGS8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:04:21 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-77Aoaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:04:21 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-yi0rWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:04:21 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-9EM55p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:04:21 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-Iwy644-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:04:21 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-n5QPy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:04:21 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-HRBtUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:04:22 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-bZQiIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:04:22 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-ZWEmIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:04:22 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)) 15:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:04:22 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-fd44GP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:04:22 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-I0FHee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:04:22 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-4jPG0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:04:22 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-0a5mk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:04:22 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)) 15:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:04:22 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-tO9hN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:04:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:04:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:04:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:04:25 INFO - Downloading blessings-1.6.tar.gz 15:04:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:04:25 INFO - Installing collected packages: blessings 15:04:25 INFO - Running setup.py install for blessings 15:04:25 INFO - Successfully installed blessings 15:04:25 INFO - Cleaning up... 15:04:25 INFO - Return code: 0 15:04:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:04:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:04:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:04:26 INFO - Reading from file tmpfile_stdout 15:04:26 INFO - Current package versions: 15:04:26 INFO - blessings == 1.6 15:04:26 INFO - blobuploader == 1.2.4 15:04:26 INFO - docopt == 0.6.1 15:04:26 INFO - functools32 == 3.2.3-2 15:04:26 INFO - jsonschema == 2.5.1 15:04:26 INFO - manifestparser == 1.1 15:04:26 INFO - mozInstall == 1.12 15:04:26 INFO - mozcrash == 1.0 15:04:26 INFO - mozdebug == 0.1 15:04:26 INFO - mozdevice == 0.49 15:04:26 INFO - mozfile == 1.2 15:04:26 INFO - mozhttpd == 0.7 15:04:26 INFO - mozinfo == 0.9 15:04:26 INFO - mozleak == 0.1 15:04:26 INFO - mozlog == 3.4 15:04:26 INFO - moznetwork == 0.27 15:04:26 INFO - mozprocess == 0.23 15:04:26 INFO - mozprofile == 0.28 15:04:26 INFO - mozrunner == 6.13 15:04:26 INFO - mozscreenshot == 0.1 15:04:26 INFO - mozsystemmonitor == 0.3 15:04:26 INFO - moztest == 0.7 15:04:26 INFO - mozversion == 1.4 15:04:26 INFO - psutil == 3.1.1 15:04:26 INFO - requests == 1.2.3 15:04:26 INFO - wsgiref == 0.1.2 15:04:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:26 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 0x1102f13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110267570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2985ab880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110107d30>, '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 0x10ff6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100ffb20>, '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.dh4MIzlSIG/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.mTptfWQ2wa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:04:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:04:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:04:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dh4MIzlSIG/Render', 15:04:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:04:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:04:26 INFO - 'HOME': '/Users/cltbld', 15:04:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:04:26 INFO - 'LOGNAME': 'cltbld', 15:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:26 INFO - 'MOZ_NO_REMOTE': '1', 15:04:26 INFO - 'NO_EM_RESTART': '1', 15:04:26 INFO - 'PAGER': '/bin/cat', 15:04:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:26 INFO - 'PWD': '/builds/slave/test', 15:04:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:04:26 INFO - 'SHELL': '/bin/bash', 15:04:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mTptfWQ2wa/Listeners', 15:04:26 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 15:04:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:04:26 INFO - 'USER': 'cltbld', 15:04:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:04:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:26 INFO - 'XPC_FLAGS': '0x0', 15:04:26 INFO - 'XPC_SERVICE_NAME': '0', 15:04:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:04:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:04:27 INFO - Cleaning up... 15:04:27 INFO - Return code: 0 15:04:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:04:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:04:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:04:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:04:27 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 0x1102f13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110267570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2985ab880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110107d30>, '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 0x10ff6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100ffb20>, '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.dh4MIzlSIG/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.mTptfWQ2wa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:04:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:04:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dh4MIzlSIG/Render', 15:04:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:04:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:04:27 INFO - 'HOME': '/Users/cltbld', 15:04:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:04:27 INFO - 'LOGNAME': 'cltbld', 15:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:04:27 INFO - 'MOZ_NO_REMOTE': '1', 15:04:27 INFO - 'NO_EM_RESTART': '1', 15:04:27 INFO - 'PAGER': '/bin/cat', 15:04:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:04:27 INFO - 'PWD': '/builds/slave/test', 15:04:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:04:27 INFO - 'SHELL': '/bin/bash', 15:04:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mTptfWQ2wa/Listeners', 15:04:27 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 15:04:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:04:27 INFO - 'USER': 'cltbld', 15:04:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:04:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:04:27 INFO - 'XPC_FLAGS': '0x0', 15:04:27 INFO - 'XPC_SERVICE_NAME': '0', 15:04:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:04:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:04:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:04:27 INFO - Cleaning up... 15:04:27 INFO - Return code: 0 15:04:27 INFO - Running post-action listener: _resource_record_post_action 15:04:27 INFO - Running post-action listener: _start_resource_monitoring 15:04:27 INFO - Starting resource monitoring. 15:04:27 INFO - [mozharness: 2016-11-30 23:04:27.727635Z] Finished create-virtualenv step (success) 15:04:27 INFO - [mozharness: 2016-11-30 23:04:27.728638Z] Running install step. 15:04:27 INFO - Running pre-action listener: _resource_record_pre_action 15:04:27 INFO - Running main action method: install 15:04:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:04:27 INFO - Reading from file tmpfile_stdout 15:04:27 INFO - Detecting whether we're running mozinstall >=1.0... 15:04:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:04:28 INFO - Reading from file tmpfile_stdout 15:04:28 INFO - Output received: 15:04:28 INFO - Usage: mozinstall [options] installer 15:04:28 INFO - Options: 15:04:28 INFO - -h, --help show this help message and exit 15:04:28 INFO - -d DEST, --destination=DEST 15:04:28 INFO - Directory to install application into. [default: 15:04:28 INFO - "/builds/slave/test"] 15:04:28 INFO - --app=APP Application being installed. [default: firefox] 15:04:28 INFO - mkdir: /builds/slave/test/build/application 15:04:28 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'] 15:04:28 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 15:05:00 INFO - Reading from file tmpfile_stdout 15:05:00 INFO - Output received: 15:05:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:05:00 INFO - Running post-action listener: _resource_record_post_action 15:05:00 INFO - [mozharness: 2016-11-30 23:05:00.885301Z] Finished install step (success) 15:05:00 INFO - [mozharness: 2016-11-30 23:05:00.885432Z] Running run-tests step. 15:05:00 INFO - Running pre-action listener: _resource_record_pre_action 15:05:00 INFO - Running main action method: run_tests 15:05:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:05:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:05:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:05:00 INFO - 2016-11-30 15:05:00.900 screenresolution[1625:7506] starting screenresolution argv=screenresolution get 15:05:00 INFO - 2016-11-30 15:05:00.902 screenresolution[1625:7506] Display 0: 1600x1200x32@60 15:05:00 INFO - 2016-11-30 15:05:00.908 screenresolution[1626:7509] starting screenresolution argv=screenresolution list 15:05:00 INFO - Available Modes on Display 0 15:05:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:05:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:05:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:05:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:05:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:05:01 INFO - Intel Iris: 15:05:01 INFO - Chipset Model: Intel Iris 15:05:01 INFO - Type: GPU 15:05:01 INFO - Bus: Built-In 15:05:01 INFO - VRAM (Dynamic, Max): 1536 MB 15:05:01 INFO - Vendor: Intel (0x8086) 15:05:01 INFO - Device ID: 0x0a2e 15:05:01 INFO - Revision ID: 0x0009 15:05:01 INFO - Displays: 15:05:01 INFO - Display: 15:05:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:05:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:05:01 INFO - Display Serial Number: 1600x1200 60 15:05:01 INFO - Main Display: Yes 15:05:01 INFO - Mirror: Off 15:05:01 INFO - Online: Yes 15:05:01 INFO - Rotation: Supported 15:05:01 INFO - Return code: 0 15:05:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:05:01 INFO - Python 2.7.3 15:05:01 INFO - Return code: 0 15:05:01 INFO - grabbing minidump binary from tooltool 15:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:05:01 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 0x110107d30>, '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 0x10ff6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100ffb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:05:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:05:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:05:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:05:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:05:01 INFO - Return code: 0 15:05:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:05:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:05:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:05:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:05:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:05:01 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/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0309', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:05:01 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/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0309 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:05:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dh4MIzlSIG/Render', 15:05:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:05:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:05:01 INFO - 'HOME': '/Users/cltbld', 15:05:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:05:01 INFO - 'LOGNAME': 'cltbld', 15:05:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:05:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:05:01 INFO - 'MOZ_NO_REMOTE': '1', 15:05:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:05:01 INFO - 'NO_EM_RESTART': '1', 15:05:01 INFO - 'PAGER': '/bin/cat', 15:05:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:05:01 INFO - 'PWD': '/builds/slave/test', 15:05:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:05:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:05:01 INFO - 'SHELL': '/bin/bash', 15:05:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mTptfWQ2wa/Listeners', 15:05:01 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 15:05:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:05:01 INFO - 'USER': 'cltbld', 15:05:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:05:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:05:01 INFO - 'XPC_FLAGS': '0x0', 15:05:01 INFO - 'XPC_SERVICE_NAME': '0', 15:05:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:05:01 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/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0309', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:05:01 INFO - mozversion application_buildid: 20161130125344 15:05:01 INFO - mozversion application_changeset: 8f1e420699832d42753c6503aa31861be6f5b186 15:05:01 INFO - mozversion application_display_name: Nightly 15:05:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:05:01 INFO - mozversion application_name: Firefox 15:05:01 INFO - mozversion application_remotingname: firefox 15:05:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:05:01 INFO - mozversion application_vendor: Mozilla 15:05:01 INFO - mozversion application_version: 53.0a1 15:05:01 INFO - mozversion platform_buildid: 20161130125344 15:05:01 INFO - mozversion platform_changeset: 8f1e420699832d42753c6503aa31861be6f5b186 15:05:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:05:01 INFO - mozversion platform_version: 53.0a1 15:05:01 INFO - using testdate: 1480547101 15:05:01 INFO - actual date: 1480547101 15:05:01 INFO - starting webserver on 'localhost:49241' 15:05:01 INFO - SUITE-START | Running 2 tests 15:05:01 INFO - TEST-START | dromaeo_css 15:05:01 INFO - operating with platform_type : mac_ 15:05:01 INFO - Initialising browser for dromaeo_css test... 15:05:01 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpno44ev/profile http://localhost:49241/getInfo.html) 15:05:04 INFO - PROCESS | 1636 | 2016-11-30 15:05:04.515 plugin-container[1638:7679] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x953f, name = 'com.apple.tsm.portname' 15:05:04 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:05:04 INFO - PROCESS | 1636 | 2016-11-30 15:05:04.518 plugin-container[1638:7679] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4917, name = 'com.apple.CFPasteboardClient' 15:05:04 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:05:04 INFO - PROCESS | 1636 | 2016-11-30 15:05:04.518 plugin-container[1638:7679] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:05:04 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 15:05:04 INFO - PROCESS | 1636 | colorDepth:24 15:05:04 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 15:05:04 INFO - PROCESS | 1636 | __metrics 15:05:04 ERROR - PROCESS | 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 15:05:05 INFO - TEST-INFO | 1636: exit 0 15:05:05 INFO - Browser initialized. 15:05:05 INFO - Running cycle 1/1 for dromaeo_css test... 15:05:05 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpno44ev/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:05:08 INFO - PROCESS | 1639 | 2016-11-30 15:05:08.125 plugin-container[1640:7803] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 15:05:08 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:05:08 INFO - PROCESS | 1639 | 2016-11-30 15:05:08.125 plugin-container[1640:7803] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d1f, name = 'com.apple.CFPasteboardClient' 15:05:08 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:05:08 INFO - PROCESS | 1639 | 2016-11-30 15:05:08.125 plugin-container[1640:7803] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:05:17 INFO - PROCESS | 1639 | RSS: Main: 243126272 15:05:17 INFO - PROCESS | 1639 | 15:06:07 INFO - PROCESS | 1639 | 1480547167333 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] 15:08:20 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 15:08:22 INFO - PROCESS | 1639 | RSS: Main: 255713280 15:08:22 INFO - PROCESS | 1639 | 15:11:24 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 15:11:25 INFO - PROCESS | 1639 | RSS: Main: 266960896 15:11:25 INFO - PROCESS | 1639 | 15:14:27 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 15:14:27 INFO - PROCESS | 1639 | RSS: Main: 271855616 15:14:27 INFO - PROCESS | 1639 | 15:17:29 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 15:17:30 INFO - PROCESS | 1639 | RSS: Main: 270381056 15:17:30 INFO - PROCESS | 1639 | 15:20:33 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 15:20:34 INFO - PROCESS | 1639 | RSS: Main: 274825216 15:20:34 INFO - PROCESS | 1639 | 15:23:36 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 15:23:37 INFO - PROCESS | 1639 | RSS: Main: 277438464 15:23:37 INFO - PROCESS | 1639 | 15:23:37 INFO - PROCESS | 1639 | __start_tp_report 15:23:37 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 15:23:37 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 15:23:37 INFO - PROCESS | 1639 | |i|pagename|runs| 15:23:37 INFO - PROCESS | 1639 | |0;dojo.html;2850.7719382449404;3366.276250606121;3374.746893982952;3392.067181525079;3422.0760394693434;5540.307461567304;5576.944230557693;5583.609147359686;5638.323401191858;5681.744321505532;5192.688438693681;5538.030844602188;5612.831615051545;5711.428857114297;5717.085266357383;3767.8869633911027;5084.822031228908;5249.18637611169;5263.736813159346;5273.9736301318635;5107.131787596099;5239.13554263546;5253.9737301313635;5297.523222909937;5309;5087.465816089294;5129.333186685707;5188.247704082924;5190.71451070191;5234.18870075139;5080.517350851663;5119.539241468286;5156.535911767959;5202.713850738208;5205.427402985669;3863.497745293122;4770.308305295747;5037.19404895215;5094.337736094321;5112.59099272061;5542.972285138549;5573.498385145316;5586.469285417878;5586.804461843856;5610.915836262459;4954.702717836942;6023.638581685069;6030.366811484775;6035.456808887221;6120.265568131853;6123.4656464211685;6134.742747059152;6156;6156.322804491502;6166.969165154145;5745.08078707409;5746.626469279525;5757.251557297524;5781.94218057814;5785.71071446426;6129.724162412702;6246.219222597176;6261.78083767066;6266;6301;5874.206982057453;5877.089051197071;5882;6022.3676513966275;6057.151998720183;6110.923300256496;6134.19168101403;6144.218176728698;6212.254529456403;6223.657698826518;5973.850653733604;6052.878942421215;6066.878662426815;6090.3605121461605;6115.602485838406;6144.187464697925;6186.81439556814;6188.4739797116845;6195.752169913243;6213.03697926822;4858.562729354305;4872.8781780455065;4874.2201247800185;4875.780589873464;4915.778789954461;4272.530021697611;4277.764722940268;4282.5075116361395;4322.459692538433;4343.305071188594;5541.141123125922;5736.483716465538;5741.397153298927;5750.769969201185;5782.826515204551;5308.0710875596615;6190.907136392958;6204.937950620436;6213.471854892295;6227.377262273736;5637.154426835926;5695.6582605043;5710.685912274865;5716.542676585863;5725.713714314351;4430.5126436092005;5282.920756188661;5307;5336.759845806948;5337.172738225581;6260.154879091265;6286;6297.118403423525;6305;6313.589616674902;6119.388061193845;6232.439080482597;6235.875282494416;6241.251049874044;6259.405356491126;5338.839834804962;5910.936031514369;6199.039148931923;6200.255969283535;6205.286392064971;6007.30915944672;6033.668148251888;6046.7581296749395;6070.696465176635;6088.086786981989;6133.907991380043;6160.599561028698;6188.721507532082;6198.0702894566175;6224.315325314121;4902.534259245509;5986.072158815216;6001.909971350346;6004;6048.0625503047095;4701.435827700698;5778.04662230744;5781.046127388934;5889.998700220887;5928.762849485972;4424.623906967944;4953.826616068421;5084.135696931457;5795.8551036224435;5937.495312898279;6007.038873780174;6031.849203769941;6034.939650603438;6041.214642096499;6051.001584738468;4753.334533165429;5832.708364581838;5886.381929897299;5893.675847828411;5903.91144132847 15:23:37 INFO - PROCESS | 1639 | |1;ext.html;458.2484725050917;504.33427875204734;523.1942808075564;532.7416203141478;540.6161625246075;33986.49020264695;36222;39622.00944976373;40937.7953110234;41058.58941410585;39942.8002859986;40402.19195616093;40427.595724042825;40514.79742601283;40567.797161014154;9192.402493837895;9375.81248375032;9394.060593940585;11022.834657480103;11399.829002564968;9863.457509836957;10841.83737243942;11256.212065155443;11354.43227838609;11380.260283081614;11310.151738619596;11334.206605537616;11390.25963312382;11400.201985860993;11419.486123124438;11262.718432039183;11284.492197851076;11299.322040677585;11302.773944521146;11321.981021708003;11123.944380278128;11164.609238676689;11191.496382662799;11203.66389008323;11206.943965280203;38138.618613813785;38295.42556861649;38484.84545463641;38534;38603.61396386056;3262.21706790371;3336.7831090979007;3364.8485818138242;3404.4042292598697;3815.656590906804;29115;29318.413631727246;29866.80532778708;29875.551866722017;30019.699803002128;3248.983755081233;3273.558069660613;3276.9836150819333;3282.195862013798;3329.450640644315;396024;426242;430538.8473057646;431147;529100;54252.91494170173;57934.71032644894;58261.70869145712;58793;58868.41131588715;59983.70008150019;61282;61615.69192154011;61844;61852;15207.61980950463;15462.84537154614;15468.303926323342;15675.294611742498;15697.764533532007;10792.51433685486;11098.722531936766;11702.414879256174;12057.276563406223;12057.879421205676;18300.81044732088;18392.816071839112;18393.34459898589;18425.26298948054;18441.354552590594;7579.848403032019;7777.250118723355;7783.763330578398;7794.246294583787;7809.648565814438;828.8010877389383;831.2601784411878;901.5176880369103;907.5416914458157;939.7227817793768;28743.281417964718;28880;29131.126066218047;29321.413571728444;29366.412671746446;934.7476181431111;1005.562580277567;1040.3497813866334;1042.6924057403085;1145.169751929844;14586.562403127924;14857.925710371379;14955;15110.320035598425;15333.233338333039;422128.77871220896;435785;516000;516374;563924;42036.789816051336;42650.360244596355;53811.19283210755;53899.999999999214;54264.45735542673;1119.3843386137592;1287.0668765145194;1304.7586196553668;1325.1254172246272;1330.3215360166384;27894.721052790024;28691;28885.42229155363;29377.559336610397;29386.412271754874;47225.291620626405;47673;47679;47755.04489910252;47912;411315;490068;490422;491356;492825;22381.88809055944;23025.539489209787;24733.87633061823;25466.363340916625;25499;31786.205344865637;43577;43708;44274.11451770882;44395.556044439145;31686.841565792023;34591.827040864635;36221.63778362182;36349.27301453903;37554.62445375511;36040.91877243687;36154.81922590476;36313.092172694836;37422.438663419525;37656.68201612931;35740.46389304214;36152.819235903655;36441.453378199876;36684;36789.81605091957;30038;32441;32565.674343256265;32736.83631581827;32880.50679239861;24197.395065122808;24298.448662890143;24390.75609243885;24721.13476028402;24788.628170577096 15:23:37 INFO - PROCESS | 1639 | |2;jquery.html;303.8571871220526;366.364357839149;369.44029794860785;378.60246740922025;398.4899328859061;18443.53891152722;19194.9442780647;19380.321688740896;19892.104855281494;20130.89934550325;19162.808371916275;19542.511437214078;19957.800421995777;20116.698249526267;20143.992800359996;5338.359396872371;5382.461753824626;5579.609427340088;5612.971935140318;5613.522850557708;5519.420460851613;5692.288463942007;5699.088145896658;5701.885962280752;5730.971345143268;5596.104623260279;5648.576356773238;5650.463205995424;5655.632383895034;6073;6326.746930122789;6475.125858009203;6500.577462464925;6513.055606936968;6524.314946930552;5538.280023596947;5736.483716465496;5752.612665743712;5804.62269952456;5807.506361959238;12436.129470937038;12635.052371072206;12721.618351449471;12841.1011229214;12881.355932203445;2112.324056301984;2266.0822366941416;2279.2250634784255;2417.8065754739578;2600.24592868068;9646.710598682052;10070.44612546317;10228.64199753005;10772.515236814284;13744.381502832397;1579.8973066750739;1653.5535405440585;1723.8448539631368;1726.1714377098938;1871.9064046797741;89499.21001579997;110716.4464177682;111588;116836.41581792121;117351;10034.749131271778;11315.20793544444;11343.546258149581;11507.252028618113;11671.59149429766;14341.64145896361;14473.710525789636;14504.927475362556;14512.62130097639;14513.782293265609;8067.233612806774;8239.258466738022;8271.917280827114;8376.748697539084;8410.915890841014;7955.761327160194;8061.596920154087;8064.637091330904;8091.109977902426;8179;3718.665320121202;4056.7971601419813;4338.3709362142945;4444.911101777946;4448.288273876229;1642.3266460751036;1887.9150438230313;1917.980820191808;1919.9808001920082;1925.1433112265188;778.6846327237478;837.5435387713711;856.7900864288165;893.2095095840228;927.9768005799774;19584.60830783405;20028.69956950647;20068.297609583595;20296.898515507328;20427.392228687793;806.9193080692002;869.7912500999842;872.3785025996839;877.2762470961483;888.7868060098049;9625.855612165824;9697.321187516805;10666.786664266827;10710.143188544898;10797.46012699362;433711;511510;511646;523561;526644.7335526672;109115;122203;122359.38820305842;125799;125912;829.9128591497927;950.3300173377752;969.0648524174065;987.0918754745651;993.1955116355775;14139.929300353433;17625.73561396606;18407.263709452007;18457;18488.890666560048;37798.81100594479;40249.1950161001;50225.497745023546;52151.73924130507;52209;51605.741971291405;63752.681236595374;68785.59250426412;72241;74095.88856167269;7547.471676982558;7684.231576842271;7816.179301173295;7959.243871832166;7983.002124734408;11660.183787135158;11693.766124677288;11911.166218364979;12029.15795894314;12285;8416.915830841614;10365.585376584851;10516.894831051592;10578;10807.783844322912;10344.37933723979;10428.217883658908;10449.373037617766;10554.630587929692;10808.081313088476;10527.894721052691;10628.84056739165;10775.838362424727;10783.784324313312;10967.780644387227;7527.096748390229;7819.827025946153;7894.881576776468;7903.288704016666;8101.068377136469;10160.695179144637;10527.684169474927;10528.684139475828;10580.788384232119;10922.836157457803 15:23:37 INFO - PROCESS | 1639 | |3;mootools.html;1337.5786627212428;1465.1941432212284;1630.6820170066835;1770.530809335527;1796.3892276625936;7424.925750742491;7690.461667683265;7962.203779622042;8408.873866891994;8412.747617571475;7937.365010799137;8236.711715089958;8241.546714930677;8355.164483551642;8361.456505327149;2268.319504148757;2281.258590957945;2297.7012988311494;2297.9425514362106;2306.9653955190684;2287.5653625811124;2314.166899916029;2325.767423257678;2339.6022676145094;2340.637201233803;2270.591293567157;2275.1581914691587;2289.2559918026623;2295.7704229577075;2303.4586872085047;2261.118163916074;2272.534130503243;2286.085565773687;2290.1869836208075;2294.89672964717;2293.575688497633;2299.85050971688;2305.020366344297;2307.077169132344;2313.1556981701556;8250.587470626504;8341.916580834235;8374.581270936429;8377.95811020941;8434.072252052269;5033.043721692867;5137.075326441239;5189.143791274435;5199.298094757235;5218.112920803473;2718.9456210875674;3237.9352412951607;3530.258645684409;3541.097020259843;3542.433210686278;855.4995327733284;917.47703808829;1058.3596923861107;1059.5496913811676;1089.411717672456;8673.783155421102;9517.714468565884;10480.94759526205;10723;10832.566697332097;3689.856144595184;4313.374560688682;4396.538363471789;4419.867403977886;4424.867253982386;8493.405461617751;8579.485230886166;8579.699710510102;8599.484030958163;8662.35032372562;4964.304997300381;5045.621578381636;5049.469805670426;5057.949420505748;5070.315507406527;4269.658427325807;4716.976415117971;4770.451398089194;4776.59398951093;4798.448178459452;3523.119220194951;3575.713942884563;3612.945805812915;3648.2338708871434;3658.743887927873;1134.4497918509517;1150.9827352589718;1152.7607821591655;1156.9132315076404;1158.0966845860241;778.5601135358504;791.6081539637801;812.1675282835141;908.8273228086642;931.3108299858056;5506.146547285177;5599.384067752544;5629.380768115504;5727.885442291131;5749.68376739275;357.80499627702966;421.6668831623045;428.27621319969154;433.9652827773834;435.98692039238875;3432.982835085809;3899.0447340401215;3915.9608403915595;3985.143194213258;3996.360582306817;9455.858162127573;9871.358361706467;9890.703278901645;10046.648367307109;10053.597856085675;9435.811283774286;9817.852732209023;9933.950330248303;9947.900520994843;9981.850272245922;7568.940348351235;7788.454808163374;7800.063992320957;7804.414668899855;7849.764507064797;4451.7996690148375;4871.561559459666;5497.725113744376;5720.971395143164;5807.477327040418;9170.495622740813;9176.908230917872;9244.029376915596;9271.30465215098;9294.349395542247;9059.818803624023;9254.35219534626;9291.163795258459;9347.252219822261;9381.296402769683;6425.389587989133;6634.933650663625;6832.897506537306;6972.407345375497;7174.784756457106;7626.8093297668;7784.338331241682;7832.412569057457;7849.803754906173;7866.7639970800965;6843;7012.088428504466;7023.683934223074;7074.752383666753;7120.857582848417;6870.862582748417;6896.7586134485055;6924.203716572659;6944.930550694428;7041.5422997505;6385.489160867027;6533.444657204001;6620.106285651568;6658.3674550917585;6663.733450661919;4126.319157339006;4852.44196917359;4906.215005599087;4925.261210818406;4983.551480366639;4540.636749060001;4802.687825291345;4881.023795240895;4963.404391473046;5075.3402057732255 15:23:37 INFO - PROCESS | 1639 | |4;prototype.html;274.7486050264008;298.33917871913707;308.8749056632064;310.7917695144253;311.71945249275666;4998.600111991041;5375.032494151061;5458.781648734046;5598;5605.27131472909;5021.5229553192385;5474.452554744534;5476.3702174249975;5479.753301146531;5531.308586426697;3321.8671253149846;4207.537170911197;4221.092465120007;4230.873073807791;4310.396544483775;3723.813809309537;4173.707840451155;4212.241796476633;4246.830126794925;4251.277282861921;3458.5849698036272;3851.34392211349;4155.501339839224;4156.293430116887;4165.20965921012;3657.4696668982847;4149.356849688304;4168.416421700964;4179.185058913513;4208.347706105528;3442.347673116893;3463.9134021649406;3659.14010207601;3665.963340366589;3667.559892812853;4269.359596060584;5218.947810521884;5225.425203227642;5322.270262164812;5408.540274076709;4186.958130418688;4359.4306049822035;4448.488423831269;4458.331250312447;4783.736894470802;4785.688930219525;5776.59563830532;5802.839432113594;5805.448482394166;5905.1103646833035;3478.617352091268;3564.6078931317534;3908.921821563553;3924.352481840493;3933.331333673282;5533.612647114704;5997.970010149921;6065.63606183626;6114.419130182626;6173.197484327054;3449.862005519801;3524.69586253088;3861.3896007233325;4003.739756915791;4029.879103626896;3255.3977514159956;3389.4237979543045;3846.9230615387537;3982.4026396040244;4022;4716.915109524829;4747.359106520645;4756.357891684578;4770.666053376231;4779.426468823764;5867.882642347129;5914.733836977346;5915.438033386821;5942.732577034044;5988.113744170572;1163.2438914705508;1213.3326670331282;1214.5789426371166;1243.5523211643801;1270.3775150176532;745.8881167824869;766.7961300757756;843.7468759372164;867.8958524976916;885.1944730295401;5091.389033316026;5194.870128246748;5218;5234.031704134747;5247.2653828464045;4441.267190913463;5047.343845300087;5125.411122552021;5538.667679939216;5696.259486266842;4777.784999675023;4981.729658936948;5210.53105220532;5238.842834714965;5243.606729495303;2402.9879850600983;2987.268119310783;3017.3060196155006;3039.4984827503213;3048.8780448782245;4884.780184891689;5958.659301657092;5963.554942473652;5987.401259874065;6002.939970600325;4934.679245849008;5176.715280659525;5659.320881494247;5791.276090488689;6095.908561371583;5280.841574752763;5522.337319521683;5931.584789064724;5948.018576934757;6020.397960204032;4722.858314250578;4774.379330686988;5236.476352364733;5665.66006039639;5703.093381034005;5556.38879723222;5978.581499295007;6012.076135636555;6019.969900150471;6077;5703.942960570507;6224.470919971672;6248.187735594343;6253.15330166296;6267.4986001120715;3270.6238782540313;3727.030971947259;3969.1069509360163;4022.175454031858;4029.3150164472695;5650.745716442688;6015.699215039318;6044.516438684983;6059.394060594082;6074.574779765374;5338.519533242027;5628.774849005994;5737.5983681141915;5867.882642347044;5922.763089476372;4854.927176092291;5815.476607105381;5819.214406055128;5835.533157347317;5884.205632239593;4563.520830312769;4753;5475.72621368938;5675.375708671961;5724.198612194213;4725.645576581839;5105.744712764421;5782.710864456676;5876.415386614077;5878.823635290948;4904.779284932258;5732.254806875247;5805.680687562224;5858;5860.706964651665 15:23:37 INFO - PROCESS | 1639 | |5;yui.html;655.7999810057934;703.8838591632377;761.2083433229442;769.3883362726632;805.1746959366649;14752;15652.921735391306;15664.138472384015;15671.138087405203;15693.215339233035;14051.156930584171;14188.219647919386;14204.857951420508;14214.431422743104;14231.71536569268;654.9836254093639;675.0987431778582;807.2492581898846;809.9635516401776;834.6577903059747;826.0789220019694;841.154639587214;842.0274582856811;842.2419822160043;846.1369403208723;846.4540371460404;886.3352485635774;886.7118186589352;890.3678388344283;893.1068931068932;852.3990586636437;861.9569021548898;881.2773525708922;887.658251573149;893.1024320557863;645.2063961327547;661.5633681770057;661.7816120680164;662.3674390956625;665.5108495256031;14239.074460160056;14287.78568321476;14712.779308310384;14731.852681473263;14738.042027268193;13999.166716266922;14117.435302587885;14130.92934535331;14294.02840301436;14604.12375257488;11603.4198290086;11794.823077653757;11834.230774999598;11839.052875769918;11945.522179112824;3190.6171259448784;3571.1072231942017;3699.3896007158787;3798.2593394288124;3852.248811481762;111571.44214278877;113479.86520134775;113540;114246;115731;9380.272857135677;10777.922207779317;10867.673969780919;10886.346819190874;10893.346399216072;20729;20732.274370397266;20736.688949665768;20751.962401879846;20775.272865449635;6713.26154123046;7454.440916931252;7502.699892004368;7556.622168891534;7635.389168866477;3640.399334109842;4246.044639955985;4277.743335399886;4369.847055353048;4423.0048239145935;3502.614712381636;3597.4244120940525;3617.7829330239742;3618.620044895248;3650.5071815305123;653.947684185264;670.2426258328059;690.2441826200303;700.663681432915;702.3398005874461;546.734942503687;553.1265077920166;588.4703766609999;593.7684303121786;660.9768658096943;9053.864192037125;9350.345475816763;9444.527773611291;9499.90500095004;9596.66411675588;443.64687702507223;568.4060157135802;596.4998029954668;659.577870163096;678.3250665587772;4438.578335058164;4578.931316030262;4606.8157273708675;4610.631149508098;4639.837605683785;91380.54309728542;92370.53814730883;97247;101001.49499252603;109637.45181274202;99549.00450995397;100301;100487.49756251172;101084.49457752664;101728;58218.8356232873;74499.62750186214;78410;82823.17176828155;83392.58303708442;7727.806804829925;8562.828743425222;8731.214190722865;8911.866322005304;8964.955175224082;46461.53538464572;51370.22944655908;53518.197227040844;53875.461245388615;54189.18716219181;73910;78321.60839195768;82014.58992704998;82869.58565207136;82950.17049829425;11501.367424791717;11587.188896777145;11712.648620541397;11745.588904388305;11976.28142311464;12724.109312348417;12916.612501624966;12979;13094.738105238033;13768.793468097787;11921.582744603897;12223.511059557519;12245.387730613256;12263.632091037283;12641.2415255085;12073.637790866289;12096.274223546616;12323.44544495482;12483.563075292685;12492.000639948601;11770.234934729215;11921.225120367148;11944.522219111139;12050.578229761917;12133.21134126279;9484.857727134236;9879.357841740264;9945.900540994497;10092.697219083146;10116.494175291058;9483.430994140374;10355.378677279086;10371.68884933423;10407.791844163226;10438.68683939483 15:23:37 INFO - PROCESS | 1639 | __end_tp_report 15:23:37 INFO - PROCESS | 1639 | __start_cc_report 15:23:37 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,380 15:23:37 INFO - PROCESS | 1639 | __end_cc_report 15:23:37 INFO - PROCESS | 1639 | __startTimestamp1480548217063__endTimestamp 15:23:37 INFO - PROCESS | 1639 | 15:23:37 INFO - PROCESS | 1639 | ------- Summary: start ------- 15:23:37 INFO - PROCESS | 1639 | Number of tests: 6 15:23:37 INFO - PROCESS | 1639 | 15:23:37 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5588.43 Median:5781.05 stddev:687.61 (11.9%) stddev-sans-first:655.32 15:23:37 INFO - PROCESS | 1639 | Values: 2850.8 3366.3 3374.7 3392.1 3422.1 5540.3 5576.9 5583.6 5638.3 5681.7 5192.7 5538.0 5612.8 5711.4 5717.1 3767.9 5084.8 5249.2 5263.7 5274.0 5107.1 5239.1 5254.0 5297.5 5309.0 5087.5 5129.3 5188.2 5190.7 5234.2 5080.5 5119.5 5156.5 5202.7 5205.4 3863.5 4770.3 5037.2 5094.3 5112.6 5543.0 5573.5 5586.5 5586.8 5610.9 4954.7 6023.6 6030.4 6035.5 6120.3 6123.5 6134.7 6156.0 6156.3 6167.0 5745.1 5746.6 5757.3 5781.9 5785.7 6129.7 6246.2 6261.8 6266.0 6301.0 5874.2 5877.1 5882.0 6022.4 6057.2 6110.9 6134.2 6144.2 6212.3 6223.7 5973.9 6052.9 6066.9 6090.4 6115.6 6144.2 6186.8 6188.5 6195.8 6213.0 4858.6 4872.9 4874.2 4875.8 4915.8 4272.5 4277.8 4282.5 4322.5 4343.3 5541.1 5736.5 5741.4 5750.8 5782.8 5308.1 6190.9 6204.9 6213.5 6227.4 5637.2 5695.7 5710.7 5716.5 5725.7 4430.5 5282.9 5307.0 5336.8 5337.2 6260.2 6286.0 6297.1 6305.0 6313.6 6119.4 6232.4 6235.9 6241.3 6259.4 5338.8 5910.9 6199.0 6200.3 6205.3 6007.3 6033.7 6046.8 6070.7 6088.1 6133.9 6160.6 6188.7 6198.1 6224.3 4902.5 5986.1 6001.9 6004.0 6048.1 4701.4 5778.0 5781.0 5890.0 5928.8 4424.6 4953.8 5084.1 5795.9 5937.5 6007.0 6031.8 6034.9 6041.2 6051.0 4753.3 5832.7 5886.4 5893.7 5903.9 15:23:37 INFO - PROCESS | 1639 | 15:23:37 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:60929.56 Median:18695.45 stddev:125450.28 (671.0%) stddev-sans-first:125720.04 15:23:37 INFO - PROCESS | 1639 | Values: 458.2 504.3 523.2 532.7 540.6 33986.5 36222.0 39622.0 40937.8 41058.6 39942.8 40402.2 40427.6 40514.8 40567.8 9192.4 9375.8 9394.1 11022.8 11399.8 9863.5 10841.8 11256.2 11354.4 11380.3 11310.2 11334.2 11390.3 11400.2 11419.5 11262.7 11284.5 11299.3 11302.8 11322.0 11123.9 11164.6 11191.5 11203.7 11206.9 38138.6 38295.4 38484.8 38534.0 38603.6 3262.2 3336.8 3364.8 3404.4 3815.7 29115.0 29318.4 29866.8 29875.6 30019.7 3249.0 3273.6 3277.0 3282.2 3329.5 396024.0 426242.0 430538.8 431147.0 529100.0 54252.9 57934.7 58261.7 58793.0 58868.4 59983.7 61282.0 61615.7 61844.0 61852.0 15207.6 15462.8 15468.3 15675.3 15697.8 10792.5 11098.7 11702.4 12057.3 12057.9 18300.8 18392.8 18393.3 18425.3 18441.4 7579.8 7777.3 7783.8 7794.2 7809.6 828.8 831.3 901.5 907.5 939.7 28743.3 28880.0 29131.1 29321.4 29366.4 934.7 1005.6 1040.3 1042.7 1145.2 14586.6 14857.9 14955.0 15110.3 15333.2 422128.8 435785.0 516000.0 516374.0 563924.0 42036.8 42650.4 53811.2 53900.0 54264.5 1119.4 1287.1 1304.8 1325.1 1330.3 27894.7 28691.0 28885.4 29377.6 29386.4 47225.3 47673.0 47679.0 47755.0 47912.0 411315.0 490068.0 490422.0 491356.0 492825.0 22381.9 23025.5 24733.9 25466.4 25499.0 31786.2 43577.0 43708.0 44274.1 44395.6 31686.8 34591.8 36221.6 36349.3 37554.6 36040.9 36154.8 36313.1 37422.4 37656.7 35740.5 36152.8 36441.5 36684.0 36789.8 30038.0 32441.0 32565.7 32736.8 32880.5 24197.4 24298.4 24390.8 24721.1 24788.6 15:23:37 INFO - PROCESS | 1639 | 15:23:37 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:30795.12 Median:335.11 stddev:84408.17 (25188.1%) stddev-sans-first:84613.91 15:23:37 INFO - PROCESS | 1639 | Values: 303.9 366.4 369.4 378.6 398.5 18443.5 19194.9 19380.3 19892.1 20130.9 19162.8 19542.5 19957.8 20116.7 20144.0 5338.4 5382.5 5579.6 5613.0 5613.5 5519.4 5692.3 5699.1 5701.9 5731.0 5596.1 5648.6 5650.5 5655.6 6073.0 6326.7 6475.1 6500.6 6513.1 6524.3 5538.3 5736.5 5752.6 5804.6 5807.5 12436.1 12635.1 12721.6 12841.1 12881.4 2112.3 2266.1 2279.2 2417.8 2600.2 9646.7 10070.4 10228.6 10772.5 13744.4 1579.9 1653.6 1723.8 1726.2 1871.9 89499.2 110716.4 111588.0 116836.4 117351.0 10034.7 11315.2 11343.5 11507.3 11671.6 14341.6 14473.7 14504.9 14512.6 14513.8 8067.2 8239.3 8271.9 8376.7 8410.9 7955.8 8061.6 8064.6 8091.1 8179.0 3718.7 4056.8 4338.4 4444.9 4448.3 1642.3 1887.9 1918.0 1920.0 1925.1 778.7 837.5 856.8 893.2 928.0 19584.6 20028.7 20068.3 20296.9 20427.4 806.9 869.8 872.4 877.3 888.8 9625.9 9697.3 10666.8 10710.1 10797.5 433711.0 511510.0 511646.0 523561.0 526644.7 109115.0 122203.0 122359.4 125799.0 125912.0 829.9 950.3 969.1 987.1 993.2 14139.9 17625.7 18407.3 18457.0 18488.9 37798.8 40249.2 50225.5 52151.7 52209.0 51605.7 63752.7 68785.6 72241.0 74095.9 7547.5 7684.2 7816.2 7959.2 7983.0 11660.2 11693.8 11911.2 12029.2 12285.0 8416.9 10365.6 10516.9 10578.0 10807.8 10344.4 10428.2 10449.4 10554.6 10808.1 10527.9 10628.8 10775.8 10783.8 10967.8 7527.1 7819.8 7894.9 7903.3 8101.1 10160.7 10527.7 10528.7 10580.8 10922.8 15:23:37 INFO - PROCESS | 1639 | 15:23:37 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5309.64 Median:5106.21 stddev:2913.27 (57.1%) stddev-sans-first:2906.15 15:23:37 INFO - PROCESS | 1639 | Values: 1337.6 1465.2 1630.7 1770.5 1796.4 7424.9 7690.5 7962.2 8408.9 8412.7 7937.4 8236.7 8241.5 8355.2 8361.5 2268.3 2281.3 2297.7 2297.9 2307.0 2287.6 2314.2 2325.8 2339.6 2340.6 2270.6 2275.2 2289.3 2295.8 2303.5 2261.1 2272.5 2286.1 2290.2 2294.9 2293.6 2299.9 2305.0 2307.1 2313.2 8250.6 8341.9 8374.6 8378.0 8434.1 5033.0 5137.1 5189.1 5199.3 5218.1 2718.9 3237.9 3530.3 3541.1 3542.4 855.5 917.5 1058.4 1059.5 1089.4 8673.8 9517.7 10480.9 10723.0 10832.6 3689.9 4313.4 4396.5 4419.9 4424.9 8493.4 8579.5 8579.7 8599.5 8662.4 4964.3 5045.6 5049.5 5057.9 5070.3 4269.7 4717.0 4770.5 4776.6 4798.4 3523.1 3575.7 3612.9 3648.2 3658.7 1134.4 1151.0 1152.8 1156.9 1158.1 778.6 791.6 812.2 908.8 931.3 5506.1 5599.4 5629.4 5727.9 5749.7 357.8 421.7 428.3 434.0 436.0 3433.0 3899.0 3916.0 3985.1 3996.4 9455.9 9871.4 9890.7 10046.6 10053.6 9435.8 9817.9 9934.0 9947.9 9981.9 7568.9 7788.5 7800.1 7804.4 7849.8 4451.8 4871.6 5497.7 5721.0 5807.5 9170.5 9176.9 9244.0 9271.3 9294.3 9059.8 9254.4 9291.2 9347.3 9381.3 6425.4 6634.9 6832.9 6972.4 7174.8 7626.8 7784.3 7832.4 7849.8 7866.8 6843.0 7012.1 7023.7 7074.8 7120.9 6870.9 6896.8 6924.2 6944.9 7041.5 6385.5 6533.4 6620.1 6658.4 6663.7 4126.3 4852.4 4906.2 4925.3 4983.6 4540.6 4802.7 4881.0 4963.4 5075.3 15:23:37 INFO - PROCESS | 1639 | 15:23:37 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4614.33 Median:5185.79 stddev:1463.68 (28.2%) stddev-sans-first:1431.08 15:23:37 INFO - PROCESS | 1639 | Values: 274.7 298.3 308.9 310.8 311.7 4998.6 5375.0 5458.8 5598.0 5605.3 5021.5 5474.5 5476.4 5479.8 5531.3 3321.9 4207.5 4221.1 4230.9 4310.4 3723.8 4173.7 4212.2 4246.8 4251.3 3458.6 3851.3 4155.5 4156.3 4165.2 3657.5 4149.4 4168.4 4179.2 4208.3 3442.3 3463.9 3659.1 3666.0 3667.6 4269.4 5218.9 5225.4 5322.3 5408.5 4187.0 4359.4 4448.5 4458.3 4783.7 4785.7 5776.6 5802.8 5805.4 5905.1 3478.6 3564.6 3908.9 3924.4 3933.3 5533.6 5998.0 6065.6 6114.4 6173.2 3449.9 3524.7 3861.4 4003.7 4029.9 3255.4 3389.4 3846.9 3982.4 4022.0 4716.9 4747.4 4756.4 4770.7 4779.4 5867.9 5914.7 5915.4 5942.7 5988.1 1163.2 1213.3 1214.6 1243.6 1270.4 745.9 766.8 843.7 867.9 885.2 5091.4 5194.9 5218.0 5234.0 5247.3 4441.3 5047.3 5125.4 5538.7 5696.3 4777.8 4981.7 5210.5 5238.8 5243.6 2403.0 2987.3 3017.3 3039.5 3048.9 4884.8 5958.7 5963.6 5987.4 6002.9 4934.7 5176.7 5659.3 5791.3 6095.9 5280.8 5522.3 5931.6 5948.0 6020.4 4722.9 4774.4 5236.5 5665.7 5703.1 5556.4 5978.6 6012.1 6020.0 6077.0 5703.9 6224.5 6248.2 6253.2 6267.5 3270.6 3727.0 3969.1 4022.2 4029.3 5650.7 6015.7 6044.5 6059.4 6074.6 5338.5 5628.8 5737.6 5867.9 5922.8 4854.9 5815.5 5819.2 5835.5 5884.2 4563.5 4753.0 5475.7 5675.4 5724.2 4725.6 5105.7 5782.7 5876.4 5878.8 4904.8 5732.3 5805.7 5858.0 5860.7 15:23:37 INFO - PROCESS | 1639 | 15:23:37 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:20859.82 Median:2433.33 stddev:31169.25 (1280.9%) stddev-sans-first:31219.77 15:23:37 INFO - PROCESS | 1639 | Values: 655.8 703.9 761.2 769.4 805.2 14752.0 15652.9 15664.1 15671.1 15693.2 14051.2 14188.2 14204.9 14214.4 14231.7 655.0 675.1 807.2 810.0 834.7 826.1 841.2 842.0 842.2 846.1 846.5 886.3 886.7 890.4 893.1 852.4 862.0 881.3 887.7 893.1 645.2 661.6 661.8 662.4 665.5 14239.1 14287.8 14712.8 14731.9 14738.0 13999.2 14117.4 14130.9 14294.0 14604.1 11603.4 11794.8 11834.2 11839.1 11945.5 3190.6 3571.1 3699.4 3798.3 3852.2 111571.4 113479.9 113540.0 114246.0 115731.0 9380.3 10777.9 10867.7 10886.3 10893.3 20729.0 20732.3 20736.7 20752.0 20775.3 6713.3 7454.4 7502.7 7556.6 7635.4 3640.4 4246.0 4277.7 4369.8 4423.0 3502.6 3597.4 3617.8 3618.6 3650.5 653.9 670.2 690.2 700.7 702.3 546.7 553.1 588.5 593.8 661.0 9053.9 9350.3 9444.5 9499.9 9596.7 443.6 568.4 596.5 659.6 678.3 4438.6 4578.9 4606.8 4610.6 4639.8 91380.5 92370.5 97247.0 101001.5 109637.5 99549.0 100301.0 100487.5 101084.5 101728.0 58218.8 74499.6 78410.0 82823.2 83392.6 7727.8 8562.8 8731.2 8911.9 8965.0 46461.5 51370.2 53518.2 53875.5 54189.2 73910.0 78321.6 82014.6 82869.6 82950.2 11501.4 11587.2 11712.6 11745.6 11976.3 12724.1 12916.6 12979.0 13094.7 13768.8 11921.6 12223.5 12245.4 12263.6 12641.2 12073.6 12096.3 12323.4 12483.6 12492.0 11770.2 11921.2 11944.5 12050.6 12133.2 9484.9 9879.4 9945.9 10092.7 10116.5 9483.4 10355.4 10371.7 10407.8 10438.7 15:23:37 INFO - PROCESS | 1639 | -------- Summary: end -------- 15:23:37 INFO - PROCESS | 1639 | 15:23:37 INFO - TEST-INFO | 1639: exit 0 15:23:37 INFO - TEST-OK | dromaeo_css | took 1116212ms 15:23:37 INFO - TEST-START | kraken 15:23:37 INFO - operating with platform_type : mac_ 15:23:37 INFO - Initialising browser for kraken test... 15:23:37 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpWQFmRF/profile http://localhost:49241/getInfo.html) 15:23:40 INFO - PROCESS | 1650 | 2016-11-30 15:23:40.777 plugin-container[1651:10337] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 15:23:40 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:23:40 INFO - PROCESS | 1650 | 2016-11-30 15:23:40.780 plugin-container[1651:10337] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x901f, name = 'com.apple.CFPasteboardClient' 15:23:40 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:23:40 INFO - PROCESS | 1650 | 2016-11-30 15:23:40.780 plugin-container[1651:10337] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:23:40 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 15:23:40 INFO - PROCESS | 1650 | colorDepth:24 15:23:40 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 15:23:40 INFO - PROCESS | 1650 | __metrics 15:23:40 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 15:23:41 INFO - TEST-INFO | 1650: exit 0 15:23:41 INFO - Browser initialized. 15:23:41 INFO - Running cycle 1/1 for kraken test... 15:23:41 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpWQFmRF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:23:44 INFO - PROCESS | 1652 | 2016-11-30 15:23:44.655 plugin-container[1653:10454] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 15:23:44 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:23:44 INFO - PROCESS | 1652 | 2016-11-30 15:23:44.656 plugin-container[1653:10454] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 15:23:44 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:23:44 INFO - PROCESS | 1652 | 2016-11-30 15:23:44.656 plugin-container[1653:10454] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:23:54 INFO - PROCESS | 1652 | RSS: Main: 242733056 15:23:54 INFO - PROCESS | 1652 | 15:23:57 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 15:23:58 INFO - PROCESS | 1652 | RSS: Main: 254951424 15:23:58 INFO - PROCESS | 1652 | 15:24:00 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 15:24:01 INFO - PROCESS | 1652 | RSS: Main: 262561792 15:24:01 INFO - PROCESS | 1652 | 15:24:04 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 15:24:05 INFO - PROCESS | 1652 | RSS: Main: 265207808 15:24:05 INFO - PROCESS | 1652 | 15:24:07 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 15:24:08 INFO - PROCESS | 1652 | RSS: Main: 267444224 15:24:08 INFO - PROCESS | 1652 | 15:24:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:24:10 INFO - PROCESS | 1652 | RSS: Main: 267685888 15:24:10 INFO - PROCESS | 1652 | 15:24:13 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 15:24:14 INFO - PROCESS | 1652 | RSS: Main: 273391616 15:24:14 INFO - PROCESS | 1652 | 15:24:17 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 15:24:17 INFO - PROCESS | 1652 | RSS: Main: 273051648 15:24:17 INFO - PROCESS | 1652 | 15:24:20 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 15:24:21 INFO - PROCESS | 1652 | RSS: Main: 273166336 15:24:21 INFO - PROCESS | 1652 | 15:24:22 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:24:23 INFO - PROCESS | 1652 | RSS: Main: 272142336 15:24:23 INFO - PROCESS | 1652 | 15:24:25 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:24:26 INFO - PROCESS | 1652 | RSS: Main: 272318464 15:24:26 INFO - PROCESS | 1652 | 15:24:28 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:24:28 INFO - PROCESS | 1652 | RSS: Main: 272334848 15:24:28 INFO - PROCESS | 1652 | 15:24:32 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:24:32 INFO - PROCESS | 1652 | RSS: Main: 272650240 15:24:32 INFO - PROCESS | 1652 | 15:24:35 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:24:36 INFO - PROCESS | 1652 | RSS: Main: 272650240 15:24:36 INFO - PROCESS | 1652 | 15:24:38 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 15:24:38 INFO - PROCESS | 1652 | RSS: Main: 274530304 15:24:38 INFO - PROCESS | 1652 | 15:24:38 INFO - PROCESS | 1652 | __start_tp_report 15:24:38 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 15:24:38 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 15:24:38 INFO - PROCESS | 1652 | |i|pagename|runs| 15:24:38 INFO - PROCESS | 1652 | |0;ai-astar;106;132;176;157;117;120;115;119;117;117 15:24:38 INFO - PROCESS | 1652 | |1;audio-beat-detection;150;116;120;174;124;118;120;114;136;120 15:24:38 INFO - PROCESS | 1652 | |2;audio-dft;203;235;194;201;195;199;198;194;214;193 15:24:38 INFO - PROCESS | 1652 | |3;audio-fft;73;51;63;107;88;84;59;59;72;60 15:24:38 INFO - PROCESS | 1652 | |4;audio-oscillator;87;72;83;72;71;71;81;70;70;82 15:24:38 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;88;86;88;85;88;111;137;131;88;86 15:24:38 INFO - PROCESS | 1652 | |6;imaging-darkroom;95;95;105;131;94;94;95;95;95;95 15:24:38 INFO - PROCESS | 1652 | |7;imaging-desaturate;90;95;98;93;94;93;92;110;93;92 15:24:38 INFO - PROCESS | 1652 | |8;json-parse-financial;59;57;59;58;59;59;59;57;58;60 15:24:38 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;69;70;78;78;115;112;83;70;69;70 15:24:38 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;103;82;101;111;106;108;96;88;89;86 15:24:38 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;181;145;153;154;156;166;150;150;192;179 15:24:38 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;173;178;172;170;165;185;175;165;192;175 15:24:38 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;65;75;91;90;85;68;75;82;94;69 15:24:38 INFO - PROCESS | 1652 | __end_tp_report 15:24:38 INFO - PROCESS | 1652 | __start_cc_report 15:24:38 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,943 15:24:38 INFO - PROCESS | 1652 | __end_cc_report 15:24:38 INFO - PROCESS | 1652 | __startTimestamp1480548278473__endTimestamp 15:24:38 INFO - PROCESS | 1652 | 15:24:38 INFO - PROCESS | 1652 | ------- Summary: start ------- 15:24:38 INFO - PROCESS | 1652 | Number of tests: 14 15:24:38 INFO - PROCESS | 1652 | 15:24:38 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:127.60 Median:119.50 stddev:21.91 (18.3%) stddev-sans-first:21.80 15:24:38 INFO - PROCESS | 1652 | Values: 106.0 132.0 176.0 157.0 117.0 120.0 115.0 119.0 117.0 117.0 15:24:38 INFO - PROCESS | 1652 | 15:24:38 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:129.20 Median:122.00 stddev:19.14 (15.7%) stddev-sans-first:18.76 15:24:38 INFO - PROCESS | 1652 | Values: 150.0 116.0 120.0 174.0 124.0 118.0 120.0 114.0 136.0 120.0 15:24:38 INFO - PROCESS | 1652 | 15:24:38 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:202.60 Median:200.00 stddev:12.97 (6.5%) stddev-sans-first:13.76 15:24:38 INFO - PROCESS | 1652 | Values: 203.0 235.0 194.0 201.0 195.0 199.0 198.0 194.0 214.0 193.0 15:24:38 INFO - PROCESS | 1652 | 15:24:38 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:71.60 Median:67.50 stddev:17.09 (25.3%) stddev-sans-first:18.12 15:24:38 INFO - PROCESS | 1652 | Values: 73.0 51.0 63.0 107.0 88.0 84.0 59.0 59.0 72.0 60.0 15:24:38 INFO - PROCESS | 1652 | 15:24:38 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:75.90 Median:76.50 stddev:6.54 (8.5%) stddev-sans-first:5.57 15:24:38 INFO - PROCESS | 1652 | Values: 87.0 72.0 83.0 72.0 71.0 71.0 81.0 70.0 70.0 82.0 15:24:38 INFO - PROCESS | 1652 | 15:24:38 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:98.80 Median:87.00 stddev:20.08 (23.1%) stddev-sans-first:20.92 15:24:38 INFO - PROCESS | 1652 | Values: 88.0 86.0 88.0 85.0 88.0 111.0 137.0 131.0 88.0 86.0 15:24:38 INFO - PROCESS | 1652 | 15:24:38 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:99.40 Median:95.00 stddev:11.57 (12.2%) stddev-sans-first:12.16 15:24:38 INFO - PROCESS | 1652 | Values: 95.0 95.0 105.0 131.0 94.0 94.0 95.0 95.0 95.0 95.0 15:24:38 INFO - PROCESS | 1652 | 15:24:38 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:93.00 stddev:5.68 (6.1%) stddev-sans-first:5.73 15:24:38 INFO - PROCESS | 1652 | Values: 90.0 95.0 98.0 93.0 94.0 93.0 92.0 110.0 93.0 92.0 15:24:38 INFO - PROCESS | 1652 | 15:24:38 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:59.00 stddev:0.97 (1.6%) stddev-sans-first:1.01 15:24:38 INFO - PROCESS | 1652 | Values: 59.0 57.0 59.0 58.0 59.0 59.0 59.0 57.0 58.0 60.0 15:24:38 INFO - PROCESS | 1652 | 15:24:38 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:81.40 Median:70.00 stddev:17.60 (25.1%) stddev-sans-first:18.09 15:24:38 INFO - PROCESS | 1652 | Values: 69.0 70.0 78.0 78.0 115.0 112.0 83.0 70.0 69.0 70.0 15:24:38 INFO - PROCESS | 1652 | 15:24:38 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:97.00 Median:84.00 stddev:10.23 (12.2%) stddev-sans-first:10.62 15:24:38 INFO - PROCESS | 1652 | Values: 103.0 82.0 101.0 111.0 106.0 108.0 96.0 88.0 89.0 86.0 15:24:38 INFO - PROCESS | 1652 | 15:24:38 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:162.60 Median:161.00 stddev:16.06 (10.0%) stddev-sans-first:15.59 15:24:38 INFO - PROCESS | 1652 | Values: 181.0 145.0 153.0 154.0 156.0 166.0 150.0 150.0 192.0 179.0 15:24:38 INFO - PROCESS | 1652 | 15:24:38 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:175.00 stddev:8.41 (4.8%) stddev-sans-first:8.89 15:24:38 INFO - PROCESS | 1652 | Values: 173.0 178.0 172.0 170.0 165.0 185.0 175.0 165.0 192.0 175.0 15:24:38 INFO - PROCESS | 1652 | 15:24:38 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.40 Median:83.50 stddev:10.45 (12.5%) stddev-sans-first:9.70 15:24:38 INFO - PROCESS | 1652 | Values: 65.0 75.0 91.0 90.0 85.0 68.0 75.0 82.0 94.0 69.0 15:24:38 INFO - PROCESS | 1652 | -------- Summary: end -------- 15:24:38 INFO - PROCESS | 1652 | 15:24:39 INFO - TEST-INFO | 1652: exit 0 15:24:39 INFO - TEST-OK | kraken | took 61759ms 15:24:39 INFO - SUITE-END | took 1177s 15:24:39 INFO - Completed test suite (00:19:38) 15:24:39 INFO - javascript benchmark 15:24:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7040.754021197438, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2850.7719382449404, 3366.276250606121, 3374.746893982952, 3392.067181525079, 3422.0760394693434, 5540.307461567304, 5576.944230557693, 5583.609147359686, 5638.323401191858, 5681.744321505532, 5192.688438693681, 5538.030844602188, 5612.831615051545, 5711.428857114297, 5717.085266357383, 3767.8869633911027, 5084.822031228908, 5249.18637611169, 5263.736813159346, 5273.9736301318635, 5107.131787596099, 5239.13554263546, 5253.9737301313635, 5297.523222909937, 5309.0, 5087.465816089294, 5129.333186685707, 5188.247704082924, 5190.71451070191, 5234.18870075139, 5080.517350851663, 5119.539241468286, 5156.535911767959, 5202.713850738208, 5205.427402985669, 3863.497745293122, 4770.308305295747, 5037.19404895215, 5094.337736094321, 5112.59099272061, 5542.972285138549, 5573.498385145316, 5586.469285417878, 5586.804461843856, 5610.915836262459, 4954.702717836942, 6023.638581685069, 6030.366811484775, 6035.456808887221, 6120.265568131853, 6123.4656464211685, 6134.742747059152, 6156.0, 6156.322804491502, 6166.969165154145, 5745.08078707409, 5746.626469279525, 5757.251557297524, 5781.94218057814, 5785.71071446426, 6129.724162412702, 6246.219222597176, 6261.78083767066, 6266.0, 6301.0, 5874.206982057453, 5877.089051197071, 5882.0, 6022.3676513966275, 6057.151998720183, 6110.923300256496, 6134.19168101403, 6144.218176728698, 6212.254529456403, 6223.657698826518, 5973.850653733604, 6052.878942421215, 6066.878662426815, 6090.3605121461605, 6115.602485838406, 6144.187464697925, 6186.81439556814, 6188.4739797116845, 6195.752169913243, 6213.03697926822, 4858.562729354305, 4872.8781780455065, 4874.2201247800185, 4875.780589873464, 4915.778789954461, 4272.530021697611, 4277.764722940268, 4282.5075116361395, 4322.459692538433, 4343.305071188594, 5541.141123125922, 5736.483716465538, 5741.397153298927, 5750.769969201185, 5782.826515204551, 5308.0710875596615, 6190.907136392958, 6204.937950620436, 6213.471854892295, 6227.377262273736, 5637.154426835926, 5695.6582605043, 5710.685912274865, 5716.542676585863, 5725.713714314351, 4430.5126436092005, 5282.920756188661, 5307.0, 5336.759845806948, 5337.172738225581, 6260.154879091265, 6286.0, 6297.118403423525, 6305.0, 6313.589616674902, 6119.388061193845, 6232.439080482597, 6235.875282494416, 6241.251049874044, 6259.405356491126, 5338.839834804962, 5910.936031514369, 6199.039148931923, 6200.255969283535, 6205.286392064971, 6007.30915944672, 6033.668148251888, 6046.7581296749395, 6070.696465176635, 6088.086786981989, 6133.907991380043, 6160.599561028698, 6188.721507532082, 6198.0702894566175, 6224.315325314121, 4902.534259245509, 5986.072158815216, 6001.909971350346, 6004.0, 6048.0625503047095, 4701.435827700698, 5778.04662230744, 5781.046127388934, 5889.998700220887, 5928.762849485972, 4424.623906967944, 4953.826616068421, 5084.135696931457, 5795.8551036224435, 5937.495312898279, 6007.038873780174, 6031.849203769941, 6034.939650603438, 6041.214642096499, 6051.001584738468, 4753.334533165429, 5832.708364581838, 5886.381929897299, 5893.675847828411, 5903.91144132847], "value": 5545.916011572163, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [458.2484725050917, 504.33427875204734, 523.1942808075564, 532.7416203141478, 540.6161625246075, 33986.49020264695, 36222.0, 39622.00944976373, 40937.7953110234, 41058.58941410585, 39942.8002859986, 40402.19195616093, 40427.595724042825, 40514.79742601283, 40567.797161014154, 9192.402493837895, 9375.81248375032, 9394.060593940585, 11022.834657480103, 11399.829002564968, 9863.457509836957, 10841.83737243942, 11256.212065155443, 11354.43227838609, 11380.260283081614, 11310.151738619596, 11334.206605537616, 11390.25963312382, 11400.201985860993, 11419.486123124438, 11262.718432039183, 11284.492197851076, 11299.322040677585, 11302.773944521146, 11321.981021708003, 11123.944380278128, 11164.609238676689, 11191.496382662799, 11203.66389008323, 11206.943965280203, 38138.618613813785, 38295.42556861649, 38484.84545463641, 38534.0, 38603.61396386056, 3262.21706790371, 3336.7831090979007, 3364.8485818138242, 3404.4042292598697, 3815.656590906804, 29115.0, 29318.413631727246, 29866.80532778708, 29875.551866722017, 30019.699803002128, 3248.983755081233, 3273.558069660613, 3276.9836150819333, 3282.195862013798, 3329.450640644315, 396024.0, 426242.0, 430538.8473057646, 431147.0, 529100.0, 54252.91494170173, 57934.71032644894, 58261.70869145712, 58793.0, 58868.41131588715, 59983.70008150019, 61282.0, 61615.69192154011, 61844.0, 61852.0, 15207.61980950463, 15462.84537154614, 15468.303926323342, 15675.294611742498, 15697.764533532007, 10792.51433685486, 11098.722531936766, 11702.414879256174, 12057.276563406223, 12057.879421205676, 18300.81044732088, 18392.816071839112, 18393.34459898589, 18425.26298948054, 18441.354552590594, 7579.848403032019, 7777.250118723355, 7783.763330578398, 7794.246294583787, 7809.648565814438, 828.8010877389383, 831.2601784411878, 901.5176880369103, 907.5416914458157, 939.7227817793768, 28743.281417964718, 28880.0, 29131.126066218047, 29321.413571728444, 29366.412671746446, 934.7476181431111, 1005.562580277567, 1040.3497813866334, 1042.6924057403085, 1145.169751929844, 14586.562403127924, 14857.925710371379, 14955.0, 15110.320035598425, 15333.233338333039, 422128.77871220896, 435785.0, 516000.0, 516374.0, 563924.0, 42036.789816051336, 42650.360244596355, 53811.19283210755, 53899.999999999214, 54264.45735542673, 1119.3843386137592, 1287.0668765145194, 1304.7586196553668, 1325.1254172246272, 1330.3215360166384, 27894.721052790024, 28691.0, 28885.42229155363, 29377.559336610397, 29386.412271754874, 47225.291620626405, 47673.0, 47679.0, 47755.04489910252, 47912.0, 411315.0, 490068.0, 490422.0, 491356.0, 492825.0, 22381.88809055944, 23025.539489209787, 24733.87633061823, 25466.363340916625, 25499.0, 31786.205344865637, 43577.0, 43708.0, 44274.11451770882, 44395.556044439145, 31686.841565792023, 34591.827040864635, 36221.63778362182, 36349.27301453903, 37554.62445375511, 36040.91877243687, 36154.81922590476, 36313.092172694836, 37422.438663419525, 37656.68201612931, 35740.46389304214, 36152.819235903655, 36441.453378199876, 36684.0, 36789.81605091957, 30038.0, 32441.0, 32565.674343256265, 32736.83631581827, 32880.50679239861, 24197.395065122808, 24298.448662890143, 24390.75609243885, 24721.13476028402, 24788.628170577096], "value": 19305.091328305043, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.8571871220526, 366.364357839149, 369.44029794860785, 378.60246740922025, 398.4899328859061, 18443.53891152722, 19194.9442780647, 19380.321688740896, 19892.104855281494, 20130.89934550325, 19162.808371916275, 19542.511437214078, 19957.800421995777, 20116.698249526267, 20143.992800359996, 5338.359396872371, 5382.461753824626, 5579.609427340088, 5612.971935140318, 5613.522850557708, 5519.420460851613, 5692.288463942007, 5699.088145896658, 5701.885962280752, 5730.971345143268, 5596.104623260279, 5648.576356773238, 5650.463205995424, 5655.632383895034, 6073.0, 6326.746930122789, 6475.125858009203, 6500.577462464925, 6513.055606936968, 6524.314946930552, 5538.280023596947, 5736.483716465496, 5752.612665743712, 5804.62269952456, 5807.506361959238, 12436.129470937038, 12635.052371072206, 12721.618351449471, 12841.1011229214, 12881.355932203445, 2112.324056301984, 2266.0822366941416, 2279.2250634784255, 2417.8065754739578, 2600.24592868068, 9646.710598682052, 10070.44612546317, 10228.64199753005, 10772.515236814284, 13744.381502832397, 1579.8973066750739, 1653.5535405440585, 1723.8448539631368, 1726.1714377098938, 1871.9064046797741, 89499.21001579997, 110716.4464177682, 111588.0, 116836.41581792121, 117351.0, 10034.749131271778, 11315.20793544444, 11343.546258149581, 11507.252028618113, 11671.59149429766, 14341.64145896361, 14473.710525789636, 14504.927475362556, 14512.62130097639, 14513.782293265609, 8067.233612806774, 8239.258466738022, 8271.917280827114, 8376.748697539084, 8410.915890841014, 7955.761327160194, 8061.596920154087, 8064.637091330904, 8091.109977902426, 8179.0, 3718.665320121202, 4056.7971601419813, 4338.3709362142945, 4444.911101777946, 4448.288273876229, 1642.3266460751036, 1887.9150438230313, 1917.980820191808, 1919.9808001920082, 1925.1433112265188, 778.6846327237478, 837.5435387713711, 856.7900864288165, 893.2095095840228, 927.9768005799774, 19584.60830783405, 20028.69956950647, 20068.297609583595, 20296.898515507328, 20427.392228687793, 806.9193080692002, 869.7912500999842, 872.3785025996839, 877.2762470961483, 888.7868060098049, 9625.855612165824, 9697.321187516805, 10666.786664266827, 10710.143188544898, 10797.46012699362, 433711.0, 511510.0, 511646.0, 523561.0, 526644.7335526672, 109115.0, 122203.0, 122359.38820305842, 125799.0, 125912.0, 829.9128591497927, 950.3300173377752, 969.0648524174065, 987.0918754745651, 993.1955116355775, 14139.929300353433, 17625.73561396606, 18407.263709452007, 18457.0, 18488.890666560048, 37798.81100594479, 40249.1950161001, 50225.497745023546, 52151.73924130507, 52209.0, 51605.741971291405, 63752.681236595374, 68785.59250426412, 72241.0, 74095.88856167269, 7547.471676982558, 7684.231576842271, 7816.179301173295, 7959.243871832166, 7983.002124734408, 11660.183787135158, 11693.766124677288, 11911.166218364979, 12029.15795894314, 12285.0, 8416.915830841614, 10365.585376584851, 10516.894831051592, 10578.0, 10807.783844322912, 10344.37933723979, 10428.217883658908, 10449.373037617766, 10554.630587929692, 10808.081313088476, 10527.894721052691, 10628.84056739165, 10775.838362424727, 10783.784324313312, 10967.780644387227, 7527.096748390229, 7819.827025946153, 7894.881576776468, 7903.288704016666, 8101.068377136469, 10160.695179144637, 10527.684169474927, 10528.684139475828, 10580.788384232119, 10922.836157457803], "value": 8965.802623843994, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.5786627212428, 1465.1941432212284, 1630.6820170066835, 1770.530809335527, 1796.3892276625936, 7424.925750742491, 7690.461667683265, 7962.203779622042, 8408.873866891994, 8412.747617571475, 7937.365010799137, 8236.711715089958, 8241.546714930677, 8355.164483551642, 8361.456505327149, 2268.319504148757, 2281.258590957945, 2297.7012988311494, 2297.9425514362106, 2306.9653955190684, 2287.5653625811124, 2314.166899916029, 2325.767423257678, 2339.6022676145094, 2340.637201233803, 2270.591293567157, 2275.1581914691587, 2289.2559918026623, 2295.7704229577075, 2303.4586872085047, 2261.118163916074, 2272.534130503243, 2286.085565773687, 2290.1869836208075, 2294.89672964717, 2293.575688497633, 2299.85050971688, 2305.020366344297, 2307.077169132344, 2313.1556981701556, 8250.587470626504, 8341.916580834235, 8374.581270936429, 8377.95811020941, 8434.072252052269, 5033.043721692867, 5137.075326441239, 5189.143791274435, 5199.298094757235, 5218.112920803473, 2718.9456210875674, 3237.9352412951607, 3530.258645684409, 3541.097020259843, 3542.433210686278, 855.4995327733284, 917.47703808829, 1058.3596923861107, 1059.5496913811676, 1089.411717672456, 8673.783155421102, 9517.714468565884, 10480.94759526205, 10723.0, 10832.566697332097, 3689.856144595184, 4313.374560688682, 4396.538363471789, 4419.867403977886, 4424.867253982386, 8493.405461617751, 8579.485230886166, 8579.699710510102, 8599.484030958163, 8662.35032372562, 4964.304997300381, 5045.621578381636, 5049.469805670426, 5057.949420505748, 5070.315507406527, 4269.658427325807, 4716.976415117971, 4770.451398089194, 4776.59398951093, 4798.448178459452, 3523.119220194951, 3575.713942884563, 3612.945805812915, 3648.2338708871434, 3658.743887927873, 1134.4497918509517, 1150.9827352589718, 1152.7607821591655, 1156.9132315076404, 1158.0966845860241, 778.5601135358504, 791.6081539637801, 812.1675282835141, 908.8273228086642, 931.3108299858056, 5506.146547285177, 5599.384067752544, 5629.380768115504, 5727.885442291131, 5749.68376739275, 357.80499627702966, 421.6668831623045, 428.27621319969154, 433.9652827773834, 435.98692039238875, 3432.982835085809, 3899.0447340401215, 3915.9608403915595, 3985.143194213258, 3996.360582306817, 9455.858162127573, 9871.358361706467, 9890.703278901645, 10046.648367307109, 10053.597856085675, 9435.811283774286, 9817.852732209023, 9933.950330248303, 9947.900520994843, 9981.850272245922, 7568.940348351235, 7788.454808163374, 7800.063992320957, 7804.414668899855, 7849.764507064797, 4451.7996690148375, 4871.561559459666, 5497.725113744376, 5720.971395143164, 5807.477327040418, 9170.495622740813, 9176.908230917872, 9244.029376915596, 9271.30465215098, 9294.349395542247, 9059.818803624023, 9254.35219534626, 9291.163795258459, 9347.252219822261, 9381.296402769683, 6425.389587989133, 6634.933650663625, 6832.897506537306, 6972.407345375497, 7174.784756457106, 7626.8093297668, 7784.338331241682, 7832.412569057457, 7849.803754906173, 7866.7639970800965, 6843.0, 7012.088428504466, 7023.683934223074, 7074.752383666753, 7120.857582848417, 6870.862582748417, 6896.7586134485055, 6924.203716572659, 6944.930550694428, 7041.5422997505, 6385.489160867027, 6533.444657204001, 6620.106285651568, 6658.3674550917585, 6663.733450661919, 4126.319157339006, 4852.44196917359, 4906.215005599087, 4925.261210818406, 4983.551480366639, 4540.636749060001, 4802.687825291345, 4881.023795240895, 4963.404391473046, 5075.3402057732255], "value": 4227.555358847323, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.7486050264008, 298.33917871913707, 308.8749056632064, 310.7917695144253, 311.71945249275666, 4998.600111991041, 5375.032494151061, 5458.781648734046, 5598.0, 5605.27131472909, 5021.5229553192385, 5474.452554744534, 5476.3702174249975, 5479.753301146531, 5531.308586426697, 3321.8671253149846, 4207.537170911197, 4221.092465120007, 4230.873073807791, 4310.396544483775, 3723.813809309537, 4173.707840451155, 4212.241796476633, 4246.830126794925, 4251.277282861921, 3458.5849698036272, 3851.34392211349, 4155.501339839224, 4156.293430116887, 4165.20965921012, 3657.4696668982847, 4149.356849688304, 4168.416421700964, 4179.185058913513, 4208.347706105528, 3442.347673116893, 3463.9134021649406, 3659.14010207601, 3665.963340366589, 3667.559892812853, 4269.359596060584, 5218.947810521884, 5225.425203227642, 5322.270262164812, 5408.540274076709, 4186.958130418688, 4359.4306049822035, 4448.488423831269, 4458.331250312447, 4783.736894470802, 4785.688930219525, 5776.59563830532, 5802.839432113594, 5805.448482394166, 5905.1103646833035, 3478.617352091268, 3564.6078931317534, 3908.921821563553, 3924.352481840493, 3933.331333673282, 5533.612647114704, 5997.970010149921, 6065.63606183626, 6114.419130182626, 6173.197484327054, 3449.862005519801, 3524.69586253088, 3861.3896007233325, 4003.739756915791, 4029.879103626896, 3255.3977514159956, 3389.4237979543045, 3846.9230615387537, 3982.4026396040244, 4022.0, 4716.915109524829, 4747.359106520645, 4756.357891684578, 4770.666053376231, 4779.426468823764, 5867.882642347129, 5914.733836977346, 5915.438033386821, 5942.732577034044, 5988.113744170572, 1163.2438914705508, 1213.3326670331282, 1214.5789426371166, 1243.5523211643801, 1270.3775150176532, 745.8881167824869, 766.7961300757756, 843.7468759372164, 867.8958524976916, 885.1944730295401, 5091.389033316026, 5194.870128246748, 5218.0, 5234.031704134747, 5247.2653828464045, 4441.267190913463, 5047.343845300087, 5125.411122552021, 5538.667679939216, 5696.259486266842, 4777.784999675023, 4981.729658936948, 5210.53105220532, 5238.842834714965, 5243.606729495303, 2402.9879850600983, 2987.268119310783, 3017.3060196155006, 3039.4984827503213, 3048.8780448782245, 4884.780184891689, 5958.659301657092, 5963.554942473652, 5987.401259874065, 6002.939970600325, 4934.679245849008, 5176.715280659525, 5659.320881494247, 5791.276090488689, 6095.908561371583, 5280.841574752763, 5522.337319521683, 5931.584789064724, 5948.018576934757, 6020.397960204032, 4722.858314250578, 4774.379330686988, 5236.476352364733, 5665.66006039639, 5703.093381034005, 5556.38879723222, 5978.581499295007, 6012.076135636555, 6019.969900150471, 6077.0, 5703.942960570507, 6224.470919971672, 6248.187735594343, 6253.15330166296, 6267.4986001120715, 3270.6238782540313, 3727.030971947259, 3969.1069509360163, 4022.175454031858, 4029.3150164472695, 5650.745716442688, 6015.699215039318, 6044.516438684983, 6059.394060594082, 6074.574779765374, 5338.519533242027, 5628.774849005994, 5737.5983681141915, 5867.882642347044, 5922.763089476372, 4854.927176092291, 5815.476607105381, 5819.214406055128, 5835.533157347317, 5884.205632239593, 4563.520830312769, 4753.0, 5475.72621368938, 5675.375708671961, 5724.198612194213, 4725.645576581839, 5105.744712764421, 5782.710864456676, 5876.415386614077, 5878.823635290948, 4904.779284932258, 5732.254806875247, 5805.680687562224, 5858.0, 5860.706964651665], "value": 4134.868178672779, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.7999810057934, 703.8838591632377, 761.2083433229442, 769.3883362726632, 805.1746959366649, 14752.0, 15652.921735391306, 15664.138472384015, 15671.138087405203, 15693.215339233035, 14051.156930584171, 14188.219647919386, 14204.857951420508, 14214.431422743104, 14231.71536569268, 654.9836254093639, 675.0987431778582, 807.2492581898846, 809.9635516401776, 834.6577903059747, 826.0789220019694, 841.154639587214, 842.0274582856811, 842.2419822160043, 846.1369403208723, 846.4540371460404, 886.3352485635774, 886.7118186589352, 890.3678388344283, 893.1068931068932, 852.3990586636437, 861.9569021548898, 881.2773525708922, 887.658251573149, 893.1024320557863, 645.2063961327547, 661.5633681770057, 661.7816120680164, 662.3674390956625, 665.5108495256031, 14239.074460160056, 14287.78568321476, 14712.779308310384, 14731.852681473263, 14738.042027268193, 13999.166716266922, 14117.435302587885, 14130.92934535331, 14294.02840301436, 14604.12375257488, 11603.4198290086, 11794.823077653757, 11834.230774999598, 11839.052875769918, 11945.522179112824, 3190.6171259448784, 3571.1072231942017, 3699.3896007158787, 3798.2593394288124, 3852.248811481762, 111571.44214278877, 113479.86520134775, 113540.0, 114246.0, 115731.0, 9380.272857135677, 10777.922207779317, 10867.673969780919, 10886.346819190874, 10893.346399216072, 20729.0, 20732.274370397266, 20736.688949665768, 20751.962401879846, 20775.272865449635, 6713.26154123046, 7454.440916931252, 7502.699892004368, 7556.622168891534, 7635.389168866477, 3640.399334109842, 4246.044639955985, 4277.743335399886, 4369.847055353048, 4423.0048239145935, 3502.614712381636, 3597.4244120940525, 3617.7829330239742, 3618.620044895248, 3650.5071815305123, 653.947684185264, 670.2426258328059, 690.2441826200303, 700.663681432915, 702.3398005874461, 546.734942503687, 553.1265077920166, 588.4703766609999, 593.7684303121786, 660.9768658096943, 9053.864192037125, 9350.345475816763, 9444.527773611291, 9499.90500095004, 9596.66411675588, 443.64687702507223, 568.4060157135802, 596.4998029954668, 659.577870163096, 678.3250665587772, 4438.578335058164, 4578.931316030262, 4606.8157273708675, 4610.631149508098, 4639.837605683785, 91380.54309728542, 92370.53814730883, 97247.0, 101001.49499252603, 109637.45181274202, 99549.00450995397, 100301.0, 100487.49756251172, 101084.49457752664, 101728.0, 58218.8356232873, 74499.62750186214, 78410.0, 82823.17176828155, 83392.58303708442, 7727.806804829925, 8562.828743425222, 8731.214190722865, 8911.866322005304, 8964.955175224082, 46461.53538464572, 51370.22944655908, 53518.197227040844, 53875.461245388615, 54189.18716219181, 73910.0, 78321.60839195768, 82014.58992704998, 82869.58565207136, 82950.17049829425, 11501.367424791717, 11587.188896777145, 11712.648620541397, 11745.588904388305, 11976.28142311464, 12724.109312348417, 12916.612501624966, 12979.0, 13094.738105238033, 13768.793468097787, 11921.582744603897, 12223.511059557519, 12245.387730613256, 12263.632091037283, 12641.2415255085, 12073.637790866289, 12096.274223546616, 12323.44544495482, 12483.563075292685, 12492.000639948601, 11770.234934729215, 11921.225120367148, 11944.522219111139, 12050.578229761917, 12133.21134126279, 9484.857727134236, 9879.357841740264, 9945.900540994497, 10092.697219083146, 10116.494175291058, 9483.430994140374, 10355.378677279086, 10371.68884933423, 10407.791844163226, 10438.68683939483], "value": 7259.103923114278, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1554.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 132.0, 176.0, 157.0, 117.0, 120.0, 115.0, 119.0, 117.0, 117.0], "value": 127.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 116.0, 120.0, 174.0, 124.0, 118.0, 120.0, 114.0, 136.0, 120.0], "value": 129.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 235.0, 194.0, 201.0, 195.0, 199.0, 198.0, 194.0, 214.0, 193.0], "value": 202.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 51.0, 63.0, 107.0, 88.0, 84.0, 59.0, 59.0, 72.0, 60.0], "value": 71.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 83.0, 72.0, 71.0, 71.0, 81.0, 70.0, 70.0, 82.0], "value": 75.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 85.0, 88.0, 111.0, 137.0, 131.0, 88.0, 86.0], "value": 98.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 105.0, 131.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 99.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 95.0, 98.0, 93.0, 94.0, 93.0, 92.0, 110.0, 93.0, 92.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 59.0, 58.0, 59.0, 59.0, 59.0, 57.0, 58.0, 60.0], "value": 58.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 78.0, 78.0, 115.0, 112.0, 83.0, 70.0, 69.0, 70.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 82.0, 101.0, 111.0, 106.0, 108.0, 96.0, 88.0, 89.0, 86.0], "value": 97.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 145.0, 153.0, 154.0, 156.0, 166.0, 150.0, 150.0, 192.0, 179.0], "value": 162.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 178.0, 172.0, 170.0, 165.0, 185.0, 175.0, 165.0, 192.0, 175.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 75.0, 91.0, 90.0, 85.0, 68.0, 75.0, 82.0, 94.0, 69.0], "value": 79.4, "unit": "score"}]}]} 15:24:39 INFO - Return code: 0 15:24:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:24:39 ERROR - # TBPL SUCCESS # 15:24:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:24:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:24:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:24:39 INFO - 2016-11-30 15:24:39.795 screenresolution[1657:10842] starting screenresolution argv=screenresolution get 15:24:39 INFO - 2016-11-30 15:24:39.798 screenresolution[1657:10842] Display 0: 1600x1200x32@60 15:24:39 INFO - 2016-11-30 15:24:39.803 screenresolution[1658:10845] starting screenresolution argv=screenresolution list 15:24:39 INFO - Available Modes on Display 0 15:24:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:24:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:24:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:24:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:24:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:24:40 INFO - Intel Iris: 15:24:40 INFO - Chipset Model: Intel Iris 15:24:40 INFO - Type: GPU 15:24:40 INFO - Bus: Built-In 15:24:40 INFO - VRAM (Dynamic, Max): 1536 MB 15:24:40 INFO - Vendor: Intel (0x8086) 15:24:40 INFO - Device ID: 0x0a2e 15:24:40 INFO - Revision ID: 0x0009 15:24:40 INFO - Displays: 15:24:40 INFO - Display: 15:24:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:24:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:24:40 INFO - Display Serial Number: 1600x1200 60 15:24:40 INFO - Main Display: Yes 15:24:40 INFO - Mirror: Off 15:24:40 INFO - Online: Yes 15:24:40 INFO - Rotation: Supported 15:24:40 INFO - Return code: 0 15:24:40 INFO - Running post-action listener: _resource_record_post_action 15:24:40 INFO - [mozharness: 2016-11-30 23:24:40.034521Z] Finished run-tests step (success) 15:24:40 INFO - Running post-run listener: _resource_record_post_run 15:24:40 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 38599168; Write bytes: 693726208; Read time: 241; Write time: 2031 15:24:40 INFO - TinderboxPrint: CPU usage
54.5% 15:24:40 INFO - TinderboxPrint: I/O read bytes / time
38,599,168 / 241 15:24:40 INFO - TinderboxPrint: I/O write bytes / time
693,726,208 / 2,031 15:24:40 INFO - TinderboxPrint: CPU idle
2,206.8 (45.5%) 15:24:40 INFO - TinderboxPrint: CPU system
979.2 (20.2%) 15:24:40 INFO - TinderboxPrint: CPU user
1,659.8 (34.3%) 15:24:40 INFO - TinderboxPrint: Swap in / out
422,223,872 / 0 15:24:40 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 384483840; Write bytes: 377981952; Read time: 29274; Write time: 809 15:24:40 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 35416576; Write bytes: 305537024; Read time: 217; Write time: 1181 15:24:40 INFO - Running post-run listener: _upload_blobber_files 15:24:40 INFO - Blob upload gear active. 15:24:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:24:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:24:40 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'] 15:24:40 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 15:24:41 INFO - (blobuploader) - INFO - Open directory for files ... 15:24:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:24:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:24:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:24:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:24:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:24:42 INFO - (blobuploader) - INFO - Done attempting. 15:24:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:24:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:24:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:24:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:24:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:24:43 INFO - (blobuploader) - INFO - Done attempting. 15:24:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:24:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:24:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:24:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:24:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:24:45 INFO - (blobuploader) - INFO - Done attempting. 15:24:45 INFO - (blobuploader) - INFO - Iteration through files over. 15:24:45 INFO - Return code: 0 15:24:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:24:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:24:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49aa4452e4fc95d736fd9aaf4224b65b8d066195b0ef1b1b36356de1b0543459ddb9b7d9d73616d75cdffac28fab43eea88206a1c4fb8e46d5231910811f6d61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e20a99ed050033575c4fdeeea9062d63ec5c4bab775d4af84a196a34d8c27de6f45ea1f75b8db382406bc6df9fd756d5477069f7b3d59f42090bc2840f22bdff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffa6a4249867ffb29a17b3b416521cc53301ba3fab10523aadd35d61e76d53f7f8cf582032f5cbe4b32b3c9b26a1be6e192e8ae4e9bf1e1c1bc0b2bc40233889"} 15:24:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:24:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:24:45 INFO - Contents: 15:24:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49aa4452e4fc95d736fd9aaf4224b65b8d066195b0ef1b1b36356de1b0543459ddb9b7d9d73616d75cdffac28fab43eea88206a1c4fb8e46d5231910811f6d61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e20a99ed050033575c4fdeeea9062d63ec5c4bab775d4af84a196a34d8c27de6f45ea1f75b8db382406bc6df9fd756d5477069f7b3d59f42090bc2840f22bdff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffa6a4249867ffb29a17b3b416521cc53301ba3fab10523aadd35d61e76d53f7f8cf582032f5cbe4b32b3c9b26a1be6e192e8ae4e9bf1e1c1bc0b2bc40233889"} 15:24:45 INFO - Running post-run listener: copy_logs_to_upload_dir 15:24:45 INFO - Copying logs to upload dir... 15:24:45 INFO - mkdir: /builds/slave/test/build/upload/logs 15:24:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.716766 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-11-30 15:24:45.858241) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 15:24:45.865792) ========= 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.dh4MIzlSIG/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.mTptfWQ2wa/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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/49aa4452e4fc95d736fd9aaf4224b65b8d066195b0ef1b1b36356de1b0543459ddb9b7d9d73616d75cdffac28fab43eea88206a1c4fb8e46d5231910811f6d61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e20a99ed050033575c4fdeeea9062d63ec5c4bab775d4af84a196a34d8c27de6f45ea1f75b8db382406bc6df9fd756d5477069f7b3d59f42090bc2840f22bdff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffa6a4249867ffb29a17b3b416521cc53301ba3fab10523aadd35d61e76d53f7f8cf582032f5cbe4b32b3c9b26a1be6e192e8ae4e9bf1e1c1bc0b2bc40233889"} build_url:https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011144 build_url: 'https://queue.taskcluster.net/v1/task/Yqq93reKSnCige2qZRrWpg/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/49aa4452e4fc95d736fd9aaf4224b65b8d066195b0ef1b1b36356de1b0543459ddb9b7d9d73616d75cdffac28fab43eea88206a1c4fb8e46d5231910811f6d61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e20a99ed050033575c4fdeeea9062d63ec5c4bab775d4af84a196a34d8c27de6f45ea1f75b8db382406bc6df9fd756d5477069f7b3d59f42090bc2840f22bdff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffa6a4249867ffb29a17b3b416521cc53301ba3fab10523aadd35d61e76d53f7f8cf582032f5cbe4b32b3c9b26a1be6e192e8ae4e9bf1e1c1bc0b2bc40233889"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 15:24:45.907772) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 15:24:45.908271) ========= 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.dh4MIzlSIG/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.mTptfWQ2wa/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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.005016 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 15:24:45.957217) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 15:24:45.957557) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 15:24:45.957964) ========= ========= Total master_lag: 0.20 =========