builder: jamun_yosemite_r7_devedition_test-dromaeojs-e10s slave: t-yosemite-r7-0311 starttime: 1495173126.09 results: success (0) buildid: 20170518061119 builduid: 7a1e5b2e212645c49a2690d1f92c8b9f revision: 9cee0e8b00d28d7e977df6ee3e1adc9680004b8d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-18 22:52:06.091168) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-18 22:52:06.091663) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-18 22:52:06.091949) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-18 22:52:06.117800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 22:52:06.118247) ========= 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.VuyA1WMKVP/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.VvqF7uaUWp/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-18 22:52:06-- 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% 151M=0s 2017-05-18 22:52:06 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.167133 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 22:52:06.308933) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 22:52:06.309308) ========= 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.VuyA1WMKVP/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.VvqF7uaUWp/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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.026391 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 22:52:06.359143) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-18 22:52:06.359630) ========= bash -c 'python archiver_client.py mozharness --repo projects/jamun --rev 9cee0e8b00d28d7e977df6ee3e1adc9680004b8d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/jamun --rev 9cee0e8b00d28d7e977df6ee3e1adc9680004b8d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VuyA1WMKVP/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.VvqF7uaUWp/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-18 22:52:06,453 truncating revision to first 12 chars 2017-05-18 22:52:06,453 Setting DEBUG logging. 2017-05-18 22:52:06,454 attempt 1/10 2017-05-18 22:52:06,454 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/jamun/9cee0e8b00d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-18 22:52:07,539 unpacking tar archive at: jamun-9cee0e8b00d2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.365331 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-18 22:52:07.747439) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-18 22:52:07.747791) ========= script_repo_revision: 9cee0e8b00d28d7e977df6ee3e1adc9680004b8d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-18 22:52:07.748203) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-18 22:52:07.748481) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-18 22:52:07.767200) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 41 mins, 22 secs) (at 2017-05-18 22:52:07.767579) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Jamun --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Jamun 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', 'Jamun', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Jamun'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VuyA1WMKVP/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.VvqF7uaUWp/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 22:52:07 INFO - MultiFileLogger online at 20170518 22:52:07 in /builds/slave/test 22:52:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Jamun --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Jamun 22:52:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:52:07 INFO - {'append_to_log': False, 22:52:07 INFO - 'base_work_dir': '/builds/slave/test', 22:52:07 INFO - 'blob_upload_branch': 'Jamun', 22:52:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:52:07 INFO - 'branch': 'Jamun', 22:52:07 INFO - 'buildbot_json_path': 'buildprops.json', 22:52:07 INFO - 'config_files': ('talos/mac_config.py',), 22:52:07 INFO - 'default_actions': ('clobber', 22:52:07 INFO - 'read-buildbot-config', 22:52:07 INFO - 'download-and-extract', 22:52:07 INFO - 'populate-webroot', 22:52:07 INFO - 'create-virtualenv', 22:52:07 INFO - 'install', 22:52:07 INFO - 'run-tests'), 22:52:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:52:07 INFO - 'download_minidump_stackwalk': True, 22:52:07 INFO - 'download_symbols': 'ondemand', 22:52:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:52:07 INFO - 'tooltool.py': '/tools/tooltool.py', 22:52:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:52:07 INFO - '/tools/misc-python/virtualenv.py')}, 22:52:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:52:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:52:07 INFO - 'gecko_profile': False, 22:52:07 INFO - 'gecko_profile_interval': 0, 22:52:07 INFO - 'installer_path': 'installer.exe', 22:52:07 INFO - 'log_level': 'info', 22:52:07 INFO - 'log_name': 'talos', 22:52:07 INFO - 'log_to_console': True, 22:52:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 22:52:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 22:52:07 INFO - 'opt_config_files': (), 22:52:07 INFO - 'pip_index': False, 22:52:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:52:07 INFO - 'cmd': ('bash', 22:52:07 INFO - '-c', 22:52:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:52:07 INFO - 'enabled': True, 22:52:07 INFO - 'halt_on_failure': False, 22:52:07 INFO - 'name': 'check_screen_resolution'},), 22:52:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 22:52:07 INFO - 'cmd': ('bash', 22:52:07 INFO - '-c', 22:52:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 22:52:07 INFO - 'enabled': True, 22:52:07 INFO - 'halt_on_failure': False, 22:52:07 INFO - 'name': 'check_screen_resolution'},), 22:52:07 INFO - 'run_cmd_checks_enabled': True, 22:52:07 INFO - 'suite': 'dromaeojs-e10s', 22:52:07 INFO - 'system_bits': '32', 22:52:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:52:07 INFO - 'title': 't-yosemite-r7-0311', 22:52:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:52:07 INFO - 'use_talos_json': True, 22:52:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:52:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:52:07 INFO - 'work_dir': 'build'} 22:52:07 INFO - [mozharness: 2017-05-19 05:52:07.964528Z] Running clobber step. 22:52:07 INFO - Running pre-action listener: _resource_record_pre_action 22:52:07 INFO - Running main action method: clobber 22:52:07 INFO - rmtree: /builds/slave/test/build 22:52:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:52:10 INFO - Running post-action listener: _resource_record_post_action 22:52:10 INFO - [mozharness: 2017-05-19 05:52:10.409616Z] Finished clobber step (success) 22:52:10 INFO - [mozharness: 2017-05-19 05:52:10.409777Z] Running read-buildbot-config step. 22:52:10 INFO - Running pre-action listener: _resource_record_pre_action 22:52:10 INFO - Running main action method: read_buildbot_config 22:52:10 INFO - Using buildbot properties: 22:52:10 INFO - { 22:52:10 INFO - "project": "", 22:52:10 INFO - "product": "firefox", 22:52:10 INFO - "script_repo_revision": "production", 22:52:10 INFO - "builddir": "jamun_yosemite_r7_devedition_test-dromaeojs-e10s", 22:52:10 INFO - "repository": "", 22:52:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 DevEdition jamun talos dromaeojs-e10s", 22:52:10 INFO - "buildid": "20170518061119", 22:52:10 INFO - "pgo_build": "False", 22:52:10 INFO - "basedir": "/builds/slave/test", 22:52:10 INFO - "buildnumber": 0, 22:52:10 INFO - "slavename": "t-yosemite-r7-0311", 22:52:10 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 22:52:10 INFO - "platform": "yosemite_r7_devedition", 22:52:10 INFO - "scheduler": "tests-jamun-macosx64-devedition-talos", 22:52:10 INFO - "branch": "jamun", 22:52:10 INFO - "repo_path": "projects/jamun", 22:52:10 INFO - "revision": "9cee0e8b00d28d7e977df6ee3e1adc9680004b8d", 22:52:10 INFO - "stage_platform": "macosx64-devedition", 22:52:10 INFO - "builduid": "7a1e5b2e212645c49a2690d1f92c8b9f", 22:52:10 INFO - "slavebuilddir": "test" 22:52:10 INFO - } 22:52:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 22:52:10 INFO - Running post-action listener: _resource_record_post_action 22:52:10 INFO - [mozharness: 2017-05-19 05:52:10.413392Z] Finished read-buildbot-config step (success) 22:52:10 INFO - [mozharness: 2017-05-19 05:52:10.413523Z] Running download-and-extract step. 22:52:10 INFO - Running pre-action listener: _resource_record_pre_action 22:52:10 INFO - Running main action method: download_and_extract 22:52:10 INFO - mkdir: /builds/slave/test/build/tests 22:52:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:52:10 INFO - trying https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 22:52:10 INFO - Downloading https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 22:52:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 22:52:11 INFO - Downloaded 1287 bytes. 22:52:11 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 22:52:11 INFO - Using the following test package requirements: 22:52:11 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 22:52:11 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 22:52:11 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 22:52:11 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 22:52:11 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 22:52:11 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 22:52:11 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 22:52:11 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 22:52:11 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 22:52:11 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 22:52:11 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 22:52:11 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 22:52:11 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 22:52:11 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 22:52:11 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 22:52:11 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 22:52:11 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 22:52:11 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 22:52:11 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 22:52:11 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 22:52:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 22:52:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 22:52:11 INFO - Fetch https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 22:52:13 INFO - Expected file size: 51793955 22:52:13 INFO - Obtained file size: 51793955 22:52:28 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 22:52:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 22:52:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 22:52:28 INFO - Fetch https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 22:52:30 INFO - Expected file size: 51793955 22:52:30 INFO - Obtained file size: 51793955 22:52:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 22:52:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 22:52:45 INFO - Fetch https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 22:52:46 INFO - Expected file size: 14404449 22:52:46 INFO - Obtained file size: 14404449 22:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:52:47 INFO - trying https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 22:52:47 INFO - Downloading https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 22:52:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 22:52:49 INFO - Downloaded 74768418 bytes. 22:52:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 22:52:49 INFO - mkdir: /builds/slave/test/properties 22:52:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:52:49 INFO - Writing to file /builds/slave/test/properties/build_url 22:52:49 INFO - Contents: 22:52:49 INFO - build_url:https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 22:52:50 INFO - Running post-action listener: _resource_record_post_action 22:52:50 INFO - Running post-action listener: set_extra_try_arguments 22:52:50 INFO - [mozharness: 2017-05-19 05:52:50.022084Z] Finished download-and-extract step (success) 22:52:50 INFO - [mozharness: 2017-05-19 05:52:50.022202Z] Running populate-webroot step. 22:52:50 INFO - Running pre-action listener: _resource_record_pre_action 22:52:50 INFO - Running main action method: populate_webroot 22:52:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:52:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:52:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:52:50 INFO - '--tppagecycles', 22:52:50 INFO - '7'], 22:52:50 INFO - 'tests': ['tsvgm']}}, 22:52:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:52:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:52:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:52:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:52:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:52:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:52:50 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:52:50 INFO - 'talos_options': ['--disable-e10s'], 22:52:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:52:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:52:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:52:50 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:52:50 INFO - 'talos_options': ['--disable-e10s'], 22:52:50 INFO - 'tests': ['damp', 'tps']}, 22:52:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:52:50 INFO - 'tests': ['damp', 'tps']}, 22:52:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:52:50 INFO - 'tests': ['dromaeo_dom']}, 22:52:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:52:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:52:50 INFO - 'tests': ['basic_compositor_video']}, 22:52:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:52:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:52:50 INFO - 'tests': ['a11yr', 22:52:50 INFO - 'ts_paint', 22:52:50 INFO - 'tpaint', 22:52:50 INFO - 'sessionrestore', 22:52:50 INFO - 'sessionrestore_no_auto_restore', 22:52:50 INFO - 'tabpaint']}, 22:52:50 INFO - 'other-e10s': {'tests': ['a11yr', 22:52:50 INFO - 'ts_paint', 22:52:50 INFO - 'tpaint', 22:52:50 INFO - 'sessionrestore', 22:52:50 INFO - 'sessionrestore_no_auto_restore', 22:52:50 INFO - 'tabpaint']}, 22:52:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:52:50 INFO - 'ts_paint', 22:52:50 INFO - 'tpaint', 22:52:50 INFO - 'sessionrestore', 22:52:50 INFO - 'sessionrestore_no_auto_restore', 22:52:50 INFO - 'tabpaint']}, 22:52:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:52:50 INFO - 'ts_paint', 22:52:50 INFO - 'tpaint', 22:52:50 INFO - 'sessionrestore', 22:52:50 INFO - 'sessionrestore_no_auto_restore', 22:52:50 INFO - 'tabpaint']}, 22:52:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:52:50 INFO - 'tests': ['a11yr', 22:52:50 INFO - 'ts_paint', 22:52:50 INFO - 'tpaint', 22:52:50 INFO - 'sessionrestore', 22:52:50 INFO - 'sessionrestore_no_auto_restore', 22:52:50 INFO - 'tabpaint']}, 22:52:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:52:50 INFO - 'tests': ['a11yr', 22:52:50 INFO - 'ts_paint', 22:52:50 INFO - 'tpaint', 22:52:50 INFO - 'sessionrestore', 22:52:50 INFO - 'sessionrestore_no_auto_restore', 22:52:50 INFO - 'tabpaint']}, 22:52:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:52:50 INFO - 'tests': ['tsvgx', 22:52:50 INFO - 'tsvgr_opacity', 22:52:50 INFO - 'tart', 22:52:50 INFO - 'tscrollx', 22:52:50 INFO - 'cart', 22:52:50 INFO - 'tsvg_static']}, 22:52:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:52:50 INFO - 'tsvgr_opacity', 22:52:50 INFO - 'tart', 22:52:50 INFO - 'tscrollx', 22:52:50 INFO - 'cart', 22:52:50 INFO - 'tsvg_static']}, 22:52:50 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:52:50 INFO - 'talos_options': ['--disable-e10s'], 22:52:50 INFO - 'tests': ['tp5o']}, 22:52:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:52:50 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:52:50 INFO - 'talos_options': ['--disable-e10s', 22:52:50 INFO - '--xperf_path', 22:52:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:52:50 INFO - 'tests': ['tp5n']}, 22:52:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:52:50 INFO - 'talos_options': ['--xperf_path', 22:52:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:52:50 INFO - 'tests': ['tp5n']}}, 22:52:50 INFO - 'talos.zip': {'path': '', 22:52:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:52:50 INFO - Running post-action listener: _resource_record_post_action 22:52:50 INFO - [mozharness: 2017-05-19 05:52:50.040738Z] Finished populate-webroot step (success) 22:52:50 INFO - [mozharness: 2017-05-19 05:52:50.040848Z] Running create-virtualenv step. 22:52:50 INFO - Running pre-action listener: _resource_record_pre_action 22:52:50 INFO - Running main action method: create_virtualenv 22:52:50 INFO - Creating virtualenv /builds/slave/test/build/venv 22:52:50 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 22:52:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:52:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:52:50 INFO - Using real prefix '/tools/python27' 22:52:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:52:50 INFO - Installing distribute.............................................................................................................................................................................................done. 22:52:53 INFO - Installing pip.................done. 22:52:53 INFO - Return code: 0 22:52:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:52:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:52:53 INFO - Reading from file tmpfile_stdout 22:52:53 INFO - Output received: 22:52:53 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) 22:52:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:52:53 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')]} 22:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:53 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')]} 22:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:54 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 0x101089b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10108c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9939d9a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e67d30>, '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 0x100d8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e5cbe8>, '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.VuyA1WMKVP/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.VvqF7uaUWp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 22:52:54 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 22:52:54 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 22:52:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VuyA1WMKVP/Render', 22:52:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:52:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:52:54 INFO - 'HOME': '/Users/cltbld', 22:52:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:52:54 INFO - 'LOGNAME': 'cltbld', 22:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:54 INFO - 'MOZ_NO_REMOTE': '1', 22:52:54 INFO - 'NO_EM_RESTART': '1', 22:52:54 INFO - 'PAGER': '/bin/cat', 22:52:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:54 INFO - 'PWD': '/builds/slave/test', 22:52:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:52:54 INFO - 'SHELL': '/bin/bash', 22:52:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VvqF7uaUWp/Listeners', 22:52:54 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 22:52:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:52:54 INFO - 'USER': 'cltbld', 22:52:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:52:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:54 INFO - 'XPC_FLAGS': '0x0', 22:52:54 INFO - 'XPC_SERVICE_NAME': '0', 22:52:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:54 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 22:52:54 INFO - Cleaning up... 22:52:54 INFO - Return code: 0 22:52:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:52:54 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')]} 22:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:54 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')]} 22:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:52:54 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 0x101089b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10108c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9939d9a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e67d30>, '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 0x100d8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e5cbe8>, '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.VuyA1WMKVP/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.VvqF7uaUWp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 22:52:54 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 22:52:54 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 22:52:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VuyA1WMKVP/Render', 22:52:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:52:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:52:54 INFO - 'HOME': '/Users/cltbld', 22:52:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:52:54 INFO - 'LOGNAME': 'cltbld', 22:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:54 INFO - 'MOZ_NO_REMOTE': '1', 22:52:54 INFO - 'NO_EM_RESTART': '1', 22:52:54 INFO - 'PAGER': '/bin/cat', 22:52:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:52:54 INFO - 'PWD': '/builds/slave/test', 22:52:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:52:54 INFO - 'SHELL': '/bin/bash', 22:52:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VvqF7uaUWp/Listeners', 22:52:54 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 22:52:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:52:54 INFO - 'USER': 'cltbld', 22:52:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:52:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:54 INFO - 'XPC_FLAGS': '0x0', 22:52:54 INFO - 'XPC_SERVICE_NAME': '0', 22:52:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:52:54 INFO - Downloading/unpacking psutil>=3.1.1 22:52:54 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 22:52:54 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 22:52:54 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 22:52:54 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 22:52:54 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 22:52:54 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 22:55:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:55:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:55:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:55:27 INFO - Installing collected packages: psutil 22:55:27 INFO - Running setup.py install for psutil 22:55:27 INFO - building 'psutil._psutil_osx' extension 22:55:27 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 22:55:27 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 22:55:27 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 22:55:27 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 22:55:28 INFO - building 'psutil._psutil_posix' extension 22:55:28 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 22:55:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 22:55:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 22:55:28 INFO - ^ 22:55:28 INFO - 1 warning generated. 22:55:28 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 22:55:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:55:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:55:28 INFO - Successfully installed psutil 22:55:28 INFO - Cleaning up... 22:55:28 INFO - Return code: 0 22:55:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:55:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:55:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:55:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:55:28 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 0x101089b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10108c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9939d9a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e67d30>, '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 0x100d8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e5cbe8>, '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.VuyA1WMKVP/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.VvqF7uaUWp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 22:55:28 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 22:55:28 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 22:55:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VuyA1WMKVP/Render', 22:55:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:55:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:55:28 INFO - 'HOME': '/Users/cltbld', 22:55:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:55:28 INFO - 'LOGNAME': 'cltbld', 22:55:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:55:28 INFO - 'MOZ_NO_REMOTE': '1', 22:55:28 INFO - 'NO_EM_RESTART': '1', 22:55:28 INFO - 'PAGER': '/bin/cat', 22:55:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:55:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:55:28 INFO - 'PWD': '/builds/slave/test', 22:55:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:55:28 INFO - 'SHELL': '/bin/bash', 22:55:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VvqF7uaUWp/Listeners', 22:55:28 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 22:55:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:55:28 INFO - 'USER': 'cltbld', 22:55:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:55:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:55:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:55:28 INFO - 'XPC_FLAGS': '0x0', 22:55:28 INFO - 'XPC_SERVICE_NAME': '0', 22:55:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:55:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:55:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:55:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:58:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:58:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:58:01 INFO - Installing collected packages: mozsystemmonitor 22:58:01 INFO - Running setup.py install for mozsystemmonitor 22:58:02 INFO - Successfully installed mozsystemmonitor 22:58:02 INFO - Cleaning up... 22:58:02 INFO - Return code: 0 22:58:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:58: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')]} 22:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:58:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58: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')]} 22:58:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:58:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:58:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101089b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10108c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9939d9a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e67d30>, '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 0x100d8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e5cbe8>, '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.VuyA1WMKVP/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.VvqF7uaUWp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 22:58:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 22:58:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 22:58:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VuyA1WMKVP/Render', 22:58:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:58:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:58:03 INFO - 'HOME': '/Users/cltbld', 22:58:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:58:03 INFO - 'LOGNAME': 'cltbld', 22:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:58:03 INFO - 'MOZ_NO_REMOTE': '1', 22:58:03 INFO - 'NO_EM_RESTART': '1', 22:58:03 INFO - 'PAGER': '/bin/cat', 22:58:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:58:03 INFO - 'PWD': '/builds/slave/test', 22:58:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:58:03 INFO - 'SHELL': '/bin/bash', 22:58:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VvqF7uaUWp/Listeners', 22:58:03 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 22:58:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:58:03 INFO - 'USER': 'cltbld', 22:58:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:58:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:58:03 INFO - 'XPC_FLAGS': '0x0', 22:58:03 INFO - 'XPC_SERVICE_NAME': '0', 22:58:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:58:03 INFO - Downloading/unpacking jsonschema==2.5.1 22:58:03 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 22:58:03 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 22:58:03 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 22:58:03 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 22:58:03 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 22:58:03 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 23:00:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:00:35 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:00:35 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 23:00:35 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 23:00:35 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 23:00:35 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 23:00:35 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 23:00:35 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 23:03:06 INFO - Downloading functools32-3.2.3-2.tar.gz 23:03:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:03:06 INFO - warning: no files found matching '*.txt' 23:03:06 INFO - no previously-included directories found matching 'build' 23:03:06 INFO - no previously-included directories found matching 'dist' 23:03:06 INFO - no previously-included directories found matching '.git*' 23:03:06 INFO - Installing collected packages: jsonschema, functools32 23:03:06 INFO - Running setup.py install for functools32 23:03:06 INFO - warning: no files found matching '*.txt' 23:03:06 INFO - no previously-included directories found matching 'build' 23:03:06 INFO - no previously-included directories found matching 'dist' 23:03:06 INFO - no previously-included directories found matching '.git*' 23:03:06 INFO - Successfully installed jsonschema functools32 23:03:06 INFO - Cleaning up... 23:03:06 INFO - Return code: 0 23:03:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:08 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 0x101089b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10108c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9939d9a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e67d30>, '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 0x100d8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e5cbe8>, '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.VuyA1WMKVP/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.VvqF7uaUWp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 23:03:08 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 23:03:08 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 23:03:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VuyA1WMKVP/Render', 23:03:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:03:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:03:08 INFO - 'HOME': '/Users/cltbld', 23:03:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:03:08 INFO - 'LOGNAME': 'cltbld', 23:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:08 INFO - 'MOZ_NO_REMOTE': '1', 23:03:08 INFO - 'NO_EM_RESTART': '1', 23:03:08 INFO - 'PAGER': '/bin/cat', 23:03:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:03:08 INFO - 'PWD': '/builds/slave/test', 23:03:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:03:08 INFO - 'SHELL': '/bin/bash', 23:03:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VvqF7uaUWp/Listeners', 23:03:08 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 23:03:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:03:08 INFO - 'USER': 'cltbld', 23:03:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:03:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:08 INFO - 'XPC_FLAGS': '0x0', 23:03:08 INFO - 'XPC_SERVICE_NAME': '0', 23:03:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:03:08 INFO - Cleaning up... 23:03:08 INFO - Return code: 0 23:03:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:03:08 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')]} 23:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:08 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')]} 23:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:03:08 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 0x101089b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10108c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9939d9a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e67d30>, '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 0x100d8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e5cbe8>, '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.VuyA1WMKVP/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.VvqF7uaUWp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 23:03:08 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 23:03:08 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 23:03:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VuyA1WMKVP/Render', 23:03:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:03:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:03:08 INFO - 'HOME': '/Users/cltbld', 23:03:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:03:08 INFO - 'LOGNAME': 'cltbld', 23:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:03:08 INFO - 'MOZ_NO_REMOTE': '1', 23:03:08 INFO - 'NO_EM_RESTART': '1', 23:03:08 INFO - 'PAGER': '/bin/cat', 23:03:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:03:08 INFO - 'PWD': '/builds/slave/test', 23:03:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:03:08 INFO - 'SHELL': '/bin/bash', 23:03:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VvqF7uaUWp/Listeners', 23:03:08 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 23:03:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:03:08 INFO - 'USER': 'cltbld', 23:03:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:03:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:03:08 INFO - 'XPC_FLAGS': '0x0', 23:03:08 INFO - 'XPC_SERVICE_NAME': '0', 23:03:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:03:09 INFO - Downloading/unpacking blobuploader==1.2.4 23:03: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 23:03: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 23:03: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 23:03: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 23:03: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 23:03: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 23:05:41 INFO - Downloading blobuploader-1.2.4.tar.gz 23:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:05:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:05:41 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 23:05:41 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 23:05:41 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 23:05:41 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 23:05:41 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 23:05:41 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 23:08:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:08:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:08: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 23:08: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 23:08: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 23:08: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 23:08: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 23:08: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 23:10:42 INFO - Downloading docopt-0.6.1.tar.gz 23:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:10:42 INFO - Installing collected packages: blobuploader, requests, docopt 23:10:42 INFO - Running setup.py install for blobuploader 23:10:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:10:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:10:42 INFO - Running setup.py install for requests 23:10:43 INFO - Running setup.py install for docopt 23:10:43 INFO - Successfully installed blobuploader requests docopt 23:10:43 INFO - Cleaning up... 23:10:43 INFO - Return code: 0 23:10:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:10:43 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')]} 23:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:43 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')]} 23:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:44 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 0x101089b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10108c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9939d9a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e67d30>, '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 0x100d8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e5cbe8>, '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.VuyA1WMKVP/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.VvqF7uaUWp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 23:10:44 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 23:10:44 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 23:10:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VuyA1WMKVP/Render', 23:10:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:10:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:10:44 INFO - 'HOME': '/Users/cltbld', 23:10:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:10:44 INFO - 'LOGNAME': 'cltbld', 23:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:44 INFO - 'MOZ_NO_REMOTE': '1', 23:10:44 INFO - 'NO_EM_RESTART': '1', 23:10:44 INFO - 'PAGER': '/bin/cat', 23:10:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:44 INFO - 'PWD': '/builds/slave/test', 23:10:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:10:44 INFO - 'SHELL': '/bin/bash', 23:10:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VvqF7uaUWp/Listeners', 23:10:44 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 23:10:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:10:44 INFO - 'USER': 'cltbld', 23:10:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:10:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:44 INFO - 'XPC_FLAGS': '0x0', 23:10:44 INFO - 'XPC_SERVICE_NAME': '0', 23:10:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:10:44 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-vXqctx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:10:45 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-Tn5Ulr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:10:45 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-uvlkGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:10:45 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-eiEiEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:10:45 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-AoAw78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:10:45 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-g4nYqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:10:45 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-vKKRCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:10:45 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-63Zi4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:10:45 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-mbjei1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:10:45 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-F46trk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:10:45 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-MIWGq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:10:46 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-vMyijF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:10:46 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-NiPbIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:10:46 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-E3ieru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:46 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-c8ZkGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:10:46 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-zM1fXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:10:46 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-xtHUOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:10:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:10:46 INFO - Running setup.py install for manifestparser 23:10:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:10:46 INFO - Running setup.py install for mozcrash 23:10:47 INFO - Running setup.py install for mozdebug 23:10:47 INFO - Running setup.py install for mozdevice 23:10:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:10:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:10:47 INFO - Running setup.py install for mozfile 23:10:47 INFO - Running setup.py install for mozhttpd 23:10:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:10:47 INFO - Running setup.py install for mozinfo 23:10:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:10:47 INFO - Running setup.py install for mozInstall 23:10:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:10:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:10:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:10:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:10:47 INFO - Running setup.py install for mozleak 23:10:48 INFO - Running setup.py install for mozlog 23:10:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:10:48 INFO - Running setup.py install for moznetwork 23:10:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:10:48 INFO - Running setup.py install for mozprocess 23:10:48 INFO - Running setup.py install for mozprofile 23:10:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:10:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:10:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:10:48 INFO - Running setup.py install for mozrunner 23:10:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:10:48 INFO - Running setup.py install for mozscreenshot 23:10:49 INFO - Running setup.py install for moztest 23:10:49 INFO - Running setup.py install for mozversion 23:10:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:10:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:10:49 INFO - Cleaning up... 23:10:49 INFO - Return code: 0 23:10:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:10:49 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')]} 23:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:49 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')]} 23:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:49 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 0x101089b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10108c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9939d9a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e67d30>, '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 0x100d8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e5cbe8>, '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.VuyA1WMKVP/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.VvqF7uaUWp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 23:10:49 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 23:10:49 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 23:10:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VuyA1WMKVP/Render', 23:10:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:10:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:10:49 INFO - 'HOME': '/Users/cltbld', 23:10:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:10:49 INFO - 'LOGNAME': 'cltbld', 23:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:49 INFO - 'MOZ_NO_REMOTE': '1', 23:10:49 INFO - 'NO_EM_RESTART': '1', 23:10:49 INFO - 'PAGER': '/bin/cat', 23:10:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:49 INFO - 'PWD': '/builds/slave/test', 23:10:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:10:49 INFO - 'SHELL': '/bin/bash', 23:10:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VvqF7uaUWp/Listeners', 23:10:49 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 23:10:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:10:49 INFO - 'USER': 'cltbld', 23:10:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:10:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:49 INFO - 'XPC_FLAGS': '0x0', 23:10:49 INFO - 'XPC_SERVICE_NAME': '0', 23:10:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:10:49 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-dL4rDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:10:49 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)) 23:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:10:49 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-RJeobz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:10:49 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)) 23:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:10:49 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-SCqXKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:10:49 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)) 23:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:10:49 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-BqQh6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:10:50 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)) 23:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:10:50 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-C3IuBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:10:50 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)) 23:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:10:50 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-on_xPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:10:50 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)) 23:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:10:50 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-6OeCzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:10:50 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)) 23:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:10:50 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-JGBChN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:10:50 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)) 23:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:10:50 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-1awIml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:10:50 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)) 23:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:10:50 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-dkD0Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:10:50 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)) 23:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:10:50 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-0urN7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:10:50 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)) 23:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:10:50 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-EjFPSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:10:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:10:50 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-0jx3MG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:10:51 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)) 23:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:10:51 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-W6hKGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:10:51 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)) 23:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:51 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-ETlRWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:51 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)) 23:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:10:51 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-q9Du4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:10:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:10:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:10:51 INFO - Running setup.py (path:/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/pip-HIuez1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:10:51 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)) 23:10:51 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)) 23:10:51 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)) 23:10:51 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)) 23:10:51 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)) 23:10:51 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)) 23:10:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:10:51 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 23:10:51 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 23:10:51 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 23:10:51 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 23:10:51 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 23:10:51 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 23:13:24 INFO - Downloading blessings-1.6.tar.gz 23:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:13:24 INFO - Installing collected packages: blessings 23:13:24 INFO - Running setup.py install for blessings 23:13:24 INFO - Successfully installed blessings 23:13:24 INFO - Cleaning up... 23:13:24 INFO - Return code: 0 23:13:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:13:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:13:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:13:24 INFO - Reading from file tmpfile_stdout 23:13:24 INFO - Current package versions: 23:13:24 INFO - blessings == 1.6 23:13:24 INFO - blobuploader == 1.2.4 23:13:24 INFO - docopt == 0.6.1 23:13:24 INFO - functools32 == 3.2.3-2 23:13:24 INFO - jsonschema == 2.5.1 23:13:24 INFO - manifestparser == 1.1 23:13:24 INFO - mozInstall == 1.12 23:13:24 INFO - mozcrash == 1.0 23:13:24 INFO - mozdebug == 0.1 23:13:24 INFO - mozdevice == 0.49 23:13:24 INFO - mozfile == 1.2 23:13:24 INFO - mozhttpd == 0.7 23:13:24 INFO - mozinfo == 0.9 23:13:24 INFO - mozleak == 0.1 23:13:24 INFO - mozlog == 3.4 23:13:24 INFO - moznetwork == 0.27 23:13:24 INFO - mozprocess == 0.25 23:13:24 INFO - mozprofile == 0.28 23:13:24 INFO - mozrunner == 6.13 23:13:24 INFO - mozscreenshot == 0.1 23:13:24 INFO - mozsystemmonitor == 0.3 23:13:24 INFO - moztest == 0.8 23:13:24 INFO - mozversion == 1.4 23:13:24 INFO - psutil == 3.1.1 23:13:24 INFO - requests == 1.2.3 23:13:24 INFO - wsgiref == 0.1.2 23:13:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:13: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')]} 23:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13: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')]} 23:13:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:25 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 0x101089b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10108c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9939d9a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e67d30>, '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 0x100d8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e5cbe8>, '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.VuyA1WMKVP/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.VvqF7uaUWp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 23:13:25 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 23:13:25 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 23:13:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VuyA1WMKVP/Render', 23:13:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:13:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:13:25 INFO - 'HOME': '/Users/cltbld', 23:13:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:13:25 INFO - 'LOGNAME': 'cltbld', 23:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:25 INFO - 'MOZ_NO_REMOTE': '1', 23:13:25 INFO - 'NO_EM_RESTART': '1', 23:13:25 INFO - 'PAGER': '/bin/cat', 23:13:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:25 INFO - 'PWD': '/builds/slave/test', 23:13:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:13:25 INFO - 'SHELL': '/bin/bash', 23:13:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VvqF7uaUWp/Listeners', 23:13:25 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 23:13:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:13:25 INFO - 'USER': 'cltbld', 23:13:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:13:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:25 INFO - 'XPC_FLAGS': '0x0', 23:13:25 INFO - 'XPC_SERVICE_NAME': '0', 23:13:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:26 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)) 23:13:26 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)) 23:13:26 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)) 23:13:26 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)) 23:13:26 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)) 23:13:26 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)) 23:13:26 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)) 23:13:26 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)) 23:13:26 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)) 23:13:26 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)) 23:13:26 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)) 23:13:26 INFO - Cleaning up... 23:13:26 INFO - Return code: 0 23:13:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:13:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101089b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10108c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9939d9a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100e67d30>, '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 0x100d8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e5cbe8>, '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.VuyA1WMKVP/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.VvqF7uaUWp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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 23:13:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:13:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VuyA1WMKVP/Render', 23:13:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:13:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:13:26 INFO - 'HOME': '/Users/cltbld', 23:13:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:13:26 INFO - 'LOGNAME': 'cltbld', 23:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:26 INFO - 'MOZ_NO_REMOTE': '1', 23:13:26 INFO - 'NO_EM_RESTART': '1', 23:13:26 INFO - 'PAGER': '/bin/cat', 23:13:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:26 INFO - 'PWD': '/builds/slave/test', 23:13:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:13:26 INFO - 'SHELL': '/bin/bash', 23:13:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VvqF7uaUWp/Listeners', 23:13:26 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 23:13:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:13:26 INFO - 'USER': 'cltbld', 23:13:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:13:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:26 INFO - 'XPC_FLAGS': '0x0', 23:13:26 INFO - 'XPC_SERVICE_NAME': '0', 23:13:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:13:26 INFO - Cleaning up... 23:13:26 INFO - Return code: 0 23:13:26 INFO - Running post-action listener: _resource_record_post_action 23:13:26 INFO - Running post-action listener: _start_resource_monitoring 23:13:26 INFO - Starting resource monitoring. 23:13:26 INFO - [mozharness: 2017-05-19 06:13:26.322602Z] Finished create-virtualenv step (success) 23:13:26 INFO - [mozharness: 2017-05-19 06:13:26.323558Z] Running install step. 23:13:26 INFO - Running pre-action listener: _resource_record_pre_action 23:13:26 INFO - Running main action method: install 23:13:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:13:26 INFO - Reading from file tmpfile_stdout 23:13:26 INFO - Detecting whether we're running mozinstall >=1.0... 23:13:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:13:26 INFO - Reading from file tmpfile_stdout 23:13:26 INFO - Output received: 23:13:26 INFO - Usage: mozinstall [options] installer 23:13:26 INFO - Options: 23:13:26 INFO - -h, --help show this help message and exit 23:13:26 INFO - -d DEST, --destination=DEST 23:13:26 INFO - Directory to install application into. [default: 23:13:26 INFO - "/builds/slave/test"] 23:13:26 INFO - --app=APP Application being installed. [default: firefox] 23:13:26 INFO - mkdir: /builds/slave/test/build/application 23:13:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 23:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 23:13:46 INFO - Reading from file tmpfile_stdout 23:13:46 INFO - Output received: 23:13:46 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 23:13:46 INFO - Running post-action listener: _resource_record_post_action 23:13:46 INFO - [mozharness: 2017-05-19 06:13:46.622038Z] Finished install step (success) 23:13:46 INFO - [mozharness: 2017-05-19 06:13:46.622177Z] Running run-tests step. 23:13:46 INFO - Running pre-action listener: _resource_record_pre_action 23:13:46 INFO - Running main action method: run_tests 23:13:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:13:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:13:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:13:46 INFO - 2017-05-18 23:13:46.636 screenresolution[1628:9519] starting screenresolution argv=screenresolution get 23:13:46 INFO - 2017-05-18 23:13:46.639 screenresolution[1628:9519] Display 0: 1600x1200x32@60 23:13:46 INFO - 2017-05-18 23:13:46.645 screenresolution[1629:9522] starting screenresolution argv=screenresolution list 23:13:46 INFO - Available Modes on Display 0 23:13:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:13:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:13:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:13:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:13:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:13:46 INFO - Intel Iris: 23:13:46 INFO - Chipset Model: Intel Iris 23:13:46 INFO - Type: GPU 23:13:46 INFO - Bus: Built-In 23:13:46 INFO - VRAM (Dynamic, Max): 1536 MB 23:13:46 INFO - Vendor: Intel (0x8086) 23:13:46 INFO - Device ID: 0x0a2e 23:13:46 INFO - Revision ID: 0x0009 23:13:46 INFO - Displays: 23:13:46 INFO - Display: 23:13:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:13:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:13:46 INFO - Display Serial Number: 1600x1200 60 23:13:46 INFO - Main Display: Yes 23:13:46 INFO - Mirror: Off 23:13:46 INFO - Online: Yes 23:13:46 INFO - Rotation: Supported 23:13:46 INFO - Return code: 0 23:13:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:13:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:13:46 INFO - Python 2.7.3 23:13:46 INFO - Return code: 0 23:13:46 INFO - grabbing minidump binary from tooltool 23:13:46 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')]} 23:13:46 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 0x100e67d30>, '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 0x100d8edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100e5cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:13:46 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 23:13:46 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 23:13:46 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 23:13:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:13:47 INFO - Return code: 0 23:13:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:13:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:13:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:13:47 INFO - ENV: RUST_BACKTRACE is now 1 23:13:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:13:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:13:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Jamun', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0311', '--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 23:13:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Jamun --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0311 --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 23:13:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VuyA1WMKVP/Render', 23:13:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:13:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:13:47 INFO - 'HOME': '/Users/cltbld', 23:13:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:13:47 INFO - 'LOGNAME': 'cltbld', 23:13:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:13:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:13:47 INFO - 'MOZ_NO_REMOTE': '1', 23:13:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:13:47 INFO - 'NO_EM_RESTART': '1', 23:13:47 INFO - 'PAGER': '/bin/cat', 23:13:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:13:47 INFO - 'PWD': '/builds/slave/test', 23:13:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:13:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:13:47 INFO - 'RUST_BACKTRACE': '1', 23:13:47 INFO - 'SHELL': '/bin/bash', 23:13:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VvqF7uaUWp/Listeners', 23:13:47 INFO - 'TMPDIR': '/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/', 23:13:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:13:47 INFO - 'USER': 'cltbld', 23:13:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:13:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:13:47 INFO - 'XPC_FLAGS': '0x0', 23:13:47 INFO - 'XPC_SERVICE_NAME': '0', 23:13:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:13:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Jamun', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0311', '--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 23:13:47 INFO - mozversion application_buildid: 20170518061119 23:13:47 INFO - mozversion application_changeset: 9cee0e8b00d28d7e977df6ee3e1adc9680004b8d 23:13:47 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:13:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:13:47 INFO - mozversion application_name: Firefox 23:13:47 INFO - mozversion application_remotingname: firefox-dev 23:13:47 INFO - mozversion application_repository: https://hg.mozilla.org/projects/jamun 23:13:47 INFO - mozversion application_vendor: Mozilla 23:13:47 INFO - mozversion application_version: 54.0 23:13:47 INFO - mozversion platform_buildid: 20170518061119 23:13:47 INFO - mozversion platform_changeset: 9cee0e8b00d28d7e977df6ee3e1adc9680004b8d 23:13:47 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/jamun 23:13:47 INFO - mozversion platform_version: 54.0 23:13:47 INFO - using testdate: 1495174427 23:13:47 INFO - actual date: 1495174427 23:13:47 INFO - starting webserver on 'localhost:49252' 23:13:47 INFO - SUITE-START | Running 2 tests 23:13:47 INFO - TEST-START | dromaeo_css 23:13:47 INFO - operating with platform_type : mac_ 23:13:47 INFO - Initialising browser for dromaeo_css test... 23:13:47 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpN4MWYT/profile http://localhost:49252/getInfo.html) 23:13:50 INFO - PROCESS | 1639 | 2017-05-18 23:13:50.340 plugin-container[1643:9706] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x924b, name = 'com.apple.tsm.portname' 23:13:50 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:13:50 INFO - PROCESS | 1639 | 2017-05-18 23:13:50.341 plugin-container[1643:9706] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 23:13:50 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:13:50 INFO - PROCESS | 1639 | 2017-05-18 23:13:50.342 plugin-container[1643:9706] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 23:13:50 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 23:13:50 INFO - PROCESS | 1639 | colorDepth:24 23:13:50 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 23:13:50 INFO - PROCESS | 1639 | __metrics 23:13:50 ERROR - PROCESS | 1639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 23:13:50 INFO - TEST-INFO | 1639: exit 0 23:13:50 INFO - Browser initialized. 23:13:50 INFO - Running cycle 1/1 for dromaeo_css test... 23:13:50 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpN4MWYT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:13:53 INFO - PROCESS | 1645 | 2017-05-18 23:13:53.508 plugin-container[1646:9838] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4343, name = 'com.apple.tsm.portname' 23:13:53 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:13:53 INFO - PROCESS | 1645 | 2017-05-18 23:13:53.509 plugin-container[1646:9838] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8543, name = 'com.apple.CFPasteboardClient' 23:13:53 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:13:53 INFO - PROCESS | 1645 | 2017-05-18 23:13:53.509 plugin-container[1646:9838] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 23:14:03 INFO - PROCESS | 1645 | RSS: Main: 202743808 23:14:03 INFO - PROCESS | 1645 | 23:17:05 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49252/tests/dromaeo/cssquery-ext.html) 23:17:08 INFO - PROCESS | 1645 | RSS: Main: 215969792 23:17:08 INFO - PROCESS | 1645 | 23:20:10 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-ext.html (next: http://localhost:49252/tests/dromaeo/cssquery-jquery.html) 23:20:11 INFO - PROCESS | 1645 | RSS: Main: 230600704 23:20:11 INFO - PROCESS | 1645 | 23:23:13 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49252/tests/dromaeo/cssquery-mootools.html) 23:23:13 INFO - PROCESS | 1645 | RSS: Main: 232304640 23:23:13 INFO - PROCESS | 1645 | 23:26:15 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49252/tests/dromaeo/cssquery-prototype.html) 23:26:16 INFO - PROCESS | 1645 | RSS: Main: 235507712 23:26:16 INFO - PROCESS | 1645 | 23:29:19 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49252/tests/dromaeo/cssquery-yui.html) 23:29:19 INFO - PROCESS | 1645 | RSS: Main: 237539328 23:29:19 INFO - PROCESS | 1645 | 23:32:22 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49252/tests/dromaeo/cssquery-yui.html (next: http://localhost:49252/tests/dromaeo/cssquery-dojo.html) 23:32:23 INFO - PROCESS | 1645 | RSS: Main: 235835392 23:32:23 INFO - PROCESS | 1645 | 23:32:23 INFO - PROCESS | 1645 | __start_tp_report 23:32:23 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 23:32:23 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 23:32:23 INFO - PROCESS | 1645 | |i|pagename|runs| 23:32:23 INFO - PROCESS | 1645 | |0;dojo.html;3382.830858457077;3393.0499460151136;3416.6070901846297;3427.1603457153;3427.263138425238;5903.645781253128;5926.496247818935;5929.4367035131645;5971.104334349844;5971.701414929247;5845.210896528967;5941.3761555036635;5942.61373010754;5961.433663801943;5977.312609049961;4128.62842344189;5320.76056577454;5388.43421440749;5403.648762830423;5447.073997420428;5466.863328416782;5470.070088085035;5479.820627802691;5482.506574408302;5489.615726899118;4698.624110071203;5211.879445919127;5258.921116183241;5272.973635131838;5510.476504732064;4568.817247310104;5385.461453854603;5404.91892621611;5432.619716619838;5445.700486473243;4405.140997505488;5288.894222115575;5380.2736630555155;5428.538574221196;5444.727763611803;5649.12438572022;5762.769489220426;5834.824955251349;5957.910631340534;5989.700514974234;6245.656488893109;6254.374562543755;6276.121343011982;6287.842803929892;6295.338989406138;6312.779052733178;6344.777932772331;6357.141785858896;6358.459530939876;6362.77730279438;6026.668533230671;6053.606515576474;6070.514358851281;6071.453569178795;6079.574429789916;6191.504679625619;6236.251649801962;6262.436380725757;6373.553851230462;6392.4566411854585;6226.968865155645;6248.50011999039;6298;6334.113224148623;6349.2698339690605;6271.717772700239;6327.209098862642;6334.049892516159;6337.493000559944;6360.745570177141;6135.171422439398;6168.352323006109;6304.275008374004;6319.873602528016;6321.020241862519;6211.534134939898;6246.500279977682;6267;6287.842803929939;6298.464630506367;5008.824691135793;5009.5741861941415;5030.547250747377;5082.593392528589;5085.110105731482;3887.3391523441082;4533;4536.818527258939;4548.74981876;4574.565416285448;5802.187693722883;5905.320888097924;5933.021051526536;5939.584229104008;5948.167256584082;6190.50475961922;6231.40801623845;6235.095911092866;6263.78076767311;6349.396807303298;5877.764889404461;5887;5894.997850365448;5928.7332070056955;5932.2584676915385;5559.749811258503;5564.527015203672;5568.16477528374;5585.413531579207;5587.860303492445;6222.253329600477;6246.187995560548;6404.615723056631;6493.902591461132;6512.446442052384;5966.134910438049;6298.401651843067;6331.176946996861;6340.080688300263;6382.90425643625;6478.870422591427;6510.121133646897;6514.902276465951;6515.771947981798;6572.441342485942;6134.754609815736;6135.538906165067;6286.245650521967;6317.273513545817;6323.873522529616;6187.16473276102;6224.315325314303;6242.500599952084;6299.149614802126;6307.211598550181;4906.313116163811;5546.334439867242;6297.590656607306;6307.873842523032;6310.747570097328;6228.128062071223;6259.874802504016;6295.527835412454;6304.5271604628915;6323.715432805443;5245.527902488794;5878.353381127987;5934.406559344031;5973.671448070398;6007.969960150172;6184.628922264678;6185.350538193425;6277.591956522811;6286;6303.1175635412;5897;5957.017092179742;6038.969805150946;6084.6349219047;6114.6636934969 23:32:23 INFO - PROCESS | 1645 | |1;ext.html;747.409546458298;814.9551774652393;840.8192238668687;967.0812727908484;968.47218266045;32756.836215818916;38579.42130868036;40651.99999999996;40724.98187545313;40756.592434075654;30536.389272214543;38978.805105974505;38979.0255243619;39021.41467877984;39062.414063788994;9090.54547272637;9438.858417123749;9524.476153811538;9526.571304291323;9533.856992145124;9234.769130771718;9261.953690231574;9333.346665733367;9335.859962100574;9339.206167475739;9260.351775375726;9337.673181438651;9344.486053267068;9346.345755797098;9351.158395744382;9274.58264378098;9312.720618381425;9327.393719408217;9350.532473376372;9369.906300936971;8995.235404990584;9047.954760226223;9056.954715226448;9062.275017998545;9069.047749986223;27093.86453067722;34866.82566587151;34891.825540872385;34932.47601285983;34952;3776.0687313794865;3798.715096367756;3808.1431677872533;3876.0116170376655;3883.359245724452;25680.22959311205;26415.943362265487;26992;27072.323191920164;27085.322866928287;3046.8628911699025;3097.3805238952073;3118.5166299223656;3163.335699503107;3197.4564324064963;281930.99999999796;335035;335351;335689;337098;45194.32208516875;45466.54533454623;45517.544824551995;45535;45594.86012849639;37931.620683793364;45495;46052.539474605495;46344;46390;13399.933000334935;13487.662808429868;13510.054296199369;13517.526886558922;13529.932350338186;11353.262037967506;11447.25592836463;11475.77048459026;11479;11497.137714671433;10691.572337106583;11964.92315691592;12121.75756484883;12126.029917606571;12214.26714397139;5729.455701708331;5765.365809760923;5773.566982476247;5776.104703770922;5801.158831969341;1064.9041586257274;1092.186321190718;1104.3263609198382;1144.5993902134187;1163.8021536338842;27358.589621155697;28068.578971315448;28598.714012860022;29914.252143696584;29916.700832991828;898.3935843305743;1075.7418219627389;1113.2447193196936;1120.910327173824;1134.9489272982735;11927.642170734893;13970.790438143233;14243.643908902153;14248.786268205986;14266.714665706628;479252;484859;485045;485857.14142858825;486620;47342.76328618404;47361.526384736404;47370.76314618474;47586.28620570694;47698.76150619225;1421;1433.906796058253;1436.5977526292654;1444.1046551138152;1459.532949456185;24111.785955301162;24691.753082468946;27154.864225678746;27622.5856612155;28421;34299.31401372008;37874.62125378711;37881.81059094687;37896;37925;445630;447210;447229;449500;451222;30104.69895301019;30279.848600757738;30550.388992220476;30552.388952220386;30614.326280846442;37385.81307093447;37917;38832.08759343004;38856;38870.41694374643;20525.692114618592;26520.071797487766;26719;27576.448471030064;28191.57712634353;27214.591781122905;27569;27981.860090699418;28181.15456536307;28226.576601351408;31743.841280793447;31899;32195.35609287848;32398.51402228921;32411.83794081109;23348.6497702538;27844.16467505978;27871.303217418914;28353.574696379983;28613.570796438486;21282.57434851325;21416.143354266278;22811.429714257276;22930.656040159745;23011.309660710205 23:32:23 INFO - PROCESS | 1645 | |2;jquery.html;315.4904828701647;433.2980571474212;434.819549886797;441.0693436848252;447.76716107624037;20306.89846550767;20885.477863053413;22310.665340019914;22386.104555817747;22408.439789005282;21176.364709058715;22545.887270563664;23319.650205246933;23777.524449511;23784;6722.5294229403835;6936.237013928464;6979.895301570456;7010.6494675266285;7012.439004879598;6676.432503237231;6762.560433571826;6810.353016463428;6823.863522729543;6836.965815170942;6676.532642715012;6792.218894827084;6813.965930170342;6816.045753594476;6831.2144103428245;6620.371064748865;6761.222459417181;6786.72853085876;6789.93210067898;6792.354726300993;6923.930760692379;7255.383292420151;7367.926320736778;7376.815579610499;7396.815079623052;26556.73443265562;27209.45581088387;27334.316642083908;27609.86195069032;27886;2720.863956802152;2855.9000434984882;2945.7937944343903;3030.3939212157657;3054.57235986962;16203.1088290144;16231.350745970147;16320.67358652832;16898.658592786043;17082.402115925885;2047.1095073643014;2054.1064636883;2054.753429588444;2055.5683306505653;2060.783617720133;156944;168742;168754;168778.3122168775;170019.14990425092;17007.914960425118;20831.8958405207;20861.58276834455;20961.475963101046;21015.684764728543;28695.13914582566;31342.216444588612;31914.723411063762;31997;32002.039938801874;10020.899791002143;10116.443595602166;10293.7426564335;10363.378197308035;10483.423411712276;6770.695318710571;8218.465799722999;8378.622961966727;8397.160283971554;8544.487330760174;8913;9043.914730232415;9677.564509597085;9785.119339259501;9852.458114803754;3538.363094642989;3720;4269.612375977819;4278.748151404955;4329.5237523872975;1038.7299302181336;1046.8115739167024;1056.3292309383596;1058.6083149234678;1074.3500182389698;16222.513324600044;21072.683909741365;21288.893555532122;21290.893545532173;21481;1031.896810318962;1044.8223801953534;1061.3366645846345;1064.3135177810268;1068.7541865370852;10435.32170408921;10927.235093543375;10937.234393592373;10993.285436446766;11180.776384472427;704032.4798376078;775873;782588;790413;799354;167520;168357.15821420815;169313;170313;173029.4045589317;1212.6119641714567;1223.8837310455492;1297.7145028093994;1299.2789002103923;1315.5592876386327;20089.694169878912;20135.093920773892;20366.796332037084;20489.590208195455;21030.369088927357;67482.66258668675;67849.81166669933;67968.6601566989;68856;69196.65401673161;63489.68255158695;89480.5525972366;98503;98562.57905815249;99950;7473.701051957861;10027.949860250652;11269.380184089954;11659.659139198762;11875.821862671894;12631.810522842348;12746.872531274568;12772.872271277169;12959.481620735442;12998.620358706994;9414.811703766023;10923.689157300856;10992.340459572451;11002.834957475485;11562.88437115618;9225.538723063686;9506.61973521079;10306.433146176732;10555.525001374803;10633.521491532745;11410.14423918193;11426.371549564521;11450.599229026944;11526.538938442704;11664.358460284766;11594.88405115938;11705.590304339306;11881.821772673244;11940.70148246266;12033.398330083286;11057.447127643425;11141.053010494199;11150.665480035612;11188.881111888746;11258 23:32:23 INFO - PROCESS | 1645 | |3;mootools.html;1403.3334166271022;1570.0501196775942;1594.2028985507247;1603.7754714339987;1606.5260748079315;9550.331476796628;10840.72898177545;11529.538818447272;11530.481128349224;11924.224925379865;11270.661880143589;11439.428028598579;11470.197086203949;11489.195756297062;11489.770204595923;2431.513697260546;2479.0331770609478;2479.0951302774447;2480.193936970483;2486.5151295497385;2062.4328309714797;2412.7587241275905;2432.963505547418;2457.45935894103;2464.8890799914047;2387.1883559589737;2452.681151450309;2453.668754718108;2463.741307162749;2464.297675162579;2383.1063351243283;2404.3868813452546;2423.87880605969;2431.683881095455;2459.2990997565785;2426.0902161689364;2433.1362366359863;2454.914078007279;2459.6433517140094;2461.3354394313615;11268.042216411615;11468.770624587545;11495.2528085675;11500.252483588623;11517.827232591519;5913.852153696192;6109.938900610981;6111.236095488064;6112.63324200545;6118.785842495491;3589.928201435983;3676.889693309205;3703.4629978652943;3704.203596226824;3732.253549290153;1158.9304641721524;1163.6443543272078;1206.1737709668905;1249.5564074753422;1263.418827339425;13846.792298115435;14182.503612373517;15110.244487775677;16074.919625401799;16245.91877040619;4709.929351059737;4812.109759694467;4813.7593120343845;4896.95103048972;4900.754962251945;11798.292102473879;11914.761704765857;11944.940275298568;11946.820797688042;11972.64082077539;4955.554000139932;5994.820155395345;5999.6400215986305;5999.790007349722;6011.48902343297;5374.435684253175;5380.515753582196;5417.404085550586;5428.859939412689;5462.071447853875;3939.6454319111417;4015.799210039545;4036.1524079942956;4097.078157414558;4111.958880411157;1056.2817284246632;1069.9037086662238;1079.7840431913648;1094.1738987064716;1098.555085190499;975.3952549419264;977.5063592885547;1000.0549480740775;1006.5269323417982;1028.2442404832443;6669.199696036507;6685;6744.865102697919;6866.553674011173;6935.826604334932;958;964.1900803325241;973.1825266775942;982.3418309732353;1008.1682611845257;4244.702870799015;4338.0890013097605;4350.32569951658;4469.508354081048;4494.07871386365;13570.728585428433;14120.85879141216;14135.293235338399;14137.85862141386;14162.079464834753;10480.528376222936;13472.259025753481;14034.298285085704;14105.36525856339;14118.364673589507;8641.222289993804;10272.845907311395;10537.367757934548;10537.473126343806;10544.472776361305;5946.167536544801;6941.861162776817;6957.721691132298;7073.787786366417;7079.752208672672;11855;11937.880621194025;12167.878321216675;12192.939035304767;12207.023438125107;12151.817722734342;12161.878381216075;12307.753844922872;12309.076819238413;12312.938435307766;9284;9479.952600237231;9508;9597.184239339735;9604;10350.068493835592;10393.168546516412;10448.05967462932;10514.369137851754;10531.420771857622;7419.332260096618;8897.466152030898;8964.282857371265;9111.726648200565;9117.726468205965;8677.1756683115;8740.431871928304;8748.47509149453;8808.5595720215;8898;7124.323189297009;7597.974273473232;7743.109542402696;7842.843143136991;7979.680812767424;5276.973615131899;5473.616846820684;5715.514181294637;5893.852653683693;6060.030395136933;5108.28484012246;6037.486813620892;6055.182550355646;6077.179580756718;6173.629582225081 23:32:23 INFO - PROCESS | 1645 | |4;prototype.html;335.67942614802865;336.6969727245479;381.15954320722807;383.17999481110445;387.7634642867848;5254.7635356408955;5353.598480113992;5363.425555733245;5415.377231618365;5451.3458384993755;5170.767315470804;5183.403908550517;5191.260927589253;5281.577473802096;5385.165299378603;3877.573466918651;4225.302825033866;4353.956460435386;4358.585934336233;4406.97796511017;4230.851920182794;4254.532001479834;4411.625011873978;4443.422355093833;4484.349769283452;3932.469116669256;4070.0231944333295;4384.8026838792175;4388.802503887333;4408.250597398434;4178.415021896937;4313.892152696177;4317.827286908519;4359.956400435986;4401.713888597263;3980.4029395590605;4018.3369743992207;4028.697847661437;4028.738132021409;4037.2732908076537;4240.9151816963795;4710.458297295821;5104.487153873844;5168.934444244661;5195.636305458619;4567.771611419415;4741.786619602126;4817.012512434942;4985.958565275179;5082.23766435034;5360.3567571891235;5393.460653934614;5644.0737225913035;5690.857728556778;5708.26108898672;4260.785676082332;4450.332450132473;4473.239549276631;4475.1944649963;4525.389072475206;4999.4250661174065;5139.0749665060275;5283.682979021271;5461.317335333083;5529.225908372831;4583.816647334136;4612.262038073892;4613.284940834176;4633;4659.627229821606;3896.4155376693725;4338.913221735547;4663.784702266396;4698.3187437821325;4726.952730472652;4053.5204650302426;4402.4056752338665;4566.589006989387;4818.6626936114135;4896.706197628154;4784.497627749106;4860.586850117779;5302.3637163540625;5680.091185410397;5694.06048002075;1296.4425297122139;1366.6788304748377;1579.9414392357148;1581.541353007638;1595.4974183132276;1083.913286937043;1098.9340639561651;1120.0591503137405;1195.9760804783855;1209.3046498263534;4482.977585112054;4543.931841022388;5106.706174517415;5134.947335796152;5165.018646457161;5009.949900500948;5712.285964254468;5791.855203619859;5835.986584628381;5855.822107676442;3985.621365970228;5157.432682404932;5165.819196328186;5210.38478071799;5229.294045303911;2462.1997850698594;2805.452936677328;2925.9570047150723;3062.4028314478464;3071.5392691096513;5864;5994.4932214654045;6047.367210853045;6049.334573196945;6126.08108783686;4932.778024988812;4941.171766446366;5499.4225606310765;5796.449337312949;6008.399160084044;5279.868003299948;5722.599418040781;5745.655260684456;6118.694065296718;6150.692465376803;5233.947660523499;5689.431056894277;5831.7667293307795;5863.472287494146;5960.552958528041;4626.560476754703;4801.759912004316;4942.629302802232;5215.582753379645;5717.856428714191;5597.8448297404975;5829.222087263425;5918.467337939606;6083.300420451705;6094.329623741296;3968.5832987537046;4116.958830411658;4228.51372092201;4578.908421831611;4579.015511665008;4958.752062396938;5355.732213389393;5366.275552800478;5753.1945527627;5863.677497737665;5305.628605997543;5672.177534257592;5685.71571421419;5810.854728631818;5867.765289388377;5292.682439053669;5660.632058916157;5702.743376548148;5735.56983226268;5776.971115144397;4669.18289299378;5376.225845471064;5459.553218397048;5514.889702206014;5648.83053508379;4924.729139897197;5162.716050617102;5385.865353366197;5659.6887171204335;5714.685692286964;5268.420473747961;5506.724663766876;5559.526725417848;5631.239782629293;5658.349289831722 23:32:23 INFO - PROCESS | 1645 | |5;yui.html;740.8444226712394;774.7211004038542;775.9922400775994;844.2865778417237;866.1987661413191;15845.683086338266;16040.438584649524;16498.42255521057;16652.250648720805;16668.49994500164;15035;15337.156456394894;15354.078755274664;15475;15477.303521341539;951.8667386565869;966.6471737815682;970.0396607358699;973.1825266775907;974.2108891797667;955.8470644696849;965.1217392173124;966.9903300967006;986.9309148359617;991.6578780320777;1010.1767059846202;1012.4836333469947;1013.716159475348;1014.7666036811501;1018.1396719771781;1009.2682804966414;1012.3015119567475;1012.5494155100984;1013.3717095400825;1013.3970287678819;750.5496701978824;760.1448370583093;760.6501009535621;761.5430741555078;761.6191904047976;15494.380224791108;15963.281652325673;16332.265048072746;16568.66862662752;17504.38734644294;13081.41133648988;13734.244616546086;13918.791218131737;14231.932605054662;14549.636259093608;11822.822657660143;11860.22908510944;11873.762524749543;11991.760164796742;12019;3382.7991063172467;3544.29114177163;3731.7201209909367;3876.4960555127936;3884.3396622574232;107689.15685520388;109554;112939;113987.43006284999;114539.42730286378;10952.890471095347;11059.391733454577;11066.557337706563;11386.658400248005;11428.428578571038;22659.546809064057;22736.431589210402;22943.541129177323;22978.655320169877;23155.768442315697;7521.172671006185;7541.849163016709;7624.237576242332;7657.349125324298;7893.486923349964;4369.257226271541;4463.687541872103;4478.57453541913;4510.571495707903;4636.466806317249;3537.557805274341;3591.174029973121;3608.350496910581;3611.963880361163;3616.945745813815;587.4155215560545;602.7227475361295;605.8061420345535;618.1654766065865;620.4385031546367;702.4661257444277;713.0124777183535;723.4284914917157;738.5273425007999;744.8100734312824;8961.283097352327;9822.950885245671;10050.798984020425;10362.673771896307;10618.150547956146;678.107041918889;698.9615571143535;711.7010855440727;720.935115839577;722.8482018776116;4634.467036290802;5067.113255180328;5092.8472145835685;5104.030234255554;5149.304843846033;102453.97546024593;103247;108100;109466;109966;84796.57601712075;86336.56831715802;88010;88325.55837220901;89705;70377.59244814972;82348;82867;82982.5850870754;83668.58165709133;10645.627403040857;11058.019799026342;11126.944365278445;11251.38117403518;11302.152338574475;33047.834760826045;39374.80312598419;42016.78991605023;45270.320945186504;50040;53890.73054634702;54260.45739542712;62131;66040;70224.94662579964;13021.283829389475;13184.472621095048;13431.462741490623;13440.395182216627;13549.458021679022;14882.925585372004;14987.925060374628;15062.774058389352;15130;15303.693926121638;13754.996003197202;13930.18439503971;13986;14403.855961440251;14498.710025799213;13517.121387110199;14089.365978530786;14169.411223780578;14329.211893345966;14382.712345752818;13488.595342139752;13672.3101748008;13689.657758556115;13722.931385343009;14429.567112986628;9656.517174141125;10196.45088727818;10335.896641033794;10480.737981550523;10699.358038517714;8167;10338.689839304832;10926.289791163867;10957.887025560978;11000.614978475714 23:32:23 INFO - PROCESS | 1645 | __end_tp_report 23:32:23 INFO - PROCESS | 1645 | __start_cc_report 23:32:23 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,371 23:32:23 INFO - PROCESS | 1645 | __end_cc_report 23:32:23 INFO - PROCESS | 1645 | __startTimestamp1495175542993__endTimestamp 23:32:23 INFO - PROCESS | 1645 | 23:32:23 INFO - PROCESS | 1645 | ------- Summary: start ------- 23:32:23 INFO - PROCESS | 1645 | Number of tests: 6 23:32:23 INFO - PROCESS | 1645 | 23:32:23 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5831.56 Median:6053.61 stddev:675.49 (11.2%) stddev-sans-first:649.68 23:32:23 INFO - PROCESS | 1645 | Values: 3382.8 3393.0 3416.6 3427.2 3427.3 5903.6 5926.5 5929.4 5971.1 5971.7 5845.2 5941.4 5942.6 5961.4 5977.3 4128.6 5320.8 5388.4 5403.6 5447.1 5466.9 5470.1 5479.8 5482.5 5489.6 4698.6 5211.9 5258.9 5273.0 5510.5 4568.8 5385.5 5404.9 5432.6 5445.7 4405.1 5288.9 5380.3 5428.5 5444.7 5649.1 5762.8 5834.8 5957.9 5989.7 6245.7 6254.4 6276.1 6287.8 6295.3 6312.8 6344.8 6357.1 6358.5 6362.8 6026.7 6053.6 6070.5 6071.5 6079.6 6191.5 6236.3 6262.4 6373.6 6392.5 6227.0 6248.5 6298.0 6334.1 6349.3 6271.7 6327.2 6334.0 6337.5 6360.7 6135.2 6168.4 6304.3 6319.9 6321.0 6211.5 6246.5 6267.0 6287.8 6298.5 5008.8 5009.6 5030.5 5082.6 5085.1 3887.3 4533.0 4536.8 4548.7 4574.6 5802.2 5905.3 5933.0 5939.6 5948.2 6190.5 6231.4 6235.1 6263.8 6349.4 5877.8 5887.0 5895.0 5928.7 5932.3 5559.7 5564.5 5568.2 5585.4 5587.9 6222.3 6246.2 6404.6 6493.9 6512.4 5966.1 6298.4 6331.2 6340.1 6382.9 6478.9 6510.1 6514.9 6515.8 6572.4 6134.8 6135.5 6286.2 6317.3 6323.9 6187.2 6224.3 6242.5 6299.1 6307.2 4906.3 5546.3 6297.6 6307.9 6310.7 6228.1 6259.9 6295.5 6304.5 6323.7 5245.5 5878.4 5934.4 5973.7 6008.0 6184.6 6185.4 6277.6 6286.0 6303.1 5897.0 5957.0 6039.0 6084.6 6114.7 23:32:23 INFO - PROCESS | 1645 | 23:32:23 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:53931.31 Median:336393.50 stddev:113113.29 (33.6%) stddev-sans-first:113360.12 23:32:23 INFO - PROCESS | 1645 | Values: 747.4 815.0 840.8 967.1 968.5 32756.8 38579.4 40652.0 40725.0 40756.6 30536.4 38978.8 38979.0 39021.4 39062.4 9090.5 9438.9 9524.5 9526.6 9533.9 9234.8 9262.0 9333.3 9335.9 9339.2 9260.4 9337.7 9344.5 9346.3 9351.2 9274.6 9312.7 9327.4 9350.5 9369.9 8995.2 9048.0 9057.0 9062.3 9069.0 27093.9 34866.8 34891.8 34932.5 34952.0 3776.1 3798.7 3808.1 3876.0 3883.4 25680.2 26415.9 26992.0 27072.3 27085.3 3046.9 3097.4 3118.5 3163.3 3197.5 281931.0 335035.0 335351.0 335689.0 337098.0 45194.3 45466.5 45517.5 45535.0 45594.9 37931.6 45495.0 46052.5 46344.0 46390.0 13399.9 13487.7 13510.1 13517.5 13529.9 11353.3 11447.3 11475.8 11479.0 11497.1 10691.6 11964.9 12121.8 12126.0 12214.3 5729.5 5765.4 5773.6 5776.1 5801.2 1064.9 1092.2 1104.3 1144.6 1163.8 27358.6 28068.6 28598.7 29914.3 29916.7 898.4 1075.7 1113.2 1120.9 1134.9 11927.6 13970.8 14243.6 14248.8 14266.7 479252.0 484859.0 485045.0 485857.1 486620.0 47342.8 47361.5 47370.8 47586.3 47698.8 1421.0 1433.9 1436.6 1444.1 1459.5 24111.8 24691.8 27154.9 27622.6 28421.0 34299.3 37874.6 37881.8 37896.0 37925.0 445630.0 447210.0 447229.0 449500.0 451222.0 30104.7 30279.8 30550.4 30552.4 30614.3 37385.8 37917.0 38832.1 38856.0 38870.4 20525.7 26520.1 26719.0 27576.4 28191.6 27214.6 27569.0 27981.9 28181.2 28226.6 31743.8 31899.0 32195.4 32398.5 32411.8 23348.6 27844.2 27871.3 28353.6 28613.6 21282.6 21416.1 22811.4 22930.7 23011.3 23:32:23 INFO - PROCESS | 1645 | 23:32:23 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:44725.34 Median:21232.63 stddev:129251.22 (608.7%) stddev-sans-first:129570.79 23:32:23 INFO - PROCESS | 1645 | Values: 315.5 433.3 434.8 441.1 447.8 20306.9 20885.5 22310.7 22386.1 22408.4 21176.4 22545.9 23319.7 23777.5 23784.0 6722.5 6936.2 6979.9 7010.6 7012.4 6676.4 6762.6 6810.4 6823.9 6837.0 6676.5 6792.2 6814.0 6816.0 6831.2 6620.4 6761.2 6786.7 6789.9 6792.4 6923.9 7255.4 7367.9 7376.8 7396.8 26556.7 27209.5 27334.3 27609.9 27886.0 2720.9 2855.9 2945.8 3030.4 3054.6 16203.1 16231.4 16320.7 16898.7 17082.4 2047.1 2054.1 2054.8 2055.6 2060.8 156944.0 168742.0 168754.0 168778.3 170019.1 17007.9 20831.9 20861.6 20961.5 21015.7 28695.1 31342.2 31914.7 31997.0 32002.0 10020.9 10116.4 10293.7 10363.4 10483.4 6770.7 8218.5 8378.6 8397.2 8544.5 8913.0 9043.9 9677.6 9785.1 9852.5 3538.4 3720.0 4269.6 4278.7 4329.5 1038.7 1046.8 1056.3 1058.6 1074.4 16222.5 21072.7 21288.9 21290.9 21481.0 1031.9 1044.8 1061.3 1064.3 1068.8 10435.3 10927.2 10937.2 10993.3 11180.8 704032.5 775873.0 782588.0 790413.0 799354.0 167520.0 168357.2 169313.0 170313.0 173029.4 1212.6 1223.9 1297.7 1299.3 1315.6 20089.7 20135.1 20366.8 20489.6 21030.4 67482.7 67849.8 67968.7 68856.0 69196.7 63489.7 89480.6 98503.0 98562.6 99950.0 7473.7 10027.9 11269.4 11659.7 11875.8 12631.8 12746.9 12772.9 12959.5 12998.6 9414.8 10923.7 10992.3 11002.8 11562.9 9225.5 9506.6 10306.4 10555.5 10633.5 11410.1 11426.4 11450.6 11526.5 11664.4 11594.9 11705.6 11881.8 11940.7 12033.4 11057.4 11141.1 11150.7 11188.9 11258.0 23:32:23 INFO - PROCESS | 1645 | 23:32:23 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:6807.32 Median:2464.02 stddev:4227.69 (171.6%) stddev-sans-first:4220.04 23:32:23 INFO - PROCESS | 1645 | Values: 1403.3 1570.1 1594.2 1603.8 1606.5 9550.3 10840.7 11529.5 11530.5 11924.2 11270.7 11439.4 11470.2 11489.2 11489.8 2431.5 2479.0 2479.1 2480.2 2486.5 2062.4 2412.8 2433.0 2457.5 2464.9 2387.2 2452.7 2453.7 2463.7 2464.3 2383.1 2404.4 2423.9 2431.7 2459.3 2426.1 2433.1 2454.9 2459.6 2461.3 11268.0 11468.8 11495.3 11500.3 11517.8 5913.9 6109.9 6111.2 6112.6 6118.8 3589.9 3676.9 3703.5 3704.2 3732.3 1158.9 1163.6 1206.2 1249.6 1263.4 13846.8 14182.5 15110.2 16074.9 16245.9 4709.9 4812.1 4813.8 4897.0 4900.8 11798.3 11914.8 11944.9 11946.8 11972.6 4955.6 5994.8 5999.6 5999.8 6011.5 5374.4 5380.5 5417.4 5428.9 5462.1 3939.6 4015.8 4036.2 4097.1 4112.0 1056.3 1069.9 1079.8 1094.2 1098.6 975.4 977.5 1000.1 1006.5 1028.2 6669.2 6685.0 6744.9 6866.6 6935.8 958.0 964.2 973.2 982.3 1008.2 4244.7 4338.1 4350.3 4469.5 4494.1 13570.7 14120.9 14135.3 14137.9 14162.1 10480.5 13472.3 14034.3 14105.4 14118.4 8641.2 10272.8 10537.4 10537.5 10544.5 5946.2 6941.9 6957.7 7073.8 7079.8 11855.0 11937.9 12167.9 12192.9 12207.0 12151.8 12161.9 12307.8 12309.1 12312.9 9284.0 9480.0 9508.0 9597.2 9604.0 10350.1 10393.2 10448.1 10514.4 10531.4 7419.3 8897.5 8964.3 9111.7 9117.7 8677.2 8740.4 8748.5 8808.6 8898.0 7124.3 7598.0 7743.1 7842.8 7979.7 5277.0 5473.6 5715.5 5893.9 6060.0 5108.3 6037.5 6055.2 6077.2 6173.6 23:32:23 INFO - PROCESS | 1645 | 23:32:23 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4673.42 Median:5046.09 stddev:1315.83 (26.1%) stddev-sans-first:1278.61 23:32:23 INFO - PROCESS | 1645 | Values: 335.7 336.7 381.2 383.2 387.8 5254.8 5353.6 5363.4 5415.4 5451.3 5170.8 5183.4 5191.3 5281.6 5385.2 3877.6 4225.3 4354.0 4358.6 4407.0 4230.9 4254.5 4411.6 4443.4 4484.3 3932.5 4070.0 4384.8 4388.8 4408.3 4178.4 4313.9 4317.8 4360.0 4401.7 3980.4 4018.3 4028.7 4028.7 4037.3 4240.9 4710.5 5104.5 5168.9 5195.6 4567.8 4741.8 4817.0 4986.0 5082.2 5360.4 5393.5 5644.1 5690.9 5708.3 4260.8 4450.3 4473.2 4475.2 4525.4 4999.4 5139.1 5283.7 5461.3 5529.2 4583.8 4612.3 4613.3 4633.0 4659.6 3896.4 4338.9 4663.8 4698.3 4727.0 4053.5 4402.4 4566.6 4818.7 4896.7 4784.5 4860.6 5302.4 5680.1 5694.1 1296.4 1366.7 1579.9 1581.5 1595.5 1083.9 1098.9 1120.1 1196.0 1209.3 4483.0 4543.9 5106.7 5134.9 5165.0 5009.9 5712.3 5791.9 5836.0 5855.8 3985.6 5157.4 5165.8 5210.4 5229.3 2462.2 2805.5 2926.0 3062.4 3071.5 5864.0 5994.5 6047.4 6049.3 6126.1 4932.8 4941.2 5499.4 5796.4 6008.4 5279.9 5722.6 5745.7 6118.7 6150.7 5233.9 5689.4 5831.8 5863.5 5960.6 4626.6 4801.8 4942.6 5215.6 5717.9 5597.8 5829.2 5918.5 6083.3 6094.3 3968.6 4117.0 4228.5 4578.9 4579.0 4958.8 5355.7 5366.3 5753.2 5863.7 5305.6 5672.2 5685.7 5810.9 5867.8 5292.7 5660.6 5702.7 5735.6 5777.0 4669.2 5376.2 5459.6 5514.9 5648.8 4924.7 5162.7 5385.9 5659.7 5714.7 5268.4 5506.7 5559.5 5631.2 5658.3 23:32:23 INFO - PROCESS | 1645 | 23:32:23 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:20596.23 Median:20081.97 stddev:29740.09 (148.1%) stddev-sans-first:29786.15 23:32:23 INFO - PROCESS | 1645 | Values: 740.8 774.7 776.0 844.3 866.2 15845.7 16040.4 16498.4 16652.3 16668.5 15035.0 15337.2 15354.1 15475.0 15477.3 951.9 966.6 970.0 973.2 974.2 955.8 965.1 967.0 986.9 991.7 1010.2 1012.5 1013.7 1014.8 1018.1 1009.3 1012.3 1012.5 1013.4 1013.4 750.5 760.1 760.7 761.5 761.6 15494.4 15963.3 16332.3 16568.7 17504.4 13081.4 13734.2 13918.8 14231.9 14549.6 11822.8 11860.2 11873.8 11991.8 12019.0 3382.8 3544.3 3731.7 3876.5 3884.3 107689.2 109554.0 112939.0 113987.4 114539.4 10952.9 11059.4 11066.6 11386.7 11428.4 22659.5 22736.4 22943.5 22978.7 23155.8 7521.2 7541.8 7624.2 7657.3 7893.5 4369.3 4463.7 4478.6 4510.6 4636.5 3537.6 3591.2 3608.4 3612.0 3616.9 587.4 602.7 605.8 618.2 620.4 702.5 713.0 723.4 738.5 744.8 8961.3 9823.0 10050.8 10362.7 10618.2 678.1 699.0 711.7 720.9 722.8 4634.5 5067.1 5092.8 5104.0 5149.3 102454.0 103247.0 108100.0 109466.0 109966.0 84796.6 86336.6 88010.0 88325.6 89705.0 70377.6 82348.0 82867.0 82982.6 83668.6 10645.6 11058.0 11126.9 11251.4 11302.2 33047.8 39374.8 42016.8 45270.3 50040.0 53890.7 54260.5 62131.0 66040.0 70224.9 13021.3 13184.5 13431.5 13440.4 13549.5 14882.9 14987.9 15062.8 15130.0 15303.7 13755.0 13930.2 13986.0 14403.9 14498.7 13517.1 14089.4 14169.4 14329.2 14382.7 13488.6 13672.3 13689.7 13722.9 14429.6 9656.5 10196.5 10335.9 10480.7 10699.4 8167.0 10338.7 10926.3 10957.9 11000.6 23:32:23 INFO - PROCESS | 1645 | -------- Summary: end -------- 23:32:23 INFO - PROCESS | 1645 | 23:32:23 INFO - TEST-INFO | 1645: exit 0 23:32:23 INFO - TEST-OK | dromaeo_css | took 1116204ms 23:32:23 INFO - TEST-START | kraken 23:32:23 INFO - operating with platform_type : mac_ 23:32:23 INFO - Initialising browser for kraken test... 23:32:23 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpvZzbs0/profile http://localhost:49252/getInfo.html) 23:32:26 INFO - PROCESS | 1654 | 2017-05-18 23:32:26.142 plugin-container[1656:12024] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 23:32:26 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:32:26 INFO - PROCESS | 1654 | 2017-05-18 23:32:26.142 plugin-container[1656:12024] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 23:32:26 INFO - PROCESS | 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:32:26 INFO - PROCESS | 1654 | 2017-05-18 23:32:26.142 plugin-container[1656:12024] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 23:32:26 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 23:32:26 INFO - PROCESS | 1654 | colorDepth:24 23:32:26 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 23:32:26 INFO - PROCESS | 1654 | __metrics 23:32:26 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 23:32:26 INFO - TEST-INFO | 1654: exit 0 23:32:26 INFO - Browser initialized. 23:32:26 INFO - Running cycle 1/1 for kraken test... 23:32:26 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/T/tmpvZzbs0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:32:29 INFO - PROCESS | 1657 | 2017-05-18 23:32:29.160 plugin-container[1658:12144] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454b, name = 'com.apple.tsm.portname' 23:32:29 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:32:29 INFO - PROCESS | 1657 | 2017-05-18 23:32:29.160 plugin-container[1658:12144] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461b, name = 'com.apple.CFPasteboardClient' 23:32:29 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:32:29 INFO - PROCESS | 1657 | 2017-05-18 23:32:29.161 plugin-container[1658:12144] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 23:32:38 INFO - PROCESS | 1657 | RSS: Main: 202792960 23:32:38 INFO - PROCESS | 1657 | 23:32:41 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-beat-detection) 23:32:42 INFO - PROCESS | 1657 | RSS: Main: 216408064 23:32:42 INFO - PROCESS | 1657 | 23:32:45 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-dft) 23:32:46 INFO - PROCESS | 1657 | RSS: Main: 224280576 23:32:46 INFO - PROCESS | 1657 | 23:32:49 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-fft) 23:32:50 INFO - PROCESS | 1657 | RSS: Main: 227893248 23:32:50 INFO - PROCESS | 1657 | 23:32:52 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49252/tests/kraken/driver.html?testName=audio-oscillator) 23:32:52 INFO - PROCESS | 1657 | RSS: Main: 229367808 23:32:52 INFO - PROCESS | 1657 | 23:32:54 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:32:55 INFO - PROCESS | 1657 | RSS: Main: 229404672 23:32:55 INFO - PROCESS | 1657 | 23:32:58 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-darkroom) 23:32:58 INFO - PROCESS | 1657 | RSS: Main: 233549824 23:32:58 INFO - PROCESS | 1657 | 23:33:01 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49252/tests/kraken/driver.html?testName=imaging-desaturate) 23:33:02 INFO - PROCESS | 1657 | RSS: Main: 233259008 23:33:02 INFO - PROCESS | 1657 | 23:33:05 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49252/tests/kraken/driver.html?testName=json-parse-financial) 23:33:06 INFO - PROCESS | 1657 | RSS: Main: 233308160 23:33:06 INFO - PROCESS | 1657 | 23:33:08 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49252/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:33:08 INFO - PROCESS | 1657 | RSS: Main: 232632320 23:33:08 INFO - PROCESS | 1657 | 23:33:10 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:33:11 INFO - PROCESS | 1657 | RSS: Main: 232624128 23:33:11 INFO - PROCESS | 1657 | 23:33:13 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:33:14 INFO - PROCESS | 1657 | RSS: Main: 232677376 23:33:14 INFO - PROCESS | 1657 | 23:33:17 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:33:17 INFO - PROCESS | 1657 | RSS: Main: 233062400 23:33:17 INFO - PROCESS | 1657 | 23:33:20 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:33:21 INFO - PROCESS | 1657 | RSS: Main: 232730624 23:33:21 INFO - PROCESS | 1657 | 23:33:23 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49252/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49252/tests/kraken/driver.html?testName=ai-astar) 23:33:23 INFO - PROCESS | 1657 | RSS: Main: 234975232 23:33:23 INFO - PROCESS | 1657 | 23:33:23 INFO - PROCESS | 1657 | __start_tp_report 23:33:23 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 23:33:23 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 23:33:23 INFO - PROCESS | 1657 | |i|pagename|runs| 23:33:23 INFO - PROCESS | 1657 | |0;ai-astar;118;167;119;120;119;119;120;119;118;120 23:33:23 INFO - PROCESS | 1657 | |1;audio-beat-detection;151;129;97;164;131;99;131;138;131;125 23:33:23 INFO - PROCESS | 1657 | |2;audio-dft;200;197;199;196;191;197;198;198;202;195 23:33:23 INFO - PROCESS | 1657 | |3;audio-fft;72;58;60;88;61;64;85;51;91;82 23:33:23 INFO - PROCESS | 1657 | |4;audio-oscillator;98;70;84;78;103;100;96;72;72;83 23:33:23 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;88;90;89;87;90;88;88;89;89;89 23:33:23 INFO - PROCESS | 1657 | |6;imaging-darkroom;96;97;97;134;144;154;124;97;98;112 23:33:23 INFO - PROCESS | 1657 | |7;imaging-desaturate;98;93;90;112;97;107;127;139;75;139 23:33:23 INFO - PROCESS | 1657 | |8;json-parse-financial;65;67;66;67;69;70;67;82;99;106 23:33:23 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;56;62;61;67;64;57;57;65;83;82 23:33:23 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;91;85;84;71;85;95;102;97;79;93 23:33:23 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;138;143;144;146;149;149;161;153;202;156 23:33:23 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;168;169;163;170;168;166;186;170;167;165 23:33:23 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;67;67;68;78;82;82;86;86;64;66 23:33:23 INFO - PROCESS | 1657 | __end_tp_report 23:33:23 INFO - PROCESS | 1657 | __start_cc_report 23:33:23 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,999 23:33:23 INFO - PROCESS | 1657 | __end_cc_report 23:33:23 INFO - PROCESS | 1657 | __startTimestamp1495175603491__endTimestamp 23:33:23 INFO - PROCESS | 1657 | 23:33:23 INFO - PROCESS | 1657 | ------- Summary: start ------- 23:33:23 INFO - PROCESS | 1657 | Number of tests: 14 23:33:23 INFO - PROCESS | 1657 | 23:33:23 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:123.90 Median:119.50 stddev:15.16 (12.7%) stddev-sans-first:15.93 23:33:23 INFO - PROCESS | 1657 | Values: 118.0 167.0 119.0 120.0 119.0 119.0 120.0 119.0 118.0 120.0 23:33:23 INFO - PROCESS | 1657 | 23:33:23 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:144.50 stddev:20.38 (14.1%) stddev-sans-first:20.09 23:33:23 INFO - PROCESS | 1657 | Values: 151.0 129.0 97.0 164.0 131.0 99.0 131.0 138.0 131.0 125.0 23:33:23 INFO - PROCESS | 1657 | 23:33:23 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:197.30 Median:198.00 stddev:2.98 (1.5%) stddev-sans-first:3.00 23:33:23 INFO - PROCESS | 1657 | Values: 200.0 197.0 199.0 196.0 191.0 197.0 198.0 198.0 202.0 195.0 23:33:23 INFO - PROCESS | 1657 | 23:33:23 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:71.20 Median:77.00 stddev:14.32 (18.6%) stddev-sans-first:15.19 23:33:23 INFO - PROCESS | 1657 | Values: 72.0 58.0 60.0 88.0 61.0 64.0 85.0 51.0 91.0 82.0 23:33:23 INFO - PROCESS | 1657 | 23:33:23 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:85.60 Median:80.50 stddev:12.70 (15.8%) stddev-sans-first:12.66 23:33:23 INFO - PROCESS | 1657 | Values: 98.0 70.0 84.0 78.0 103.0 100.0 96.0 72.0 72.0 83.0 23:33:23 INFO - PROCESS | 1657 | 23:33:23 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:89.00 stddev:0.95 (1.1%) stddev-sans-first:0.97 23:33:23 INFO - PROCESS | 1657 | Values: 88.0 90.0 89.0 87.0 90.0 88.0 88.0 89.0 89.0 89.0 23:33:23 INFO - PROCESS | 1657 | 23:33:23 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:115.30 Median:96.50 stddev:22.20 (23.0%) stddev-sans-first:22.42 23:33:23 INFO - PROCESS | 1657 | Values: 96.0 97.0 97.0 134.0 144.0 154.0 124.0 97.0 98.0 112.0 23:33:23 INFO - PROCESS | 1657 | 23:33:23 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:107.70 Median:82.50 stddev:21.49 (26.1%) stddev-sans-first:22.51 23:33:23 INFO - PROCESS | 1657 | Values: 98.0 93.0 90.0 112.0 97.0 107.0 127.0 139.0 75.0 139.0 23:33:23 INFO - PROCESS | 1657 | 23:33:23 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:75.80 Median:68.00 stddev:14.96 (22.0%) stddev-sans-first:15.35 23:33:23 INFO - PROCESS | 1657 | Values: 65.0 67.0 66.0 67.0 69.0 70.0 67.0 82.0 99.0 106.0 23:33:23 INFO - PROCESS | 1657 | 23:33:23 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:64.50 stddev:9.72 (15.1%) stddev-sans-first:9.70 23:33:23 INFO - PROCESS | 1657 | Values: 56.0 62.0 61.0 67.0 64.0 57.0 57.0 65.0 83.0 82.0 23:33:23 INFO - PROCESS | 1657 | 23:33:23 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:88.00 stddev:9.21 (10.5%) stddev-sans-first:9.71 23:33:23 INFO - PROCESS | 1657 | Values: 91.0 85.0 84.0 71.0 85.0 95.0 102.0 97.0 79.0 93.0 23:33:23 INFO - PROCESS | 1657 | 23:33:23 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:154.10 Median:151.00 stddev:18.10 (12.0%) stddev-sans-first:18.24 23:33:23 INFO - PROCESS | 1657 | Values: 138.0 143.0 144.0 146.0 149.0 149.0 161.0 153.0 202.0 156.0 23:33:23 INFO - PROCESS | 1657 | 23:33:23 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.20 Median:168.50 stddev:6.30 (3.7%) stddev-sans-first:6.67 23:33:23 INFO - PROCESS | 1657 | Values: 168.0 169.0 163.0 170.0 168.0 166.0 186.0 170.0 167.0 165.0 23:33:23 INFO - PROCESS | 1657 | 23:33:23 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:80.00 stddev:8.98 (11.2%) stddev-sans-first:9.10 23:33:23 INFO - PROCESS | 1657 | Values: 67.0 67.0 68.0 78.0 82.0 82.0 86.0 86.0 64.0 66.0 23:33:23 INFO - PROCESS | 1657 | -------- Summary: end -------- 23:33:23 INFO - PROCESS | 1657 | 23:33:24 INFO - TEST-INFO | 1657: exit 0 23:33:24 INFO - TEST-OK | kraken | took 60705ms 23:33:24 INFO - SUITE-END | took 1176s 23:33:24 INFO - Completed test suite (00:19:36) 23:33:24 INFO - javascript benchmark 23:33:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7691.217579926929, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3382.830858457077, 3393.0499460151136, 3416.6070901846297, 3427.1603457153, 3427.263138425238, 5903.645781253128, 5926.496247818935, 5929.4367035131645, 5971.104334349844, 5971.701414929247, 5845.210896528967, 5941.3761555036635, 5942.61373010754, 5961.433663801943, 5977.312609049961, 4128.62842344189, 5320.76056577454, 5388.43421440749, 5403.648762830423, 5447.073997420428, 5466.863328416782, 5470.070088085035, 5479.820627802691, 5482.506574408302, 5489.615726899118, 4698.624110071203, 5211.879445919127, 5258.921116183241, 5272.973635131838, 5510.476504732064, 4568.817247310104, 5385.461453854603, 5404.91892621611, 5432.619716619838, 5445.700486473243, 4405.140997505488, 5288.894222115575, 5380.2736630555155, 5428.538574221196, 5444.727763611803, 5649.12438572022, 5762.769489220426, 5834.824955251349, 5957.910631340534, 5989.700514974234, 6245.656488893109, 6254.374562543755, 6276.121343011982, 6287.842803929892, 6295.338989406138, 6312.779052733178, 6344.777932772331, 6357.141785858896, 6358.459530939876, 6362.77730279438, 6026.668533230671, 6053.606515576474, 6070.514358851281, 6071.453569178795, 6079.574429789916, 6191.504679625619, 6236.251649801962, 6262.436380725757, 6373.553851230462, 6392.4566411854585, 6226.968865155645, 6248.50011999039, 6298.0, 6334.113224148623, 6349.2698339690605, 6271.717772700239, 6327.209098862642, 6334.049892516159, 6337.493000559944, 6360.745570177141, 6135.171422439398, 6168.352323006109, 6304.275008374004, 6319.873602528016, 6321.020241862519, 6211.534134939898, 6246.500279977682, 6267.0, 6287.842803929939, 6298.464630506367, 5008.824691135793, 5009.5741861941415, 5030.547250747377, 5082.593392528589, 5085.110105731482, 3887.3391523441082, 4533.0, 4536.818527258939, 4548.74981876, 4574.565416285448, 5802.187693722883, 5905.320888097924, 5933.021051526536, 5939.584229104008, 5948.167256584082, 6190.50475961922, 6231.40801623845, 6235.095911092866, 6263.78076767311, 6349.396807303298, 5877.764889404461, 5887.0, 5894.997850365448, 5928.7332070056955, 5932.2584676915385, 5559.749811258503, 5564.527015203672, 5568.16477528374, 5585.413531579207, 5587.860303492445, 6222.253329600477, 6246.187995560548, 6404.615723056631, 6493.902591461132, 6512.446442052384, 5966.134910438049, 6298.401651843067, 6331.176946996861, 6340.080688300263, 6382.90425643625, 6478.870422591427, 6510.121133646897, 6514.902276465951, 6515.771947981798, 6572.441342485942, 6134.754609815736, 6135.538906165067, 6286.245650521967, 6317.273513545817, 6323.873522529616, 6187.16473276102, 6224.315325314303, 6242.500599952084, 6299.149614802126, 6307.211598550181, 4906.313116163811, 5546.334439867242, 6297.590656607306, 6307.873842523032, 6310.747570097328, 6228.128062071223, 6259.874802504016, 6295.527835412454, 6304.5271604628915, 6323.715432805443, 5245.527902488794, 5878.353381127987, 5934.406559344031, 5973.671448070398, 6007.969960150172, 6184.628922264678, 6185.350538193425, 6277.591956522811, 6286.0, 6303.1175635412, 5897.0, 5957.017092179742, 6038.969805150946, 6084.6349219047, 6114.6636934969], "value": 5788.593921095537, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.409546458298, 814.9551774652393, 840.8192238668687, 967.0812727908484, 968.47218266045, 32756.836215818916, 38579.42130868036, 40651.99999999996, 40724.98187545313, 40756.592434075654, 30536.389272214543, 38978.805105974505, 38979.0255243619, 39021.41467877984, 39062.414063788994, 9090.54547272637, 9438.858417123749, 9524.476153811538, 9526.571304291323, 9533.856992145124, 9234.769130771718, 9261.953690231574, 9333.346665733367, 9335.859962100574, 9339.206167475739, 9260.351775375726, 9337.673181438651, 9344.486053267068, 9346.345755797098, 9351.158395744382, 9274.58264378098, 9312.720618381425, 9327.393719408217, 9350.532473376372, 9369.906300936971, 8995.235404990584, 9047.954760226223, 9056.954715226448, 9062.275017998545, 9069.047749986223, 27093.86453067722, 34866.82566587151, 34891.825540872385, 34932.47601285983, 34952.0, 3776.0687313794865, 3798.715096367756, 3808.1431677872533, 3876.0116170376655, 3883.359245724452, 25680.22959311205, 26415.943362265487, 26992.0, 27072.323191920164, 27085.322866928287, 3046.8628911699025, 3097.3805238952073, 3118.5166299223656, 3163.335699503107, 3197.4564324064963, 281930.99999999796, 335035.0, 335351.0, 335689.0, 337098.0, 45194.32208516875, 45466.54533454623, 45517.544824551995, 45535.0, 45594.86012849639, 37931.620683793364, 45495.0, 46052.539474605495, 46344.0, 46390.0, 13399.933000334935, 13487.662808429868, 13510.054296199369, 13517.526886558922, 13529.932350338186, 11353.262037967506, 11447.25592836463, 11475.77048459026, 11479.0, 11497.137714671433, 10691.572337106583, 11964.92315691592, 12121.75756484883, 12126.029917606571, 12214.26714397139, 5729.455701708331, 5765.365809760923, 5773.566982476247, 5776.104703770922, 5801.158831969341, 1064.9041586257274, 1092.186321190718, 1104.3263609198382, 1144.5993902134187, 1163.8021536338842, 27358.589621155697, 28068.578971315448, 28598.714012860022, 29914.252143696584, 29916.700832991828, 898.3935843305743, 1075.7418219627389, 1113.2447193196936, 1120.910327173824, 1134.9489272982735, 11927.642170734893, 13970.790438143233, 14243.643908902153, 14248.786268205986, 14266.714665706628, 479252.0, 484859.0, 485045.0, 485857.14142858825, 486620.0, 47342.76328618404, 47361.526384736404, 47370.76314618474, 47586.28620570694, 47698.76150619225, 1421.0, 1433.906796058253, 1436.5977526292654, 1444.1046551138152, 1459.532949456185, 24111.785955301162, 24691.753082468946, 27154.864225678746, 27622.5856612155, 28421.0, 34299.31401372008, 37874.62125378711, 37881.81059094687, 37896.0, 37925.0, 445630.0, 447210.0, 447229.0, 449500.0, 451222.0, 30104.69895301019, 30279.848600757738, 30550.388992220476, 30552.388952220386, 30614.326280846442, 37385.81307093447, 37917.0, 38832.08759343004, 38856.0, 38870.41694374643, 20525.692114618592, 26520.071797487766, 26719.0, 27576.448471030064, 28191.57712634353, 27214.591781122905, 27569.0, 27981.860090699418, 28181.15456536307, 28226.576601351408, 31743.841280793447, 31899.0, 32195.35609287848, 32398.51402228921, 32411.83794081109, 23348.6497702538, 27844.16467505978, 27871.303217418914, 28353.574696379983, 28613.570796438486, 21282.57434851325, 21416.143354266278, 22811.429714257276, 22930.656040159745, 23011.309660710205], "value": 17618.734217124005, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.4904828701647, 433.2980571474212, 434.819549886797, 441.0693436848252, 447.76716107624037, 20306.89846550767, 20885.477863053413, 22310.665340019914, 22386.104555817747, 22408.439789005282, 21176.364709058715, 22545.887270563664, 23319.650205246933, 23777.524449511, 23784.0, 6722.5294229403835, 6936.237013928464, 6979.895301570456, 7010.6494675266285, 7012.439004879598, 6676.432503237231, 6762.560433571826, 6810.353016463428, 6823.863522729543, 6836.965815170942, 6676.532642715012, 6792.218894827084, 6813.965930170342, 6816.045753594476, 6831.2144103428245, 6620.371064748865, 6761.222459417181, 6786.72853085876, 6789.93210067898, 6792.354726300993, 6923.930760692379, 7255.383292420151, 7367.926320736778, 7376.815579610499, 7396.815079623052, 26556.73443265562, 27209.45581088387, 27334.316642083908, 27609.86195069032, 27886.0, 2720.863956802152, 2855.9000434984882, 2945.7937944343903, 3030.3939212157657, 3054.57235986962, 16203.1088290144, 16231.350745970147, 16320.67358652832, 16898.658592786043, 17082.402115925885, 2047.1095073643014, 2054.1064636883, 2054.753429588444, 2055.5683306505653, 2060.783617720133, 156944.0, 168742.0, 168754.0, 168778.3122168775, 170019.14990425092, 17007.914960425118, 20831.8958405207, 20861.58276834455, 20961.475963101046, 21015.684764728543, 28695.13914582566, 31342.216444588612, 31914.723411063762, 31997.0, 32002.039938801874, 10020.899791002143, 10116.443595602166, 10293.7426564335, 10363.378197308035, 10483.423411712276, 6770.695318710571, 8218.465799722999, 8378.622961966727, 8397.160283971554, 8544.487330760174, 8913.0, 9043.914730232415, 9677.564509597085, 9785.119339259501, 9852.458114803754, 3538.363094642989, 3720.0, 4269.612375977819, 4278.748151404955, 4329.5237523872975, 1038.7299302181336, 1046.8115739167024, 1056.3292309383596, 1058.6083149234678, 1074.3500182389698, 16222.513324600044, 21072.683909741365, 21288.893555532122, 21290.893545532173, 21481.0, 1031.896810318962, 1044.8223801953534, 1061.3366645846345, 1064.3135177810268, 1068.7541865370852, 10435.32170408921, 10927.235093543375, 10937.234393592373, 10993.285436446766, 11180.776384472427, 704032.4798376078, 775873.0, 782588.0, 790413.0, 799354.0, 167520.0, 168357.15821420815, 169313.0, 170313.0, 173029.4045589317, 1212.6119641714567, 1223.8837310455492, 1297.7145028093994, 1299.2789002103923, 1315.5592876386327, 20089.694169878912, 20135.093920773892, 20366.796332037084, 20489.590208195455, 21030.369088927357, 67482.66258668675, 67849.81166669933, 67968.6601566989, 68856.0, 69196.65401673161, 63489.68255158695, 89480.5525972366, 98503.0, 98562.57905815249, 99950.0, 7473.701051957861, 10027.949860250652, 11269.380184089954, 11659.659139198762, 11875.821862671894, 12631.810522842348, 12746.872531274568, 12772.872271277169, 12959.481620735442, 12998.620358706994, 9414.811703766023, 10923.689157300856, 10992.340459572451, 11002.834957475485, 11562.88437115618, 9225.538723063686, 9506.61973521079, 10306.433146176732, 10555.525001374803, 10633.521491532745, 11410.14423918193, 11426.371549564521, 11450.599229026944, 11526.538938442704, 11664.358460284766, 11594.88405115938, 11705.590304339306, 11881.821772673244, 11940.70148246266, 12033.398330083286, 11057.447127643425, 11141.053010494199, 11150.665480035612, 11188.881111888746, 11258.0], "value": 11744.226321235714, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1403.3334166271022, 1570.0501196775942, 1594.2028985507247, 1603.7754714339987, 1606.5260748079315, 9550.331476796628, 10840.72898177545, 11529.538818447272, 11530.481128349224, 11924.224925379865, 11270.661880143589, 11439.428028598579, 11470.197086203949, 11489.195756297062, 11489.770204595923, 2431.513697260546, 2479.0331770609478, 2479.0951302774447, 2480.193936970483, 2486.5151295497385, 2062.4328309714797, 2412.7587241275905, 2432.963505547418, 2457.45935894103, 2464.8890799914047, 2387.1883559589737, 2452.681151450309, 2453.668754718108, 2463.741307162749, 2464.297675162579, 2383.1063351243283, 2404.3868813452546, 2423.87880605969, 2431.683881095455, 2459.2990997565785, 2426.0902161689364, 2433.1362366359863, 2454.914078007279, 2459.6433517140094, 2461.3354394313615, 11268.042216411615, 11468.770624587545, 11495.2528085675, 11500.252483588623, 11517.827232591519, 5913.852153696192, 6109.938900610981, 6111.236095488064, 6112.63324200545, 6118.785842495491, 3589.928201435983, 3676.889693309205, 3703.4629978652943, 3704.203596226824, 3732.253549290153, 1158.9304641721524, 1163.6443543272078, 1206.1737709668905, 1249.5564074753422, 1263.418827339425, 13846.792298115435, 14182.503612373517, 15110.244487775677, 16074.919625401799, 16245.91877040619, 4709.929351059737, 4812.109759694467, 4813.7593120343845, 4896.95103048972, 4900.754962251945, 11798.292102473879, 11914.761704765857, 11944.940275298568, 11946.820797688042, 11972.64082077539, 4955.554000139932, 5994.820155395345, 5999.6400215986305, 5999.790007349722, 6011.48902343297, 5374.435684253175, 5380.515753582196, 5417.404085550586, 5428.859939412689, 5462.071447853875, 3939.6454319111417, 4015.799210039545, 4036.1524079942956, 4097.078157414558, 4111.958880411157, 1056.2817284246632, 1069.9037086662238, 1079.7840431913648, 1094.1738987064716, 1098.555085190499, 975.3952549419264, 977.5063592885547, 1000.0549480740775, 1006.5269323417982, 1028.2442404832443, 6669.199696036507, 6685.0, 6744.865102697919, 6866.553674011173, 6935.826604334932, 958.0, 964.1900803325241, 973.1825266775942, 982.3418309732353, 1008.1682611845257, 4244.702870799015, 4338.0890013097605, 4350.32569951658, 4469.508354081048, 4494.07871386365, 13570.728585428433, 14120.85879141216, 14135.293235338399, 14137.85862141386, 14162.079464834753, 10480.528376222936, 13472.259025753481, 14034.298285085704, 14105.36525856339, 14118.364673589507, 8641.222289993804, 10272.845907311395, 10537.367757934548, 10537.473126343806, 10544.472776361305, 5946.167536544801, 6941.861162776817, 6957.721691132298, 7073.787786366417, 7079.752208672672, 11855.0, 11937.880621194025, 12167.878321216675, 12192.939035304767, 12207.023438125107, 12151.817722734342, 12161.878381216075, 12307.753844922872, 12309.076819238413, 12312.938435307766, 9284.0, 9479.952600237231, 9508.0, 9597.184239339735, 9604.0, 10350.068493835592, 10393.168546516412, 10448.05967462932, 10514.369137851754, 10531.420771857622, 7419.332260096618, 8897.466152030898, 8964.282857371265, 9111.726648200565, 9117.726468205965, 8677.1756683115, 8740.431871928304, 8748.47509149453, 8808.5595720215, 8898.0, 7124.323189297009, 7597.974273473232, 7743.109542402696, 7842.843143136991, 7979.680812767424, 5276.973615131899, 5473.616846820684, 5715.514181294637, 5893.852653683693, 6060.030395136933, 5108.28484012246, 6037.486813620892, 6055.182550355646, 6077.179580756718, 6173.629582225081], "value": 5212.577568460419, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.67942614802865, 336.6969727245479, 381.15954320722807, 383.17999481110445, 387.7634642867848, 5254.7635356408955, 5353.598480113992, 5363.425555733245, 5415.377231618365, 5451.3458384993755, 5170.767315470804, 5183.403908550517, 5191.260927589253, 5281.577473802096, 5385.165299378603, 3877.573466918651, 4225.302825033866, 4353.956460435386, 4358.585934336233, 4406.97796511017, 4230.851920182794, 4254.532001479834, 4411.625011873978, 4443.422355093833, 4484.349769283452, 3932.469116669256, 4070.0231944333295, 4384.8026838792175, 4388.802503887333, 4408.250597398434, 4178.415021896937, 4313.892152696177, 4317.827286908519, 4359.956400435986, 4401.713888597263, 3980.4029395590605, 4018.3369743992207, 4028.697847661437, 4028.738132021409, 4037.2732908076537, 4240.9151816963795, 4710.458297295821, 5104.487153873844, 5168.934444244661, 5195.636305458619, 4567.771611419415, 4741.786619602126, 4817.012512434942, 4985.958565275179, 5082.23766435034, 5360.3567571891235, 5393.460653934614, 5644.0737225913035, 5690.857728556778, 5708.26108898672, 4260.785676082332, 4450.332450132473, 4473.239549276631, 4475.1944649963, 4525.389072475206, 4999.4250661174065, 5139.0749665060275, 5283.682979021271, 5461.317335333083, 5529.225908372831, 4583.816647334136, 4612.262038073892, 4613.284940834176, 4633.0, 4659.627229821606, 3896.4155376693725, 4338.913221735547, 4663.784702266396, 4698.3187437821325, 4726.952730472652, 4053.5204650302426, 4402.4056752338665, 4566.589006989387, 4818.6626936114135, 4896.706197628154, 4784.497627749106, 4860.586850117779, 5302.3637163540625, 5680.091185410397, 5694.06048002075, 1296.4425297122139, 1366.6788304748377, 1579.9414392357148, 1581.541353007638, 1595.4974183132276, 1083.913286937043, 1098.9340639561651, 1120.0591503137405, 1195.9760804783855, 1209.3046498263534, 4482.977585112054, 4543.931841022388, 5106.706174517415, 5134.947335796152, 5165.018646457161, 5009.949900500948, 5712.285964254468, 5791.855203619859, 5835.986584628381, 5855.822107676442, 3985.621365970228, 5157.432682404932, 5165.819196328186, 5210.38478071799, 5229.294045303911, 2462.1997850698594, 2805.452936677328, 2925.9570047150723, 3062.4028314478464, 3071.5392691096513, 5864.0, 5994.4932214654045, 6047.367210853045, 6049.334573196945, 6126.08108783686, 4932.778024988812, 4941.171766446366, 5499.4225606310765, 5796.449337312949, 6008.399160084044, 5279.868003299948, 5722.599418040781, 5745.655260684456, 6118.694065296718, 6150.692465376803, 5233.947660523499, 5689.431056894277, 5831.7667293307795, 5863.472287494146, 5960.552958528041, 4626.560476754703, 4801.759912004316, 4942.629302802232, 5215.582753379645, 5717.856428714191, 5597.8448297404975, 5829.222087263425, 5918.467337939606, 6083.300420451705, 6094.329623741296, 3968.5832987537046, 4116.958830411658, 4228.51372092201, 4578.908421831611, 4579.015511665008, 4958.752062396938, 5355.732213389393, 5366.275552800478, 5753.1945527627, 5863.677497737665, 5305.628605997543, 5672.177534257592, 5685.71571421419, 5810.854728631818, 5867.765289388377, 5292.682439053669, 5660.632058916157, 5702.743376548148, 5735.56983226268, 5776.971115144397, 4669.18289299378, 5376.225845471064, 5459.553218397048, 5514.889702206014, 5648.83053508379, 4924.729139897197, 5162.716050617102, 5385.865353366197, 5659.6887171204335, 5714.685692286964, 5268.420473747961, 5506.724663766876, 5559.526725417848, 5631.239782629293, 5658.349289831722], "value": 4280.578218644631, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.8444226712394, 774.7211004038542, 775.9922400775994, 844.2865778417237, 866.1987661413191, 15845.683086338266, 16040.438584649524, 16498.42255521057, 16652.250648720805, 16668.49994500164, 15035.0, 15337.156456394894, 15354.078755274664, 15475.0, 15477.303521341539, 951.8667386565869, 966.6471737815682, 970.0396607358699, 973.1825266775907, 974.2108891797667, 955.8470644696849, 965.1217392173124, 966.9903300967006, 986.9309148359617, 991.6578780320777, 1010.1767059846202, 1012.4836333469947, 1013.716159475348, 1014.7666036811501, 1018.1396719771781, 1009.2682804966414, 1012.3015119567475, 1012.5494155100984, 1013.3717095400825, 1013.3970287678819, 750.5496701978824, 760.1448370583093, 760.6501009535621, 761.5430741555078, 761.6191904047976, 15494.380224791108, 15963.281652325673, 16332.265048072746, 16568.66862662752, 17504.38734644294, 13081.41133648988, 13734.244616546086, 13918.791218131737, 14231.932605054662, 14549.636259093608, 11822.822657660143, 11860.22908510944, 11873.762524749543, 11991.760164796742, 12019.0, 3382.7991063172467, 3544.29114177163, 3731.7201209909367, 3876.4960555127936, 3884.3396622574232, 107689.15685520388, 109554.0, 112939.0, 113987.43006284999, 114539.42730286378, 10952.890471095347, 11059.391733454577, 11066.557337706563, 11386.658400248005, 11428.428578571038, 22659.546809064057, 22736.431589210402, 22943.541129177323, 22978.655320169877, 23155.768442315697, 7521.172671006185, 7541.849163016709, 7624.237576242332, 7657.349125324298, 7893.486923349964, 4369.257226271541, 4463.687541872103, 4478.57453541913, 4510.571495707903, 4636.466806317249, 3537.557805274341, 3591.174029973121, 3608.350496910581, 3611.963880361163, 3616.945745813815, 587.4155215560545, 602.7227475361295, 605.8061420345535, 618.1654766065865, 620.4385031546367, 702.4661257444277, 713.0124777183535, 723.4284914917157, 738.5273425007999, 744.8100734312824, 8961.283097352327, 9822.950885245671, 10050.798984020425, 10362.673771896307, 10618.150547956146, 678.107041918889, 698.9615571143535, 711.7010855440727, 720.935115839577, 722.8482018776116, 4634.467036290802, 5067.113255180328, 5092.8472145835685, 5104.030234255554, 5149.304843846033, 102453.97546024593, 103247.0, 108100.0, 109466.0, 109966.0, 84796.57601712075, 86336.56831715802, 88010.0, 88325.55837220901, 89705.0, 70377.59244814972, 82348.0, 82867.0, 82982.5850870754, 83668.58165709133, 10645.627403040857, 11058.019799026342, 11126.944365278445, 11251.38117403518, 11302.152338574475, 33047.834760826045, 39374.80312598419, 42016.78991605023, 45270.320945186504, 50040.0, 53890.73054634702, 54260.45739542712, 62131.0, 66040.0, 70224.94662579964, 13021.283829389475, 13184.472621095048, 13431.462741490623, 13440.395182216627, 13549.458021679022, 14882.925585372004, 14987.925060374628, 15062.774058389352, 15130.0, 15303.693926121638, 13754.996003197202, 13930.18439503971, 13986.0, 14403.855961440251, 14498.710025799213, 13517.121387110199, 14089.365978530786, 14169.411223780578, 14329.211893345966, 14382.712345752818, 13488.595342139752, 13672.3101748008, 13689.657758556115, 13722.931385343009, 14429.567112986628, 9656.517174141125, 10196.45088727818, 10335.896641033794, 10480.737981550523, 10699.358038517714, 8167.0, 10338.689839304832, 10926.289791163867, 10957.887025560978, 11000.614978475714], "value": 7744.702139768491, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 167.0, 119.0, 120.0, 119.0, 119.0, 120.0, 119.0, 118.0, 120.0], "value": 123.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 129.0, 97.0, 164.0, 131.0, 99.0, 131.0, 138.0, 131.0, 125.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 197.0, 199.0, 196.0, 191.0, 197.0, 198.0, 198.0, 202.0, 195.0], "value": 197.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 58.0, 60.0, 88.0, 61.0, 64.0, 85.0, 51.0, 91.0, 82.0], "value": 71.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 70.0, 84.0, 78.0, 103.0, 100.0, 96.0, 72.0, 72.0, 83.0], "value": 85.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 89.0, 87.0, 90.0, 88.0, 88.0, 89.0, 89.0, 89.0], "value": 88.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 134.0, 144.0, 154.0, 124.0, 97.0, 98.0, 112.0], "value": 115.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 93.0, 90.0, 112.0, 97.0, 107.0, 127.0, 139.0, 75.0, 139.0], "value": 107.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 67.0, 69.0, 70.0, 67.0, 82.0, 99.0, 106.0], "value": 75.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 62.0, 61.0, 67.0, 64.0, 57.0, 57.0, 65.0, 83.0, 82.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 85.0, 84.0, 71.0, 85.0, 95.0, 102.0, 97.0, 79.0, 93.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 143.0, 144.0, 146.0, 149.0, 149.0, 161.0, 153.0, 202.0, 156.0], "value": 154.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 163.0, 170.0, 168.0, 166.0, 186.0, 170.0, 167.0, 165.0], "value": 169.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 78.0, 82.0, 82.0, 86.0, 86.0, 64.0, 66.0], "value": 74.6, "unit": "score"}]}]} 23:33:24 INFO - Return code: 0 23:33:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:33:24 ERROR - # TBPL SUCCESS # 23:33:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:33:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:33:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:33:24 INFO - 2017-05-18 23:33:24.342 screenresolution[1662:12520] starting screenresolution argv=screenresolution get 23:33:24 INFO - 2017-05-18 23:33:24.344 screenresolution[1662:12520] Display 0: 1600x1200x32@60 23:33:24 INFO - 2017-05-18 23:33:24.350 screenresolution[1663:12523] starting screenresolution argv=screenresolution list 23:33:24 INFO - Available Modes on Display 0 23:33:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:33:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:33:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:33:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:33:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:33:24 INFO - Intel Iris: 23:33:24 INFO - Chipset Model: Intel Iris 23:33:24 INFO - Type: GPU 23:33:24 INFO - Bus: Built-In 23:33:24 INFO - VRAM (Dynamic, Max): 1536 MB 23:33:24 INFO - Vendor: Intel (0x8086) 23:33:24 INFO - Device ID: 0x0a2e 23:33:24 INFO - Revision ID: 0x0009 23:33:24 INFO - Displays: 23:33:24 INFO - Display: 23:33:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:33:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:33:24 INFO - Display Serial Number: 1600x1200 60 23:33:24 INFO - Main Display: Yes 23:33:24 INFO - Mirror: Off 23:33:24 INFO - Online: Yes 23:33:24 INFO - Rotation: Supported 23:33:24 INFO - Return code: 0 23:33:24 INFO - Running post-action listener: _resource_record_post_action 23:33:24 INFO - [mozharness: 2017-05-19 06:33:24.596157Z] Finished run-tests step (success) 23:33:24 INFO - Running post-run listener: _resource_record_post_run 23:33:24 INFO - Total resource usage - Wall time: 1197s; CPU: 55.0%; Read bytes: 34856960; Write bytes: 513542144; Read time: 213; Write time: 1625 23:33:24 INFO - TinderboxPrint: CPU usage
54.5% 23:33:24 INFO - TinderboxPrint: I/O read bytes / time
34,856,960 / 213 23:33:24 INFO - TinderboxPrint: I/O write bytes / time
513,542,144 / 1,625 23:33:24 INFO - TinderboxPrint: CPU idle
2,177.2 (45.5%) 23:33:24 INFO - TinderboxPrint: CPU system
957.4 (20.0%) 23:33:24 INFO - TinderboxPrint: CPU user
1,655.2 (34.6%) 23:33:24 INFO - TinderboxPrint: Swap in / out
239,734,784 / 0 23:33:24 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206469632; Write bytes: 199438336; Read time: 15665; Write time: 413 23:33:24 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 32337920; Write bytes: 303036416; Read time: 186; Write time: 1180 23:33:25 INFO - Running post-run listener: _upload_blobber_files 23:33:25 INFO - Blob upload gear active. 23:33:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:33:25 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 23:33:25 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', 'Jamun', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:33:25 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 Jamun -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:33:25 INFO - (blobuploader) - INFO - Open directory for files ... 23:33:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:33:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:33:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:33:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:33:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:33:26 INFO - (blobuploader) - INFO - Done attempting. 23:33:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:33:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:33:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:33:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:33:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:33:27 INFO - (blobuploader) - INFO - Done attempting. 23:33:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 23:33:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:33:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:33:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 23:33:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:33:28 INFO - (blobuploader) - INFO - Done attempting. 23:33:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:33:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:33:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:33:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:33:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:33:30 INFO - (blobuploader) - INFO - Done attempting. 23:33:30 INFO - (blobuploader) - INFO - Iteration through files over. 23:33:30 INFO - Return code: 0 23:33:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:33:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:33:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/81ddea19f0dd983726e49b4751ebf24efaeb04988b2f245e3727fa536ceacb13d72955a6f00f743214f76e5ff5ec9503dc56cd6c3bc46dea715c733b1f552da2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/9bf38369524e3460fe6de768f61f7ae74abffeb43ced1efecf85e2b74224e041fb98dd4ff972c7551ac66108a9046c63d9205f9abd4952adcf76592ef120ff0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/83d0063bc0c13ac2b1d7f70a76537324cd31a4813a46be1c038553966ac504183f54404bdcf0ecb7aedc6ccf40d8a502c731c192e3baa7bd3b21117c8dcbab71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/542638a6005c6e29f248165c198e47d91c0d3ccaf59f998b4ccd5f06001cd004b08406bde5e741d08fb9cf4e110297b6d5ec5eb7b6f2959d4851df8c4293009c"} 23:33:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:33:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:33:30 INFO - Contents: 23:33:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/81ddea19f0dd983726e49b4751ebf24efaeb04988b2f245e3727fa536ceacb13d72955a6f00f743214f76e5ff5ec9503dc56cd6c3bc46dea715c733b1f552da2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/9bf38369524e3460fe6de768f61f7ae74abffeb43ced1efecf85e2b74224e041fb98dd4ff972c7551ac66108a9046c63d9205f9abd4952adcf76592ef120ff0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/83d0063bc0c13ac2b1d7f70a76537324cd31a4813a46be1c038553966ac504183f54404bdcf0ecb7aedc6ccf40d8a502c731c192e3baa7bd3b21117c8dcbab71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/542638a6005c6e29f248165c198e47d91c0d3ccaf59f998b4ccd5f06001cd004b08406bde5e741d08fb9cf4e110297b6d5ec5eb7b6f2959d4851df8c4293009c"} 23:33:30 INFO - Running post-run listener: copy_logs_to_upload_dir 23:33:30 INFO - Copying logs to upload dir... 23:33:30 INFO - mkdir: /builds/slave/test/build/upload/logs 23:33:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2482.419198 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 41 mins, 22 secs) (at 2017-05-18 23:33:30.222673) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-18 23:33:30.225921) ========= 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.VuyA1WMKVP/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.VvqF7uaUWp/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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/Jamun/sha512/81ddea19f0dd983726e49b4751ebf24efaeb04988b2f245e3727fa536ceacb13d72955a6f00f743214f76e5ff5ec9503dc56cd6c3bc46dea715c733b1f552da2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/9bf38369524e3460fe6de768f61f7ae74abffeb43ced1efecf85e2b74224e041fb98dd4ff972c7551ac66108a9046c63d9205f9abd4952adcf76592ef120ff0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/83d0063bc0c13ac2b1d7f70a76537324cd31a4813a46be1c038553966ac504183f54404bdcf0ecb7aedc6ccf40d8a502c731c192e3baa7bd3b21117c8dcbab71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/542638a6005c6e29f248165c198e47d91c0d3ccaf59f998b4ccd5f06001cd004b08406bde5e741d08fb9cf4e110297b6d5ec5eb7b6f2959d4851df8c4293009c"} build_url:https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009455 build_url: 'https://queue.taskcluster.net/v1/task/HIuSRRq0RIyj4EzoP7lGMw/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/81ddea19f0dd983726e49b4751ebf24efaeb04988b2f245e3727fa536ceacb13d72955a6f00f743214f76e5ff5ec9503dc56cd6c3bc46dea715c733b1f552da2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/9bf38369524e3460fe6de768f61f7ae74abffeb43ced1efecf85e2b74224e041fb98dd4ff972c7551ac66108a9046c63d9205f9abd4952adcf76592ef120ff0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/83d0063bc0c13ac2b1d7f70a76537324cd31a4813a46be1c038553966ac504183f54404bdcf0ecb7aedc6ccf40d8a502c731c192e3baa7bd3b21117c8dcbab71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/542638a6005c6e29f248165c198e47d91c0d3ccaf59f998b4ccd5f06001cd004b08406bde5e741d08fb9cf4e110297b6d5ec5eb7b6f2959d4851df8c4293009c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-18 23:33:30.256152) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 23:33:30.256719) ========= 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.VuyA1WMKVP/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.VvqF7uaUWp/Listeners TMPDIR=/var/folders/f4/cdjwhlw50ss_jzdmf27sh_yw00000w/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.004927 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 23:33:30.307880) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-18 23:33:30.308198) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-18 23:33:30.308550) ========= ========= Total master_lag: 0.17 =========