builder: jamun_yosemite_r7_devedition_test-dromaeojs-e10s slave: t-yosemite-r7-0365 starttime: 1495246719.58 results: success (0) buildid: 20170519111123 builduid: afc8dff692c24a1ea1ef90675fb7bc81 revision: c3d5dc1002044b0b5c4fdc38de4db8a7f70429a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 19:18:39.582605) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 19:18:39.583070) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 19:18:39.583350) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 19:18:39.610956) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 19:18:39.611365) ========= 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.DhU45StL7j/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.wC7y7i2npZ/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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-19 19:18:39-- 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% 7.89M=0.001s 2017-05-19 19:18:39 (7.89 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084949 ========= master_lag: 0.54 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 19:18:40.240982) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 19:18:40.241329) ========= 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.DhU45StL7j/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.wC7y7i2npZ/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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.023552 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 19:18:40.287082) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-19 19:18:40.287448) ========= bash -c 'python archiver_client.py mozharness --repo projects/jamun --rev c3d5dc1002044b0b5c4fdc38de4db8a7f70429a7 --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 c3d5dc1002044b0b5c4fdc38de4db8a7f70429a7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DhU45StL7j/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.wC7y7i2npZ/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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-19 19:18:40,374 truncating revision to first 12 chars 2017-05-19 19:18:40,374 Setting DEBUG logging. 2017-05-19 19:18:40,374 attempt 1/10 2017-05-19 19:18:40,374 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/jamun/c3d5dc100204?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-19 19:18:42,133 unpacking tar archive at: jamun-c3d5dc100204/testing/mozharness/ program finished with exit code 0 elapsedTime=2.029520 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-19 19:18:42.337906) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 19:18:42.338330) ========= script_repo_revision: c3d5dc1002044b0b5c4fdc38de4db8a7f70429a7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 19:18:42.338810) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 19:18:42.339082) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 19:18:42.358440) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 41 mins, 24 secs) (at 2017-05-19 19:18:42.358875) ========= /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.DhU45StL7j/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.wC7y7i2npZ/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 19:18:42 INFO - MultiFileLogger online at 20170519 19:18:42 in /builds/slave/test 19:18:42 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 19:18:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:18:42 INFO - {'append_to_log': False, 19:18:42 INFO - 'base_work_dir': '/builds/slave/test', 19:18:42 INFO - 'blob_upload_branch': 'Jamun', 19:18:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:18:42 INFO - 'branch': 'Jamun', 19:18:42 INFO - 'buildbot_json_path': 'buildprops.json', 19:18:42 INFO - 'config_files': ('talos/mac_config.py',), 19:18:42 INFO - 'default_actions': ('clobber', 19:18:42 INFO - 'read-buildbot-config', 19:18:42 INFO - 'download-and-extract', 19:18:42 INFO - 'populate-webroot', 19:18:42 INFO - 'create-virtualenv', 19:18:42 INFO - 'install', 19:18:42 INFO - 'run-tests'), 19:18:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:18:42 INFO - 'download_minidump_stackwalk': True, 19:18:42 INFO - 'download_symbols': 'ondemand', 19:18:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:18:42 INFO - 'tooltool.py': '/tools/tooltool.py', 19:18:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:18:42 INFO - '/tools/misc-python/virtualenv.py')}, 19:18:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:18:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:18:42 INFO - 'gecko_profile': False, 19:18:42 INFO - 'gecko_profile_interval': 0, 19:18:42 INFO - 'installer_path': 'installer.exe', 19:18:42 INFO - 'log_level': 'info', 19:18:42 INFO - 'log_name': 'talos', 19:18:42 INFO - 'log_to_console': True, 19:18:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:18:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:18:42 INFO - 'opt_config_files': (), 19:18:42 INFO - 'pip_index': False, 19:18:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:18:42 INFO - 'cmd': ('bash', 19:18:42 INFO - '-c', 19:18:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:18:42 INFO - 'enabled': True, 19:18:42 INFO - 'halt_on_failure': False, 19:18:42 INFO - 'name': 'check_screen_resolution'},), 19:18:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:18:42 INFO - 'cmd': ('bash', 19:18:42 INFO - '-c', 19:18:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:18:42 INFO - 'enabled': True, 19:18:42 INFO - 'halt_on_failure': False, 19:18:42 INFO - 'name': 'check_screen_resolution'},), 19:18:42 INFO - 'run_cmd_checks_enabled': True, 19:18:42 INFO - 'suite': 'dromaeojs-e10s', 19:18:42 INFO - 'system_bits': '32', 19:18:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:18:42 INFO - 'title': 't-yosemite-r7-0365', 19:18:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:18:42 INFO - 'use_talos_json': True, 19:18:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:18:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:18:42 INFO - 'work_dir': 'build'} 19:18:42 INFO - [mozharness: 2017-05-20 02:18:42.564643Z] Running clobber step. 19:18:42 INFO - Running pre-action listener: _resource_record_pre_action 19:18:42 INFO - Running main action method: clobber 19:18:42 INFO - rmtree: /builds/slave/test/build 19:18:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:18:44 INFO - Running post-action listener: _resource_record_post_action 19:18:44 INFO - [mozharness: 2017-05-20 02:18:44.492479Z] Finished clobber step (success) 19:18:44 INFO - [mozharness: 2017-05-20 02:18:44.492683Z] Running read-buildbot-config step. 19:18:44 INFO - Running pre-action listener: _resource_record_pre_action 19:18:44 INFO - Running main action method: read_buildbot_config 19:18:44 INFO - Using buildbot properties: 19:18:44 INFO - { 19:18:44 INFO - "project": "", 19:18:44 INFO - "product": "firefox", 19:18:44 INFO - "script_repo_revision": "production", 19:18:44 INFO - "builddir": "jamun_yosemite_r7_devedition_test-dromaeojs-e10s", 19:18:44 INFO - "repository": "", 19:18:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 DevEdition jamun talos dromaeojs-e10s", 19:18:44 INFO - "buildid": "20170519111123", 19:18:44 INFO - "pgo_build": "False", 19:18:44 INFO - "basedir": "/builds/slave/test", 19:18:44 INFO - "buildnumber": 2, 19:18:44 INFO - "slavename": "t-yosemite-r7-0365", 19:18:44 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 19:18:44 INFO - "platform": "yosemite_r7_devedition", 19:18:44 INFO - "scheduler": "tests-jamun-macosx64-devedition-talos", 19:18:44 INFO - "branch": "jamun", 19:18:44 INFO - "repo_path": "projects/jamun", 19:18:44 INFO - "revision": "c3d5dc1002044b0b5c4fdc38de4db8a7f70429a7", 19:18:44 INFO - "stage_platform": "macosx64-devedition", 19:18:44 INFO - "builduid": "afc8dff692c24a1ea1ef90675fb7bc81", 19:18:44 INFO - "slavebuilddir": "test" 19:18:44 INFO - } 19:18:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 19:18:44 INFO - Running post-action listener: _resource_record_post_action 19:18:44 INFO - [mozharness: 2017-05-20 02:18:44.496660Z] Finished read-buildbot-config step (success) 19:18:44 INFO - [mozharness: 2017-05-20 02:18:44.496808Z] Running download-and-extract step. 19:18:44 INFO - Running pre-action listener: _resource_record_pre_action 19:18:44 INFO - Running main action method: download_and_extract 19:18:44 INFO - mkdir: /builds/slave/test/build/tests 19:18:44 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')]} 19:18:44 INFO - trying https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 19:18:44 INFO - Downloading https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/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 19:18:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/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 19:18:45 INFO - Downloaded 1287 bytes. 19:18:45 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 19:18:45 INFO - Using the following test package requirements: 19:18:45 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:18:45 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 19:18:45 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 19:18:45 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:18:45 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 19:18:45 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:18:45 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 19:18:45 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 19:18:45 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:18:45 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 19:18:45 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 19:18:45 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:18:45 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 19:18:45 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:18:45 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 19:18:45 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:18:45 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 19:18:45 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:18:45 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 19:18:45 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 19:18:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 19:18:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 19:18:45 INFO - Fetch https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 19:18:47 INFO - Expected file size: 51793962 19:18:47 INFO - Obtained file size: 51793962 19:19:03 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 19:19:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 19:19:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 19:19:03 INFO - Fetch https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 19:19:04 INFO - Expected file size: 51793962 19:19:04 INFO - Obtained file size: 51793962 19:19:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 19:19:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 19:19:19 INFO - Fetch https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 19:19:20 INFO - Expected file size: 14404449 19:19:20 INFO - Obtained file size: 14404449 19:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:20 INFO - trying https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:19:20 INFO - Downloading https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 19:19:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/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 19:19:23 INFO - Downloaded 74763169 bytes. 19:19:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:19:23 INFO - mkdir: /builds/slave/test/properties 19:19:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:19:23 INFO - Writing to file /builds/slave/test/properties/build_url 19:19:23 INFO - Contents: 19:19:23 INFO - build_url:https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:19:23 INFO - Running post-action listener: _resource_record_post_action 19:19:23 INFO - Running post-action listener: set_extra_try_arguments 19:19:23 INFO - [mozharness: 2017-05-20 02:19:23.706595Z] Finished download-and-extract step (success) 19:19:23 INFO - [mozharness: 2017-05-20 02:19:23.706700Z] Running populate-webroot step. 19:19:23 INFO - Running pre-action listener: _resource_record_pre_action 19:19:23 INFO - Running main action method: populate_webroot 19:19:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:19:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:19:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:19:23 INFO - '--tppagecycles', 19:19:23 INFO - '7'], 19:19:23 INFO - 'tests': ['tsvgm']}}, 19:19:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:19:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:19:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:19:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:19:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:19:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:19:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:19:23 INFO - 'talos_options': ['--disable-e10s'], 19:19:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:19:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:19:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:19:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:19:23 INFO - 'talos_options': ['--disable-e10s'], 19:19:23 INFO - 'tests': ['damp', 'tps']}, 19:19:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:19:23 INFO - 'tests': ['damp', 'tps']}, 19:19:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:19:23 INFO - 'tests': ['dromaeo_dom']}, 19:19:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:19:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:19:23 INFO - 'tests': ['basic_compositor_video']}, 19:19:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:19:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:19:23 INFO - 'tests': ['a11yr', 19:19:23 INFO - 'ts_paint', 19:19:23 INFO - 'tpaint', 19:19:23 INFO - 'sessionrestore', 19:19:23 INFO - 'sessionrestore_no_auto_restore', 19:19:23 INFO - 'tabpaint']}, 19:19:23 INFO - 'other-e10s': {'tests': ['a11yr', 19:19:23 INFO - 'ts_paint', 19:19:23 INFO - 'tpaint', 19:19:23 INFO - 'sessionrestore', 19:19:23 INFO - 'sessionrestore_no_auto_restore', 19:19:23 INFO - 'tabpaint']}, 19:19:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:19:23 INFO - 'ts_paint', 19:19:23 INFO - 'tpaint', 19:19:23 INFO - 'sessionrestore', 19:19:23 INFO - 'sessionrestore_no_auto_restore', 19:19:23 INFO - 'tabpaint']}, 19:19:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:19:23 INFO - 'ts_paint', 19:19:23 INFO - 'tpaint', 19:19:23 INFO - 'sessionrestore', 19:19:23 INFO - 'sessionrestore_no_auto_restore', 19:19:23 INFO - 'tabpaint']}, 19:19:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:19:23 INFO - 'tests': ['a11yr', 19:19:23 INFO - 'ts_paint', 19:19:23 INFO - 'tpaint', 19:19:23 INFO - 'sessionrestore', 19:19:23 INFO - 'sessionrestore_no_auto_restore', 19:19:23 INFO - 'tabpaint']}, 19:19:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:19:23 INFO - 'tests': ['a11yr', 19:19:23 INFO - 'ts_paint', 19:19:23 INFO - 'tpaint', 19:19:23 INFO - 'sessionrestore', 19:19:23 INFO - 'sessionrestore_no_auto_restore', 19:19:23 INFO - 'tabpaint']}, 19:19:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:19:23 INFO - 'tests': ['tsvgx', 19:19:23 INFO - 'tsvgr_opacity', 19:19:23 INFO - 'tart', 19:19:23 INFO - 'tscrollx', 19:19:23 INFO - 'cart', 19:19:23 INFO - 'tsvg_static']}, 19:19:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:19:23 INFO - 'tsvgr_opacity', 19:19:23 INFO - 'tart', 19:19:23 INFO - 'tscrollx', 19:19:23 INFO - 'cart', 19:19:23 INFO - 'tsvg_static']}, 19:19:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:19:23 INFO - 'talos_options': ['--disable-e10s'], 19:19:23 INFO - 'tests': ['tp5o']}, 19:19:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:19:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:19:23 INFO - 'talos_options': ['--disable-e10s', 19:19:23 INFO - '--xperf_path', 19:19:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:19:23 INFO - 'tests': ['tp5n']}, 19:19:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:19:23 INFO - 'talos_options': ['--xperf_path', 19:19:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:19:23 INFO - 'tests': ['tp5n']}}, 19:19:23 INFO - 'talos.zip': {'path': '', 19:19:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:19:23 INFO - Running post-action listener: _resource_record_post_action 19:19:23 INFO - [mozharness: 2017-05-20 02:19:23.724826Z] Finished populate-webroot step (success) 19:19:23 INFO - [mozharness: 2017-05-20 02:19:23.724964Z] Running create-virtualenv step. 19:19:23 INFO - Running pre-action listener: _resource_record_pre_action 19:19:23 INFO - Running main action method: create_virtualenv 19:19:23 INFO - Creating virtualenv /builds/slave/test/build/venv 19:19:23 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 19:19:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:19:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:19:23 INFO - Using real prefix '/tools/python27' 19:19:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:19:24 INFO - Installing distribute.............................................................................................................................................................................................done. 19:19:27 INFO - Installing pip.................done. 19:19:27 INFO - Return code: 0 19:19:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:19:27 INFO - Reading from file tmpfile_stdout 19:19:27 INFO - Output received: 19:19:27 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) 19:19:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f081b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f084768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc8475750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5fd30>, '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 0x10ed86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54be8>, '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.DhU45StL7j/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.wC7y7i2npZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 19:19:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:19:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DhU45StL7j/Render', 19:19:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:19:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:19:27 INFO - 'HOME': '/Users/cltbld', 19:19:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:19:27 INFO - 'LOGNAME': 'cltbld', 19:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:27 INFO - 'MOZ_NO_REMOTE': '1', 19:19:27 INFO - 'NO_EM_RESTART': '1', 19:19:27 INFO - 'PAGER': '/bin/cat', 19:19:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:27 INFO - 'PWD': '/builds/slave/test', 19:19:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:19:27 INFO - 'SHELL': '/bin/bash', 19:19:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wC7y7i2npZ/Listeners', 19:19:27 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 19:19:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:19:27 INFO - 'USER': 'cltbld', 19:19:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:19:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:27 INFO - 'XPC_FLAGS': '0x0', 19:19:27 INFO - 'XPC_SERVICE_NAME': '0', 19:19:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:27 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 19:19:27 INFO - Cleaning up... 19:19:27 INFO - Return code: 0 19:19:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:19:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f081b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f084768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc8475750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5fd30>, '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 0x10ed86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54be8>, '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.DhU45StL7j/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.wC7y7i2npZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 19:19:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:19:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:19:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DhU45StL7j/Render', 19:19:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:19:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:19:27 INFO - 'HOME': '/Users/cltbld', 19:19:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:19:27 INFO - 'LOGNAME': 'cltbld', 19:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:19:27 INFO - 'MOZ_NO_REMOTE': '1', 19:19:27 INFO - 'NO_EM_RESTART': '1', 19:19:27 INFO - 'PAGER': '/bin/cat', 19:19:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:19:27 INFO - 'PWD': '/builds/slave/test', 19:19:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:19:27 INFO - 'SHELL': '/bin/bash', 19:19:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wC7y7i2npZ/Listeners', 19:19:27 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 19:19:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:19:27 INFO - 'USER': 'cltbld', 19:19:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:19:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:19:27 INFO - 'XPC_FLAGS': '0x0', 19:19:27 INFO - 'XPC_SERVICE_NAME': '0', 19:19:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:19:28 INFO - Downloading/unpacking psutil>=3.1.1 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:19: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 19:22:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:22:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:22:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:22:01 INFO - Installing collected packages: psutil 19:22:01 INFO - Running setup.py install for psutil 19:22:01 INFO - building 'psutil._psutil_osx' extension 19:22:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 19:22:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:22:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:22:01 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 19:22:01 INFO - building 'psutil._psutil_posix' extension 19:22:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 19:22:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:22:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:22:01 INFO - ^ 19:22:01 INFO - 1 warning generated. 19:22:01 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 19:22:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:22:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:22:01 INFO - Successfully installed psutil 19:22:01 INFO - Cleaning up... 19:22:02 INFO - Return code: 0 19:22:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:22: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')]} 19:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22: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')]} 19:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:22:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f081b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f084768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc8475750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5fd30>, '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 0x10ed86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54be8>, '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.DhU45StL7j/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.wC7y7i2npZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 19:22:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:22:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:22:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DhU45StL7j/Render', 19:22:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:22:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:22:03 INFO - 'HOME': '/Users/cltbld', 19:22:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:22:03 INFO - 'LOGNAME': 'cltbld', 19:22:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:22:03 INFO - 'MOZ_NO_REMOTE': '1', 19:22:03 INFO - 'NO_EM_RESTART': '1', 19:22:03 INFO - 'PAGER': '/bin/cat', 19:22:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:22:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:22:03 INFO - 'PWD': '/builds/slave/test', 19:22:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:22:03 INFO - 'SHELL': '/bin/bash', 19:22:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wC7y7i2npZ/Listeners', 19:22:03 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 19:22:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:22:03 INFO - 'USER': 'cltbld', 19:22:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:22:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:22:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:22:03 INFO - 'XPC_FLAGS': '0x0', 19:22:03 INFO - 'XPC_SERVICE_NAME': '0', 19:22:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:22:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:22:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:22: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 19:22: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 19:22: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 19:22: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 19:22: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 19:22: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 19:24:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:24:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:24:35 INFO - Installing collected packages: mozsystemmonitor 19:24:35 INFO - Running setup.py install for mozsystemmonitor 19:24:35 INFO - Successfully installed mozsystemmonitor 19:24:35 INFO - Cleaning up... 19:24:36 INFO - Return code: 0 19:24:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:24:37 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 0x10f081b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f084768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc8475750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5fd30>, '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 0x10ed86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54be8>, '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.DhU45StL7j/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.wC7y7i2npZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 19:24:37 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 19:24:37 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 19:24:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DhU45StL7j/Render', 19:24:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:24:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:24:37 INFO - 'HOME': '/Users/cltbld', 19:24:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:24:37 INFO - 'LOGNAME': 'cltbld', 19:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:24:37 INFO - 'MOZ_NO_REMOTE': '1', 19:24:37 INFO - 'NO_EM_RESTART': '1', 19:24:37 INFO - 'PAGER': '/bin/cat', 19:24:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:24:37 INFO - 'PWD': '/builds/slave/test', 19:24:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:24:37 INFO - 'SHELL': '/bin/bash', 19:24:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wC7y7i2npZ/Listeners', 19:24:37 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 19:24:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:24:37 INFO - 'USER': 'cltbld', 19:24:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:24:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:24:37 INFO - 'XPC_FLAGS': '0x0', 19:24:37 INFO - 'XPC_SERVICE_NAME': '0', 19:24:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:24:37 INFO - Downloading/unpacking jsonschema==2.5.1 19:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:24:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:27:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:29:40 INFO - Downloading functools32-3.2.3-2.tar.gz 19:29:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:29:40 INFO - warning: no files found matching '*.txt' 19:29:40 INFO - no previously-included directories found matching 'build' 19:29:40 INFO - no previously-included directories found matching 'dist' 19:29:40 INFO - no previously-included directories found matching '.git*' 19:29:40 INFO - Installing collected packages: jsonschema, functools32 19:29:40 INFO - Running setup.py install for functools32 19:29:40 INFO - warning: no files found matching '*.txt' 19:29:40 INFO - no previously-included directories found matching 'build' 19:29:40 INFO - no previously-included directories found matching 'dist' 19:29:40 INFO - no previously-included directories found matching '.git*' 19:29:40 INFO - Successfully installed jsonschema functools32 19:29:40 INFO - Cleaning up... 19:29:40 INFO - Return code: 0 19:29:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:41 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 0x10f081b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f084768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc8475750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5fd30>, '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 0x10ed86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54be8>, '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.DhU45StL7j/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.wC7y7i2npZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 19:29:41 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 19:29:41 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 19:29:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DhU45StL7j/Render', 19:29:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:29:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:29:41 INFO - 'HOME': '/Users/cltbld', 19:29:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:29:41 INFO - 'LOGNAME': 'cltbld', 19:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:29:41 INFO - 'MOZ_NO_REMOTE': '1', 19:29:41 INFO - 'NO_EM_RESTART': '1', 19:29:41 INFO - 'PAGER': '/bin/cat', 19:29:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:29:41 INFO - 'PWD': '/builds/slave/test', 19:29:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:29:41 INFO - 'SHELL': '/bin/bash', 19:29:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wC7y7i2npZ/Listeners', 19:29:41 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 19:29:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:29:41 INFO - 'USER': 'cltbld', 19:29:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:29:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:29:41 INFO - 'XPC_FLAGS': '0x0', 19:29:41 INFO - 'XPC_SERVICE_NAME': '0', 19:29:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:29:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:29:42 INFO - Cleaning up... 19:29:42 INFO - Return code: 0 19:29:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:29:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f081b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f084768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc8475750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5fd30>, '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 0x10ed86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54be8>, '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.DhU45StL7j/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.wC7y7i2npZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 19:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:29:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DhU45StL7j/Render', 19:29:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:29:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:29:42 INFO - 'HOME': '/Users/cltbld', 19:29:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:29:42 INFO - 'LOGNAME': 'cltbld', 19:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:29:42 INFO - 'MOZ_NO_REMOTE': '1', 19:29:42 INFO - 'NO_EM_RESTART': '1', 19:29:42 INFO - 'PAGER': '/bin/cat', 19:29:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:29:42 INFO - 'PWD': '/builds/slave/test', 19:29:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:29:42 INFO - 'SHELL': '/bin/bash', 19:29:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wC7y7i2npZ/Listeners', 19:29:42 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 19:29:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:29:42 INFO - 'USER': 'cltbld', 19:29:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:29:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:29:42 INFO - 'XPC_FLAGS': '0x0', 19:29:42 INFO - 'XPC_SERVICE_NAME': '0', 19:29:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:29:42 INFO - Downloading/unpacking blobuploader==1.2.4 19:29:42 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 19:29:42 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 19:29:42 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 19:29:42 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 19:29:42 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 19:29:42 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 19:32:14 INFO - Downloading blobuploader-1.2.4.tar.gz 19:32:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:32:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:32:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:32:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:34:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:34:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:34:45 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 19:34:45 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 19:34:45 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 19:34:45 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 19:34:45 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 19:34:45 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 19:37:16 INFO - Downloading docopt-0.6.1.tar.gz 19:37:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:37:16 INFO - Installing collected packages: blobuploader, requests, docopt 19:37:16 INFO - Running setup.py install for blobuploader 19:37:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:37:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:37:16 INFO - Running setup.py install for requests 19:37:17 INFO - Running setup.py install for docopt 19:37:17 INFO - Successfully installed blobuploader requests docopt 19:37:17 INFO - Cleaning up... 19:37:17 INFO - Return code: 0 19:37:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:18 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 0x10f081b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f084768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc8475750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5fd30>, '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 0x10ed86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54be8>, '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.DhU45StL7j/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.wC7y7i2npZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 19:37:18 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 19:37:18 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 19:37:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DhU45StL7j/Render', 19:37:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:18 INFO - 'HOME': '/Users/cltbld', 19:37:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:18 INFO - 'LOGNAME': 'cltbld', 19:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:18 INFO - 'MOZ_NO_REMOTE': '1', 19:37:18 INFO - 'NO_EM_RESTART': '1', 19:37:18 INFO - 'PAGER': '/bin/cat', 19:37:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:18 INFO - 'PWD': '/builds/slave/test', 19:37:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:18 INFO - 'SHELL': '/bin/bash', 19:37:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wC7y7i2npZ/Listeners', 19:37:18 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 19:37:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:18 INFO - 'USER': 'cltbld', 19:37:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:18 INFO - 'XPC_FLAGS': '0x0', 19:37:18 INFO - 'XPC_SERVICE_NAME': '0', 19:37:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:37:18 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-ZcnVdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:37:19 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-AHswla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:37:19 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-dtpEJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:37:19 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-VblB0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:37:19 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-ASAzLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:37:19 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-sGPJe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:37:19 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-Xowz8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:37:19 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-mIDQdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:37:19 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-L0sFZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:37:19 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-q5446R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:37:20 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-4lXuoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:37:20 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-ENR5Lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:37:20 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-2LXK7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:37:20 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-RyoBq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:37:20 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-k3SNY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:37:20 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-qoyLPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:37:20 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-BkfsQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:37:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:37:20 INFO - Running setup.py install for manifestparser 19:37:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:37:20 INFO - Running setup.py install for mozcrash 19:37:21 INFO - Running setup.py install for mozdebug 19:37:21 INFO - Running setup.py install for mozdevice 19:37:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:37:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:37:21 INFO - Running setup.py install for mozfile 19:37:21 INFO - Running setup.py install for mozhttpd 19:37:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:37:21 INFO - Running setup.py install for mozinfo 19:37:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:37:21 INFO - Running setup.py install for mozInstall 19:37:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:37:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:37:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:37:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:37:21 INFO - Running setup.py install for mozleak 19:37:22 INFO - Running setup.py install for mozlog 19:37:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:37:22 INFO - Running setup.py install for moznetwork 19:37:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:37:22 INFO - Running setup.py install for mozprocess 19:37:22 INFO - Running setup.py install for mozprofile 19:37:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:37:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:37:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:37:22 INFO - Running setup.py install for mozrunner 19:37:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:37:22 INFO - Running setup.py install for mozscreenshot 19:37:23 INFO - Running setup.py install for moztest 19:37:23 INFO - Running setup.py install for mozversion 19:37:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:37:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:37:23 INFO - Cleaning up... 19:37:23 INFO - Return code: 0 19:37:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:37:23 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')]} 19:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:23 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')]} 19:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:37:23 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 0x10f081b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f084768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc8475750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5fd30>, '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 0x10ed86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54be8>, '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.DhU45StL7j/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.wC7y7i2npZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 19:37:23 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 19:37:23 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 19:37:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DhU45StL7j/Render', 19:37:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:37:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:37:23 INFO - 'HOME': '/Users/cltbld', 19:37:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:37:23 INFO - 'LOGNAME': 'cltbld', 19:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:37:23 INFO - 'MOZ_NO_REMOTE': '1', 19:37:23 INFO - 'NO_EM_RESTART': '1', 19:37:23 INFO - 'PAGER': '/bin/cat', 19:37:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:37:23 INFO - 'PWD': '/builds/slave/test', 19:37:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:37:23 INFO - 'SHELL': '/bin/bash', 19:37:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wC7y7i2npZ/Listeners', 19:37:23 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 19:37:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:37:23 INFO - 'USER': 'cltbld', 19:37:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:37:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:37:23 INFO - 'XPC_FLAGS': '0x0', 19:37:23 INFO - 'XPC_SERVICE_NAME': '0', 19:37:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:37:23 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-HXjAT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:37:23 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)) 19:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:37:23 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-n067FF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:37:23 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)) 19:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:37:23 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-pZYLAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:37:23 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)) 19:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:37:24 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-aRS8I7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:37:24 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)) 19:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:37:24 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-LIbrRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:37:24 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)) 19:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:37:24 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-ihq313-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:37:24 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)) 19:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:37:24 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-5G2XAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:37:24 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)) 19:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:37:24 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-8Pr8OF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:37:24 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)) 19:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:37:24 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-QHSJdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:37:24 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)) 19:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:37:24 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-YgyrOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:37:24 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)) 19:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:37:24 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-szqaKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:37:24 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)) 19:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:37:24 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-e6W_Wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:37:24 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)) 19:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:37:24 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-tf2l76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:37:25 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)) 19:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:37:25 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-St1AiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:37:25 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)) 19:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:37:25 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-S7VD3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:37:25 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)) 19:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:37:25 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-MqZtdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:37:25 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)) 19:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:37:25 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-smhKxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:37:25 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)) 19:37:25 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)) 19:37:25 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)) 19:37:25 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)) 19:37:25 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)) 19:37:25 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)) 19:37:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:37:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:39:57 INFO - Downloading blessings-1.6.tar.gz 19:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:39:58 INFO - Installing collected packages: blessings 19:39:58 INFO - Running setup.py install for blessings 19:39:58 INFO - Successfully installed blessings 19:39:58 INFO - Cleaning up... 19:39:58 INFO - Return code: 0 19:39:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:39:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:39:58 INFO - Reading from file tmpfile_stdout 19:39:58 INFO - Current package versions: 19:39:58 INFO - blessings == 1.6 19:39:58 INFO - blobuploader == 1.2.4 19:39:58 INFO - docopt == 0.6.1 19:39:58 INFO - functools32 == 3.2.3-2 19:39:58 INFO - jsonschema == 2.5.1 19:39:58 INFO - manifestparser == 1.1 19:39:58 INFO - mozInstall == 1.12 19:39:58 INFO - mozcrash == 1.0 19:39:58 INFO - mozdebug == 0.1 19:39:58 INFO - mozdevice == 0.49 19:39:58 INFO - mozfile == 1.2 19:39:58 INFO - mozhttpd == 0.7 19:39:58 INFO - mozinfo == 0.9 19:39:58 INFO - mozleak == 0.1 19:39:58 INFO - mozlog == 3.4 19:39:58 INFO - moznetwork == 0.27 19:39:58 INFO - mozprocess == 0.25 19:39:58 INFO - mozprofile == 0.28 19:39:58 INFO - mozrunner == 6.13 19:39:58 INFO - mozscreenshot == 0.1 19:39:58 INFO - mozsystemmonitor == 0.3 19:39:58 INFO - moztest == 0.8 19:39:58 INFO - mozversion == 1.4 19:39:58 INFO - psutil == 3.1.1 19:39:58 INFO - requests == 1.2.3 19:39:58 INFO - wsgiref == 0.1.2 19:39:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:59 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 0x10f081b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f084768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc8475750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5fd30>, '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 0x10ed86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54be8>, '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.DhU45StL7j/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.wC7y7i2npZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 19:39:59 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 19:39:59 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 19:39:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DhU45StL7j/Render', 19:39:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:39:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:39:59 INFO - 'HOME': '/Users/cltbld', 19:39:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:39:59 INFO - 'LOGNAME': 'cltbld', 19:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:59 INFO - 'MOZ_NO_REMOTE': '1', 19:39:59 INFO - 'NO_EM_RESTART': '1', 19:39:59 INFO - 'PAGER': '/bin/cat', 19:39:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:59 INFO - 'PWD': '/builds/slave/test', 19:39:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:39:59 INFO - 'SHELL': '/bin/bash', 19:39:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wC7y7i2npZ/Listeners', 19:39:59 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 19:39:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:39:59 INFO - 'USER': 'cltbld', 19:39:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:39:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:59 INFO - 'XPC_FLAGS': '0x0', 19:39:59 INFO - 'XPC_SERVICE_NAME': '0', 19:39:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:39:59 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)) 19:39:59 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)) 19:39:59 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)) 19:39:59 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)) 19:39:59 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)) 19:39:59 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)) 19:39:59 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)) 19:39:59 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)) 19:39:59 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)) 19:39:59 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)) 19:39:59 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)) 19:39:59 INFO - Cleaning up... 19:39:59 INFO - Return code: 0 19:39:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:39:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f081b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f084768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbdc8475750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5fd30>, '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 0x10ed86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54be8>, '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.DhU45StL7j/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.wC7y7i2npZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 19:39:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:39:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:39:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DhU45StL7j/Render', 19:39:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:39:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:39:59 INFO - 'HOME': '/Users/cltbld', 19:39:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:39:59 INFO - 'LOGNAME': 'cltbld', 19:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:39:59 INFO - 'MOZ_NO_REMOTE': '1', 19:39:59 INFO - 'NO_EM_RESTART': '1', 19:39:59 INFO - 'PAGER': '/bin/cat', 19:39:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:39:59 INFO - 'PWD': '/builds/slave/test', 19:39:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:39:59 INFO - 'SHELL': '/bin/bash', 19:39:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wC7y7i2npZ/Listeners', 19:39:59 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 19:39:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:39:59 INFO - 'USER': 'cltbld', 19:39:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:39:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:39:59 INFO - 'XPC_FLAGS': '0x0', 19:39:59 INFO - 'XPC_SERVICE_NAME': '0', 19:39:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:40:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:40:00 INFO - Cleaning up... 19:40:00 INFO - Return code: 0 19:40:00 INFO - Running post-action listener: _resource_record_post_action 19:40:00 INFO - Running post-action listener: _start_resource_monitoring 19:40:00 INFO - Starting resource monitoring. 19:40:00 INFO - [mozharness: 2017-05-20 02:40:00.183290Z] Finished create-virtualenv step (success) 19:40:00 INFO - [mozharness: 2017-05-20 02:40:00.184112Z] Running install step. 19:40:00 INFO - Running pre-action listener: _resource_record_pre_action 19:40:00 INFO - Running main action method: install 19:40:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:40:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:40:00 INFO - Reading from file tmpfile_stdout 19:40:00 INFO - Detecting whether we're running mozinstall >=1.0... 19:40:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:40:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:40:00 INFO - Reading from file tmpfile_stdout 19:40:00 INFO - Output received: 19:40:00 INFO - Usage: mozinstall [options] installer 19:40:00 INFO - Options: 19:40:00 INFO - -h, --help show this help message and exit 19:40:00 INFO - -d DEST, --destination=DEST 19:40:00 INFO - Directory to install application into. [default: 19:40:00 INFO - "/builds/slave/test"] 19:40:00 INFO - --app=APP Application being installed. [default: firefox] 19:40:00 INFO - mkdir: /builds/slave/test/build/application 19:40:00 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'] 19:40:00 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 19:40:20 INFO - Reading from file tmpfile_stdout 19:40:20 INFO - Output received: 19:40:20 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 19:40:20 INFO - Running post-action listener: _resource_record_post_action 19:40:20 INFO - [mozharness: 2017-05-20 02:40:20.651389Z] Finished install step (success) 19:40:20 INFO - [mozharness: 2017-05-20 02:40:20.651552Z] Running run-tests step. 19:40:20 INFO - Running pre-action listener: _resource_record_pre_action 19:40:20 INFO - Running main action method: run_tests 19:40:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:40:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:40:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:40:20 INFO - 2017-05-19 19:40:20.666 screenresolution[3674:74392] starting screenresolution argv=screenresolution get 19:40:20 INFO - 2017-05-19 19:40:20.669 screenresolution[3674:74392] Display 0: 1600x1200x32@60 19:40:20 INFO - 2017-05-19 19:40:20.674 screenresolution[3675:74394] starting screenresolution argv=screenresolution list 19:40:20 INFO - Available Modes on Display 0 19:40:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:40:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:40:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:40:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:40:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:40:20 INFO - Intel Iris: 19:40:20 INFO - Chipset Model: Intel Iris 19:40:20 INFO - Type: GPU 19:40:20 INFO - Bus: Built-In 19:40:20 INFO - VRAM (Dynamic, Max): 1536 MB 19:40:20 INFO - Vendor: Intel (0x8086) 19:40:20 INFO - Device ID: 0x0a2e 19:40:20 INFO - Revision ID: 0x0009 19:40:20 INFO - Displays: 19:40:20 INFO - Display: 19:40:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:40:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:40:20 INFO - Display Serial Number: 1600x1200 60 19:40:20 INFO - Main Display: Yes 19:40:20 INFO - Mirror: Off 19:40:20 INFO - Online: Yes 19:40:20 INFO - Rotation: Supported 19:40:20 INFO - Return code: 0 19:40:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:40:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:40:20 INFO - Python 2.7.3 19:40:20 INFO - Return code: 0 19:40:20 INFO - grabbing minidump binary from tooltool 19:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:40:20 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 0x10ee5fd30>, '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 0x10ed86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:40:20 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 19:40:20 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 19:40:20 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 19:40:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:40:21 INFO - Return code: 0 19:40:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:40:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:40:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:40:21 INFO - ENV: RUST_BACKTRACE is now 1 19:40:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:40:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:40:21 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/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0365', '--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 19:40:21 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/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0365 --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 19:40:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DhU45StL7j/Render', 19:40:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:40:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:40:21 INFO - 'HOME': '/Users/cltbld', 19:40:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:40:21 INFO - 'LOGNAME': 'cltbld', 19:40:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:40:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:40:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:40:21 INFO - 'MOZ_NO_REMOTE': '1', 19:40:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:40:21 INFO - 'NO_EM_RESTART': '1', 19:40:21 INFO - 'PAGER': '/bin/cat', 19:40:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:40:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:40:21 INFO - 'PWD': '/builds/slave/test', 19:40:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:40:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:40:21 INFO - 'RUST_BACKTRACE': '1', 19:40:21 INFO - 'SHELL': '/bin/bash', 19:40:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wC7y7i2npZ/Listeners', 19:40:21 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 19:40:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:40:21 INFO - 'USER': 'cltbld', 19:40:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:40:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:40:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:40:21 INFO - 'XPC_FLAGS': '0x0', 19:40:21 INFO - 'XPC_SERVICE_NAME': '0', 19:40:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:40:21 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/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0365', '--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 19:40:21 INFO - mozversion application_buildid: 20170519111123 19:40:21 INFO - mozversion application_changeset: c3d5dc1002044b0b5c4fdc38de4db8a7f70429a7 19:40:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:40:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:40:21 INFO - mozversion application_name: Firefox 19:40:21 INFO - mozversion application_remotingname: firefox-dev 19:40:21 INFO - mozversion application_repository: https://hg.mozilla.org/projects/jamun 19:40:21 INFO - mozversion application_vendor: Mozilla 19:40:21 INFO - mozversion application_version: 54.0 19:40:21 INFO - mozversion platform_buildid: 20170519111123 19:40:21 INFO - mozversion platform_changeset: c3d5dc1002044b0b5c4fdc38de4db8a7f70429a7 19:40:21 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/jamun 19:40:21 INFO - mozversion platform_version: 54.0 19:40:21 INFO - using testdate: 1495248021 19:40:21 INFO - actual date: 1495248021 19:40:21 INFO - starting webserver on 'localhost:54225' 19:40:21 INFO - SUITE-START | Running 2 tests 19:40:21 INFO - TEST-START | dromaeo_css 19:40:21 INFO - operating with platform_type : mac_ 19:40:21 INFO - Initialising browser for dromaeo_css test... 19:40:21 INFO - TEST-INFO | started process 3685 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpe2Gaph/profile http://localhost:54225/getInfo.html) 19:40:24 INFO - PROCESS | 3685 | 2017-05-19 19:40:24.318 plugin-container[3689:74559] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 19:40:24 INFO - PROCESS | 3685 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:40:24 INFO - PROCESS | 3685 | 2017-05-19 19:40:24.319 plugin-container[3689:74559] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 19:40:24 INFO - PROCESS | 3685 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:40:24 INFO - PROCESS | 3685 | 2017-05-19 19:40:24.319 plugin-container[3689:74559] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:40:24 INFO - PROCESS | 3685 | __metrics Screen width/height:1600/1200 19:40:24 INFO - PROCESS | 3685 | colorDepth:24 19:40:24 INFO - PROCESS | 3685 | Browser inner width/height: 1024/689 19:40:24 INFO - PROCESS | 3685 | __metrics 19:40:24 ERROR - PROCESS | 3685 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 19:40:25 INFO - TEST-INFO | 3685: exit 0 19:40:25 INFO - Browser initialized. 19:40:25 INFO - Running cycle 1/1 for dromaeo_css test... 19:40:25 INFO - TEST-INFO | started process 3690 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpe2Gaph/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:40:27 INFO - PROCESS | 3690 | 2017-05-19 19:40:27.440 plugin-container[3691:74690] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4443, name = 'com.apple.tsm.portname' 19:40:27 INFO - PROCESS | 3690 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:40:27 INFO - PROCESS | 3690 | 2017-05-19 19:40:27.441 plugin-container[3691:74690] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8817, name = 'com.apple.CFPasteboardClient' 19:40:27 INFO - PROCESS | 3690 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:40:27 INFO - PROCESS | 3690 | 2017-05-19 19:40:27.441 plugin-container[3691:74690] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:40:37 INFO - PROCESS | 3690 | RSS: Main: 202784768 19:40:37 INFO - PROCESS | 3690 | 19:43:41 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:54225/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54225/tests/dromaeo/cssquery-ext.html) 19:43:44 INFO - PROCESS | 3690 | RSS: Main: 217800704 19:43:44 INFO - PROCESS | 3690 | 19:46:46 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:54225/tests/dromaeo/cssquery-ext.html (next: http://localhost:54225/tests/dromaeo/cssquery-jquery.html) 19:46:46 INFO - PROCESS | 3690 | RSS: Main: 229756928 19:46:46 INFO - PROCESS | 3690 | 19:49:48 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:54225/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54225/tests/dromaeo/cssquery-mootools.html) 19:49:49 INFO - PROCESS | 3690 | RSS: Main: 231686144 19:49:49 INFO - PROCESS | 3690 | 19:52:51 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:54225/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54225/tests/dromaeo/cssquery-prototype.html) 19:52:51 INFO - PROCESS | 3690 | RSS: Main: 234467328 19:52:51 INFO - PROCESS | 3690 | 19:55:54 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:54225/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54225/tests/dromaeo/cssquery-yui.html) 19:55:55 INFO - PROCESS | 3690 | RSS: Main: 237436928 19:55:55 INFO - PROCESS | 3690 | 19:58:58 INFO - PROCESS | 3690 | Cycle 1(1): loaded http://localhost:54225/tests/dromaeo/cssquery-yui.html (next: http://localhost:54225/tests/dromaeo/cssquery-dojo.html) 19:58:58 INFO - PROCESS | 3690 | RSS: Main: 235511808 19:58:58 INFO - PROCESS | 3690 | 19:58:58 INFO - PROCESS | 3690 | __start_tp_report 19:58:58 INFO - PROCESS | 3690 | _x_x_mozilla_page_load 19:58:58 INFO - PROCESS | 3690 | _x_x_mozilla_page_load_details 19:58:58 INFO - PROCESS | 3690 | |i|pagename|runs| 19:58:58 INFO - PROCESS | 3690 | |0;dojo.html;2929.384829185871;3451.8608859076508;3462.3940810358195;3500.072480792592;3501.3522498337816;6096.573239873205;6165.506759459244;6167.537434692394;6184.628922264667;6210.9689451552795;6140.692965351737;6146;6177.413145751158;6226.564140510155;6234.407731265534;5464.153056276274;5502.9174562381595;5542.196381524676;5599.244102046212;5618.381977982419;5621.662700237978;5633.690147041911;5639.295088113986;5648.830535083954;5687.317521897378;5396.136618141099;5420.972895135519;5575.219469274284;5623.971880140593;5630.521405680522;5499.037668408033;5516.668999860021;5520.309961254843;5525.033119204143;5547.972260138674;4668.579827815479;5435.972820135874;5493.890122197574;5598.4961353477975;5636.605437619368;5209.4009188943;6134.17188679527;6213.161223234896;6220.284667263278;6224.159738435344;6321.209848768904;6352.301246862841;6390.082496144703;6421.71102300393;6464.256610489807;6236.594621349598;6282.685865706696;6398.584092034003;6408.51936104794;6433.260175079832;6199.752009919643;6205.751769929152;6230.59501132425;6232.0963460298;6268.435840774352;6624.933750662528;6743.730250789913;6757.391834734897;6769.22153952292;6781.152355955505;5340.225667278223;5647.632903861236;6179.16581261524;6201.0388389799655;6230.6884655767935;6494.090827284184;6509.837254068686;6514.739410423625;6524.412802847766;6545.312742162099;6417.871642567123;6432.421082102634;6441.710123044474;6450.967745161338;6467.159269294962;6159.753609855646;6199.28708198563;6339.841503962346;6436.935630643728;6523.510736694672;5055.418626857959;5206.375234971828;5236.869078272997;5239.44985776488;5268.157094864803;4593.862184134481;4604.884877878013;4613.584777369986;4621.722696638212;4634.467036290802;6112.2665280165775;6127.494965205055;6134;6162.014077747539;6172.537059720539;6562.77030303937;6587.308332625005;6590.9670451647435;6596.901046484307;6597.406233439014;5961.731722072517;6016.639001659914;6100.3899610039525;6130.386961303923;6145.016797312498;5770.19217309577;5777.24895763548;5786.218860453869;5790.131480277908;5805.94194058054;6786.932130678828;6802.251752307242;6808.8297792554595;6811.182658081062;6815.625140617313;4741.881452963566;6194.783182588588;6349.555531112777;6377.202849643794;6468.062130991074;5815.912761308668;6050.909236361546;6719.496037797283;6779.491538134758;6782.660866956534;5397.487238712316;6440.774572889926;6445.70994305248;6457.0637257596445;6476.740930362733;6218.129461875251;6273.498120150286;6364.522660800366;6491.318411566717;6493.480521558358;6130.612163469634;6296.024116261987;6332.556721029668;6350.269718982191;6369.936300636934;6342.207224096988;6349.936500634934;6364.809055728336;6367.140436041075;6425.453836423956;6080.361562035922;6138.723757430837;6181.381861813783;6281.120643109877;6307.432331090224;6229.127922091002;6237.563370564017;6259.061140828912;6285.905711414424;6337.366263373626;6265.843353916189;6295.213098362705;6306.873862522815;6314.936850631435;6318.27339855904 19:58:58 INFO - PROCESS | 3690 | |1;ext.html;809.6923169195707;834.4200780457583;931.501646619059;965.1410244882056;970.441995852385;37900.43149352758;40868.59131408689;40873.59126408735;40896.38655420171;40912.386314205236;38809.611903880956;38994.635187768436;39104.02239944003;39159.41260881089;39333.60666393335;8080.070791858923;10943.726406839813;11222.943885280562;11417.372044537547;11417.828732569018;11168;11249.100071994262;11270.774584508305;11282.54869805211;11295.096392288639;11265.042471389941;11270.54917803291;11280.887191128108;11284.153688473398;11287.943560282187;11237.044851187618;11250.493727782188;11267.943660281646;11281.70260420054;11292.83060754081;10913.017828395403;10935.83596246057;10957.287776294515;10973.615923442641;10975.341479511255;35186.824065879766;35309.82345088284;35414.46878296827;35473.64526354755;35555;3751.7748935063983;3786.8295926683363;3798.734088613798;3827.827747751358;3851.9422208666892;21815.67276490854;25916.740832591622;26699.665016749084;27181.048663296886;27235;3081.768867334959;3126.339610603247;3136.231623252295;3156.5580818685403;3161.6206055273283;365992;366675;366725;366784;367547.9999999973;45527.317090243676;45633.54366456359;45740.3138952916;45820.77089614597;45832.3125153123;41449.585504144576;43859.684209473766;44462.77768611136;46740.76629616898;46786.298205526946;12762.553310634083;14343.713125737428;14396.640083997983;14518.346674399678;14529.128252304685;11221.326720396803;11563.595274165364;12450.06624503166;12477.251364918135;12499.625011249676;11368.204225704287;12001.399930003465;12019.699507512381;12037.939810300892;12083.45624446902;5643.830685079454;5699.546615612992;5746.9712651436475;5747.109198074305;5755.0791873300905;1092.2954694222183;1122.712808273661;1145.9083273338113;1178.8703242643303;1204.5543149034913;26878.5968210477;27296.10580455549;27373.31566710848;27612.895484180808;27790.86104569505;1260.1368062876775;1260.3824126178106;1265.0196098024105;1286.922784632925;1294.5210272199347;14056.85943140576;14221.573352799433;14345.713085738227;14376.281185940661;14377.56867293983;186028;633134;640238;642889;644297;50442;50751.746241268556;50980.74509627428;51064.489355106714;51081;1234.382808595684;1410.4992727581562;1440.1431148466645;1455.3887367305756;1455.89080818939;23562.175323863583;25517.87241063783;27415;28066.85966570154;29126.56310155392;46507.30239046484;46592.53407465882;46771.29843052289;46887;47002.76498617485;485006.5749671229;486431;487501;488640;489153;30348.426190876922;30662;30908.536371954888;30940.69059309468;30960.606772695734;37529.498820047986;38332.616673832905;38962;39239.21521569495;39331.2133757329;26889.462210755282;27784;27864.582031269954;27906.302342441602;28665.14004579866;21193.470163246042;25696.743032570183;27992;28098.438031239668;28501.287467813472;31557.053288401385;32589.18527036843;32622.83688581542;32924.50613240755;32957.50563741498;26051.348716282246;26284.73715262823;26399.868000659873;28387.574186387636;28764.712352876202;22169.113235471046;22685.319440416813;22904.312870613907;23317.183898563468;23415.41461463477 19:58:58 INFO - PROCESS | 3690 | |2;jquery.html;408.22029922847366;410.2123922069626;416.44612665155336;431.65683281790984;450.875066708562;20278.49303767405;21192.682109768364;21702.34892953212;22298.55402891941;22488.775112248873;18074.367397141104;22197.223097191603;22213.666794998087;22401.66397504035;22547.887260563715;5866.384029676887;6467.191601049881;6862.588244705309;6865.794026179223;6898.517103802736;5866.237389139427;6806.591604503721;6859.3826555609985;6866;6869.896951545731;5395.352557693062;6695.799126026227;6748.055272261888;6865.313468653145;6871.415929645986;6247.125402443661;6573.901391479131;6749.696263668122;6814.62519561424;6836.658167091626;6787;7130.750423735196;7133.536320139175;7157.6063316517575;7169.211386747454;25375.604341761195;25476.108336208144;26030.479390412274;26128.8693556531;26221.868890655616;2947.970520294791;2952.3357244619788;2999.7150270724246;3005.4890668586395;3013;15905.045697258085;15917.52247432579;16090.195490225558;16093.91953040239;16937.830621693873;1986.692062730279;2104.778998205182;2106.65240235361;2111.345482900306;2111.7782632823487;145619;147808.26095869453;159448.20275898662;174873;175109.24890751185;17490.03804790749;19330.130144143546;19525.316613918443;20693.89653051725;20742;28478.860845565945;31778.205544861103;31783.682163178535;31897.202569935936;31958.201044974063;10420.166386689198;10536.420496872746;10602.628907988183;10718.196135289885;10869.619563315246;8884.156005179497;8896.911030889609;8936.106389361012;8973.685920992733;9044;9454.527273636291;9462.52687365629;9536.235796377554;9551.61793528265;9581.233501319877;3517.36687396266;3804.486394336729;3820.656140947328;3952.01199700075;4251.829926802955;890.4835195586544;892.5537231384308;898.9955050224708;927.536231884058;928.5450129436528;20642.483937901372;21110.73335599838;21120;21127.366179014654;21160.894195528923;932.608304512093;949.4920217683645;959.8992105828927;960.2989817433313;965.6861520006026;8741.650333986569;8811.074837142136;10795.028447439769;10922.726931826768;10952.39761813092;741728;742299;761799;780200;786819;125709;127414.36292818662;148357;150492;153460.6980895265;1225.1730082194483;1231.4273862653909;1243.2664727810454;1257.1639859493516;1259.8456639146978;17225.913870430566;18061.729074063638;18106.547336316697;18176.09119544044;18205.635887282446;55166.17250741162;56551.71724141353;58166.4183358161;58845;59125;76742.23257767574;77514.61242693976;78871.60564197143;79058.6047069761;79123.60438197773;8966.820663586823;10703.892961070289;10713.250072494851;11005;11056;11701.473433695333;11825.881741182478;11908.464119114833;12075.154739168525;12158.635240942785;10234.692959211236;10381.273310868166;10438.060574548326;10465.544895743158;10499.107575856138;9314;9340.439573625332;9361.578728957076;9456.905430945877;9572.856407154037;9643.08390702882;10455.424951627734;10560.049595536439;10685.8931410688;10810;9246.861297080415;10513.842292365774;10577.735556611146;10770.461476926279;10914.290571112851;9832.557534910804;10423.426711530636;10435.37387756737;10504.684859454228;10559.472026398804 19:58:58 INFO - PROCESS | 3690 | |3;mootools.html;1423.4875444839859;1581.0671703694818;1602.230929154006;1619.2308653389634;1633.5181121569135;10725.678229653104;11269.774604507906;11321.886781132196;11500.252483588562;11855.46650400732;10896.291741036826;11082.944585277062;11092.55629774808;11107.611233606825;11132.443377831096;2115.7355330583678;2444.1567659157563;2494.787943024845;2509.5482813093636;2510.2092840755195;2432.914847980321;2489.2283392148493;2489.788367988723;2502.461970676304;2503.2114883811632;2454.349597356702;2461.963070553943;2478.0583378316214;2490.514349701809;2492.9252122436264;2440.2923152285816;2440.6217036359394;2454.5459090068307;2462.261321603512;2481.5781317176125;2108.2726459371493;2140.2937030779963;2444.181199298237;2459.7786199241973;2470.419451428913;11270.774584508346;11389.715257118556;11390.03184729299;11394.259373140801;11414.54341826326;5972.611780234271;6130.509559235251;6152.3540028297275;6158.753649854045;6159.784407545714;3595.7055460034367;3709.4250391189407;3733.178700685845;3758.004128905842;3802.315583195024;1212.5513559982862;1217.4217246807784;1254.5797157952097;1270.5616562285998;1280.961571152867;13899.583012509642;14218.928905355511;15334.926555141144;15691.823113266551;15880.205989700584;4753.382060332135;4781.856544303677;4814.374131362901;4914.852554423302;4928.753562321941;11901.226420282654;11926;11936;11937.820932686016;11948.940255298668;6030.246219222598;6037.516998640098;6041.969790151021;6044.153818465418;6062.696865156725;5270.393904700932;5480.123180291134;5481.506664400223;5508.7521061552325;5517.972410138004;3961.4057891316534;4033.072393349546;4067.471228740304;4087.4073259377224;4145.0880806222585;947.9810403792023;1082.112667612566;1084.5467074120716;1086.7174534621056;1094.3215206571977;789.0058526256958;919.2737737187681;958.8609651600478;966.9951650241844;995.4674249276602;6678.298778628174;6795.660216989131;6847.863042739117;6909.896351554731;6923.9307606923285;1005.2762011351815;1029.5881647340973;1029.6499190275342;1035.5184839049728;1063.324788759128;4236.173946080485;4378.2994720845145;4396.208682437192;4504.954950450519;4573.954260457353;13442.529511467052;13655.795163072562;13726.794098088536;14089.943254255766;14113.78829317561;13638.727225455435;13907.79138312926;14033.508827191203;14035.157890526398;14065.874730021575;8122.472039317426;8249.505029698117;9485.33602647808;9813.656522021838;10431.113355364727;6661.800145995628;6964.477664175309;7291.489595728248;7304.671289791866;7357.117145942521;11844.28934263947;11864.22882512634;11947.462364193458;11972.521099155936;12511.874881251435;10709.714834219943;12541.811872821732;12612.621621351374;12713;12756.234625922474;8393.538355390268;8437.325013998743;8492.532910689972;8596.054434012129;8601.22588966996;8874.911250887408;10351.06840384369;10357.896421035693;10442.53008614599;10477.214208934512;7904.170062143392;8995.955020224857;9005.909940900507;9089.909100908906;9111;8212.876806848022;8294.460860044077;8358.87461688063;8377.246047855722;8401.663933442594;7071.292870712888;7864.252895974873;8000.719974801087;8149.9185008151535;8208.794780130545;5876.294844618673;5961.135635332766;5961.612495187799;6126.693665316806;6160;6086.6652334122045;6187.133801267736;6203.7828675996125;6287.528435367457;6404.551681382259 19:58:58 INFO - PROCESS | 3690 | |4;prototype.html;358.2780696895754;379.36267071320174;389.41587618572123;391.8785176595256;396.74013521143644;4473.843415480451;4777.331173635689;5067.417247016594;5178.922316165256;5416.864578385543;4697.5302469753005;5159.658488792913;5166.225066240066;5182.792688292473;5182.896342073166;4055.580546808623;4205.600467955539;4378.3213601891675;4392.484592815474;4423.557644235583;3674.724395670322;4399.64802815774;4408.228560002003;4436.6672499562665;4452.599266066053;3805.4207503885855;3946.960530394688;4441.445494077063;4460.286354183331;4464.196444639963;3697.4655517960014;3771.340015497277;3811.0472381904524;3841.8271177797064;4077.673786097105;3439.9656003439895;3641.253543023674;3873.1866308075337;3916.6279203475624;4073.9388909166387;4629.537046295377;4952;4952.653314268003;5208.890399388254;5232.659877107976;4285.882145584857;4429.424174857248;4431.911361772746;4765.809367625291;5029.554754992805;5126;5480.246321177225;5500.339959204881;5612.85967850807;5691.325077213703;4042.393640953851;4507.481639611421;4508.188526065307;4512.9774351128035;4543.386642803212;4948.554630083274;5128.538431541179;5904.822855314347;5974.522038236931;6002.759889604411;3940.251352243122;4300.957045403408;4593.586577208067;4595.241785105421;4649.046945376257;4301;4708.081924024851;4741.786619602126;4761.381020467386;4779.402574678165;4642.814287428532;4886.975565122151;4979.551840334315;5097.776533631902;5141.742912854343;4773.474917759044;5560.805371811967;5585.469380408855;5624.746886390122;5632.408597097327;1416.4405060001243;1586.9605408457478;1588.6743217640355;1599.6320846205206;1606.726856434409;1089.5750657243682;1108.4790148630132;1183.5384200161943;1209.171717373602;1231.0028876609974;4789.377380940456;5125.5914816647255;5169.870753231199;5246.580273578104;5271.657342272817;5855.268091488564;5860.912086318709;5864.237649105589;5898.616589921641;5952.9107063394085;4252;4846.7818948147415;5017.2154454278225;5106.765565295602;5283.622369933469;2677.9866100669374;2703.4863375958503;2942.646882374086;3017.4870272053804;3092.335147943203;5246.842594722164;5420;5537.6155961009745;5576.86955830321;5915.467607915309;5164.586833053422;5259.526642602184;5396.7587454884815;5526.668399896019;5940.6435613863305;5178.637495375438;5666.575006874501;5751.942480575224;5777.393373695785;5958.85102872423;5581.832545023656;5633.436656334334;5814.418558144152;5877.091733996845;5894.408509702271;5089.847304580869;5497.340319161726;5731.5927310530515;5808.954388209993;5825.262126800397;5676.183621241164;5992.850178745566;6065.7859881142185;6079.392060793885;6102.9694851525455;4553.043860789271;4586.614960220733;4593.448786145684;4603.401557797465;4607.5392460755;5112.948870511247;5421.834305624309;5510.448955104457;5544.833654990357;5602.887942241051;4914.680545764514;4996;5017.498250174954;5018.498150185098;5225.5558277545315;5175.689458632494;5319;5656.85857853557;5657.15142728594;5693.572982026281;4627.93058104122;5412.159865645699;5443.237946687546;5448.83653490396;5471.699056551928;4772.6181905448175;4915.606751459946;5066.82266120684;5431.970512730944;5587.832365029056;5065;5095.515925987025;5177;5465.617406781646;5610.85972850682 19:58:58 INFO - PROCESS | 3690 | |5;yui.html;726.1866709285601;748.5770539645104;756.4213376766775;829.1252728371569;837.9790505237369;15533.301001454933;16274.186290685477;16626.750598740997;16706.997580145184;16733.66532669346;12902.741945161091;13222.66943326415;14684.486042988498;15225.92387038066;15499.767503487428;865.5023361567124;970.5050424283613;989.6041583366639;991.5141580625514;999.9150072243868;977.1352353167426;995.8307087795092;1002.3835341265143;1003.0721582536162;1010.914072303855;1058.6453538064757;1059.5867611631431;1059.8357254625546;1061.0238580505913;1062.617457715222;1051.5530899367777;1056.8784589772197;1058.3385384134915;1058.8305871060631;1059.8569193158903;792.6512334572769;792.9563873986929;794.566961006253;795.7095660084085;796.3708670150575;16381.590460238589;16690.49928502147;16863.747043794352;17171.82828171715;17337.479875603625;14201.573952781433;14423.711525769531;14454.132752034806;14489.927550362287;14570.781438278435;11755.471003804849;11757.470913808813;11887.881121188764;11978.161528692995;12547.309897955609;3672.2839046385966;3749.6062913393976;3808.4668146459517;3888.319544079775;3904.141088960424;111571.32643010361;113493;116437.8356216444;118065;120694.39652801768;10856.457177141112;10896.564137434572;11021.944890275498;11239.988401043945;11395.088392928546;23041.42396440069;23395.53208935812;23454.882725586263;23699.881500592386;23791.881040594686;7748.7675369739;7792.805179870548;7801;7837.568933708587;7857.489263197874;4335.761533115646;4443.33349997503;4481.663875209372;4521.932171017372;4533.750643714628;3473.774204676688;3504.474328850642;3518.1908161123083;3537.911552211215;3538.7876727395924;625.1966223402906;632.8734253149388;649.9902501462482;653.4151934019121;657.612008914733;585.88868115058;589.7051474262869;601.2544444888307;640.7244884699624;679.78926532774;10019.749506262402;10463.738406539898;10493.895061049445;10540.314879532805;10599.788004240027;590.8818236352661;595.6158277910723;609.9191065081134;660.7191943424026;719.162176064889;4702.976485117552;5086.262491938648;5132.8460146195675;5147.536721695065;5161.458046905096;88283;91922;92883;101294;104975.95024049815;82321.17678823255;84114;84618.57690711631;86709;87060;62378.68810655917;68444.63110737858;73849;74208;74246.25753742502;9896.604135834774;9911.355761875744;9930.950345248228;9962.402255864672;9966.850497242402;49216.70434501862;49873.002539949724;50199.24701129413;50976.23535646894;51872.740636298084;53271;64540.67729661322;65183;67054.65890682061;68444.3155568438;11405.429728513374;11541.653750387502;11644;11798.705032374259;12198.512059517874;13042.282674452617;13142.474301027853;13175.736485270048;13347.532836350681;13390.062695611214;11810.882607527725;12046.216995895238;12230.87769122333;12247.75504489923;12568.937155314165;12138.575149869712;12269.69325766863;12368.876311236772;12514.124011319484;12817.038722095693;11782.52869885195;12070.818937716116;12185.634430967086;12403.317817520123;12629.052821038642;8397.496150231005;8686.04453510126;8715.738527843921;8792.956035220039;8876.556172191495;9111.726648200565;9460.385074970105;10305.690829275134;10312.27814053009;10551.208659350734 19:58:58 INFO - PROCESS | 3690 | __end_tp_report 19:58:58 INFO - PROCESS | 3690 | __start_cc_report 19:58:58 INFO - PROCESS | 3690 | _x_x_mozilla_cycle_collect,373 19:58:58 INFO - PROCESS | 3690 | __end_cc_report 19:58:58 INFO - PROCESS | 3690 | __startTimestamp1495249138349__endTimestamp 19:58:58 INFO - PROCESS | 3690 | 19:58:58 INFO - PROCESS | 3690 | ------- Summary: start ------- 19:58:58 INFO - PROCESS | 3690 | Number of tests: 6 19:58:58 INFO - PROCESS | 3690 | 19:58:58 INFO - PROCESS | 3690 | [#0] dojo.html Cycles:165 Average:5998.52 Median:6213.16 stddev:684.52 (11.0%) stddev-sans-first:642.88 19:58:58 INFO - PROCESS | 3690 | Values: 2929.4 3451.9 3462.4 3500.1 3501.4 6096.6 6165.5 6167.5 6184.6 6211.0 6140.7 6146.0 6177.4 6226.6 6234.4 5464.2 5502.9 5542.2 5599.2 5618.4 5621.7 5633.7 5639.3 5648.8 5687.3 5396.1 5421.0 5575.2 5624.0 5630.5 5499.0 5516.7 5520.3 5525.0 5548.0 4668.6 5436.0 5493.9 5598.5 5636.6 5209.4 6134.2 6213.2 6220.3 6224.2 6321.2 6352.3 6390.1 6421.7 6464.3 6236.6 6282.7 6398.6 6408.5 6433.3 6199.8 6205.8 6230.6 6232.1 6268.4 6624.9 6743.7 6757.4 6769.2 6781.2 5340.2 5647.6 6179.2 6201.0 6230.7 6494.1 6509.8 6514.7 6524.4 6545.3 6417.9 6432.4 6441.7 6451.0 6467.2 6159.8 6199.3 6339.8 6436.9 6523.5 5055.4 5206.4 5236.9 5239.4 5268.2 4593.9 4604.9 4613.6 4621.7 4634.5 6112.3 6127.5 6134.0 6162.0 6172.5 6562.8 6587.3 6591.0 6596.9 6597.4 5961.7 6016.6 6100.4 6130.4 6145.0 5770.2 5777.2 5786.2 5790.1 5805.9 6786.9 6802.3 6808.8 6811.2 6815.6 4741.9 6194.8 6349.6 6377.2 6468.1 5815.9 6050.9 6719.5 6779.5 6782.7 5397.5 6440.8 6445.7 6457.1 6476.7 6218.1 6273.5 6364.5 6491.3 6493.5 6130.6 6296.0 6332.6 6350.3 6369.9 6342.2 6349.9 6364.8 6367.1 6425.5 6080.4 6138.7 6181.4 6281.1 6307.4 6229.1 6237.6 6259.1 6285.9 6337.4 6265.8 6295.2 6306.9 6314.9 6318.3 19:58:58 INFO - PROCESS | 3690 | 19:58:58 INFO - PROCESS | 3690 | [#1] ext.html Cycles:180 Average:58813.65 Median:28444.43 stddev:130025.15 (457.1%) stddev-sans-first:130316.97 19:58:58 INFO - PROCESS | 3690 | Values: 809.7 834.4 931.5 965.1 970.4 37900.4 40868.6 40873.6 40896.4 40912.4 38809.6 38994.6 39104.0 39159.4 39333.6 8080.1 10943.7 11222.9 11417.4 11417.8 11168.0 11249.1 11270.8 11282.5 11295.1 11265.0 11270.5 11280.9 11284.2 11287.9 11237.0 11250.5 11267.9 11281.7 11292.8 10913.0 10935.8 10957.3 10973.6 10975.3 35186.8 35309.8 35414.5 35473.6 35555.0 3751.8 3786.8 3798.7 3827.8 3851.9 21815.7 25916.7 26699.7 27181.0 27235.0 3081.8 3126.3 3136.2 3156.6 3161.6 365992.0 366675.0 366725.0 366784.0 367548.0 45527.3 45633.5 45740.3 45820.8 45832.3 41449.6 43859.7 44462.8 46740.8 46786.3 12762.6 14343.7 14396.6 14518.3 14529.1 11221.3 11563.6 12450.1 12477.3 12499.6 11368.2 12001.4 12019.7 12037.9 12083.5 5643.8 5699.5 5747.0 5747.1 5755.1 1092.3 1122.7 1145.9 1178.9 1204.6 26878.6 27296.1 27373.3 27612.9 27790.9 1260.1 1260.4 1265.0 1286.9 1294.5 14056.9 14221.6 14345.7 14376.3 14377.6 186028.0 633134.0 640238.0 642889.0 644297.0 50442.0 50751.7 50980.7 51064.5 51081.0 1234.4 1410.5 1440.1 1455.4 1455.9 23562.2 25517.9 27415.0 28066.9 29126.6 46507.3 46592.5 46771.3 46887.0 47002.8 485006.6 486431.0 487501.0 488640.0 489153.0 30348.4 30662.0 30908.5 30940.7 30960.6 37529.5 38332.6 38962.0 39239.2 39331.2 26889.5 27784.0 27864.6 27906.3 28665.1 21193.5 25696.7 27992.0 28098.4 28501.3 31557.1 32589.2 32622.8 32924.5 32957.5 26051.3 26284.7 26399.9 28387.6 28764.7 22169.1 22685.3 22904.3 23317.2 23415.4 19:58:58 INFO - PROCESS | 3690 | 19:58:58 INFO - PROCESS | 3690 | [#2] jquery.html Cycles:180 Average:42594.57 Median:2950.15 stddev:126996.12 (4304.7%) stddev-sans-first:127312.87 19:58:58 INFO - PROCESS | 3690 | Values: 408.2 410.2 416.4 431.7 450.9 20278.5 21192.7 21702.3 22298.6 22488.8 18074.4 22197.2 22213.7 22401.7 22547.9 5866.4 6467.2 6862.6 6865.8 6898.5 5866.2 6806.6 6859.4 6866.0 6869.9 5395.4 6695.8 6748.1 6865.3 6871.4 6247.1 6573.9 6749.7 6814.6 6836.7 6787.0 7130.8 7133.5 7157.6 7169.2 25375.6 25476.1 26030.5 26128.9 26221.9 2948.0 2952.3 2999.7 3005.5 3013.0 15905.0 15917.5 16090.2 16093.9 16937.8 1986.7 2104.8 2106.7 2111.3 2111.8 145619.0 147808.3 159448.2 174873.0 175109.2 17490.0 19330.1 19525.3 20693.9 20742.0 28478.9 31778.2 31783.7 31897.2 31958.2 10420.2 10536.4 10602.6 10718.2 10869.6 8884.2 8896.9 8936.1 8973.7 9044.0 9454.5 9462.5 9536.2 9551.6 9581.2 3517.4 3804.5 3820.7 3952.0 4251.8 890.5 892.6 899.0 927.5 928.5 20642.5 21110.7 21120.0 21127.4 21160.9 932.6 949.5 959.9 960.3 965.7 8741.7 8811.1 10795.0 10922.7 10952.4 741728.0 742299.0 761799.0 780200.0 786819.0 125709.0 127414.4 148357.0 150492.0 153460.7 1225.2 1231.4 1243.3 1257.2 1259.8 17225.9 18061.7 18106.5 18176.1 18205.6 55166.2 56551.7 58166.4 58845.0 59125.0 76742.2 77514.6 78871.6 79058.6 79123.6 8966.8 10703.9 10713.3 11005.0 11056.0 11701.5 11825.9 11908.5 12075.2 12158.6 10234.7 10381.3 10438.1 10465.5 10499.1 9314.0 9340.4 9361.6 9456.9 9572.9 9643.1 10455.4 10560.0 10685.9 10810.0 9246.9 10513.8 10577.7 10770.5 10914.3 9832.6 10423.4 10435.4 10504.7 10559.5 19:58:58 INFO - PROCESS | 3690 | 19:58:58 INFO - PROCESS | 3690 | [#3] mootools.html Cycles:180 Average:6789.16 Median:2502.84 stddev:4180.96 (167.0%) stddev-sans-first:4173.25 19:58:58 INFO - PROCESS | 3690 | Values: 1423.5 1581.1 1602.2 1619.2 1633.5 10725.7 11269.8 11321.9 11500.3 11855.5 10896.3 11082.9 11092.6 11107.6 11132.4 2115.7 2444.2 2494.8 2509.5 2510.2 2432.9 2489.2 2489.8 2502.5 2503.2 2454.3 2462.0 2478.1 2490.5 2492.9 2440.3 2440.6 2454.5 2462.3 2481.6 2108.3 2140.3 2444.2 2459.8 2470.4 11270.8 11389.7 11390.0 11394.3 11414.5 5972.6 6130.5 6152.4 6158.8 6159.8 3595.7 3709.4 3733.2 3758.0 3802.3 1212.6 1217.4 1254.6 1270.6 1281.0 13899.6 14218.9 15334.9 15691.8 15880.2 4753.4 4781.9 4814.4 4914.9 4928.8 11901.2 11926.0 11936.0 11937.8 11948.9 6030.2 6037.5 6042.0 6044.2 6062.7 5270.4 5480.1 5481.5 5508.8 5518.0 3961.4 4033.1 4067.5 4087.4 4145.1 948.0 1082.1 1084.5 1086.7 1094.3 789.0 919.3 958.9 967.0 995.5 6678.3 6795.7 6847.9 6909.9 6923.9 1005.3 1029.6 1029.6 1035.5 1063.3 4236.2 4378.3 4396.2 4505.0 4574.0 13442.5 13655.8 13726.8 14089.9 14113.8 13638.7 13907.8 14033.5 14035.2 14065.9 8122.5 8249.5 9485.3 9813.7 10431.1 6661.8 6964.5 7291.5 7304.7 7357.1 11844.3 11864.2 11947.5 11972.5 12511.9 10709.7 12541.8 12612.6 12713.0 12756.2 8393.5 8437.3 8492.5 8596.1 8601.2 8874.9 10351.1 10357.9 10442.5 10477.2 7904.2 8996.0 9005.9 9089.9 9111.0 8212.9 8294.5 8358.9 8377.2 8401.7 7071.3 7864.3 8000.7 8149.9 8208.8 5876.3 5961.1 5961.6 6126.7 6160.0 6086.7 6187.1 6203.8 6287.5 6404.6 19:58:58 INFO - PROCESS | 3690 | 19:58:58 INFO - PROCESS | 3690 | [#4] prototype.html Cycles:180 Average:4644.43 Median:5024.03 stddev:1297.78 (25.8%) stddev-sans-first:1260.92 19:58:58 INFO - PROCESS | 3690 | Values: 358.3 379.4 389.4 391.9 396.7 4473.8 4777.3 5067.4 5178.9 5416.9 4697.5 5159.7 5166.2 5182.8 5182.9 4055.6 4205.6 4378.3 4392.5 4423.6 3674.7 4399.6 4408.2 4436.7 4452.6 3805.4 3947.0 4441.4 4460.3 4464.2 3697.5 3771.3 3811.0 3841.8 4077.7 3440.0 3641.3 3873.2 3916.6 4073.9 4629.5 4952.0 4952.7 5208.9 5232.7 4285.9 4429.4 4431.9 4765.8 5029.6 5126.0 5480.2 5500.3 5612.9 5691.3 4042.4 4507.5 4508.2 4513.0 4543.4 4948.6 5128.5 5904.8 5974.5 6002.8 3940.3 4301.0 4593.6 4595.2 4649.0 4301.0 4708.1 4741.8 4761.4 4779.4 4642.8 4887.0 4979.6 5097.8 5141.7 4773.5 5560.8 5585.5 5624.7 5632.4 1416.4 1587.0 1588.7 1599.6 1606.7 1089.6 1108.5 1183.5 1209.2 1231.0 4789.4 5125.6 5169.9 5246.6 5271.7 5855.3 5860.9 5864.2 5898.6 5952.9 4252.0 4846.8 5017.2 5106.8 5283.6 2678.0 2703.5 2942.6 3017.5 3092.3 5246.8 5420.0 5537.6 5576.9 5915.5 5164.6 5259.5 5396.8 5526.7 5940.6 5178.6 5666.6 5751.9 5777.4 5958.9 5581.8 5633.4 5814.4 5877.1 5894.4 5089.8 5497.3 5731.6 5809.0 5825.3 5676.2 5992.9 6065.8 6079.4 6103.0 4553.0 4586.6 4593.4 4603.4 4607.5 5112.9 5421.8 5510.4 5544.8 5602.9 4914.7 4996.0 5017.5 5018.5 5225.6 5175.7 5319.0 5656.9 5657.2 5693.6 4627.9 5412.2 5443.2 5448.8 5471.7 4772.6 4915.6 5066.8 5432.0 5587.8 5065.0 5095.5 5177.0 5465.6 5610.9 19:58:58 INFO - PROCESS | 3690 | 19:58:58 INFO - PROCESS | 3690 | [#5] yui.html Cycles:180 Average:20086.78 Median:3528.05 stddev:29004.72 (822.1%) stddev-sans-first:29049.66 19:58:58 INFO - PROCESS | 3690 | Values: 726.2 748.6 756.4 829.1 838.0 15533.3 16274.2 16626.8 16707.0 16733.7 12902.7 13222.7 14684.5 15225.9 15499.8 865.5 970.5 989.6 991.5 999.9 977.1 995.8 1002.4 1003.1 1010.9 1058.6 1059.6 1059.8 1061.0 1062.6 1051.6 1056.9 1058.3 1058.8 1059.9 792.7 793.0 794.6 795.7 796.4 16381.6 16690.5 16863.7 17171.8 17337.5 14201.6 14423.7 14454.1 14489.9 14570.8 11755.5 11757.5 11887.9 11978.2 12547.3 3672.3 3749.6 3808.5 3888.3 3904.1 111571.3 113493.0 116437.8 118065.0 120694.4 10856.5 10896.6 11021.9 11240.0 11395.1 23041.4 23395.5 23454.9 23699.9 23791.9 7748.8 7792.8 7801.0 7837.6 7857.5 4335.8 4443.3 4481.7 4521.9 4533.8 3473.8 3504.5 3518.2 3537.9 3538.8 625.2 632.9 650.0 653.4 657.6 585.9 589.7 601.3 640.7 679.8 10019.7 10463.7 10493.9 10540.3 10599.8 590.9 595.6 609.9 660.7 719.2 4703.0 5086.3 5132.8 5147.5 5161.5 88283.0 91922.0 92883.0 101294.0 104976.0 82321.2 84114.0 84618.6 86709.0 87060.0 62378.7 68444.6 73849.0 74208.0 74246.3 9896.6 9911.4 9931.0 9962.4 9966.9 49216.7 49873.0 50199.2 50976.2 51872.7 53271.0 64540.7 65183.0 67054.7 68444.3 11405.4 11541.7 11644.0 11798.7 12198.5 13042.3 13142.5 13175.7 13347.5 13390.1 11810.9 12046.2 12230.9 12247.8 12568.9 12138.6 12269.7 12368.9 12514.1 12817.0 11782.5 12070.8 12185.6 12403.3 12629.1 8397.5 8686.0 8715.7 8793.0 8876.6 9111.7 9460.4 10305.7 10312.3 10551.2 19:58:58 INFO - PROCESS | 3690 | -------- Summary: end -------- 19:58:58 INFO - PROCESS | 3690 | 19:58:58 INFO - TEST-INFO | 3690: exit 0 19:58:58 INFO - TEST-OK | dromaeo_css | took 1117533ms 19:58:58 INFO - TEST-START | kraken 19:58:58 INFO - operating with platform_type : mac_ 19:58:58 INFO - Initialising browser for kraken test... 19:58:58 INFO - TEST-INFO | started process 3695 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmp2D9bY4/profile http://localhost:54225/getInfo.html) 19:59:01 INFO - PROCESS | 3695 | 2017-05-19 19:59:01.286 plugin-container[3697:76774] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8537, name = 'com.apple.tsm.portname' 19:59:01 INFO - PROCESS | 3695 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:59:01 INFO - PROCESS | 3695 | 2017-05-19 19:59:01.286 plugin-container[3697:76774] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x865b, name = 'com.apple.CFPasteboardClient' 19:59:01 INFO - PROCESS | 3695 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:59:01 INFO - PROCESS | 3695 | 2017-05-19 19:59:01.286 plugin-container[3697:76774] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:59:01 INFO - PROCESS | 3695 | __metrics Screen width/height:1600/1200 19:59:01 INFO - PROCESS | 3695 | colorDepth:24 19:59:01 INFO - PROCESS | 3695 | Browser inner width/height: 1024/689 19:59:01 INFO - PROCESS | 3695 | __metrics 19:59:01 ERROR - PROCESS | 3695 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 19:59:02 INFO - TEST-INFO | 3695: exit 0 19:59:02 INFO - Browser initialized. 19:59:02 INFO - Running cycle 1/1 for kraken test... 19:59:02 INFO - TEST-INFO | started process 3698 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmp2D9bY4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:59:04 INFO - PROCESS | 3698 | 2017-05-19 19:59:04.521 plugin-container[3699:76892] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 19:59:04 INFO - PROCESS | 3698 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:59:04 INFO - PROCESS | 3698 | 2017-05-19 19:59:04.522 plugin-container[3699:76892] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a0b, name = 'com.apple.CFPasteboardClient' 19:59:04 INFO - PROCESS | 3698 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:59:04 INFO - PROCESS | 3698 | 2017-05-19 19:59:04.522 plugin-container[3699:76892] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:59:14 INFO - PROCESS | 3698 | RSS: Main: 202870784 19:59:14 INFO - PROCESS | 3698 | 19:59:17 INFO - PROCESS | 3698 | Cycle 1(1): loaded http://localhost:54225/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54225/tests/kraken/driver.html?testName=audio-beat-detection) 19:59:18 INFO - PROCESS | 3698 | RSS: Main: 216436736 19:59:18 INFO - PROCESS | 3698 | 19:59:20 INFO - PROCESS | 3698 | Cycle 1(1): loaded http://localhost:54225/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54225/tests/kraken/driver.html?testName=audio-dft) 19:59:21 INFO - PROCESS | 3698 | RSS: Main: 224423936 19:59:21 INFO - PROCESS | 3698 | 19:59:24 INFO - PROCESS | 3698 | Cycle 1(1): loaded http://localhost:54225/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54225/tests/kraken/driver.html?testName=audio-fft) 19:59:25 INFO - PROCESS | 3698 | RSS: Main: 227962880 19:59:25 INFO - PROCESS | 3698 | 19:59:27 INFO - PROCESS | 3698 | Cycle 1(1): loaded http://localhost:54225/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54225/tests/kraken/driver.html?testName=audio-oscillator) 19:59:28 INFO - PROCESS | 3698 | RSS: Main: 228319232 19:59:28 INFO - PROCESS | 3698 | 19:59:30 INFO - PROCESS | 3698 | Cycle 1(1): loaded http://localhost:54225/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54225/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:59:30 INFO - PROCESS | 3698 | RSS: Main: 229785600 19:59:30 INFO - PROCESS | 3698 | 19:59:33 INFO - PROCESS | 3698 | Cycle 1(1): loaded http://localhost:54225/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54225/tests/kraken/driver.html?testName=imaging-darkroom) 19:59:34 INFO - PROCESS | 3698 | RSS: Main: 233902080 19:59:34 INFO - PROCESS | 3698 | 19:59:37 INFO - PROCESS | 3698 | Cycle 1(1): loaded http://localhost:54225/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54225/tests/kraken/driver.html?testName=imaging-desaturate) 19:59:38 INFO - PROCESS | 3698 | RSS: Main: 233062400 19:59:38 INFO - PROCESS | 3698 | 19:59:41 INFO - PROCESS | 3698 | Cycle 1(1): loaded http://localhost:54225/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54225/tests/kraken/driver.html?testName=json-parse-financial) 19:59:41 INFO - PROCESS | 3698 | RSS: Main: 233398272 19:59:41 INFO - PROCESS | 3698 | 19:59:43 INFO - PROCESS | 3698 | Cycle 1(1): loaded http://localhost:54225/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54225/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:59:44 INFO - PROCESS | 3698 | RSS: Main: 232640512 19:59:44 INFO - PROCESS | 3698 | 19:59:45 INFO - PROCESS | 3698 | Cycle 1(1): loaded http://localhost:54225/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54225/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:59:46 INFO - PROCESS | 3698 | RSS: Main: 232607744 19:59:46 INFO - PROCESS | 3698 | 19:59:48 INFO - PROCESS | 3698 | Cycle 1(1): loaded http://localhost:54225/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54225/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:59:49 INFO - PROCESS | 3698 | RSS: Main: 232677376 19:59:49 INFO - PROCESS | 3698 | 19:59:52 INFO - PROCESS | 3698 | Cycle 1(1): loaded http://localhost:54225/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:59:53 INFO - PROCESS | 3698 | RSS: Main: 233209856 19:59:53 INFO - PROCESS | 3698 | 19:59:56 INFO - PROCESS | 3698 | Cycle 1(1): loaded http://localhost:54225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:59:56 INFO - PROCESS | 3698 | RSS: Main: 241340416 19:59:56 INFO - PROCESS | 3698 | 19:59:58 INFO - PROCESS | 3698 | Cycle 1(1): loaded http://localhost:54225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54225/tests/kraken/driver.html?testName=ai-astar) 19:59:58 INFO - PROCESS | 3698 | RSS: Main: 242851840 19:59:58 INFO - PROCESS | 3698 | 19:59:58 INFO - PROCESS | 3698 | __start_tp_report 19:59:58 INFO - PROCESS | 3698 | _x_x_mozilla_page_load 19:59:58 INFO - PROCESS | 3698 | _x_x_mozilla_page_load_details 19:59:58 INFO - PROCESS | 3698 | |i|pagename|runs| 19:59:58 INFO - PROCESS | 3698 | |0;ai-astar;111;120;119;121;120;120;120;120;121;119 19:59:58 INFO - PROCESS | 3698 | |1;audio-beat-detection;175;139;116;148;111;114;111;112;156;137 19:59:58 INFO - PROCESS | 3698 | |2;audio-dft;202;196;199;202;200;189;199;198;199;199 19:59:58 INFO - PROCESS | 3698 | |3;audio-fft;85;60;81;111;82;79;61;61;74;60 19:59:58 INFO - PROCESS | 3698 | |4;audio-oscillator;88;69;108;69;72;70;103;58;68;99 19:59:58 INFO - PROCESS | 3698 | |5;imaging-gaussian-blur;89;90;91;89;90;113;89;89;90;90 19:59:58 INFO - PROCESS | 3698 | |6;imaging-darkroom;97;120;150;96;95;97;98;124;93;133 19:59:58 INFO - PROCESS | 3698 | |7;imaging-desaturate;119;90;92;92;89;90;89;91;91;128 19:59:58 INFO - PROCESS | 3698 | |8;json-parse-financial;67;64;63;63;69;69;91;102;103;101 19:59:58 INFO - PROCESS | 3698 | |9;json-stringify-tinderbox;59;57;67;69;64;60;58;56;66;80 19:59:58 INFO - PROCESS | 3698 | |10;stanford-crypto-aes;83;86;95;73;92;100;107;104;95;83 19:59:58 INFO - PROCESS | 3698 | |11;stanford-crypto-ccm;146;145;155;153;135;162;154;167;184;167 19:59:58 INFO - PROCESS | 3698 | |12;stanford-crypto-pbkdf2;167;168;169;164;170;215;168;165;160;182 19:59:58 INFO - PROCESS | 3698 | |13;stanford-crypto-sha256-iterative;60;65;66;65;67;66;66;64;64;82 19:59:58 INFO - PROCESS | 3698 | __end_tp_report 19:59:58 INFO - PROCESS | 3698 | __start_cc_report 19:59:58 INFO - PROCESS | 3698 | _x_x_mozilla_cycle_collect,1006 19:59:58 INFO - PROCESS | 3698 | __end_cc_report 19:59:58 INFO - PROCESS | 3698 | __startTimestamp1495249198968__endTimestamp 19:59:58 INFO - PROCESS | 3698 | 19:59:58 INFO - PROCESS | 3698 | ------- Summary: start ------- 19:59:58 INFO - PROCESS | 3698 | Number of tests: 14 19:59:58 INFO - PROCESS | 3698 | 19:59:58 INFO - PROCESS | 3698 | [#0] ai-astar Cycles:10 Average:119.10 Median:120.00 stddev:2.92 (2.4%) stddev-sans-first:0.71 19:59:58 INFO - PROCESS | 3698 | Values: 111.0 120.0 119.0 121.0 120.0 120.0 120.0 120.0 121.0 119.0 19:59:58 INFO - PROCESS | 3698 | 19:59:58 INFO - PROCESS | 3698 | [#1] audio-beat-detection Cycles:10 Average:131.90 Median:138.00 stddev:22.65 (16.4%) stddev-sans-first:17.86 19:59:58 INFO - PROCESS | 3698 | Values: 175.0 139.0 116.0 148.0 111.0 114.0 111.0 112.0 156.0 137.0 19:59:58 INFO - PROCESS | 3698 | 19:59:58 INFO - PROCESS | 3698 | [#2] audio-dft Cycles:10 Average:198.30 Median:199.00 stddev:3.71 (1.9%) stddev-sans-first:3.69 19:59:58 INFO - PROCESS | 3698 | Values: 202.0 196.0 199.0 202.0 200.0 189.0 199.0 198.0 199.0 199.0 19:59:58 INFO - PROCESS | 3698 | 19:59:58 INFO - PROCESS | 3698 | [#3] audio-fft Cycles:10 Average:75.40 Median:76.50 stddev:16.12 (21.1%) stddev-sans-first:16.72 19:59:58 INFO - PROCESS | 3698 | Values: 85.0 60.0 81.0 111.0 82.0 79.0 61.0 61.0 74.0 60.0 19:59:58 INFO - PROCESS | 3698 | 19:59:58 INFO - PROCESS | 3698 | [#4] audio-oscillator Cycles:10 Average:80.40 Median:69.50 stddev:17.54 (25.2%) stddev-sans-first:18.39 19:59:58 INFO - PROCESS | 3698 | Values: 88.0 69.0 108.0 69.0 72.0 70.0 103.0 58.0 68.0 99.0 19:59:58 INFO - PROCESS | 3698 | 19:59:58 INFO - PROCESS | 3698 | [#5] imaging-gaussian-blur Cycles:10 Average:92.00 Median:90.00 stddev:7.41 (8.2%) stddev-sans-first:7.78 19:59:58 INFO - PROCESS | 3698 | Values: 89.0 90.0 91.0 89.0 90.0 113.0 89.0 89.0 90.0 90.0 19:59:58 INFO - PROCESS | 3698 | 19:59:58 INFO - PROCESS | 3698 | [#6] imaging-darkroom Cycles:10 Average:110.30 Median:95.50 stddev:20.04 (21.0%) stddev-sans-first:20.67 19:59:58 INFO - PROCESS | 3698 | Values: 97.0 120.0 150.0 96.0 95.0 97.0 98.0 124.0 93.0 133.0 19:59:58 INFO - PROCESS | 3698 | 19:59:58 INFO - PROCESS | 3698 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:90.50 stddev:14.11 (15.6%) stddev-sans-first:12.55 19:59:58 INFO - PROCESS | 3698 | Values: 119.0 90.0 92.0 92.0 89.0 90.0 89.0 91.0 91.0 128.0 19:59:58 INFO - PROCESS | 3698 | 19:59:58 INFO - PROCESS | 3698 | [#8] json-parse-financial Cycles:10 Average:79.20 Median:65.50 stddev:17.68 (27.0%) stddev-sans-first:18.19 19:59:58 INFO - PROCESS | 3698 | Values: 67.0 64.0 63.0 63.0 69.0 69.0 91.0 102.0 103.0 101.0 19:59:58 INFO - PROCESS | 3698 | 19:59:58 INFO - PROCESS | 3698 | [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:65.00 stddev:7.32 (11.3%) stddev-sans-first:7.57 19:59:58 INFO - PROCESS | 3698 | Values: 59.0 57.0 67.0 69.0 64.0 60.0 58.0 56.0 66.0 80.0 19:59:58 INFO - PROCESS | 3698 | 19:59:58 INFO - PROCESS | 3698 | [#10] stanford-crypto-aes Cycles:10 Average:91.80 Median:84.50 stddev:10.59 (12.5%) stddev-sans-first:10.74 19:59:58 INFO - PROCESS | 3698 | Values: 83.0 86.0 95.0 73.0 92.0 100.0 107.0 104.0 95.0 83.0 19:59:58 INFO - PROCESS | 3698 | 19:59:58 INFO - PROCESS | 3698 | [#11] stanford-crypto-ccm Cycles:10 Average:156.80 Median:158.50 stddev:13.87 (8.8%) stddev-sans-first:14.15 19:59:58 INFO - PROCESS | 3698 | Values: 146.0 145.0 155.0 153.0 135.0 162.0 154.0 167.0 184.0 167.0 19:59:58 INFO - PROCESS | 3698 | 19:59:58 INFO - PROCESS | 3698 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:168.50 stddev:15.88 (9.4%) stddev-sans-first:16.70 19:59:58 INFO - PROCESS | 3698 | Values: 167.0 168.0 169.0 164.0 170.0 215.0 168.0 165.0 160.0 182.0 19:59:58 INFO - PROCESS | 3698 | 19:59:58 INFO - PROCESS | 3698 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:5.78 (8.8%) stddev-sans-first:5.63 19:59:58 INFO - PROCESS | 3698 | Values: 60.0 65.0 66.0 65.0 67.0 66.0 66.0 64.0 64.0 82.0 19:59:58 INFO - PROCESS | 3698 | -------- Summary: end -------- 19:59:58 INFO - PROCESS | 3698 | 19:59:59 INFO - TEST-INFO | 3698: exit 0 19:59:59 INFO - TEST-OK | kraken | took 60837ms 19:59:59 INFO - SUITE-END | took 1178s 20:00:00 INFO - Completed test suite (00:19:38) 20:00:00 INFO - javascript benchmark 20:00:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7703.963524429258, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2929.384829185871, 3451.8608859076508, 3462.3940810358195, 3500.072480792592, 3501.3522498337816, 6096.573239873205, 6165.506759459244, 6167.537434692394, 6184.628922264667, 6210.9689451552795, 6140.692965351737, 6146.0, 6177.413145751158, 6226.564140510155, 6234.407731265534, 5464.153056276274, 5502.9174562381595, 5542.196381524676, 5599.244102046212, 5618.381977982419, 5621.662700237978, 5633.690147041911, 5639.295088113986, 5648.830535083954, 5687.317521897378, 5396.136618141099, 5420.972895135519, 5575.219469274284, 5623.971880140593, 5630.521405680522, 5499.037668408033, 5516.668999860021, 5520.309961254843, 5525.033119204143, 5547.972260138674, 4668.579827815479, 5435.972820135874, 5493.890122197574, 5598.4961353477975, 5636.605437619368, 5209.4009188943, 6134.17188679527, 6213.161223234896, 6220.284667263278, 6224.159738435344, 6321.209848768904, 6352.301246862841, 6390.082496144703, 6421.71102300393, 6464.256610489807, 6236.594621349598, 6282.685865706696, 6398.584092034003, 6408.51936104794, 6433.260175079832, 6199.752009919643, 6205.751769929152, 6230.59501132425, 6232.0963460298, 6268.435840774352, 6624.933750662528, 6743.730250789913, 6757.391834734897, 6769.22153952292, 6781.152355955505, 5340.225667278223, 5647.632903861236, 6179.16581261524, 6201.0388389799655, 6230.6884655767935, 6494.090827284184, 6509.837254068686, 6514.739410423625, 6524.412802847766, 6545.312742162099, 6417.871642567123, 6432.421082102634, 6441.710123044474, 6450.967745161338, 6467.159269294962, 6159.753609855646, 6199.28708198563, 6339.841503962346, 6436.935630643728, 6523.510736694672, 5055.418626857959, 5206.375234971828, 5236.869078272997, 5239.44985776488, 5268.157094864803, 4593.862184134481, 4604.884877878013, 4613.584777369986, 4621.722696638212, 4634.467036290802, 6112.2665280165775, 6127.494965205055, 6134.0, 6162.014077747539, 6172.537059720539, 6562.77030303937, 6587.308332625005, 6590.9670451647435, 6596.901046484307, 6597.406233439014, 5961.731722072517, 6016.639001659914, 6100.3899610039525, 6130.386961303923, 6145.016797312498, 5770.19217309577, 5777.24895763548, 5786.218860453869, 5790.131480277908, 5805.94194058054, 6786.932130678828, 6802.251752307242, 6808.8297792554595, 6811.182658081062, 6815.625140617313, 4741.881452963566, 6194.783182588588, 6349.555531112777, 6377.202849643794, 6468.062130991074, 5815.912761308668, 6050.909236361546, 6719.496037797283, 6779.491538134758, 6782.660866956534, 5397.487238712316, 6440.774572889926, 6445.70994305248, 6457.0637257596445, 6476.740930362733, 6218.129461875251, 6273.498120150286, 6364.522660800366, 6491.318411566717, 6493.480521558358, 6130.612163469634, 6296.024116261987, 6332.556721029668, 6350.269718982191, 6369.936300636934, 6342.207224096988, 6349.936500634934, 6364.809055728336, 6367.140436041075, 6425.453836423956, 6080.361562035922, 6138.723757430837, 6181.381861813783, 6281.120643109877, 6307.432331090224, 6229.127922091002, 6237.563370564017, 6259.061140828912, 6285.905711414424, 6337.366263373626, 6265.843353916189, 6295.213098362705, 6306.873862522815, 6314.936850631435, 6318.27339855904], "value": 5954.726070567952, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [809.6923169195707, 834.4200780457583, 931.501646619059, 965.1410244882056, 970.441995852385, 37900.43149352758, 40868.59131408689, 40873.59126408735, 40896.38655420171, 40912.386314205236, 38809.611903880956, 38994.635187768436, 39104.02239944003, 39159.41260881089, 39333.60666393335, 8080.070791858923, 10943.726406839813, 11222.943885280562, 11417.372044537547, 11417.828732569018, 11168.0, 11249.100071994262, 11270.774584508305, 11282.54869805211, 11295.096392288639, 11265.042471389941, 11270.54917803291, 11280.887191128108, 11284.153688473398, 11287.943560282187, 11237.044851187618, 11250.493727782188, 11267.943660281646, 11281.70260420054, 11292.83060754081, 10913.017828395403, 10935.83596246057, 10957.287776294515, 10973.615923442641, 10975.341479511255, 35186.824065879766, 35309.82345088284, 35414.46878296827, 35473.64526354755, 35555.0, 3751.7748935063983, 3786.8295926683363, 3798.734088613798, 3827.827747751358, 3851.9422208666892, 21815.67276490854, 25916.740832591622, 26699.665016749084, 27181.048663296886, 27235.0, 3081.768867334959, 3126.339610603247, 3136.231623252295, 3156.5580818685403, 3161.6206055273283, 365992.0, 366675.0, 366725.0, 366784.0, 367547.9999999973, 45527.317090243676, 45633.54366456359, 45740.3138952916, 45820.77089614597, 45832.3125153123, 41449.585504144576, 43859.684209473766, 44462.77768611136, 46740.76629616898, 46786.298205526946, 12762.553310634083, 14343.713125737428, 14396.640083997983, 14518.346674399678, 14529.128252304685, 11221.326720396803, 11563.595274165364, 12450.06624503166, 12477.251364918135, 12499.625011249676, 11368.204225704287, 12001.399930003465, 12019.699507512381, 12037.939810300892, 12083.45624446902, 5643.830685079454, 5699.546615612992, 5746.9712651436475, 5747.109198074305, 5755.0791873300905, 1092.2954694222183, 1122.712808273661, 1145.9083273338113, 1178.8703242643303, 1204.5543149034913, 26878.5968210477, 27296.10580455549, 27373.31566710848, 27612.895484180808, 27790.86104569505, 1260.1368062876775, 1260.3824126178106, 1265.0196098024105, 1286.922784632925, 1294.5210272199347, 14056.85943140576, 14221.573352799433, 14345.713085738227, 14376.281185940661, 14377.56867293983, 186028.0, 633134.0, 640238.0, 642889.0, 644297.0, 50442.0, 50751.746241268556, 50980.74509627428, 51064.489355106714, 51081.0, 1234.382808595684, 1410.4992727581562, 1440.1431148466645, 1455.3887367305756, 1455.89080818939, 23562.175323863583, 25517.87241063783, 27415.0, 28066.85966570154, 29126.56310155392, 46507.30239046484, 46592.53407465882, 46771.29843052289, 46887.0, 47002.76498617485, 485006.5749671229, 486431.0, 487501.0, 488640.0, 489153.0, 30348.426190876922, 30662.0, 30908.536371954888, 30940.69059309468, 30960.606772695734, 37529.498820047986, 38332.616673832905, 38962.0, 39239.21521569495, 39331.2133757329, 26889.462210755282, 27784.0, 27864.582031269954, 27906.302342441602, 28665.14004579866, 21193.470163246042, 25696.743032570183, 27992.0, 28098.438031239668, 28501.287467813472, 31557.053288401385, 32589.18527036843, 32622.83688581542, 32924.50613240755, 32957.50563741498, 26051.348716282246, 26284.73715262823, 26399.868000659873, 28387.574186387636, 28764.712352876202, 22169.113235471046, 22685.319440416813, 22904.312870613907, 23317.183898563468, 23415.41461463477], "value": 18631.159169628656, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.22029922847366, 410.2123922069626, 416.44612665155336, 431.65683281790984, 450.875066708562, 20278.49303767405, 21192.682109768364, 21702.34892953212, 22298.55402891941, 22488.775112248873, 18074.367397141104, 22197.223097191603, 22213.666794998087, 22401.66397504035, 22547.887260563715, 5866.384029676887, 6467.191601049881, 6862.588244705309, 6865.794026179223, 6898.517103802736, 5866.237389139427, 6806.591604503721, 6859.3826555609985, 6866.0, 6869.896951545731, 5395.352557693062, 6695.799126026227, 6748.055272261888, 6865.313468653145, 6871.415929645986, 6247.125402443661, 6573.901391479131, 6749.696263668122, 6814.62519561424, 6836.658167091626, 6787.0, 7130.750423735196, 7133.536320139175, 7157.6063316517575, 7169.211386747454, 25375.604341761195, 25476.108336208144, 26030.479390412274, 26128.8693556531, 26221.868890655616, 2947.970520294791, 2952.3357244619788, 2999.7150270724246, 3005.4890668586395, 3013.0, 15905.045697258085, 15917.52247432579, 16090.195490225558, 16093.91953040239, 16937.830621693873, 1986.692062730279, 2104.778998205182, 2106.65240235361, 2111.345482900306, 2111.7782632823487, 145619.0, 147808.26095869453, 159448.20275898662, 174873.0, 175109.24890751185, 17490.03804790749, 19330.130144143546, 19525.316613918443, 20693.89653051725, 20742.0, 28478.860845565945, 31778.205544861103, 31783.682163178535, 31897.202569935936, 31958.201044974063, 10420.166386689198, 10536.420496872746, 10602.628907988183, 10718.196135289885, 10869.619563315246, 8884.156005179497, 8896.911030889609, 8936.106389361012, 8973.685920992733, 9044.0, 9454.527273636291, 9462.52687365629, 9536.235796377554, 9551.61793528265, 9581.233501319877, 3517.36687396266, 3804.486394336729, 3820.656140947328, 3952.01199700075, 4251.829926802955, 890.4835195586544, 892.5537231384308, 898.9955050224708, 927.536231884058, 928.5450129436528, 20642.483937901372, 21110.73335599838, 21120.0, 21127.366179014654, 21160.894195528923, 932.608304512093, 949.4920217683645, 959.8992105828927, 960.2989817433313, 965.6861520006026, 8741.650333986569, 8811.074837142136, 10795.028447439769, 10922.726931826768, 10952.39761813092, 741728.0, 742299.0, 761799.0, 780200.0, 786819.0, 125709.0, 127414.36292818662, 148357.0, 150492.0, 153460.6980895265, 1225.1730082194483, 1231.4273862653909, 1243.2664727810454, 1257.1639859493516, 1259.8456639146978, 17225.913870430566, 18061.729074063638, 18106.547336316697, 18176.09119544044, 18205.635887282446, 55166.17250741162, 56551.71724141353, 58166.4183358161, 58845.0, 59125.0, 76742.23257767574, 77514.61242693976, 78871.60564197143, 79058.6047069761, 79123.60438197773, 8966.820663586823, 10703.892961070289, 10713.250072494851, 11005.0, 11056.0, 11701.473433695333, 11825.881741182478, 11908.464119114833, 12075.154739168525, 12158.635240942785, 10234.692959211236, 10381.273310868166, 10438.060574548326, 10465.544895743158, 10499.107575856138, 9314.0, 9340.439573625332, 9361.578728957076, 9456.905430945877, 9572.856407154037, 9643.08390702882, 10455.424951627734, 10560.049595536439, 10685.8931410688, 10810.0, 9246.861297080415, 10513.842292365774, 10577.735556611146, 10770.461476926279, 10914.290571112851, 9832.557534910804, 10423.426711530636, 10435.37387756737, 10504.684859454228, 10559.472026398804], "value": 11227.044753211741, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1423.4875444839859, 1581.0671703694818, 1602.230929154006, 1619.2308653389634, 1633.5181121569135, 10725.678229653104, 11269.774604507906, 11321.886781132196, 11500.252483588562, 11855.46650400732, 10896.291741036826, 11082.944585277062, 11092.55629774808, 11107.611233606825, 11132.443377831096, 2115.7355330583678, 2444.1567659157563, 2494.787943024845, 2509.5482813093636, 2510.2092840755195, 2432.914847980321, 2489.2283392148493, 2489.788367988723, 2502.461970676304, 2503.2114883811632, 2454.349597356702, 2461.963070553943, 2478.0583378316214, 2490.514349701809, 2492.9252122436264, 2440.2923152285816, 2440.6217036359394, 2454.5459090068307, 2462.261321603512, 2481.5781317176125, 2108.2726459371493, 2140.2937030779963, 2444.181199298237, 2459.7786199241973, 2470.419451428913, 11270.774584508346, 11389.715257118556, 11390.03184729299, 11394.259373140801, 11414.54341826326, 5972.611780234271, 6130.509559235251, 6152.3540028297275, 6158.753649854045, 6159.784407545714, 3595.7055460034367, 3709.4250391189407, 3733.178700685845, 3758.004128905842, 3802.315583195024, 1212.5513559982862, 1217.4217246807784, 1254.5797157952097, 1270.5616562285998, 1280.961571152867, 13899.583012509642, 14218.928905355511, 15334.926555141144, 15691.823113266551, 15880.205989700584, 4753.382060332135, 4781.856544303677, 4814.374131362901, 4914.852554423302, 4928.753562321941, 11901.226420282654, 11926.0, 11936.0, 11937.820932686016, 11948.940255298668, 6030.246219222598, 6037.516998640098, 6041.969790151021, 6044.153818465418, 6062.696865156725, 5270.393904700932, 5480.123180291134, 5481.506664400223, 5508.7521061552325, 5517.972410138004, 3961.4057891316534, 4033.072393349546, 4067.471228740304, 4087.4073259377224, 4145.0880806222585, 947.9810403792023, 1082.112667612566, 1084.5467074120716, 1086.7174534621056, 1094.3215206571977, 789.0058526256958, 919.2737737187681, 958.8609651600478, 966.9951650241844, 995.4674249276602, 6678.298778628174, 6795.660216989131, 6847.863042739117, 6909.896351554731, 6923.9307606923285, 1005.2762011351815, 1029.5881647340973, 1029.6499190275342, 1035.5184839049728, 1063.324788759128, 4236.173946080485, 4378.2994720845145, 4396.208682437192, 4504.954950450519, 4573.954260457353, 13442.529511467052, 13655.795163072562, 13726.794098088536, 14089.943254255766, 14113.78829317561, 13638.727225455435, 13907.79138312926, 14033.508827191203, 14035.157890526398, 14065.874730021575, 8122.472039317426, 8249.505029698117, 9485.33602647808, 9813.656522021838, 10431.113355364727, 6661.800145995628, 6964.477664175309, 7291.489595728248, 7304.671289791866, 7357.117145942521, 11844.28934263947, 11864.22882512634, 11947.462364193458, 11972.521099155936, 12511.874881251435, 10709.714834219943, 12541.811872821732, 12612.621621351374, 12713.0, 12756.234625922474, 8393.538355390268, 8437.325013998743, 8492.532910689972, 8596.054434012129, 8601.22588966996, 8874.911250887408, 10351.06840384369, 10357.896421035693, 10442.53008614599, 10477.214208934512, 7904.170062143392, 8995.955020224857, 9005.909940900507, 9089.909100908906, 9111.0, 8212.876806848022, 8294.460860044077, 8358.87461688063, 8377.246047855722, 8401.663933442594, 7071.292870712888, 7864.252895974873, 8000.719974801087, 8149.9185008151535, 8208.794780130545, 5876.294844618673, 5961.135635332766, 5961.612495187799, 6126.693665316806, 6160.0, 6086.6652334122045, 6187.133801267736, 6203.7828675996125, 6287.528435367457, 6404.551681382259], "value": 5215.158858071408, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.2780696895754, 379.36267071320174, 389.41587618572123, 391.8785176595256, 396.74013521143644, 4473.843415480451, 4777.331173635689, 5067.417247016594, 5178.922316165256, 5416.864578385543, 4697.5302469753005, 5159.658488792913, 5166.225066240066, 5182.792688292473, 5182.896342073166, 4055.580546808623, 4205.600467955539, 4378.3213601891675, 4392.484592815474, 4423.557644235583, 3674.724395670322, 4399.64802815774, 4408.228560002003, 4436.6672499562665, 4452.599266066053, 3805.4207503885855, 3946.960530394688, 4441.445494077063, 4460.286354183331, 4464.196444639963, 3697.4655517960014, 3771.340015497277, 3811.0472381904524, 3841.8271177797064, 4077.673786097105, 3439.9656003439895, 3641.253543023674, 3873.1866308075337, 3916.6279203475624, 4073.9388909166387, 4629.537046295377, 4952.0, 4952.653314268003, 5208.890399388254, 5232.659877107976, 4285.882145584857, 4429.424174857248, 4431.911361772746, 4765.809367625291, 5029.554754992805, 5126.0, 5480.246321177225, 5500.339959204881, 5612.85967850807, 5691.325077213703, 4042.393640953851, 4507.481639611421, 4508.188526065307, 4512.9774351128035, 4543.386642803212, 4948.554630083274, 5128.538431541179, 5904.822855314347, 5974.522038236931, 6002.759889604411, 3940.251352243122, 4300.957045403408, 4593.586577208067, 4595.241785105421, 4649.046945376257, 4301.0, 4708.081924024851, 4741.786619602126, 4761.381020467386, 4779.402574678165, 4642.814287428532, 4886.975565122151, 4979.551840334315, 5097.776533631902, 5141.742912854343, 4773.474917759044, 5560.805371811967, 5585.469380408855, 5624.746886390122, 5632.408597097327, 1416.4405060001243, 1586.9605408457478, 1588.6743217640355, 1599.6320846205206, 1606.726856434409, 1089.5750657243682, 1108.4790148630132, 1183.5384200161943, 1209.171717373602, 1231.0028876609974, 4789.377380940456, 5125.5914816647255, 5169.870753231199, 5246.580273578104, 5271.657342272817, 5855.268091488564, 5860.912086318709, 5864.237649105589, 5898.616589921641, 5952.9107063394085, 4252.0, 4846.7818948147415, 5017.2154454278225, 5106.765565295602, 5283.622369933469, 2677.9866100669374, 2703.4863375958503, 2942.646882374086, 3017.4870272053804, 3092.335147943203, 5246.842594722164, 5420.0, 5537.6155961009745, 5576.86955830321, 5915.467607915309, 5164.586833053422, 5259.526642602184, 5396.7587454884815, 5526.668399896019, 5940.6435613863305, 5178.637495375438, 5666.575006874501, 5751.942480575224, 5777.393373695785, 5958.85102872423, 5581.832545023656, 5633.436656334334, 5814.418558144152, 5877.091733996845, 5894.408509702271, 5089.847304580869, 5497.340319161726, 5731.5927310530515, 5808.954388209993, 5825.262126800397, 5676.183621241164, 5992.850178745566, 6065.7859881142185, 6079.392060793885, 6102.9694851525455, 4553.043860789271, 4586.614960220733, 4593.448786145684, 4603.401557797465, 4607.5392460755, 5112.948870511247, 5421.834305624309, 5510.448955104457, 5544.833654990357, 5602.887942241051, 4914.680545764514, 4996.0, 5017.498250174954, 5018.498150185098, 5225.5558277545315, 5175.689458632494, 5319.0, 5656.85857853557, 5657.15142728594, 5693.572982026281, 4627.93058104122, 5412.159865645699, 5443.237946687546, 5448.83653490396, 5471.699056551928, 4772.6181905448175, 4915.606751459946, 5066.82266120684, 5431.970512730944, 5587.832365029056, 5065.0, 5095.515925987025, 5177.0, 5465.617406781646, 5610.85972850682], "value": 4265.8008276448145, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.1866709285601, 748.5770539645104, 756.4213376766775, 829.1252728371569, 837.9790505237369, 15533.301001454933, 16274.186290685477, 16626.750598740997, 16706.997580145184, 16733.66532669346, 12902.741945161091, 13222.66943326415, 14684.486042988498, 15225.92387038066, 15499.767503487428, 865.5023361567124, 970.5050424283613, 989.6041583366639, 991.5141580625514, 999.9150072243868, 977.1352353167426, 995.8307087795092, 1002.3835341265143, 1003.0721582536162, 1010.914072303855, 1058.6453538064757, 1059.5867611631431, 1059.8357254625546, 1061.0238580505913, 1062.617457715222, 1051.5530899367777, 1056.8784589772197, 1058.3385384134915, 1058.8305871060631, 1059.8569193158903, 792.6512334572769, 792.9563873986929, 794.566961006253, 795.7095660084085, 796.3708670150575, 16381.590460238589, 16690.49928502147, 16863.747043794352, 17171.82828171715, 17337.479875603625, 14201.573952781433, 14423.711525769531, 14454.132752034806, 14489.927550362287, 14570.781438278435, 11755.471003804849, 11757.470913808813, 11887.881121188764, 11978.161528692995, 12547.309897955609, 3672.2839046385966, 3749.6062913393976, 3808.4668146459517, 3888.319544079775, 3904.141088960424, 111571.32643010361, 113493.0, 116437.8356216444, 118065.0, 120694.39652801768, 10856.457177141112, 10896.564137434572, 11021.944890275498, 11239.988401043945, 11395.088392928546, 23041.42396440069, 23395.53208935812, 23454.882725586263, 23699.881500592386, 23791.881040594686, 7748.7675369739, 7792.805179870548, 7801.0, 7837.568933708587, 7857.489263197874, 4335.761533115646, 4443.33349997503, 4481.663875209372, 4521.932171017372, 4533.750643714628, 3473.774204676688, 3504.474328850642, 3518.1908161123083, 3537.911552211215, 3538.7876727395924, 625.1966223402906, 632.8734253149388, 649.9902501462482, 653.4151934019121, 657.612008914733, 585.88868115058, 589.7051474262869, 601.2544444888307, 640.7244884699624, 679.78926532774, 10019.749506262402, 10463.738406539898, 10493.895061049445, 10540.314879532805, 10599.788004240027, 590.8818236352661, 595.6158277910723, 609.9191065081134, 660.7191943424026, 719.162176064889, 4702.976485117552, 5086.262491938648, 5132.8460146195675, 5147.536721695065, 5161.458046905096, 88283.0, 91922.0, 92883.0, 101294.0, 104975.95024049815, 82321.17678823255, 84114.0, 84618.57690711631, 86709.0, 87060.0, 62378.68810655917, 68444.63110737858, 73849.0, 74208.0, 74246.25753742502, 9896.604135834774, 9911.355761875744, 9930.950345248228, 9962.402255864672, 9966.850497242402, 49216.70434501862, 49873.002539949724, 50199.24701129413, 50976.23535646894, 51872.740636298084, 53271.0, 64540.67729661322, 65183.0, 67054.65890682061, 68444.3155568438, 11405.429728513374, 11541.653750387502, 11644.0, 11798.705032374259, 12198.512059517874, 13042.282674452617, 13142.474301027853, 13175.736485270048, 13347.532836350681, 13390.062695611214, 11810.882607527725, 12046.216995895238, 12230.87769122333, 12247.75504489923, 12568.937155314165, 12138.575149869712, 12269.69325766863, 12368.876311236772, 12514.124011319484, 12817.038722095693, 11782.52869885195, 12070.818937716116, 12185.634430967086, 12403.317817520123, 12629.052821038642, 8397.496150231005, 8686.04453510126, 8715.738527843921, 8792.956035220039, 8876.556172191495, 9111.726648200565, 9460.385074970105, 10305.690829275134, 10312.27814053009, 10551.208659350734], "value": 7544.157459440137, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 120.0, 119.0, 121.0, 120.0, 120.0, 120.0, 120.0, 121.0, 119.0], "value": 119.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 139.0, 116.0, 148.0, 111.0, 114.0, 111.0, 112.0, 156.0, 137.0], "value": 131.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 196.0, 199.0, 202.0, 200.0, 189.0, 199.0, 198.0, 199.0, 199.0], "value": 198.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 60.0, 81.0, 111.0, 82.0, 79.0, 61.0, 61.0, 74.0, 60.0], "value": 75.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 108.0, 69.0, 72.0, 70.0, 103.0, 58.0, 68.0, 99.0], "value": 80.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 91.0, 89.0, 90.0, 113.0, 89.0, 89.0, 90.0, 90.0], "value": 92.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 120.0, 150.0, 96.0, 95.0, 97.0, 98.0, 124.0, 93.0, 133.0], "value": 110.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 90.0, 92.0, 92.0, 89.0, 90.0, 89.0, 91.0, 91.0, 128.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 63.0, 63.0, 69.0, 69.0, 91.0, 102.0, 103.0, 101.0], "value": 79.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 67.0, 69.0, 64.0, 60.0, 58.0, 56.0, 66.0, 80.0], "value": 63.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 95.0, 73.0, 92.0, 100.0, 107.0, 104.0, 95.0, 83.0], "value": 91.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 155.0, 153.0, 135.0, 162.0, 154.0, 167.0, 184.0, 167.0], "value": 156.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 169.0, 164.0, 170.0, 215.0, 168.0, 165.0, 160.0, 182.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 65.0, 66.0, 65.0, 67.0, 66.0, 66.0, 64.0, 64.0, 82.0], "value": 66.5, "unit": "score"}]}]} 20:00:00 INFO - Return code: 0 20:00:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:00:00 ERROR - # TBPL SUCCESS # 20:00:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:00:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:00:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:00:00 INFO - 2017-05-19 20:00:00.273 screenresolution[3703:77284] starting screenresolution argv=screenresolution get 20:00:00 INFO - 2017-05-19 20:00:00.276 screenresolution[3703:77284] Display 0: 1600x1200x32@60 20:00:00 INFO - 2017-05-19 20:00:00.282 screenresolution[3704:77287] starting screenresolution argv=screenresolution list 20:00:00 INFO - Available Modes on Display 0 20:00:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:00:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:00:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:00:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:00:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:00:00 INFO - Intel Iris: 20:00:00 INFO - Chipset Model: Intel Iris 20:00:00 INFO - Type: GPU 20:00:00 INFO - Bus: Built-In 20:00:00 INFO - VRAM (Dynamic, Max): 1536 MB 20:00:00 INFO - Vendor: Intel (0x8086) 20:00:00 INFO - Device ID: 0x0a2e 20:00:00 INFO - Revision ID: 0x0009 20:00:00 INFO - Displays: 20:00:00 INFO - Display: 20:00:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:00:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:00:00 INFO - Display Serial Number: 1600x1200 60 20:00:00 INFO - Main Display: Yes 20:00:00 INFO - Mirror: Off 20:00:00 INFO - Online: Yes 20:00:00 INFO - Rotation: Supported 20:00:00 INFO - Return code: 0 20:00:00 INFO - Running post-action listener: _resource_record_post_action 20:00:00 INFO - [mozharness: 2017-05-20 03:00:00.514509Z] Finished run-tests step (success) 20:00:00 INFO - Running post-run listener: _resource_record_post_run 20:00:00 INFO - Total resource usage - Wall time: 1199s; CPU: 55.0%; Read bytes: 1950208; Write bytes: 515176448; Read time: 21; Write time: 1660 20:00:00 INFO - TinderboxPrint: CPU usage
54.8% 20:00:00 INFO - TinderboxPrint: I/O read bytes / time
1,950,208 / 21 20:00:00 INFO - TinderboxPrint: I/O write bytes / time
515,176,448 / 1,660 20:00:00 INFO - TinderboxPrint: CPU idle
2,170.6 (45.2%) 20:00:00 INFO - TinderboxPrint: CPU system
971.3 (20.2%) 20:00:00 INFO - TinderboxPrint: CPU user
1,655.9 (34.5%) 20:00:00 INFO - TinderboxPrint: Swap in / out
209,977,344 / 0 20:00:00 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 203692544; Write bytes: 199507968; Read time: 15632; Write time: 438 20:00:00 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 1085440; Write bytes: 304826368; Read time: 17; Write time: 1191 20:00:00 INFO - Running post-run listener: _upload_blobber_files 20:00:00 INFO - Blob upload gear active. 20:00:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:00:00 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 20:00:00 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'] 20:00:00 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 20:00:01 INFO - (blobuploader) - INFO - Open directory for files ... 20:00:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:00:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:00:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:02 INFO - (blobuploader) - INFO - Done attempting. 20:00:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:00:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:00:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:03 INFO - (blobuploader) - INFO - Done attempting. 20:00:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:00:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:00:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:04 INFO - (blobuploader) - INFO - Done attempting. 20:00:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:00:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:00:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:00:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:00:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:00:06 INFO - (blobuploader) - INFO - Done attempting. 20:00:06 INFO - (blobuploader) - INFO - Iteration through files over. 20:00:06 INFO - Return code: 0 20:00:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:00:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:00:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/708aa9ee9531826ecd2140ddadee7754b66f51fa3b2092ff81a1e5ffd30c702d89266dee6aec5372263ee2d428cf20e76ff6f9b085814ec5762870bed20daf9a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/95223110fe431507e12519aaebe845e8a1433e6d0a2afb735cc4e76df67ab0c4d77e4a0f0fd75804fd4a3b8934dd3c43ad8e2eb3bb6ef2f98527b0760a3ff591", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/e6db4660d09d39e6f304307efaacfcb643ce09da091a7fbda7d09bb272b2c9ca32326ec59c3ada42c0e37b6966e3d9ce09dec54e90e0b8e4acf1c2ee5c6a3d7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/74fe619641056afc0a5a22ebe50a2bc19640d244a8f0a8a40a4ee66ad9d350ef1824b4b3dc03754e7a7f329480bd2cf946dea056295f7a4ef378095c0f1e4f15"} 20:00:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:00:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:00:06 INFO - Contents: 20:00:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/708aa9ee9531826ecd2140ddadee7754b66f51fa3b2092ff81a1e5ffd30c702d89266dee6aec5372263ee2d428cf20e76ff6f9b085814ec5762870bed20daf9a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/95223110fe431507e12519aaebe845e8a1433e6d0a2afb735cc4e76df67ab0c4d77e4a0f0fd75804fd4a3b8934dd3c43ad8e2eb3bb6ef2f98527b0760a3ff591", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/e6db4660d09d39e6f304307efaacfcb643ce09da091a7fbda7d09bb272b2c9ca32326ec59c3ada42c0e37b6966e3d9ce09dec54e90e0b8e4acf1c2ee5c6a3d7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/74fe619641056afc0a5a22ebe50a2bc19640d244a8f0a8a40a4ee66ad9d350ef1824b4b3dc03754e7a7f329480bd2cf946dea056295f7a4ef378095c0f1e4f15"} 20:00:06 INFO - Running post-run listener: copy_logs_to_upload_dir 20:00:06 INFO - Copying logs to upload dir... 20:00:06 INFO - mkdir: /builds/slave/test/build/upload/logs 20:00:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=2484.566095 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 41 mins, 24 secs) (at 2017-05-19 20:00:07.030599) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 20:00:07.035000) ========= 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.DhU45StL7j/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.wC7y7i2npZ/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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/708aa9ee9531826ecd2140ddadee7754b66f51fa3b2092ff81a1e5ffd30c702d89266dee6aec5372263ee2d428cf20e76ff6f9b085814ec5762870bed20daf9a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/95223110fe431507e12519aaebe845e8a1433e6d0a2afb735cc4e76df67ab0c4d77e4a0f0fd75804fd4a3b8934dd3c43ad8e2eb3bb6ef2f98527b0760a3ff591", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/e6db4660d09d39e6f304307efaacfcb643ce09da091a7fbda7d09bb272b2c9ca32326ec59c3ada42c0e37b6966e3d9ce09dec54e90e0b8e4acf1c2ee5c6a3d7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/74fe619641056afc0a5a22ebe50a2bc19640d244a8f0a8a40a4ee66ad9d350ef1824b4b3dc03754e7a7f329480bd2cf946dea056295f7a4ef378095c0f1e4f15"} build_url:https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/VEaxq_7DSm2BJXsvraLUvQ/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/708aa9ee9531826ecd2140ddadee7754b66f51fa3b2092ff81a1e5ffd30c702d89266dee6aec5372263ee2d428cf20e76ff6f9b085814ec5762870bed20daf9a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/95223110fe431507e12519aaebe845e8a1433e6d0a2afb735cc4e76df67ab0c4d77e4a0f0fd75804fd4a3b8934dd3c43ad8e2eb3bb6ef2f98527b0760a3ff591", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/e6db4660d09d39e6f304307efaacfcb643ce09da091a7fbda7d09bb272b2c9ca32326ec59c3ada42c0e37b6966e3d9ce09dec54e90e0b8e4acf1c2ee5c6a3d7f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Jamun/sha512/74fe619641056afc0a5a22ebe50a2bc19640d244a8f0a8a40a4ee66ad9d350ef1824b4b3dc03754e7a7f329480bd2cf946dea056295f7a4ef378095c0f1e4f15"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 20:00:07.071030) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 20:00:07.071366) ========= 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.DhU45StL7j/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.wC7y7i2npZ/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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.005331 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 20:00:07.119244) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 20:00:07.122569) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 20:00:07.122890) ========= ========= Total master_lag: 0.76 =========