builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0218 starttime: 1492172784.07 results: success (0) buildid: 20170414030225 builduid: 956a059a4b004398a141ac7eb03cff05 revision: cda24082bff8864a6e53726feeae33cae9e17309 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-14 05:26:24.069525) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-14 05:26:24.070013) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-14 05:26:24.070322) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-14 05:26:24.097679) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 05:26:24.098103) ========= 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.ZHpKZtHyts/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.RlzeVJuAPF/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-14 05:26:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2017-04-14 05:26:24 (18.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085037 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 05:26:24.211146) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 05:26:24.211908) ========= 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.ZHpKZtHyts/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.RlzeVJuAPF/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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.026623 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 05:26:24.265879) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-14 05:26:24.266693) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cda24082bff8864a6e53726feeae33cae9e17309 --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 cda24082bff8864a6e53726feeae33cae9e17309 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZHpKZtHyts/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.RlzeVJuAPF/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-14 05:26:24,373 truncating revision to first 12 chars 2017-04-14 05:26:24,373 Setting DEBUG logging. 2017-04-14 05:26:24,374 attempt 1/10 2017-04-14 05:26:24,374 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cda24082bff8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-14 05:26:26,060 unpacking tar archive at: mozilla-central-cda24082bff8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.961901 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-14 05:26:26.256273) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-14 05:26:26.257795) ========= script_repo_revision: cda24082bff8864a6e53726feeae33cae9e17309 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-14 05:26:26.258840) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-14 05:26:26.259654) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-14 05:26:26.280069) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-14 05:26:26.280383) ========= /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.ZHpKZtHyts/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.RlzeVJuAPF/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 05:26:26 INFO - MultiFileLogger online at 20170414 05:26:26 in /builds/slave/test 05:26:26 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 05:26:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:26:26 INFO - {'append_to_log': False, 05:26:26 INFO - 'base_work_dir': '/builds/slave/test', 05:26:26 INFO - 'blob_upload_branch': 'Firefox', 05:26:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:26:26 INFO - 'branch': 'Firefox', 05:26:26 INFO - 'buildbot_json_path': 'buildprops.json', 05:26:26 INFO - 'config_files': ('talos/mac_config.py',), 05:26:26 INFO - 'default_actions': ('clobber', 05:26:26 INFO - 'read-buildbot-config', 05:26:26 INFO - 'download-and-extract', 05:26:26 INFO - 'populate-webroot', 05:26:26 INFO - 'create-virtualenv', 05:26:26 INFO - 'install', 05:26:26 INFO - 'run-tests'), 05:26:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:26:26 INFO - 'download_minidump_stackwalk': True, 05:26:26 INFO - 'download_symbols': 'ondemand', 05:26:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:26:26 INFO - 'tooltool.py': '/tools/tooltool.py', 05:26:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:26:26 INFO - '/tools/misc-python/virtualenv.py')}, 05:26:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:26:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:26:26 INFO - 'gecko_profile': False, 05:26:26 INFO - 'gecko_profile_interval': 0, 05:26:26 INFO - 'installer_path': 'installer.exe', 05:26:26 INFO - 'log_level': 'info', 05:26:26 INFO - 'log_name': 'talos', 05:26:26 INFO - 'log_to_console': True, 05:26:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:26:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:26:26 INFO - 'opt_config_files': (), 05:26:26 INFO - 'pip_index': False, 05:26:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:26:26 INFO - 'cmd': ('bash', 05:26:26 INFO - '-c', 05:26:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:26:26 INFO - 'enabled': True, 05:26:26 INFO - 'halt_on_failure': False, 05:26:26 INFO - 'name': 'check_screen_resolution'},), 05:26:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:26:26 INFO - 'cmd': ('bash', 05:26:26 INFO - '-c', 05:26:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:26:26 INFO - 'enabled': True, 05:26:26 INFO - 'halt_on_failure': False, 05:26:26 INFO - 'name': 'check_screen_resolution'},), 05:26:26 INFO - 'run_cmd_checks_enabled': True, 05:26:26 INFO - 'suite': 'dromaeojs-e10s', 05:26:26 INFO - 'system_bits': '32', 05:26:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:26:26 INFO - 'title': 't-yosemite-r7-0218', 05:26:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:26:26 INFO - 'use_talos_json': True, 05:26:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:26:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:26:26 INFO - 'work_dir': 'build'} 05:26:26 INFO - [mozharness: 2017-04-14 12:26:26.493102Z] Running clobber step. 05:26:26 INFO - Running pre-action listener: _resource_record_pre_action 05:26:26 INFO - Running main action method: clobber 05:26:26 INFO - rmtree: /builds/slave/test/build 05:26:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:26:28 INFO - Running post-action listener: _resource_record_post_action 05:26:28 INFO - [mozharness: 2017-04-14 12:26:28.968932Z] Finished clobber step (success) 05:26:28 INFO - [mozharness: 2017-04-14 12:26:28.969066Z] Running read-buildbot-config step. 05:26:28 INFO - Running pre-action listener: _resource_record_pre_action 05:26:28 INFO - Running main action method: read_buildbot_config 05:26:28 INFO - Using buildbot properties: 05:26:28 INFO - { 05:26:28 INFO - "project": "", 05:26:28 INFO - "product": "firefox", 05:26:28 INFO - "script_repo_revision": "production", 05:26:28 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:26:28 INFO - "repository": "", 05:26:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:26:28 INFO - "buildid": "20170414030225", 05:26:28 INFO - "stage_platform": "macosx64", 05:26:28 INFO - "basedir": "/builds/slave/test", 05:26:28 INFO - "nightly_build": "True", 05:26:28 INFO - "buildnumber": 22, 05:26:28 INFO - "slavename": "t-yosemite-r7-0218", 05:26:28 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 05:26:28 INFO - "platform": "yosemite_r7", 05:26:28 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:26:28 INFO - "branch": "mozilla-central", 05:26:28 INFO - "repo_path": "mozilla-central", 05:26:28 INFO - "revision": "cda24082bff8864a6e53726feeae33cae9e17309", 05:26:28 INFO - "pgo_build": "False", 05:26:28 INFO - "builduid": "956a059a4b004398a141ac7eb03cff05", 05:26:28 INFO - "slavebuilddir": "test" 05:26:28 INFO - } 05:26:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 05:26:28 INFO - Running post-action listener: _resource_record_post_action 05:26:28 INFO - [mozharness: 2017-04-14 12:26:28.972716Z] Finished read-buildbot-config step (success) 05:26:28 INFO - [mozharness: 2017-04-14 12:26:28.972827Z] Running download-and-extract step. 05:26:28 INFO - Running pre-action listener: _resource_record_pre_action 05:26:28 INFO - Running main action method: download_and_extract 05:26:28 INFO - mkdir: /builds/slave/test/build/tests 05:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:28 INFO - trying https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 05:26:28 INFO - Downloading https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:26:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 05:26:29 INFO - Downloaded 1325 bytes. 05:26:29 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:26:29 INFO - Using the following test package requirements: 05:26:29 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:26:29 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 05:26:29 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:26:29 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:26:29 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 05:26:29 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:26:29 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 05:26:29 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:26:29 INFO - u'jsshell-mac.zip'], 05:26:29 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:26:29 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 05:26:29 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:26:29 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:26:29 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 05:26:29 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:26:29 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 05:26:29 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:26:29 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 05:26:29 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:26:29 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 05:26:29 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:26:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:26:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:26:29 INFO - Fetch https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:26:31 INFO - Expected file size: 52600910 05:26:31 INFO - Obtained file size: 52600910 05:26:47 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:26:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:26:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:26:47 INFO - Fetch https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:26:49 INFO - Expected file size: 52600910 05:26:49 INFO - Obtained file size: 52600910 05:27:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 05:27:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:27:05 INFO - Fetch https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 05:27:06 INFO - Expected file size: 14408853 05:27:06 INFO - Obtained file size: 14408853 05:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:06 INFO - trying https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:27:06 INFO - Downloading https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 05:27:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 05:27:08 INFO - Downloaded 71200349 bytes. 05:27:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:27:08 INFO - mkdir: /builds/slave/test/properties 05:27:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:27:08 INFO - Writing to file /builds/slave/test/properties/build_url 05:27:08 INFO - Contents: 05:27:08 INFO - build_url:https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:27:09 INFO - Running post-action listener: _resource_record_post_action 05:27:09 INFO - Running post-action listener: set_extra_try_arguments 05:27:09 INFO - [mozharness: 2017-04-14 12:27:09.544215Z] Finished download-and-extract step (success) 05:27:09 INFO - [mozharness: 2017-04-14 12:27:09.544338Z] Running populate-webroot step. 05:27:09 INFO - Running pre-action listener: _resource_record_pre_action 05:27:09 INFO - Running main action method: populate_webroot 05:27:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:27:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:27:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:27:09 INFO - '--tppagecycles', 05:27:09 INFO - '7'], 05:27:09 INFO - 'tests': ['tsvgm']}}, 05:27:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:27:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:27:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:27:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:27:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:27:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:27:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:27:09 INFO - 'talos_options': ['--disable-e10s'], 05:27:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:27:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:27:09 INFO - 'talos_options': ['--disable-e10s'], 05:27:09 INFO - 'tests': ['damp', 'tps']}, 05:27:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:27:09 INFO - 'tests': ['damp', 'tps']}, 05:27:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:27:09 INFO - 'tests': ['dromaeo_dom']}, 05:27:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:27:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:27:09 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:27:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:27:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:27:09 INFO - 'tests': ['a11yr', 05:27:09 INFO - 'ts_paint', 05:27:09 INFO - 'tpaint', 05:27:09 INFO - 'sessionrestore', 05:27:09 INFO - 'sessionrestore_no_auto_restore', 05:27:09 INFO - 'tabpaint']}, 05:27:09 INFO - 'other-e10s': {'tests': ['a11yr', 05:27:09 INFO - 'ts_paint', 05:27:09 INFO - 'tpaint', 05:27:09 INFO - 'sessionrestore', 05:27:09 INFO - 'sessionrestore_no_auto_restore', 05:27:09 INFO - 'tabpaint']}, 05:27:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:27:09 INFO - 'ts_paint', 05:27:09 INFO - 'tpaint', 05:27:09 INFO - 'sessionrestore', 05:27:09 INFO - 'sessionrestore_no_auto_restore', 05:27:09 INFO - 'tabpaint']}, 05:27:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:27:09 INFO - 'ts_paint', 05:27:09 INFO - 'tpaint', 05:27:09 INFO - 'sessionrestore', 05:27:09 INFO - 'sessionrestore_no_auto_restore', 05:27:09 INFO - 'tabpaint']}, 05:27:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:27:09 INFO - 'tests': ['a11yr', 05:27:09 INFO - 'ts_paint', 05:27:09 INFO - 'tpaint', 05:27:09 INFO - 'sessionrestore', 05:27:09 INFO - 'sessionrestore_no_auto_restore', 05:27:09 INFO - 'tabpaint']}, 05:27:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:27:09 INFO - 'tests': ['a11yr', 05:27:09 INFO - 'ts_paint', 05:27:09 INFO - 'tpaint', 05:27:09 INFO - 'sessionrestore', 05:27:09 INFO - 'sessionrestore_no_auto_restore', 05:27:09 INFO - 'tabpaint']}, 05:27:09 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:27:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:27:09 INFO - 'bloom_basic_ref']}, 05:27:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:27:09 INFO - 'tests': ['tsvgx', 05:27:09 INFO - 'tsvgr_opacity', 05:27:09 INFO - 'tart', 05:27:09 INFO - 'tscrollx', 05:27:09 INFO - 'cart', 05:27:09 INFO - 'tsvg_static']}, 05:27:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:27:09 INFO - 'tsvgr_opacity', 05:27:09 INFO - 'tart', 05:27:09 INFO - 'tscrollx', 05:27:09 INFO - 'cart', 05:27:09 INFO - 'tsvg_static']}, 05:27:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:27:09 INFO - 'talos_options': ['--disable-e10s'], 05:27:09 INFO - 'tests': ['tp5o']}, 05:27:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:27:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:27:09 INFO - 'talos_options': ['--disable-e10s', 05:27:09 INFO - '--xperf_path', 05:27:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:09 INFO - 'tests': ['tp5n']}, 05:27:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:27:09 INFO - 'talos_options': ['--xperf_path', 05:27:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:09 INFO - 'tests': ['tp5n']}}, 05:27:09 INFO - 'talos.zip': {'path': '', 05:27:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:27:09 INFO - Running post-action listener: _resource_record_post_action 05:27:09 INFO - [mozharness: 2017-04-14 12:27:09.563580Z] Finished populate-webroot step (success) 05:27:09 INFO - [mozharness: 2017-04-14 12:27:09.563713Z] Running create-virtualenv step. 05:27:09 INFO - Running pre-action listener: _resource_record_pre_action 05:27:09 INFO - Running main action method: create_virtualenv 05:27:09 INFO - Creating virtualenv /builds/slave/test/build/venv 05:27:09 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 05:27:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:27:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:27:09 INFO - Using real prefix '/tools/python27' 05:27:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:27:10 INFO - Installing distribute.............................................................................................................................................................................................done. 05:27:13 INFO - Installing pip.................done. 05:27:13 INFO - Return code: 0 05:27:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:27:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:27:13 INFO - Reading from file tmpfile_stdout 05:27:13 INFO - Output received: 05:27:13 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) 05:27:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f145b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f148768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb0056d880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef23d30>, '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 0x10ee49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef18be8>, '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.ZHpKZtHyts/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.RlzeVJuAPF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 05:27:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:27:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:27:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZHpKZtHyts/Render', 05:27:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:13 INFO - 'HOME': '/Users/cltbld', 05:27:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:13 INFO - 'LOGNAME': 'cltbld', 05:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:13 INFO - 'MOZ_NO_REMOTE': '1', 05:27:13 INFO - 'NO_EM_RESTART': '1', 05:27:13 INFO - 'PAGER': '/bin/cat', 05:27:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:13 INFO - 'PWD': '/builds/slave/test', 05:27:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:13 INFO - 'SHELL': '/bin/bash', 05:27:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlzeVJuAPF/Listeners', 05:27:13 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 05:27:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:13 INFO - 'USER': 'cltbld', 05:27:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:13 INFO - 'XPC_FLAGS': '0x0', 05:27:13 INFO - 'XPC_SERVICE_NAME': '0', 05:27:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:13 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 05:27:13 INFO - Cleaning up... 05:27:13 INFO - Return code: 0 05:27:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f145b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f148768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb0056d880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef23d30>, '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 0x10ee49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef18be8>, '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.ZHpKZtHyts/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.RlzeVJuAPF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 05:27:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:27:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:27:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZHpKZtHyts/Render', 05:27:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:13 INFO - 'HOME': '/Users/cltbld', 05:27:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:13 INFO - 'LOGNAME': 'cltbld', 05:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:13 INFO - 'MOZ_NO_REMOTE': '1', 05:27:13 INFO - 'NO_EM_RESTART': '1', 05:27:13 INFO - 'PAGER': '/bin/cat', 05:27:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:13 INFO - 'PWD': '/builds/slave/test', 05:27:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:13 INFO - 'SHELL': '/bin/bash', 05:27:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlzeVJuAPF/Listeners', 05:27:13 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 05:27:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:13 INFO - 'USER': 'cltbld', 05:27:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:13 INFO - 'XPC_FLAGS': '0x0', 05:27:13 INFO - 'XPC_SERVICE_NAME': '0', 05:27:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:14 INFO - Downloading/unpacking psutil>=3.1.1 05:27: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 05:27: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 05:27: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 05:27: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 05:27: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 05:27: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 05:27:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:27:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:27:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:27:17 INFO - Installing collected packages: psutil 05:27:17 INFO - Running setup.py install for psutil 05:27:17 INFO - building 'psutil._psutil_osx' extension 05:27:17 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 05:27:18 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 05:27:18 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 05:27:18 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 05:27:18 INFO - building 'psutil._psutil_posix' extension 05:27:18 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 05:27:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:27:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:27:18 INFO - ^ 05:27:18 INFO - 1 warning generated. 05:27:18 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 05:27:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:27:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:27:18 INFO - Successfully installed psutil 05:27:18 INFO - Cleaning up... 05:27:18 INFO - Return code: 0 05:27:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:27:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:18 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 0x10f145b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f148768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb0056d880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef23d30>, '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 0x10ee49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef18be8>, '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.ZHpKZtHyts/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.RlzeVJuAPF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 05:27:18 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 05:27:18 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 05:27:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZHpKZtHyts/Render', 05:27:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:18 INFO - 'HOME': '/Users/cltbld', 05:27:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:18 INFO - 'LOGNAME': 'cltbld', 05:27:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:18 INFO - 'MOZ_NO_REMOTE': '1', 05:27:18 INFO - 'NO_EM_RESTART': '1', 05:27:18 INFO - 'PAGER': '/bin/cat', 05:27:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:18 INFO - 'PWD': '/builds/slave/test', 05:27:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:18 INFO - 'SHELL': '/bin/bash', 05:27:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlzeVJuAPF/Listeners', 05:27:18 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 05:27:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:18 INFO - 'USER': 'cltbld', 05:27:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:18 INFO - 'XPC_FLAGS': '0x0', 05:27:18 INFO - 'XPC_SERVICE_NAME': '0', 05:27:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:27:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:27:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:27:21 INFO - Installing collected packages: mozsystemmonitor 05:27:21 INFO - Running setup.py install for mozsystemmonitor 05:27:21 INFO - Successfully installed mozsystemmonitor 05:27:21 INFO - Cleaning up... 05:27:21 INFO - Return code: 0 05:27:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:27:21 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')]} 05:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:22 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 0x10f145b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f148768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb0056d880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef23d30>, '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 0x10ee49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef18be8>, '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.ZHpKZtHyts/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.RlzeVJuAPF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 05:27:22 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 05:27:22 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 05:27:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZHpKZtHyts/Render', 05:27:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:22 INFO - 'HOME': '/Users/cltbld', 05:27:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:22 INFO - 'LOGNAME': 'cltbld', 05:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:22 INFO - 'MOZ_NO_REMOTE': '1', 05:27:22 INFO - 'NO_EM_RESTART': '1', 05:27:22 INFO - 'PAGER': '/bin/cat', 05:27:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:22 INFO - 'PWD': '/builds/slave/test', 05:27:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:22 INFO - 'SHELL': '/bin/bash', 05:27:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlzeVJuAPF/Listeners', 05:27:22 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 05:27:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:22 INFO - 'USER': 'cltbld', 05:27:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:22 INFO - 'XPC_FLAGS': '0x0', 05:27:22 INFO - 'XPC_SERVICE_NAME': '0', 05:27:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:22 INFO - Downloading/unpacking jsonschema==2.5.1 05:27: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 05:27: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 05:27: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 05:27: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 05:27: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 05:27: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 05:27:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:27:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:26 INFO - Downloading functools32-3.2.3-2.tar.gz 05:27:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:27:26 INFO - warning: no files found matching '*.txt' 05:27:26 INFO - no previously-included directories found matching 'build' 05:27:26 INFO - no previously-included directories found matching 'dist' 05:27:26 INFO - no previously-included directories found matching '.git*' 05:27:26 INFO - Installing collected packages: jsonschema, functools32 05:27:26 INFO - Running setup.py install for functools32 05:27:26 INFO - warning: no files found matching '*.txt' 05:27:26 INFO - no previously-included directories found matching 'build' 05:27:26 INFO - no previously-included directories found matching 'dist' 05:27:26 INFO - no previously-included directories found matching '.git*' 05:27:26 INFO - Successfully installed jsonschema functools32 05:27:26 INFO - Cleaning up... 05:27:26 INFO - Return code: 0 05:27:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:27: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')]} 05:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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')]} 05:27:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:26 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 0x10f145b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f148768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb0056d880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef23d30>, '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 0x10ee49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef18be8>, '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.ZHpKZtHyts/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.RlzeVJuAPF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 05:27:26 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 05:27:26 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 05:27:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZHpKZtHyts/Render', 05:27:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:26 INFO - 'HOME': '/Users/cltbld', 05:27:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:26 INFO - 'LOGNAME': 'cltbld', 05:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:26 INFO - 'MOZ_NO_REMOTE': '1', 05:27:26 INFO - 'NO_EM_RESTART': '1', 05:27:26 INFO - 'PAGER': '/bin/cat', 05:27:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:26 INFO - 'PWD': '/builds/slave/test', 05:27:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:26 INFO - 'SHELL': '/bin/bash', 05:27:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlzeVJuAPF/Listeners', 05:27:26 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 05:27:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:26 INFO - 'USER': 'cltbld', 05:27:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:26 INFO - 'XPC_FLAGS': '0x0', 05:27:26 INFO - 'XPC_SERVICE_NAME': '0', 05:27:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:27:26 INFO - Cleaning up... 05:27:26 INFO - Return code: 0 05:27:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:27: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')]} 05:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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')]} 05:27:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:26 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 0x10f145b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f148768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb0056d880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef23d30>, '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 0x10ee49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef18be8>, '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.ZHpKZtHyts/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.RlzeVJuAPF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 05:27:26 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 05:27:26 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 05:27:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZHpKZtHyts/Render', 05:27:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:26 INFO - 'HOME': '/Users/cltbld', 05:27:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:26 INFO - 'LOGNAME': 'cltbld', 05:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:26 INFO - 'MOZ_NO_REMOTE': '1', 05:27:26 INFO - 'NO_EM_RESTART': '1', 05:27:26 INFO - 'PAGER': '/bin/cat', 05:27:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:26 INFO - 'PWD': '/builds/slave/test', 05:27:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:26 INFO - 'SHELL': '/bin/bash', 05:27:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlzeVJuAPF/Listeners', 05:27:26 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 05:27:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:26 INFO - 'USER': 'cltbld', 05:27:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:26 INFO - 'XPC_FLAGS': '0x0', 05:27:26 INFO - 'XPC_SERVICE_NAME': '0', 05:27:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:27 INFO - Downloading/unpacking blobuploader==1.2.4 05:27:27 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 05:27:27 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 05:27:27 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 05:27:27 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 05:27:27 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 05:27:27 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 05:27:29 INFO - Downloading blobuploader-1.2.4.tar.gz 05:27:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:27:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:27:30 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 05:27:30 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 05:27:30 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 05:27:30 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 05:27:30 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 05:27:30 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 05:27:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:27:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:27:30 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 05:27:30 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 05:27:30 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 05:27:30 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 05:27:30 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 05:27:30 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 05:27:31 INFO - Downloading docopt-0.6.1.tar.gz 05:27:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:27:31 INFO - Installing collected packages: blobuploader, requests, docopt 05:27:31 INFO - Running setup.py install for blobuploader 05:27:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:27:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:27:31 INFO - Running setup.py install for requests 05:27:31 INFO - Running setup.py install for docopt 05:27:32 INFO - Successfully installed blobuploader requests docopt 05:27:32 INFO - Cleaning up... 05:27:32 INFO - Return code: 0 05:27:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:32 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')]} 05:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:32 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')]} 05:27:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:32 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 0x10f145b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f148768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb0056d880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef23d30>, '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 0x10ee49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef18be8>, '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.ZHpKZtHyts/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.RlzeVJuAPF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 05:27:32 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 05:27:32 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 05:27:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZHpKZtHyts/Render', 05:27:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:32 INFO - 'HOME': '/Users/cltbld', 05:27:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:32 INFO - 'LOGNAME': 'cltbld', 05:27:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:32 INFO - 'MOZ_NO_REMOTE': '1', 05:27:32 INFO - 'NO_EM_RESTART': '1', 05:27:32 INFO - 'PAGER': '/bin/cat', 05:27:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:32 INFO - 'PWD': '/builds/slave/test', 05:27:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:32 INFO - 'SHELL': '/bin/bash', 05:27:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlzeVJuAPF/Listeners', 05:27:32 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 05:27:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:32 INFO - 'USER': 'cltbld', 05:27:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:32 INFO - 'XPC_FLAGS': '0x0', 05:27:32 INFO - 'XPC_SERVICE_NAME': '0', 05:27:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:32 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-E9r7UT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:32 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-7LSbxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:32 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-rKRSX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:32 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-kMOXVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:32 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-HJvhd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:32 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-J_lGyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:33 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-7oYn34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:33 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-ZX4BLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:33 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-Ra3U7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:33 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-KjuyG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:33 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-KC7lVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:33 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-ugc55Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:33 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-pRrqwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:33 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-vgWQ2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:33 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-MxPNjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:33 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-jzX6bE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:34 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-K5Cvya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:27:34 INFO - Running setup.py install for manifestparser 05:27:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:27:34 INFO - Running setup.py install for mozcrash 05:27:34 INFO - Running setup.py install for mozdebug 05:27:34 INFO - Running setup.py install for mozdevice 05:27:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:27:34 INFO - Running setup.py install for mozfile 05:27:34 INFO - Running setup.py install for mozhttpd 05:27:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:27:35 INFO - Running setup.py install for mozinfo 05:27:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:27:35 INFO - Running setup.py install for mozInstall 05:27:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:27:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:27:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:27:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:27:35 INFO - Running setup.py install for mozleak 05:27:35 INFO - Running setup.py install for mozlog 05:27:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:27:35 INFO - Running setup.py install for moznetwork 05:27:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:27:35 INFO - Running setup.py install for mozprocess 05:27:35 INFO - Running setup.py install for mozprofile 05:27:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:27:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:27:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:27:36 INFO - Running setup.py install for mozrunner 05:27:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:27:36 INFO - Running setup.py install for mozscreenshot 05:27:36 INFO - Running setup.py install for moztest 05:27:36 INFO - Running setup.py install for mozversion 05:27:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:27:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:27:36 INFO - Cleaning up... 05:27:36 INFO - Return code: 0 05:27:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:36 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 0x10f145b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f148768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb0056d880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef23d30>, '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 0x10ee49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef18be8>, '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.ZHpKZtHyts/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.RlzeVJuAPF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 05:27:36 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 05:27:36 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 05:27:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZHpKZtHyts/Render', 05:27:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:36 INFO - 'HOME': '/Users/cltbld', 05:27:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:36 INFO - 'LOGNAME': 'cltbld', 05:27:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:36 INFO - 'MOZ_NO_REMOTE': '1', 05:27:36 INFO - 'NO_EM_RESTART': '1', 05:27:36 INFO - 'PAGER': '/bin/cat', 05:27:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:36 INFO - 'PWD': '/builds/slave/test', 05:27:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:36 INFO - 'SHELL': '/bin/bash', 05:27:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlzeVJuAPF/Listeners', 05:27:36 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 05:27:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:36 INFO - 'USER': 'cltbld', 05:27:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:36 INFO - 'XPC_FLAGS': '0x0', 05:27:36 INFO - 'XPC_SERVICE_NAME': '0', 05:27:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:37 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-pDfTZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:37 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)) 05:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:37 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-XKXZEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:37 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)) 05:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:37 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-Fvqmpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:37 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)) 05:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:37 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-yuy4X2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 05:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:37 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-bdf8oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:37 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)) 05:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:37 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-RCuNJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:37 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)) 05:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:37 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-s0p91A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:37 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)) 05:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:37 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-fQwYgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:37 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)) 05:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:37 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-Ctpauw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:37 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)) 05:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:37 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-CBDhcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:38 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)) 05:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:38 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-99ScFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:38 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)) 05:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:38 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-R1GJSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:38 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-zo_vAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:38 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)) 05:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:38 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-6k5qeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:38 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)) 05:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:38 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-UhcdAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:38 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)) 05:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:38 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-WSzWwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:38 INFO - Running setup.py (path:/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/pip-Fsf7hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:38 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)) 05:27:38 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)) 05:27:38 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)) 05:27:38 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)) 05:27:38 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:27:38 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:27:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:27:38 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 05:27:38 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 05:27:38 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 05:27:38 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 05:27:38 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 05:27:38 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 05:27:41 INFO - Downloading blessings-1.6.tar.gz 05:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:27:41 INFO - Installing collected packages: blessings 05:27:41 INFO - Running setup.py install for blessings 05:27:41 INFO - Successfully installed blessings 05:27:41 INFO - Cleaning up... 05:27:41 INFO - Return code: 0 05:27:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:27:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:42 INFO - Reading from file tmpfile_stdout 05:27:42 INFO - Current package versions: 05:27:42 INFO - blessings == 1.6 05:27:42 INFO - blobuploader == 1.2.4 05:27:42 INFO - docopt == 0.6.1 05:27:42 INFO - functools32 == 3.2.3-2 05:27:42 INFO - jsonschema == 2.5.1 05:27:42 INFO - manifestparser == 1.1 05:27:42 INFO - mozInstall == 1.12 05:27:42 INFO - mozcrash == 1.0 05:27:42 INFO - mozdebug == 0.1 05:27:42 INFO - mozdevice == 0.50 05:27:42 INFO - mozfile == 1.2 05:27:42 INFO - mozhttpd == 0.7 05:27:42 INFO - mozinfo == 0.9 05:27:42 INFO - mozleak == 0.1 05:27:42 INFO - mozlog == 3.4 05:27:42 INFO - moznetwork == 0.27 05:27:42 INFO - mozprocess == 0.25 05:27:42 INFO - mozprofile == 0.28 05:27:42 INFO - mozrunner == 6.13 05:27:42 INFO - mozscreenshot == 0.1 05:27:42 INFO - mozsystemmonitor == 0.3 05:27:42 INFO - moztest == 0.8 05:27:42 INFO - mozversion == 1.4 05:27:42 INFO - psutil == 3.1.1 05:27:42 INFO - requests == 1.2.3 05:27:42 INFO - wsgiref == 0.1.2 05:27:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:42 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')]} 05:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:42 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')]} 05:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:42 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 0x10f145b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f148768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb0056d880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef23d30>, '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 0x10ee49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef18be8>, '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.ZHpKZtHyts/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.RlzeVJuAPF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 05:27:42 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 05:27:42 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 05:27:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZHpKZtHyts/Render', 05:27:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:42 INFO - 'HOME': '/Users/cltbld', 05:27:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:42 INFO - 'LOGNAME': 'cltbld', 05:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:42 INFO - 'MOZ_NO_REMOTE': '1', 05:27:42 INFO - 'NO_EM_RESTART': '1', 05:27:42 INFO - 'PAGER': '/bin/cat', 05:27:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:42 INFO - 'PWD': '/builds/slave/test', 05:27:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:42 INFO - 'SHELL': '/bin/bash', 05:27:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlzeVJuAPF/Listeners', 05:27:42 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 05:27:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:42 INFO - 'USER': 'cltbld', 05:27:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:42 INFO - 'XPC_FLAGS': '0x0', 05:27:42 INFO - 'XPC_SERVICE_NAME': '0', 05:27:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:42 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)) 05:27:42 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)) 05:27:42 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)) 05:27:42 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)) 05:27:42 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)) 05:27:42 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)) 05:27:42 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)) 05:27:42 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)) 05:27:42 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)) 05:27:42 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)) 05:27:42 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)) 05:27:42 INFO - Cleaning up... 05:27:42 INFO - Return code: 0 05:27:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:27:42 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')]} 05:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:42 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')]} 05:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:42 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 0x10f145b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f148768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb0056d880>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef23d30>, '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 0x10ee49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef18be8>, '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.ZHpKZtHyts/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.RlzeVJuAPF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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 05:27:42 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 05:27:42 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 05:27:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZHpKZtHyts/Render', 05:27:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:27:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:27:42 INFO - 'HOME': '/Users/cltbld', 05:27:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:27:42 INFO - 'LOGNAME': 'cltbld', 05:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:42 INFO - 'MOZ_NO_REMOTE': '1', 05:27:42 INFO - 'NO_EM_RESTART': '1', 05:27:42 INFO - 'PAGER': '/bin/cat', 05:27:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:42 INFO - 'PWD': '/builds/slave/test', 05:27:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:27:42 INFO - 'SHELL': '/bin/bash', 05:27:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlzeVJuAPF/Listeners', 05:27:42 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 05:27:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:27:42 INFO - 'USER': 'cltbld', 05:27:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:27:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:42 INFO - 'XPC_FLAGS': '0x0', 05:27:42 INFO - 'XPC_SERVICE_NAME': '0', 05:27:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:27:42 INFO - Cleaning up... 05:27:42 INFO - Return code: 0 05:27:42 INFO - Running post-action listener: _resource_record_post_action 05:27:42 INFO - Running post-action listener: _start_resource_monitoring 05:27:42 INFO - Starting resource monitoring. 05:27:42 INFO - [mozharness: 2017-04-14 12:27:42.695112Z] Finished create-virtualenv step (success) 05:27:42 INFO - [mozharness: 2017-04-14 12:27:42.696096Z] Running install step. 05:27:42 INFO - Running pre-action listener: _resource_record_pre_action 05:27:42 INFO - Running main action method: install 05:27:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:42 INFO - Reading from file tmpfile_stdout 05:27:42 INFO - Detecting whether we're running mozinstall >=1.0... 05:27:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:27:43 INFO - Reading from file tmpfile_stdout 05:27:43 INFO - Output received: 05:27:43 INFO - Usage: mozinstall [options] installer 05:27:43 INFO - Options: 05:27:43 INFO - -h, --help show this help message and exit 05:27:43 INFO - -d DEST, --destination=DEST 05:27:43 INFO - Directory to install application into. [default: 05:27:43 INFO - "/builds/slave/test"] 05:27:43 INFO - --app=APP Application being installed. [default: firefox] 05:27:43 INFO - mkdir: /builds/slave/test/build/application 05:27:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:28:02 INFO - Reading from file tmpfile_stdout 05:28:02 INFO - Output received: 05:28:02 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:28:02 INFO - Running post-action listener: _resource_record_post_action 05:28:02 INFO - [mozharness: 2017-04-14 12:28:02.797661Z] Finished install step (success) 05:28:02 INFO - [mozharness: 2017-04-14 12:28:02.797818Z] Running run-tests step. 05:28:02 INFO - Running pre-action listener: _resource_record_pre_action 05:28:02 INFO - Running main action method: run_tests 05:28:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:28:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:28:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:28:02 INFO - 2017-04-14 05:28:02.812 screenresolution[1621:7368] starting screenresolution argv=screenresolution get 05:28:02 INFO - 2017-04-14 05:28:02.814 screenresolution[1621:7368] Display 0: 1600x1200x32@60 05:28:02 INFO - 2017-04-14 05:28:02.820 screenresolution[1622:7371] starting screenresolution argv=screenresolution list 05:28:02 INFO - Available Modes on Display 0 05:28:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:28:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:28:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:28:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:28:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:28:03 INFO - Intel Iris: 05:28:03 INFO - Chipset Model: Intel Iris 05:28:03 INFO - Type: GPU 05:28:03 INFO - Bus: Built-In 05:28:03 INFO - VRAM (Dynamic, Max): 1536 MB 05:28:03 INFO - Vendor: Intel (0x8086) 05:28:03 INFO - Device ID: 0x0a2e 05:28:03 INFO - Revision ID: 0x0009 05:28:03 INFO - Displays: 05:28:03 INFO - Display: 05:28:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:28:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:28:03 INFO - Display Serial Number: 1600x1200 60 05:28:03 INFO - Main Display: Yes 05:28:03 INFO - Mirror: Off 05:28:03 INFO - Online: Yes 05:28:03 INFO - Rotation: Supported 05:28:03 INFO - Return code: 0 05:28:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:28:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:28:03 INFO - Python 2.7.3 05:28:03 INFO - Return code: 0 05:28:03 INFO - grabbing minidump binary from tooltool 05:28: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')]} 05:28:03 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef23d30>, '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 0x10ee49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef18be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:28:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:28:03 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:28:03 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:28:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:28:03 INFO - Return code: 0 05:28:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:28:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:28:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:28:03 INFO - ENV: RUST_BACKTRACE is now 1 05:28:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:28:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:28:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0218', '--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 05:28:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0218 --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 05:28:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZHpKZtHyts/Render', 05:28:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:03 INFO - 'HOME': '/Users/cltbld', 05:28:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:03 INFO - 'LOGNAME': 'cltbld', 05:28:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:28:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:28:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:03 INFO - 'MOZ_NO_REMOTE': '1', 05:28:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:28:03 INFO - 'NO_EM_RESTART': '1', 05:28:03 INFO - 'PAGER': '/bin/cat', 05:28:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:03 INFO - 'PWD': '/builds/slave/test', 05:28:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:28:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:03 INFO - 'RUST_BACKTRACE': '1', 05:28:03 INFO - 'SHELL': '/bin/bash', 05:28:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RlzeVJuAPF/Listeners', 05:28:03 INFO - 'TMPDIR': '/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/', 05:28:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:03 INFO - 'USER': 'cltbld', 05:28:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:03 INFO - 'XPC_FLAGS': '0x0', 05:28:03 INFO - 'XPC_SERVICE_NAME': '0', 05:28:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0218', '--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 05:28:03 INFO - mozversion application_buildid: 20170414030225 05:28:03 INFO - mozversion application_changeset: cda24082bff8864a6e53726feeae33cae9e17309 05:28:03 INFO - mozversion application_display_name: Nightly 05:28:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:28:03 INFO - mozversion application_name: Firefox 05:28:03 INFO - mozversion application_remotingname: firefox 05:28:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:28:03 INFO - mozversion application_vendor: Mozilla 05:28:03 INFO - mozversion application_version: 55.0a1 05:28:03 INFO - mozversion platform_buildid: 20170414030225 05:28:03 INFO - mozversion platform_changeset: cda24082bff8864a6e53726feeae33cae9e17309 05:28:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:28:03 INFO - mozversion platform_version: 55.0a1 05:28:03 INFO - using testdate: 1492172883 05:28:03 INFO - actual date: 1492172883 05:28:03 INFO - starting webserver on 'localhost:49241' 05:28:03 INFO - SUITE-START | Running 2 tests 05:28:03 INFO - TEST-START | dromaeo_css 05:28:03 INFO - operating with platform_type : mac_ 05:28:03 INFO - Initialising browser for dromaeo_css test... 05:28:03 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/tmpXtnG9_/profile http://localhost:49241/getInfo.html) 05:28:06 INFO - PID 1632 | 2017-04-14 05:28:06.645 plugin-container[1635:7560] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b53, name = 'com.apple.tsm.portname' 05:28:06 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:28:06 INFO - PID 1632 | 2017-04-14 05:28:06.645 plugin-container[1635:7560] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9413, name = 'com.apple.CFPasteboardClient' 05:28:06 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:28:06 INFO - PID 1632 | 2017-04-14 05:28:06.645 plugin-container[1635:7560] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:28:06 INFO - PID 1632 | __metrics Screen width/height:1600/1200 05:28:06 INFO - PID 1632 | colorDepth:24 05:28:06 INFO - PID 1632 | Browser inner width/height: 1024/689 05:28:06 INFO - PID 1632 | __metrics 05:28:06 ERROR - PID 1632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 05:28:07 INFO - TEST-INFO | 1632: exit 0 05:28:07 INFO - Browser initialized. 05:28:07 INFO - Running cycle 1/1 for dromaeo_css test... 05:28:07 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/tmpXtnG9_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:10 INFO - PID 1636 | 2017-04-14 05:28:10.345 plugin-container[1637:7693] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 05:28:10 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:28:10 INFO - PID 1636 | 2017-04-14 05:28:10.345 plugin-container[1637:7693] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.CFPasteboardClient' 05:28:10 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:28:10 INFO - PID 1636 | 2017-04-14 05:28:10.345 plugin-container[1637:7693] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:28:20 INFO - PID 1636 | RSS: Main: 239378432 05:28:20 INFO - PID 1636 | 05:31:24 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 05:31:26 INFO - PID 1636 | RSS: Main: 254545920 05:31:26 INFO - PID 1636 | 05:33:08 INFO - PID 1636 | ************************* 05:33:08 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 05:33:08 INFO - PID 1636 | 05:33:08 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:33:08 INFO - PID 1636 | Full stack: 05:33:08 INFO - PID 1636 | ************************* 05:33:08 INFO - PID 1636 | ************************* 05:33:08 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 05:33:08 INFO - PID 1636 | 05:33:08 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:33:08 INFO - PID 1636 | Full stack: 05:33:08 INFO - PID 1636 | ************************* 05:33:08 INFO - PID 1636 | ************************* 05:33:08 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 05:33:08 INFO - PID 1636 | 05:33:08 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:33:08 INFO - PID 1636 | Full stack: 05:33:08 INFO - PID 1636 | ************************* 05:33:08 INFO - PID 1636 | ************************* 05:33:08 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 05:33:08 INFO - PID 1636 | 05:33:08 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:33:08 INFO - PID 1636 | Full stack: 05:33:08 INFO - PID 1636 | ************************* 05:34:27 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 05:34:28 INFO - PID 1636 | RSS: Main: 262475776 05:34:28 INFO - PID 1636 | 05:37:30 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 05:37:30 INFO - PID 1636 | RSS: Main: 273543168 05:37:30 INFO - PID 1636 | 05:40:32 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 05:40:33 INFO - PID 1636 | RSS: Main: 265928704 05:40:33 INFO - PID 1636 | 05:43:35 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 05:43:36 INFO - PID 1636 | RSS: Main: 276676608 05:43:36 INFO - PID 1636 | 05:46:38 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 05:46:38 INFO - PID 1636 | RSS: Main: 270450688 05:46:38 INFO - PID 1636 | 05:46:38 INFO - PID 1636 | __start_tp_report 05:46:38 INFO - PID 1636 | _x_x_mozilla_page_load 05:46:38 INFO - PID 1636 | _x_x_mozilla_page_load_details 05:46:38 INFO - PID 1636 | |i|pagename|runs| 05:46:38 INFO - PID 1636 | |0;dojo.html;3013.5479678048277;3594.8382322795455;3621;3640.326539590176;3669.5596528416595;6112.229929638737;6219.315875253718;6258.968705156473;6260.2487701475775;6301.621902685842;6172.290186628539;6208.658523781201;6209.130721698965;6276.529260305484;6276.686165691709;5494.203340515623;5516.475934786189;5568.303962004749;5597.468240517144;5625.268715067035;5449.427810079944;5570.721463926808;5627.296587926509;5637.943620563803;5648.406917273689;5480.588955828289;5499.780008799643;5538;5559.6664200148125;5607;5537;5540.473655002768;5558.972205138948;5565.833025009256;5615.691136987505;5479.342478902558;5494.587905907073;5501.174823776466;5501.614886957915;5529.640573362759;4523.982104026568;6064.54515911304;6143.385661433866;6176.104464852616;6188.87622247557;6671.532992690513;6717.966410167918;6718.731250749964;6720.630365329905;6723.7646682365885;6778.898316525256;6795.694193761293;6796.524243302971;6799.864002719967;6814.48891333152;6175.96912015437;6204.317525072239;6309.589876658002;6323.588966717149;6324.177856878622;6953.582785032813;6984.057152284377;7006.614636194956;7033.226345102034;7034.402075823612;4869.95130048695;6442.645654489048;6497.870042599122;6511.28375878653;6610.8347291318105;6582.144321238208;6728.091707619409;6810;6830.009648600925;6837.521373503807;5628.437156284421;6337.873242535124;6716.227633822173;6724.899126513106;6751.898721519181;6561.967190164019;6566.146400967939;6650.334966503311;6704.899426508607;6756.189257289157;5347.491988261109;5356.491133342326;5368.731563421813;5389.164679474609;5410.242566040757;4771.594414474808;4784.473707892129;4801.255805350176;4826.493218212037;4845.781939812717;6156.107364432132;6294.181756371642;6404.583702059351;6418.229812422539;6439.710213040425;6889.138857642794;6898.379145876795;6898.586084834926;6900.827479313058;6909.585424874524;6402.711877965409;6419.197600299963;6422.229332480132;6460.806175814733;6472.35276472349;5847.795327163529;5903.203067585821;5919.881602367928;5952.4047595241;5990.940090599038;6981.2669669684965;7007.229204787572;7011.824704382431;7014.68433920485;7016.228214896255;6787.321267873173;6815.761448349284;6856.382925536725;6863.691133899087;6878.896816547855;6753.628550429774;6837.760678376233;6859.7256109757045;6944.4097251734165;6982.546134501241;6698.2631910488835;6727.091842601382;6727.629980351127;6732.798016059526;6737.191537015589;6723.294054124247;6811.625360605214;6823.624700641314;6840.657967101525;6852.314768523307;6367.3314301997625;6446.742130314922;6447.0329450582785;6513.413792758674;6609.537332386687;6547.312532184243;6563.245226798788;6607.3062328456745;6613.66931653425;6615.206175259;5298.337707786527;6345.238571371465;6383.202099737533;6430.614163150226;6461.256955449995;6339.049142628458;6415.615063096229;6483;6582.3746744059235;6601.405873471411;6280.497560195082;6292.465140463112;6352.333005034589;6381.840453988688;6392.488600912009 05:46:38 INFO - PID 1636 | |1;ext.html;738.1253214940297;810.6352141536308;832.6003518311211;1121.9214654974144;1126.5775334249652;30181.396372072544;36154.63845361549;37176.814115929454;37259.06852328693;37312.440313395324;38759.61240387595;39131.804340978255;39171.60828391715;39183.608163918354;39188.60811391885;8484.872726909101;8525.147485251457;8667.43661661993;8698.956505217466;8784.341174411944;8554.486730796141;8600.698975535857;8678.002029766563;8683.652653893836;8693.739187824343;8638.956805215965;8643.740687779346;8685.826283474358;8696.21734043936;8708.782280443007;8639.913600864005;8673.306135509207;8683.348748843799;8683.826323473559;8689.261412779953;8512.319014478826;8541.871871921927;8563.143685631449;8574.657013719443;8600.397972141953;37644;37644.43533347002;37677.058073548105;37795.811020944995;37867.24265514674;3576.9642303576893;3580.104973756561;3615.4757560153894;3621.3300539400293;3625.9303505465687;30798.53802192969;30909.536356954664;30974.380512389627;31002.689973100205;31037;2978.0470249520163;3040.7111324424145;3056.006797790727;3063.1423201503617;3067.9233019174476;224580;227644;252151;252445;256453.717731412;35763;47780.7610961943;47814.52185478101;47949.04101917942;47976.28035579469;42334.36498452526;47110;49155.262671059965;49445;49462.75268623706;14294.213818240096;14396;14399.568012959628;14407.42370305197;14474.710505789826;11551.711207219887;11730.70673233159;11747.823782643096;11767.940885320362;11785.646430607096;11517.827232591519;13138.700727372672;13456.46174153023;13611.727765444635;13655.931720341334;5980.521558275327;5999.790007349722;6002.819915402545;6014.789482368096;6048.153258543807;1009.65671671632;1038.4236748604596;1048.250500891866;1062.5802807890839;1069.2034434346463;22977.655335169984;23973.160939367386;24063.7593624065;24097.75902240955;24243;1120.6469961961957;1123.8763735989035;1126.830975353687;1157.745296034871;1167.9708007299716;9761.170300524393;12249.632511024683;12281.078919080926;12394.75210495785;12848.421821018077;273601;276855;277216.2278377231;278275;278301;53858.730706346214;54280;54334.72832635811;54372.45627543753;54493.727531362885;1325.821014163095;1481.5629389330174;1554.2694933381292;1554.844515548436;1561.9062856228663;23699.881500593077;23722;23837.165699200446;23986.520269594163;24267.75732242655;33985.66014339825;35071.12322191965;37846.43230351492;38047.42928856014;38113.80943095267;254822;256302;256926;257088;258135;34095.82952085224;34411.311773764886;34585;35118.824405878826;35281.82359088188;44646.3303050461;45186.09627807359;45264;45336.77331613321;45742.62772116842;30396.936107237027;31229;31540;31599.526007109453;31628.627852910664;30197.921624622883;30602.540961885144;31083.067507974796;31119.533207002365;31139.532907006866;36292.45561316529;36556.81721591375;36632;36653.81673091617;36679.08302292464;29940.401191976474;31136.688633114285;31142;31651.841740791147;31907.883224087047;21475.248366307103;22691.546169076857;23320.883395582914;24240;24317 05:46:38 INFO - PID 1636 | |2;jquery.html;429.47174974781;441.3468067260454;446.9307257375106;459.120783699216;459.75173406360585;19267.518312042204;20826.687599686018;21583.67624485634;21638.567228655458;21711.782882171174;18842.71735923959;20505.17979280827;22756.544869102607;23378.64932026021;23406.29781106565;6028.969855150718;6279.215098112736;6310.211223597051;6317.05244213367;6351.872962540747;5948.88102237955;6225.719842607094;6280.026595877646;6285.842853928642;6286.7170977305905;6175.722092505848;6178.474829639486;6185.628862268279;6226.968865155668;6229.470495007907;6068.484178844804;6182.629042257434;6193.721282542297;6243.406876346739;6252.124702541671;4813.975930120362;5348.598855085846;5520.917186242169;5540.944590554123;5555.111182210827;26845.73154268452;27225.86387068052;27490;27770.722292777016;27836.443271134463;2189.770074142208;2232.1852523828684;2255.4699645583273;2260.660900864867;2262.7058482397347;17705.29178832845;17709.822901771076;17802;18315.35896243625;18389.26442942281;2147.9463013424634;2164;2208.723909511311;2210.071769856664;2212.6459766437456;133017;151248;156348;159533;161323.1933840335;12244.877551224552;12714.427850746739;12799.488020479077;12927.806082908764;12948.352582370844;16403.91798041002;16473.423430179886;16475.17624118789;16481.17594120289;16492.34030638785;8865.778355541162;9055.81888362229;9077.228435582918;9087.31845111606;9229.10803285325;8491.702790402307;8650.221480066824;8651.48091114535;8827.426217295855;8852.513111778913;6821.3519715626935;7812.570308632966;7977.3618110551015;7999.760007199793;8018.4787988780545;1862.7764668239897;1863.8508919286423;2163.210428193698;2182;2362.421206804344;764.957927313992;849.2781136034445;862.2196911794836;971.4414211828228;1016.2510409342858;20422.59154816925;20903.790962090185;20908.477288067617;21087.578248434944;21128.366149015554;887.8135591525852;896.5427631907774;991.1822746234242;995;1025.1644909398817;10243.59025638981;10757;10832.350058996486;10860.565577376974;10870.836937445945;413538;503823;505357;506981;512493;82241.94395140049;119708;120802;122063;125679.48641027129;1141.3380239461092;1150.7295785490403;1172.7478592102739;1175.3359351966283;1175.9412029398495;17892.642147157243;17944.19251133676;17958.473529750117;18079.45761627153;18297.45107646773;55952.440475594725;56223;56347;56768;57057.42942570687;73358;74882.62558687171;77233.06917327111;80120.79818802606;81665;8822.5588720565;8833.33749968742;8907;8960.417572857743;9353.85969210476;12049.81925271104;14426.85573144255;14640.926795365955;14880;15028;12021.338826364634;12196.390180491117;12306.077044221898;12318.568850090203;12343.382830858602;11543.4805433754;11547.769044619228;11753.353565553976;11881;11907.285562866256;12267.447964841425;12304.692382690504;12445.439955201857;12528.123031387715;12550;9006;9063.13900179482;9140.034892498144;9177;9208.953955230181;11992.940035299767;12170.330631815335;12334.938325308316;12396.380180990735;12435.191712538655 05:46:38 INFO - PID 1636 | |3;mootools.html;1419.5599364197094;1419.8012278281049;1420.169201017405;1464.9379200079936;1496.6931778985306;11368.658940231797;11815.70460738482;11828.704282392933;11901.58344457944;12232.938835305833;11846.526138954454;12002.219855709372;12045.879541204586;12050.758984820299;12082.15424920256;2523.356544081266;2571.807114466413;2577.9871100644564;2593.638339871564;2598.5062838060803;2465.827392082555;2484.335495218208;2486.3411196032976;2497.0261597976805;2497.5878979968284;2299.643210505801;2469.172827102923;2478.7893029092456;2530.4812513434795;2541.275736415122;2100.4223838444395;2438.780509754122;2440.791808055024;2510.1716433576876;2531.1520640585336;2469.9012039518398;2525.7600527949817;2531.0255551612577;2537.112010796225;2562.154489018619;12095.334756588383;12118.212316199508;12127.818082728767;12157.088218383657;12265.938670306681;5645.858853528694;5731.742071606787;6690.264070952191;6908.9309106909295;6931.2375638679705;3656.9817150914073;4063.3701776224734;4326.329418940069;4379.540148284448;4379.978100109511;1237.665830225843;1238.2261086820738;1259.0368368198335;1283.4609464025039;1286.2989670629436;12672.936635316857;13705.177689338672;15547.378104875792;16769.496915092568;16884.07137607431;5691.601587888808;5758.107493338539;5923.200367950271;5929.080992446177;6012.218411606463;11723.237989530653;12349.629511114681;12482.75034499305;12491.250524968349;12549.560765373168;6628.409181796334;6685.097511835937;6691.197056353171;6693.230278517935;6695.866082678319;4967.677100988496;5891.587588868823;6191.854506916235;6223.844403889849;6247.843803904848;4460.665450091256;4511.736713720164;4563.885902852455;4567.269236922077;4567.451905771329;1226.589092653971;1238.2446707508593;1242.2049888071642;1257.3147634539198;1261.1235191541791;788.8561585700642;789.3172405868996;814.5275740070745;822.0300045945842;845.040878602778;6216.378362163748;6248.156498872594;6452.548321617535;6474.384933431316;6482.967585162044;593.1429084972174;604.9122877182872;605.2857627998916;609.3601718195877;617.1514168018974;4015.7590544566833;4435.6673249505775;4439.067795762861;4484.192845287879;4499.617532509707;14688.779668304984;15147.848521514865;15330.770038449433;15332;15419.92290038565;14706.705865882623;15110.54668359951;15258.542243732705;15279.465218717292;15298.158601276815;8453;8629.093945135795;8686.478811271343;8699.391042626956;8702.260307873901;5439.700816455133;6107.770663707626;6462.806115816533;7022.40309573692;7383.707851126139;13443.193408395528;13557.864421356055;13841.861581384057;13990.16059036461;13995.300234988006;13817.447302108205;13979.021468497107;14119.0822596535;14127.717445651235;14218.289085545475;9459.574319155792;9671.70984870455;9754;9759.560819762986;9780.608775648894;10724.785504290026;10729.356238625707;10847.67456976292;10866.456677166268;10891.183161263096;9195.172434480928;9202.35583509148;9211.861822072808;9233.538323083952;9397.342186046912;8913.910860891308;9010.594523246338;9011.23404510624;9030.645403189574;9077.819883415114;8091.433599647969;8195.83608327842;8204.138565450781;8216.178382161735;8223.259906608433;5136.9743151284;5350.491703288181;6149.108379285068;6190.535709821871;6321.241451025722;5659.236003139688;5964.747403045409;6255.811395834777;6255.843603909939;6473.708683109366 05:46:38 INFO - PID 1636 | |4;prototype.html;383.8376273217496;394.6172212953434;410.3045338151832;418.1407208187176;418.474814108294;6001.849953751158;6033.7284822183;6206.7827626033095;6212.5029997600195;6257.937420625793;5221.477852214776;5913.822585322437;5984.940150598492;6040.275166979968;6045.425684559959;4272.077565095704;4448.777561121947;4469.128519938605;4486.237339652267;4505.526919673436;4213.241616509027;4446.444194475691;4475.172093162775;4491.348754430605;4506.752128632924;3843.4427008083812;4378.912421751563;4390.716827249828;4419;4437.4009508716235;3323.7341012719044;3574.4817001534893;3992.860249891254;4425;4448.753379543342;3692.4276737105793;3860.1314704191614;3863.8454461821493;3864;3869.7678139311734;4845.394325709286;5820.534357251409;5859.560532960002;5888.816742420441;5956.553258505586;3941.586133456003;4509.075639493896;5268.710220937885;5356.544693701001;5391.272178255925;5782.913256301159;5876.7649294028615;6268.518009623142;6432.935670643281;6493.93506064938;4348.869533913988;4379.6131108545915;4381;4381.58374954382;4394.121175764828;5762.423757624246;6012.8496787580225;6691.832704182386;6838.537581985026;6912.481563882729;4480.61914737251;4483.955160448419;4485.25993211123;4485.968227307738;4509.354085758674;4517.2094883395275;4530.961067519629;4540.500544940054;4563.041761230179;4563.680542362069;4194.916101677949;4925.581325587294;5238.580913526985;5294.352823588206;5361;5613.614213959051;6522.184726909137;6534.934650653528;6546.541742078104;6573.671316434159;1277.5337001994205;1404.2417094768914;1553.8113343292391;1555.719970405338;1555.813302403696;954.341504361988;964.2767924056957;1012.9392236465688;1021.933574317667;1030.9381437113648;5670;5940.970295148497;6061.090676475228;6123.448889599868;6165.270011642981;5972.223610930551;6155.799619074327;6641.269460359356;6667.433268172163;6682.331766823376;4819.614430845524;5385.75764090609;6070.028795392716;6085.208922840091;6094.634321940698;3442.862285508602;3472.3055388922317;3474.305138972165;3476.1830969722096;3487.8081705506443;5647.463490968352;6657.900131498031;6775.71261460321;6790.864182716318;6884.657491789153;6702.530822842452;6819.488538359643;6825.2833452486775;6826.859644563458;6829.556078854858;5662.858428539237;6464.22429308486;6714.563553369016;6825.795226143224;6835.384815366641;6565.212174539086;6587.6376799274585;6598.3401659833635;6607.900881486878;6609.834754131185;5560.499555040065;6470.773522926675;6509.674516274262;6509.934900650933;6529.804105876831;5557;6340.524460665376;6755.493337999571;6779.220389655253;6816.965915170393;4117.835286588503;4349.717268377545;4417.734935903727;4419.690621656453;4420.292753159608;6250.406211409909;6498.317676643885;6568.211814582281;6569.638669873203;6617.205935287796;5276.103062479465;5356.437574054824;6348.650824204713;6350.968245158745;6374.74501019954;5558.777648893999;6051.364606716232;6302.71637776292;6345.460635846005;6366.713497892699;5966;6229.750809967551;6249.312575616587;6256.31180570146;6257.1552840367785;5884.735186916513;6120.265568131853;6371.904421433775;6379.362063793584;6516.436055346778;5207.453217412269;5901.3213480448585;6127.264728232641;6247.344028877084;6259 05:46:38 INFO - PID 1636 | |5;yui.html;794.5550491724634;813.0852790610563;835.6072645856449;851.778537580229;859.2095272349438;16419.261133249;16880.240389182487;16913.83086169138;18155.909220453912;18857.15142818573;17693.46919592411;17885.82114178858;17978.730319045226;18078.5480362991;18495.35266265681;828.8715249136394;992.8709267795176;1004.5780772075709;1010.6260683547098;1011.145581983223;1005.316384858296;1030.4178139351243;1031.2317323593895;1032.5301987595626;1036.3212096077082;1056.7094049136472;1057.5293994172596;1066.4134725900763;1087.2009073331096;1087.9619213327496;896.7085697148453;1011.0698157694939;1054.6994106679597;1066.461436974323;1078.795028944498;743.7991742229568;748.9850202995909;760.4790718357942;769.799852038474;770.5184259837602;16274.511764647079;16349.509514714458;16411.671766564723;16433.178341082898;16511.422100226555;16856.072915989615;16875.746863797052;17041.977481351158;17055.48833534996;17299.74050389245;13772;13832;14078.71842563143;14093.506727264497;14095.71808563823;3343.1111422046465;3389.1527118220447;3393.253484233465;3401.523786669868;3403.710684591813;107252;122351;123168;124116;124478;13443.193408395528;13542.796858047137;13685.521006764715;13815.378307976165;13830.170189788645;18879.62240755177;21139.47151321229;21318;25822.354441139123;25994.6100808488;6771.93228067713;7832.255935686101;7864.567448790257;7897.763067107996;7923.286904178652;3759.9060023499633;3830.4062870255157;3834.213986132836;3846.826892789831;3858.3247931611854;4295.871123866289;4365.781710914442;4469.508354081048;4484.730916145042;4489.6408287336935;925.995370023159;955.2930831185012;957.7988622389237;958.5686441101532;959.8992105828927;542.7394850471717;627.9058141278845;629.3643420145686;661.3518751623436;684.3601232847303;10834.945825270823;10941.23411361213;11205.775884482264;11345.773084538263;11388.715282118013;602.4848754314997;641.5316818722265;646.8803271394808;654.9672516374162;679.8402375441767;4337.392765012901;5236.764345604457;5294.682319060868;5480.997180146249;5544.695041772741;93221.5338923301;93857.53071234736;96097;96348.51825740826;96942;84611.5769421149;84846.15153848506;84861.21110311161;85148.29703405897;86668.13331866727;76318;76367.61816190995;76523.23476765161;77834.99999999886;78630.06849657609;10240.436775977392;10463.372197667859;10713.946430267799;10890.237683362406;10921.563137474412;31219.687803121677;34528;39999.400008999306;40214;40756;49824.50175498199;68662.65668671625;69652.95520567094;69668.25829354307;69740.30259697339;16733.414330498374;16975;16984.915075424542;16992.235349409555;17119.14404279756;17938.91030544839;18487.352942646943;18588.349407770664;18741.34405295808;18760.624787504446;14518.346674399467;16727;16951.406700765416;17168.484945451655;17368.91315543414;16557.42049028278;16767.496975090766;16985.320587176375;17047.573810654834;17101.401450949157;16149;16694;16699.415520456725;16703.081330526453;16858.578535536708;11871.821922670993;11958.461869215733;12271.447784849881;12321.199122057038;12408.255504669749;12171.817422738843;13079.149855259378;13745.518906838213;13757;13766.31168441594 05:46:38 INFO - PID 1636 | __end_tp_report 05:46:38 INFO - PID 1636 | __start_cc_report 05:46:38 INFO - PID 1636 | _x_x_mozilla_cycle_collect,421 05:46:38 INFO - PID 1636 | __end_cc_report 05:46:38 INFO - PID 1636 | __startTimestamp1492173998608__endTimestamp 05:46:38 INFO - PID 1636 | 05:46:38 INFO - PID 1636 | ------- Summary: start ------- 05:46:38 INFO - PID 1636 | Number of tests: 6 05:46:38 INFO - PID 1636 | 05:46:38 INFO - PID 1636 | [#0] dojo.html Cycles:165 Average:6195.41 Median:6415.62 stddev:750.74 (11.7%) stddev-sans-first:710.33 05:46:38 INFO - PID 1636 | Values: 3013.5 3594.8 3621.0 3640.3 3669.6 6112.2 6219.3 6259.0 6260.2 6301.6 6172.3 6208.7 6209.1 6276.5 6276.7 5494.2 5516.5 5568.3 5597.5 5625.3 5449.4 5570.7 5627.3 5637.9 5648.4 5480.6 5499.8 5538.0 5559.7 5607.0 5537.0 5540.5 5559.0 5565.8 5615.7 5479.3 5494.6 5501.2 5501.6 5529.6 4524.0 6064.5 6143.4 6176.1 6188.9 6671.5 6718.0 6718.7 6720.6 6723.8 6778.9 6795.7 6796.5 6799.9 6814.5 6176.0 6204.3 6309.6 6323.6 6324.2 6953.6 6984.1 7006.6 7033.2 7034.4 4870.0 6442.6 6497.9 6511.3 6610.8 6582.1 6728.1 6810.0 6830.0 6837.5 5628.4 6337.9 6716.2 6724.9 6751.9 6562.0 6566.1 6650.3 6704.9 6756.2 5347.5 5356.5 5368.7 5389.2 5410.2 4771.6 4784.5 4801.3 4826.5 4845.8 6156.1 6294.2 6404.6 6418.2 6439.7 6889.1 6898.4 6898.6 6900.8 6909.6 6402.7 6419.2 6422.2 6460.8 6472.4 5847.8 5903.2 5919.9 5952.4 5990.9 6981.3 7007.2 7011.8 7014.7 7016.2 6787.3 6815.8 6856.4 6863.7 6878.9 6753.6 6837.8 6859.7 6944.4 6982.5 6698.3 6727.1 6727.6 6732.8 6737.2 6723.3 6811.6 6823.6 6840.7 6852.3 6367.3 6446.7 6447.0 6513.4 6609.5 6547.3 6563.2 6607.3 6613.7 6615.2 5298.3 6345.2 6383.2 6430.6 6461.3 6339.0 6415.6 6483.0 6582.4 6601.4 6280.5 6292.5 6352.3 6381.8 6392.5 05:46:38 INFO - PID 1636 | 05:46:38 INFO - PID 1636 | [#1] ext.html Cycles:180 Average:41545.86 Median:31779.86 stddev:67588.57 (212.7%) stddev-sans-first:67708.72 05:46:38 INFO - PID 1636 | Values: 738.1 810.6 832.6 1121.9 1126.6 30181.4 36154.6 37176.8 37259.1 37312.4 38759.6 39131.8 39171.6 39183.6 39188.6 8484.9 8525.1 8667.4 8699.0 8784.3 8554.5 8600.7 8678.0 8683.7 8693.7 8639.0 8643.7 8685.8 8696.2 8708.8 8639.9 8673.3 8683.3 8683.8 8689.3 8512.3 8541.9 8563.1 8574.7 8600.4 37644.0 37644.4 37677.1 37795.8 37867.2 3577.0 3580.1 3615.5 3621.3 3625.9 30798.5 30909.5 30974.4 31002.7 31037.0 2978.0 3040.7 3056.0 3063.1 3067.9 224580.0 227644.0 252151.0 252445.0 256453.7 35763.0 47780.8 47814.5 47949.0 47976.3 42334.4 47110.0 49155.3 49445.0 49462.8 14294.2 14396.0 14399.6 14407.4 14474.7 11551.7 11730.7 11747.8 11767.9 11785.6 11517.8 13138.7 13456.5 13611.7 13655.9 5980.5 5999.8 6002.8 6014.8 6048.2 1009.7 1038.4 1048.3 1062.6 1069.2 22977.7 23973.2 24063.8 24097.8 24243.0 1120.6 1123.9 1126.8 1157.7 1168.0 9761.2 12249.6 12281.1 12394.8 12848.4 273601.0 276855.0 277216.2 278275.0 278301.0 53858.7 54280.0 54334.7 54372.5 54493.7 1325.8 1481.6 1554.3 1554.8 1561.9 23699.9 23722.0 23837.2 23986.5 24267.8 33985.7 35071.1 37846.4 38047.4 38113.8 254822.0 256302.0 256926.0 257088.0 258135.0 34095.8 34411.3 34585.0 35118.8 35281.8 44646.3 45186.1 45264.0 45336.8 45742.6 30396.9 31229.0 31540.0 31599.5 31628.6 30197.9 30602.5 31083.1 31119.5 31139.5 36292.5 36556.8 36632.0 36653.8 36679.1 29940.4 31136.7 31142.0 31651.8 31907.9 21475.2 22691.5 23320.9 24240.0 24317.0 05:46:38 INFO - PID 1636 | 05:46:38 INFO - PID 1636 | [#2] jquery.html Cycles:180 Average:33400.01 Median:2261.68 stddev:83612.15 (3696.9%) stddev-sans-first:83810.05 05:46:38 INFO - PID 1636 | Values: 429.5 441.3 446.9 459.1 459.8 19267.5 20826.7 21583.7 21638.6 21711.8 18842.7 20505.2 22756.5 23378.6 23406.3 6029.0 6279.2 6310.2 6317.1 6351.9 5948.9 6225.7 6280.0 6285.8 6286.7 6175.7 6178.5 6185.6 6227.0 6229.5 6068.5 6182.6 6193.7 6243.4 6252.1 4814.0 5348.6 5520.9 5540.9 5555.1 26845.7 27225.9 27490.0 27770.7 27836.4 2189.8 2232.2 2255.5 2260.7 2262.7 17705.3 17709.8 17802.0 18315.4 18389.3 2147.9 2164.0 2208.7 2210.1 2212.6 133017.0 151248.0 156348.0 159533.0 161323.2 12244.9 12714.4 12799.5 12927.8 12948.4 16403.9 16473.4 16475.2 16481.2 16492.3 8865.8 9055.8 9077.2 9087.3 9229.1 8491.7 8650.2 8651.5 8827.4 8852.5 6821.4 7812.6 7977.4 7999.8 8018.5 1862.8 1863.9 2163.2 2182.0 2362.4 765.0 849.3 862.2 971.4 1016.3 20422.6 20903.8 20908.5 21087.6 21128.4 887.8 896.5 991.2 995.0 1025.2 10243.6 10757.0 10832.4 10860.6 10870.8 413538.0 503823.0 505357.0 506981.0 512493.0 82241.9 119708.0 120802.0 122063.0 125679.5 1141.3 1150.7 1172.7 1175.3 1175.9 17892.6 17944.2 17958.5 18079.5 18297.5 55952.4 56223.0 56347.0 56768.0 57057.4 73358.0 74882.6 77233.1 80120.8 81665.0 8822.6 8833.3 8907.0 8960.4 9353.9 12049.8 14426.9 14640.9 14880.0 15028.0 12021.3 12196.4 12306.1 12318.6 12343.4 11543.5 11547.8 11753.4 11881.0 11907.3 12267.4 12304.7 12445.4 12528.1 12550.0 9006.0 9063.1 9140.0 9177.0 9209.0 11992.9 12170.3 12334.9 12396.4 12435.2 05:46:38 INFO - PID 1636 | 05:46:38 INFO - PID 1636 | [#3] mootools.html Cycles:180 Average:7157.17 Median:3836.37 stddev:4549.64 (118.6%) stddev-sans-first:4541.98 05:46:38 INFO - PID 1636 | Values: 1419.6 1419.8 1420.2 1464.9 1496.7 11368.7 11815.7 11828.7 11901.6 12232.9 11846.5 12002.2 12045.9 12050.8 12082.2 2523.4 2571.8 2578.0 2593.6 2598.5 2465.8 2484.3 2486.3 2497.0 2497.6 2299.6 2469.2 2478.8 2530.5 2541.3 2100.4 2438.8 2440.8 2510.2 2531.2 2469.9 2525.8 2531.0 2537.1 2562.2 12095.3 12118.2 12127.8 12157.1 12265.9 5645.9 5731.7 6690.3 6908.9 6931.2 3657.0 4063.4 4326.3 4379.5 4380.0 1237.7 1238.2 1259.0 1283.5 1286.3 12672.9 13705.2 15547.4 16769.5 16884.1 5691.6 5758.1 5923.2 5929.1 6012.2 11723.2 12349.6 12482.8 12491.3 12549.6 6628.4 6685.1 6691.2 6693.2 6695.9 4967.7 5891.6 6191.9 6223.8 6247.8 4460.7 4511.7 4563.9 4567.3 4567.5 1226.6 1238.2 1242.2 1257.3 1261.1 788.9 789.3 814.5 822.0 845.0 6216.4 6248.2 6452.5 6474.4 6483.0 593.1 604.9 605.3 609.4 617.2 4015.8 4435.7 4439.1 4484.2 4499.6 14688.8 15147.8 15330.8 15332.0 15419.9 14706.7 15110.5 15258.5 15279.5 15298.2 8453.0 8629.1 8686.5 8699.4 8702.3 5439.7 6107.8 6462.8 7022.4 7383.7 13443.2 13557.9 13841.9 13990.2 13995.3 13817.4 13979.0 14119.1 14127.7 14218.3 9459.6 9671.7 9754.0 9759.6 9780.6 10724.8 10729.4 10847.7 10866.5 10891.2 9195.2 9202.4 9211.9 9233.5 9397.3 8913.9 9010.6 9011.2 9030.6 9077.8 8091.4 8195.8 8204.1 8216.2 8223.3 5137.0 5350.5 6149.1 6190.5 6321.2 5659.2 5964.7 6255.8 6255.8 6473.7 05:46:38 INFO - PID 1636 | 05:46:38 INFO - PID 1636 | [#4] prototype.html Cycles:180 Average:5162.35 Median:5868.16 stddev:1611.99 (27.5%) stddev-sans-first:1576.11 05:46:38 INFO - PID 1636 | Values: 383.8 394.6 410.3 418.1 418.5 6001.8 6033.7 6206.8 6212.5 6257.9 5221.5 5913.8 5984.9 6040.3 6045.4 4272.1 4448.8 4469.1 4486.2 4505.5 4213.2 4446.4 4475.2 4491.3 4506.8 3843.4 4378.9 4390.7 4419.0 4437.4 3323.7 3574.5 3992.9 4425.0 4448.8 3692.4 3860.1 3863.8 3864.0 3869.8 4845.4 5820.5 5859.6 5888.8 5956.6 3941.6 4509.1 5268.7 5356.5 5391.3 5782.9 5876.8 6268.5 6432.9 6493.9 4348.9 4379.6 4381.0 4381.6 4394.1 5762.4 6012.8 6691.8 6838.5 6912.5 4480.6 4484.0 4485.3 4486.0 4509.4 4517.2 4531.0 4540.5 4563.0 4563.7 4194.9 4925.6 5238.6 5294.4 5361.0 5613.6 6522.2 6534.9 6546.5 6573.7 1277.5 1404.2 1553.8 1555.7 1555.8 954.3 964.3 1012.9 1021.9 1030.9 5670.0 5941.0 6061.1 6123.4 6165.3 5972.2 6155.8 6641.3 6667.4 6682.3 4819.6 5385.8 6070.0 6085.2 6094.6 3442.9 3472.3 3474.3 3476.2 3487.8 5647.5 6657.9 6775.7 6790.9 6884.7 6702.5 6819.5 6825.3 6826.9 6829.6 5662.9 6464.2 6714.6 6825.8 6835.4 6565.2 6587.6 6598.3 6607.9 6609.8 5560.5 6470.8 6509.7 6509.9 6529.8 5557.0 6340.5 6755.5 6779.2 6817.0 4117.8 4349.7 4417.7 4419.7 4420.3 6250.4 6498.3 6568.2 6569.6 6617.2 5276.1 5356.4 6348.7 6351.0 6374.7 5558.8 6051.4 6302.7 6345.5 6366.7 5966.0 6229.8 6249.3 6256.3 6257.2 5884.7 6120.3 6371.9 6379.4 6516.4 5207.5 5901.3 6127.3 6247.3 6259.0 05:46:38 INFO - PID 1636 | 05:46:38 INFO - PID 1636 | [#5] yui.html Cycles:180 Average:21252.82 Median:18321.63 stddev:29220.54 (159.5%) stddev-sans-first:29262.13 05:46:38 INFO - PID 1636 | Values: 794.6 813.1 835.6 851.8 859.2 16419.3 16880.2 16913.8 18155.9 18857.2 17693.5 17885.8 17978.7 18078.5 18495.4 828.9 992.9 1004.6 1010.6 1011.1 1005.3 1030.4 1031.2 1032.5 1036.3 1056.7 1057.5 1066.4 1087.2 1088.0 896.7 1011.1 1054.7 1066.5 1078.8 743.8 749.0 760.5 769.8 770.5 16274.5 16349.5 16411.7 16433.2 16511.4 16856.1 16875.7 17042.0 17055.5 17299.7 13772.0 13832.0 14078.7 14093.5 14095.7 3343.1 3389.2 3393.3 3401.5 3403.7 107252.0 122351.0 123168.0 124116.0 124478.0 13443.2 13542.8 13685.5 13815.4 13830.2 18879.6 21139.5 21318.0 25822.4 25994.6 6771.9 7832.3 7864.6 7897.8 7923.3 3759.9 3830.4 3834.2 3846.8 3858.3 4295.9 4365.8 4469.5 4484.7 4489.6 926.0 955.3 957.8 958.6 959.9 542.7 627.9 629.4 661.4 684.4 10834.9 10941.2 11205.8 11345.8 11388.7 602.5 641.5 646.9 655.0 679.8 4337.4 5236.8 5294.7 5481.0 5544.7 93221.5 93857.5 96097.0 96348.5 96942.0 84611.6 84846.2 84861.2 85148.3 86668.1 76318.0 76367.6 76523.2 77835.0 78630.1 10240.4 10463.4 10713.9 10890.2 10921.6 31219.7 34528.0 39999.4 40214.0 40756.0 49824.5 68662.7 69653.0 69668.3 69740.3 16733.4 16975.0 16984.9 16992.2 17119.1 17938.9 18487.4 18588.3 18741.3 18760.6 14518.3 16727.0 16951.4 17168.5 17368.9 16557.4 16767.5 16985.3 17047.6 17101.4 16149.0 16694.0 16699.4 16703.1 16858.6 11871.8 11958.5 12271.4 12321.2 12408.3 12171.8 13079.1 13745.5 13757.0 13766.3 05:46:38 INFO - PID 1636 | -------- Summary: end -------- 05:46:38 INFO - PID 1636 | 05:46:39 INFO - TEST-INFO | 1636: exit 0 05:46:39 INFO - TEST-OK | dromaeo_css | took 1115904ms 05:46:39 INFO - TEST-START | kraken 05:46:39 INFO - operating with platform_type : mac_ 05:46:39 INFO - Initialising browser for kraken test... 05:46:39 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/tmpGPy7SF/profile http://localhost:49241/getInfo.html) 05:46:42 INFO - PID 1652 | 2017-04-14 05:46:42.343 plugin-container[1653:10176] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 05:46:42 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:46:42 INFO - PID 1652 | 2017-04-14 05:46:42.344 plugin-container[1653:10176] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a1f, name = 'com.apple.CFPasteboardClient' 05:46:42 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:46:42 INFO - PID 1652 | 2017-04-14 05:46:42.344 plugin-container[1653:10176] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:46:42 INFO - PID 1652 | __metrics Screen width/height:1600/1200 05:46:42 INFO - PID 1652 | colorDepth:24 05:46:42 INFO - PID 1652 | Browser inner width/height: 1024/689 05:46:42 INFO - PID 1652 | __metrics 05:46:42 ERROR - PID 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 05:46:43 INFO - TEST-INFO | 1652: exit 0 05:46:43 INFO - Browser initialized. 05:46:43 INFO - Running cycle 1/1 for kraken test... 05:46:43 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/T/tmpGPy7SF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:46 INFO - PID 1654 | 2017-04-14 05:46:46.046 plugin-container[1655:10295] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 05:46:46 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:46:46 INFO - PID 1654 | 2017-04-14 05:46:46.047 plugin-container[1655:10295] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b17, name = 'com.apple.CFPasteboardClient' 05:46:46 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:46:46 INFO - PID 1654 | 2017-04-14 05:46:46.047 plugin-container[1655:10295] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:46:55 INFO - PID 1654 | RSS: Main: 239226880 05:46:55 INFO - PID 1654 | 05:46:58 INFO - PID 1654 | 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) 05:46:59 INFO - PID 1654 | RSS: Main: 250900480 05:46:59 INFO - PID 1654 | 05:47:02 INFO - PID 1654 | 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) 05:47:02 INFO - PID 1654 | RSS: Main: 259260416 05:47:02 INFO - PID 1654 | 05:47:06 INFO - PID 1654 | 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) 05:47:06 INFO - PID 1654 | RSS: Main: 261795840 05:47:06 INFO - PID 1654 | 05:47:08 INFO - PID 1654 | 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) 05:47:09 INFO - PID 1654 | RSS: Main: 263712768 05:47:09 INFO - PID 1654 | 05:47:11 INFO - PID 1654 | 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) 05:47:12 INFO - PID 1654 | RSS: Main: 264445952 05:47:12 INFO - PID 1654 | 05:47:15 INFO - PID 1654 | 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) 05:47:15 INFO - PID 1654 | RSS: Main: 270409728 05:47:15 INFO - PID 1654 | 05:47:18 INFO - PID 1654 | 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) 05:47:19 INFO - PID 1654 | RSS: Main: 271495168 05:47:19 INFO - PID 1654 | 05:47:22 INFO - PID 1654 | 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) 05:47:22 INFO - PID 1654 | RSS: Main: 271097856 05:47:22 INFO - PID 1654 | 05:47:24 INFO - PID 1654 | 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) 05:47:25 INFO - PID 1654 | RSS: Main: 270475264 05:47:25 INFO - PID 1654 | 05:47:26 INFO - PID 1654 | 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) 05:47:27 INFO - PID 1654 | RSS: Main: 270725120 05:47:27 INFO - PID 1654 | 05:47:29 INFO - PID 1654 | 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) 05:47:30 INFO - PID 1654 | RSS: Main: 270254080 05:47:30 INFO - PID 1654 | 05:47:33 INFO - PID 1654 | 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) 05:47:34 INFO - PID 1654 | RSS: Main: 270503936 05:47:34 INFO - PID 1654 | 05:47:37 INFO - PID 1654 | 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) 05:47:37 INFO - PID 1654 | RSS: Main: 270573568 05:47:37 INFO - PID 1654 | 05:47:39 INFO - PID 1654 | 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) 05:47:39 INFO - PID 1654 | RSS: Main: 272314368 05:47:39 INFO - PID 1654 | 05:47:39 INFO - PID 1654 | __start_tp_report 05:47:39 INFO - PID 1654 | _x_x_mozilla_page_load 05:47:39 INFO - PID 1654 | _x_x_mozilla_page_load_details 05:47:39 INFO - PID 1654 | |i|pagename|runs| 05:47:39 INFO - PID 1654 | |0;ai-astar;104;99;161;169;115;116;115;116;116;115 05:47:39 INFO - PID 1654 | |1;audio-beat-detection;145;117;146;147;139;144;146;113;139;111 05:47:39 INFO - PID 1654 | |2;audio-dft;192;196;233;230;179;166;198;267;222;229 05:47:39 INFO - PID 1654 | |3;audio-fft;66;48;60;97;88;72;52;52;82;52 05:47:39 INFO - PID 1654 | |4;audio-oscillator;86;69;86;73;94;104;111;81;71;91 05:47:39 INFO - PID 1654 | |5;imaging-gaussian-blur;89;91;89;88;90;89;105;100;90;91 05:47:39 INFO - PID 1654 | |6;imaging-darkroom;97;98;97;117;154;130;97;97;97;97 05:47:39 INFO - PID 1654 | |7;imaging-desaturate;91;94;89;93;93;90;90;93;92;93 05:47:39 INFO - PID 1654 | |8;json-parse-financial;52;50;51;52;51;52;53;51;53;51 05:47:39 INFO - PID 1654 | |9;json-stringify-tinderbox;57;76;86;95;89;63;59;56;56;57 05:47:39 INFO - PID 1654 | |10;stanford-crypto-aes;85;111;107;106;84;86;87;86;83;84 05:47:39 INFO - PID 1654 | |11;stanford-crypto-ccm;139;139;135;136;144;139;142;147;186;139 05:47:39 INFO - PID 1654 | |12;stanford-crypto-pbkdf2;191;185;191;227;217;178;165;216;236;188 05:47:39 INFO - PID 1654 | |13;stanford-crypto-sha256-iterative;71;71;69;70;68;80;70;60;76;78 05:47:39 INFO - PID 1654 | __end_tp_report 05:47:39 INFO - PID 1654 | __start_cc_report 05:47:39 INFO - PID 1654 | _x_x_mozilla_cycle_collect,1002 05:47:39 INFO - PID 1654 | __end_cc_report 05:47:39 INFO - PID 1654 | __startTimestamp1492174059857__endTimestamp 05:47:39 INFO - PID 1654 | 05:47:39 INFO - PID 1654 | ------- Summary: start ------- 05:47:39 INFO - PID 1654 | Number of tests: 14 05:47:39 INFO - PID 1654 | 05:47:39 INFO - PID 1654 | [#0] ai-astar Cycles:10 Average:122.60 Median:116.00 stddev:23.18 (20.0%) stddev-sans-first:23.58 05:47:39 INFO - PID 1654 | Values: 104.0 99.0 161.0 169.0 115.0 116.0 115.0 116.0 116.0 115.0 05:47:39 INFO - PID 1654 | 05:47:39 INFO - PID 1654 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:144.50 stddev:14.84 (10.3%) stddev-sans-first:15.27 05:47:39 INFO - PID 1654 | Values: 145.0 117.0 146.0 147.0 139.0 144.0 146.0 113.0 139.0 111.0 05:47:39 INFO - PID 1654 | 05:47:39 INFO - PID 1654 | [#2] audio-dft Cycles:10 Average:211.20 Median:225.50 stddev:30.24 (13.4%) stddev-sans-first:31.26 05:47:39 INFO - PID 1654 | Values: 192.0 196.0 233.0 230.0 179.0 166.0 198.0 267.0 222.0 229.0 05:47:39 INFO - PID 1654 | 05:47:39 INFO - PID 1654 | [#3] audio-fft Cycles:10 Average:66.90 Median:69.00 stddev:17.25 (25.0%) stddev-sans-first:18.29 05:47:39 INFO - PID 1654 | Values: 66.0 48.0 60.0 97.0 88.0 72.0 52.0 52.0 82.0 52.0 05:47:39 INFO - PID 1654 | 05:47:39 INFO - PID 1654 | [#4] audio-oscillator Cycles:10 Average:86.60 Median:83.50 stddev:13.91 (16.7%) stddev-sans-first:14.76 05:47:39 INFO - PID 1654 | Values: 86.0 69.0 86.0 73.0 94.0 104.0 111.0 81.0 71.0 91.0 05:47:39 INFO - PID 1654 | 05:47:39 INFO - PID 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:92.20 Median:89.50 stddev:5.63 (6.3%) stddev-sans-first:5.85 05:47:39 INFO - PID 1654 | Values: 89.0 91.0 89.0 88.0 90.0 89.0 105.0 100.0 90.0 91.0 05:47:39 INFO - PID 1654 | 05:47:39 INFO - PID 1654 | [#6] imaging-darkroom Cycles:10 Average:108.10 Median:97.00 stddev:19.74 (20.4%) stddev-sans-first:20.52 05:47:39 INFO - PID 1654 | Values: 97.0 98.0 97.0 117.0 154.0 130.0 97.0 97.0 97.0 97.0 05:47:39 INFO - PID 1654 | 05:47:39 INFO - PID 1654 | [#7] imaging-desaturate Cycles:10 Average:91.80 Median:93.00 stddev:1.69 (1.8%) stddev-sans-first:1.76 05:47:39 INFO - PID 1654 | Values: 91.0 94.0 89.0 93.0 93.0 90.0 90.0 93.0 92.0 93.0 05:47:39 INFO - PID 1654 | 05:47:39 INFO - PID 1654 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:0.97 (1.9%) stddev-sans-first:1.01 05:47:39 INFO - PID 1654 | Values: 52.0 50.0 51.0 52.0 51.0 52.0 53.0 51.0 53.0 51.0 05:47:39 INFO - PID 1654 | 05:47:39 INFO - PID 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.50 stddev:15.54 (22.4%) stddev-sans-first:15.83 05:47:39 INFO - PID 1654 | Values: 57.0 76.0 86.0 95.0 89.0 63.0 59.0 56.0 56.0 57.0 05:47:39 INFO - PID 1654 | 05:47:39 INFO - PID 1654 | [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:84.50 stddev:11.24 (13.3%) stddev-sans-first:11.64 05:47:39 INFO - PID 1654 | Values: 85.0 111.0 107.0 106.0 84.0 86.0 87.0 86.0 83.0 84.0 05:47:39 INFO - PID 1654 | 05:47:39 INFO - PID 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:144.60 Median:140.50 stddev:14.98 (10.7%) stddev-sans-first:15.75 05:47:39 INFO - PID 1654 | Values: 139.0 139.0 135.0 136.0 144.0 139.0 142.0 147.0 186.0 139.0 05:47:39 INFO - PID 1654 | 05:47:39 INFO - PID 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.40 Median:203.50 stddev:23.11 (11.4%) stddev-sans-first:24.31 05:47:39 INFO - PID 1654 | Values: 191.0 185.0 191.0 227.0 217.0 178.0 165.0 216.0 236.0 188.0 05:47:39 INFO - PID 1654 | 05:47:39 INFO - PID 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.00 stddev:5.68 (8.0%) stddev-sans-first:6.02 05:47:39 INFO - PID 1654 | Values: 71.0 71.0 69.0 70.0 68.0 80.0 70.0 60.0 76.0 78.0 05:47:39 INFO - PID 1654 | -------- Summary: end -------- 05:47:39 INFO - PID 1654 | 05:47:41 INFO - TEST-INFO | 1654: exit 0 05:47:41 INFO - TEST-OK | kraken | took 61845ms 05:47:41 INFO - SUITE-END | took 1177s 05:47:41 INFO - Completed test suite (00:19:38) 05:47:41 INFO - javascript benchmark 05:47:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7821.619191779099, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3013.5479678048277, 3594.8382322795455, 3621.0, 3640.326539590176, 3669.5596528416595, 6112.229929638737, 6219.315875253718, 6258.968705156473, 6260.2487701475775, 6301.621902685842, 6172.290186628539, 6208.658523781201, 6209.130721698965, 6276.529260305484, 6276.686165691709, 5494.203340515623, 5516.475934786189, 5568.303962004749, 5597.468240517144, 5625.268715067035, 5449.427810079944, 5570.721463926808, 5627.296587926509, 5637.943620563803, 5648.406917273689, 5480.588955828289, 5499.780008799643, 5538.0, 5559.6664200148125, 5607.0, 5537.0, 5540.473655002768, 5558.972205138948, 5565.833025009256, 5615.691136987505, 5479.342478902558, 5494.587905907073, 5501.174823776466, 5501.614886957915, 5529.640573362759, 4523.982104026568, 6064.54515911304, 6143.385661433866, 6176.104464852616, 6188.87622247557, 6671.532992690513, 6717.966410167918, 6718.731250749964, 6720.630365329905, 6723.7646682365885, 6778.898316525256, 6795.694193761293, 6796.524243302971, 6799.864002719967, 6814.48891333152, 6175.96912015437, 6204.317525072239, 6309.589876658002, 6323.588966717149, 6324.177856878622, 6953.582785032813, 6984.057152284377, 7006.614636194956, 7033.226345102034, 7034.402075823612, 4869.95130048695, 6442.645654489048, 6497.870042599122, 6511.28375878653, 6610.8347291318105, 6582.144321238208, 6728.091707619409, 6810.0, 6830.009648600925, 6837.521373503807, 5628.437156284421, 6337.873242535124, 6716.227633822173, 6724.899126513106, 6751.898721519181, 6561.967190164019, 6566.146400967939, 6650.334966503311, 6704.899426508607, 6756.189257289157, 5347.491988261109, 5356.491133342326, 5368.731563421813, 5389.164679474609, 5410.242566040757, 4771.594414474808, 4784.473707892129, 4801.255805350176, 4826.493218212037, 4845.781939812717, 6156.107364432132, 6294.181756371642, 6404.583702059351, 6418.229812422539, 6439.710213040425, 6889.138857642794, 6898.379145876795, 6898.586084834926, 6900.827479313058, 6909.585424874524, 6402.711877965409, 6419.197600299963, 6422.229332480132, 6460.806175814733, 6472.35276472349, 5847.795327163529, 5903.203067585821, 5919.881602367928, 5952.4047595241, 5990.940090599038, 6981.2669669684965, 7007.229204787572, 7011.824704382431, 7014.68433920485, 7016.228214896255, 6787.321267873173, 6815.761448349284, 6856.382925536725, 6863.691133899087, 6878.896816547855, 6753.628550429774, 6837.760678376233, 6859.7256109757045, 6944.4097251734165, 6982.546134501241, 6698.2631910488835, 6727.091842601382, 6727.629980351127, 6732.798016059526, 6737.191537015589, 6723.294054124247, 6811.625360605214, 6823.624700641314, 6840.657967101525, 6852.314768523307, 6367.3314301997625, 6446.742130314922, 6447.0329450582785, 6513.413792758674, 6609.537332386687, 6547.312532184243, 6563.245226798788, 6607.3062328456745, 6613.66931653425, 6615.206175259, 5298.337707786527, 6345.238571371465, 6383.202099737533, 6430.614163150226, 6461.256955449995, 6339.049142628458, 6415.615063096229, 6483.0, 6582.3746744059235, 6601.405873471411, 6280.497560195082, 6292.465140463112, 6352.333005034589, 6381.840453988688, 6392.488600912009], "value": 6145.459009440796, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.1253214940297, 810.6352141536308, 832.6003518311211, 1121.9214654974144, 1126.5775334249652, 30181.396372072544, 36154.63845361549, 37176.814115929454, 37259.06852328693, 37312.440313395324, 38759.61240387595, 39131.804340978255, 39171.60828391715, 39183.608163918354, 39188.60811391885, 8484.872726909101, 8525.147485251457, 8667.43661661993, 8698.956505217466, 8784.341174411944, 8554.486730796141, 8600.698975535857, 8678.002029766563, 8683.652653893836, 8693.739187824343, 8638.956805215965, 8643.740687779346, 8685.826283474358, 8696.21734043936, 8708.782280443007, 8639.913600864005, 8673.306135509207, 8683.348748843799, 8683.826323473559, 8689.261412779953, 8512.319014478826, 8541.871871921927, 8563.143685631449, 8574.657013719443, 8600.397972141953, 37644.0, 37644.43533347002, 37677.058073548105, 37795.811020944995, 37867.24265514674, 3576.9642303576893, 3580.104973756561, 3615.4757560153894, 3621.3300539400293, 3625.9303505465687, 30798.53802192969, 30909.536356954664, 30974.380512389627, 31002.689973100205, 31037.0, 2978.0470249520163, 3040.7111324424145, 3056.006797790727, 3063.1423201503617, 3067.9233019174476, 224580.0, 227644.0, 252151.0, 252445.0, 256453.717731412, 35763.0, 47780.7610961943, 47814.52185478101, 47949.04101917942, 47976.28035579469, 42334.36498452526, 47110.0, 49155.262671059965, 49445.0, 49462.75268623706, 14294.213818240096, 14396.0, 14399.568012959628, 14407.42370305197, 14474.710505789826, 11551.711207219887, 11730.70673233159, 11747.823782643096, 11767.940885320362, 11785.646430607096, 11517.827232591519, 13138.700727372672, 13456.46174153023, 13611.727765444635, 13655.931720341334, 5980.521558275327, 5999.790007349722, 6002.819915402545, 6014.789482368096, 6048.153258543807, 1009.65671671632, 1038.4236748604596, 1048.250500891866, 1062.5802807890839, 1069.2034434346463, 22977.655335169984, 23973.160939367386, 24063.7593624065, 24097.75902240955, 24243.0, 1120.6469961961957, 1123.8763735989035, 1126.830975353687, 1157.745296034871, 1167.9708007299716, 9761.170300524393, 12249.632511024683, 12281.078919080926, 12394.75210495785, 12848.421821018077, 273601.0, 276855.0, 277216.2278377231, 278275.0, 278301.0, 53858.730706346214, 54280.0, 54334.72832635811, 54372.45627543753, 54493.727531362885, 1325.821014163095, 1481.5629389330174, 1554.2694933381292, 1554.844515548436, 1561.9062856228663, 23699.881500593077, 23722.0, 23837.165699200446, 23986.520269594163, 24267.75732242655, 33985.66014339825, 35071.12322191965, 37846.43230351492, 38047.42928856014, 38113.80943095267, 254822.0, 256302.0, 256926.0, 257088.0, 258135.0, 34095.82952085224, 34411.311773764886, 34585.0, 35118.824405878826, 35281.82359088188, 44646.3303050461, 45186.09627807359, 45264.0, 45336.77331613321, 45742.62772116842, 30396.936107237027, 31229.0, 31540.0, 31599.526007109453, 31628.627852910664, 30197.921624622883, 30602.540961885144, 31083.067507974796, 31119.533207002365, 31139.532907006866, 36292.45561316529, 36556.81721591375, 36632.0, 36653.81673091617, 36679.08302292464, 29940.401191976474, 31136.688633114285, 31142.0, 31651.841740791147, 31907.883224087047, 21475.248366307103, 22691.546169076857, 23320.883395582914, 24240.0, 24317.0], "value": 17308.2733102626, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.47174974781, 441.3468067260454, 446.9307257375106, 459.120783699216, 459.75173406360585, 19267.518312042204, 20826.687599686018, 21583.67624485634, 21638.567228655458, 21711.782882171174, 18842.71735923959, 20505.17979280827, 22756.544869102607, 23378.64932026021, 23406.29781106565, 6028.969855150718, 6279.215098112736, 6310.211223597051, 6317.05244213367, 6351.872962540747, 5948.88102237955, 6225.719842607094, 6280.026595877646, 6285.842853928642, 6286.7170977305905, 6175.722092505848, 6178.474829639486, 6185.628862268279, 6226.968865155668, 6229.470495007907, 6068.484178844804, 6182.629042257434, 6193.721282542297, 6243.406876346739, 6252.124702541671, 4813.975930120362, 5348.598855085846, 5520.917186242169, 5540.944590554123, 5555.111182210827, 26845.73154268452, 27225.86387068052, 27490.0, 27770.722292777016, 27836.443271134463, 2189.770074142208, 2232.1852523828684, 2255.4699645583273, 2260.660900864867, 2262.7058482397347, 17705.29178832845, 17709.822901771076, 17802.0, 18315.35896243625, 18389.26442942281, 2147.9463013424634, 2164.0, 2208.723909511311, 2210.071769856664, 2212.6459766437456, 133017.0, 151248.0, 156348.0, 159533.0, 161323.1933840335, 12244.877551224552, 12714.427850746739, 12799.488020479077, 12927.806082908764, 12948.352582370844, 16403.91798041002, 16473.423430179886, 16475.17624118789, 16481.17594120289, 16492.34030638785, 8865.778355541162, 9055.81888362229, 9077.228435582918, 9087.31845111606, 9229.10803285325, 8491.702790402307, 8650.221480066824, 8651.48091114535, 8827.426217295855, 8852.513111778913, 6821.3519715626935, 7812.570308632966, 7977.3618110551015, 7999.760007199793, 8018.4787988780545, 1862.7764668239897, 1863.8508919286423, 2163.210428193698, 2182.0, 2362.421206804344, 764.957927313992, 849.2781136034445, 862.2196911794836, 971.4414211828228, 1016.2510409342858, 20422.59154816925, 20903.790962090185, 20908.477288067617, 21087.578248434944, 21128.366149015554, 887.8135591525852, 896.5427631907774, 991.1822746234242, 995.0, 1025.1644909398817, 10243.59025638981, 10757.0, 10832.350058996486, 10860.565577376974, 10870.836937445945, 413538.0, 503823.0, 505357.0, 506981.0, 512493.0, 82241.94395140049, 119708.0, 120802.0, 122063.0, 125679.48641027129, 1141.3380239461092, 1150.7295785490403, 1172.7478592102739, 1175.3359351966283, 1175.9412029398495, 17892.642147157243, 17944.19251133676, 17958.473529750117, 18079.45761627153, 18297.45107646773, 55952.440475594725, 56223.0, 56347.0, 56768.0, 57057.42942570687, 73358.0, 74882.62558687171, 77233.06917327111, 80120.79818802606, 81665.0, 8822.5588720565, 8833.33749968742, 8907.0, 8960.417572857743, 9353.85969210476, 12049.81925271104, 14426.85573144255, 14640.926795365955, 14880.0, 15028.0, 12021.338826364634, 12196.390180491117, 12306.077044221898, 12318.568850090203, 12343.382830858602, 11543.4805433754, 11547.769044619228, 11753.353565553976, 11881.0, 11907.285562866256, 12267.447964841425, 12304.692382690504, 12445.439955201857, 12528.123031387715, 12550.0, 9006.0, 9063.13900179482, 9140.034892498144, 9177.0, 9208.953955230181, 11992.940035299767, 12170.330631815335, 12334.938325308316, 12396.380180990735, 12435.191712538655], "value": 10393.323520415403, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.5599364197094, 1419.8012278281049, 1420.169201017405, 1464.9379200079936, 1496.6931778985306, 11368.658940231797, 11815.70460738482, 11828.704282392933, 11901.58344457944, 12232.938835305833, 11846.526138954454, 12002.219855709372, 12045.879541204586, 12050.758984820299, 12082.15424920256, 2523.356544081266, 2571.807114466413, 2577.9871100644564, 2593.638339871564, 2598.5062838060803, 2465.827392082555, 2484.335495218208, 2486.3411196032976, 2497.0261597976805, 2497.5878979968284, 2299.643210505801, 2469.172827102923, 2478.7893029092456, 2530.4812513434795, 2541.275736415122, 2100.4223838444395, 2438.780509754122, 2440.791808055024, 2510.1716433576876, 2531.1520640585336, 2469.9012039518398, 2525.7600527949817, 2531.0255551612577, 2537.112010796225, 2562.154489018619, 12095.334756588383, 12118.212316199508, 12127.818082728767, 12157.088218383657, 12265.938670306681, 5645.858853528694, 5731.742071606787, 6690.264070952191, 6908.9309106909295, 6931.2375638679705, 3656.9817150914073, 4063.3701776224734, 4326.329418940069, 4379.540148284448, 4379.978100109511, 1237.665830225843, 1238.2261086820738, 1259.0368368198335, 1283.4609464025039, 1286.2989670629436, 12672.936635316857, 13705.177689338672, 15547.378104875792, 16769.496915092568, 16884.07137607431, 5691.601587888808, 5758.107493338539, 5923.200367950271, 5929.080992446177, 6012.218411606463, 11723.237989530653, 12349.629511114681, 12482.75034499305, 12491.250524968349, 12549.560765373168, 6628.409181796334, 6685.097511835937, 6691.197056353171, 6693.230278517935, 6695.866082678319, 4967.677100988496, 5891.587588868823, 6191.854506916235, 6223.844403889849, 6247.843803904848, 4460.665450091256, 4511.736713720164, 4563.885902852455, 4567.269236922077, 4567.451905771329, 1226.589092653971, 1238.2446707508593, 1242.2049888071642, 1257.3147634539198, 1261.1235191541791, 788.8561585700642, 789.3172405868996, 814.5275740070745, 822.0300045945842, 845.040878602778, 6216.378362163748, 6248.156498872594, 6452.548321617535, 6474.384933431316, 6482.967585162044, 593.1429084972174, 604.9122877182872, 605.2857627998916, 609.3601718195877, 617.1514168018974, 4015.7590544566833, 4435.6673249505775, 4439.067795762861, 4484.192845287879, 4499.617532509707, 14688.779668304984, 15147.848521514865, 15330.770038449433, 15332.0, 15419.92290038565, 14706.705865882623, 15110.54668359951, 15258.542243732705, 15279.465218717292, 15298.158601276815, 8453.0, 8629.093945135795, 8686.478811271343, 8699.391042626956, 8702.260307873901, 5439.700816455133, 6107.770663707626, 6462.806115816533, 7022.40309573692, 7383.707851126139, 13443.193408395528, 13557.864421356055, 13841.861581384057, 13990.16059036461, 13995.300234988006, 13817.447302108205, 13979.021468497107, 14119.0822596535, 14127.717445651235, 14218.289085545475, 9459.574319155792, 9671.70984870455, 9754.0, 9759.560819762986, 9780.608775648894, 10724.785504290026, 10729.356238625707, 10847.67456976292, 10866.456677166268, 10891.183161263096, 9195.172434480928, 9202.35583509148, 9211.861822072808, 9233.538323083952, 9397.342186046912, 8913.910860891308, 9010.594523246338, 9011.23404510624, 9030.645403189574, 9077.819883415114, 8091.433599647969, 8195.83608327842, 8204.138565450781, 8216.178382161735, 8223.259906608433, 5136.9743151284, 5350.491703288181, 6149.108379285068, 6190.535709821871, 6321.241451025722, 5659.236003139688, 5964.747403045409, 6255.811395834777, 6255.843603909939, 6473.708683109366], "value": 5352.927008246493, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.8376273217496, 394.6172212953434, 410.3045338151832, 418.1407208187176, 418.474814108294, 6001.849953751158, 6033.7284822183, 6206.7827626033095, 6212.5029997600195, 6257.937420625793, 5221.477852214776, 5913.822585322437, 5984.940150598492, 6040.275166979968, 6045.425684559959, 4272.077565095704, 4448.777561121947, 4469.128519938605, 4486.237339652267, 4505.526919673436, 4213.241616509027, 4446.444194475691, 4475.172093162775, 4491.348754430605, 4506.752128632924, 3843.4427008083812, 4378.912421751563, 4390.716827249828, 4419.0, 4437.4009508716235, 3323.7341012719044, 3574.4817001534893, 3992.860249891254, 4425.0, 4448.753379543342, 3692.4276737105793, 3860.1314704191614, 3863.8454461821493, 3864.0, 3869.7678139311734, 4845.394325709286, 5820.534357251409, 5859.560532960002, 5888.816742420441, 5956.553258505586, 3941.586133456003, 4509.075639493896, 5268.710220937885, 5356.544693701001, 5391.272178255925, 5782.913256301159, 5876.7649294028615, 6268.518009623142, 6432.935670643281, 6493.93506064938, 4348.869533913988, 4379.6131108545915, 4381.0, 4381.58374954382, 4394.121175764828, 5762.423757624246, 6012.8496787580225, 6691.832704182386, 6838.537581985026, 6912.481563882729, 4480.61914737251, 4483.955160448419, 4485.25993211123, 4485.968227307738, 4509.354085758674, 4517.2094883395275, 4530.961067519629, 4540.500544940054, 4563.041761230179, 4563.680542362069, 4194.916101677949, 4925.581325587294, 5238.580913526985, 5294.352823588206, 5361.0, 5613.614213959051, 6522.184726909137, 6534.934650653528, 6546.541742078104, 6573.671316434159, 1277.5337001994205, 1404.2417094768914, 1553.8113343292391, 1555.719970405338, 1555.813302403696, 954.341504361988, 964.2767924056957, 1012.9392236465688, 1021.933574317667, 1030.9381437113648, 5670.0, 5940.970295148497, 6061.090676475228, 6123.448889599868, 6165.270011642981, 5972.223610930551, 6155.799619074327, 6641.269460359356, 6667.433268172163, 6682.331766823376, 4819.614430845524, 5385.75764090609, 6070.028795392716, 6085.208922840091, 6094.634321940698, 3442.862285508602, 3472.3055388922317, 3474.305138972165, 3476.1830969722096, 3487.8081705506443, 5647.463490968352, 6657.900131498031, 6775.71261460321, 6790.864182716318, 6884.657491789153, 6702.530822842452, 6819.488538359643, 6825.2833452486775, 6826.859644563458, 6829.556078854858, 5662.858428539237, 6464.22429308486, 6714.563553369016, 6825.795226143224, 6835.384815366641, 6565.212174539086, 6587.6376799274585, 6598.3401659833635, 6607.900881486878, 6609.834754131185, 5560.499555040065, 6470.773522926675, 6509.674516274262, 6509.934900650933, 6529.804105876831, 5557.0, 6340.524460665376, 6755.493337999571, 6779.220389655253, 6816.965915170393, 4117.835286588503, 4349.717268377545, 4417.734935903727, 4419.690621656453, 4420.292753159608, 6250.406211409909, 6498.317676643885, 6568.211814582281, 6569.638669873203, 6617.205935287796, 5276.103062479465, 5356.437574054824, 6348.650824204713, 6350.968245158745, 6374.74501019954, 5558.777648893999, 6051.364606716232, 6302.71637776292, 6345.460635846005, 6366.713497892699, 5966.0, 6229.750809967551, 6249.312575616587, 6256.31180570146, 6257.1552840367785, 5884.735186916513, 6120.265568131853, 6371.904421433775, 6379.362063793584, 6516.436055346778, 5207.453217412269, 5901.3213480448585, 6127.264728232641, 6247.344028877084, 6259.0], "value": 4664.785758233955, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.5550491724634, 813.0852790610563, 835.6072645856449, 851.778537580229, 859.2095272349438, 16419.261133249, 16880.240389182487, 16913.83086169138, 18155.909220453912, 18857.15142818573, 17693.46919592411, 17885.82114178858, 17978.730319045226, 18078.5480362991, 18495.35266265681, 828.8715249136394, 992.8709267795176, 1004.5780772075709, 1010.6260683547098, 1011.145581983223, 1005.316384858296, 1030.4178139351243, 1031.2317323593895, 1032.5301987595626, 1036.3212096077082, 1056.7094049136472, 1057.5293994172596, 1066.4134725900763, 1087.2009073331096, 1087.9619213327496, 896.7085697148453, 1011.0698157694939, 1054.6994106679597, 1066.461436974323, 1078.795028944498, 743.7991742229568, 748.9850202995909, 760.4790718357942, 769.799852038474, 770.5184259837602, 16274.511764647079, 16349.509514714458, 16411.671766564723, 16433.178341082898, 16511.422100226555, 16856.072915989615, 16875.746863797052, 17041.977481351158, 17055.48833534996, 17299.74050389245, 13772.0, 13832.0, 14078.71842563143, 14093.506727264497, 14095.71808563823, 3343.1111422046465, 3389.1527118220447, 3393.253484233465, 3401.523786669868, 3403.710684591813, 107252.0, 122351.0, 123168.0, 124116.0, 124478.0, 13443.193408395528, 13542.796858047137, 13685.521006764715, 13815.378307976165, 13830.170189788645, 18879.62240755177, 21139.47151321229, 21318.0, 25822.354441139123, 25994.6100808488, 6771.93228067713, 7832.255935686101, 7864.567448790257, 7897.763067107996, 7923.286904178652, 3759.9060023499633, 3830.4062870255157, 3834.213986132836, 3846.826892789831, 3858.3247931611854, 4295.871123866289, 4365.781710914442, 4469.508354081048, 4484.730916145042, 4489.6408287336935, 925.995370023159, 955.2930831185012, 957.7988622389237, 958.5686441101532, 959.8992105828927, 542.7394850471717, 627.9058141278845, 629.3643420145686, 661.3518751623436, 684.3601232847303, 10834.945825270823, 10941.23411361213, 11205.775884482264, 11345.773084538263, 11388.715282118013, 602.4848754314997, 641.5316818722265, 646.8803271394808, 654.9672516374162, 679.8402375441767, 4337.392765012901, 5236.764345604457, 5294.682319060868, 5480.997180146249, 5544.695041772741, 93221.5338923301, 93857.53071234736, 96097.0, 96348.51825740826, 96942.0, 84611.5769421149, 84846.15153848506, 84861.21110311161, 85148.29703405897, 86668.13331866727, 76318.0, 76367.61816190995, 76523.23476765161, 77834.99999999886, 78630.06849657609, 10240.436775977392, 10463.372197667859, 10713.946430267799, 10890.237683362406, 10921.563137474412, 31219.687803121677, 34528.0, 39999.400008999306, 40214.0, 40756.0, 49824.50175498199, 68662.65668671625, 69652.95520567094, 69668.25829354307, 69740.30259697339, 16733.414330498374, 16975.0, 16984.915075424542, 16992.235349409555, 17119.14404279756, 17938.91030544839, 18487.352942646943, 18588.349407770664, 18741.34405295808, 18760.624787504446, 14518.346674399467, 16727.0, 16951.406700765416, 17168.484945451655, 17368.91315543414, 16557.42049028278, 16767.496975090766, 16985.320587176375, 17047.573810654834, 17101.401450949157, 16149.0, 16694.0, 16699.415520456725, 16703.081330526453, 16858.578535536708, 11871.821922670993, 11958.461869215733, 12271.447784849881, 12321.199122057038, 12408.255504669749, 12171.817422738843, 13079.149855259378, 13745.518906838213, 13757.0, 13766.31168441594], "value": 8293.989498728568, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 99.0, 161.0, 169.0, 115.0, 116.0, 115.0, 116.0, 116.0, 115.0], "value": 122.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 146.0, 147.0, 139.0, 144.0, 146.0, 113.0, 139.0, 111.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 196.0, 233.0, 230.0, 179.0, 166.0, 198.0, 267.0, 222.0, 229.0], "value": 211.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 48.0, 60.0, 97.0, 88.0, 72.0, 52.0, 52.0, 82.0, 52.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 86.0, 73.0, 94.0, 104.0, 111.0, 81.0, 71.0, 91.0], "value": 86.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 89.0, 88.0, 90.0, 89.0, 105.0, 100.0, 90.0, 91.0], "value": 92.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 97.0, 117.0, 154.0, 130.0, 97.0, 97.0, 97.0, 97.0], "value": 108.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 89.0, 93.0, 93.0, 90.0, 90.0, 93.0, 92.0, 93.0], "value": 91.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 51.0, 52.0, 51.0, 52.0, 53.0, 51.0, 53.0, 51.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 76.0, 86.0, 95.0, 89.0, 63.0, 59.0, 56.0, 56.0, 57.0], "value": 69.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 111.0, 107.0, 106.0, 84.0, 86.0, 87.0, 86.0, 83.0, 84.0], "value": 91.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 135.0, 136.0, 144.0, 139.0, 142.0, 147.0, 186.0, 139.0], "value": 144.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 185.0, 191.0, 227.0, 217.0, 178.0, 165.0, 216.0, 236.0, 188.0], "value": 199.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 69.0, 70.0, 68.0, 80.0, 70.0, 60.0, 76.0, 78.0], "value": 71.3, "unit": "score"}]}]} 05:47:41 INFO - Return code: 0 05:47:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:47:41 ERROR - # TBPL SUCCESS # 05:47:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:47:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:47:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:47:41 INFO - 2017-04-14 05:47:41.669 screenresolution[1660:10683] starting screenresolution argv=screenresolution get 05:47:41 INFO - 2017-04-14 05:47:41.672 screenresolution[1660:10683] Display 0: 1600x1200x32@60 05:47:41 INFO - 2017-04-14 05:47:41.677 screenresolution[1661:10686] starting screenresolution argv=screenresolution list 05:47:41 INFO - Available Modes on Display 0 05:47:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:47:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:47:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:47:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:47:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:47:41 INFO - Intel Iris: 05:47:41 INFO - Chipset Model: Intel Iris 05:47:41 INFO - Type: GPU 05:47:41 INFO - Bus: Built-In 05:47:41 INFO - VRAM (Dynamic, Max): 1536 MB 05:47:41 INFO - Vendor: Intel (0x8086) 05:47:41 INFO - Device ID: 0x0a2e 05:47:41 INFO - Revision ID: 0x0009 05:47:41 INFO - Displays: 05:47:41 INFO - Display: 05:47:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:47:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:47:41 INFO - Display Serial Number: 1600x1200 60 05:47:41 INFO - Main Display: Yes 05:47:41 INFO - Mirror: Off 05:47:41 INFO - Online: Yes 05:47:41 INFO - Rotation: Supported 05:47:41 INFO - Return code: 0 05:47:41 INFO - Running post-action listener: _resource_record_post_action 05:47:41 INFO - [mozharness: 2017-04-14 12:47:41.922027Z] Finished run-tests step (success) 05:47:41 INFO - Running post-run listener: _resource_record_post_run 05:47:41 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 40294912; Write bytes: 518954496; Read time: 261; Write time: 1666 05:47:41 INFO - TinderboxPrint: CPU usage
54.0% 05:47:41 INFO - TinderboxPrint: I/O read bytes / time
40,294,912 / 261 05:47:41 INFO - TinderboxPrint: I/O write bytes / time
518,954,496 / 1,666 05:47:41 INFO - TinderboxPrint: CPU idle
2,203.7 (46.0%) 05:47:41 INFO - TinderboxPrint: CPU system
959.7 (20.0%) 05:47:41 INFO - TinderboxPrint: CPU user
1,630.2 (34.0%) 05:47:41 INFO - TinderboxPrint: Swap in / out
248,061,952 / 0 05:47:41 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209205760; Write bytes: 210490880; Read time: 16149; Write time: 475 05:47:42 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 36243968; Write bytes: 306948096; Read time: 233; Write time: 1186 05:47:42 INFO - Running post-run listener: _upload_blobber_files 05:47:42 INFO - Blob upload gear active. 05:47:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:47:42 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:47:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:47:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:47:42 INFO - (blobuploader) - INFO - Open directory for files ... 05:47:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:47:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:47:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:43 INFO - (blobuploader) - INFO - Done attempting. 05:47:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:47:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:47:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:44 INFO - (blobuploader) - INFO - Done attempting. 05:47:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:47:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:47:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:45 INFO - (blobuploader) - INFO - Done attempting. 05:47:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:47:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:47:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:47 INFO - (blobuploader) - INFO - Done attempting. 05:47:47 INFO - (blobuploader) - INFO - Iteration through files over. 05:47:47 INFO - Return code: 0 05:47:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:47:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:47:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f606e615d071f4bb870145e607ea15a7350fc29309033ce9a7e569658256acf9026908adaff3e5dafe4bc0664396257bf42a4e233318e586fdeef6fb5308b8e4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04a9752eeca12b25091a0b44de50d41a58d312d27dc2341b505881771c79e9fb6c5d76772ea3a4b1c2b79465bb639840259ed881aeb5b8af78511a9249d1a104", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf0eecbe83ca9868e1e64e528b2fa288347d7fa14cf76fc6390002a1d91a77b156435e8c268615154a196f05cfda6887cda34e28c3311f28ddd84601df2015a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72c096dc292c299060eaedd4f00c015792397bffd2a4a5f8b1ba7b529ab8636f6c4abf60b51055a1d80cb7528c904bd3ed8016dfdbbdd7e288cdfa8a2ebe26ca"} 05:47:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:47:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:47:47 INFO - Contents: 05:47:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f606e615d071f4bb870145e607ea15a7350fc29309033ce9a7e569658256acf9026908adaff3e5dafe4bc0664396257bf42a4e233318e586fdeef6fb5308b8e4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04a9752eeca12b25091a0b44de50d41a58d312d27dc2341b505881771c79e9fb6c5d76772ea3a4b1c2b79465bb639840259ed881aeb5b8af78511a9249d1a104", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf0eecbe83ca9868e1e64e528b2fa288347d7fa14cf76fc6390002a1d91a77b156435e8c268615154a196f05cfda6887cda34e28c3311f28ddd84601df2015a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72c096dc292c299060eaedd4f00c015792397bffd2a4a5f8b1ba7b529ab8636f6c4abf60b51055a1d80cb7528c904bd3ed8016dfdbbdd7e288cdfa8a2ebe26ca"} 05:47:47 INFO - Running post-run listener: copy_logs_to_upload_dir 05:47:47 INFO - Copying logs to upload dir... 05:47:47 INFO - mkdir: /builds/slave/test/build/upload/logs 05:47:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.434043 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-14 05:47:47.759892) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-14 05:47:47.763388) ========= 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.ZHpKZtHyts/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.RlzeVJuAPF/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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/f606e615d071f4bb870145e607ea15a7350fc29309033ce9a7e569658256acf9026908adaff3e5dafe4bc0664396257bf42a4e233318e586fdeef6fb5308b8e4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04a9752eeca12b25091a0b44de50d41a58d312d27dc2341b505881771c79e9fb6c5d76772ea3a4b1c2b79465bb639840259ed881aeb5b8af78511a9249d1a104", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf0eecbe83ca9868e1e64e528b2fa288347d7fa14cf76fc6390002a1d91a77b156435e8c268615154a196f05cfda6887cda34e28c3311f28ddd84601df2015a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72c096dc292c299060eaedd4f00c015792397bffd2a4a5f8b1ba7b529ab8636f6c4abf60b51055a1d80cb7528c904bd3ed8016dfdbbdd7e288cdfa8a2ebe26ca"} build_url:https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/CkWl_q6NT5Gu598sl5g4gQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f606e615d071f4bb870145e607ea15a7350fc29309033ce9a7e569658256acf9026908adaff3e5dafe4bc0664396257bf42a4e233318e586fdeef6fb5308b8e4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04a9752eeca12b25091a0b44de50d41a58d312d27dc2341b505881771c79e9fb6c5d76772ea3a4b1c2b79465bb639840259ed881aeb5b8af78511a9249d1a104", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf0eecbe83ca9868e1e64e528b2fa288347d7fa14cf76fc6390002a1d91a77b156435e8c268615154a196f05cfda6887cda34e28c3311f28ddd84601df2015a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72c096dc292c299060eaedd4f00c015792397bffd2a4a5f8b1ba7b529ab8636f6c4abf60b51055a1d80cb7528c904bd3ed8016dfdbbdd7e288cdfa8a2ebe26ca"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-14 05:47:47.798601) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 05:47:47.798960) ========= 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.ZHpKZtHyts/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.RlzeVJuAPF/Listeners TMPDIR=/var/folders/k4/xd58rgkx0dnbrdjb1pv1qrj800000w/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.005020 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 05:47:47.850391) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-14 05:47:47.851074) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-14 05:47:47.851725) ========= ========= Total master_lag: 0.20 =========