builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0032 starttime: 1476393647.82 results: success (0) buildid: 20161013100424 builduid: 4b9bcdcb8c2c4f22854211951697e042 revision: 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 14:20:47.818407) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 14:20:47.818924) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 14:20:47.819223) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 14:20:47.844574) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 14:20:47.845093) ========= 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.TmrrR4d5Iy/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.ZET9zi2oPY/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-13 14:20:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.57M=0.001s 2016-10-13 14:20:47 (8.57 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093071 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 14:20:47.961190) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 14:20:47.961528) ========= 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.TmrrR4d5Iy/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.ZET9zi2oPY/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.026798 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 14:20:48.011533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 14:20:48.012066) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TmrrR4d5Iy/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.ZET9zi2oPY/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-13 14:20:48,087 truncating revision to first 12 chars 2016-10-13 14:20:48,087 Setting DEBUG logging. 2016-10-13 14:20:48,087 attempt 1/10 2016-10-13 14:20:48,087 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/62ccb498db3e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 14:20:49,141 unpacking tar archive at: fx-team-62ccb498db3e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.329828 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 14:20:49.365266) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 14:20:49.365594) ========= script_repo_revision: 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 14:20:49.365991) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 14:20:49.366278) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 14:20:49.384508) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-13 14:20:49.384910) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TmrrR4d5Iy/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.ZET9zi2oPY/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 14:20:49 INFO - MultiFileLogger online at 20161013 14:20:49 in /builds/slave/test 14:20:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:20:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:20:49 INFO - {'append_to_log': False, 14:20:49 INFO - 'base_work_dir': '/builds/slave/test', 14:20:49 INFO - 'blob_upload_branch': 'Fx-Team', 14:20:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:20:49 INFO - 'branch': 'Fx-Team', 14:20:49 INFO - 'buildbot_json_path': 'buildprops.json', 14:20:49 INFO - 'config_files': ('talos/mac_config.py',), 14:20:49 INFO - 'default_actions': ('clobber', 14:20:49 INFO - 'read-buildbot-config', 14:20:49 INFO - 'download-and-extract', 14:20:49 INFO - 'populate-webroot', 14:20:49 INFO - 'create-virtualenv', 14:20:49 INFO - 'install', 14:20:49 INFO - 'run-tests'), 14:20:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:20:49 INFO - 'download_minidump_stackwalk': True, 14:20:49 INFO - 'download_symbols': 'ondemand', 14:20:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:20:49 INFO - 'tooltool.py': '/tools/tooltool.py', 14:20:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:20:49 INFO - '/tools/misc-python/virtualenv.py')}, 14:20:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:20:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:20:49 INFO - 'installer_path': 'installer.exe', 14:20:49 INFO - 'log_level': 'info', 14:20:49 INFO - 'log_name': 'talos', 14:20:49 INFO - 'log_to_console': True, 14:20:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:20:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:20:49 INFO - 'opt_config_files': (), 14:20:49 INFO - 'pip_index': False, 14:20:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:20:49 INFO - 'cmd': ('bash', 14:20:49 INFO - '-c', 14:20:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:20:49 INFO - 'enabled': True, 14:20:49 INFO - 'halt_on_failure': False, 14:20:49 INFO - 'name': 'check_screen_resolution'},), 14:20:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:20:49 INFO - 'cmd': ('bash', 14:20:49 INFO - '-c', 14:20:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:20:49 INFO - 'enabled': True, 14:20:49 INFO - 'halt_on_failure': False, 14:20:49 INFO - 'name': 'check_screen_resolution'},), 14:20:49 INFO - 'run_cmd_checks_enabled': True, 14:20:49 INFO - 'sps_profile': False, 14:20:49 INFO - 'sps_profile_interval': 0, 14:20:49 INFO - 'suite': 'dromaeojs-e10s', 14:20:49 INFO - 'system_bits': '32', 14:20:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:20:49 INFO - 'title': 't-yosemite-r7-0032', 14:20:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:20:49 INFO - 'use_talos_json': True, 14:20:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:20:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:20:49 INFO - 'work_dir': 'build'} 14:20:49 INFO - [mozharness: 2016-10-13 21:20:49.588586Z] Running clobber step. 14:20:49 INFO - Running pre-action listener: _resource_record_pre_action 14:20:49 INFO - Running main action method: clobber 14:20:49 INFO - rmtree: /builds/slave/test/build 14:20:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:20:51 INFO - Running post-action listener: _resource_record_post_action 14:20:51 INFO - [mozharness: 2016-10-13 21:20:51.697655Z] Finished clobber step (success) 14:20:51 INFO - [mozharness: 2016-10-13 21:20:51.697838Z] Running read-buildbot-config step. 14:20:51 INFO - Running pre-action listener: _resource_record_pre_action 14:20:51 INFO - Running main action method: read_buildbot_config 14:20:51 INFO - Using buildbot properties: 14:20:51 INFO - { 14:20:51 INFO - "project": "", 14:20:51 INFO - "product": "firefox", 14:20:51 INFO - "script_repo_revision": "production", 14:20:51 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 14:20:51 INFO - "repository": "", 14:20:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 14:20:51 INFO - "buildid": "20161013100424", 14:20:51 INFO - "pgo_build": "False", 14:20:51 INFO - "basedir": "/builds/slave/test", 14:20:51 INFO - "buildnumber": 796, 14:20:51 INFO - "slavename": "t-yosemite-r7-0032", 14:20:51 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:20:51 INFO - "platform": "yosemite_r7", 14:20:51 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 14:20:51 INFO - "branch": "fx-team", 14:20:51 INFO - "repo_path": "integration/fx-team", 14:20:51 INFO - "revision": "62ccb498db3ec05bef1b6427d5b1b4b0e501cad5", 14:20:51 INFO - "stage_platform": "macosx64", 14:20:51 INFO - "builduid": "4b9bcdcb8c2c4f22854211951697e042", 14:20:51 INFO - "slavebuilddir": "test" 14:20:51 INFO - } 14:20:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 14:20:51 INFO - Running post-action listener: _resource_record_post_action 14:20:51 INFO - [mozharness: 2016-10-13 21:20:51.701330Z] Finished read-buildbot-config step (success) 14:20:51 INFO - [mozharness: 2016-10-13 21:20:51.701465Z] Running download-and-extract step. 14:20:51 INFO - Running pre-action listener: _resource_record_pre_action 14:20:51 INFO - Running main action method: download_and_extract 14:20:51 INFO - mkdir: /builds/slave/test/build/tests 14:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:20:51 INFO - trying https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 14:20:51 INFO - Downloading https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 14:20:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 14:20:52 INFO - Downloaded 1199 bytes. 14:20:52 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 14:20:52 INFO - Using the following test package requirements: 14:20:52 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:20:52 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:20:52 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 14:20:52 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:20:52 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 14:20:52 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:20:52 INFO - u'jsshell-mac.zip'], 14:20:52 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:20:52 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 14:20:52 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:20:52 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:20:52 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 14:20:52 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:20:52 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 14:20:52 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:20:52 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 14:20:52 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:20:52 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 14:20:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:20:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:20:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:20:52 INFO - Fetch https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:20:53 INFO - Http code: 200 14:20:53 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 14:20:53 INFO - x-amz-cf-id: oIY3wCKpyJzrNcNDcCA76cmTW2Vye2puy-Bj0Av3eCAJl_U3GKNDoA== 14:20:53 INFO - x-amz-version-id: yT0Q3fpH0GPo.elGObCmn0UuIyF6AXLY 14:20:53 INFO - Expected file size: 16514314 14:20:53 INFO - Obtained file size: 16514314 14:21:00 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:21:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:21:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:21:00 INFO - Fetch https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:21:00 INFO - Http code: 200 14:21:00 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 14:21:00 INFO - x-amz-cf-id: gpoORYN7K8pTn1TAsMdYzJUTFAIPuuu5P47BYyKGnP3YgdOoMy-sIQ== 14:21:00 INFO - x-amz-version-id: yT0Q3fpH0GPo.elGObCmn0UuIyF6AXLY 14:21:01 INFO - Expected file size: 16514314 14:21:01 INFO - Obtained file size: 16514314 14:21:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 14:21:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:21:07 INFO - Fetch https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 14:21:08 INFO - Http code: 200 14:21:08 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 14:21:08 INFO - x-amz-cf-id: iOj8VjM1MwI_uOzt3oewV0_1m1CqVLlESH-zZaVZXVxaCIvBQWm4mg== 14:21:08 INFO - x-amz-version-id: 1BgHglAvLpiOLGzRQ7SM43yAKSsjXEIY 14:21:08 INFO - Expected file size: 14409006 14:21:08 INFO - Obtained file size: 14409006 14:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:09 INFO - trying https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:21:09 INFO - Downloading https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 14:21:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 14:21:12 INFO - Downloaded 111667121 bytes. 14:21:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:21:12 INFO - mkdir: /builds/slave/test/properties 14:21:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:21:12 INFO - Writing to file /builds/slave/test/properties/build_url 14:21:12 INFO - Contents: 14:21:12 INFO - build_url:https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:21:12 INFO - Running post-action listener: _resource_record_post_action 14:21:12 INFO - Running post-action listener: set_extra_try_arguments 14:21:12 INFO - [mozharness: 2016-10-13 21:21:12.972209Z] Finished download-and-extract step (success) 14:21:12 INFO - [mozharness: 2016-10-13 21:21:12.972326Z] Running populate-webroot step. 14:21:12 INFO - Running pre-action listener: _resource_record_pre_action 14:21:12 INFO - Running main action method: populate_webroot 14:21:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:21:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:21:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:21:12 INFO - '--tppagecycles', 14:21:12 INFO - '7'], 14:21:12 INFO - 'tests': ['tsvgm']}}, 14:21:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:21:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:21:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:21:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:21:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:21:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:21:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:12 INFO - 'talos_options': ['--disable-e10s'], 14:21:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:21:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:12 INFO - 'talos_options': ['--disable-e10s'], 14:21:12 INFO - 'tests': ['damp', 'tps']}, 14:21:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:12 INFO - 'tests': ['damp', 'tps']}, 14:21:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:21:12 INFO - 'tests': ['dromaeo_dom']}, 14:21:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:21:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:21:12 INFO - 'tests': ['basic_compositor_video']}, 14:21:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:21:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:21:12 INFO - 'tests': ['a11yr', 14:21:12 INFO - 'ts_paint', 14:21:12 INFO - 'tpaint', 14:21:12 INFO - 'sessionrestore', 14:21:12 INFO - 'sessionrestore_no_auto_restore', 14:21:12 INFO - 'tabpaint']}, 14:21:12 INFO - 'other-e10s': {'tests': ['a11yr', 14:21:12 INFO - 'ts_paint', 14:21:12 INFO - 'tpaint', 14:21:12 INFO - 'sessionrestore', 14:21:12 INFO - 'sessionrestore_no_auto_restore', 14:21:12 INFO - 'tabpaint']}, 14:21:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:21:12 INFO - 'ts_paint', 14:21:12 INFO - 'tpaint', 14:21:12 INFO - 'sessionrestore', 14:21:12 INFO - 'sessionrestore_no_auto_restore', 14:21:12 INFO - 'tabpaint']}, 14:21:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:21:12 INFO - 'ts_paint', 14:21:12 INFO - 'tpaint', 14:21:12 INFO - 'sessionrestore', 14:21:12 INFO - 'sessionrestore_no_auto_restore', 14:21:12 INFO - 'tabpaint']}, 14:21:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:21:12 INFO - 'tests': ['a11yr', 14:21:12 INFO - 'ts_paint', 14:21:12 INFO - 'tpaint', 14:21:12 INFO - 'sessionrestore', 14:21:12 INFO - 'sessionrestore_no_auto_restore', 14:21:12 INFO - 'tabpaint']}, 14:21:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:21:12 INFO - 'tests': ['a11yr', 14:21:12 INFO - 'ts_paint', 14:21:12 INFO - 'tpaint', 14:21:12 INFO - 'sessionrestore', 14:21:12 INFO - 'sessionrestore_no_auto_restore', 14:21:12 INFO - 'tabpaint']}, 14:21:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:21:12 INFO - 'tests': ['tsvgx', 14:21:12 INFO - 'tsvgr_opacity', 14:21:12 INFO - 'tart', 14:21:12 INFO - 'tscrollx', 14:21:12 INFO - 'cart']}, 14:21:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:21:12 INFO - 'tsvgr_opacity', 14:21:12 INFO - 'tart', 14:21:12 INFO - 'tscrollx', 14:21:12 INFO - 'cart']}, 14:21:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:12 INFO - 'talos_options': ['--disable-e10s'], 14:21:12 INFO - 'tests': ['tp5o']}, 14:21:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:12 INFO - 'tests': ['tp5o']}, 14:21:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:12 INFO - 'talos_options': ['--disable-e10s', 14:21:12 INFO - '--xperf_path', 14:21:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:12 INFO - 'tests': ['tp5n']}, 14:21:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:21:12 INFO - 'talos_options': ['--xperf_path', 14:21:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:21:12 INFO - 'tests': ['tp5n']}}, 14:21:12 INFO - 'talos.zip': {'path': '', 14:21:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:21:12 INFO - Running post-action listener: _resource_record_post_action 14:21:12 INFO - [mozharness: 2016-10-13 21:21:12.990891Z] Finished populate-webroot step (success) 14:21:12 INFO - [mozharness: 2016-10-13 21:21:12.991004Z] Running create-virtualenv step. 14:21:12 INFO - Running pre-action listener: _resource_record_pre_action 14:21:12 INFO - Running main action method: create_virtualenv 14:21:12 INFO - Creating virtualenv /builds/slave/test/build/venv 14:21:12 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 14:21:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:21:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:21:13 INFO - Using real prefix '/tools/python27' 14:21:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:21:13 INFO - Installing distribute.............................................................................................................................................................................................done. 14:21:16 INFO - Installing pip.................done. 14:21:16 INFO - Return code: 0 14:21:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:21:16 INFO - Reading from file tmpfile_stdout 14:21:16 INFO - Output received: 14:21:16 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) 14:21:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:16 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 0x10f048490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efbe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeaa57c2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5cd30>, '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 0x10ec82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54b20>, '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.TmrrR4d5Iy/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.ZET9zi2oPY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 14:21:16 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 14:21:16 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 14:21:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmrrR4d5Iy/Render', 14:21:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:16 INFO - 'HOME': '/Users/cltbld', 14:21:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:16 INFO - 'LOGNAME': 'cltbld', 14:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:16 INFO - 'MOZ_NO_REMOTE': '1', 14:21:16 INFO - 'NO_EM_RESTART': '1', 14:21:16 INFO - 'PAGER': '/bin/cat', 14:21:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:16 INFO - 'PWD': '/builds/slave/test', 14:21:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:16 INFO - 'SHELL': '/bin/bash', 14:21:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZET9zi2oPY/Listeners', 14:21:16 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:21:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:16 INFO - 'USER': 'cltbld', 14:21:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:16 INFO - 'XPC_FLAGS': '0x0', 14:21:16 INFO - 'XPC_SERVICE_NAME': '0', 14:21:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:17 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 14:21:17 INFO - Cleaning up... 14:21:17 INFO - Return code: 0 14:21:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:21: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')]} 14:21:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21: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')]} 14:21:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:17 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 0x10f048490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efbe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeaa57c2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5cd30>, '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 0x10ec82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54b20>, '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.TmrrR4d5Iy/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.ZET9zi2oPY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 14:21:17 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 14:21:17 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 14:21:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmrrR4d5Iy/Render', 14:21:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:17 INFO - 'HOME': '/Users/cltbld', 14:21:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:17 INFO - 'LOGNAME': 'cltbld', 14:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:17 INFO - 'MOZ_NO_REMOTE': '1', 14:21:17 INFO - 'NO_EM_RESTART': '1', 14:21:17 INFO - 'PAGER': '/bin/cat', 14:21:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:17 INFO - 'PWD': '/builds/slave/test', 14:21:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:17 INFO - 'SHELL': '/bin/bash', 14:21:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZET9zi2oPY/Listeners', 14:21:17 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:21:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:17 INFO - 'USER': 'cltbld', 14:21:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:17 INFO - 'XPC_FLAGS': '0x0', 14:21:17 INFO - 'XPC_SERVICE_NAME': '0', 14:21:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:17 INFO - Downloading/unpacking psutil>=3.1.1 14:21:17 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 14:21:17 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 14:21:17 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 14:21:17 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 14:21:17 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 14:21:17 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 14:21:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:21:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:21:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:21:20 INFO - Installing collected packages: psutil 14:21:20 INFO - Running setup.py install for psutil 14:21:20 INFO - building 'psutil._psutil_osx' extension 14:21:20 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 14:21:21 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 14:21:21 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 14:21:21 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 14:21:21 INFO - building 'psutil._psutil_posix' extension 14:21:21 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 14:21:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:21:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:21:21 INFO - ^ 14:21:21 INFO - 1 warning generated. 14:21:21 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 14:21:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:21:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:21:22 INFO - Successfully installed psutil 14:21:22 INFO - Cleaning up... 14:21:22 INFO - Return code: 0 14:21:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f048490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efbe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeaa57c2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5cd30>, '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 0x10ec82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54b20>, '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.TmrrR4d5Iy/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.ZET9zi2oPY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 14:21:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:21:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmrrR4d5Iy/Render', 14:21:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:22 INFO - 'HOME': '/Users/cltbld', 14:21:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:22 INFO - 'LOGNAME': 'cltbld', 14:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:22 INFO - 'MOZ_NO_REMOTE': '1', 14:21:22 INFO - 'NO_EM_RESTART': '1', 14:21:22 INFO - 'PAGER': '/bin/cat', 14:21:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:22 INFO - 'PWD': '/builds/slave/test', 14:21:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:22 INFO - 'SHELL': '/bin/bash', 14:21:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZET9zi2oPY/Listeners', 14:21:22 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:21:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:22 INFO - 'USER': 'cltbld', 14:21:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:22 INFO - 'XPC_FLAGS': '0x0', 14:21:22 INFO - 'XPC_SERVICE_NAME': '0', 14:21:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:21:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:21:24 INFO - Installing collected packages: mozsystemmonitor 14:21:24 INFO - Running setup.py install for mozsystemmonitor 14:21:25 INFO - Successfully installed mozsystemmonitor 14:21:25 INFO - Cleaning up... 14:21:25 INFO - Return code: 0 14:21:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:21:25 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')]} 14:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:25 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')]} 14:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:25 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 0x10f048490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efbe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeaa57c2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5cd30>, '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 0x10ec82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54b20>, '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.TmrrR4d5Iy/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.ZET9zi2oPY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 14:21:25 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 14:21:25 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 14:21:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmrrR4d5Iy/Render', 14:21:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:25 INFO - 'HOME': '/Users/cltbld', 14:21:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:25 INFO - 'LOGNAME': 'cltbld', 14:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:25 INFO - 'MOZ_NO_REMOTE': '1', 14:21:25 INFO - 'NO_EM_RESTART': '1', 14:21:25 INFO - 'PAGER': '/bin/cat', 14:21:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:25 INFO - 'PWD': '/builds/slave/test', 14:21:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:25 INFO - 'SHELL': '/bin/bash', 14:21:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZET9zi2oPY/Listeners', 14:21:25 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:21:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:25 INFO - 'USER': 'cltbld', 14:21:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:25 INFO - 'XPC_FLAGS': '0x0', 14:21:25 INFO - 'XPC_SERVICE_NAME': '0', 14:21:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:25 INFO - Downloading/unpacking jsonschema==2.5.1 14:21: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 14:21: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 14:21: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 14:21: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 14:21: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 14:21: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 14:21:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:21:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:21:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:21:28 INFO - Downloading functools32-3.2.3-2.tar.gz 14:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:21:28 INFO - warning: no files found matching '*.txt' 14:21:28 INFO - no previously-included directories found matching 'build' 14:21:28 INFO - no previously-included directories found matching 'dist' 14:21:28 INFO - no previously-included directories found matching '.git*' 14:21:28 INFO - Installing collected packages: jsonschema, functools32 14:21:28 INFO - Running setup.py install for functools32 14:21:28 INFO - warning: no files found matching '*.txt' 14:21:28 INFO - no previously-included directories found matching 'build' 14:21:28 INFO - no previously-included directories found matching 'dist' 14:21:28 INFO - no previously-included directories found matching '.git*' 14:21:28 INFO - Successfully installed jsonschema functools32 14:21:28 INFO - Cleaning up... 14:21:28 INFO - Return code: 0 14:21:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f048490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efbe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeaa57c2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5cd30>, '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 0x10ec82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54b20>, '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.TmrrR4d5Iy/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.ZET9zi2oPY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 14:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:21:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmrrR4d5Iy/Render', 14:21:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:28 INFO - 'HOME': '/Users/cltbld', 14:21:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:28 INFO - 'LOGNAME': 'cltbld', 14:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:28 INFO - 'MOZ_NO_REMOTE': '1', 14:21:28 INFO - 'NO_EM_RESTART': '1', 14:21:28 INFO - 'PAGER': '/bin/cat', 14:21:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:28 INFO - 'PWD': '/builds/slave/test', 14:21:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:28 INFO - 'SHELL': '/bin/bash', 14:21:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZET9zi2oPY/Listeners', 14:21:28 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:21:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:28 INFO - 'USER': 'cltbld', 14:21:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:28 INFO - 'XPC_FLAGS': '0x0', 14:21:28 INFO - 'XPC_SERVICE_NAME': '0', 14:21:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:21:29 INFO - Cleaning up... 14:21:29 INFO - Return code: 0 14:21:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:21:29 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')]} 14:21:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:29 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')]} 14:21:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:29 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 0x10f048490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efbe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeaa57c2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5cd30>, '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 0x10ec82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54b20>, '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.TmrrR4d5Iy/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.ZET9zi2oPY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 14:21:29 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 14:21:29 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 14:21:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmrrR4d5Iy/Render', 14:21:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:29 INFO - 'HOME': '/Users/cltbld', 14:21:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:29 INFO - 'LOGNAME': 'cltbld', 14:21:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:29 INFO - 'MOZ_NO_REMOTE': '1', 14:21:29 INFO - 'NO_EM_RESTART': '1', 14:21:29 INFO - 'PAGER': '/bin/cat', 14:21:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:29 INFO - 'PWD': '/builds/slave/test', 14:21:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:29 INFO - 'SHELL': '/bin/bash', 14:21:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZET9zi2oPY/Listeners', 14:21:29 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:21:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:29 INFO - 'USER': 'cltbld', 14:21:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:29 INFO - 'XPC_FLAGS': '0x0', 14:21:29 INFO - 'XPC_SERVICE_NAME': '0', 14:21:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:29 INFO - Downloading/unpacking blobuploader==1.2.4 14:21:29 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 14:21:29 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 14:21:29 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 14:21:29 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 14:21:29 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 14:21:29 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 14:21:31 INFO - Downloading blobuploader-1.2.4.tar.gz 14:21:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:21:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:21:31 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 14:21:31 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 14:21:31 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 14:21:31 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 14:21:31 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 14:21:31 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 14:21:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:21:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:21:32 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 14:21:32 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 14:21:32 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 14:21:32 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 14:21:32 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 14:21:32 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 14:21:33 INFO - Downloading docopt-0.6.1.tar.gz 14:21:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:21:33 INFO - Installing collected packages: blobuploader, requests, docopt 14:21:33 INFO - Running setup.py install for blobuploader 14:21:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:21:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:21:33 INFO - Running setup.py install for requests 14:21:33 INFO - Running setup.py install for docopt 14:21:33 INFO - Successfully installed blobuploader requests docopt 14:21:33 INFO - Cleaning up... 14:21:34 INFO - Return code: 0 14:21:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:34 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 0x10f048490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efbe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeaa57c2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5cd30>, '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 0x10ec82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54b20>, '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.TmrrR4d5Iy/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.ZET9zi2oPY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 14:21:34 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 14:21:34 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 14:21:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmrrR4d5Iy/Render', 14:21:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:34 INFO - 'HOME': '/Users/cltbld', 14:21:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:34 INFO - 'LOGNAME': 'cltbld', 14:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:34 INFO - 'MOZ_NO_REMOTE': '1', 14:21:34 INFO - 'NO_EM_RESTART': '1', 14:21:34 INFO - 'PAGER': '/bin/cat', 14:21:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:34 INFO - 'PWD': '/builds/slave/test', 14:21:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:34 INFO - 'SHELL': '/bin/bash', 14:21:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZET9zi2oPY/Listeners', 14:21:34 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:21:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:34 INFO - 'USER': 'cltbld', 14:21:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:34 INFO - 'XPC_FLAGS': '0x0', 14:21:34 INFO - 'XPC_SERVICE_NAME': '0', 14:21:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:21:34 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-R8wMwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:21:34 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Fn15LJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:21:34 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-wbUQsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:21:34 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-JianPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:21:34 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-gOP6tK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:21:34 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-8YF1Kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:21:34 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-cSNxk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:21:34 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Qw26nM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:21:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-_hXwcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:21:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-6LFlI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:21:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-2tZ6fn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:21:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-kcVjVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:21:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-4lqkXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:21:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-2Q_8WR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-CIMUfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:21:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-GqUusd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:21:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:21:35 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-wQbch7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:21:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:21:36 INFO - Running setup.py install for manifestparser 14:21:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:21:36 INFO - Running setup.py install for mozcrash 14:21:36 INFO - Running setup.py install for mozdebug 14:21:36 INFO - Running setup.py install for mozdevice 14:21:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:21:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:21:36 INFO - Running setup.py install for mozfile 14:21:36 INFO - Running setup.py install for mozhttpd 14:21:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:21:36 INFO - Running setup.py install for mozinfo 14:21:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:21:37 INFO - Running setup.py install for mozInstall 14:21:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:21:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:21:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:21:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:21:37 INFO - Running setup.py install for mozleak 14:21:37 INFO - Running setup.py install for mozlog 14:21:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:21:37 INFO - Running setup.py install for moznetwork 14:21:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:21:37 INFO - Running setup.py install for mozprocess 14:21:37 INFO - Running setup.py install for mozprofile 14:21:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:21:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:21:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:21:37 INFO - Running setup.py install for mozrunner 14:21:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:21:38 INFO - Running setup.py install for mozscreenshot 14:21:38 INFO - Running setup.py install for moztest 14:21:38 INFO - Running setup.py install for mozversion 14:21:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:21:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:21:38 INFO - Cleaning up... 14:21:38 INFO - Return code: 0 14:21:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:21:38 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')]} 14:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:38 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')]} 14:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:38 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 0x10f048490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efbe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeaa57c2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5cd30>, '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 0x10ec82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54b20>, '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.TmrrR4d5Iy/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.ZET9zi2oPY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 14:21:38 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 14:21:38 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 14:21:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmrrR4d5Iy/Render', 14:21:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:38 INFO - 'HOME': '/Users/cltbld', 14:21:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:38 INFO - 'LOGNAME': 'cltbld', 14:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:38 INFO - 'MOZ_NO_REMOTE': '1', 14:21:38 INFO - 'NO_EM_RESTART': '1', 14:21:38 INFO - 'PAGER': '/bin/cat', 14:21:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:38 INFO - 'PWD': '/builds/slave/test', 14:21:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:38 INFO - 'SHELL': '/bin/bash', 14:21:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZET9zi2oPY/Listeners', 14:21:38 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:21:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:38 INFO - 'USER': 'cltbld', 14:21:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:38 INFO - 'XPC_FLAGS': '0x0', 14:21:38 INFO - 'XPC_SERVICE_NAME': '0', 14:21:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:21:38 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-ziF_BD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:21:38 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)) 14:21:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:21:38 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-uTbOUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:21:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-rMTE_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:21:39 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)) 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:21:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-4eTrOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:21:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:21:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-bHlB10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:21:39 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)) 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:21:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-1TIk7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:21:39 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)) 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:21:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-A4j9hN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:21:39 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)) 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:21:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-wTg32f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:21:39 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)) 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:21:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-X5JVjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:21:39 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)) 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:21:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-iXQxVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:21:39 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)) 14:21:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:21:39 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-emnuwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:21:40 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)) 14:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:21:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-HDJHUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:21:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-TNUNvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:21:40 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)) 14:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:21:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-hKgGjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 14:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-_o5MoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:21:40 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)) 14:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:21:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-M7mqNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:21:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:21:40 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-6evh0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:21:40 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)) 14:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:21:40 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)) 14:21:40 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:21:40 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:21:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:21:40 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 14:21:40 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 14:21:40 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 14:21:40 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 14:21:40 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 14:21:40 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 14:21:43 INFO - Downloading blessings-1.6.tar.gz 14:21:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:21:43 INFO - Installing collected packages: blessings 14:21:43 INFO - Running setup.py install for blessings 14:21:43 INFO - Successfully installed blessings 14:21:43 INFO - Cleaning up... 14:21:43 INFO - Return code: 0 14:21:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:21:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:21:43 INFO - Reading from file tmpfile_stdout 14:21:43 INFO - Current package versions: 14:21:43 INFO - blessings == 1.6 14:21:43 INFO - blobuploader == 1.2.4 14:21:43 INFO - docopt == 0.6.1 14:21:43 INFO - functools32 == 3.2.3-2 14:21:43 INFO - jsonschema == 2.5.1 14:21:43 INFO - manifestparser == 1.1 14:21:43 INFO - mozInstall == 1.12 14:21:43 INFO - mozcrash == 0.17 14:21:43 INFO - mozdebug == 0.1 14:21:43 INFO - mozdevice == 0.48 14:21:43 INFO - mozfile == 1.2 14:21:43 INFO - mozhttpd == 0.7 14:21:43 INFO - mozinfo == 0.9 14:21:43 INFO - mozleak == 0.1 14:21:43 INFO - mozlog == 3.4 14:21:43 INFO - moznetwork == 0.27 14:21:43 INFO - mozprocess == 0.23 14:21:43 INFO - mozprofile == 0.28 14:21:43 INFO - mozrunner == 6.12 14:21:43 INFO - mozscreenshot == 0.1 14:21:43 INFO - mozsystemmonitor == 0.3 14:21:43 INFO - moztest == 0.7 14:21:43 INFO - mozversion == 1.4 14:21:43 INFO - psutil == 3.1.1 14:21:43 INFO - requests == 1.2.3 14:21:43 INFO - wsgiref == 0.1.2 14:21:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:43 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 0x10f048490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efbe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeaa57c2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5cd30>, '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 0x10ec82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54b20>, '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.TmrrR4d5Iy/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.ZET9zi2oPY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 14:21:43 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 14:21:43 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 14:21:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmrrR4d5Iy/Render', 14:21:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:43 INFO - 'HOME': '/Users/cltbld', 14:21:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:43 INFO - 'LOGNAME': 'cltbld', 14:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:43 INFO - 'MOZ_NO_REMOTE': '1', 14:21:43 INFO - 'NO_EM_RESTART': '1', 14:21:43 INFO - 'PAGER': '/bin/cat', 14:21:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:43 INFO - 'PWD': '/builds/slave/test', 14:21:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:43 INFO - 'SHELL': '/bin/bash', 14:21:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZET9zi2oPY/Listeners', 14:21:43 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:21:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:43 INFO - 'USER': 'cltbld', 14:21:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:43 INFO - 'XPC_FLAGS': '0x0', 14:21:43 INFO - 'XPC_SERVICE_NAME': '0', 14:21:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:44 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)) 14:21:44 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)) 14:21:44 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)) 14:21:44 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)) 14:21:44 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)) 14:21:44 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)) 14:21:44 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)) 14:21:44 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)) 14:21:44 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)) 14:21:44 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)) 14:21:44 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)) 14:21:44 INFO - Cleaning up... 14:21:44 INFO - Return code: 0 14:21:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:21: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')]} 14:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:21:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21: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')]} 14:21:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:21:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:21:44 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 0x10f048490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10efbe570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbeaa57c2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5cd30>, '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 0x10ec82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54b20>, '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.TmrrR4d5Iy/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.ZET9zi2oPY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 14:21:44 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 14:21:44 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 14:21:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmrrR4d5Iy/Render', 14:21:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:21:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:21:44 INFO - 'HOME': '/Users/cltbld', 14:21:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:21:44 INFO - 'LOGNAME': 'cltbld', 14:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:21:44 INFO - 'MOZ_NO_REMOTE': '1', 14:21:44 INFO - 'NO_EM_RESTART': '1', 14:21:44 INFO - 'PAGER': '/bin/cat', 14:21:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:21:44 INFO - 'PWD': '/builds/slave/test', 14:21:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:21:44 INFO - 'SHELL': '/bin/bash', 14:21:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZET9zi2oPY/Listeners', 14:21:44 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:21:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:21:44 INFO - 'USER': 'cltbld', 14:21:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:21:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:21:44 INFO - 'XPC_FLAGS': '0x0', 14:21:44 INFO - 'XPC_SERVICE_NAME': '0', 14:21:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:21:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:21:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:21:44 INFO - Cleaning up... 14:21:44 INFO - Return code: 0 14:21:44 INFO - Running post-action listener: _resource_record_post_action 14:21:44 INFO - Running post-action listener: _start_resource_monitoring 14:21:44 INFO - Starting resource monitoring. 14:21:44 INFO - [mozharness: 2016-10-13 21:21:44.478175Z] Finished create-virtualenv step (success) 14:21:44 INFO - [mozharness: 2016-10-13 21:21:44.479149Z] Running install step. 14:21:44 INFO - Running pre-action listener: _resource_record_pre_action 14:21:44 INFO - Running main action method: install 14:21:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:21:44 INFO - Reading from file tmpfile_stdout 14:21:44 INFO - Detecting whether we're running mozinstall >=1.0... 14:21:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:21:44 INFO - Reading from file tmpfile_stdout 14:21:44 INFO - Output received: 14:21:44 INFO - Usage: mozinstall [options] installer 14:21:44 INFO - Options: 14:21:44 INFO - -h, --help show this help message and exit 14:21:44 INFO - -d DEST, --destination=DEST 14:21:44 INFO - Directory to install application into. [default: 14:21:44 INFO - "/builds/slave/test"] 14:21:44 INFO - --app=APP Application being installed. [default: firefox] 14:21:44 INFO - mkdir: /builds/slave/test/build/application 14:21:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:22:19 INFO - Reading from file tmpfile_stdout 14:22:19 INFO - Output received: 14:22:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:22:19 INFO - Running post-action listener: _resource_record_post_action 14:22:19 INFO - [mozharness: 2016-10-13 21:22:19.640721Z] Finished install step (success) 14:22:19 INFO - [mozharness: 2016-10-13 21:22:19.640836Z] Running run-tests step. 14:22:19 INFO - Running pre-action listener: _resource_record_pre_action 14:22:19 INFO - Running main action method: run_tests 14:22:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:22:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:22:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:22:19 INFO - 2016-10-13 14:22:19.655 screenresolution[1642:7573] starting screenresolution argv=screenresolution get 14:22:19 INFO - 2016-10-13 14:22:19.658 screenresolution[1642:7573] Display 0: 1600x1200x32@60 14:22:19 INFO - 2016-10-13 14:22:19.664 screenresolution[1643:7575] starting screenresolution argv=screenresolution list 14:22:19 INFO - Available Modes on Display 0 14:22:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:22:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:22:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:22:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:22:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:22:19 INFO - Intel Iris: 14:22:19 INFO - Chipset Model: Intel Iris 14:22:19 INFO - Type: GPU 14:22:19 INFO - Bus: Built-In 14:22:19 INFO - VRAM (Dynamic, Max): 1536 MB 14:22:19 INFO - Vendor: Intel (0x8086) 14:22:19 INFO - Device ID: 0x0a2e 14:22:19 INFO - Revision ID: 0x0009 14:22:19 INFO - Displays: 14:22:19 INFO - Display: 14:22:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:22:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:22:19 INFO - Display Serial Number: 1600x1200 60 14:22:19 INFO - Main Display: Yes 14:22:19 INFO - Mirror: Off 14:22:19 INFO - Online: Yes 14:22:19 INFO - Rotation: Supported 14:22:19 INFO - Return code: 0 14:22:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:22:19 INFO - Python 2.7.3 14:22:19 INFO - Return code: 0 14:22:19 INFO - grabbing minidump binary from tooltool 14:22:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:22:19 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 0x10ee5cd30>, '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 0x10ec82db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee54b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:22:19 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 14:22:19 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 14:22:19 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 14:22:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:22:20 INFO - Return code: 0 14:22:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:22:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:22:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:22:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:22:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:22:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--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 14:22:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0032 --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 14:22:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TmrrR4d5Iy/Render', 14:22:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:20 INFO - 'HOME': '/Users/cltbld', 14:22:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:20 INFO - 'LOGNAME': 'cltbld', 14:22:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:22:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:20 INFO - 'MOZ_NO_REMOTE': '1', 14:22:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:22:20 INFO - 'NO_EM_RESTART': '1', 14:22:20 INFO - 'PAGER': '/bin/cat', 14:22:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:20 INFO - 'PWD': '/builds/slave/test', 14:22:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:22:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:20 INFO - 'SHELL': '/bin/bash', 14:22:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZET9zi2oPY/Listeners', 14:22:20 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 14:22:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:20 INFO - 'USER': 'cltbld', 14:22:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:20 INFO - 'XPC_FLAGS': '0x0', 14:22:20 INFO - 'XPC_SERVICE_NAME': '0', 14:22:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--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 14:22:20 INFO - mozversion application_buildid: 20161013100424 14:22:20 INFO - mozversion application_changeset: 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5 14:22:20 INFO - mozversion application_display_name: Nightly 14:22:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:22:20 INFO - mozversion application_name: Firefox 14:22:20 INFO - mozversion application_remotingname: firefox 14:22:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:22:20 INFO - mozversion application_vendor: Mozilla 14:22:20 INFO - mozversion application_version: 52.0a1 14:22:20 INFO - mozversion platform_buildid: 20161013100424 14:22:20 INFO - mozversion platform_changeset: 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5 14:22:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:22:20 INFO - mozversion platform_version: 52.0a1 14:22:20 INFO - using testdate: 1476393740 14:22:20 INFO - actual date: 1476393740 14:22:20 INFO - starting webserver on 'localhost:49273' 14:22:20 INFO - SUITE-START | Running 2 tests 14:22:20 INFO - TEST-START | dromaeo_css 14:22:20 INFO - operating with platform_type : mac_ 14:22:20 INFO - Initialising browser for dromaeo_css test... 14:22:20 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpqIj1HW/profile http://localhost:49273/getInfo.html) 14:22:23 INFO - PROCESS | 1653 | 2016-10-13 14:22:23.194 plugin-container[1655:7739] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 14:22:23 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:22:23 INFO - PROCESS | 1653 | 2016-10-13 14:22:23.197 plugin-container[1655:7739] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 14:22:23 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:22:23 INFO - PROCESS | 1653 | 2016-10-13 14:22:23.197 plugin-container[1655:7739] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:22:23 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 14:22:23 INFO - PROCESS | 1653 | colorDepth:24 14:22:23 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 14:22:23 INFO - PROCESS | 1653 | __metrics 14:22:23 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 14:22:23 INFO - TEST-INFO | 1653: exit 0 14:22:23 INFO - Browser initialized. 14:22:23 INFO - Running cycle 1/1 for dromaeo_css test... 14:22:23 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpqIj1HW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:22:26 INFO - PROCESS | 1656 | 2016-10-13 14:22:26.205 plugin-container[1657:7861] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 14:22:26 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:22:26 INFO - PROCESS | 1656 | 2016-10-13 14:22:26.205 plugin-container[1657:7861] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 14:22:26 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:22:26 INFO - PROCESS | 1656 | 2016-10-13 14:22:26.205 plugin-container[1657:7861] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:22:35 INFO - PROCESS | 1656 | RSS: Main: 239357952 14:22:35 INFO - PROCESS | 1656 | 14:23:25 INFO - PROCESS | 1656 | 1476393805562 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:25:38 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 14:25:39 INFO - PROCESS | 1656 | RSS: Main: 252616704 14:25:39 INFO - PROCESS | 1656 | 14:28:41 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 14:28:42 INFO - PROCESS | 1656 | RSS: Main: 265461760 14:28:42 INFO - PROCESS | 1656 | 14:31:44 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 14:31:45 INFO - PROCESS | 1656 | RSS: Main: 269598720 14:31:45 INFO - PROCESS | 1656 | 14:34:46 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 14:34:47 INFO - PROCESS | 1656 | RSS: Main: 269312000 14:34:47 INFO - PROCESS | 1656 | 14:37:50 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 14:37:51 INFO - PROCESS | 1656 | RSS: Main: 274681856 14:37:51 INFO - PROCESS | 1656 | 14:40:53 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 14:40:54 INFO - PROCESS | 1656 | RSS: Main: 277352448 14:40:54 INFO - PROCESS | 1656 | 14:40:54 INFO - PROCESS | 1656 | __start_tp_report 14:40:54 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 14:40:54 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 14:40:54 INFO - PROCESS | 1656 | |i|pagename|runs| 14:40:54 INFO - PROCESS | 1656 | |0;dojo.html;3364.461686130219;3365.7980521168747;3407.2163402417436;3413.0102270341604;3415.795052296864;5536.086545719952;5606.046972014762;5606.943930560693;5658.236138121362;5689.2603961485;4574.794134263958;5564.944350556493;5675.460831221028;5710.400407957157;5743.9712801435935;4153.584641535853;5021.548060674539;5132.332796736438;5159.690418574879;5252.921206181911;5103.234514822788;5253.973730131344;5295.338082739658;5296.046711591912;5307.867303317409;5080.415752188472;5219.399769026534;5228.660137091077;5251.422343542226;5334.973325133369;5130.410002849682;5131.743412829381;5141.845744627667;5167.896642067138;5231.346081739783;5079.5428411443145;5086.135356989321;5118.692878427306;5130.3074084998425;5152.425506050671;5686.971565142189;5711.942880571182;5716.599838011341;5734.369219385864;5736.455036771542;6125.111858780497;6134.846628834271;6179.443850053472;6226.40849119333;6238.625682459067;6186.412290832363;6215.12988181655;6235.282942461629;6290.685465726695;6313.305536390993;5587.580931430078;5635.746391412396;5770.297762160131;5785.855353616151;5799.2750906136735;5162.5095615916425;5889.4993925515955;6176.505879529627;6221.035739460391;6228.439440450381;6109.572329936951;6122.418370254908;6125.081237814364;6132;6139.140520327158;6054.51563874889;6217.595856269328;6224.9377506224355;6251.4061164189325;6267.65527895961;5969.641821490724;6111.908321375183;6126.181801870944;6167.537434692416;6181.196444462191;6101.24471383566;6140.3552626974415;6221.502279817604;6226.501879849601;6231.501479881598;4911.214205727138;4925.852224433273;4940.987097644974;4942.085714142823;4951.579115775199;4301.634361079281;4319.028218650778;4361.847335343247;4387.4954380246045;4417.138657961731;5521.254630624814;5835.5915085944425;5849.298084229919;5849.385814489502;5896.64620122794;6126.172966649535;6245.96877015612;6288.654124023131;6306.621602703761;6308.148399965946;5557;5654.6324488908085;5709.714514274269;5755.740991655385;5837.7664893404635;5372.355317361941;5392.433794451526;5399.055165346127;5402.783888644489;5440.455954404607;4737.455192652889;5502.752376143163;5528.834134976038;6300;6305.747770089145;6105.035213715839;6123.050927106306;6130.856783744145;6264.812055638338;6283.5601507895835;6166.414190651881;6275.560710750204;6331.936680633319;6346.365363463801;6357.618542887441;6128.264608247039;6140.877182456236;6144.38556144382;6148.354422785543;6175.783847565313;5913.172155898264;6075.967085595547;6108.205933228652;6126.632402055891;6136.846578835565;6050.969745151246;6071.848203794763;6092.208012958465;6113.908291375722;6118.632882027093;6056.333803281724;6080.270367555921;6100.176476175837;6109.450149486567;6113.969430152821;4712.293156026486;5230.790768369223;5841.415858414294;5871.7651293949475;5944.3164036136395;6028.15605815195;6069.150318955438;6071.362506936708;6083.878322433615;6099.2985806632805;5859.414058594107;5890.204822348928;5932.199153114274;5938.910916336172;5984.042553191643 14:40:54 INFO - PROCESS | 1656 | |1;ext.html;479.1303783632707;497.0233491189811;509.8572399728075;510.13022796132594;521.7365230558565;37015.62984370156;39848.60151398485;39984.40023399648;41731.37402938958;41858;40833.38749918746;40929.181416371655;41585.7920710396;41641.95895102624;41717;9303.767405814859;9481;9584.712458626253;9590.842060536394;9612.711618651452;9478.146966772989;9583.377080489781;9589.472579008152;9591.904080959206;9605.66380176694;9541.570629321663;9628.422294662309;9636.325457217998;9636.951815240915;9703.320767546275;9541.188998935064;9593.616255349778;9621.807563848684;9624.615015399375;9628.27787915902;9467.195288400495;9525.237980961507;9611;9613.086756758097;9648.662296819648;38963.02592435184;39357.40963885544;39436.40845387321;39448.408273875626;39564.20871582552;3067.2331917020747;3266.591676040495;3311.0397984584442;3462.6149540183874;3573;29689.851550742107;30087.172607703396;30348;30454.238644033856;30455;3132.3265497918055;3157.7265965836878;3293.6870997255223;3328.5506456628286;3336.115929278743;339762;340988;341738;342746.9999999975;343303;55960.44039559552;56331;56403.48772098222;56477.71761141168;56549.43450565442;59577.702111490034;60326.77712560078;60557;60650;60673;15474.767878481833;15651.608709782347;15691;15749.13379764124;15767.921160394355;11999.76000480003;12035.759284814254;12094.637160885188;12151.696207594705;12152.57465988704;15992.20136476112;16851.74722379165;16921.492355229362;16924.915375423043;16925;7110.857782844314;7156.463265255023;7179.461540384387;7275.417966562768;7287.684103732895;823.197382552007;924.9039887732923;935.335911502827;947.2564037230741;972.6304004478394;26928.86535567349;28679.56980645292;29354.11937641874;29855.552166717516;30116.397672046438;898.9865152022725;1046.2832959422667;1048.2295512798087;1087.0868470484832;1111.055801682516;12829.29438880852;14611.488597899022;15414.922925385301;15495.14776687293;15626.062436253635;631885;633590;633649;633779;635253;54835.62910927259;55804.88390232173;55821.441785582436;55878.72060639671;56138.7193064032;1271.5930902111236;1327.4557431453059;1332.7201287729492;1340.3432318164225;1342.0404410846293;28329.433411331247;28899.56650650284;29106;29678.58696249959;29876.70123298739;49536.50463495463;49845.501544985535;49949;50011;50073.74963125307;568836.1558192183;575497;575576;576112;577795.222047791;39290.24968252195;39776.80111599423;40122.59877401305;40177.598224018555;40180.79909600433;44612.776936115115;45629.315560267285;45665;46749;46814.53185468238;37644.62355376411;37652;38257;38549.6145038546;38751.8374448767;36747.44878826766;36787.63212367842;37160.81419592885;37961.050973725876;38436.80781596186;32276.515852261764;33143.66856331406;37078;37351.62648373481;38083.809580951915;31333.216669583442;32457.675423246408;33614.663853361155;34167.65832341645;34197.48703769396;25168.874155629106;25318.620220696335;25346.746532535177;25444.745552544977;25955.61066583965 14:40:54 INFO - PROCESS | 1656 | |2;jquery.html;341.7866573663494;362.4092728851969;362.7859562857913;367.3351234265979;386.8761996161228;17689;18271.54321141972;18814.717779233306;19740;20192.8990355048;18393.44819655409;18625.720614190763;18836.34072807452;19161.52096197596;19200.615987680238;5647.181158731992;5888.499477544392;5929.584929054968;5931.436513531207;5945.554083443759;5532.474414930575;5791.884162316751;5849.941500584982;5853.034249348852;5865.76536938522;5711.8572035699235;5742.511886489632;5749.65502069875;5750.942490575083;5786.479216870481;5544.140658197965;5862.853428664275;5918.289805223358;5975.312839023524;5994.820155395345;5578.246936663539;5711.343195532525;5732.254806875121;5758.136279558058;5762.654240745527;9054.143900500381;9740.269479788973;10147.79704405915;11820.290782553075;11844.763104737856;2170.1319472211085;2216.4791274050585;2325.767423257678;2641.960370594443;2907.956380654292;8039.799005024863;9459;9636.855447168227;10117.544710488046;10147.238957078249;1759.155605309446;1779.661864245789;1789.391606853663;1810.3754204799322;1877.915493802782;117693;124516;125624.11563826459;125891;127102.2056912033;10534.102382118665;10988.560457581767;11013.559457621766;11147.498362573542;11289.887101129048;13688.589342319747;13848;13904.791428128587;13920.677535634099;13944.860551394559;7750.341220996165;8059.919400806034;8069.426461839885;8174.509529428254;8191.795205119801;6656.901611234189;7582.734604288823;7933.206679332021;7938.56337901421;8124.106348301682;4285.5928686774705;4286.271333873249;4291.420658211164;4320.308750599952;4386.758728269976;1825.8448031917171;1862.5064357945155;1876.74663920369;1882.8493720502327;1935.816097470738;796.3907610677836;862.0132533294984;895.1496078725237;918.2332752151895;969.3311614985637;15033.473828416172;19071.80928190728;19582.90208548948;19602;20211.494712632302;803.5299349880386;893.1604291965662;916.8258030974227;919.9034101419254;947.7820101376584;9792.461414622121;10284.331518451278;10306.742331441774;10390.48047597617;10532.315399499008;573094;574793;575074;590615;591113;114585;118146;118161;123473.38263308626;129942;989.7030890732896;1001.2940876681922;1007.3301254665565;1010.4190090697731;1031.9638812641522;16292.755608666117;18232.726509102107;18260.817391825913;18564.907175464035;18606.81393186051;57498.13752793795;57507;58484.12273815811;58865.70567147137;59417.51456213629;74762;76520;82236.58881705553;85730;87014.6947795771;7757;7803.531788092732;7977.282044616012;8013.278804907586;8090;9416.905830941603;10556.366618002945;12570.748585028065;12634.873651263737;12815.743685126432;9757.365771224848;10508.78982420332;10762.784744305227;10905.890941090805;10939.835902461311;8551.230389264996;8863.911360886566;9396.778418805512;10449.791004180026;11123;9698.127168554864;9701.951490242503;10270.537825797708;10562.630857335103;11263.436828158723;6483.967580162069;7565.319121279112;7941.523508589503;8049.436539442183;8095.02859656845;8618.310535157298;10990.560377585127;11086.722831929266;11094.889051109385;11168.329900206014 14:40:54 INFO - PROCESS | 1656 | |3;mootools.html;1255.7990721484564;1312.6783937935204;1524.0017788348628;1747.571844898;1768.2750072470283;7825.295723384894;8059.314958228543;8303.833923321537;8885.600147993347;8897.68858089967;8341.62462689179;8620.698275560357;8625.741227763161;8750.124987501247;8752.78118047049;2294.19703103914;2327.453048533593;2336.778006089419;2337.614293641547;2340.20433052762;2305.4236440889777;2339.251439539348;2349.130821596012;2349.7650234976536;2359.256834097254;2114.7356580427445;2144.1209104267255;2146.549224662815;2176.62997290461;2199.472126689591;2020.3837829462009;2273.9090436382526;2304.5506126305377;2304.8962796674105;2311.4452531392512;2297.977020229793;2304.677345171677;2308.8499247548857;2313.838031337807;2315.6642286868478;8637.568121593895;8755.168259015383;8787.297016238686;8806.647734090693;8807.987081485648;5002.649814512985;5163.173892177271;5165.199394093884;5167.3282473278605;5186.455422180655;3319.5020746887917;3409.454487282048;3511.5786105667485;3528.0826984983833;3534.1164708822794;1055.176961969665;1063.1813503602261;1068.1775033224374;1086.098538213281;1087.152021423291;11594.594189203337;11700.122490813137;11704.88295117055;11708.88291117095;11729.178957472981;4459.219636563588;4508.616767574793;4678.50875658051;4701.717896926195;4711.646626503026;9815.2147828175;9900.009999000042;9904;9913.65302214419;9920.156786673213;5118.718470484159;5127.461616530285;5129.179331306973;5140.820071297561;5141.0232055909255;4203.5376108628025;4356.934645980313;4524.163029839425;4650.488446270908;4693.671442999025;3748.887533374003;3806.8286927088348;3875.6318149775725;3901.96098039016;3907.4724912137067;1230.2372529032057;1231.8644949055597;1235.2218102595307;1240.1443004326986;1246.7568824079399;866.3199388480012;882.4131952251681;887.5163036145316;889.564113584339;915.2540679346445;5486.780528778884;5847.26909136358;5946.762129514857;5970;6045.607035542764;877.4165180155253;885.5041176940933;891.7114769158503;920.3005715656016;963.0321526865455;3920.6079392060565;3996.820143093568;4060.837566497366;4098.077932465171;4231.386448964944;10590.364578125336;10779.35323880554;10794.568217271379;10794.622188223375;10796.67609971702;10610.522526486327;10666.626668066581;10728.195385346131;10748.441475985937;10758.300710453796;7965.322947549524;8048.476849004796;8067.233612806774;8067.959660201662;8209.261166495044;4928.433230178575;5332.120200166929;5724.513416359656;5835.533157347487;6060.363661815446;9781.41311521311;10039.648612298535;10108.292419530562;10113.190944724258;10121.291509594257;9757.585150153047;10108.595656173671;10243.94878025605;10283.023112804272;10300.175985921258;6778.186617605918;6987.266337034742;7037.401820845285;7354.080739907512;7498;8161.877571836309;8212;8269.09040005611;8295;8344.791380215544;6484.962406015015;7204.891926621;7217.06178196831;7368.1526624438875;7461.701531938662;6374.776882809079;6836.906095024772;6893.276205998499;7219.530730502711;7246.782596522113;6186.566940314135;6547.639879806657;6703.262641109572;6779.186497620317;6828.248892621708;4769;4898.599686153688;4934.901301973869;4965.4041515018425;5047.545720885138;4924.335214745964;5020.899582008266;5037;5062.291279220838;5141.074606570854 14:40:54 INFO - PROCESS | 1656 | |4;prototype.html;294.50670127536375;296.93912747886685;301.0546882788045;305.20341907621105;306.4407456392085;4672.392588963434;5020.6234532410035;5430.782768689258;5447.747018185814;5453.781848726051;5341.1187154119525;5378.650387724795;5386.572558272061;5406.377726922961;5431.293931788872;3252.9349413011723;3923.5880232575596;4054.858079967202;4064.3903414487913;4110.260153172428;4079.5920407959266;4127.101533294688;4128.091819799639;4138.213739389522;4152.211079894811;3314.370269648759;3458.806711684465;4105.609967053125;4112.753234805907;4117.485314335708;3778.8299526521096;3787.8636409077444;3982.2677135446174;4098.6516146127615;4129.215449064668;3463.1169051891607;3481.704055155315;3481.791092534431;3484.285721427101;3485.3203625293077;4281.250781113293;4883.827881308496;5217.426083130853;5219.73901304937;5268.868278293035;4093.9385909211387;4142.730722503027;4215.662746980234;4568.596395685236;4605.631549476034;4906.693853888667;4932.408111026664;5647.350554686182;5650.51970582501;5750.338711048199;3339.3655205510877;3798.2213646202463;3799.25914446683;3812.4471951567143;3825.4261860720835;5066.062778385974;5187.533122019036;5832.433729159199;5943.543831761203;5983.970080149615;2981.8509074546187;3529.3823580873245;3780.4896338994436;3784.8456220852904;3888.202918401721;3250.4636734938945;3302.844004598371;3439.724822014233;3927.4697915781576;3933.468981687493;3514.367413865478;4314.90726997406;4574.222382194968;4608.654350923694;4620.953790462119;5072.594192464594;5363.436839131913;5717.514011309086;5775.018246898037;5794.681292528951;1117.871444783844;1350;1351.6823546466574;1354.1536539662711;1364.447398803486;781.8045488627843;803.9307720731413;821.2958111917794;824.698984870518;827.5076329583887;5130.7947682093045;5200.115980283361;5401.513863752202;5404.270633397354;5410.675359478444;5202.4277329493725;5547.639403438763;5889.4993925515955;5893.086571581412;5898.8497243038055;4257.361395790656;4863.878403039882;5097.439281679012;5334.306540149756;5377.193420986883;2898.8985385511405;2980.8062475938996;2999.7750168737434;3081.553174789643;3118.8596513156963;5303.390110137384;5710.71446427677;5798.985177593904;6054.606450580698;6207.410296021961;4456.059001059285;5253.868653283622;5332.576939441193;5860.794872179454;5988.850278743066;4840.394950631101;5912.645241285537;6097.420745029215;6112.327643959161;6149.907751383822;5598.10430331145;5824.970875145597;5833.416658334133;5846.473817356288;5903.527717782481;4773.1408346497965;5018.44797072329;5730.911126885879;5810.970945145247;5832.854178645568;5088.974555127201;6098.512119030378;6110.572259941761;6120.25572711775;6130.816075517741;3197.2806118623125;3594.2991116731987;3864.516935383077;3901.9269700831364;3911.2373087247715;5139.357580302462;5889.37803250989;5890.9116363253725;5891.675957822361;5907.911381329198;4433.977830110829;5725.570582206435;5736.254286942671;5756.481916627524;5779.624324418899;4702.858914232578;5519.724013799374;5684.545236380997;5769.394128669582;5817.7963771267805;5101.240072175094;5327.440618734977;5601.383847776823;5606.299212598426;5634.802781902614;5389.299391079135;5565.443455654402;5600.899662626515;5713.114467257582;5731;4816.783244753924;4879.365682461257;4900.828471003498;5027.868729535825;5572.832815015556 14:40:54 INFO - PROCESS | 1656 | |5;yui.html;593.4836692077893;650.3074225949364;655.5542231282728;666.5201055240227;740.3373980287643;13892.444302227912;14647.340869660864;14748.33632486538;14772;14809.037412568176;12898.806517902216;12995.285259310758;13036.73926521469;13045.93477032616;13047.60857174284;621.4034526854225;646.3504178300801;786.2962648429666;805.8831469436929;807.4509333653114;767.8003719033063;801.3308887079296;805.4683908620311;819.6516480495766;819.7991492084448;817.2930415190847;852.526847599582;852.6845067325098;852.8720691896203;858.3090612057291;701.8140192848899;705.1819888928843;802.0255389701512;816.383630359081;850.9617067231959;557.4035781713568;637.7512770019696;638.2851206648584;639.3031595560861;640.2061443809689;13293.069485136044;13445.731085378238;13452.260125693181;13476.124051936691;13483.932580337036;13623.386947587382;13715.794263086062;13768.793468097987;13886.861131388658;14008.859911400858;11416.885831141666;11429.142814288962;11455.521579330047;11858.466369013415;11982.26257192711;3200.2959348943195;3675;3689.05928988109;3714.7771133732062;3738.1962877981364;91510;113989.4300528492;115650;116013.83986160115;116120.41939790247;10504.422256775797;10511.106555942677;10618.097461715686;10773.030427261427;10945.890541094646;21015;21111.68332475014;21336.573268534852;21340.253091141734;21395.893020534797;6778.898316525256;7315.707371705073;7377.963110184414;7555.896689560285;7623.9618801906745;4165.416841642173;4172.666186705056;4174.102567947906;4183.49798024239;4222.282212023963;3539.752217344813;3745.0824547985917;3758.0792705787258;3758.8496460141837;3779.6976241901134;652.9706163222667;654.594151625995;654.6661202786613;661.2990230355838;672.0356288725694;546;549.9120140777457;643.32129603269;654.107143748789;660.5805313625882;8662.96044474667;8904.8664270036;9031.683891063782;9075.183233509017;9225.492597907045;542.8425756530562;605.5397897597858;617.6417677746986;657.9571379363666;659.2188256915571;4389.517153113155;4859.392575928009;4875.247781822201;4913.238448040559;4985.382519784659;120749;124977.37511312385;140377;143614.28192858968;143858;87597;120500.79499205071;120783;124003;124190;51453.19913802999;79140.60429697814;92877;107743.46128269465;108265;8980.506072166094;9121.224695900923;9193.126652967958;9254.722358329262;9710.417374957242;60977;64740.70518589507;65155.674221628586;65495.67252163708;66668.66665666834;95246;96944.51527742317;98670.50664746917;98909.51635725614;99736;10504.054635082879;12250.816237756262;12597.86619204276;12883.227006379648;13494.190348579117;14384.42462301538;14405.207713575854;14408.351624176728;14481.782773258621;14515.709685806436;12887.226766394046;12895.548655797002;13051.934740326238;13301.800472993107;13625.65935851572;11213.495392707184;13304.334783260605;13355.732885342044;13387.397567109698;13457.596272111852;12748.171368860994;12870.742585148431;12911.741765164832;13095.41070651842;13148.60554183376;9865.95067024689;9970.451625160396;10833.349999000086;11437.485313160762;11463.942680286546;10688.198385121303;11202.103831693283;11213.66359009231;11249.156313276373;11284 14:40:54 INFO - PROCESS | 1656 | __end_tp_report 14:40:54 INFO - PROCESS | 1656 | __start_cc_report 14:40:54 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,367 14:40:54 INFO - PROCESS | 1656 | __end_cc_report 14:40:54 INFO - PROCESS | 1656 | __startTimestamp1476394854118__endTimestamp 14:40:54 INFO - PROCESS | 1656 | 14:40:54 INFO - PROCESS | 1656 | ------- Summary: start ------- 14:40:54 INFO - PROCESS | 1656 | Number of tests: 6 14:40:54 INFO - PROCESS | 1656 | 14:40:54 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5669.31 Median:5871.77 stddev:650.01 (11.1%) stddev-sans-first:626.36 14:40:54 INFO - PROCESS | 1656 | Values: 3364.5 3365.8 3407.2 3413.0 3415.8 5536.1 5606.0 5606.9 5658.2 5689.3 4574.8 5564.9 5675.5 5710.4 5744.0 4153.6 5021.5 5132.3 5159.7 5252.9 5103.2 5254.0 5295.3 5296.0 5307.9 5080.4 5219.4 5228.7 5251.4 5335.0 5130.4 5131.7 5141.8 5167.9 5231.3 5079.5 5086.1 5118.7 5130.3 5152.4 5687.0 5711.9 5716.6 5734.4 5736.5 6125.1 6134.8 6179.4 6226.4 6238.6 6186.4 6215.1 6235.3 6290.7 6313.3 5587.6 5635.7 5770.3 5785.9 5799.3 5162.5 5889.5 6176.5 6221.0 6228.4 6109.6 6122.4 6125.1 6132.0 6139.1 6054.5 6217.6 6224.9 6251.4 6267.7 5969.6 6111.9 6126.2 6167.5 6181.2 6101.2 6140.4 6221.5 6226.5 6231.5 4911.2 4925.9 4941.0 4942.1 4951.6 4301.6 4319.0 4361.8 4387.5 4417.1 5521.3 5835.6 5849.3 5849.4 5896.6 6126.2 6246.0 6288.7 6306.6 6308.1 5557.0 5654.6 5709.7 5755.7 5837.8 5372.4 5392.4 5399.1 5402.8 5440.5 4737.5 5502.8 5528.8 6300.0 6305.7 6105.0 6123.1 6130.9 6264.8 6283.6 6166.4 6275.6 6331.9 6346.4 6357.6 6128.3 6140.9 6144.4 6148.4 6175.8 5913.2 6076.0 6108.2 6126.6 6136.8 6051.0 6071.8 6092.2 6113.9 6118.6 6056.3 6080.3 6100.2 6109.5 6114.0 4712.3 5230.8 5841.4 5871.8 5944.3 6028.2 6069.2 6071.4 6083.9 6099.3 5859.4 5890.2 5932.2 5938.9 5984.0 14:40:54 INFO - PROCESS | 1656 | 14:40:54 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:65607.01 Median:39670.50 stddev:142263.35 (358.6%) stddev-sans-first:142578.40 14:40:54 INFO - PROCESS | 1656 | Values: 479.1 497.0 509.9 510.1 521.7 37015.6 39848.6 39984.4 41731.4 41858.0 40833.4 40929.2 41585.8 41642.0 41717.0 9303.8 9481.0 9584.7 9590.8 9612.7 9478.1 9583.4 9589.5 9591.9 9605.7 9541.6 9628.4 9636.3 9637.0 9703.3 9541.2 9593.6 9621.8 9624.6 9628.3 9467.2 9525.2 9611.0 9613.1 9648.7 38963.0 39357.4 39436.4 39448.4 39564.2 3067.2 3266.6 3311.0 3462.6 3573.0 29689.9 30087.2 30348.0 30454.2 30455.0 3132.3 3157.7 3293.7 3328.6 3336.1 339762.0 340988.0 341738.0 342747.0 343303.0 55960.4 56331.0 56403.5 56477.7 56549.4 59577.7 60326.8 60557.0 60650.0 60673.0 15474.8 15651.6 15691.0 15749.1 15767.9 11999.8 12035.8 12094.6 12151.7 12152.6 15992.2 16851.7 16921.5 16924.9 16925.0 7110.9 7156.5 7179.5 7275.4 7287.7 823.2 924.9 935.3 947.3 972.6 26928.9 28679.6 29354.1 29855.6 30116.4 899.0 1046.3 1048.2 1087.1 1111.1 12829.3 14611.5 15414.9 15495.1 15626.1 631885.0 633590.0 633649.0 633779.0 635253.0 54835.6 55804.9 55821.4 55878.7 56138.7 1271.6 1327.5 1332.7 1340.3 1342.0 28329.4 28899.6 29106.0 29678.6 29876.7 49536.5 49845.5 49949.0 50011.0 50073.7 568836.2 575497.0 575576.0 576112.0 577795.2 39290.2 39776.8 40122.6 40177.6 40180.8 44612.8 45629.3 45665.0 46749.0 46814.5 37644.6 37652.0 38257.0 38549.6 38751.8 36747.4 36787.6 37160.8 37961.1 38436.8 32276.5 33143.7 37078.0 37351.6 38083.8 31333.2 32457.7 33614.7 34167.7 34197.5 25168.9 25318.6 25346.7 25444.7 25955.6 14:40:54 INFO - PROCESS | 1656 | 14:40:54 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:33936.88 Median:4285.93 stddev:97340.64 (2271.2%) stddev-sans-first:97581.02 14:40:54 INFO - PROCESS | 1656 | Values: 341.8 362.4 362.8 367.3 386.9 17689.0 18271.5 18814.7 19740.0 20192.9 18393.4 18625.7 18836.3 19161.5 19200.6 5647.2 5888.5 5929.6 5931.4 5945.6 5532.5 5791.9 5849.9 5853.0 5865.8 5711.9 5742.5 5749.7 5750.9 5786.5 5544.1 5862.9 5918.3 5975.3 5994.8 5578.2 5711.3 5732.3 5758.1 5762.7 9054.1 9740.3 10147.8 11820.3 11844.8 2170.1 2216.5 2325.8 2642.0 2908.0 8039.8 9459.0 9636.9 10117.5 10147.2 1759.2 1779.7 1789.4 1810.4 1877.9 117693.0 124516.0 125624.1 125891.0 127102.2 10534.1 10988.6 11013.6 11147.5 11289.9 13688.6 13848.0 13904.8 13920.7 13944.9 7750.3 8059.9 8069.4 8174.5 8191.8 6656.9 7582.7 7933.2 7938.6 8124.1 4285.6 4286.3 4291.4 4320.3 4386.8 1825.8 1862.5 1876.7 1882.8 1935.8 796.4 862.0 895.1 918.2 969.3 15033.5 19071.8 19582.9 19602.0 20211.5 803.5 893.2 916.8 919.9 947.8 9792.5 10284.3 10306.7 10390.5 10532.3 573094.0 574793.0 575074.0 590615.0 591113.0 114585.0 118146.0 118161.0 123473.4 129942.0 989.7 1001.3 1007.3 1010.4 1032.0 16292.8 18232.7 18260.8 18564.9 18606.8 57498.1 57507.0 58484.1 58865.7 59417.5 74762.0 76520.0 82236.6 85730.0 87014.7 7757.0 7803.5 7977.3 8013.3 8090.0 9416.9 10556.4 12570.7 12634.9 12815.7 9757.4 10508.8 10762.8 10905.9 10939.8 8551.2 8863.9 9396.8 10449.8 11123.0 9698.1 9702.0 10270.5 10562.6 11263.4 6484.0 7565.3 7941.5 8049.4 8095.0 8618.3 10990.6 11086.7 11094.9 11168.3 14:40:54 INFO - PROCESS | 1656 | 14:40:54 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5617.72 Median:4926.38 stddev:3197.41 (64.9%) stddev-sans-first:3189.58 14:40:54 INFO - PROCESS | 1656 | Values: 1255.8 1312.7 1524.0 1747.6 1768.3 7825.3 8059.3 8303.8 8885.6 8897.7 8341.6 8620.7 8625.7 8750.1 8752.8 2294.2 2327.5 2336.8 2337.6 2340.2 2305.4 2339.3 2349.1 2349.8 2359.3 2114.7 2144.1 2146.5 2176.6 2199.5 2020.4 2273.9 2304.6 2304.9 2311.4 2298.0 2304.7 2308.8 2313.8 2315.7 8637.6 8755.2 8787.3 8806.6 8808.0 5002.6 5163.2 5165.2 5167.3 5186.5 3319.5 3409.5 3511.6 3528.1 3534.1 1055.2 1063.2 1068.2 1086.1 1087.2 11594.6 11700.1 11704.9 11708.9 11729.2 4459.2 4508.6 4678.5 4701.7 4711.6 9815.2 9900.0 9904.0 9913.7 9920.2 5118.7 5127.5 5129.2 5140.8 5141.0 4203.5 4356.9 4524.2 4650.5 4693.7 3748.9 3806.8 3875.6 3902.0 3907.5 1230.2 1231.9 1235.2 1240.1 1246.8 866.3 882.4 887.5 889.6 915.3 5486.8 5847.3 5946.8 5970.0 6045.6 877.4 885.5 891.7 920.3 963.0 3920.6 3996.8 4060.8 4098.1 4231.4 10590.4 10779.4 10794.6 10794.6 10796.7 10610.5 10666.6 10728.2 10748.4 10758.3 7965.3 8048.5 8067.2 8068.0 8209.3 4928.4 5332.1 5724.5 5835.5 6060.4 9781.4 10039.6 10108.3 10113.2 10121.3 9757.6 10108.6 10243.9 10283.0 10300.2 6778.2 6987.3 7037.4 7354.1 7498.0 8161.9 8212.0 8269.1 8295.0 8344.8 6485.0 7204.9 7217.1 7368.2 7461.7 6374.8 6836.9 6893.3 7219.5 7246.8 6186.6 6547.6 6703.3 6779.2 6828.2 4769.0 4898.6 4934.9 4965.4 5047.5 4924.3 5020.9 5037.0 5062.3 5141.1 14:40:54 INFO - PROCESS | 1656 | 14:40:54 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4527.26 Median:5093.21 stddev:1436.95 (28.2%) stddev-sans-first:1405.42 14:40:54 INFO - PROCESS | 1656 | Values: 294.5 296.9 301.1 305.2 306.4 4672.4 5020.6 5430.8 5447.7 5453.8 5341.1 5378.7 5386.6 5406.4 5431.3 3252.9 3923.6 4054.9 4064.4 4110.3 4079.6 4127.1 4128.1 4138.2 4152.2 3314.4 3458.8 4105.6 4112.8 4117.5 3778.8 3787.9 3982.3 4098.7 4129.2 3463.1 3481.7 3481.8 3484.3 3485.3 4281.3 4883.8 5217.4 5219.7 5268.9 4093.9 4142.7 4215.7 4568.6 4605.6 4906.7 4932.4 5647.4 5650.5 5750.3 3339.4 3798.2 3799.3 3812.4 3825.4 5066.1 5187.5 5832.4 5943.5 5984.0 2981.9 3529.4 3780.5 3784.8 3888.2 3250.5 3302.8 3439.7 3927.5 3933.5 3514.4 4314.9 4574.2 4608.7 4621.0 5072.6 5363.4 5717.5 5775.0 5794.7 1117.9 1350.0 1351.7 1354.2 1364.4 781.8 803.9 821.3 824.7 827.5 5130.8 5200.1 5401.5 5404.3 5410.7 5202.4 5547.6 5889.5 5893.1 5898.8 4257.4 4863.9 5097.4 5334.3 5377.2 2898.9 2980.8 2999.8 3081.6 3118.9 5303.4 5710.7 5799.0 6054.6 6207.4 4456.1 5253.9 5332.6 5860.8 5988.9 4840.4 5912.6 6097.4 6112.3 6149.9 5598.1 5825.0 5833.4 5846.5 5903.5 4773.1 5018.4 5730.9 5811.0 5832.9 5089.0 6098.5 6110.6 6120.3 6130.8 3197.3 3594.3 3864.5 3901.9 3911.2 5139.4 5889.4 5890.9 5891.7 5907.9 4434.0 5725.6 5736.3 5756.5 5779.6 4702.9 5519.7 5684.5 5769.4 5817.8 5101.2 5327.4 5601.4 5606.3 5634.8 5389.3 5565.4 5600.9 5713.1 5731.0 4816.8 4879.4 4900.8 5027.9 5572.8 14:40:54 INFO - PROCESS | 1656 | 14:40:54 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:23483.80 Median:3758.46 stddev:37010.79 (984.7%) stddev-sans-first:37074.71 14:40:54 INFO - PROCESS | 1656 | Values: 593.5 650.3 655.6 666.5 740.3 13892.4 14647.3 14748.3 14772.0 14809.0 12898.8 12995.3 13036.7 13045.9 13047.6 621.4 646.4 786.3 805.9 807.5 767.8 801.3 805.5 819.7 819.8 817.3 852.5 852.7 852.9 858.3 701.8 705.2 802.0 816.4 851.0 557.4 637.8 638.3 639.3 640.2 13293.1 13445.7 13452.3 13476.1 13483.9 13623.4 13715.8 13768.8 13886.9 14008.9 11416.9 11429.1 11455.5 11858.5 11982.3 3200.3 3675.0 3689.1 3714.8 3738.2 91510.0 113989.4 115650.0 116013.8 116120.4 10504.4 10511.1 10618.1 10773.0 10945.9 21015.0 21111.7 21336.6 21340.3 21395.9 6778.9 7315.7 7378.0 7555.9 7624.0 4165.4 4172.7 4174.1 4183.5 4222.3 3539.8 3745.1 3758.1 3758.8 3779.7 653.0 654.6 654.7 661.3 672.0 546.0 549.9 643.3 654.1 660.6 8663.0 8904.9 9031.7 9075.2 9225.5 542.8 605.5 617.6 658.0 659.2 4389.5 4859.4 4875.2 4913.2 4985.4 120749.0 124977.4 140377.0 143614.3 143858.0 87597.0 120500.8 120783.0 124003.0 124190.0 51453.2 79140.6 92877.0 107743.5 108265.0 8980.5 9121.2 9193.1 9254.7 9710.4 60977.0 64740.7 65155.7 65495.7 66668.7 95246.0 96944.5 98670.5 98909.5 99736.0 10504.1 12250.8 12597.9 12883.2 13494.2 14384.4 14405.2 14408.4 14481.8 14515.7 12887.2 12895.5 13051.9 13301.8 13625.7 11213.5 13304.3 13355.7 13387.4 13457.6 12748.2 12870.7 12911.7 13095.4 13148.6 9866.0 9970.5 10833.3 11437.5 11463.9 10688.2 11202.1 11213.7 11249.2 11284.0 14:40:54 INFO - PROCESS | 1656 | -------- Summary: end -------- 14:40:54 INFO - PROCESS | 1656 | 14:40:54 INFO - TEST-INFO | 1656: exit 0 14:40:54 INFO - TEST-OK | dromaeo_css | took 1114557ms 14:40:54 INFO - TEST-START | kraken 14:40:54 INFO - operating with platform_type : mac_ 14:40:54 INFO - Initialising browser for kraken test... 14:40:54 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmp94pDVw/profile http://localhost:49273/getInfo.html) 14:40:57 INFO - PROCESS | 1666 | 2016-10-13 14:40:57.591 plugin-container[1667:9996] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 14:40:57 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:40:57 INFO - PROCESS | 1666 | 2016-10-13 14:40:57.595 plugin-container[1667:9996] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f13, name = 'com.apple.CFPasteboardClient' 14:40:57 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:40:57 INFO - PROCESS | 1666 | 2016-10-13 14:40:57.595 plugin-container[1667:9996] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:40:57 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 14:40:57 INFO - PROCESS | 1666 | colorDepth:24 14:40:57 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 14:40:57 INFO - PROCESS | 1666 | __metrics 14:40:57 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 14:40:58 INFO - TEST-INFO | 1666: exit 0 14:40:58 INFO - Browser initialized. 14:40:58 INFO - Running cycle 1/1 for kraken test... 14:40:58 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmp94pDVw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:41:00 INFO - PROCESS | 1668 | 2016-10-13 14:41:00.751 plugin-container[1669:10110] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 14:41:00 INFO - PROCESS | 1668 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:41:00 INFO - PROCESS | 1668 | 2016-10-13 14:41:00.751 plugin-container[1669:10110] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e03, name = 'com.apple.CFPasteboardClient' 14:41:00 INFO - PROCESS | 1668 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:41:00 INFO - PROCESS | 1668 | 2016-10-13 14:41:00.751 plugin-container[1669:10110] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:41:10 INFO - PROCESS | 1668 | RSS: Main: 238936064 14:41:10 INFO - PROCESS | 1668 | 14:41:13 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 14:41:14 INFO - PROCESS | 1668 | RSS: Main: 252723200 14:41:14 INFO - PROCESS | 1668 | 14:41:17 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 14:41:17 INFO - PROCESS | 1668 | RSS: Main: 261226496 14:41:17 INFO - PROCESS | 1668 | 14:41:21 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 14:41:21 INFO - PROCESS | 1668 | RSS: Main: 261373952 14:41:21 INFO - PROCESS | 1668 | 14:41:23 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 14:41:24 INFO - PROCESS | 1668 | RSS: Main: 262762496 14:41:24 INFO - PROCESS | 1668 | 14:41:26 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:41:26 INFO - PROCESS | 1668 | RSS: Main: 263745536 14:41:26 INFO - PROCESS | 1668 | 14:41:29 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 14:41:30 INFO - PROCESS | 1668 | RSS: Main: 264548352 14:41:30 INFO - PROCESS | 1668 | 14:41:33 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 14:41:33 INFO - PROCESS | 1668 | RSS: Main: 264769536 14:41:33 INFO - PROCESS | 1668 | 14:41:37 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 14:41:37 INFO - PROCESS | 1668 | RSS: Main: 265064448 14:41:37 INFO - PROCESS | 1668 | 14:41:39 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:41:39 INFO - PROCESS | 1668 | RSS: Main: 264216576 14:41:39 INFO - PROCESS | 1668 | 14:41:41 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:41:42 INFO - PROCESS | 1668 | RSS: Main: 264286208 14:41:42 INFO - PROCESS | 1668 | 14:41:44 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:41:45 INFO - PROCESS | 1668 | RSS: Main: 264200192 14:41:45 INFO - PROCESS | 1668 | 14:41:48 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:41:49 INFO - PROCESS | 1668 | RSS: Main: 264687616 14:41:49 INFO - PROCESS | 1668 | 14:41:52 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:41:52 INFO - PROCESS | 1668 | RSS: Main: 264699904 14:41:52 INFO - PROCESS | 1668 | 14:41:54 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 14:41:54 INFO - PROCESS | 1668 | RSS: Main: 266035200 14:41:54 INFO - PROCESS | 1668 | 14:41:54 INFO - PROCESS | 1668 | __start_tp_report 14:41:54 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 14:41:54 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 14:41:54 INFO - PROCESS | 1668 | |i|pagename|runs| 14:41:54 INFO - PROCESS | 1668 | |0;ai-astar;118;116;119;137;123;103;169;176;128;118 14:41:54 INFO - PROCESS | 1668 | |1;audio-beat-detection;146;101;147;172;116;116;116;116;143;116 14:41:54 INFO - PROCESS | 1668 | |2;audio-dft;199;220;198;203;195;194;196;198;201;194 14:41:54 INFO - PROCESS | 1668 | |3;audio-fft;85;66;50;85;72;85;84;83;106;59 14:41:54 INFO - PROCESS | 1668 | |4;audio-oscillator;79;71;91;71;69;70;87;71;70;88 14:41:54 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;91;88;89;89;90;88;90;88;92;89 14:41:54 INFO - PROCESS | 1668 | |6;imaging-darkroom;96;97;95;96;97;125;97;119;100;152 14:41:54 INFO - PROCESS | 1668 | |7;imaging-desaturate;91;120;103;78;86;139;150;85;145;147 14:41:54 INFO - PROCESS | 1668 | |8;json-parse-financial;59;57;57;57;57;58;56;59;60;58 14:41:54 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;68;71;82;79;64;102;63;90;106;105 14:41:54 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;90;89;87;87;113;109;109;90;92;90 14:41:54 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;151;160;164;148;149;148;148;171;183;151 14:41:54 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;173;178;174;174;174;174;175;174;233;187 14:41:54 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;72;68;69;70;70;71;71;68;69;76 14:41:54 INFO - PROCESS | 1668 | __end_tp_report 14:41:54 INFO - PROCESS | 1668 | __start_cc_report 14:41:54 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,956 14:41:54 INFO - PROCESS | 1668 | __end_cc_report 14:41:54 INFO - PROCESS | 1668 | __startTimestamp1476394914623__endTimestamp 14:41:54 INFO - PROCESS | 1668 | 14:41:54 INFO - PROCESS | 1668 | ------- Summary: start ------- 14:41:54 INFO - PROCESS | 1668 | Number of tests: 14 14:41:54 INFO - PROCESS | 1668 | 14:41:54 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:130.70 Median:125.50 stddev:23.73 (18.9%) stddev-sans-first:24.72 14:41:54 INFO - PROCESS | 1668 | Values: 118.0 116.0 119.0 137.0 123.0 103.0 169.0 176.0 128.0 118.0 14:41:54 INFO - PROCESS | 1668 | 14:41:54 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:129.50 stddev:21.82 (16.9%) stddev-sans-first:22.25 14:41:54 INFO - PROCESS | 1668 | Values: 146.0 101.0 147.0 172.0 116.0 116.0 116.0 116.0 143.0 116.0 14:41:54 INFO - PROCESS | 1668 | 14:41:54 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:199.80 Median:198.50 stddev:7.69 (3.9%) stddev-sans-first:8.15 14:41:54 INFO - PROCESS | 1668 | Values: 199.0 220.0 198.0 203.0 195.0 194.0 196.0 198.0 201.0 194.0 14:41:54 INFO - PROCESS | 1668 | 14:41:54 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:77.50 Median:83.50 stddev:16.04 (19.2%) stddev-sans-first:16.78 14:41:54 INFO - PROCESS | 1668 | Values: 85.0 66.0 50.0 85.0 72.0 85.0 84.0 83.0 106.0 59.0 14:41:54 INFO - PROCESS | 1668 | 14:41:54 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:75.00 stddev:8.76 (11.7%) stddev-sans-first:9.25 14:41:54 INFO - PROCESS | 1668 | Values: 79.0 71.0 91.0 71.0 69.0 70.0 87.0 71.0 70.0 88.0 14:41:54 INFO - PROCESS | 1668 | 14:41:54 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:89.40 Median:89.50 stddev:1.35 (1.5%) stddev-sans-first:1.30 14:41:54 INFO - PROCESS | 1668 | Values: 91.0 88.0 89.0 89.0 90.0 88.0 90.0 88.0 92.0 89.0 14:41:54 INFO - PROCESS | 1668 | 14:41:54 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:107.40 Median:96.00 stddev:18.93 (19.7%) stddev-sans-first:19.63 14:41:54 INFO - PROCESS | 1668 | Values: 96.0 97.0 95.0 96.0 97.0 125.0 97.0 119.0 100.0 152.0 14:41:54 INFO - PROCESS | 1668 | 14:41:54 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:114.40 Median:114.00 stddev:29.01 (25.5%) stddev-sans-first:29.51 14:41:54 INFO - PROCESS | 1668 | Values: 91.0 120.0 103.0 78.0 86.0 139.0 150.0 85.0 145.0 147.0 14:41:54 INFO - PROCESS | 1668 | 14:41:54 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:1.23 (2.1%) stddev-sans-first:1.22 14:41:54 INFO - PROCESS | 1668 | Values: 59.0 57.0 57.0 57.0 57.0 58.0 56.0 59.0 60.0 58.0 14:41:54 INFO - PROCESS | 1668 | 14:41:54 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:83.00 Median:69.50 stddev:16.90 (24.3%) stddev-sans-first:17.03 14:41:54 INFO - PROCESS | 1668 | Values: 68.0 71.0 82.0 79.0 64.0 102.0 63.0 90.0 106.0 105.0 14:41:54 INFO - PROCESS | 1668 | 14:41:54 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:95.60 Median:89.50 stddev:10.33 (11.5%) stddev-sans-first:10.76 14:41:54 INFO - PROCESS | 1668 | Values: 90.0 89.0 87.0 87.0 113.0 109.0 109.0 90.0 92.0 90.0 14:41:54 INFO - PROCESS | 1668 | 14:41:54 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:157.30 Median:155.50 stddev:12.06 (7.8%) stddev-sans-first:12.57 14:41:54 INFO - PROCESS | 1668 | Values: 151.0 160.0 164.0 148.0 149.0 148.0 148.0 171.0 183.0 151.0 14:41:54 INFO - PROCESS | 1668 | 14:41:54 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.60 Median:174.50 stddev:18.53 (10.6%) stddev-sans-first:19.39 14:41:54 INFO - PROCESS | 1668 | Values: 173.0 178.0 174.0 174.0 174.0 174.0 175.0 174.0 233.0 187.0 14:41:54 INFO - PROCESS | 1668 | 14:41:54 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.50 stddev:2.37 (3.4%) stddev-sans-first:2.44 14:41:54 INFO - PROCESS | 1668 | Values: 72.0 68.0 69.0 70.0 70.0 71.0 71.0 68.0 69.0 76.0 14:41:54 INFO - PROCESS | 1668 | -------- Summary: end -------- 14:41:54 INFO - PROCESS | 1668 | 14:41:55 INFO - TEST-INFO | 1668: exit 0 14:41:55 INFO - TEST-OK | kraken | took 60746ms 14:41:55 INFO - SUITE-END | took 1175s 14:41:55 INFO - Completed test suite (00:19:35) 14:41:55 INFO - javascript benchmark 14:41:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7167.022558260946, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3364.461686130219, 3365.7980521168747, 3407.2163402417436, 3413.0102270341604, 3415.795052296864, 5536.086545719952, 5606.046972014762, 5606.943930560693, 5658.236138121362, 5689.2603961485, 4574.794134263958, 5564.944350556493, 5675.460831221028, 5710.400407957157, 5743.9712801435935, 4153.584641535853, 5021.548060674539, 5132.332796736438, 5159.690418574879, 5252.921206181911, 5103.234514822788, 5253.973730131344, 5295.338082739658, 5296.046711591912, 5307.867303317409, 5080.415752188472, 5219.399769026534, 5228.660137091077, 5251.422343542226, 5334.973325133369, 5130.410002849682, 5131.743412829381, 5141.845744627667, 5167.896642067138, 5231.346081739783, 5079.5428411443145, 5086.135356989321, 5118.692878427306, 5130.3074084998425, 5152.425506050671, 5686.971565142189, 5711.942880571182, 5716.599838011341, 5734.369219385864, 5736.455036771542, 6125.111858780497, 6134.846628834271, 6179.443850053472, 6226.40849119333, 6238.625682459067, 6186.412290832363, 6215.12988181655, 6235.282942461629, 6290.685465726695, 6313.305536390993, 5587.580931430078, 5635.746391412396, 5770.297762160131, 5785.855353616151, 5799.2750906136735, 5162.5095615916425, 5889.4993925515955, 6176.505879529627, 6221.035739460391, 6228.439440450381, 6109.572329936951, 6122.418370254908, 6125.081237814364, 6132.0, 6139.140520327158, 6054.51563874889, 6217.595856269328, 6224.9377506224355, 6251.4061164189325, 6267.65527895961, 5969.641821490724, 6111.908321375183, 6126.181801870944, 6167.537434692416, 6181.196444462191, 6101.24471383566, 6140.3552626974415, 6221.502279817604, 6226.501879849601, 6231.501479881598, 4911.214205727138, 4925.852224433273, 4940.987097644974, 4942.085714142823, 4951.579115775199, 4301.634361079281, 4319.028218650778, 4361.847335343247, 4387.4954380246045, 4417.138657961731, 5521.254630624814, 5835.5915085944425, 5849.298084229919, 5849.385814489502, 5896.64620122794, 6126.172966649535, 6245.96877015612, 6288.654124023131, 6306.621602703761, 6308.148399965946, 5557.0, 5654.6324488908085, 5709.714514274269, 5755.740991655385, 5837.7664893404635, 5372.355317361941, 5392.433794451526, 5399.055165346127, 5402.783888644489, 5440.455954404607, 4737.455192652889, 5502.752376143163, 5528.834134976038, 6300.0, 6305.747770089145, 6105.035213715839, 6123.050927106306, 6130.856783744145, 6264.812055638338, 6283.5601507895835, 6166.414190651881, 6275.560710750204, 6331.936680633319, 6346.365363463801, 6357.618542887441, 6128.264608247039, 6140.877182456236, 6144.38556144382, 6148.354422785543, 6175.783847565313, 5913.172155898264, 6075.967085595547, 6108.205933228652, 6126.632402055891, 6136.846578835565, 6050.969745151246, 6071.848203794763, 6092.208012958465, 6113.908291375722, 6118.632882027093, 6056.333803281724, 6080.270367555921, 6100.176476175837, 6109.450149486567, 6113.969430152821, 4712.293156026486, 5230.790768369223, 5841.415858414294, 5871.7651293949475, 5944.3164036136395, 6028.15605815195, 6069.150318955438, 6071.362506936708, 6083.878322433615, 6099.2985806632805, 5859.414058594107, 5890.204822348928, 5932.199153114274, 5938.910916336172, 5984.042553191643], "value": 5629.488802626842, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.1303783632707, 497.0233491189811, 509.8572399728075, 510.13022796132594, 521.7365230558565, 37015.62984370156, 39848.60151398485, 39984.40023399648, 41731.37402938958, 41858.0, 40833.38749918746, 40929.181416371655, 41585.7920710396, 41641.95895102624, 41717.0, 9303.767405814859, 9481.0, 9584.712458626253, 9590.842060536394, 9612.711618651452, 9478.146966772989, 9583.377080489781, 9589.472579008152, 9591.904080959206, 9605.66380176694, 9541.570629321663, 9628.422294662309, 9636.325457217998, 9636.951815240915, 9703.320767546275, 9541.188998935064, 9593.616255349778, 9621.807563848684, 9624.615015399375, 9628.27787915902, 9467.195288400495, 9525.237980961507, 9611.0, 9613.086756758097, 9648.662296819648, 38963.02592435184, 39357.40963885544, 39436.40845387321, 39448.408273875626, 39564.20871582552, 3067.2331917020747, 3266.591676040495, 3311.0397984584442, 3462.6149540183874, 3573.0, 29689.851550742107, 30087.172607703396, 30348.0, 30454.238644033856, 30455.0, 3132.3265497918055, 3157.7265965836878, 3293.6870997255223, 3328.5506456628286, 3336.115929278743, 339762.0, 340988.0, 341738.0, 342746.9999999975, 343303.0, 55960.44039559552, 56331.0, 56403.48772098222, 56477.71761141168, 56549.43450565442, 59577.702111490034, 60326.77712560078, 60557.0, 60650.0, 60673.0, 15474.767878481833, 15651.608709782347, 15691.0, 15749.13379764124, 15767.921160394355, 11999.76000480003, 12035.759284814254, 12094.637160885188, 12151.696207594705, 12152.57465988704, 15992.20136476112, 16851.74722379165, 16921.492355229362, 16924.915375423043, 16925.0, 7110.857782844314, 7156.463265255023, 7179.461540384387, 7275.417966562768, 7287.684103732895, 823.197382552007, 924.9039887732923, 935.335911502827, 947.2564037230741, 972.6304004478394, 26928.86535567349, 28679.56980645292, 29354.11937641874, 29855.552166717516, 30116.397672046438, 898.9865152022725, 1046.2832959422667, 1048.2295512798087, 1087.0868470484832, 1111.055801682516, 12829.29438880852, 14611.488597899022, 15414.922925385301, 15495.14776687293, 15626.062436253635, 631885.0, 633590.0, 633649.0, 633779.0, 635253.0, 54835.62910927259, 55804.88390232173, 55821.441785582436, 55878.72060639671, 56138.7193064032, 1271.5930902111236, 1327.4557431453059, 1332.7201287729492, 1340.3432318164225, 1342.0404410846293, 28329.433411331247, 28899.56650650284, 29106.0, 29678.58696249959, 29876.70123298739, 49536.50463495463, 49845.501544985535, 49949.0, 50011.0, 50073.74963125307, 568836.1558192183, 575497.0, 575576.0, 576112.0, 577795.222047791, 39290.24968252195, 39776.80111599423, 40122.59877401305, 40177.598224018555, 40180.79909600433, 44612.776936115115, 45629.315560267285, 45665.0, 46749.0, 46814.53185468238, 37644.62355376411, 37652.0, 38257.0, 38549.6145038546, 38751.8374448767, 36747.44878826766, 36787.63212367842, 37160.81419592885, 37961.050973725876, 38436.80781596186, 32276.515852261764, 33143.66856331406, 37078.0, 37351.62648373481, 38083.809580951915, 31333.216669583442, 32457.675423246408, 33614.663853361155, 34167.65832341645, 34197.48703769396, 25168.874155629106, 25318.620220696335, 25346.746532535177, 25444.745552544977, 25955.61066583965], "value": 19527.0429162265, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.7866573663494, 362.4092728851969, 362.7859562857913, 367.3351234265979, 386.8761996161228, 17689.0, 18271.54321141972, 18814.717779233306, 19740.0, 20192.8990355048, 18393.44819655409, 18625.720614190763, 18836.34072807452, 19161.52096197596, 19200.615987680238, 5647.181158731992, 5888.499477544392, 5929.584929054968, 5931.436513531207, 5945.554083443759, 5532.474414930575, 5791.884162316751, 5849.941500584982, 5853.034249348852, 5865.76536938522, 5711.8572035699235, 5742.511886489632, 5749.65502069875, 5750.942490575083, 5786.479216870481, 5544.140658197965, 5862.853428664275, 5918.289805223358, 5975.312839023524, 5994.820155395345, 5578.246936663539, 5711.343195532525, 5732.254806875121, 5758.136279558058, 5762.654240745527, 9054.143900500381, 9740.269479788973, 10147.79704405915, 11820.290782553075, 11844.763104737856, 2170.1319472211085, 2216.4791274050585, 2325.767423257678, 2641.960370594443, 2907.956380654292, 8039.799005024863, 9459.0, 9636.855447168227, 10117.544710488046, 10147.238957078249, 1759.155605309446, 1779.661864245789, 1789.391606853663, 1810.3754204799322, 1877.915493802782, 117693.0, 124516.0, 125624.11563826459, 125891.0, 127102.2056912033, 10534.102382118665, 10988.560457581767, 11013.559457621766, 11147.498362573542, 11289.887101129048, 13688.589342319747, 13848.0, 13904.791428128587, 13920.677535634099, 13944.860551394559, 7750.341220996165, 8059.919400806034, 8069.426461839885, 8174.509529428254, 8191.795205119801, 6656.901611234189, 7582.734604288823, 7933.206679332021, 7938.56337901421, 8124.106348301682, 4285.5928686774705, 4286.271333873249, 4291.420658211164, 4320.308750599952, 4386.758728269976, 1825.8448031917171, 1862.5064357945155, 1876.74663920369, 1882.8493720502327, 1935.816097470738, 796.3907610677836, 862.0132533294984, 895.1496078725237, 918.2332752151895, 969.3311614985637, 15033.473828416172, 19071.80928190728, 19582.90208548948, 19602.0, 20211.494712632302, 803.5299349880386, 893.1604291965662, 916.8258030974227, 919.9034101419254, 947.7820101376584, 9792.461414622121, 10284.331518451278, 10306.742331441774, 10390.48047597617, 10532.315399499008, 573094.0, 574793.0, 575074.0, 590615.0, 591113.0, 114585.0, 118146.0, 118161.0, 123473.38263308626, 129942.0, 989.7030890732896, 1001.2940876681922, 1007.3301254665565, 1010.4190090697731, 1031.9638812641522, 16292.755608666117, 18232.726509102107, 18260.817391825913, 18564.907175464035, 18606.81393186051, 57498.13752793795, 57507.0, 58484.12273815811, 58865.70567147137, 59417.51456213629, 74762.0, 76520.0, 82236.58881705553, 85730.0, 87014.6947795771, 7757.0, 7803.531788092732, 7977.282044616012, 8013.278804907586, 8090.0, 9416.905830941603, 10556.366618002945, 12570.748585028065, 12634.873651263737, 12815.743685126432, 9757.365771224848, 10508.78982420332, 10762.784744305227, 10905.890941090805, 10939.835902461311, 8551.230389264996, 8863.911360886566, 9396.778418805512, 10449.791004180026, 11123.0, 9698.127168554864, 9701.951490242503, 10270.537825797708, 10562.630857335103, 11263.436828158723, 6483.967580162069, 7565.319121279112, 7941.523508589503, 8049.436539442183, 8095.02859656845, 8618.310535157298, 10990.560377585127, 11086.722831929266, 11094.889051109385, 11168.329900206014], "value": 9032.27144087177, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1255.7990721484564, 1312.6783937935204, 1524.0017788348628, 1747.571844898, 1768.2750072470283, 7825.295723384894, 8059.314958228543, 8303.833923321537, 8885.600147993347, 8897.68858089967, 8341.62462689179, 8620.698275560357, 8625.741227763161, 8750.124987501247, 8752.78118047049, 2294.19703103914, 2327.453048533593, 2336.778006089419, 2337.614293641547, 2340.20433052762, 2305.4236440889777, 2339.251439539348, 2349.130821596012, 2349.7650234976536, 2359.256834097254, 2114.7356580427445, 2144.1209104267255, 2146.549224662815, 2176.62997290461, 2199.472126689591, 2020.3837829462009, 2273.9090436382526, 2304.5506126305377, 2304.8962796674105, 2311.4452531392512, 2297.977020229793, 2304.677345171677, 2308.8499247548857, 2313.838031337807, 2315.6642286868478, 8637.568121593895, 8755.168259015383, 8787.297016238686, 8806.647734090693, 8807.987081485648, 5002.649814512985, 5163.173892177271, 5165.199394093884, 5167.3282473278605, 5186.455422180655, 3319.5020746887917, 3409.454487282048, 3511.5786105667485, 3528.0826984983833, 3534.1164708822794, 1055.176961969665, 1063.1813503602261, 1068.1775033224374, 1086.098538213281, 1087.152021423291, 11594.594189203337, 11700.122490813137, 11704.88295117055, 11708.88291117095, 11729.178957472981, 4459.219636563588, 4508.616767574793, 4678.50875658051, 4701.717896926195, 4711.646626503026, 9815.2147828175, 9900.009999000042, 9904.0, 9913.65302214419, 9920.156786673213, 5118.718470484159, 5127.461616530285, 5129.179331306973, 5140.820071297561, 5141.0232055909255, 4203.5376108628025, 4356.934645980313, 4524.163029839425, 4650.488446270908, 4693.671442999025, 3748.887533374003, 3806.8286927088348, 3875.6318149775725, 3901.96098039016, 3907.4724912137067, 1230.2372529032057, 1231.8644949055597, 1235.2218102595307, 1240.1443004326986, 1246.7568824079399, 866.3199388480012, 882.4131952251681, 887.5163036145316, 889.564113584339, 915.2540679346445, 5486.780528778884, 5847.26909136358, 5946.762129514857, 5970.0, 6045.607035542764, 877.4165180155253, 885.5041176940933, 891.7114769158503, 920.3005715656016, 963.0321526865455, 3920.6079392060565, 3996.820143093568, 4060.837566497366, 4098.077932465171, 4231.386448964944, 10590.364578125336, 10779.35323880554, 10794.568217271379, 10794.622188223375, 10796.67609971702, 10610.522526486327, 10666.626668066581, 10728.195385346131, 10748.441475985937, 10758.300710453796, 7965.322947549524, 8048.476849004796, 8067.233612806774, 8067.959660201662, 8209.261166495044, 4928.433230178575, 5332.120200166929, 5724.513416359656, 5835.533157347487, 6060.363661815446, 9781.41311521311, 10039.648612298535, 10108.292419530562, 10113.190944724258, 10121.291509594257, 9757.585150153047, 10108.595656173671, 10243.94878025605, 10283.023112804272, 10300.175985921258, 6778.186617605918, 6987.266337034742, 7037.401820845285, 7354.080739907512, 7498.0, 8161.877571836309, 8212.0, 8269.09040005611, 8295.0, 8344.791380215544, 6484.962406015015, 7204.891926621, 7217.06178196831, 7368.1526624438875, 7461.701531938662, 6374.776882809079, 6836.906095024772, 6893.276205998499, 7219.530730502711, 7246.782596522113, 6186.566940314135, 6547.639879806657, 6703.262641109572, 6779.186497620317, 6828.248892621708, 4769.0, 4898.599686153688, 4934.901301973869, 4965.4041515018425, 5047.545720885138, 4924.335214745964, 5020.899582008266, 5037.0, 5062.291279220838, 5141.074606570854], "value": 4495.183467810468, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.50670127536375, 296.93912747886685, 301.0546882788045, 305.20341907621105, 306.4407456392085, 4672.392588963434, 5020.6234532410035, 5430.782768689258, 5447.747018185814, 5453.781848726051, 5341.1187154119525, 5378.650387724795, 5386.572558272061, 5406.377726922961, 5431.293931788872, 3252.9349413011723, 3923.5880232575596, 4054.858079967202, 4064.3903414487913, 4110.260153172428, 4079.5920407959266, 4127.101533294688, 4128.091819799639, 4138.213739389522, 4152.211079894811, 3314.370269648759, 3458.806711684465, 4105.609967053125, 4112.753234805907, 4117.485314335708, 3778.8299526521096, 3787.8636409077444, 3982.2677135446174, 4098.6516146127615, 4129.215449064668, 3463.1169051891607, 3481.704055155315, 3481.791092534431, 3484.285721427101, 3485.3203625293077, 4281.250781113293, 4883.827881308496, 5217.426083130853, 5219.73901304937, 5268.868278293035, 4093.9385909211387, 4142.730722503027, 4215.662746980234, 4568.596395685236, 4605.631549476034, 4906.693853888667, 4932.408111026664, 5647.350554686182, 5650.51970582501, 5750.338711048199, 3339.3655205510877, 3798.2213646202463, 3799.25914446683, 3812.4471951567143, 3825.4261860720835, 5066.062778385974, 5187.533122019036, 5832.433729159199, 5943.543831761203, 5983.970080149615, 2981.8509074546187, 3529.3823580873245, 3780.4896338994436, 3784.8456220852904, 3888.202918401721, 3250.4636734938945, 3302.844004598371, 3439.724822014233, 3927.4697915781576, 3933.468981687493, 3514.367413865478, 4314.90726997406, 4574.222382194968, 4608.654350923694, 4620.953790462119, 5072.594192464594, 5363.436839131913, 5717.514011309086, 5775.018246898037, 5794.681292528951, 1117.871444783844, 1350.0, 1351.6823546466574, 1354.1536539662711, 1364.447398803486, 781.8045488627843, 803.9307720731413, 821.2958111917794, 824.698984870518, 827.5076329583887, 5130.7947682093045, 5200.115980283361, 5401.513863752202, 5404.270633397354, 5410.675359478444, 5202.4277329493725, 5547.639403438763, 5889.4993925515955, 5893.086571581412, 5898.8497243038055, 4257.361395790656, 4863.878403039882, 5097.439281679012, 5334.306540149756, 5377.193420986883, 2898.8985385511405, 2980.8062475938996, 2999.7750168737434, 3081.553174789643, 3118.8596513156963, 5303.390110137384, 5710.71446427677, 5798.985177593904, 6054.606450580698, 6207.410296021961, 4456.059001059285, 5253.868653283622, 5332.576939441193, 5860.794872179454, 5988.850278743066, 4840.394950631101, 5912.645241285537, 6097.420745029215, 6112.327643959161, 6149.907751383822, 5598.10430331145, 5824.970875145597, 5833.416658334133, 5846.473817356288, 5903.527717782481, 4773.1408346497965, 5018.44797072329, 5730.911126885879, 5810.970945145247, 5832.854178645568, 5088.974555127201, 6098.512119030378, 6110.572259941761, 6120.25572711775, 6130.816075517741, 3197.2806118623125, 3594.2991116731987, 3864.516935383077, 3901.9269700831364, 3911.2373087247715, 5139.357580302462, 5889.37803250989, 5890.9116363253725, 5891.675957822361, 5907.911381329198, 4433.977830110829, 5725.570582206435, 5736.254286942671, 5756.481916627524, 5779.624324418899, 4702.858914232578, 5519.724013799374, 5684.545236380997, 5769.394128669582, 5817.7963771267805, 5101.240072175094, 5327.440618734977, 5601.383847776823, 5606.299212598426, 5634.802781902614, 5389.299391079135, 5565.443455654402, 5600.899662626515, 5713.114467257582, 5731.0, 4816.783244753924, 4879.365682461257, 4900.828471003498, 5027.868729535825, 5572.832815015556], "value": 4066.0079774823826, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.4836692077893, 650.3074225949364, 655.5542231282728, 666.5201055240227, 740.3373980287643, 13892.444302227912, 14647.340869660864, 14748.33632486538, 14772.0, 14809.037412568176, 12898.806517902216, 12995.285259310758, 13036.73926521469, 13045.93477032616, 13047.60857174284, 621.4034526854225, 646.3504178300801, 786.2962648429666, 805.8831469436929, 807.4509333653114, 767.8003719033063, 801.3308887079296, 805.4683908620311, 819.6516480495766, 819.7991492084448, 817.2930415190847, 852.526847599582, 852.6845067325098, 852.8720691896203, 858.3090612057291, 701.8140192848899, 705.1819888928843, 802.0255389701512, 816.383630359081, 850.9617067231959, 557.4035781713568, 637.7512770019696, 638.2851206648584, 639.3031595560861, 640.2061443809689, 13293.069485136044, 13445.731085378238, 13452.260125693181, 13476.124051936691, 13483.932580337036, 13623.386947587382, 13715.794263086062, 13768.793468097987, 13886.861131388658, 14008.859911400858, 11416.885831141666, 11429.142814288962, 11455.521579330047, 11858.466369013415, 11982.26257192711, 3200.2959348943195, 3675.0, 3689.05928988109, 3714.7771133732062, 3738.1962877981364, 91510.0, 113989.4300528492, 115650.0, 116013.83986160115, 116120.41939790247, 10504.422256775797, 10511.106555942677, 10618.097461715686, 10773.030427261427, 10945.890541094646, 21015.0, 21111.68332475014, 21336.573268534852, 21340.253091141734, 21395.893020534797, 6778.898316525256, 7315.707371705073, 7377.963110184414, 7555.896689560285, 7623.9618801906745, 4165.416841642173, 4172.666186705056, 4174.102567947906, 4183.49798024239, 4222.282212023963, 3539.752217344813, 3745.0824547985917, 3758.0792705787258, 3758.8496460141837, 3779.6976241901134, 652.9706163222667, 654.594151625995, 654.6661202786613, 661.2990230355838, 672.0356288725694, 546.0, 549.9120140777457, 643.32129603269, 654.107143748789, 660.5805313625882, 8662.96044474667, 8904.8664270036, 9031.683891063782, 9075.183233509017, 9225.492597907045, 542.8425756530562, 605.5397897597858, 617.6417677746986, 657.9571379363666, 659.2188256915571, 4389.517153113155, 4859.392575928009, 4875.247781822201, 4913.238448040559, 4985.382519784659, 120749.0, 124977.37511312385, 140377.0, 143614.28192858968, 143858.0, 87597.0, 120500.79499205071, 120783.0, 124003.0, 124190.0, 51453.19913802999, 79140.60429697814, 92877.0, 107743.46128269465, 108265.0, 8980.506072166094, 9121.224695900923, 9193.126652967958, 9254.722358329262, 9710.417374957242, 60977.0, 64740.70518589507, 65155.674221628586, 65495.67252163708, 66668.66665666834, 95246.0, 96944.51527742317, 98670.50664746917, 98909.51635725614, 99736.0, 10504.054635082879, 12250.816237756262, 12597.86619204276, 12883.227006379648, 13494.190348579117, 14384.42462301538, 14405.207713575854, 14408.351624176728, 14481.782773258621, 14515.709685806436, 12887.226766394046, 12895.548655797002, 13051.934740326238, 13301.800472993107, 13625.65935851572, 11213.495392707184, 13304.334783260605, 13355.732885342044, 13387.397567109698, 13457.596272111852, 12748.171368860994, 12870.742585148431, 12911.741765164832, 13095.41070651842, 13148.60554183376, 9865.95067024689, 9970.451625160396, 10833.349999000086, 11437.485313160762, 11463.942680286546, 10688.198385121303, 11202.103831693283, 11213.66359009231, 11249.156313276373, 11284.0], "value": 7467.394513918679, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1570.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 119.0, 137.0, 123.0, 103.0, 169.0, 176.0, 128.0, 118.0], "value": 130.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 101.0, 147.0, 172.0, 116.0, 116.0, 116.0, 116.0, 143.0, 116.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 220.0, 198.0, 203.0, 195.0, 194.0, 196.0, 198.0, 201.0, 194.0], "value": 199.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 66.0, 50.0, 85.0, 72.0, 85.0, 84.0, 83.0, 106.0, 59.0], "value": 77.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 71.0, 91.0, 71.0, 69.0, 70.0, 87.0, 71.0, 70.0, 88.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 89.0, 89.0, 90.0, 88.0, 90.0, 88.0, 92.0, 89.0], "value": 89.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 96.0, 97.0, 125.0, 97.0, 119.0, 100.0, 152.0], "value": 107.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 120.0, 103.0, 78.0, 86.0, 139.0, 150.0, 85.0, 145.0, 147.0], "value": 114.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 57.0, 57.0, 57.0, 58.0, 56.0, 59.0, 60.0, 58.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 82.0, 79.0, 64.0, 102.0, 63.0, 90.0, 106.0, 105.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 87.0, 87.0, 113.0, 109.0, 109.0, 90.0, 92.0, 90.0], "value": 95.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 160.0, 164.0, 148.0, 149.0, 148.0, 148.0, 171.0, 183.0, 151.0], "value": 157.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 178.0, 174.0, 174.0, 174.0, 174.0, 175.0, 174.0, 233.0, 187.0], "value": 181.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 69.0, 70.0, 70.0, 71.0, 71.0, 68.0, 69.0, 76.0], "value": 70.4, "unit": "score"}]}]} 14:41:55 INFO - Return code: 0 14:41:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:41:55 ERROR - # TBPL SUCCESS # 14:41:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:41:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:41:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:41:55 INFO - 2016-10-13 14:41:55.935 screenresolution[1673:10505] starting screenresolution argv=screenresolution get 14:41:55 INFO - 2016-10-13 14:41:55.937 screenresolution[1673:10505] Display 0: 1600x1200x32@60 14:41:55 INFO - 2016-10-13 14:41:55.943 screenresolution[1674:10508] starting screenresolution argv=screenresolution list 14:41:55 INFO - Available Modes on Display 0 14:41:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:41:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:41:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:41:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:41:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:41:56 INFO - Intel Iris: 14:41:56 INFO - Chipset Model: Intel Iris 14:41:56 INFO - Type: GPU 14:41:56 INFO - Bus: Built-In 14:41:56 INFO - VRAM (Dynamic, Max): 1536 MB 14:41:56 INFO - Vendor: Intel (0x8086) 14:41:56 INFO - Device ID: 0x0a2e 14:41:56 INFO - Revision ID: 0x0009 14:41:56 INFO - Displays: 14:41:56 INFO - Display: 14:41:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:41:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:41:56 INFO - Display Serial Number: 1600x1200 60 14:41:56 INFO - Main Display: Yes 14:41:56 INFO - Mirror: Off 14:41:56 INFO - Online: Yes 14:41:56 INFO - Rotation: Supported 14:41:56 INFO - Return code: 0 14:41:56 INFO - Running post-action listener: _resource_record_post_action 14:41:56 INFO - [mozharness: 2016-10-13 21:41:56.183320Z] Finished run-tests step (success) 14:41:56 INFO - Running post-run listener: _resource_record_post_run 14:41:56 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 39721472; Write bytes: 712566272; Read time: 392; Write time: 2393 14:41:56 INFO - TinderboxPrint: CPU usage
54.5% 14:41:56 INFO - TinderboxPrint: I/O read bytes / time
39,721,472 / 392 14:41:56 INFO - TinderboxPrint: I/O write bytes / time
712,566,272 / 2,393 14:41:56 INFO - TinderboxPrint: CPU idle
2,205.9 (45.5%) 14:41:56 INFO - TinderboxPrint: CPU system
978.3 (20.2%) 14:41:56 INFO - TinderboxPrint: CPU user
1,661.4 (34.3%) 14:41:56 INFO - TinderboxPrint: Swap in / out
446,263,296 / 0 14:41:56 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 413432320; Write bytes: 403445760; Read time: 31178; Write time: 818 14:41:56 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 30126592; Write bytes: 300166656; Read time: 287; Write time: 1541 14:41:56 INFO - Running post-run listener: _upload_blobber_files 14:41:56 INFO - Blob upload gear active. 14:41:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:41:56 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 14:41:56 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:41:56 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:41:57 INFO - (blobuploader) - INFO - Open directory for files ... 14:41:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:41:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:41:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:41:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:41:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:41:58 INFO - (blobuploader) - INFO - Done attempting. 14:41:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:41:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:41:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:41:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:41:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:41:59 INFO - (blobuploader) - INFO - Done attempting. 14:41:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:41:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:41:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:42:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:42:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:42:02 INFO - (blobuploader) - INFO - Done attempting. 14:42:02 INFO - (blobuploader) - INFO - Iteration through files over. 14:42:02 INFO - Return code: 0 14:42:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:42:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:42:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e280ba09f5e93896557f45664af90b92fd49bebd0e715d42598c71e51db97d6708c6eae90ca8acc204275223186b81bc215495919d887656b674b74199150bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cbaf9a830c1f96f97c5f86e9e8d8e7a17c3360af7a0d20431c8ad2236b5d1483747074a810d432f0caa183617a7625de9a24681f5d8058c4ca275a8b31fa465f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0557ece0ecaaec25d5bb3128f9d814c6e0a7e263a47c2d25f25bc07a07eef0263bffb99b21f6d29a9fbe86193f4360f41f9ce773f48ae0fc98f0444d322e1b3"} 14:42:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:42:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:42:02 INFO - Contents: 14:42:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e280ba09f5e93896557f45664af90b92fd49bebd0e715d42598c71e51db97d6708c6eae90ca8acc204275223186b81bc215495919d887656b674b74199150bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cbaf9a830c1f96f97c5f86e9e8d8e7a17c3360af7a0d20431c8ad2236b5d1483747074a810d432f0caa183617a7625de9a24681f5d8058c4ca275a8b31fa465f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0557ece0ecaaec25d5bb3128f9d814c6e0a7e263a47c2d25f25bc07a07eef0263bffb99b21f6d29a9fbe86193f4360f41f9ce773f48ae0fc98f0444d322e1b3"} 14:42:02 INFO - Running post-run listener: copy_logs_to_upload_dir 14:42:02 INFO - Copying logs to upload dir... 14:42:02 INFO - mkdir: /builds/slave/test/build/upload/logs 14:42:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.537740 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-13 14:42:02.959659) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 14:42:02.963748) ========= 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.TmrrR4d5Iy/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.ZET9zi2oPY/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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/Fx-Team/sha512/8e280ba09f5e93896557f45664af90b92fd49bebd0e715d42598c71e51db97d6708c6eae90ca8acc204275223186b81bc215495919d887656b674b74199150bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cbaf9a830c1f96f97c5f86e9e8d8e7a17c3360af7a0d20431c8ad2236b5d1483747074a810d432f0caa183617a7625de9a24681f5d8058c4ca275a8b31fa465f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0557ece0ecaaec25d5bb3128f9d814c6e0a7e263a47c2d25f25bc07a07eef0263bffb99b21f6d29a9fbe86193f4360f41f9ce773f48ae0fc98f0444d322e1b3"} build_url:https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/CVsqb7jGSEqebe_AWB1zsw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e280ba09f5e93896557f45664af90b92fd49bebd0e715d42598c71e51db97d6708c6eae90ca8acc204275223186b81bc215495919d887656b674b74199150bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cbaf9a830c1f96f97c5f86e9e8d8e7a17c3360af7a0d20431c8ad2236b5d1483747074a810d432f0caa183617a7625de9a24681f5d8058c4ca275a8b31fa465f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a0557ece0ecaaec25d5bb3128f9d814c6e0a7e263a47c2d25f25bc07a07eef0263bffb99b21f6d29a9fbe86193f4360f41f9ce773f48ae0fc98f0444d322e1b3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 14:42:02.996450) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 14:42:02.996903) ========= 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.TmrrR4d5Iy/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.ZET9zi2oPY/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005292 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 14:42:03.046061) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 14:42:03.046378) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 14:42:03.046703) ========= ========= Total master_lag: 0.17 =========