builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0078 starttime: 1481041946.22 results: success (0) buildid: 20161206064938 builduid: 40557a0b34664e168ac91695244d19e6 revision: 3ec83fde43f2e1ba1dc583df0c722033c63ab7b7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-06 08:32:26.220816) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-06 08:32:26.221268) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-06 08:32:26.221554) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-06 08:32:26.248637) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 08:32:26.249071) ========= 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.rrg30T7AGk/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.bcOclImMO5/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-06 08:32:26-- 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% 204M=0s 2016-12-06 08:32:26 (204 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114244 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 08:32:26.387519) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 08:32:26.387861) ========= 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.rrg30T7AGk/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.bcOclImMO5/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.028032 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 08:32:26.470300) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-06 08:32:26.470753) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3ec83fde43f2e1ba1dc583df0c722033c63ab7b7 --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 3ec83fde43f2e1ba1dc583df0c722033c63ab7b7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rrg30T7AGk/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.bcOclImMO5/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-06 08:32:26,561 truncating revision to first 12 chars 2016-12-06 08:32:26,561 Setting DEBUG logging. 2016-12-06 08:32:26,561 attempt 1/10 2016-12-06 08:32:26,562 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3ec83fde43f2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-06 08:32:27,730 unpacking tar archive at: mozilla-central-3ec83fde43f2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.442539 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-06 08:32:27.938306) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-06 08:32:27.938628) ========= script_repo_revision: 3ec83fde43f2e1ba1dc583df0c722033c63ab7b7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-06 08:32:27.939063) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-06 08:32:27.939333) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-06 08:32:27.959640) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-12-06 08:32:27.960091) ========= /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.rrg30T7AGk/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.bcOclImMO5/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 08:32:28 INFO - MultiFileLogger online at 20161206 08:32:28 in /builds/slave/test 08:32:28 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 08:32:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:32:28 INFO - {'append_to_log': False, 08:32:28 INFO - 'base_work_dir': '/builds/slave/test', 08:32:28 INFO - 'blob_upload_branch': 'Firefox', 08:32:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:32:28 INFO - 'branch': 'Firefox', 08:32:28 INFO - 'buildbot_json_path': 'buildprops.json', 08:32:28 INFO - 'config_files': ('talos/mac_config.py',), 08:32:28 INFO - 'default_actions': ('clobber', 08:32:28 INFO - 'read-buildbot-config', 08:32:28 INFO - 'download-and-extract', 08:32:28 INFO - 'populate-webroot', 08:32:28 INFO - 'create-virtualenv', 08:32:28 INFO - 'install', 08:32:28 INFO - 'run-tests'), 08:32:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:32:28 INFO - 'download_minidump_stackwalk': True, 08:32:28 INFO - 'download_symbols': 'ondemand', 08:32:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:32:28 INFO - 'tooltool.py': '/tools/tooltool.py', 08:32:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:32:28 INFO - '/tools/misc-python/virtualenv.py')}, 08:32:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:32:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:32:28 INFO - 'installer_path': 'installer.exe', 08:32:28 INFO - 'log_level': 'info', 08:32:28 INFO - 'log_name': 'talos', 08:32:28 INFO - 'log_to_console': True, 08:32:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:32:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:32:28 INFO - 'opt_config_files': (), 08:32:28 INFO - 'pip_index': False, 08:32:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:32:28 INFO - 'cmd': ('bash', 08:32:28 INFO - '-c', 08:32:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:32:28 INFO - 'enabled': True, 08:32:28 INFO - 'halt_on_failure': False, 08:32:28 INFO - 'name': 'check_screen_resolution'},), 08:32:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:32:28 INFO - 'cmd': ('bash', 08:32:28 INFO - '-c', 08:32:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:32:28 INFO - 'enabled': True, 08:32:28 INFO - 'halt_on_failure': False, 08:32:28 INFO - 'name': 'check_screen_resolution'},), 08:32:28 INFO - 'run_cmd_checks_enabled': True, 08:32:28 INFO - 'sps_profile': False, 08:32:28 INFO - 'sps_profile_interval': 0, 08:32:28 INFO - 'suite': 'dromaeojs-e10s', 08:32:28 INFO - 'system_bits': '32', 08:32:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:32:28 INFO - 'title': 't-yosemite-r7-0078', 08:32:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:32:28 INFO - 'use_talos_json': True, 08:32:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:32:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:32:28 INFO - 'work_dir': 'build'} 08:32:28 INFO - [mozharness: 2016-12-06 16:32:28.166590Z] Running clobber step. 08:32:28 INFO - Running pre-action listener: _resource_record_pre_action 08:32:28 INFO - Running main action method: clobber 08:32:28 INFO - rmtree: /builds/slave/test/build 08:32:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:32:30 INFO - Running post-action listener: _resource_record_post_action 08:32:30 INFO - [mozharness: 2016-12-06 16:32:30.681684Z] Finished clobber step (success) 08:32:30 INFO - [mozharness: 2016-12-06 16:32:30.681810Z] Running read-buildbot-config step. 08:32:30 INFO - Running pre-action listener: _resource_record_pre_action 08:32:30 INFO - Running main action method: read_buildbot_config 08:32:30 INFO - Using buildbot properties: 08:32:30 INFO - { 08:32:30 INFO - "project": "", 08:32:30 INFO - "product": "firefox", 08:32:30 INFO - "script_repo_revision": "production", 08:32:30 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 08:32:30 INFO - "repository": "", 08:32:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 08:32:30 INFO - "buildid": "20161206064938", 08:32:30 INFO - "pgo_build": "False", 08:32:30 INFO - "basedir": "/builds/slave/test", 08:32:30 INFO - "buildnumber": 4, 08:32:30 INFO - "slavename": "t-yosemite-r7-0078", 08:32:30 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:32:30 INFO - "platform": "yosemite_r7", 08:32:30 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:32:30 INFO - "branch": "mozilla-central", 08:32:30 INFO - "repo_path": "mozilla-central", 08:32:30 INFO - "revision": "3ec83fde43f2e1ba1dc583df0c722033c63ab7b7", 08:32:30 INFO - "stage_platform": "macosx64", 08:32:30 INFO - "builduid": "40557a0b34664e168ac91695244d19e6", 08:32:30 INFO - "slavebuilddir": "test" 08:32:30 INFO - } 08:32:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 08:32:30 INFO - Running post-action listener: _resource_record_post_action 08:32:30 INFO - [mozharness: 2016-12-06 16:32:30.685241Z] Finished read-buildbot-config step (success) 08:32:30 INFO - [mozharness: 2016-12-06 16:32:30.685345Z] Running download-and-extract step. 08:32:30 INFO - Running pre-action listener: _resource_record_pre_action 08:32:30 INFO - Running main action method: download_and_extract 08:32:30 INFO - mkdir: /builds/slave/test/build/tests 08:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:30 INFO - trying https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 08:32:30 INFO - Downloading https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:32:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 08:32:32 INFO - Downloaded 1199 bytes. 08:32:32 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:32:32 INFO - Using the following test package requirements: 08:32:32 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:32:32 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:32:32 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 08:32:32 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:32:32 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 08:32:32 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:32:32 INFO - u'jsshell-mac.zip'], 08:32:32 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:32:32 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 08:32:32 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:32:32 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:32:32 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 08:32:32 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:32:32 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 08:32:32 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:32:32 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 08:32:32 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:32:32 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 08:32:32 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:32:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:32:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:32:32 INFO - Fetch https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:32:32 INFO - Expected file size: 16283756 08:32:32 INFO - Obtained file size: 16283756 08:32:39 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:32:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:32:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:32:39 INFO - Fetch https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:32:40 INFO - Expected file size: 16283756 08:32:40 INFO - Obtained file size: 16283756 08:32:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 08:32:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:32:47 INFO - Fetch https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 08:32:48 INFO - Expected file size: 14409734 08:32:48 INFO - Obtained file size: 14409734 08:32:48 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')]} 08:32:48 INFO - trying https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:32:48 INFO - Downloading https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 08:32:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 08:32:51 INFO - Downloaded 107574645 bytes. 08:32:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:32:51 INFO - mkdir: /builds/slave/test/properties 08:32:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:32:51 INFO - Writing to file /builds/slave/test/properties/build_url 08:32:51 INFO - Contents: 08:32:51 INFO - build_url:https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:32:52 INFO - Running post-action listener: _resource_record_post_action 08:32:52 INFO - Running post-action listener: set_extra_try_arguments 08:32:52 INFO - [mozharness: 2016-12-06 16:32:52.357420Z] Finished download-and-extract step (success) 08:32:52 INFO - [mozharness: 2016-12-06 16:32:52.357537Z] Running populate-webroot step. 08:32:52 INFO - Running pre-action listener: _resource_record_pre_action 08:32:52 INFO - Running main action method: populate_webroot 08:32:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:32:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:32:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:32:52 INFO - '--tppagecycles', 08:32:52 INFO - '7'], 08:32:52 INFO - 'tests': ['tsvgm']}}, 08:32:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:32:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:32:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:32:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:32:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:32:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:32:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:32:52 INFO - 'talos_options': ['--disable-e10s'], 08:32:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:32:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:32:52 INFO - 'talos_options': ['--disable-e10s'], 08:32:52 INFO - 'tests': ['damp', 'tps']}, 08:32:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:32:52 INFO - 'tests': ['damp', 'tps']}, 08:32:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:32:52 INFO - 'tests': ['dromaeo_dom']}, 08:32:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:32:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:32:52 INFO - 'tests': ['basic_compositor_video']}, 08:32:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:32:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:32:52 INFO - 'tests': ['a11yr', 08:32:52 INFO - 'ts_paint', 08:32:52 INFO - 'tpaint', 08:32:52 INFO - 'sessionrestore', 08:32:52 INFO - 'sessionrestore_no_auto_restore', 08:32:52 INFO - 'tabpaint']}, 08:32:52 INFO - 'other-e10s': {'tests': ['a11yr', 08:32:52 INFO - 'ts_paint', 08:32:52 INFO - 'tpaint', 08:32:52 INFO - 'sessionrestore', 08:32:52 INFO - 'sessionrestore_no_auto_restore', 08:32:52 INFO - 'tabpaint']}, 08:32:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:32:52 INFO - 'ts_paint', 08:32:52 INFO - 'tpaint', 08:32:52 INFO - 'sessionrestore', 08:32:52 INFO - 'sessionrestore_no_auto_restore', 08:32:52 INFO - 'tabpaint']}, 08:32:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:32:52 INFO - 'ts_paint', 08:32:52 INFO - 'tpaint', 08:32:52 INFO - 'sessionrestore', 08:32:52 INFO - 'sessionrestore_no_auto_restore', 08:32:52 INFO - 'tabpaint']}, 08:32:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:32:52 INFO - 'tests': ['a11yr', 08:32:52 INFO - 'ts_paint', 08:32:52 INFO - 'tpaint', 08:32:52 INFO - 'sessionrestore', 08:32:52 INFO - 'sessionrestore_no_auto_restore', 08:32:52 INFO - 'tabpaint']}, 08:32:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:32:52 INFO - 'tests': ['a11yr', 08:32:52 INFO - 'ts_paint', 08:32:52 INFO - 'tpaint', 08:32:52 INFO - 'sessionrestore', 08:32:52 INFO - 'sessionrestore_no_auto_restore', 08:32:52 INFO - 'tabpaint']}, 08:32:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:32:52 INFO - 'tests': ['tsvgx', 08:32:52 INFO - 'tsvgr_opacity', 08:32:52 INFO - 'tart', 08:32:52 INFO - 'tscrollx', 08:32:52 INFO - 'cart', 08:32:52 INFO - 'tsvg_static']}, 08:32:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:32:52 INFO - 'tsvgr_opacity', 08:32:52 INFO - 'tart', 08:32:52 INFO - 'tscrollx', 08:32:52 INFO - 'cart', 08:32:52 INFO - 'tsvg_static']}, 08:32:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:32:52 INFO - 'talos_options': ['--disable-e10s'], 08:32:52 INFO - 'tests': ['tp5o']}, 08:32:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:32:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:32:52 INFO - 'talos_options': ['--disable-e10s', 08:32:52 INFO - '--xperf_path', 08:32:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:52 INFO - 'tests': ['tp5n']}, 08:32:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:32:52 INFO - 'talos_options': ['--xperf_path', 08:32:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:52 INFO - 'tests': ['tp5n']}}, 08:32:52 INFO - 'talos.zip': {'path': '', 08:32:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:32:52 INFO - Running post-action listener: _resource_record_post_action 08:32:52 INFO - [mozharness: 2016-12-06 16:32:52.376398Z] Finished populate-webroot step (success) 08:32:52 INFO - [mozharness: 2016-12-06 16:32:52.376527Z] Running create-virtualenv step. 08:32:52 INFO - Running pre-action listener: _resource_record_pre_action 08:32:52 INFO - Running main action method: create_virtualenv 08:32:52 INFO - Creating virtualenv /builds/slave/test/build/venv 08:32:52 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 08:32:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:32:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:32:52 INFO - Using real prefix '/tools/python27' 08:32:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:32:53 INFO - Installing distribute.............................................................................................................................................................................................done. 08:32:56 INFO - Installing pip.................done. 08:32:56 INFO - Return code: 0 08:32:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:32:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:32:56 INFO - Reading from file tmpfile_stdout 08:32:56 INFO - Output received: 08:32:56 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) 08:32:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:32:56 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')]} 08:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:56 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')]} 08:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:56 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 0x10245d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe84be680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102272d30>, '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 0x1020d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10226ab20>, '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.rrg30T7AGk/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.bcOclImMO5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 08:32:56 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 08:32:56 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 08:32:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rrg30T7AGk/Render', 08:32:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:56 INFO - 'HOME': '/Users/cltbld', 08:32:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:56 INFO - 'LOGNAME': 'cltbld', 08:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:56 INFO - 'MOZ_NO_REMOTE': '1', 08:32:56 INFO - 'NO_EM_RESTART': '1', 08:32:56 INFO - 'PAGER': '/bin/cat', 08:32:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:56 INFO - 'PWD': '/builds/slave/test', 08:32:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:56 INFO - 'SHELL': '/bin/bash', 08:32:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcOclImMO5/Listeners', 08:32:56 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 08:32:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:56 INFO - 'USER': 'cltbld', 08:32:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:56 INFO - 'XPC_FLAGS': '0x0', 08:32:56 INFO - 'XPC_SERVICE_NAME': '0', 08:32:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:56 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 08:32:56 INFO - Cleaning up... 08:32:56 INFO - Return code: 0 08:32:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:32:56 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')]} 08:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:56 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')]} 08:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:56 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 0x10245d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe84be680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102272d30>, '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 0x1020d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10226ab20>, '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.rrg30T7AGk/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.bcOclImMO5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 08:32:56 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 08:32:56 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 08:32:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rrg30T7AGk/Render', 08:32:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:32:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:32:56 INFO - 'HOME': '/Users/cltbld', 08:32:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:32:56 INFO - 'LOGNAME': 'cltbld', 08:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:56 INFO - 'MOZ_NO_REMOTE': '1', 08:32:56 INFO - 'NO_EM_RESTART': '1', 08:32:56 INFO - 'PAGER': '/bin/cat', 08:32:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:56 INFO - 'PWD': '/builds/slave/test', 08:32:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:32:56 INFO - 'SHELL': '/bin/bash', 08:32:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcOclImMO5/Listeners', 08:32:56 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 08:32:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:32:56 INFO - 'USER': 'cltbld', 08:32:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:32:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:56 INFO - 'XPC_FLAGS': '0x0', 08:32:56 INFO - 'XPC_SERVICE_NAME': '0', 08:32:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:56 INFO - Downloading/unpacking psutil>=3.1.1 08:32:56 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 08:32:56 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 08:32:56 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 08:32:56 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 08:32:56 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 08:32:56 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 08:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:33:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:33:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:33:01 INFO - Installing collected packages: psutil 08:33:01 INFO - Running setup.py install for psutil 08:33:01 INFO - building 'psutil._psutil_osx' extension 08:33:01 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 08:33:01 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 08:33:01 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 08:33:01 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 08:33:01 INFO - building 'psutil._psutil_posix' extension 08:33:01 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 08:33:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:33:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:33:02 INFO - ^ 08:33:02 INFO - 1 warning generated. 08:33:02 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 08:33:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:33:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:33:02 INFO - Successfully installed psutil 08:33:02 INFO - Cleaning up... 08:33:02 INFO - Return code: 0 08:33:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10245d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe84be680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102272d30>, '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 0x1020d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10226ab20>, '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.rrg30T7AGk/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.bcOclImMO5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 08:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:33:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rrg30T7AGk/Render', 08:33:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:02 INFO - 'HOME': '/Users/cltbld', 08:33:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:02 INFO - 'LOGNAME': 'cltbld', 08:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:02 INFO - 'MOZ_NO_REMOTE': '1', 08:33:02 INFO - 'NO_EM_RESTART': '1', 08:33:02 INFO - 'PAGER': '/bin/cat', 08:33:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:02 INFO - 'PWD': '/builds/slave/test', 08:33:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:02 INFO - 'SHELL': '/bin/bash', 08:33:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcOclImMO5/Listeners', 08:33:02 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 08:33:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:02 INFO - 'USER': 'cltbld', 08:33:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:02 INFO - 'XPC_FLAGS': '0x0', 08:33:02 INFO - 'XPC_SERVICE_NAME': '0', 08:33:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:33:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:33:05 INFO - Installing collected packages: mozsystemmonitor 08:33:05 INFO - Running setup.py install for mozsystemmonitor 08:33:05 INFO - Successfully installed mozsystemmonitor 08:33:05 INFO - Cleaning up... 08:33:05 INFO - Return code: 0 08:33:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:33:05 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')]} 08:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:05 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')]} 08:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:05 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 0x10245d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe84be680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102272d30>, '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 0x1020d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10226ab20>, '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.rrg30T7AGk/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.bcOclImMO5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 08:33:05 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 08:33:05 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 08:33:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rrg30T7AGk/Render', 08:33:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:05 INFO - 'HOME': '/Users/cltbld', 08:33:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:05 INFO - 'LOGNAME': 'cltbld', 08:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:05 INFO - 'MOZ_NO_REMOTE': '1', 08:33:05 INFO - 'NO_EM_RESTART': '1', 08:33:05 INFO - 'PAGER': '/bin/cat', 08:33:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:05 INFO - 'PWD': '/builds/slave/test', 08:33:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:05 INFO - 'SHELL': '/bin/bash', 08:33:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcOclImMO5/Listeners', 08:33:05 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 08:33:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:05 INFO - 'USER': 'cltbld', 08:33:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:05 INFO - 'XPC_FLAGS': '0x0', 08:33:05 INFO - 'XPC_SERVICE_NAME': '0', 08:33:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:05 INFO - Downloading/unpacking jsonschema==2.5.1 08:33:05 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 08:33:05 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 08:33:05 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 08:33:05 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 08:33:05 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 08:33:05 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 08:33:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:33:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:08 INFO - Downloading functools32-3.2.3-2.tar.gz 08:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:33:08 INFO - warning: no files found matching '*.txt' 08:33:08 INFO - no previously-included directories found matching 'build' 08:33:08 INFO - no previously-included directories found matching 'dist' 08:33:08 INFO - no previously-included directories found matching '.git*' 08:33:08 INFO - Installing collected packages: jsonschema, functools32 08:33:08 INFO - Running setup.py install for functools32 08:33:09 INFO - warning: no files found matching '*.txt' 08:33:09 INFO - no previously-included directories found matching 'build' 08:33:09 INFO - no previously-included directories found matching 'dist' 08:33:09 INFO - no previously-included directories found matching '.git*' 08:33:09 INFO - Successfully installed jsonschema functools32 08:33:09 INFO - Cleaning up... 08:33:09 INFO - Return code: 0 08:33:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10245d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe84be680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102272d30>, '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 0x1020d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10226ab20>, '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.rrg30T7AGk/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.bcOclImMO5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 08:33:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:33:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rrg30T7AGk/Render', 08:33:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:09 INFO - 'HOME': '/Users/cltbld', 08:33:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:09 INFO - 'LOGNAME': 'cltbld', 08:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:09 INFO - 'MOZ_NO_REMOTE': '1', 08:33:09 INFO - 'NO_EM_RESTART': '1', 08:33:09 INFO - 'PAGER': '/bin/cat', 08:33:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:09 INFO - 'PWD': '/builds/slave/test', 08:33:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:09 INFO - 'SHELL': '/bin/bash', 08:33:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcOclImMO5/Listeners', 08:33:09 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 08:33:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:09 INFO - 'USER': 'cltbld', 08:33:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:09 INFO - 'XPC_FLAGS': '0x0', 08:33:09 INFO - 'XPC_SERVICE_NAME': '0', 08:33:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:33:09 INFO - Cleaning up... 08:33:09 INFO - Return code: 0 08:33:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10245d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe84be680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102272d30>, '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 0x1020d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10226ab20>, '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.rrg30T7AGk/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.bcOclImMO5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 08:33:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:33:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rrg30T7AGk/Render', 08:33:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:09 INFO - 'HOME': '/Users/cltbld', 08:33:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:09 INFO - 'LOGNAME': 'cltbld', 08:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:09 INFO - 'MOZ_NO_REMOTE': '1', 08:33:09 INFO - 'NO_EM_RESTART': '1', 08:33:09 INFO - 'PAGER': '/bin/cat', 08:33:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:09 INFO - 'PWD': '/builds/slave/test', 08:33:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:09 INFO - 'SHELL': '/bin/bash', 08:33:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcOclImMO5/Listeners', 08:33:09 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 08:33:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:09 INFO - 'USER': 'cltbld', 08:33:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:09 INFO - 'XPC_FLAGS': '0x0', 08:33:09 INFO - 'XPC_SERVICE_NAME': '0', 08:33:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:09 INFO - Downloading/unpacking blobuploader==1.2.4 08:33:09 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 08:33:09 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 08:33:09 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 08:33:09 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 08:33:09 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 08:33:09 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 08:33:12 INFO - Downloading blobuploader-1.2.4.tar.gz 08:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:33:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:33:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:13 INFO - Downloading docopt-0.6.1.tar.gz 08:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:33:13 INFO - Installing collected packages: blobuploader, requests, docopt 08:33:13 INFO - Running setup.py install for blobuploader 08:33:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:33:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:33:13 INFO - Running setup.py install for requests 08:33:14 INFO - Running setup.py install for docopt 08:33:14 INFO - Successfully installed blobuploader requests docopt 08:33:14 INFO - Cleaning up... 08:33:14 INFO - Return code: 0 08:33:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:14 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')]} 08:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:14 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')]} 08:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:14 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 0x10245d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe84be680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102272d30>, '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 0x1020d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10226ab20>, '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.rrg30T7AGk/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.bcOclImMO5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 08:33:14 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 08:33:14 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 08:33:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rrg30T7AGk/Render', 08:33:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:14 INFO - 'HOME': '/Users/cltbld', 08:33:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:14 INFO - 'LOGNAME': 'cltbld', 08:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:14 INFO - 'MOZ_NO_REMOTE': '1', 08:33:14 INFO - 'NO_EM_RESTART': '1', 08:33:14 INFO - 'PAGER': '/bin/cat', 08:33:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:14 INFO - 'PWD': '/builds/slave/test', 08:33:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:14 INFO - 'SHELL': '/bin/bash', 08:33:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcOclImMO5/Listeners', 08:33:14 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 08:33:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:14 INFO - 'USER': 'cltbld', 08:33:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:14 INFO - 'XPC_FLAGS': '0x0', 08:33:14 INFO - 'XPC_SERVICE_NAME': '0', 08:33:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:33:14 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-gjOraK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:33:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:33:14 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-yTdunz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:33:15 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-15NiKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:33:15 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-M7qwg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:33:15 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-bb80wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:33:15 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-I1l6AS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:33:15 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-PC86Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:33:15 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-2ogMBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:33:15 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-GB6qb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:33:15 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-mFurRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:33:15 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-naW6xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:33:15 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-FNAcHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:33:16 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-A_SGOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:33:16 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-n0kmps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:16 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-TTkIDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:33:16 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-A91N0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:33:16 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-p6CjUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:33:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:33:16 INFO - Running setup.py install for manifestparser 08:33:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:33:16 INFO - Running setup.py install for mozcrash 08:33:16 INFO - Running setup.py install for mozdebug 08:33:17 INFO - Running setup.py install for mozdevice 08:33:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:33:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:33:17 INFO - Running setup.py install for mozfile 08:33:17 INFO - Running setup.py install for mozhttpd 08:33:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:33:17 INFO - Running setup.py install for mozinfo 08:33:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:33:17 INFO - Running setup.py install for mozInstall 08:33:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:33:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:33:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:33:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:33:17 INFO - Running setup.py install for mozleak 08:33:17 INFO - Running setup.py install for mozlog 08:33:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:33:18 INFO - Running setup.py install for moznetwork 08:33:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:33:18 INFO - Running setup.py install for mozprocess 08:33:18 INFO - Running setup.py install for mozprofile 08:33:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:33:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:33:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:33:18 INFO - Running setup.py install for mozrunner 08:33:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:33:18 INFO - Running setup.py install for mozscreenshot 08:33:18 INFO - Running setup.py install for moztest 08:33:19 INFO - Running setup.py install for mozversion 08:33:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:33:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:33:19 INFO - Cleaning up... 08:33:19 INFO - Return code: 0 08:33:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:19 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')]} 08:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:19 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')]} 08:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:19 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 0x10245d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe84be680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102272d30>, '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 0x1020d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10226ab20>, '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.rrg30T7AGk/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.bcOclImMO5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 08:33:19 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 08:33:19 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 08:33:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rrg30T7AGk/Render', 08:33:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:19 INFO - 'HOME': '/Users/cltbld', 08:33:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:19 INFO - 'LOGNAME': 'cltbld', 08:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:19 INFO - 'MOZ_NO_REMOTE': '1', 08:33:19 INFO - 'NO_EM_RESTART': '1', 08:33:19 INFO - 'PAGER': '/bin/cat', 08:33:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:19 INFO - 'PWD': '/builds/slave/test', 08:33:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:19 INFO - 'SHELL': '/bin/bash', 08:33:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcOclImMO5/Listeners', 08:33:19 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 08:33:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:19 INFO - 'USER': 'cltbld', 08:33:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:19 INFO - 'XPC_FLAGS': '0x0', 08:33:19 INFO - 'XPC_SERVICE_NAME': '0', 08:33:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:33:19 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-Ufw4jL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:33:19 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)) 08:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:33:19 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-lb1q2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:33:19 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)) 08:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:33:19 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-WmeAcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:33:19 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)) 08:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:33:19 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-bxNGnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:33:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:33:19 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-fcekLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:33:20 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)) 08:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:33:20 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-qoGFjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:33:20 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)) 08:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:33:20 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-XhbT5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:33:20 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)) 08:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:33:20 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-qxfKeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:33:20 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)) 08:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:33:20 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-sBObsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:33:20 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)) 08:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:33:20 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-ZBSaIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:33:20 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)) 08:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:33:20 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-lhuy3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:33:20 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)) 08:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:33:20 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-yYhBBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:33:20 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-r56GTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:33:20 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)) 08:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:33:20 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-7OyMyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:33:20 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)) 08:33:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:20 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-zWMRPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:21 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)) 08:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:33:21 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-RjCrW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:33:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:33:21 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-TPEwuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:33:21 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)) 08:33:21 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)) 08:33:21 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)) 08:33:21 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)) 08:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:33:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:23 INFO - Downloading blessings-1.6.tar.gz 08:33:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:33:24 INFO - Installing collected packages: blessings 08:33:24 INFO - Running setup.py install for blessings 08:33:24 INFO - Successfully installed blessings 08:33:24 INFO - Cleaning up... 08:33:24 INFO - Return code: 0 08:33:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:33:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:33:24 INFO - Reading from file tmpfile_stdout 08:33:24 INFO - Current package versions: 08:33:24 INFO - blessings == 1.6 08:33:24 INFO - blobuploader == 1.2.4 08:33:24 INFO - docopt == 0.6.1 08:33:24 INFO - functools32 == 3.2.3-2 08:33:24 INFO - jsonschema == 2.5.1 08:33:24 INFO - manifestparser == 1.1 08:33:24 INFO - mozInstall == 1.12 08:33:24 INFO - mozcrash == 1.0 08:33:24 INFO - mozdebug == 0.1 08:33:24 INFO - mozdevice == 0.49 08:33:24 INFO - mozfile == 1.2 08:33:24 INFO - mozhttpd == 0.7 08:33:24 INFO - mozinfo == 0.9 08:33:24 INFO - mozleak == 0.1 08:33:24 INFO - mozlog == 3.4 08:33:24 INFO - moznetwork == 0.27 08:33:24 INFO - mozprocess == 0.23 08:33:24 INFO - mozprofile == 0.28 08:33:24 INFO - mozrunner == 6.13 08:33:24 INFO - mozscreenshot == 0.1 08:33:24 INFO - mozsystemmonitor == 0.3 08:33:24 INFO - moztest == 0.7 08:33:24 INFO - mozversion == 1.4 08:33:24 INFO - psutil == 3.1.1 08:33:24 INFO - requests == 1.2.3 08:33:24 INFO - wsgiref == 0.1.2 08:33:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:24 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')]} 08:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:24 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')]} 08:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:24 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 0x10245d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe84be680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102272d30>, '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 0x1020d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10226ab20>, '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.rrg30T7AGk/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.bcOclImMO5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 08:33:24 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 08:33:24 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 08:33:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rrg30T7AGk/Render', 08:33:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:24 INFO - 'HOME': '/Users/cltbld', 08:33:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:24 INFO - 'LOGNAME': 'cltbld', 08:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:24 INFO - 'MOZ_NO_REMOTE': '1', 08:33:24 INFO - 'NO_EM_RESTART': '1', 08:33:24 INFO - 'PAGER': '/bin/cat', 08:33:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:24 INFO - 'PWD': '/builds/slave/test', 08:33:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:24 INFO - 'SHELL': '/bin/bash', 08:33:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcOclImMO5/Listeners', 08:33:24 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 08:33:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:24 INFO - 'USER': 'cltbld', 08:33:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:24 INFO - 'XPC_FLAGS': '0x0', 08:33:24 INFO - 'XPC_SERVICE_NAME': '0', 08:33:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:24 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)) 08:33:24 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)) 08:33:24 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)) 08:33:24 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)) 08:33:24 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)) 08:33:24 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)) 08:33:24 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)) 08:33:24 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)) 08:33:24 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)) 08:33:24 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)) 08:33:24 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)) 08:33:24 INFO - Cleaning up... 08:33:24 INFO - Return code: 0 08:33:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:33:24 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')]} 08:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:24 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')]} 08:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:24 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 0x10245d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1023d3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe84be680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102272d30>, '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 0x1020d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10226ab20>, '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.rrg30T7AGk/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.bcOclImMO5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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 08:33:24 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 08:33:24 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 08:33:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rrg30T7AGk/Render', 08:33:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:24 INFO - 'HOME': '/Users/cltbld', 08:33:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:24 INFO - 'LOGNAME': 'cltbld', 08:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:24 INFO - 'MOZ_NO_REMOTE': '1', 08:33:24 INFO - 'NO_EM_RESTART': '1', 08:33:24 INFO - 'PAGER': '/bin/cat', 08:33:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:24 INFO - 'PWD': '/builds/slave/test', 08:33:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:24 INFO - 'SHELL': '/bin/bash', 08:33:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcOclImMO5/Listeners', 08:33:24 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 08:33:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:24 INFO - 'USER': 'cltbld', 08:33:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:24 INFO - 'XPC_FLAGS': '0x0', 08:33:24 INFO - 'XPC_SERVICE_NAME': '0', 08:33:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:33:25 INFO - Cleaning up... 08:33:25 INFO - Return code: 0 08:33:25 INFO - Running post-action listener: _resource_record_post_action 08:33:25 INFO - Running post-action listener: _start_resource_monitoring 08:33:25 INFO - Starting resource monitoring. 08:33:25 INFO - [mozharness: 2016-12-06 16:33:25.124590Z] Finished create-virtualenv step (success) 08:33:25 INFO - [mozharness: 2016-12-06 16:33:25.125543Z] Running install step. 08:33:25 INFO - Running pre-action listener: _resource_record_pre_action 08:33:25 INFO - Running main action method: install 08:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:33:25 INFO - Reading from file tmpfile_stdout 08:33:25 INFO - Detecting whether we're running mozinstall >=1.0... 08:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:33:25 INFO - Reading from file tmpfile_stdout 08:33:25 INFO - Output received: 08:33:25 INFO - Usage: mozinstall [options] installer 08:33:25 INFO - Options: 08:33:25 INFO - -h, --help show this help message and exit 08:33:25 INFO - -d DEST, --destination=DEST 08:33:25 INFO - Directory to install application into. [default: 08:33:25 INFO - "/builds/slave/test"] 08:33:25 INFO - --app=APP Application being installed. [default: firefox] 08:33:25 INFO - mkdir: /builds/slave/test/build/application 08:33:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:33:57 INFO - Reading from file tmpfile_stdout 08:33:57 INFO - Output received: 08:33:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:33:57 INFO - Running post-action listener: _resource_record_post_action 08:33:57 INFO - [mozharness: 2016-12-06 16:33:57.948276Z] Finished install step (success) 08:33:57 INFO - [mozharness: 2016-12-06 16:33:57.948438Z] Running run-tests step. 08:33:57 INFO - Running pre-action listener: _resource_record_pre_action 08:33:57 INFO - Running main action method: run_tests 08:33:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:33:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:33:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:33:57 INFO - 2016-12-06 08:33:57.962 screenresolution[1676:18933] starting screenresolution argv=screenresolution get 08:33:57 INFO - 2016-12-06 08:33:57.965 screenresolution[1676:18933] Display 0: 1600x1200x32@60 08:33:57 INFO - 2016-12-06 08:33:57.971 screenresolution[1677:18935] starting screenresolution argv=screenresolution list 08:33:57 INFO - Available Modes on Display 0 08:33:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:33:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:33:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:33:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:33:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:33:58 INFO - Intel Iris: 08:33:58 INFO - Chipset Model: Intel Iris 08:33:58 INFO - Type: GPU 08:33:58 INFO - Bus: Built-In 08:33:58 INFO - VRAM (Dynamic, Max): 1536 MB 08:33:58 INFO - Vendor: Intel (0x8086) 08:33:58 INFO - Device ID: 0x0a2e 08:33:58 INFO - Revision ID: 0x0009 08:33:58 INFO - Displays: 08:33:58 INFO - Display: 08:33:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:33:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:33:58 INFO - Display Serial Number: 1600x1200 60 08:33:58 INFO - Main Display: Yes 08:33:58 INFO - Mirror: Off 08:33:58 INFO - Online: Yes 08:33:58 INFO - Rotation: Supported 08:33:58 INFO - Return code: 0 08:33:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:33:58 INFO - Python 2.7.3 08:33:58 INFO - Return code: 0 08:33:58 INFO - grabbing minidump binary from tooltool 08:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:33:58 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 0x102272d30>, '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 0x1020d9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10226ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:33:58 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 08:33:58 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 08:33:58 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 08:33:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:33:58 INFO - Return code: 0 08:33:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:33:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:33:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:33:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:33:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:33:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--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 08:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0078 --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 08:33:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rrg30T7AGk/Render', 08:33:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:58 INFO - 'HOME': '/Users/cltbld', 08:33:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:58 INFO - 'LOGNAME': 'cltbld', 08:33:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:33:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:58 INFO - 'MOZ_NO_REMOTE': '1', 08:33:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:33:58 INFO - 'NO_EM_RESTART': '1', 08:33:58 INFO - 'PAGER': '/bin/cat', 08:33:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:58 INFO - 'PWD': '/builds/slave/test', 08:33:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:33:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:58 INFO - 'SHELL': '/bin/bash', 08:33:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.bcOclImMO5/Listeners', 08:33:58 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 08:33:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:58 INFO - 'USER': 'cltbld', 08:33:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:58 INFO - 'XPC_FLAGS': '0x0', 08:33:58 INFO - 'XPC_SERVICE_NAME': '0', 08:33:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--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 08:33:58 INFO - mozversion application_buildid: 20161206064938 08:33:58 INFO - mozversion application_changeset: 3ec83fde43f2e1ba1dc583df0c722033c63ab7b7 08:33:58 INFO - mozversion application_display_name: Nightly 08:33:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:33:58 INFO - mozversion application_name: Firefox 08:33:58 INFO - mozversion application_remotingname: firefox 08:33:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:33:58 INFO - mozversion application_vendor: Mozilla 08:33:58 INFO - mozversion application_version: 53.0a1 08:33:58 INFO - mozversion platform_buildid: 20161206064938 08:33:58 INFO - mozversion platform_changeset: 3ec83fde43f2e1ba1dc583df0c722033c63ab7b7 08:33:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:33:58 INFO - mozversion platform_version: 53.0a1 08:33:58 INFO - using testdate: 1481042038 08:33:58 INFO - actual date: 1481042038 08:33:58 INFO - starting webserver on 'localhost:49247' 08:33:58 INFO - SUITE-START | Running 2 tests 08:33:58 INFO - TEST-START | dromaeo_css 08:33:58 INFO - operating with platform_type : mac_ 08:33:58 INFO - Initialising browser for dromaeo_css test... 08:33:58 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmp42aZt8/profile http://localhost:49247/getInfo.html) 08:34:01 INFO - PROCESS | 1687 | __metrics Screen width/height:1600/1200 08:34:01 INFO - PROCESS | 1687 | colorDepth:24 08:34:01 INFO - PROCESS | 1687 | Browser inner width/height: 1024/689 08:34:01 INFO - PROCESS | 1687 | __metrics 08:34:01 INFO - PROCESS | 1687 | 2016-12-06 08:34:01.775 plugin-container[1689:19103] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c3f, name = 'com.apple.tsm.portname' 08:34:01 INFO - PROCESS | 1687 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:34:01 INFO - PROCESS | 1687 | 2016-12-06 08:34:01.777 plugin-container[1689:19103] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 08:34:01 INFO - PROCESS | 1687 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:34:01 INFO - PROCESS | 1687 | 2016-12-06 08:34:01.777 plugin-container[1689:19103] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:34:01 ERROR - PROCESS | 1687 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 08:34:02 INFO - TEST-INFO | 1687: exit 0 08:34:02 INFO - Browser initialized. 08:34:02 INFO - Running cycle 1/1 for dromaeo_css test... 08:34:02 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmp42aZt8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:34:05 INFO - PROCESS | 1691 | 2016-12-06 08:34:05.419 plugin-container[1692:19234] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454b, name = 'com.apple.tsm.portname' 08:34:05 INFO - PROCESS | 1691 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:34:05 INFO - PROCESS | 1691 | 2016-12-06 08:34:05.420 plugin-container[1692:19234] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 08:34:05 INFO - PROCESS | 1691 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:34:05 INFO - PROCESS | 1691 | 2016-12-06 08:34:05.420 plugin-container[1692:19234] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:34:15 INFO - PROCESS | 1691 | RSS: Main: 241893376 08:34:15 INFO - PROCESS | 1691 | 08:35:04 INFO - PROCESS | 1691 | 1481042104734 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:37:18 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 08:37:20 INFO - PROCESS | 1691 | RSS: Main: 253648896 08:37:20 INFO - PROCESS | 1691 | 08:40:23 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 08:40:23 INFO - PROCESS | 1691 | RSS: Main: 265003008 08:40:23 INFO - PROCESS | 1691 | 08:43:25 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 08:43:26 INFO - PROCESS | 1691 | RSS: Main: 272556032 08:43:26 INFO - PROCESS | 1691 | 08:46:28 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 08:46:29 INFO - PROCESS | 1691 | RSS: Main: 271147008 08:46:29 INFO - PROCESS | 1691 | 08:49:32 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 08:49:32 INFO - PROCESS | 1691 | RSS: Main: 275562496 08:49:32 INFO - PROCESS | 1691 | 08:52:35 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 08:52:35 INFO - PROCESS | 1691 | RSS: Main: 278163456 08:52:35 INFO - PROCESS | 1691 | 08:52:35 INFO - PROCESS | 1691 | __start_tp_report 08:52:35 INFO - PROCESS | 1691 | _x_x_mozilla_page_load 08:52:35 INFO - PROCESS | 1691 | _x_x_mozilla_page_load_details 08:52:35 INFO - PROCESS | 1691 | |i|pagename|runs| 08:52:35 INFO - PROCESS | 1691 | |0;dojo.html;3419.316136772645;3431.4166591679414;3443.9139021524475;3447.2416068464945;3456.084137703509;4616.469106052805;4848.321235027091;5539.25220095287;5714.628549144302;5796.623219490735;4627.444706635209;5552.333719953601;5695.658260504372;5743.5118014968675;5816.563757718178;4066;4222.894427639303;4426.269665505204;5044.697318160904;5368.409474957752;5130.230465430197;5276.419593844674;5376.0054389937795;5376.623636345457;5387.164989426645;5123.795048198068;5150.716710580917;5291.841244762663;5297.761600727938;5316.893662126755;5162.845114646567;5210.687358758487;5279.049771041211;5328.6802791832615;5351.438098999588;5201.609879259071;5213.400458947193;5224.791008359661;5239.921401178985;5269.55208807248;5143.537081662631;5616.129499927518;5752.453516915886;5803.738831752581;5804.419558044204;6119.593952096689;6123.740204357149;6132.754689812402;6171.352008039181;6206.286277078104;6234.096056071844;6260.718267677966;6265.122882796412;6266;6296.622202667854;5913.965056115163;5915.526757859361;5921.61509501881;5927.992241318986;5947.524198064145;6180.47465965389;6233.657148856766;6293.748250069946;6311.589746666452;6417.262014868256;4821.7589120543835;6089.2997305310455;6117.705611546597;6233.345498722569;6257.374262573706;6116.418940200674;6262.373762623793;6271.655058971709;6296.338884417162;6296.961001434712;6102.3983636914;6145.139680444741;6152.384761523812;6171.537134714914;6208;5091.872703182376;6191.102290167901;6227.532935029801;6227.564070515111;6258.15514905491;4824.758762061883;4909.754512274372;4918.286848406961;5001.874953126201;5018.04657115147;3402.880899168567;3960.485136932238;3999.680025597945;4142;4167.729097608646;5181.222816577543;5747.885042299131;6015.518758499397;6053.4854537363935;6099.512039036867;6223.937760622426;6271;6271;6294.0558916162945;6300.527460440485;5989.951758442256;6012.549058820606;6036.245469316335;6037.215162028908;6042.516598672096;5363.731813409314;5410.864728381744;5417.4040855506655;5425.186222066722;5443.782248710087;5660.839527896771;6256.499480041677;6475.034515638854;6501.187351581052;6524.67376631157;6240.251169859646;6251.374862513712;6278.340774218641;6284.277308109443;6325.430711236011;5404.243405923095;6249.218847644044;6326.620402775664;6376.426121649074;6394.136791533084;6218.906716399167;6250.781222657185;6258.249010118815;6281.560290779602;6292.150559674568;4743.312219728051;5855.770288239518;6261.5616906816085;6273.686315684106;6275.623462592259;6009.489193418608;6041.939580604314;6096.420840020191;6224.221972253468;6231.189945307081;6103.5195042504665;6113.202667687911;6126.2123341605975;6136.764169924414;6142.447179753844;5991.910121348096;6073.423024812636;6119.388061193845;6127.571070025056;6133.969330153321;6028.457438830526;6085.1785009023215;6122.081687746873;6124.106319906264;6129.724162412613;5978.312494063239;6037.849053773691;6104.125697713769;6104.519788040365;6128.503123582287 08:52:35 INFO - PROCESS | 1691 | |1;ext.html;465.9603933665636;490.87728067983005;492.23948998796857;528.8836455979686;530.4721801807202;29994.250143746416;35184.82407587962;36773.816130919375;36839.4474082889;36895;39206;39582.20835583287;39589.010274743145;39774.60225397745;39776.602233977654;7738.458307918448;8212.34301255898;9340.813183736322;9340.859887101698;9398.060193980582;8324.583770811465;8993.64025438985;10799.622013229538;11035.44822758859;11049.668509944715;9132.452052876848;9326.813463730721;11059.557617695282;11075.833862492029;11101.777964440706;10977.506012229469;11020.50407731654;11034.172437067253;11087.83368249477;11112.722181945475;9424.198943089777;11004.889951100467;11099.334039957628;11103.611373601885;11115.666530004113;37594;37956.43065354022;37994.62005379939;38071.04822379435;38093.23813523714;3186.410514054884;3290.9835450822593;3359.177001634615;3486.546748922624;3543.875964341236;23359.649605255763;28485.430291394056;28828.990985315624;29256.75777012321;29383.853080734458;3066.647335556417;3267.967320326814;3270.836458177105;3284.0640417480904;3318.0543545089777;482936;488663;491349;491619;494837.5258123722;52900.73549632304;57228.71385643045;57839.710801445726;57971.420285797445;58160.12759808606;59894.401055988885;60123;60409.39590604038;60436.09345859816;60458.95410458919;14880.181590012653;15301.540953771404;15322.923385383225;15386.538403847679;15457.613559661098;10747.516361763583;11953.40232988347;12013.579524716593;12047.216930899463;12065.577704780466;13084.476620935246;14205;15850.286737096858;16267.837321626632;16424.1787910604;5546.944530554723;6542.1168142300185;6593.769218077345;6655;6678.365555272241;860.9741707748777;885.6900084970209;909.9636014559344;937.8265020971143;967.3663750243602;23285.282607618632;24306.149284775303;24751;29322.853385732935;29354.412911741645;955.9713208603753;971.6162115964155;1032.932859364139;1090.5855774805523;1239.7706424311532;11062.446877656084;12823.807642885364;12998.350082495837;14955.551333460013;15508.922455387876;556493;614604;616741;621974;625957;47709.284360734615;53918.46081539213;53969;54004.18993715097;54117;1305.1907817153426;1341.3427420563853;1346.4479563378968;1346.8181795457683;1348.5010546098006;23881.88059059763;27734.029308974088;28509.289442633508;28944.56583151212;29053.854730726212;46687;47251.76374118107;47310;47349.81625459391;47459.52540474551;389120.0543997262;390980;391805;391947;391980;32286.515702264016;32754;37754.43368349532;37837.43243851289;39056.828295151194;35509.82245088758;40376;42175.57824421839;43089.7845510783;45948;28770.712292876804;36120;36187.638123618424;37114.628853712195;37252.39202872886;27444.862775685993;30755.538666919565;30961.225969350948;36461.635383646884;36534.63465365312;28949.7105028947;35697.75057872962;35776.46335305025;35984;36196.638033619325;23388;31087.68912310848;31789;32564.534595942765;32874.67125328716;19245.32641357602;24122.15572455026;24183.51632967366;25078.37304067413;25129.24612261635 08:52:35 INFO - PROCESS | 1691 | |2;jquery.html;335.59895924370375;365.4554713476919;369.4273875492987;383.0462149248372;399.59041981968477;18947.242110315587;19602.31391901284;19638.803611963893;20249.99999999998;20470.89764551175;19566.413007609757;19854.571605505498;19912.70130948037;20077.59844803103;20237.392878213675;4694.530546945312;5081.59347252219;5658.547316214704;5940.3762604926505;5942.2869255689375;5827.426594819396;6013.72938217779;6018.15745795589;6029.849253768669;6030.728617212214;5620.409856965021;5678.46054624812;5751.7986870459545;5923.970380148093;5953.761849526014;5766.279215098113;5821.767129314822;5821.912671309934;5828.679422631753;5838.21184140142;5071.594272458195;5105.591552675777;5351.839444816662;5399.676019438807;5420.159875219348;12439.75120497594;12681.682957926125;12787.424565894464;12960.092793504458;12982.09125361225;2031.817136457711;2367.4791545859885;2560.5519034169133;2871.6554013518303;2883.855807209631;9687.612495500172;9781.266405019653;9827.852582211273;10334.948325258401;10453.21600879937;1844.437446578793;1875.962480750391;1892.5930924851086;1934.2939826963197;1962.9901850490799;104471.4776426113;106823.2611858589;117239.82760172374;117396;121296;8300.626471808662;8495.447795893371;11323.490442930088;11419.257748246337;11792.88207117935;11807.468663910146;14460.783088253685;14464.349104290122;14477.493287734878;14533.636659083397;7387.596356692211;7806.141324454419;8003;8251.422400431911;8262.462939909006;6482.967585162139;6653.700583473658;8018.51888886657;8181.181881811771;8215.548144852091;4389.582989615981;4485.102979404132;4521.773911304422;4584.564466375689;4604.401427814362;1687.767929411512;1901.8668693191344;1908.7900330963582;1951.5023668964322;1987.5726718755536;826.6321486938255;857.1985193843776;890.0787684746257;914.881065461499;1000.6797824696027;18484.630307393778;19741.703874441893;20324;20668.48328791762;20749.481262968548;880.6213328268906;881.3081730841387;900.617237673986;903.385697725553;932.4451951089227;8616;10606;11111.666650000512;11125.666230013112;11154.498047587878;535943;551241;556781;558783.206083967;559982;96431;126816.29326680322;135104;135893;137565;952.514217748953;975.3952549419264;979.7893452907516;996.138340335619;996.2378780233128;18365.63268734591;18832.62334753325;18882;18914.621707565497;18925.43223703291;54225.45774542204;54773.45226547843;54959.900801984535;55193.44806552044;55600;53699.46300536945;76125;76879;78077.60961195157;79200.60399698195;7954.323882470055;8124.390670699603;8145.755627331189;8231.218034286732;8418.747437576883;10997;11766.941165294118;12258.957988571072;12789.74420511566;13117.803232951705;10984.835227471754;11186.049185819296;11221.326720396803;11438.542458301576;11504.597339093092;10960.835587466354;11034.668959931216;11121.29423015624;11347.319160850375;11506.252093613888;11105.278156919774;11216.439178041228;11317.434128293717;11400.087992960378;11439.199256051996;6133.9079913802225;7750.844983100419;8133.511989280662;8149.388795840217;8198.631061602362;8223.383246256435;8445.957770211355;10641.521131548943;11332.433378331216;11541 08:52:35 INFO - PROCESS | 1691 | |3;mootools.html;1323.6029191242628;1443.6463066548695;1626.4226199699106;1765.2409463930505;1809.5295223241953;7504.96247518763;7712.57580833054;7955.124936257014;8400.41197116202;8416.579171041454;6809.761658341959;7600.315971562558;7871.960640196791;7875.212478752122;7961.840763184733;2229.5317983223545;2263.4228271790753;2280.2019293247395;2281.041962375806;2284.8971796269207;2245.2253972379585;2270.137347807831;2277.032261288954;2282.669012993115;2303.3205204464725;2253.3803204118835;2260.400993736661;2273.5111950930545;2281.304202218331;2289.095807156172;2155.655095184763;2230.698855654482;2246.213825161197;2261.185973049717;2263.479399738061;2038.2967876082728;2111.6199084164846;2276.3512398966213;2278.5898538263104;2282.805961493275;8111.269985701315;8290.378221633342;8311.584420778936;8315.459495132796;8339.666413343459;4972.776225069844;5121.590272778206;5136.255242989783;5146.562542183919;5153.381594208681;3155.5266709993457;3234.628017777962;3470.861165553375;3473.3400653875938;3479.251960828434;1017.3336464615688;1060.3584831177182;1065.0680654427376;1075.8977897099762;1078.9730256743567;10319.84520232197;10662.520186591544;10672.839907401396;10680.038796508352;10682;3722.6277372262557;3987.843525377666;4191.434156388848;4241.681873859473;4376.934345984812;7293.70825166998;8271.875921861178;8339.166083391612;8356.623951922178;8364.456310339809;4963.90072198554;4968;4978.850634480971;4988.850334489898;4998.375203099613;4248.808803603783;4426.800793964279;4657.8602641920115;4694.990577025956;4698.929516057262;3200.5999250093737;3481.89554313371;3570.839312230956;3618.4753210784816;3726.2733766915735;970.5777986575862;1128.915331350152;1141.1099342512853;1149.413798962535;1152.504423098059;745.6271864067966;792.9365650747926;844.3667249562828;873.1661263493348;892.0767006148606;4507.301368287921;5082.974585127051;5089.9056702809075;5281.494773989394;5321.308229930084;705.5272967112047;902.9390466202186;911.2618778789202;929.6467342409976;961.3895176562933;3592.425211966125;3603.4234522476277;3617.366960781905;3695.611960744137;3771.8868433947027;8887.466751994902;9945.453000085065;9952.552135153936;9970.850437243447;10005.399676019317;9798.853017204749;9904.65333713331;9931.751706207258;9951.25365597583;9956.352837065713;7564.054493188351;7732.226777322336;7733.961330193313;7734.2265773422205;7737.651805668758;5247.947520524898;5430.104032834538;5514.751836167302;5531.751071201886;5547.084731019337;7384.37232835215;8866.290696744374;9319.16127548524;9356.672516461891;9373.859392108987;9223.723288301362;9274;9296.581653825458;9335.019822918495;9429.481378523973;6463.806085817433;6672.5329226953645;6686.197656281277;6824.283450237654;6852.486063545353;7589.279018493235;7788.649510772142;7794.961025194838;7800.492967957065;7815.921840781747;6857.417119544894;6992.300769922967;7022.297770222936;7055;7121.715131394686;5753.280839895013;6793.150856142982;6836;6839.93160068393;6866.588004719732;6361.968190159019;6501.057346684799;6533.901991470037;6611.305812889577;6645.966770166118;4650.744209068534;4718.575328220477;4754.881127971828;4758.310045043519;4865.683730557503;3912.6478616923473;4262.509811371732;4791.161546729239;4838.225883858566;4970.850874473772 08:52:35 INFO - PROCESS | 1691 | |4;prototype.html;242.47141232113995;245.91147187012683;278.94141732126576;302.2338372226406;311.6400557356254;4515.435570553681;5074.644774865761;5318.6808791472495;5422.186671999197;5579.609427340088;3964.751103402426;4749.667523273372;5251.763670634821;5433.402325744165;5450.700211488366;3770.7360484766077;4187.811548480326;4195.454590903194;4199.91600167998;4206.390073439349;3210.9357812843728;3650;3987.2424239394422;4096.508418989725;4248.97875510622;4152.8961775955695;4189.099343641116;4191.203671302458;4194.937075943848;4220.767857767822;3109.7978631388887;4161.812718427678;4178.707490475668;4183.372494125875;4214.620684138442;3676.356637588411;3684.8341824617687;3685.5761587417524;3696.6488183622514;3702.8889133326043;5199.53204211619;5279.656822306538;5290.867728306785;5323.699306430038;5366.195070739382;3782.508273924372;4708.4820669726305;4786.545278198566;4815.783289751969;4845.224764037773;5224.373075230958;5263.447283051509;5358.526405238591;5788.594798364116;5820.650760954356;3501.441858373025;3807.923841523154;4002.6597739192202;4021.7586944783407;4050.825260674401;5091.694498330112;5094.974525127351;5284.947150528523;6007.017684164215;6114.755409783604;3648.21563363878;3948.802559871995;4094.25993952569;4094.7478886612244;4117.75293482392;3735.58908520068;3826.827792749333;4021.7989100544855;4101.507819061731;4119.186291888261;4772.689775164603;4791;4791.47293797682;4798.7283369907;4827.468978412372;5056.974715126401;5341.332333458317;5821.88356232873;5831.825045248649;5876.647401155944;1107.8061339265757;1194.1879521925175;1222.541546919905;1300.694336830844;1357.2128165663892;906.759708677201;932.9597498788802;935.8676002037474;937.3813283233034;943.7401069572061;4406.977965110218;5168.304662166569;5177.352830896138;5196.870078247998;5205.427402985669;4556.997460558672;5637.661740295595;5642.4075472075665;5653.71024734983;5659.349174844946;4716.95283047172;5156.948430515722;5170.327857378592;5178.922316165185;5192.844214673566;2272.7272727272834;2702.648675662169;2809.4942910276345;2954.3795802881637;2959.682941091237;5330.573554115662;5493.423190565013;5547.613096725819;5811.709414529341;5883.705814709333;5240.68555886648;5436.809711660073;5552.889901837276;6117.296510901303;6183.5671502994355;5836.737346819488;6336.968315158395;6348.333424990402;6353.968230158912;6362.522810789209;5045.823396181116;5509.421510741315;5624.915626265692;6085.421884920926;6096.847578810565;5090;5214.400343960493;5459.563234941115;5945.316288626863;5953.374895636069;5334.279872217201;5511.944880551304;6238.781642642486;6268.4671802897265;6307.463865571478;3010.5785190073843;3252.593425821772;3666.596674365871;3951;3997;5758.913616295843;5822.359540450462;5852.590318677651;5931.4068593142065;5933.970330148321;5145.716985565829;5659.585103724069;5781.682007489629;5807.622504537191;5855.590108692521;5031.842676184571;5233.528982391603;5416.620836541404;5627.774889004558;5764.394738552392;5407.918881216706;5621.606487545832;5637.8590535236945;5680.943190568207;5720.856978575569;5633.802816901389;5771.68255745938;5850.678212698343;5864.296284445893;5899.705014749331;5389.21856330822;5716.9428305718075;5721.399253078367;5746.0639461968685;5766.8846623066465 08:52:35 INFO - PROCESS | 1691 | |5;yui.html;632.9618628017782;682.8975653651949;708.0547469128713;742.9331360177583;796.2117503671366;14818.703625927488;15178;15542.378304867805;15726.326524490836;15746.84253157471;14075;14330.570082897504;14354.78467822981;14363.784543231859;14372;641.9325970773072;662.6388618203067;667.6594936582354;808.9878651820227;812.2892469089546;819.8237378963522;834.9707760228393;835.0355339582761;835.4653022065883;836.4061516323418;735.7719107076797;874.0822136756412;876.0932434929849;876.8816209811657;878.1920633017639;683.4225079807554;808.9595520223966;811.8498077855616;870.1863757386864;873.1574031060026;647.1102234427661;647.5596594315863;648.6853875870199;649.1009951217551;651.2152855808739;14992.850071499364;14994.400223991028;15310.234488275542;15416.229188540528;15416.22918854064;14419.206943618097;14499.565013049625;14605.92697036508;14835.48075817352;14877.776833347509;11277.548898044068;11415.086793056618;11813.645590632295;12062.336571488564;12127.575534856238;3698.7041036716996;3712.9443058354145;3713.9071523211865;3743.6256374362347;3872.419137129425;90510.09489905149;103014.48492757489;120275;121397;124786.37606812;11029.944850275697;11068.3912384818;11113.388763618079;11309.925557072065;11405.771884562262;23060.423489412562;23146.7685323148;23224.53550928972;23554.411139721644;23661.645075323882;6687.933120668731;7203.89194162088;7546.811329716801;7931.405144614062;8115.310198633182;4150.605692459211;4299.419578356944;4331.978340108342;4347.369631403492;4531.818727250873;3398.7281017519035;3497.169147174605;3509.8596056157467;3531.7527773056154;3532.5584301962253;567.9034564124026;616.5807251069316;620.1194304088206;621.5369549685513;644.9613023218621;570.785955266775;632.4181752787355;641.1376698340724;656.6079910589581;675.6621689155422;9261.953690231505;9289.628414863464;9356.667047503543;9363.812723745623;9672.115675960182;498.0243047789501;632.7121159872247;636.9426751592431;667.366002297819;668.211510417702;4372.256716358227;4523.886902827456;4562.08758248345;4613.515580864028;4726.527347265246;106048.93951060544;106371;106521;107429;107546;71188.64405677939;74076.62961685157;75649.62175189088;75686.62156689182;98708.50645746868;66664.33335666679;71366.286337137;73531.63234183795;75094.24905750982;76863.84704229441;8217.424780265324;8499.872501912352;9385.38994965325;9439.669611563837;9851.45816980073;38733.8379848605;47987.441193086604;48619.27071094007;50610;54545;66111;66749.33250667431;66947.66526167338;68556.28609284808;70573.29426705667;10748.677539673823;13178.868211317764;13342.19946803195;13380.732385352434;13685.247311397969;14738.63153421173;14999.400023999355;15018.200418137829;15124.632011636939;15938.123403212934;11106.833397499206;13346.265955372548;13475.32623368808;13858.099223550436;13937.651558711113;13647.11293765902;13919.582412527641;13926.58220253394;14425.49510767118;14448.277586120863;13463.663408414868;13539.255340956342;13592.79610805819;13703.794443083561;14158.929205353907;11341.4896329667;11390.316581005167;11460.484278207667;11585.304881707125;11900.702482438008;8948.418352807046;8969.327300452362;11359.169681017705;11569.19015668895;11677.124215683687 08:52:35 INFO - PROCESS | 1691 | __end_tp_report 08:52:35 INFO - PROCESS | 1691 | __start_cc_report 08:52:35 INFO - PROCESS | 1691 | _x_x_mozilla_cycle_collect,355 08:52:35 INFO - PROCESS | 1691 | __end_cc_report 08:52:35 INFO - PROCESS | 1691 | __startTimestamp1481043155691__endTimestamp 08:52:35 INFO - PROCESS | 1691 | 08:52:35 INFO - PROCESS | 1691 | ------- Summary: start ------- 08:52:35 INFO - PROCESS | 1691 | Number of tests: 6 08:52:35 INFO - PROCESS | 1691 | 08:52:35 INFO - PROCESS | 1691 | [#0] dojo.html Cycles:165 Average:5703.29 Median:6037.85 stddev:723.13 (12.0%) stddev-sans-first:702.80 08:52:35 INFO - PROCESS | 1691 | Values: 3419.3 3431.4 3443.9 3447.2 3456.1 4616.5 4848.3 5539.3 5714.6 5796.6 4627.4 5552.3 5695.7 5743.5 5816.6 4066.0 4222.9 4426.3 5044.7 5368.4 5130.2 5276.4 5376.0 5376.6 5387.2 5123.8 5150.7 5291.8 5297.8 5316.9 5162.8 5210.7 5279.0 5328.7 5351.4 5201.6 5213.4 5224.8 5239.9 5269.6 5143.5 5616.1 5752.5 5803.7 5804.4 6119.6 6123.7 6132.8 6171.4 6206.3 6234.1 6260.7 6265.1 6266.0 6296.6 5914.0 5915.5 5921.6 5928.0 5947.5 6180.5 6233.7 6293.7 6311.6 6417.3 4821.8 6089.3 6117.7 6233.3 6257.4 6116.4 6262.4 6271.7 6296.3 6297.0 6102.4 6145.1 6152.4 6171.5 6208.0 5091.9 6191.1 6227.5 6227.6 6258.2 4824.8 4909.8 4918.3 5001.9 5018.0 3402.9 3960.5 3999.7 4142.0 4167.7 5181.2 5747.9 6015.5 6053.5 6099.5 6223.9 6271.0 6271.0 6294.1 6300.5 5990.0 6012.5 6036.2 6037.2 6042.5 5363.7 5410.9 5417.4 5425.2 5443.8 5660.8 6256.5 6475.0 6501.2 6524.7 6240.3 6251.4 6278.3 6284.3 6325.4 5404.2 6249.2 6326.6 6376.4 6394.1 6218.9 6250.8 6258.2 6281.6 6292.2 4743.3 5855.8 6261.6 6273.7 6275.6 6009.5 6041.9 6096.4 6224.2 6231.2 6103.5 6113.2 6126.2 6136.8 6142.4 5991.9 6073.4 6119.4 6127.6 6134.0 6028.5 6085.2 6122.1 6124.1 6129.7 5978.3 6037.8 6104.1 6104.5 6128.5 08:52:35 INFO - PROCESS | 1691 | 08:52:35 INFO - PROCESS | 1691 | [#1] ext.html Cycles:180 Average:62676.96 Median:36052.00 stddev:134606.76 (373.4%) stddev-sans-first:134903.33 08:52:35 INFO - PROCESS | 1691 | Values: 466.0 490.9 492.2 528.9 530.5 29994.3 35184.8 36773.8 36839.4 36895.0 39206.0 39582.2 39589.0 39774.6 39776.6 7738.5 8212.3 9340.8 9340.9 9398.1 8324.6 8993.6 10799.6 11035.4 11049.7 9132.5 9326.8 11059.6 11075.8 11101.8 10977.5 11020.5 11034.2 11087.8 11112.7 9424.2 11004.9 11099.3 11103.6 11115.7 37594.0 37956.4 37994.6 38071.0 38093.2 3186.4 3291.0 3359.2 3486.5 3543.9 23359.6 28485.4 28829.0 29256.8 29383.9 3066.6 3268.0 3270.8 3284.1 3318.1 482936.0 488663.0 491349.0 491619.0 494837.5 52900.7 57228.7 57839.7 57971.4 58160.1 59894.4 60123.0 60409.4 60436.1 60459.0 14880.2 15301.5 15322.9 15386.5 15457.6 10747.5 11953.4 12013.6 12047.2 12065.6 13084.5 14205.0 15850.3 16267.8 16424.2 5546.9 6542.1 6593.8 6655.0 6678.4 861.0 885.7 910.0 937.8 967.4 23285.3 24306.1 24751.0 29322.9 29354.4 956.0 971.6 1032.9 1090.6 1239.8 11062.4 12823.8 12998.4 14955.6 15508.9 556493.0 614604.0 616741.0 621974.0 625957.0 47709.3 53918.5 53969.0 54004.2 54117.0 1305.2 1341.3 1346.4 1346.8 1348.5 23881.9 27734.0 28509.3 28944.6 29053.9 46687.0 47251.8 47310.0 47349.8 47459.5 389120.1 390980.0 391805.0 391947.0 391980.0 32286.5 32754.0 37754.4 37837.4 39056.8 35509.8 40376.0 42175.6 43089.8 45948.0 28770.7 36120.0 36187.6 37114.6 37252.4 27444.9 30755.5 30961.2 36461.6 36534.6 28949.7 35697.8 35776.5 35984.0 36196.6 23388.0 31087.7 31789.0 32564.5 32874.7 19245.3 24122.2 24183.5 25078.4 25129.2 08:52:35 INFO - PROCESS | 1691 | 08:52:35 INFO - PROCESS | 1691 | [#2] jquery.html Cycles:180 Average:32936.42 Median:391.32 stddev:92627.46 (23670.6%) stddev-sans-first:92854.96 08:52:35 INFO - PROCESS | 1691 | Values: 335.6 365.5 369.4 383.0 399.6 18947.2 19602.3 19638.8 20250.0 20470.9 19566.4 19854.6 19912.7 20077.6 20237.4 4694.5 5081.6 5658.5 5940.4 5942.3 5827.4 6013.7 6018.2 6029.8 6030.7 5620.4 5678.5 5751.8 5924.0 5953.8 5766.3 5821.8 5821.9 5828.7 5838.2 5071.6 5105.6 5351.8 5399.7 5420.2 12439.8 12681.7 12787.4 12960.1 12982.1 2031.8 2367.5 2560.6 2871.7 2883.9 9687.6 9781.3 9827.9 10334.9 10453.2 1844.4 1876.0 1892.6 1934.3 1963.0 104471.5 106823.3 117239.8 117396.0 121296.0 8300.6 8495.4 11323.5 11419.3 11792.9 11807.5 14460.8 14464.3 14477.5 14533.6 7387.6 7806.1 8003.0 8251.4 8262.5 6483.0 6653.7 8018.5 8181.2 8215.5 4389.6 4485.1 4521.8 4584.6 4604.4 1687.8 1901.9 1908.8 1951.5 1987.6 826.6 857.2 890.1 914.9 1000.7 18484.6 19741.7 20324.0 20668.5 20749.5 880.6 881.3 900.6 903.4 932.4 8616.0 10606.0 11111.7 11125.7 11154.5 535943.0 551241.0 556781.0 558783.2 559982.0 96431.0 126816.3 135104.0 135893.0 137565.0 952.5 975.4 979.8 996.1 996.2 18365.6 18832.6 18882.0 18914.6 18925.4 54225.5 54773.5 54959.9 55193.4 55600.0 53699.5 76125.0 76879.0 78077.6 79200.6 7954.3 8124.4 8145.8 8231.2 8418.7 10997.0 11766.9 12259.0 12789.7 13117.8 10984.8 11186.0 11221.3 11438.5 11504.6 10960.8 11034.7 11121.3 11347.3 11506.3 11105.3 11216.4 11317.4 11400.1 11439.2 6133.9 7750.8 8133.5 8149.4 8198.6 8223.4 8446.0 10641.5 11332.4 11541.0 08:52:35 INFO - PROCESS | 1691 | 08:52:35 INFO - PROCESS | 1691 | [#3] mootools.html Cycles:180 Average:5238.34 Median:5141.41 stddev:2881.78 (56.1%) stddev-sans-first:2874.84 08:52:35 INFO - PROCESS | 1691 | Values: 1323.6 1443.6 1626.4 1765.2 1809.5 7505.0 7712.6 7955.1 8400.4 8416.6 6809.8 7600.3 7872.0 7875.2 7961.8 2229.5 2263.4 2280.2 2281.0 2284.9 2245.2 2270.1 2277.0 2282.7 2303.3 2253.4 2260.4 2273.5 2281.3 2289.1 2155.7 2230.7 2246.2 2261.2 2263.5 2038.3 2111.6 2276.4 2278.6 2282.8 8111.3 8290.4 8311.6 8315.5 8339.7 4972.8 5121.6 5136.3 5146.6 5153.4 3155.5 3234.6 3470.9 3473.3 3479.3 1017.3 1060.4 1065.1 1075.9 1079.0 10319.8 10662.5 10672.8 10680.0 10682.0 3722.6 3987.8 4191.4 4241.7 4376.9 7293.7 8271.9 8339.2 8356.6 8364.5 4963.9 4968.0 4978.9 4988.9 4998.4 4248.8 4426.8 4657.9 4695.0 4698.9 3200.6 3481.9 3570.8 3618.5 3726.3 970.6 1128.9 1141.1 1149.4 1152.5 745.6 792.9 844.4 873.2 892.1 4507.3 5083.0 5089.9 5281.5 5321.3 705.5 902.9 911.3 929.6 961.4 3592.4 3603.4 3617.4 3695.6 3771.9 8887.5 9945.5 9952.6 9970.9 10005.4 9798.9 9904.7 9931.8 9951.3 9956.4 7564.1 7732.2 7734.0 7734.2 7737.7 5247.9 5430.1 5514.8 5531.8 5547.1 7384.4 8866.3 9319.2 9356.7 9373.9 9223.7 9274.0 9296.6 9335.0 9429.5 6463.8 6672.5 6686.2 6824.3 6852.5 7589.3 7788.6 7795.0 7800.5 7815.9 6857.4 6992.3 7022.3 7055.0 7121.7 5753.3 6793.2 6836.0 6839.9 6866.6 6362.0 6501.1 6533.9 6611.3 6646.0 4650.7 4718.6 4754.9 4758.3 4865.7 3912.6 4262.5 4791.2 4838.2 4970.9 08:52:35 INFO - PROCESS | 1691 | 08:52:35 INFO - PROCESS | 1691 | [#4] prototype.html Cycles:180 Average:4612.80 Median:5198.20 stddev:1445.52 (27.8%) stddev-sans-first:1411.87 08:52:35 INFO - PROCESS | 1691 | Values: 242.5 245.9 278.9 302.2 311.6 4515.4 5074.6 5318.7 5422.2 5579.6 3964.8 4749.7 5251.8 5433.4 5450.7 3770.7 4187.8 4195.5 4199.9 4206.4 3210.9 3650.0 3987.2 4096.5 4249.0 4152.9 4189.1 4191.2 4194.9 4220.8 3109.8 4161.8 4178.7 4183.4 4214.6 3676.4 3684.8 3685.6 3696.6 3702.9 5199.5 5279.7 5290.9 5323.7 5366.2 3782.5 4708.5 4786.5 4815.8 4845.2 5224.4 5263.4 5358.5 5788.6 5820.7 3501.4 3807.9 4002.7 4021.8 4050.8 5091.7 5095.0 5284.9 6007.0 6114.8 3648.2 3948.8 4094.3 4094.7 4117.8 3735.6 3826.8 4021.8 4101.5 4119.2 4772.7 4791.0 4791.5 4798.7 4827.5 5057.0 5341.3 5821.9 5831.8 5876.6 1107.8 1194.2 1222.5 1300.7 1357.2 906.8 933.0 935.9 937.4 943.7 4407.0 5168.3 5177.4 5196.9 5205.4 4557.0 5637.7 5642.4 5653.7 5659.3 4717.0 5156.9 5170.3 5178.9 5192.8 2272.7 2702.6 2809.5 2954.4 2959.7 5330.6 5493.4 5547.6 5811.7 5883.7 5240.7 5436.8 5552.9 6117.3 6183.6 5836.7 6337.0 6348.3 6354.0 6362.5 5045.8 5509.4 5624.9 6085.4 6096.8 5090.0 5214.4 5459.6 5945.3 5953.4 5334.3 5511.9 6238.8 6268.5 6307.5 3010.6 3252.6 3666.6 3951.0 3997.0 5758.9 5822.4 5852.6 5931.4 5934.0 5145.7 5659.6 5781.7 5807.6 5855.6 5031.8 5233.5 5416.6 5627.8 5764.4 5407.9 5621.6 5637.9 5680.9 5720.9 5633.8 5771.7 5850.7 5864.3 5899.7 5389.2 5716.9 5721.4 5746.1 5766.9 08:52:35 INFO - PROCESS | 1691 | 08:52:35 INFO - PROCESS | 1691 | [#5] yui.html Cycles:180 Average:20327.29 Median:4339.67 stddev:29438.63 (678.4%) stddev-sans-first:29484.07 08:52:35 INFO - PROCESS | 1691 | Values: 633.0 682.9 708.1 742.9 796.2 14818.7 15178.0 15542.4 15726.3 15746.8 14075.0 14330.6 14354.8 14363.8 14372.0 641.9 662.6 667.7 809.0 812.3 819.8 835.0 835.0 835.5 836.4 735.8 874.1 876.1 876.9 878.2 683.4 809.0 811.8 870.2 873.2 647.1 647.6 648.7 649.1 651.2 14992.9 14994.4 15310.2 15416.2 15416.2 14419.2 14499.6 14605.9 14835.5 14877.8 11277.5 11415.1 11813.6 12062.3 12127.6 3698.7 3712.9 3713.9 3743.6 3872.4 90510.1 103014.5 120275.0 121397.0 124786.4 11029.9 11068.4 11113.4 11309.9 11405.8 23060.4 23146.8 23224.5 23554.4 23661.6 6687.9 7203.9 7546.8 7931.4 8115.3 4150.6 4299.4 4332.0 4347.4 4531.8 3398.7 3497.2 3509.9 3531.8 3532.6 567.9 616.6 620.1 621.5 645.0 570.8 632.4 641.1 656.6 675.7 9262.0 9289.6 9356.7 9363.8 9672.1 498.0 632.7 636.9 667.4 668.2 4372.3 4523.9 4562.1 4613.5 4726.5 106048.9 106371.0 106521.0 107429.0 107546.0 71188.6 74076.6 75649.6 75686.6 98708.5 66664.3 71366.3 73531.6 75094.2 76863.8 8217.4 8499.9 9385.4 9439.7 9851.5 38733.8 47987.4 48619.3 50610.0 54545.0 66111.0 66749.3 66947.7 68556.3 70573.3 10748.7 13178.9 13342.2 13380.7 13685.2 14738.6 14999.4 15018.2 15124.6 15938.1 11106.8 13346.3 13475.3 13858.1 13937.7 13647.1 13919.6 13926.6 14425.5 14448.3 13463.7 13539.3 13592.8 13703.8 14158.9 11341.5 11390.3 11460.5 11585.3 11900.7 8948.4 8969.3 11359.2 11569.2 11677.1 08:52:35 INFO - PROCESS | 1691 | -------- Summary: end -------- 08:52:35 INFO - PROCESS | 1691 | 08:52:36 INFO - TEST-INFO | 1691: exit 0 08:52:36 INFO - TEST-OK | dromaeo_css | took 1117914ms 08:52:36 INFO - TEST-START | kraken 08:52:36 INFO - operating with platform_type : mac_ 08:52:36 INFO - Initialising browser for kraken test... 08:52:36 INFO - TEST-INFO | started process 1698 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpWoCFgi/profile http://localhost:49247/getInfo.html) 08:52:39 INFO - PROCESS | 1698 | 2016-12-06 08:52:39.348 plugin-container[1699:21512] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4443, name = 'com.apple.tsm.portname' 08:52:39 INFO - PROCESS | 1698 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:52:39 INFO - PROCESS | 1698 | 2016-12-06 08:52:39.351 plugin-container[1699:21512] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0f, name = 'com.apple.CFPasteboardClient' 08:52:39 INFO - PROCESS | 1698 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:52:39 INFO - PROCESS | 1698 | 2016-12-06 08:52:39.351 plugin-container[1699:21512] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:52:39 INFO - PROCESS | 1698 | __metrics Screen width/height:1600/1200 08:52:39 INFO - PROCESS | 1698 | colorDepth:24 08:52:39 INFO - PROCESS | 1698 | Browser inner width/height: 1024/689 08:52:39 INFO - PROCESS | 1698 | __metrics 08:52:39 ERROR - PROCESS | 1698 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 08:52:40 INFO - TEST-INFO | 1698: exit 0 08:52:40 INFO - Browser initialized. 08:52:40 INFO - Running cycle 1/1 for kraken test... 08:52:40 INFO - TEST-INFO | started process 1700 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpWoCFgi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:52:43 INFO - PROCESS | 1700 | 2016-12-06 08:52:43.213 plugin-container[1701:21633] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 08:52:43 INFO - PROCESS | 1700 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:52:43 INFO - PROCESS | 1700 | 2016-12-06 08:52:43.213 plugin-container[1701:21633] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f03, name = 'com.apple.CFPasteboardClient' 08:52:43 INFO - PROCESS | 1700 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:52:43 INFO - PROCESS | 1700 | 2016-12-06 08:52:43.213 plugin-container[1701:21633] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:52:52 INFO - PROCESS | 1700 | RSS: Main: 241860608 08:52:52 INFO - PROCESS | 1700 | 08:52:55 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 08:52:56 INFO - PROCESS | 1700 | RSS: Main: 253779968 08:52:56 INFO - PROCESS | 1700 | 08:52:59 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 08:52:59 INFO - PROCESS | 1700 | RSS: Main: 261304320 08:52:59 INFO - PROCESS | 1700 | 08:53:03 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 08:53:03 INFO - PROCESS | 1700 | RSS: Main: 264167424 08:53:03 INFO - PROCESS | 1700 | 08:53:05 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 08:53:06 INFO - PROCESS | 1700 | RSS: Main: 265412608 08:53:06 INFO - PROCESS | 1700 | 08:53:08 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:53:09 INFO - PROCESS | 1700 | RSS: Main: 266997760 08:53:09 INFO - PROCESS | 1700 | 08:53:12 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 08:53:12 INFO - PROCESS | 1700 | RSS: Main: 273113088 08:53:12 INFO - PROCESS | 1700 | 08:53:15 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 08:53:16 INFO - PROCESS | 1700 | RSS: Main: 271917056 08:53:16 INFO - PROCESS | 1700 | 08:53:19 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 08:53:20 INFO - PROCESS | 1700 | RSS: Main: 272240640 08:53:20 INFO - PROCESS | 1700 | 08:53:21 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:53:22 INFO - PROCESS | 1700 | RSS: Main: 271388672 08:53:22 INFO - PROCESS | 1700 | 08:53:24 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:53:25 INFO - PROCESS | 1700 | RSS: Main: 271441920 08:53:25 INFO - PROCESS | 1700 | 08:53:27 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:53:28 INFO - PROCESS | 1700 | RSS: Main: 271323136 08:53:28 INFO - PROCESS | 1700 | 08:53:31 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:53:31 INFO - PROCESS | 1700 | RSS: Main: 271806464 08:53:31 INFO - PROCESS | 1700 | 08:53:35 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:53:35 INFO - PROCESS | 1700 | RSS: Main: 269615104 08:53:35 INFO - PROCESS | 1700 | 08:53:37 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 08:53:37 INFO - PROCESS | 1700 | RSS: Main: 270983168 08:53:37 INFO - PROCESS | 1700 | 08:53:37 INFO - PROCESS | 1700 | __start_tp_report 08:53:37 INFO - PROCESS | 1700 | _x_x_mozilla_page_load 08:53:37 INFO - PROCESS | 1700 | _x_x_mozilla_page_load_details 08:53:37 INFO - PROCESS | 1700 | |i|pagename|runs| 08:53:37 INFO - PROCESS | 1700 | |0;ai-astar;106;118;117;119;116;118;119;118;118;118 08:53:37 INFO - PROCESS | 1700 | |1;audio-beat-detection;149;117;117;156;114;116;117;116;139;119 08:53:37 INFO - PROCESS | 1700 | |2;audio-dft;207;211;223;195;197;224;281;201;195;193 08:53:37 INFO - PROCESS | 1700 | |3;audio-fft;86;58;60;83;61;61;61;66;93;83 08:53:37 INFO - PROCESS | 1700 | |4;audio-oscillator;93;77;116;104;70;72;82;70;73;88 08:53:37 INFO - PROCESS | 1700 | |5;imaging-gaussian-blur;137;74;85;133;138;87;93;125;90;88 08:53:37 INFO - PROCESS | 1700 | |6;imaging-darkroom;95;126;96;96;97;106;96;95;97;97 08:53:37 INFO - PROCESS | 1700 | |7;imaging-desaturate;112;111;92;93;94;92;83;148;149;114 08:53:37 INFO - PROCESS | 1700 | |8;json-parse-financial;57;58;58;59;57;59;59;59;56;68 08:53:37 INFO - PROCESS | 1700 | |9;json-stringify-tinderbox;67;69;76;86;75;73;74;103;61;83 08:53:37 INFO - PROCESS | 1700 | |10;stanford-crypto-aes;88;81;116;109;110;85;113;113;110;96 08:53:37 INFO - PROCESS | 1700 | |11;stanford-crypto-ccm;160;153;163;168;152;158;153;151;205;167 08:53:37 INFO - PROCESS | 1700 | |12;stanford-crypto-pbkdf2;177;179;204;244;194;244;202;235;193;175 08:53:37 INFO - PROCESS | 1700 | |13;stanford-crypto-sha256-iterative;68;68;70;69;71;69;70;70;71;68 08:53:37 INFO - PROCESS | 1700 | __end_tp_report 08:53:37 INFO - PROCESS | 1700 | __start_cc_report 08:53:37 INFO - PROCESS | 1700 | _x_x_mozilla_cycle_collect,925 08:53:37 INFO - PROCESS | 1700 | __end_cc_report 08:53:37 INFO - PROCESS | 1700 | __startTimestamp1481043217819__endTimestamp 08:53:37 INFO - PROCESS | 1700 | 08:53:37 INFO - PROCESS | 1700 | ------- Summary: start ------- 08:53:37 INFO - PROCESS | 1700 | Number of tests: 14 08:53:37 INFO - PROCESS | 1700 | 08:53:37 INFO - PROCESS | 1700 | [#0] ai-astar Cycles:10 Average:116.70 Median:118.00 stddev:3.86 (3.3%) stddev-sans-first:0.93 08:53:37 INFO - PROCESS | 1700 | Values: 106.0 118.0 117.0 119.0 116.0 118.0 119.0 118.0 118.0 118.0 08:53:37 INFO - PROCESS | 1700 | 08:53:37 INFO - PROCESS | 1700 | [#1] audio-beat-detection Cycles:10 Average:126.00 Median:118.00 stddev:15.76 (13.4%) stddev-sans-first:14.34 08:53:37 INFO - PROCESS | 1700 | Values: 149.0 117.0 117.0 156.0 114.0 116.0 117.0 116.0 139.0 119.0 08:53:37 INFO - PROCESS | 1700 | 08:53:37 INFO - PROCESS | 1700 | [#2] audio-dft Cycles:10 Average:212.70 Median:209.00 stddev:26.52 (12.7%) stddev-sans-first:28.05 08:53:37 INFO - PROCESS | 1700 | Values: 207.0 211.0 223.0 195.0 197.0 224.0 281.0 201.0 195.0 193.0 08:53:37 INFO - PROCESS | 1700 | 08:53:37 INFO - PROCESS | 1700 | [#3] audio-fft Cycles:10 Average:71.20 Median:74.50 stddev:13.38 (18.0%) stddev-sans-first:13.08 08:53:37 INFO - PROCESS | 1700 | Values: 86.0 58.0 60.0 83.0 61.0 61.0 61.0 66.0 93.0 83.0 08:53:37 INFO - PROCESS | 1700 | 08:53:37 INFO - PROCESS | 1700 | [#4] audio-oscillator Cycles:10 Average:84.50 Median:75.00 stddev:15.74 (21.0%) stddev-sans-first:16.39 08:53:37 INFO - PROCESS | 1700 | Values: 93.0 77.0 116.0 104.0 70.0 72.0 82.0 70.0 73.0 88.0 08:53:37 INFO - PROCESS | 1700 | 08:53:37 INFO - PROCESS | 1700 | [#5] imaging-gaussian-blur Cycles:10 Average:105.00 Median:86.00 stddev:25.03 (29.1%) stddev-sans-first:23.72 08:53:37 INFO - PROCESS | 1700 | Values: 137.0 74.0 85.0 133.0 138.0 87.0 93.0 125.0 90.0 88.0 08:53:37 INFO - PROCESS | 1700 | 08:53:37 INFO - PROCESS | 1700 | [#6] imaging-darkroom Cycles:10 Average:100.10 Median:96.00 stddev:9.64 (10.0%) stddev-sans-first:10.05 08:53:37 INFO - PROCESS | 1700 | Values: 95.0 126.0 96.0 96.0 97.0 106.0 96.0 95.0 97.0 97.0 08:53:37 INFO - PROCESS | 1700 | 08:53:37 INFO - PROCESS | 1700 | [#7] imaging-desaturate Cycles:10 Average:108.80 Median:87.50 stddev:23.32 (26.6%) stddev-sans-first:24.70 08:53:37 INFO - PROCESS | 1700 | Values: 112.0 111.0 92.0 93.0 94.0 92.0 83.0 148.0 149.0 114.0 08:53:37 INFO - PROCESS | 1700 | 08:53:37 INFO - PROCESS | 1700 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:59.00 stddev:3.33 (5.6%) stddev-sans-first:3.46 08:53:37 INFO - PROCESS | 1700 | Values: 57.0 58.0 58.0 59.0 57.0 59.0 59.0 59.0 56.0 68.0 08:53:37 INFO - PROCESS | 1700 | 08:53:37 INFO - PROCESS | 1700 | [#9] json-stringify-tinderbox Cycles:10 Average:76.70 Median:74.50 stddev:11.75 (15.8%) stddev-sans-first:11.92 08:53:37 INFO - PROCESS | 1700 | Values: 67.0 69.0 76.0 86.0 75.0 73.0 74.0 103.0 61.0 83.0 08:53:37 INFO - PROCESS | 1700 | 08:53:37 INFO - PROCESS | 1700 | [#10] stanford-crypto-aes Cycles:10 Average:102.10 Median:98.50 stddev:13.24 (13.4%) stddev-sans-first:13.02 08:53:37 INFO - PROCESS | 1700 | Values: 88.0 81.0 116.0 109.0 110.0 85.0 113.0 113.0 110.0 96.0 08:53:37 INFO - PROCESS | 1700 | 08:53:37 INFO - PROCESS | 1700 | [#11] stanford-crypto-ccm Cycles:10 Average:163.00 Median:161.50 stddev:16.00 (9.9%) stddev-sans-first:16.93 08:53:37 INFO - PROCESS | 1700 | Values: 160.0 153.0 163.0 168.0 152.0 158.0 153.0 151.0 205.0 167.0 08:53:37 INFO - PROCESS | 1700 | 08:53:37 INFO - PROCESS | 1700 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:204.70 Median:203.00 stddev:27.03 (13.3%) stddev-sans-first:26.75 08:53:37 INFO - PROCESS | 1700 | Values: 177.0 179.0 204.0 244.0 194.0 244.0 202.0 235.0 193.0 175.0 08:53:37 INFO - PROCESS | 1700 | 08:53:37 INFO - PROCESS | 1700 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:1.17 (1.7%) stddev-sans-first:1.13 08:53:37 INFO - PROCESS | 1700 | Values: 68.0 68.0 70.0 69.0 71.0 69.0 70.0 70.0 71.0 68.0 08:53:37 INFO - PROCESS | 1700 | -------- Summary: end -------- 08:53:37 INFO - PROCESS | 1700 | 08:53:38 INFO - TEST-INFO | 1700: exit 0 08:53:39 INFO - TEST-OK | kraken | took 62560ms 08:53:39 INFO - SUITE-END | took 1180s 08:53:39 INFO - Completed test suite (00:19:40) 08:53:39 INFO - javascript benchmark 08:53:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7081.072941195137, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3419.316136772645, 3431.4166591679414, 3443.9139021524475, 3447.2416068464945, 3456.084137703509, 4616.469106052805, 4848.321235027091, 5539.25220095287, 5714.628549144302, 5796.623219490735, 4627.444706635209, 5552.333719953601, 5695.658260504372, 5743.5118014968675, 5816.563757718178, 4066.0, 4222.894427639303, 4426.269665505204, 5044.697318160904, 5368.409474957752, 5130.230465430197, 5276.419593844674, 5376.0054389937795, 5376.623636345457, 5387.164989426645, 5123.795048198068, 5150.716710580917, 5291.841244762663, 5297.761600727938, 5316.893662126755, 5162.845114646567, 5210.687358758487, 5279.049771041211, 5328.6802791832615, 5351.438098999588, 5201.609879259071, 5213.400458947193, 5224.791008359661, 5239.921401178985, 5269.55208807248, 5143.537081662631, 5616.129499927518, 5752.453516915886, 5803.738831752581, 5804.419558044204, 6119.593952096689, 6123.740204357149, 6132.754689812402, 6171.352008039181, 6206.286277078104, 6234.096056071844, 6260.718267677966, 6265.122882796412, 6266.0, 6296.622202667854, 5913.965056115163, 5915.526757859361, 5921.61509501881, 5927.992241318986, 5947.524198064145, 6180.47465965389, 6233.657148856766, 6293.748250069946, 6311.589746666452, 6417.262014868256, 4821.7589120543835, 6089.2997305310455, 6117.705611546597, 6233.345498722569, 6257.374262573706, 6116.418940200674, 6262.373762623793, 6271.655058971709, 6296.338884417162, 6296.961001434712, 6102.3983636914, 6145.139680444741, 6152.384761523812, 6171.537134714914, 6208.0, 5091.872703182376, 6191.102290167901, 6227.532935029801, 6227.564070515111, 6258.15514905491, 4824.758762061883, 4909.754512274372, 4918.286848406961, 5001.874953126201, 5018.04657115147, 3402.880899168567, 3960.485136932238, 3999.680025597945, 4142.0, 4167.729097608646, 5181.222816577543, 5747.885042299131, 6015.518758499397, 6053.4854537363935, 6099.512039036867, 6223.937760622426, 6271.0, 6271.0, 6294.0558916162945, 6300.527460440485, 5989.951758442256, 6012.549058820606, 6036.245469316335, 6037.215162028908, 6042.516598672096, 5363.731813409314, 5410.864728381744, 5417.4040855506655, 5425.186222066722, 5443.782248710087, 5660.839527896771, 6256.499480041677, 6475.034515638854, 6501.187351581052, 6524.67376631157, 6240.251169859646, 6251.374862513712, 6278.340774218641, 6284.277308109443, 6325.430711236011, 5404.243405923095, 6249.218847644044, 6326.620402775664, 6376.426121649074, 6394.136791533084, 6218.906716399167, 6250.781222657185, 6258.249010118815, 6281.560290779602, 6292.150559674568, 4743.312219728051, 5855.770288239518, 6261.5616906816085, 6273.686315684106, 6275.623462592259, 6009.489193418608, 6041.939580604314, 6096.420840020191, 6224.221972253468, 6231.189945307081, 6103.5195042504665, 6113.202667687911, 6126.2123341605975, 6136.764169924414, 6142.447179753844, 5991.910121348096, 6073.423024812636, 6119.388061193845, 6127.571070025056, 6133.969330153321, 6028.457438830526, 6085.1785009023215, 6122.081687746873, 6124.106319906264, 6129.724162412613, 5978.312494063239, 6037.849053773691, 6104.125697713769, 6104.519788040365, 6128.503123582287], "value": 5655.848816561507, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.9603933665636, 490.87728067983005, 492.23948998796857, 528.8836455979686, 530.4721801807202, 29994.250143746416, 35184.82407587962, 36773.816130919375, 36839.4474082889, 36895.0, 39206.0, 39582.20835583287, 39589.010274743145, 39774.60225397745, 39776.602233977654, 7738.458307918448, 8212.34301255898, 9340.813183736322, 9340.859887101698, 9398.060193980582, 8324.583770811465, 8993.64025438985, 10799.622013229538, 11035.44822758859, 11049.668509944715, 9132.452052876848, 9326.813463730721, 11059.557617695282, 11075.833862492029, 11101.777964440706, 10977.506012229469, 11020.50407731654, 11034.172437067253, 11087.83368249477, 11112.722181945475, 9424.198943089777, 11004.889951100467, 11099.334039957628, 11103.611373601885, 11115.666530004113, 37594.0, 37956.43065354022, 37994.62005379939, 38071.04822379435, 38093.23813523714, 3186.410514054884, 3290.9835450822593, 3359.177001634615, 3486.546748922624, 3543.875964341236, 23359.649605255763, 28485.430291394056, 28828.990985315624, 29256.75777012321, 29383.853080734458, 3066.647335556417, 3267.967320326814, 3270.836458177105, 3284.0640417480904, 3318.0543545089777, 482936.0, 488663.0, 491349.0, 491619.0, 494837.5258123722, 52900.73549632304, 57228.71385643045, 57839.710801445726, 57971.420285797445, 58160.12759808606, 59894.401055988885, 60123.0, 60409.39590604038, 60436.09345859816, 60458.95410458919, 14880.181590012653, 15301.540953771404, 15322.923385383225, 15386.538403847679, 15457.613559661098, 10747.516361763583, 11953.40232988347, 12013.579524716593, 12047.216930899463, 12065.577704780466, 13084.476620935246, 14205.0, 15850.286737096858, 16267.837321626632, 16424.1787910604, 5546.944530554723, 6542.1168142300185, 6593.769218077345, 6655.0, 6678.365555272241, 860.9741707748777, 885.6900084970209, 909.9636014559344, 937.8265020971143, 967.3663750243602, 23285.282607618632, 24306.149284775303, 24751.0, 29322.853385732935, 29354.412911741645, 955.9713208603753, 971.6162115964155, 1032.932859364139, 1090.5855774805523, 1239.7706424311532, 11062.446877656084, 12823.807642885364, 12998.350082495837, 14955.551333460013, 15508.922455387876, 556493.0, 614604.0, 616741.0, 621974.0, 625957.0, 47709.284360734615, 53918.46081539213, 53969.0, 54004.18993715097, 54117.0, 1305.1907817153426, 1341.3427420563853, 1346.4479563378968, 1346.8181795457683, 1348.5010546098006, 23881.88059059763, 27734.029308974088, 28509.289442633508, 28944.56583151212, 29053.854730726212, 46687.0, 47251.76374118107, 47310.0, 47349.81625459391, 47459.52540474551, 389120.0543997262, 390980.0, 391805.0, 391947.0, 391980.0, 32286.515702264016, 32754.0, 37754.43368349532, 37837.43243851289, 39056.828295151194, 35509.82245088758, 40376.0, 42175.57824421839, 43089.7845510783, 45948.0, 28770.712292876804, 36120.0, 36187.638123618424, 37114.628853712195, 37252.39202872886, 27444.862775685993, 30755.538666919565, 30961.225969350948, 36461.635383646884, 36534.63465365312, 28949.7105028947, 35697.75057872962, 35776.46335305025, 35984.0, 36196.638033619325, 23388.0, 31087.68912310848, 31789.0, 32564.534595942765, 32874.67125328716, 19245.32641357602, 24122.15572455026, 24183.51632967366, 25078.37304067413, 25129.24612261635], "value": 18841.147627449136, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.59895924370375, 365.4554713476919, 369.4273875492987, 383.0462149248372, 399.59041981968477, 18947.242110315587, 19602.31391901284, 19638.803611963893, 20249.99999999998, 20470.89764551175, 19566.413007609757, 19854.571605505498, 19912.70130948037, 20077.59844803103, 20237.392878213675, 4694.530546945312, 5081.59347252219, 5658.547316214704, 5940.3762604926505, 5942.2869255689375, 5827.426594819396, 6013.72938217779, 6018.15745795589, 6029.849253768669, 6030.728617212214, 5620.409856965021, 5678.46054624812, 5751.7986870459545, 5923.970380148093, 5953.761849526014, 5766.279215098113, 5821.767129314822, 5821.912671309934, 5828.679422631753, 5838.21184140142, 5071.594272458195, 5105.591552675777, 5351.839444816662, 5399.676019438807, 5420.159875219348, 12439.75120497594, 12681.682957926125, 12787.424565894464, 12960.092793504458, 12982.09125361225, 2031.817136457711, 2367.4791545859885, 2560.5519034169133, 2871.6554013518303, 2883.855807209631, 9687.612495500172, 9781.266405019653, 9827.852582211273, 10334.948325258401, 10453.21600879937, 1844.437446578793, 1875.962480750391, 1892.5930924851086, 1934.2939826963197, 1962.9901850490799, 104471.4776426113, 106823.2611858589, 117239.82760172374, 117396.0, 121296.0, 8300.626471808662, 8495.447795893371, 11323.490442930088, 11419.257748246337, 11792.88207117935, 11807.468663910146, 14460.783088253685, 14464.349104290122, 14477.493287734878, 14533.636659083397, 7387.596356692211, 7806.141324454419, 8003.0, 8251.422400431911, 8262.462939909006, 6482.967585162139, 6653.700583473658, 8018.51888886657, 8181.181881811771, 8215.548144852091, 4389.582989615981, 4485.102979404132, 4521.773911304422, 4584.564466375689, 4604.401427814362, 1687.767929411512, 1901.8668693191344, 1908.7900330963582, 1951.5023668964322, 1987.5726718755536, 826.6321486938255, 857.1985193843776, 890.0787684746257, 914.881065461499, 1000.6797824696027, 18484.630307393778, 19741.703874441893, 20324.0, 20668.48328791762, 20749.481262968548, 880.6213328268906, 881.3081730841387, 900.617237673986, 903.385697725553, 932.4451951089227, 8616.0, 10606.0, 11111.666650000512, 11125.666230013112, 11154.498047587878, 535943.0, 551241.0, 556781.0, 558783.206083967, 559982.0, 96431.0, 126816.29326680322, 135104.0, 135893.0, 137565.0, 952.514217748953, 975.3952549419264, 979.7893452907516, 996.138340335619, 996.2378780233128, 18365.63268734591, 18832.62334753325, 18882.0, 18914.621707565497, 18925.43223703291, 54225.45774542204, 54773.45226547843, 54959.900801984535, 55193.44806552044, 55600.0, 53699.46300536945, 76125.0, 76879.0, 78077.60961195157, 79200.60399698195, 7954.323882470055, 8124.390670699603, 8145.755627331189, 8231.218034286732, 8418.747437576883, 10997.0, 11766.941165294118, 12258.957988571072, 12789.74420511566, 13117.803232951705, 10984.835227471754, 11186.049185819296, 11221.326720396803, 11438.542458301576, 11504.597339093092, 10960.835587466354, 11034.668959931216, 11121.29423015624, 11347.319160850375, 11506.252093613888, 11105.278156919774, 11216.439178041228, 11317.434128293717, 11400.087992960378, 11439.199256051996, 6133.9079913802225, 7750.844983100419, 8133.511989280662, 8149.388795840217, 8198.631061602362, 8223.383246256435, 8445.957770211355, 10641.521131548943, 11332.433378331216, 11541.0], "value": 9154.729157368396, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.6029191242628, 1443.6463066548695, 1626.4226199699106, 1765.2409463930505, 1809.5295223241953, 7504.96247518763, 7712.57580833054, 7955.124936257014, 8400.41197116202, 8416.579171041454, 6809.761658341959, 7600.315971562558, 7871.960640196791, 7875.212478752122, 7961.840763184733, 2229.5317983223545, 2263.4228271790753, 2280.2019293247395, 2281.041962375806, 2284.8971796269207, 2245.2253972379585, 2270.137347807831, 2277.032261288954, 2282.669012993115, 2303.3205204464725, 2253.3803204118835, 2260.400993736661, 2273.5111950930545, 2281.304202218331, 2289.095807156172, 2155.655095184763, 2230.698855654482, 2246.213825161197, 2261.185973049717, 2263.479399738061, 2038.2967876082728, 2111.6199084164846, 2276.3512398966213, 2278.5898538263104, 2282.805961493275, 8111.269985701315, 8290.378221633342, 8311.584420778936, 8315.459495132796, 8339.666413343459, 4972.776225069844, 5121.590272778206, 5136.255242989783, 5146.562542183919, 5153.381594208681, 3155.5266709993457, 3234.628017777962, 3470.861165553375, 3473.3400653875938, 3479.251960828434, 1017.3336464615688, 1060.3584831177182, 1065.0680654427376, 1075.8977897099762, 1078.9730256743567, 10319.84520232197, 10662.520186591544, 10672.839907401396, 10680.038796508352, 10682.0, 3722.6277372262557, 3987.843525377666, 4191.434156388848, 4241.681873859473, 4376.934345984812, 7293.70825166998, 8271.875921861178, 8339.166083391612, 8356.623951922178, 8364.456310339809, 4963.90072198554, 4968.0, 4978.850634480971, 4988.850334489898, 4998.375203099613, 4248.808803603783, 4426.800793964279, 4657.8602641920115, 4694.990577025956, 4698.929516057262, 3200.5999250093737, 3481.89554313371, 3570.839312230956, 3618.4753210784816, 3726.2733766915735, 970.5777986575862, 1128.915331350152, 1141.1099342512853, 1149.413798962535, 1152.504423098059, 745.6271864067966, 792.9365650747926, 844.3667249562828, 873.1661263493348, 892.0767006148606, 4507.301368287921, 5082.974585127051, 5089.9056702809075, 5281.494773989394, 5321.308229930084, 705.5272967112047, 902.9390466202186, 911.2618778789202, 929.6467342409976, 961.3895176562933, 3592.425211966125, 3603.4234522476277, 3617.366960781905, 3695.611960744137, 3771.8868433947027, 8887.466751994902, 9945.453000085065, 9952.552135153936, 9970.850437243447, 10005.399676019317, 9798.853017204749, 9904.65333713331, 9931.751706207258, 9951.25365597583, 9956.352837065713, 7564.054493188351, 7732.226777322336, 7733.961330193313, 7734.2265773422205, 7737.651805668758, 5247.947520524898, 5430.104032834538, 5514.751836167302, 5531.751071201886, 5547.084731019337, 7384.37232835215, 8866.290696744374, 9319.16127548524, 9356.672516461891, 9373.859392108987, 9223.723288301362, 9274.0, 9296.581653825458, 9335.019822918495, 9429.481378523973, 6463.806085817433, 6672.5329226953645, 6686.197656281277, 6824.283450237654, 6852.486063545353, 7589.279018493235, 7788.649510772142, 7794.961025194838, 7800.492967957065, 7815.921840781747, 6857.417119544894, 6992.300769922967, 7022.297770222936, 7055.0, 7121.715131394686, 5753.280839895013, 6793.150856142982, 6836.0, 6839.93160068393, 6866.588004719732, 6361.968190159019, 6501.057346684799, 6533.901991470037, 6611.305812889577, 6645.966770166118, 4650.744209068534, 4718.575328220477, 4754.881127971828, 4758.310045043519, 4865.683730557503, 3912.6478616923473, 4262.509811371732, 4791.161546729239, 4838.225883858566, 4970.850874473772], "value": 4246.467160093266, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [242.47141232113995, 245.91147187012683, 278.94141732126576, 302.2338372226406, 311.6400557356254, 4515.435570553681, 5074.644774865761, 5318.6808791472495, 5422.186671999197, 5579.609427340088, 3964.751103402426, 4749.667523273372, 5251.763670634821, 5433.402325744165, 5450.700211488366, 3770.7360484766077, 4187.811548480326, 4195.454590903194, 4199.91600167998, 4206.390073439349, 3210.9357812843728, 3650.0, 3987.2424239394422, 4096.508418989725, 4248.97875510622, 4152.8961775955695, 4189.099343641116, 4191.203671302458, 4194.937075943848, 4220.767857767822, 3109.7978631388887, 4161.812718427678, 4178.707490475668, 4183.372494125875, 4214.620684138442, 3676.356637588411, 3684.8341824617687, 3685.5761587417524, 3696.6488183622514, 3702.8889133326043, 5199.53204211619, 5279.656822306538, 5290.867728306785, 5323.699306430038, 5366.195070739382, 3782.508273924372, 4708.4820669726305, 4786.545278198566, 4815.783289751969, 4845.224764037773, 5224.373075230958, 5263.447283051509, 5358.526405238591, 5788.594798364116, 5820.650760954356, 3501.441858373025, 3807.923841523154, 4002.6597739192202, 4021.7586944783407, 4050.825260674401, 5091.694498330112, 5094.974525127351, 5284.947150528523, 6007.017684164215, 6114.755409783604, 3648.21563363878, 3948.802559871995, 4094.25993952569, 4094.7478886612244, 4117.75293482392, 3735.58908520068, 3826.827792749333, 4021.7989100544855, 4101.507819061731, 4119.186291888261, 4772.689775164603, 4791.0, 4791.47293797682, 4798.7283369907, 4827.468978412372, 5056.974715126401, 5341.332333458317, 5821.88356232873, 5831.825045248649, 5876.647401155944, 1107.8061339265757, 1194.1879521925175, 1222.541546919905, 1300.694336830844, 1357.2128165663892, 906.759708677201, 932.9597498788802, 935.8676002037474, 937.3813283233034, 943.7401069572061, 4406.977965110218, 5168.304662166569, 5177.352830896138, 5196.870078247998, 5205.427402985669, 4556.997460558672, 5637.661740295595, 5642.4075472075665, 5653.71024734983, 5659.349174844946, 4716.95283047172, 5156.948430515722, 5170.327857378592, 5178.922316165185, 5192.844214673566, 2272.7272727272834, 2702.648675662169, 2809.4942910276345, 2954.3795802881637, 2959.682941091237, 5330.573554115662, 5493.423190565013, 5547.613096725819, 5811.709414529341, 5883.705814709333, 5240.68555886648, 5436.809711660073, 5552.889901837276, 6117.296510901303, 6183.5671502994355, 5836.737346819488, 6336.968315158395, 6348.333424990402, 6353.968230158912, 6362.522810789209, 5045.823396181116, 5509.421510741315, 5624.915626265692, 6085.421884920926, 6096.847578810565, 5090.0, 5214.400343960493, 5459.563234941115, 5945.316288626863, 5953.374895636069, 5334.279872217201, 5511.944880551304, 6238.781642642486, 6268.4671802897265, 6307.463865571478, 3010.5785190073843, 3252.593425821772, 3666.596674365871, 3951.0, 3997.0, 5758.913616295843, 5822.359540450462, 5852.590318677651, 5931.4068593142065, 5933.970330148321, 5145.716985565829, 5659.585103724069, 5781.682007489629, 5807.622504537191, 5855.590108692521, 5031.842676184571, 5233.528982391603, 5416.620836541404, 5627.774889004558, 5764.394738552392, 5407.918881216706, 5621.606487545832, 5637.8590535236945, 5680.943190568207, 5720.856978575569, 5633.802816901389, 5771.68255745938, 5850.678212698343, 5864.296284445893, 5899.705014749331, 5389.21856330822, 5716.9428305718075, 5721.399253078367, 5746.0639461968685, 5766.8846623066465], "value": 4138.660680255976, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.9618628017782, 682.8975653651949, 708.0547469128713, 742.9331360177583, 796.2117503671366, 14818.703625927488, 15178.0, 15542.378304867805, 15726.326524490836, 15746.84253157471, 14075.0, 14330.570082897504, 14354.78467822981, 14363.784543231859, 14372.0, 641.9325970773072, 662.6388618203067, 667.6594936582354, 808.9878651820227, 812.2892469089546, 819.8237378963522, 834.9707760228393, 835.0355339582761, 835.4653022065883, 836.4061516323418, 735.7719107076797, 874.0822136756412, 876.0932434929849, 876.8816209811657, 878.1920633017639, 683.4225079807554, 808.9595520223966, 811.8498077855616, 870.1863757386864, 873.1574031060026, 647.1102234427661, 647.5596594315863, 648.6853875870199, 649.1009951217551, 651.2152855808739, 14992.850071499364, 14994.400223991028, 15310.234488275542, 15416.229188540528, 15416.22918854064, 14419.206943618097, 14499.565013049625, 14605.92697036508, 14835.48075817352, 14877.776833347509, 11277.548898044068, 11415.086793056618, 11813.645590632295, 12062.336571488564, 12127.575534856238, 3698.7041036716996, 3712.9443058354145, 3713.9071523211865, 3743.6256374362347, 3872.419137129425, 90510.09489905149, 103014.48492757489, 120275.0, 121397.0, 124786.37606812, 11029.944850275697, 11068.3912384818, 11113.388763618079, 11309.925557072065, 11405.771884562262, 23060.423489412562, 23146.7685323148, 23224.53550928972, 23554.411139721644, 23661.645075323882, 6687.933120668731, 7203.89194162088, 7546.811329716801, 7931.405144614062, 8115.310198633182, 4150.605692459211, 4299.419578356944, 4331.978340108342, 4347.369631403492, 4531.818727250873, 3398.7281017519035, 3497.169147174605, 3509.8596056157467, 3531.7527773056154, 3532.5584301962253, 567.9034564124026, 616.5807251069316, 620.1194304088206, 621.5369549685513, 644.9613023218621, 570.785955266775, 632.4181752787355, 641.1376698340724, 656.6079910589581, 675.6621689155422, 9261.953690231505, 9289.628414863464, 9356.667047503543, 9363.812723745623, 9672.115675960182, 498.0243047789501, 632.7121159872247, 636.9426751592431, 667.366002297819, 668.211510417702, 4372.256716358227, 4523.886902827456, 4562.08758248345, 4613.515580864028, 4726.527347265246, 106048.93951060544, 106371.0, 106521.0, 107429.0, 107546.0, 71188.64405677939, 74076.62961685157, 75649.62175189088, 75686.62156689182, 98708.50645746868, 66664.33335666679, 71366.286337137, 73531.63234183795, 75094.24905750982, 76863.84704229441, 8217.424780265324, 8499.872501912352, 9385.38994965325, 9439.669611563837, 9851.45816980073, 38733.8379848605, 47987.441193086604, 48619.27071094007, 50610.0, 54545.0, 66111.0, 66749.33250667431, 66947.66526167338, 68556.28609284808, 70573.29426705667, 10748.677539673823, 13178.868211317764, 13342.19946803195, 13380.732385352434, 13685.247311397969, 14738.63153421173, 14999.400023999355, 15018.200418137829, 15124.632011636939, 15938.123403212934, 11106.833397499206, 13346.265955372548, 13475.32623368808, 13858.099223550436, 13937.651558711113, 13647.11293765902, 13919.582412527641, 13926.58220253394, 14425.49510767118, 14448.277586120863, 13463.663408414868, 13539.255340956342, 13592.79610805819, 13703.794443083561, 14158.929205353907, 11341.4896329667, 11390.316581005167, 11460.484278207667, 11585.304881707125, 11900.702482438008, 8948.418352807046, 8969.327300452362, 11359.169681017705, 11569.19015668895, 11677.124215683687], "value": 7352.0867087231145, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1599.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 117.0, 119.0, 116.0, 118.0, 119.0, 118.0, 118.0, 118.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 117.0, 156.0, 114.0, 116.0, 117.0, 116.0, 139.0, 119.0], "value": 126.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [207.0, 211.0, 223.0, 195.0, 197.0, 224.0, 281.0, 201.0, 195.0, 193.0], "value": 212.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 58.0, 60.0, 83.0, 61.0, 61.0, 61.0, 66.0, 93.0, 83.0], "value": 71.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 77.0, 116.0, 104.0, 70.0, 72.0, 82.0, 70.0, 73.0, 88.0], "value": 84.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 74.0, 85.0, 133.0, 138.0, 87.0, 93.0, 125.0, 90.0, 88.0], "value": 105.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 126.0, 96.0, 96.0, 97.0, 106.0, 96.0, 95.0, 97.0, 97.0], "value": 100.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 92.0, 93.0, 94.0, 92.0, 83.0, 148.0, 149.0, 114.0], "value": 108.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 59.0, 57.0, 59.0, 59.0, 59.0, 56.0, 68.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 76.0, 86.0, 75.0, 73.0, 74.0, 103.0, 61.0, 83.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 81.0, 116.0, 109.0, 110.0, 85.0, 113.0, 113.0, 110.0, 96.0], "value": 102.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 153.0, 163.0, 168.0, 152.0, 158.0, 153.0, 151.0, 205.0, 167.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 179.0, 204.0, 244.0, 194.0, 244.0, 202.0, 235.0, 193.0, 175.0], "value": 204.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 70.0, 69.0, 71.0, 69.0, 70.0, 70.0, 71.0, 68.0], "value": 69.4, "unit": "score"}]}]} 08:53:39 INFO - Return code: 0 08:53:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:53:39 ERROR - # TBPL SUCCESS # 08:53:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:53:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:53:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:53:39 INFO - 2016-12-06 08:53:39.670 screenresolution[1705:22034] starting screenresolution argv=screenresolution get 08:53:39 INFO - 2016-12-06 08:53:39.673 screenresolution[1705:22034] Display 0: 1600x1200x32@60 08:53:39 INFO - 2016-12-06 08:53:39.679 screenresolution[1706:22038] starting screenresolution argv=screenresolution list 08:53:39 INFO - Available Modes on Display 0 08:53:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:53:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:53:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:53:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:53:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:53:39 INFO - Intel Iris: 08:53:39 INFO - Chipset Model: Intel Iris 08:53:39 INFO - Type: GPU 08:53:39 INFO - Bus: Built-In 08:53:39 INFO - VRAM (Dynamic, Max): 1536 MB 08:53:39 INFO - Vendor: Intel (0x8086) 08:53:39 INFO - Device ID: 0x0a2e 08:53:39 INFO - Revision ID: 0x0009 08:53:39 INFO - Displays: 08:53:39 INFO - Display: 08:53:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:53:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:53:39 INFO - Display Serial Number: 1600x1200 60 08:53:39 INFO - Main Display: Yes 08:53:39 INFO - Mirror: Off 08:53:39 INFO - Online: Yes 08:53:39 INFO - Rotation: Supported 08:53:39 INFO - Return code: 0 08:53:39 INFO - Running post-action listener: _resource_record_post_action 08:53:39 INFO - [mozharness: 2016-12-06 16:53:39.914697Z] Finished run-tests step (success) 08:53:39 INFO - Running post-run listener: _resource_record_post_run 08:53:39 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 34247168; Write bytes: 700110848; Read time: 318; Write time: 2140 08:53:39 INFO - TinderboxPrint: CPU usage
54.4% 08:53:39 INFO - TinderboxPrint: I/O read bytes / time
34,247,168 / 318 08:53:39 INFO - TinderboxPrint: I/O write bytes / time
700,110,848 / 2,140 08:53:39 INFO - TinderboxPrint: CPU idle
2,214.3 (45.6%) 08:53:39 INFO - TinderboxPrint: CPU system
984.6 (20.3%) 08:53:39 INFO - TinderboxPrint: CPU user
1,658.8 (34.1%) 08:53:39 INFO - TinderboxPrint: Swap in / out
414,162,944 / 0 08:53:39 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 367567360; Write bytes: 367951360; Read time: 27652; Write time: 704 08:53:39 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 33305088; Write bytes: 313678336; Read time: 303; Write time: 1397 08:53:40 INFO - Running post-run listener: _upload_blobber_files 08:53:40 INFO - Blob upload gear active. 08:53:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:53:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:53:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:53:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:53:40 INFO - (blobuploader) - INFO - Open directory for files ... 08:53:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:53:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:53:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:41 INFO - (blobuploader) - INFO - Done attempting. 08:53:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:53:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:53:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:43 INFO - (blobuploader) - INFO - Done attempting. 08:53:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:53:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:53:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:45 INFO - (blobuploader) - INFO - Done attempting. 08:53:45 INFO - (blobuploader) - INFO - Iteration through files over. 08:53:45 INFO - Return code: 0 08:53:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:53:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:53:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5e1099f9efdbd456f271c81b9e09bb5c28817da6d485535b694ed434775d6bd3ead7c34277f86e5883a2556166d2b663dcafdbcf5d08b94d16268cd787a952e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1df789a8906a79a6b19ad1e34d9872375c489c5836f98721a9bdd4e527b4361feffe4077e2f38d5e5b020bfb47c107178fa61b87e7657078f4abf55e8478c224", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e29d5fdfa33d808c47b49b12e88225a27c146ea48f3215ce5723714891569696b47d7940c8a3d7391da10f4c6067409e57df3334dfd05d7df8d735abfef379a7"} 08:53:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:53:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:53:45 INFO - Contents: 08:53:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5e1099f9efdbd456f271c81b9e09bb5c28817da6d485535b694ed434775d6bd3ead7c34277f86e5883a2556166d2b663dcafdbcf5d08b94d16268cd787a952e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1df789a8906a79a6b19ad1e34d9872375c489c5836f98721a9bdd4e527b4361feffe4077e2f38d5e5b020bfb47c107178fa61b87e7657078f4abf55e8478c224", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e29d5fdfa33d808c47b49b12e88225a27c146ea48f3215ce5723714891569696b47d7940c8a3d7391da10f4c6067409e57df3334dfd05d7df8d735abfef379a7"} 08:53:45 INFO - Running post-run listener: copy_logs_to_upload_dir 08:53:45 INFO - Copying logs to upload dir... 08:53:45 INFO - mkdir: /builds/slave/test/build/upload/logs 08:53:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.620138 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-12-06 08:53:45.625651) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-06 08:53:45.629524) ========= 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.rrg30T7AGk/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.bcOclImMO5/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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/a5e1099f9efdbd456f271c81b9e09bb5c28817da6d485535b694ed434775d6bd3ead7c34277f86e5883a2556166d2b663dcafdbcf5d08b94d16268cd787a952e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1df789a8906a79a6b19ad1e34d9872375c489c5836f98721a9bdd4e527b4361feffe4077e2f38d5e5b020bfb47c107178fa61b87e7657078f4abf55e8478c224", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e29d5fdfa33d808c47b49b12e88225a27c146ea48f3215ce5723714891569696b47d7940c8a3d7391da10f4c6067409e57df3334dfd05d7df8d735abfef379a7"} build_url:https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011061 build_url: 'https://queue.taskcluster.net/v1/task/I7Z98e_4TNmTfyLW-ims-g/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a5e1099f9efdbd456f271c81b9e09bb5c28817da6d485535b694ed434775d6bd3ead7c34277f86e5883a2556166d2b663dcafdbcf5d08b94d16268cd787a952e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1df789a8906a79a6b19ad1e34d9872375c489c5836f98721a9bdd4e527b4361feffe4077e2f38d5e5b020bfb47c107178fa61b87e7657078f4abf55e8478c224", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e29d5fdfa33d808c47b49b12e88225a27c146ea48f3215ce5723714891569696b47d7940c8a3d7391da10f4c6067409e57df3334dfd05d7df8d735abfef379a7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-06 08:53:45.664792) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 08:53:45.665285) ========= 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.rrg30T7AGk/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.bcOclImMO5/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.005133 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-06 08:53:45.714081) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-06 08:53:45.714407) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-06 08:53:45.714841) ========= ========= Total master_lag: 0.22 =========