builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0035 starttime: 1475860069.19 results: success (0) buildid: 20161007072500 builduid: 16c022fe37e14c14be7319a337d06e20 revision: 49fe455cac957808ed4a5d1685c3a1938dac1d31 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 10:07:49.190847) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 10:07:49.191304) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 10:07:49.191586) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 10:07:49.214550) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 10:07:49.214950) ========= 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.gjcrtBDeuH/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.IIslSXrNNi/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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-07 10:07:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.99M=0.001s 2016-10-07 10:07:49 (7.99 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073329 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 10:07:49.309803) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 10:07:49.310121) ========= 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.gjcrtBDeuH/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.IIslSXrNNi/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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.021019 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 10:07:49.359389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 10:07:49.359835) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 49fe455cac957808ed4a5d1685c3a1938dac1d31 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 49fe455cac957808ed4a5d1685c3a1938dac1d31 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gjcrtBDeuH/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.IIslSXrNNi/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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-07 10:07:49,431 truncating revision to first 12 chars 2016-10-07 10:07:49,431 Setting DEBUG logging. 2016-10-07 10:07:49,432 attempt 1/10 2016-10-07 10:07:49,432 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/49fe455cac95?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 10:07:50,070 unpacking tar archive at: mozilla-central-49fe455cac95/testing/mozharness/ program finished with exit code 0 elapsedTime=0.907754 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 10:07:50.291418) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 10:07:50.291960) ========= script_repo_revision: 49fe455cac957808ed4a5d1685c3a1938dac1d31 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 10:07:50.292391) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 10:07:50.292685) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 10:07:50.310739) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-07 10:07:50.311107) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gjcrtBDeuH/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.IIslSXrNNi/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 10:07:50 INFO - MultiFileLogger online at 20161007 10:07:50 in /builds/slave/test 10:07:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:07:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:07:50 INFO - {'append_to_log': False, 10:07:50 INFO - 'base_work_dir': '/builds/slave/test', 10:07:50 INFO - 'blob_upload_branch': 'Firefox', 10:07:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:07:50 INFO - 'branch': 'Firefox', 10:07:50 INFO - 'buildbot_json_path': 'buildprops.json', 10:07:50 INFO - 'config_files': ('talos/mac_config.py',), 10:07:50 INFO - 'default_actions': ('clobber', 10:07:50 INFO - 'read-buildbot-config', 10:07:50 INFO - 'download-and-extract', 10:07:50 INFO - 'populate-webroot', 10:07:50 INFO - 'create-virtualenv', 10:07:50 INFO - 'install', 10:07:50 INFO - 'run-tests'), 10:07:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:07:50 INFO - 'download_minidump_stackwalk': True, 10:07:50 INFO - 'download_symbols': 'ondemand', 10:07:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:07:50 INFO - 'tooltool.py': '/tools/tooltool.py', 10:07:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:07:50 INFO - '/tools/misc-python/virtualenv.py')}, 10:07:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:07:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:07:50 INFO - 'installer_path': 'installer.exe', 10:07:50 INFO - 'log_level': 'info', 10:07:50 INFO - 'log_name': 'talos', 10:07:50 INFO - 'log_to_console': True, 10:07:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:07:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:07:50 INFO - 'opt_config_files': (), 10:07:50 INFO - 'pip_index': False, 10:07:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:07:50 INFO - 'cmd': ('bash', 10:07:50 INFO - '-c', 10:07:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:07:50 INFO - 'enabled': True, 10:07:50 INFO - 'halt_on_failure': False, 10:07:50 INFO - 'name': 'check_screen_resolution'},), 10:07:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:07:50 INFO - 'cmd': ('bash', 10:07:50 INFO - '-c', 10:07:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:07:50 INFO - 'enabled': True, 10:07:50 INFO - 'halt_on_failure': False, 10:07:50 INFO - 'name': 'check_screen_resolution'},), 10:07:50 INFO - 'run_cmd_checks_enabled': True, 10:07:50 INFO - 'sps_profile': False, 10:07:50 INFO - 'sps_profile_interval': 0, 10:07:50 INFO - 'suite': 'dromaeojs-e10s', 10:07:50 INFO - 'system_bits': '32', 10:07:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:07:50 INFO - 'title': 't-yosemite-r7-0035', 10:07:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:07:50 INFO - 'use_talos_json': True, 10:07:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:07:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:07:50 INFO - 'work_dir': 'build'} 10:07:50 INFO - [mozharness: 2016-10-07 17:07:50.512733Z] Running clobber step. 10:07:50 INFO - Running pre-action listener: _resource_record_pre_action 10:07:50 INFO - Running main action method: clobber 10:07:50 INFO - rmtree: /builds/slave/test/build 10:07:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:07:52 INFO - Running post-action listener: _resource_record_post_action 10:07:52 INFO - [mozharness: 2016-10-07 17:07:52.099935Z] Finished clobber step (success) 10:07:52 INFO - [mozharness: 2016-10-07 17:07:52.100130Z] Running read-buildbot-config step. 10:07:52 INFO - Running pre-action listener: _resource_record_pre_action 10:07:52 INFO - Running main action method: read_buildbot_config 10:07:52 INFO - Using buildbot properties: 10:07:52 INFO - { 10:07:52 INFO - "project": "", 10:07:52 INFO - "product": "firefox", 10:07:52 INFO - "script_repo_revision": "production", 10:07:52 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:07:52 INFO - "repository": "", 10:07:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:07:52 INFO - "buildid": "20161007072500", 10:07:52 INFO - "pgo_build": "False", 10:07:52 INFO - "basedir": "/builds/slave/test", 10:07:52 INFO - "buildnumber": 15, 10:07:52 INFO - "slavename": "t-yosemite-r7-0035", 10:07:52 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:07:52 INFO - "platform": "yosemite_r7", 10:07:52 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:07:52 INFO - "branch": "mozilla-central", 10:07:52 INFO - "repo_path": "mozilla-central", 10:07:52 INFO - "revision": "49fe455cac957808ed4a5d1685c3a1938dac1d31", 10:07:52 INFO - "stage_platform": "macosx64", 10:07:52 INFO - "builduid": "16c022fe37e14c14be7319a337d06e20", 10:07:52 INFO - "slavebuilddir": "test" 10:07:52 INFO - } 10:07:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 10:07:52 INFO - Running post-action listener: _resource_record_post_action 10:07:52 INFO - [mozharness: 2016-10-07 17:07:52.104750Z] Finished read-buildbot-config step (success) 10:07:52 INFO - [mozharness: 2016-10-07 17:07:52.104920Z] Running download-and-extract step. 10:07:52 INFO - Running pre-action listener: _resource_record_pre_action 10:07:52 INFO - Running main action method: download_and_extract 10:07:52 INFO - mkdir: /builds/slave/test/build/tests 10:07:52 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')]} 10:07:52 INFO - trying https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 10:07:52 INFO - Downloading https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/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 10:07:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/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 10:07:53 INFO - Downloaded 1199 bytes. 10:07:53 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 10:07:53 INFO - Using the following test package requirements: 10:07:53 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:07:53 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:07:53 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 10:07:53 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:07:53 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 10:07:53 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:07:53 INFO - u'jsshell-mac.zip'], 10:07:53 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:07:53 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 10:07:53 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:07:53 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:07:53 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 10:07:53 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:07:53 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 10:07:53 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:07:53 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 10:07:53 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:07:53 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 10:07:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:07:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:07:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:07:53 INFO - Fetch https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:07:53 INFO - Http code: 200 10:07:53 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 10:07:53 INFO - x-amz-cf-id: 8ABOMYdRAB5O45_flpcusc1JaSY1-ojsAGB8yJT3uAMih3pNpG5emQ== 10:07:53 INFO - x-amz-version-id: 4Yl1oPhxr_EDvfd5MX51MUmHwh3hNmZr 10:07:54 INFO - Expected file size: 16483240 10:07:54 INFO - Obtained file size: 16483240 10:08: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 10:08:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:08:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:08:00 INFO - Fetch https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:08:01 INFO - Http code: 200 10:08:01 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 10:08:01 INFO - x-amz-cf-id: ViOktWFh-Qik0chWFp4XZ7CUROEqCQxd63KphkDMWC_qT3XdUb6CXg== 10:08:01 INFO - x-amz-version-id: 4Yl1oPhxr_EDvfd5MX51MUmHwh3hNmZr 10:08:01 INFO - Expected file size: 16483240 10:08:01 INFO - Obtained file size: 16483240 10:08:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 10:08:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:08:08 INFO - Fetch https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 10:08:09 INFO - Http code: 200 10:08:09 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 10:08:09 INFO - x-amz-cf-id: NUB-gAjyovFKszDgfkSB8eP76SvCk4iaKtOdck-F9seU6Qf2WnX6Dg== 10:08:09 INFO - x-amz-version-id: kzdxCF.LBGeiG_K1RQNeUqcj9zVHN9CT 10:08:09 INFO - Expected file size: 14409006 10:08:09 INFO - Obtained file size: 14409006 10:08: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')]} 10:08:09 INFO - trying https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:08:09 INFO - Downloading https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 10:08:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/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 10:08:12 INFO - Downloaded 111658044 bytes. 10:08:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:08:12 INFO - mkdir: /builds/slave/test/properties 10:08:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:08:12 INFO - Writing to file /builds/slave/test/properties/build_url 10:08:12 INFO - Contents: 10:08:12 INFO - build_url:https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:08:13 INFO - Running post-action listener: _resource_record_post_action 10:08:13 INFO - Running post-action listener: set_extra_try_arguments 10:08:13 INFO - [mozharness: 2016-10-07 17:08:13.290116Z] Finished download-and-extract step (success) 10:08:13 INFO - [mozharness: 2016-10-07 17:08:13.290241Z] Running populate-webroot step. 10:08:13 INFO - Running pre-action listener: _resource_record_pre_action 10:08:13 INFO - Running main action method: populate_webroot 10:08:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:08:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:08:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:08:13 INFO - '--tppagecycles', 10:08:13 INFO - '7'], 10:08:13 INFO - 'tests': ['tsvgm']}}, 10:08:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:08:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:08:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:08:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:08:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:08:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:08:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:13 INFO - 'talos_options': ['--disable-e10s'], 10:08:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:08:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:08:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:13 INFO - 'talos_options': ['--disable-e10s'], 10:08:13 INFO - 'tests': ['damp', 'tps']}, 10:08:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:13 INFO - 'tests': ['damp', 'tps']}, 10:08:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:08:13 INFO - 'tests': ['dromaeo_dom']}, 10:08:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:08:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:08:13 INFO - 'tests': ['basic_compositor_video']}, 10:08:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:08:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:08:13 INFO - 'tests': ['a11yr', 10:08:13 INFO - 'ts_paint', 10:08:13 INFO - 'tpaint', 10:08:13 INFO - 'sessionrestore', 10:08:13 INFO - 'sessionrestore_no_auto_restore', 10:08:13 INFO - 'tabpaint']}, 10:08:13 INFO - 'other-e10s': {'tests': ['a11yr', 10:08:13 INFO - 'ts_paint', 10:08:13 INFO - 'tpaint', 10:08:13 INFO - 'sessionrestore', 10:08:13 INFO - 'sessionrestore_no_auto_restore', 10:08:13 INFO - 'tabpaint']}, 10:08:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:08:13 INFO - 'ts_paint', 10:08:13 INFO - 'tpaint', 10:08:13 INFO - 'sessionrestore', 10:08:13 INFO - 'sessionrestore_no_auto_restore', 10:08:13 INFO - 'tabpaint']}, 10:08:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:08:13 INFO - 'ts_paint', 10:08:13 INFO - 'tpaint', 10:08:13 INFO - 'sessionrestore', 10:08:13 INFO - 'sessionrestore_no_auto_restore', 10:08:13 INFO - 'tabpaint']}, 10:08:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:08:13 INFO - 'tests': ['a11yr', 10:08:13 INFO - 'ts_paint', 10:08:13 INFO - 'tpaint', 10:08:13 INFO - 'sessionrestore', 10:08:13 INFO - 'sessionrestore_no_auto_restore', 10:08:13 INFO - 'tabpaint']}, 10:08:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:08:13 INFO - 'tests': ['a11yr', 10:08:13 INFO - 'ts_paint', 10:08:13 INFO - 'tpaint', 10:08:13 INFO - 'sessionrestore', 10:08:13 INFO - 'sessionrestore_no_auto_restore', 10:08:13 INFO - 'tabpaint']}, 10:08:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:08:13 INFO - 'tests': ['tsvgx', 10:08:13 INFO - 'tsvgr_opacity', 10:08:13 INFO - 'tart', 10:08:13 INFO - 'tscrollx', 10:08:13 INFO - 'cart']}, 10:08:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:08:13 INFO - 'tsvgr_opacity', 10:08:13 INFO - 'tart', 10:08:13 INFO - 'tscrollx', 10:08:13 INFO - 'cart']}, 10:08:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:13 INFO - 'talos_options': ['--disable-e10s'], 10:08:13 INFO - 'tests': ['tp5o']}, 10:08:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:13 INFO - 'tests': ['tp5o']}, 10:08:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:13 INFO - 'talos_options': ['--disable-e10s', 10:08:13 INFO - '--xperf_path', 10:08:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:08:13 INFO - 'tests': ['tp5n']}, 10:08:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:08:13 INFO - 'talos_options': ['--xperf_path', 10:08:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:08:13 INFO - 'tests': ['tp5n']}}, 10:08:13 INFO - 'talos.zip': {'path': '', 10:08:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:08:13 INFO - Running post-action listener: _resource_record_post_action 10:08:13 INFO - [mozharness: 2016-10-07 17:08:13.309868Z] Finished populate-webroot step (success) 10:08:13 INFO - [mozharness: 2016-10-07 17:08:13.310007Z] Running create-virtualenv step. 10:08:13 INFO - Running pre-action listener: _resource_record_pre_action 10:08:13 INFO - Running main action method: create_virtualenv 10:08:13 INFO - Creating virtualenv /builds/slave/test/build/venv 10:08:13 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 10:08:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:08:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:08:13 INFO - Using real prefix '/tools/python27' 10:08:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:08:14 INFO - Installing distribute.............................................................................................................................................................................................done. 10:08:17 INFO - Installing pip.................done. 10:08:17 INFO - Return code: 0 10:08:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:08:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:08:17 INFO - Reading from file tmpfile_stdout 10:08:17 INFO - Output received: 10:08:17 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) 10:08:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:08: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')]} 10:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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')]} 10:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1060e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10605b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa34b490c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef9d30>, '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 0x105d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef1b20>, '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.gjcrtBDeuH/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.IIslSXrNNi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 10:08: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', 'pip>=1.5'] in /builds/slave/test/build 10:08: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 pip>=1.5 10:08:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gjcrtBDeuH/Render', 10:08:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:17 INFO - 'HOME': '/Users/cltbld', 10:08:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:17 INFO - 'LOGNAME': 'cltbld', 10:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:17 INFO - 'MOZ_NO_REMOTE': '1', 10:08:17 INFO - 'NO_EM_RESTART': '1', 10:08:17 INFO - 'PAGER': '/bin/cat', 10:08:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:17 INFO - 'PWD': '/builds/slave/test', 10:08:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:17 INFO - 'SHELL': '/bin/bash', 10:08:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IIslSXrNNi/Listeners', 10:08:17 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 10:08:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:17 INFO - 'USER': 'cltbld', 10:08:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:17 INFO - 'XPC_FLAGS': '0x0', 10:08:17 INFO - 'XPC_SERVICE_NAME': '0', 10:08:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08: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 10:08:17 INFO - Cleaning up... 10:08:17 INFO - Return code: 0 10:08:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:08: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')]} 10:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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')]} 10:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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 0x1060e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10605b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa34b490c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef9d30>, '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 0x105d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef1b20>, '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.gjcrtBDeuH/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.IIslSXrNNi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 10:08: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 10:08: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 10:08:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gjcrtBDeuH/Render', 10:08:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:17 INFO - 'HOME': '/Users/cltbld', 10:08:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:17 INFO - 'LOGNAME': 'cltbld', 10:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:17 INFO - 'MOZ_NO_REMOTE': '1', 10:08:17 INFO - 'NO_EM_RESTART': '1', 10:08:17 INFO - 'PAGER': '/bin/cat', 10:08:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:17 INFO - 'PWD': '/builds/slave/test', 10:08:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:17 INFO - 'SHELL': '/bin/bash', 10:08:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IIslSXrNNi/Listeners', 10:08:17 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 10:08:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:17 INFO - 'USER': 'cltbld', 10:08:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:17 INFO - 'XPC_FLAGS': '0x0', 10:08:17 INFO - 'XPC_SERVICE_NAME': '0', 10:08:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:17 INFO - Downloading/unpacking psutil>=3.1.1 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:08:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:21 INFO - Installing collected packages: psutil 10:08:21 INFO - Running setup.py install for psutil 10:08:21 INFO - building 'psutil._psutil_osx' extension 10:08: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:08: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 10:08: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 10:08: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 10:08:21 INFO - building 'psutil._psutil_posix' extension 10:08: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 10:08:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:08:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:08:21 INFO - ^ 10:08:21 INFO - 1 warning generated. 10:08: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 10:08:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:08:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:08:22 INFO - Successfully installed psutil 10:08:22 INFO - Cleaning up... 10:08:22 INFO - Return code: 0 10:08:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:08: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')]} 10:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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')]} 10:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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 0x1060e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10605b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa34b490c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef9d30>, '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 0x105d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef1b20>, '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.gjcrtBDeuH/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.IIslSXrNNi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 10:08: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 10:08: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 10:08:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gjcrtBDeuH/Render', 10:08:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:22 INFO - 'HOME': '/Users/cltbld', 10:08:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:22 INFO - 'LOGNAME': 'cltbld', 10:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:22 INFO - 'MOZ_NO_REMOTE': '1', 10:08:22 INFO - 'NO_EM_RESTART': '1', 10:08:22 INFO - 'PAGER': '/bin/cat', 10:08:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:22 INFO - 'PWD': '/builds/slave/test', 10:08:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:22 INFO - 'SHELL': '/bin/bash', 10:08:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IIslSXrNNi/Listeners', 10:08:22 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 10:08:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:22 INFO - 'USER': 'cltbld', 10:08:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:22 INFO - 'XPC_FLAGS': '0x0', 10:08:22 INFO - 'XPC_SERVICE_NAME': '0', 10:08:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:08:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:08:24 INFO - Installing collected packages: mozsystemmonitor 10:08:24 INFO - Running setup.py install for mozsystemmonitor 10:08:25 INFO - Successfully installed mozsystemmonitor 10:08:25 INFO - Cleaning up... 10:08:25 INFO - Return code: 0 10:08:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:08: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')]} 10:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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')]} 10:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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 0x1060e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10605b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa34b490c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef9d30>, '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 0x105d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef1b20>, '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.gjcrtBDeuH/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.IIslSXrNNi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 10:08: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 10:08: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 10:08:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gjcrtBDeuH/Render', 10:08:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:25 INFO - 'HOME': '/Users/cltbld', 10:08:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:25 INFO - 'LOGNAME': 'cltbld', 10:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:25 INFO - 'MOZ_NO_REMOTE': '1', 10:08:25 INFO - 'NO_EM_RESTART': '1', 10:08:25 INFO - 'PAGER': '/bin/cat', 10:08:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:25 INFO - 'PWD': '/builds/slave/test', 10:08:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:25 INFO - 'SHELL': '/bin/bash', 10:08:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IIslSXrNNi/Listeners', 10:08:25 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 10:08:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:25 INFO - 'USER': 'cltbld', 10:08:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:25 INFO - 'XPC_FLAGS': '0x0', 10:08:25 INFO - 'XPC_SERVICE_NAME': '0', 10:08:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:25 INFO - Downloading/unpacking jsonschema==2.5.1 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:08:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08:28 INFO - Downloading functools32-3.2.3-2.tar.gz 10:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:08:28 INFO - warning: no files found matching '*.txt' 10:08:28 INFO - no previously-included directories found matching 'build' 10:08:28 INFO - no previously-included directories found matching 'dist' 10:08:28 INFO - no previously-included directories found matching '.git*' 10:08:28 INFO - Installing collected packages: jsonschema, functools32 10:08:28 INFO - Running setup.py install for functools32 10:08:28 INFO - warning: no files found matching '*.txt' 10:08:28 INFO - no previously-included directories found matching 'build' 10:08:28 INFO - no previously-included directories found matching 'dist' 10:08:28 INFO - no previously-included directories found matching '.git*' 10:08:28 INFO - Successfully installed jsonschema functools32 10:08:28 INFO - Cleaning up... 10:08:28 INFO - Return code: 0 10:08:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:08: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')]} 10:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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')]} 10:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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 0x1060e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10605b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa34b490c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef9d30>, '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 0x105d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef1b20>, '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.gjcrtBDeuH/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.IIslSXrNNi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 10:08: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 10:08: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 10:08:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gjcrtBDeuH/Render', 10:08:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:28 INFO - 'HOME': '/Users/cltbld', 10:08:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:28 INFO - 'LOGNAME': 'cltbld', 10:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:28 INFO - 'MOZ_NO_REMOTE': '1', 10:08:28 INFO - 'NO_EM_RESTART': '1', 10:08:28 INFO - 'PAGER': '/bin/cat', 10:08:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:28 INFO - 'PWD': '/builds/slave/test', 10:08:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:28 INFO - 'SHELL': '/bin/bash', 10:08:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IIslSXrNNi/Listeners', 10:08:28 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 10:08:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:28 INFO - 'USER': 'cltbld', 10:08:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:28 INFO - 'XPC_FLAGS': '0x0', 10:08:28 INFO - 'XPC_SERVICE_NAME': '0', 10:08:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:08:28 INFO - Cleaning up... 10:08:28 INFO - Return code: 0 10:08:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:08: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')]} 10:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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')]} 10:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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', '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 0x1060e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10605b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa34b490c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef9d30>, '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 0x105d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef1b20>, '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.gjcrtBDeuH/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.IIslSXrNNi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 10:08: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:08: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 blobuploader==1.2.4 10:08:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gjcrtBDeuH/Render', 10:08:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:28 INFO - 'HOME': '/Users/cltbld', 10:08:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:28 INFO - 'LOGNAME': 'cltbld', 10:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:28 INFO - 'MOZ_NO_REMOTE': '1', 10:08:28 INFO - 'NO_EM_RESTART': '1', 10:08:28 INFO - 'PAGER': '/bin/cat', 10:08:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:28 INFO - 'PWD': '/builds/slave/test', 10:08:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:28 INFO - 'SHELL': '/bin/bash', 10:08:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IIslSXrNNi/Listeners', 10:08:28 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 10:08:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:28 INFO - 'USER': 'cltbld', 10:08:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:28 INFO - 'XPC_FLAGS': '0x0', 10:08:28 INFO - 'XPC_SERVICE_NAME': '0', 10:08:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:29 INFO - Downloading/unpacking blobuploader==1.2.4 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08:31 INFO - Downloading blobuploader-1.2.4.tar.gz 10:08:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:08:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:08:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08:32 INFO - Downloading docopt-0.6.1.tar.gz 10:08:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:08:32 INFO - Installing collected packages: blobuploader, requests, docopt 10:08:32 INFO - Running setup.py install for blobuploader 10:08:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:08:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:08:33 INFO - Running setup.py install for requests 10:08:33 INFO - Running setup.py install for docopt 10:08:33 INFO - Successfully installed blobuploader requests docopt 10:08:33 INFO - Cleaning up... 10:08:33 INFO - Return code: 0 10:08:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:33 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')]} 10:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:33 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')]} 10:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:33 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 0x1060e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10605b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa34b490c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef9d30>, '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 0x105d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef1b20>, '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.gjcrtBDeuH/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.IIslSXrNNi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 10:08:33 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 10:08:33 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 10:08:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gjcrtBDeuH/Render', 10:08:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:33 INFO - 'HOME': '/Users/cltbld', 10:08:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:33 INFO - 'LOGNAME': 'cltbld', 10:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:33 INFO - 'MOZ_NO_REMOTE': '1', 10:08:33 INFO - 'NO_EM_RESTART': '1', 10:08:33 INFO - 'PAGER': '/bin/cat', 10:08:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:33 INFO - 'PWD': '/builds/slave/test', 10:08:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:33 INFO - 'SHELL': '/bin/bash', 10:08:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IIslSXrNNi/Listeners', 10:08:33 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 10:08:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:33 INFO - 'USER': 'cltbld', 10:08:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:33 INFO - 'XPC_FLAGS': '0x0', 10:08:33 INFO - 'XPC_SERVICE_NAME': '0', 10:08:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:08:34 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-c6neA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:08:34 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-BrTl2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:08:34 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-wxtrIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:08:34 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-ZJUCg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:08:34 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-ts8E9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:08:34 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-I3gkFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:08:34 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-1PKOTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:08:34 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-pKEnUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:08:34 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-jvnOCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:08:35 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-oEtatr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:08:35 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-FtwPli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:08:35 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-HSzRMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:08:35 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-ZAKCam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:08:35 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-qYLqQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:35 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-lQDfPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:08:35 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-YP8g9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:08:35 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-PZCVhp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:08:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:08:35 INFO - Running setup.py install for manifestparser 10:08:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:08:36 INFO - Running setup.py install for mozcrash 10:08:36 INFO - Running setup.py install for mozdebug 10:08:36 INFO - Running setup.py install for mozdevice 10:08:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:08:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:08:36 INFO - Running setup.py install for mozfile 10:08:36 INFO - Running setup.py install for mozhttpd 10:08:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:08:36 INFO - Running setup.py install for mozinfo 10:08:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:08:36 INFO - Running setup.py install for mozInstall 10:08:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:08:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:08:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:08:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:08:37 INFO - Running setup.py install for mozleak 10:08:37 INFO - Running setup.py install for mozlog 10:08:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:08:37 INFO - Running setup.py install for moznetwork 10:08:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:08:37 INFO - Running setup.py install for mozprocess 10:08:37 INFO - Running setup.py install for mozprofile 10:08:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:08:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:08:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:08:37 INFO - Running setup.py install for mozrunner 10:08:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:08:38 INFO - Running setup.py install for mozscreenshot 10:08:38 INFO - Running setup.py install for moztest 10:08:38 INFO - Running setup.py install for mozversion 10:08:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:08:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:08:38 INFO - Cleaning up... 10:08:38 INFO - Return code: 0 10:08:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08: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')]} 10:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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')]} 10:08:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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 0x1060e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10605b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa34b490c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef9d30>, '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 0x105d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef1b20>, '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.gjcrtBDeuH/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.IIslSXrNNi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 10:08: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 10:08: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 10:08:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gjcrtBDeuH/Render', 10:08:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:38 INFO - 'HOME': '/Users/cltbld', 10:08:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:38 INFO - 'LOGNAME': 'cltbld', 10:08:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:38 INFO - 'MOZ_NO_REMOTE': '1', 10:08:38 INFO - 'NO_EM_RESTART': '1', 10:08:38 INFO - 'PAGER': '/bin/cat', 10:08:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:38 INFO - 'PWD': '/builds/slave/test', 10:08:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:38 INFO - 'SHELL': '/bin/bash', 10:08:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IIslSXrNNi/Listeners', 10:08:38 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 10:08:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:38 INFO - 'USER': 'cltbld', 10:08:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:38 INFO - 'XPC_FLAGS': '0x0', 10:08:38 INFO - 'XPC_SERVICE_NAME': '0', 10:08:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:08:38 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-ChWgwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:08: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)) 10:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:08:38 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-1l3LsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:08:38 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)) 10:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:08:38 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-zwBJ8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:08: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)) 10:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:08:39 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-BJiNhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:08: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)) 10:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:08:39 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-VFfaae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:08: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)) 10:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:08:39 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-2FYChj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:08: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)) 10:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:08:39 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-3fywYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:08: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)) 10:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:08:39 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-Ux3ZKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:08: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)) 10:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:08:39 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-oaOH5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:08: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)) 10:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:08:39 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-SF7awy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:08: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)) 10:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:08:39 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-yZ6qtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:08:39 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)) 10:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:08:39 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-EEshbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:08: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)) 10:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:08:40 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-PdEGAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:08: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)) 10:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:08:40 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-7_GOgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:08: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)) 10:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:40 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-ckkqFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:08: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)) 10:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:08:40 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-tw0Dnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:08: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)) 10:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:08:40 INFO - Running setup.py (path:/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/pip-Z1Wz85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:08: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)) 10:08: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)) 10:08: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)) 10:08: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)) 10:08: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)) 10:08: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)) 10:08:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08: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 10:08:43 INFO - Downloading blessings-1.6.tar.gz 10:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:08:43 INFO - Installing collected packages: blessings 10:08:43 INFO - Running setup.py install for blessings 10:08:43 INFO - Successfully installed blessings 10:08:43 INFO - Cleaning up... 10:08:43 INFO - Return code: 0 10:08:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:08:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:08:43 INFO - Reading from file tmpfile_stdout 10:08:43 INFO - Current package versions: 10:08:43 INFO - blessings == 1.6 10:08:43 INFO - blobuploader == 1.2.4 10:08:43 INFO - docopt == 0.6.1 10:08:43 INFO - functools32 == 3.2.3-2 10:08:43 INFO - jsonschema == 2.5.1 10:08:43 INFO - manifestparser == 1.1 10:08:43 INFO - mozInstall == 1.12 10:08:43 INFO - mozcrash == 0.17 10:08:43 INFO - mozdebug == 0.1 10:08:43 INFO - mozdevice == 0.48 10:08:43 INFO - mozfile == 1.2 10:08:43 INFO - mozhttpd == 0.7 10:08:43 INFO - mozinfo == 0.9 10:08:43 INFO - mozleak == 0.1 10:08:43 INFO - mozlog == 3.4 10:08:43 INFO - moznetwork == 0.27 10:08:43 INFO - mozprocess == 0.23 10:08:43 INFO - mozprofile == 0.28 10:08:43 INFO - mozrunner == 6.12 10:08:43 INFO - mozscreenshot == 0.1 10:08:43 INFO - mozsystemmonitor == 0.3 10:08:43 INFO - moztest == 0.7 10:08:43 INFO - mozversion == 1.4 10:08:43 INFO - psutil == 3.1.1 10:08:43 INFO - requests == 1.2.3 10:08:43 INFO - wsgiref == 0.1.2 10:08:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08: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')]} 10:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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')]} 10:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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 0x1060e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10605b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa34b490c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef9d30>, '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 0x105d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef1b20>, '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.gjcrtBDeuH/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.IIslSXrNNi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 10:08: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 10:08: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 10:08:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gjcrtBDeuH/Render', 10:08:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:43 INFO - 'HOME': '/Users/cltbld', 10:08:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:43 INFO - 'LOGNAME': 'cltbld', 10:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:43 INFO - 'MOZ_NO_REMOTE': '1', 10:08:43 INFO - 'NO_EM_RESTART': '1', 10:08:43 INFO - 'PAGER': '/bin/cat', 10:08:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:43 INFO - 'PWD': '/builds/slave/test', 10:08:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:43 INFO - 'SHELL': '/bin/bash', 10:08:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IIslSXrNNi/Listeners', 10:08:43 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 10:08:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:43 INFO - 'USER': 'cltbld', 10:08:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:43 INFO - 'XPC_FLAGS': '0x0', 10:08:43 INFO - 'XPC_SERVICE_NAME': '0', 10:08:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:43 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)) 10:08:43 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)) 10:08:43 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)) 10:08:43 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)) 10:08:43 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)) 10:08:43 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)) 10:08:43 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)) 10:08:43 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)) 10:08:43 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)) 10:08:43 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)) 10:08:43 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)) 10:08:43 INFO - Cleaning up... 10:08:43 INFO - Return code: 0 10:08:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:08: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')]} 10:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08: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')]} 10:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:43 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 0x1060e5490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10605b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa34b490c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef9d30>, '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 0x105d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef1b20>, '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.gjcrtBDeuH/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.IIslSXrNNi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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 10:08:43 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 10:08:43 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 10:08:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gjcrtBDeuH/Render', 10:08:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:08:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:08:43 INFO - 'HOME': '/Users/cltbld', 10:08:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:08:43 INFO - 'LOGNAME': 'cltbld', 10:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:43 INFO - 'MOZ_NO_REMOTE': '1', 10:08:43 INFO - 'NO_EM_RESTART': '1', 10:08:43 INFO - 'PAGER': '/bin/cat', 10:08:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:43 INFO - 'PWD': '/builds/slave/test', 10:08:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:08:43 INFO - 'SHELL': '/bin/bash', 10:08:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IIslSXrNNi/Listeners', 10:08:43 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 10:08:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:08:43 INFO - 'USER': 'cltbld', 10:08:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:08:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:43 INFO - 'XPC_FLAGS': '0x0', 10:08:43 INFO - 'XPC_SERVICE_NAME': '0', 10:08:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:08:44 INFO - Cleaning up... 10:08:44 INFO - Return code: 0 10:08:44 INFO - Running post-action listener: _resource_record_post_action 10:08:44 INFO - Running post-action listener: _start_resource_monitoring 10:08:44 INFO - Starting resource monitoring. 10:08:44 INFO - [mozharness: 2016-10-07 17:08:44.250305Z] Finished create-virtualenv step (success) 10:08:44 INFO - [mozharness: 2016-10-07 17:08:44.251343Z] Running install step. 10:08:44 INFO - Running pre-action listener: _resource_record_pre_action 10:08:44 INFO - Running main action method: install 10:08:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:08:44 INFO - Reading from file tmpfile_stdout 10:08:44 INFO - Detecting whether we're running mozinstall >=1.0... 10:08:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:08:44 INFO - Reading from file tmpfile_stdout 10:08:44 INFO - Output received: 10:08:44 INFO - Usage: mozinstall [options] installer 10:08:44 INFO - Options: 10:08:44 INFO - -h, --help show this help message and exit 10:08:44 INFO - -d DEST, --destination=DEST 10:08:44 INFO - Directory to install application into. [default: 10:08:44 INFO - "/builds/slave/test"] 10:08:44 INFO - --app=APP Application being installed. [default: firefox] 10:08:44 INFO - mkdir: /builds/slave/test/build/application 10:08: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'] 10:08: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 10:09:20 INFO - Reading from file tmpfile_stdout 10:09:20 INFO - Output received: 10:09:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:09:20 INFO - Running post-action listener: _resource_record_post_action 10:09:20 INFO - [mozharness: 2016-10-07 17:09:20.056950Z] Finished install step (success) 10:09:20 INFO - [mozharness: 2016-10-07 17:09:20.057082Z] Running run-tests step. 10:09:20 INFO - Running pre-action listener: _resource_record_pre_action 10:09:20 INFO - Running main action method: run_tests 10:09:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:09:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:09:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:09:20 INFO - 2016-10-07 10:09:20.072 screenresolution[2208:15803] starting screenresolution argv=screenresolution get 10:09:20 INFO - 2016-10-07 10:09:20.074 screenresolution[2208:15803] Display 0: 1600x1200x32@60 10:09:20 INFO - 2016-10-07 10:09:20.080 screenresolution[2209:15805] starting screenresolution argv=screenresolution list 10:09:20 INFO - Available Modes on Display 0 10:09:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:09:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:09:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:09:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:09:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:09:20 INFO - Intel Iris: 10:09:20 INFO - Chipset Model: Intel Iris 10:09:20 INFO - Type: GPU 10:09:20 INFO - Bus: Built-In 10:09:20 INFO - VRAM (Dynamic, Max): 1536 MB 10:09:20 INFO - Vendor: Intel (0x8086) 10:09:20 INFO - Device ID: 0x0a2e 10:09:20 INFO - Revision ID: 0x0009 10:09:20 INFO - Displays: 10:09:20 INFO - Display: 10:09:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:09:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:09:20 INFO - Display Serial Number: 1600x1200 60 10:09:20 INFO - Main Display: Yes 10:09:20 INFO - Mirror: Off 10:09:20 INFO - Online: Yes 10:09:20 INFO - Rotation: Supported 10:09:20 INFO - Return code: 0 10:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:09:20 INFO - Python 2.7.3 10:09:20 INFO - Return code: 0 10:09:20 INFO - grabbing minidump binary from tooltool 10:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:09:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ef9d30>, '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 0x105d1fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ef1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:09:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:09:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:09:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:09:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:09:20 INFO - Return code: 0 10:09:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:09:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:09:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:09:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:09:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:09:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0035', '--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 10:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0035 --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 10:09:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gjcrtBDeuH/Render', 10:09:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:09:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:09:20 INFO - 'HOME': '/Users/cltbld', 10:09:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:09:20 INFO - 'LOGNAME': 'cltbld', 10:09:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:09:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:09:20 INFO - 'MOZ_NO_REMOTE': '1', 10:09:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:09:20 INFO - 'NO_EM_RESTART': '1', 10:09:20 INFO - 'PAGER': '/bin/cat', 10:09:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:09:20 INFO - 'PWD': '/builds/slave/test', 10:09:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:09:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:09:20 INFO - 'SHELL': '/bin/bash', 10:09:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.IIslSXrNNi/Listeners', 10:09:20 INFO - 'TMPDIR': '/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/', 10:09:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:09:20 INFO - 'USER': 'cltbld', 10:09:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:09:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:09:20 INFO - 'XPC_FLAGS': '0x0', 10:09:20 INFO - 'XPC_SERVICE_NAME': '0', 10:09:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:09:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0035', '--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 10:09:20 INFO - mozversion application_buildid: 20161007072500 10:09:20 INFO - mozversion application_changeset: 49fe455cac957808ed4a5d1685c3a1938dac1d31 10:09:20 INFO - mozversion application_display_name: Nightly 10:09:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:09:20 INFO - mozversion application_name: Firefox 10:09:20 INFO - mozversion application_remotingname: firefox 10:09:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:09:20 INFO - mozversion application_vendor: Mozilla 10:09:20 INFO - mozversion application_version: 52.0a1 10:09:20 INFO - mozversion platform_buildid: 20161007072500 10:09:20 INFO - mozversion platform_changeset: 49fe455cac957808ed4a5d1685c3a1938dac1d31 10:09:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:09:20 INFO - mozversion platform_version: 52.0a1 10:09:20 INFO - using testdate: 1475860160 10:09:20 INFO - actual date: 1475860160 10:09:20 INFO - starting webserver on 'localhost:52500' 10:09:20 INFO - SUITE-START | Running 2 tests 10:09:20 INFO - TEST-START | dromaeo_css 10:09:20 INFO - operating with platform_type : mac_ 10:09:20 INFO - Initialising browser for dromaeo_css test... 10:09:20 INFO - TEST-INFO | started process 2219 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpptPON0/profile http://localhost:52500/getInfo.html) 10:09:23 INFO - PROCESS | 2219 | 2016-10-07 10:09:23.141 plugin-container[2221:15963] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f3f, name = 'com.apple.tsm.portname' 10:09:23 INFO - PROCESS | 2219 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:09:23 INFO - PROCESS | 2219 | 2016-10-07 10:09:23.145 plugin-container[2221:15963] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a1f, name = 'com.apple.CFPasteboardClient' 10:09:23 INFO - PROCESS | 2219 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:09:23 INFO - PROCESS | 2219 | 2016-10-07 10:09:23.145 plugin-container[2221:15963] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:09:23 INFO - PROCESS | 2219 | __metrics Screen width/height:1600/1200 10:09:23 INFO - PROCESS | 2219 | colorDepth:24 10:09:23 INFO - PROCESS | 2219 | Browser inner width/height: 1024/689 10:09:23 INFO - PROCESS | 2219 | __metrics 10:09:23 ERROR - PROCESS | 2219 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 10:09:24 INFO - TEST-INFO | 2219: exit 0 10:09:24 INFO - Browser initialized. 10:09:24 INFO - Running cycle 1/1 for dromaeo_css test... 10:09:24 INFO - TEST-INFO | started process 2222 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpptPON0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:09:26 INFO - PROCESS | 2222 | 2016-10-07 10:09:26.570 plugin-container[2224:16078] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x891f, name = 'com.apple.tsm.portname' 10:09:26 INFO - PROCESS | 2222 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:09:26 INFO - PROCESS | 2222 | 2016-10-07 10:09:26.576 plugin-container[2224:16078] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9013, name = 'com.apple.CFPasteboardClient' 10:09:26 INFO - PROCESS | 2222 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:09:26 INFO - PROCESS | 2222 | 2016-10-07 10:09:26.576 plugin-container[2224:16078] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:09:36 INFO - PROCESS | 2222 | RSS: Main: 239026176 10:09:36 INFO - PROCESS | 2222 | 10:10:25 INFO - PROCESS | 2222 | 1475860225831 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] 10:12:39 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:52500/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52500/tests/dromaeo/cssquery-ext.html) 10:12:41 INFO - PROCESS | 2222 | RSS: Main: 252452864 10:12:41 INFO - PROCESS | 2222 | 10:15:43 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:52500/tests/dromaeo/cssquery-ext.html (next: http://localhost:52500/tests/dromaeo/cssquery-jquery.html) 10:15:44 INFO - PROCESS | 2222 | RSS: Main: 264790016 10:15:44 INFO - PROCESS | 2222 | 10:18:46 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:52500/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52500/tests/dromaeo/cssquery-mootools.html) 10:18:46 INFO - PROCESS | 2222 | RSS: Main: 269623296 10:18:46 INFO - PROCESS | 2222 | 10:21:48 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:52500/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52500/tests/dromaeo/cssquery-prototype.html) 10:21:49 INFO - PROCESS | 2222 | RSS: Main: 269398016 10:21:49 INFO - PROCESS | 2222 | 10:24:52 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:52500/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52500/tests/dromaeo/cssquery-yui.html) 10:24:52 INFO - PROCESS | 2222 | RSS: Main: 274608128 10:24:52 INFO - PROCESS | 2222 | 10:27:55 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:52500/tests/dromaeo/cssquery-yui.html (next: http://localhost:52500/tests/dromaeo/cssquery-dojo.html) 10:27:55 INFO - PROCESS | 2222 | RSS: Main: 277479424 10:27:55 INFO - PROCESS | 2222 | 10:27:55 INFO - PROCESS | 2222 | __start_tp_report 10:27:55 INFO - PROCESS | 2222 | _x_x_mozilla_page_load 10:27:55 INFO - PROCESS | 2222 | _x_x_mozilla_page_load_details 10:27:55 INFO - PROCESS | 2222 | |i|pagename|runs| 10:27:55 INFO - PROCESS | 2222 | |0;dojo.html;3147.4806656901615;3315.270640459098;3360.714339281161;3372.8988130356065;3377.273886114486;5610.158476228567;5722.341930677968;5736.368999410067;5782.826515204545;5855.824325270249;5635.915461268084;5781.959247335478;5828.621139625921;5830.970845145779;5912.201852749878;5230;5233;5242.108841496935;5380.91928621071;5406.91889621656;5349.117395629716;5388.946110538884;5401.594880383967;5414.864628384283;5452.154915988009;5150.948490515084;5230.712310822903;5301.416844147141;5305.920411193835;5357.303550538444;5250.684958902478;5261.158214685632;5279.841604751864;5302.708351040691;5308.6549374290935;5154;5178.741062946875;5179.637425380187;5213.947860521384;5229.189475631283;5539.806106786243;5741.569382296345;5758.424157584208;5764.913526297109;5765.250517432749;6084.5132389408745;6110.589135957139;6143.051335359052;6147.354527774609;6174.38256174379;6106.236720409949;6134.4978165938865;6156.168917196166;6181.907271390933;6186.412290832363;5903.203067585821;5916.911246331266;5924.289085309791;5925.851853703605;5936.257967754031;6104.701693046543;6129.939558357133;6130.000698177752;6298.086777417248;6300.180976473029;6110.022396416552;6133;6152.169457123231;6153.661608588708;6162.630242185483;6159.599626024384;6172.660503672341;6180.690965451709;6200.751969921243;6252.468540174136;4911.8280860169725;6059.424354686298;6059.878802423927;6100.328963813977;6123.343628574293;4479.193745125844;5981.79063732776;6138;6184.226971628546;6208.968955155286;4025.577314382006;4872.610191184696;4884.9511504884495;4899.926501102486;4945.653804233741;3625.619309972468;4305.677074219446;4322.200392927319;4353.651707863363;4393.20922234001;5781.306243250837;5831.854203644943;5839.591228613956;5841.795537156264;5918.408159184133;5186.974065129651;6130.325664176937;6188.1027251048345;6236.688165591702;6246.937530624727;5699.74351154199;5838.2702162229725;5853.326867410217;5916.408359164136;5942.435468630473;5452.890942181134;5472.671639701631;5482.945170548243;5534.52956498694;5542.418046105182;6378.521610879296;6395.456386207132;6396.5522413431545;6397.552171348148;6445.838854028687;6058.666773327509;6206.441420272197;6219.751209951552;6221.440070393686;6252.531060170596;5329.706866122246;6150.753969841336;6236.656983865931;6245.5628106032145;6247.250329960434;6090.573659843769;6102.298235702773;6103.145559621567;6110.358412366638;6130.846728831815;6095.116208149882;6101.725422356093;6167.907481387693;6182.412670796267;6194.132821404917;5975.521958243417;5999.160117583455;6019.849503762441;6020.036794112921;6047.183630209865;5985.970070149796;6015.759369625341;6040.818775436744;6057.333693293646;6065.545084118797;5825.300963884191;5830.737616807169;5933.821985340447;5958.731857066529;6000.759969601341;6062.42406971337;6113.962834745811;6116.327204007466;6118.7714669719035;6122.703114648804;5976.910346344721;6013.428724271187;6028.487578555696;6051.667158306159;6052.485538729257 10:27:55 INFO - PROCESS | 2222 | |1;ext.html;512.4772731813549;521.3483146067416;531.8298144593732;547.3759913698384;560.0507140397026;29602.407951840978;40702;40730.18539629206;40731.18537629246;40813.79593102038;41235.58764412355;41628.37557436641;41909.74270771874;41937.580624193746;41945;9581.952090239574;9747.171490423323;9777.511124443785;9797.167240784542;9799.608015679365;9673.129418352348;9754.975727548612;9772.657956971507;9774.51127443625;9793.657221997231;9738.561764720569;9760.365576237557;9768.07203315684;9782.706518804447;9788.657396991106;9726.951365243163;9737.221022318197;9762.267829912786;9764.365316254421;9790.167835733972;9645.324827262095;9702.320837541374;9739.853902191402;9750.951245243728;9764.609415623367;35925.82037089798;36163.276734465166;36205.81897090524;36289.81855090734;36304.45543316852;3281.7210537104374;3764;4015.437838702584;4029.959700403017;4030.2745505808944;30333.938312158967;31334.52998205006;31614;31857;32109.1972700682;2830.787690923189;2836.801423900328;2901.970980290191;3190.872365105393;3345.7156141727983;482138;494687.9999999964;494830;497700;509030;60193.69903150456;60372.69813650991;60377.69811150916;60802.39197607967;61188.77622447526;59360.703196483744;59895;59978.400215998154;60052.39947600556;60147;13865.168089914436;15798.9210053949;15965.760513592073;16044.598885027968;16155.515334539983;12207.450664720109;12367.93816030914;12391.814122788166;12399.690007749698;12437.315947622968;16077.839221607634;17318.96086234805;17335.046572438638;17346.566335841704;17375.73936390955;5872.794452194238;6812.523123381415;6831.6242606656115;6951.270116637781;7022.12223472066;762.359617920938;825.2861274997205;841.146236569882;968.2883080935507;1109.9556017759198;28472.715272847006;28915.710842891724;30437.543436848464;30538.847305763775;30927;920.7283851263893;924.0805398628273;929.809389075238;1009.6062535611118;1058.4866339825178;15012.699746005019;15563.564384150463;15577.753779697598;15701.764473532907;15932.36270549165;678377;713749;734871;739765;940937;58284.125738113966;58720.41279587235;58836.41163588395;58879.41120588825;58970.410295896494;1219.5426714981882;1297.4096785962554;1343.3014832287156;1343.482759137739;1361.3737680666807;27683.615819208557;27995.58006629943;31267.37465250728;31470.527942081346;32136.87520936756;47896.521034789206;51233.97532049413;51269.743651282995;51434.48565514447;51793.7410312946;596790;598373;601048;601962;602671;26928.865355673097;27274.727252727218;27337.45325093447;27339.58990615182;27350.72649273482;38726;46340.536594633624;46450.76774616105;47675.046499070515;47728.761356193;32329.030129096165;38697.03257418587;38853.417198741474;39874.601253987086;40084.398734019596;29037.27406814762;38068.238635227695;38123;39369.22838472333;39581.604183958945;34342;37163.628363716016;38067.238655227295;38333;39714.60285397109;33008.83495582603;33157.66842331642;34251.314973700886;34587.82706086453;34807.47788783221;22896.084156633548;25419.745802541736;25428.491430171664;25550.23349299524;25844.483110338064 10:27:55 INFO - PROCESS | 2222 | |2;jquery.html;363.3695538241152;367.7940353402094;370.7830918912436;384.22578504313793;386.3007955600362;19398.612027759453;19923.40229793107;20031.899840500777;20666.07002684881;20863.687044694343;11348.09215262779;11875.049996000322;12036.81944770829;12042.217255878362;12048.337341446238;4888.877778055541;4912.435069966946;5293.417724050351;5671.63134396265;5761.279840019997;3936.566977632458;4152.709310348277;4460;4840;6150.077488376734;5567.610267281292;6031.0048841941025;6236.095766113934;6237.625742455444;6243.843903902416;5958.731857066442;6152.107944348045;6156.38436156383;6203.4416902479;6205.9379406206035;5196.506331898464;5397.325334333208;6026.969865150646;6045.909311360289;6046.2744470663365;20438.897805511027;20586.691199632016;20825.791742082536;23665.526689466285;24830.5033899321;1810.837024667773;2163.167180635451;2226.576950379439;2476.603743401065;2919.8102123361914;9668.661596844147;9901.603935842557;10252.538635761408;10278.903503968042;10455;1838.4117082533594;1919.5872887329292;1924.288013435038;1928.6817675083594;1951.1219951022097;98822.50588747082;119392.40303798512;120542;122528.38735806264;128790;11095.72260693489;11309.943450282695;11392.715182120348;11542.769144617228;11722.824157637642;14478.565643030515;14491.710165796625;14500.347484363228;14524;14555.19946402958;8089.878651820228;8375.994880614244;8437;8501;8523;8198.508089514648;8214.089362397654;8296.211859873423;8406.369522285853;8474.364422668325;3870.806459677005;4474.619657329164;4590.839320623762;4595.724256544618;4604.148232576984;1543.3672194400242;1631.77970973917;1659.6099916519609;1905.1522072677526;1967.7799764146034;909.9363044586815;909.9909000910038;926.8285367207088;961.8749562556962;983.7899383758017;16339.813736321541;20414.877181754848;20912.68630970537;21197.36407907765;21299.8935005324;873.2189618950058;900.7703035725979;915.6108653822099;959.0505399654292;1022.0954455306958;10682.145428365711;10891.782164356828;11194.888051119548;11239.719007024889;11251.606193783178;571024.6784602083;581608;591693;595368;595448;100063.49968250257;100710.49644751729;113704;125902.37048814697;127040.0943985841;974.6978436684509;998.3560603410905;1019.5208252121491;1024.3956065920993;1025.9127974122134;18695;19613.921234332247;19658.8034119657;19672;19687.21251149938;50857;51026;51545.22682159846;51913.48086519087;52308;62487.37512624815;78861.60569197117;79415.60292198733;79534;83016.58491707503;5704.344000439836;6609.933900660932;7254.310840470147;8135.877961830695;8188.344932405274;7214.494985350975;9038.793897768288;12582.937085314516;12669.556565520163;12931.806022909475;10665.466726663792;11360.602378917029;11369.31784092957;11505.884941150482;11507.884921151017;10864.945675271572;11106.555737770723;11174.441277936234;11342;11456.541738330707;10470;11192.216544841784;11612.954834064636;11615.24500907472;11705.829417058567;7880.605969701606;8051.35589152878;8069.515829050276;8147.959260203661;8164.714235001747;6276.372362763687;7763.883541746765;7851.332636725942;9439.811203776024;11610.6516804496 10:27:55 INFO - PROCESS | 2222 | |3;mootools.html;1464.7070585882823;1529.1283968138162;1725.8954269267663;1833.4774589242068;1851.8148185181476;7960.442769006172;8212.507249565031;8545.61544730487;9080.50057246852;9096.317776166781;8494.320454363651;8821.250193733524;8827.117288271169;8934.195922366986;8948.328875334344;2346.1905642553334;2369.5379401016808;2369.95260094798;2376.4058985253687;2384.7138343398815;2334.6381310896836;2359.1507057459385;2381.154690085012;2382.19005538117;2391.6412538119334;1992.3026940570828;2031.9796802032013;2154.278316763878;2265.5582161478437;2339.5554844579474;2315.617923042704;2326.569584626841;2327.8021368183727;2332.650102484624;2334.4747431827705;1975.9506012349661;2348.342464110035;2351.294611616508;2354.2348736660483;2355.658429527726;8829.69096081634;9030.187283144549;9032.638694452215;9034.819303613891;9092.772680683036;5267;5429.185622156669;5432.592555558309;5433.347998240197;5460.34475862899;3441.587009558844;3498.1954150545516;3620;3631.94552081719;3642.8360723767496;1024.2011231239644;1059.8728152621734;1066.4188017530464;1083.8753543342539;1084.0839490630483;11733.237339572986;11739.882601173964;11830.881691183064;11861.881381186251;11864.991475724573;4561.498235194126;4621.682820396171;4794.161021821167;4805.3512775775525;4809.014152098812;9939.900600994042;9999.750006249757;10033.648822291185;10036.146927511098;10043.69868903934;5379.462053794668;5387.138057910715;5393.946060539344;5402.972985135128;5413.188021796762;4409.823607055682;4563.383943167696;4756.381670382828;4926.901461970812;4972.776225069881;3867.3812190049457;3923.352646813244;3994.3009973254566;4023.7988100594853;4028.8992775180855;1275.1074248026418;1290.3548225887057;1296.5397283964057;1300.6293206436121;1309.803529470568;805.7461899501639;807.0517142357706;838.4131108224267;889.4440974391006;891.0910870911633;5533.280673512418;5649.887002259932;5696.401877802854;5764.798232061858;5973.880522389528;409.84016233668893;421.9746815191098;424.8279446824041;429.87533615251226;440.89418539550275;3571.94642080369;3644.963550364462;3661.9267614647556;3754.3617585010065;3796.449514820391;9053.185213330831;10564;10667.466626668636;10703.197260205516;10707.196960228013;10608.787824243473;10652.573897044187;10655.25413221067;10663.73340666474;10675.359478431164;8132;8195.71315003972;8196.34429245659;8203.794905127419;8278.875816862752;5626.493615574618;5667.914981275367;5724.656520608777;5745.482906538432;5806.012977793701;9655.468949207861;9950.094665274393;9962.50187490608;9998.250131240331;10001.14990225839;10038.498075096362;10063.446510441703;10088.192944564564;10179.389236645826;10345.586176553155;6843.520953533404;6864.21061577925;7127.8574428512175;7404.148522919718;7562.130355009244;8265.793355165928;8399.202075802788;8407;8429.789255268668;8442.36682248846;7455.4035677146785;7589.43079269046;7594.468387212842;7649.579273140031;7727.845443091219;7318.560886346836;7401.629918504161;7408.222136675571;7559.1306999695735;7604.087509498895;6899.551529150589;7030.824229394306;7068.434525237866;7074.610896400747;7085.858282834418;4783.212467211744;4915.0415668944215;4939.60483161339;4953.083679519301;4958.404991400911;4821.421429428351;4906.656534042583;4923.606111510999;5021;5164.173732202829 10:27:55 INFO - PROCESS | 2222 | |4;prototype.html;261.48096029381674;275.630654922404;287.6778008630333;300.3482443098476;315.2748678040509;5191.546367017241;5227.503387178222;5358.919616205751;5384.7307634618255;5511.779528818847;4424;5017.473165317644;5198.428172900978;5208.7395630218525;5333.280007199027;3581.641835816417;4156.960759810047;4158.812853421603;4176.895577610554;4184.623383895449;3948.565657777642;4135.627793498585;4174.039970806701;4197.7271477354025;4228.97885510572;3389.474631432132;4082.5305089914596;4088.9386659199986;4120.031792528754;4154.896127596804;4127.834886604547;4137.97931010343;4154.376843473473;4155.231282212785;4163.542010378856;3312.801231926092;3601.621829707869;3616.529851119364;3632.1827588792576;3642.1440961374055;4525.751083690396;4543.954560454419;4653.837115700968;4696.342512048282;5209.374875014984;4680.508546602626;4704.741239231841;4712.65689278554;4713.222318317474;4722.409698787652;4686.484486706494;5089.643724939256;5238.642610825106;5608.6073974821775;5678.716064196774;3711.1258814298876;3829.248602154818;3870.1872606752618;3937.7440466369594;3975.1652153047894;5042.621803364762;5214.634975551675;5377.892442151174;5742.483176514092;5971.581989260753;3775.9244815103543;4021.130174468886;4022.7988600569856;4023.436718859362;4157.459530261107;3926.234384295035;4057.736247143926;4066.0038290618986;4077.89805254871;4134.91730165401;4686.437627484724;4690.273007683814;4715.646326525524;4730.834420795256;4786.114568804782;5696.177223288508;5699.430056994267;5702.7433765480655;5775.220345253421;5797.565182611321;1071.7106381277167;1125.6172901213627;1188.7087663522493;1344.5562964221783;1379.9172049677052;903.0878812399524;911.166282851197;930.6603089872148;945.1729736480579;949.9145076943108;4513.526079761577;4762.904741905142;5215.400228973641;5222.321098257202;5242.61070816234;5098.745062746848;5592.552595792326;5746.913796293059;5817.556626216914;5826.82519524415;4944.505549445099;5135.818761684759;5263.552598029134;5268.236105764643;5303.893922121536;2186.7047948526747;2209.458682622768;2545.694516657976;2549.2352294312004;2563.3207200091992;4157.708960372805;4247.312364620047;4840.491748366441;4884.438289596671;5011.724355160502;4040.919181616351;4685.4143232095985;4947.413125484068;4998.875028124253;5020.472850350734;4195.685323600803;5005.449400565934;5013;5043.596512279082;5086.669366491166;4117.464729585135;4383.452068491439;4765.904681906273;4886.92669609949;4889.804407823647;3904.3255370071593;3989.740666856645;4062.3297155968935;4259.680523960654;4690.906181876275;4000.879973600797;4159.691371288964;4214.873553793391;4466.64266858657;4508.594226519629;3163.5254711793414;3259.4947783093658;3463.3202896595635;3475.8957231283102;3490.6909908784205;4179.519355274182;4662.836800711959;4720.268358404453;4829.637777166797;4925.310456536159;4741.383620129361;4771.117343291502;5414.835810300804;5428.45715428454;5749.54003679713;5056.544910958031;5744.569157313134;5780.826575202751;5819.6508209507565;5821.679807610622;5372;5487.588430867621;5536.584756143225;5569.605069820016;5623.694285343154;5220.295260139833;5254;5287.814926477555;5756.971215143897;5760.8271751847515;4822.68652537584;5162.741862906914;5363.0346537622045;5633.408632029313;5662.009148399096 10:27:55 INFO - PROCESS | 2222 | |5;yui.html;679.51414738462;690.3924546399168;696.8153439338575;749.030006142046;793.515955267287;12252;14569.344379502909;15220.847791522081;15903.12532810695;16124.919375403122;14370.712585748279;14391.568252952427;14464.855351446482;14498.710025799477;14546.345414456347;655.7311502284065;681.0295329155957;814.2590242878981;824.9092599814015;833.791552111972;841.1210285251926;845.8773477845708;846.191886748154;847.3517758914436;847.9406441549094;884.2395539835736;885.2740752582885;885.7032893980492;886.4193952960821;886.8315020146151;873.5064688451005;878.7363790862747;879.6525372477868;879.7844528090659;880.3573391424233;637.9011253255753;650.5348675696852;651.1274891645218;653.2944420026407;654.7871941618993;14450.855491445056;14473.059251148747;14485.42058317666;14551.636209094751;14579.635509112251;14161.291935403291;14182.574522764333;14236.145831250158;14314.785278220836;14324.14055156694;11618.593349232737;11622.593209237637;11717.53129874804;11781.410929453494;11881.34652594107;3720.1443667956523;3725.18046029873;3775.169462718198;3787.3182827091114;3799.25914446683;112064;112882;113553.43223283913;116082.41958790236;117466.23800642912;10281.228907831794;10316.896831031743;10984.395858227874;11085.94457027726;11270.436478176058;19933.800661993195;20052.799472005387;21466.57066858654;22115.447113822283;22171.004609585216;7272;7334.3032411920785;7396.815079623052;7454.85090298191;7487.887681684779;4299.398084268205;4367.890802729958;4393.626541743987;4399.527913596315;4496.1906856765445;3463.9434972333174;3574.9285014299567;3579.785212887235;3585.1933315004435;3586.8027258501033;627.2723640576909;633.5596760251673;644.5359341274275;659.2682122843639;662.4270006444391;545.664416383921;565.3074983145614;644.3298969072113;665.896785998171;669.6383952665603;8511.616977236039;8943.329250306253;9146.222571081533;9160.22138118254;9395.57719902606;615.5937081526171;654.6890227142069;662.2450406536552;665.4111111666114;669.1702289161404;4370.104128653618;4419.867403977886;4607.124646317189;4692.929606055912;4753.265058253713;130161;151329;154001;156339.43660563248;160395.39604603805;84153.31693366099;110891;113918.43040784742;114064;116410.41794790972;79905;97221.02778972262;102971;104645;108256.4587177059;7608.31525162738;8129.715459958873;8157.306628936607;8820.162084601952;8957.865632015655;53993.730031349594;61000;61251.69374153101;61896.07155892575;64041;90612.09387906037;93594.53202733943;94841.5257923706;95201.52399237959;95850;11621.477033533341;11644.475998579916;11698.70753231176;12141.878581214074;12344.753104937672;12677.112602117762;12890.654126629834;13000.95992320631;13151.079424440197;13505.459781609019;11918.344491053076;11996.591933582044;12046.096542759504;12121.393930303273;12159.331236782062;11994.580189693319;12070.827251094886;12089.911907928328;12165.57420490314;12594.496220151092;11709.121815863675;11890.681003583953;11923.224990375598;11982.161248712506;12400.937995309965;9891.554880030271;9917.752056198653;10081.747956300858;10118.696439106838;10328.328658637165;9350.485723285285;10037.656153493584;10094.343867648578;10227;10341.586336546454 10:27:55 INFO - PROCESS | 2222 | __end_tp_report 10:27:55 INFO - PROCESS | 2222 | __start_cc_report 10:27:55 INFO - PROCESS | 2222 | _x_x_mozilla_cycle_collect,362 10:27:55 INFO - PROCESS | 2222 | __end_cc_report 10:27:55 INFO - PROCESS | 2222 | __startTimestamp1475861275825__endTimestamp 10:27:55 INFO - PROCESS | 2222 | 10:27:55 INFO - PROCESS | 2222 | ------- Summary: start ------- 10:27:55 INFO - PROCESS | 2222 | Number of tests: 6 10:27:55 INFO - PROCESS | 2222 | 10:27:55 INFO - PROCESS | 2222 | [#0] dojo.html Cycles:165 Average:5711.67 Median:5958.73 stddev:655.18 (11.0%) stddev-sans-first:625.55 10:27:55 INFO - PROCESS | 2222 | Values: 3147.5 3315.3 3360.7 3372.9 3377.3 5610.2 5722.3 5736.4 5782.8 5855.8 5635.9 5782.0 5828.6 5831.0 5912.2 5230.0 5233.0 5242.1 5380.9 5406.9 5349.1 5388.9 5401.6 5414.9 5452.2 5150.9 5230.7 5301.4 5305.9 5357.3 5250.7 5261.2 5279.8 5302.7 5308.7 5154.0 5178.7 5179.6 5213.9 5229.2 5539.8 5741.6 5758.4 5764.9 5765.3 6084.5 6110.6 6143.1 6147.4 6174.4 6106.2 6134.5 6156.2 6181.9 6186.4 5903.2 5916.9 5924.3 5925.9 5936.3 6104.7 6129.9 6130.0 6298.1 6300.2 6110.0 6133.0 6152.2 6153.7 6162.6 6159.6 6172.7 6180.7 6200.8 6252.5 4911.8 6059.4 6059.9 6100.3 6123.3 4479.2 5981.8 6138.0 6184.2 6209.0 4025.6 4872.6 4885.0 4899.9 4945.7 3625.6 4305.7 4322.2 4353.7 4393.2 5781.3 5831.9 5839.6 5841.8 5918.4 5187.0 6130.3 6188.1 6236.7 6246.9 5699.7 5838.3 5853.3 5916.4 5942.4 5452.9 5472.7 5482.9 5534.5 5542.4 6378.5 6395.5 6396.6 6397.6 6445.8 6058.7 6206.4 6219.8 6221.4 6252.5 5329.7 6150.8 6236.7 6245.6 6247.3 6090.6 6102.3 6103.1 6110.4 6130.8 6095.1 6101.7 6167.9 6182.4 6194.1 5975.5 5999.2 6019.8 6020.0 6047.2 5986.0 6015.8 6040.8 6057.3 6065.5 5825.3 5830.7 5933.8 5958.7 6000.8 6062.4 6114.0 6116.3 6118.8 6122.7 5976.9 6013.4 6028.5 6051.7 6052.5 10:27:55 INFO - PROCESS | 2222 | 10:27:55 INFO - PROCESS | 2222 | [#1] ext.html Cycles:180 Average:74046.98 Median:40716.09 stddev:169453.82 (416.2%) stddev-sans-first:169839.24 10:27:55 INFO - PROCESS | 2222 | Values: 512.5 521.3 531.8 547.4 560.1 29602.4 40702.0 40730.2 40731.2 40813.8 41235.6 41628.4 41909.7 41937.6 41945.0 9582.0 9747.2 9777.5 9797.2 9799.6 9673.1 9755.0 9772.7 9774.5 9793.7 9738.6 9760.4 9768.1 9782.7 9788.7 9727.0 9737.2 9762.3 9764.4 9790.2 9645.3 9702.3 9739.9 9751.0 9764.6 35925.8 36163.3 36205.8 36289.8 36304.5 3281.7 3764.0 4015.4 4030.0 4030.3 30333.9 31334.5 31614.0 31857.0 32109.2 2830.8 2836.8 2902.0 3190.9 3345.7 482138.0 494688.0 494830.0 497700.0 509030.0 60193.7 60372.7 60377.7 60802.4 61188.8 59360.7 59895.0 59978.4 60052.4 60147.0 13865.2 15798.9 15965.8 16044.6 16155.5 12207.5 12367.9 12391.8 12399.7 12437.3 16077.8 17319.0 17335.0 17346.6 17375.7 5872.8 6812.5 6831.6 6951.3 7022.1 762.4 825.3 841.1 968.3 1110.0 28472.7 28915.7 30437.5 30538.8 30927.0 920.7 924.1 929.8 1009.6 1058.5 15012.7 15563.6 15577.8 15701.8 15932.4 678377.0 713749.0 734871.0 739765.0 940937.0 58284.1 58720.4 58836.4 58879.4 58970.4 1219.5 1297.4 1343.3 1343.5 1361.4 27683.6 27995.6 31267.4 31470.5 32136.9 47896.5 51234.0 51269.7 51434.5 51793.7 596790.0 598373.0 601048.0 601962.0 602671.0 26928.9 27274.7 27337.5 27339.6 27350.7 38726.0 46340.5 46450.8 47675.0 47728.8 32329.0 38697.0 38853.4 39874.6 40084.4 29037.3 38068.2 38123.0 39369.2 39581.6 34342.0 37163.6 38067.2 38333.0 39714.6 33008.8 33157.7 34251.3 34587.8 34807.5 22896.1 25419.7 25428.5 25550.2 25844.5 10:27:55 INFO - PROCESS | 2222 | 10:27:55 INFO - PROCESS | 2222 | [#2] jquery.html Cycles:180 Average:33728.96 Median:365.58 stddev:97852.27 (26766.2%) stddev-sans-first:98094.69 10:27:55 INFO - PROCESS | 2222 | Values: 363.4 367.8 370.8 384.2 386.3 19398.6 19923.4 20031.9 20666.1 20863.7 11348.1 11875.0 12036.8 12042.2 12048.3 4888.9 4912.4 5293.4 5671.6 5761.3 3936.6 4152.7 4460.0 4840.0 6150.1 5567.6 6031.0 6236.1 6237.6 6243.8 5958.7 6152.1 6156.4 6203.4 6205.9 5196.5 5397.3 6027.0 6045.9 6046.3 20438.9 20586.7 20825.8 23665.5 24830.5 1810.8 2163.2 2226.6 2476.6 2919.8 9668.7 9901.6 10252.5 10278.9 10455.0 1838.4 1919.6 1924.3 1928.7 1951.1 98822.5 119392.4 120542.0 122528.4 128790.0 11095.7 11309.9 11392.7 11542.8 11722.8 14478.6 14491.7 14500.3 14524.0 14555.2 8089.9 8376.0 8437.0 8501.0 8523.0 8198.5 8214.1 8296.2 8406.4 8474.4 3870.8 4474.6 4590.8 4595.7 4604.1 1543.4 1631.8 1659.6 1905.2 1967.8 909.9 910.0 926.8 961.9 983.8 16339.8 20414.9 20912.7 21197.4 21299.9 873.2 900.8 915.6 959.1 1022.1 10682.1 10891.8 11194.9 11239.7 11251.6 571024.7 581608.0 591693.0 595368.0 595448.0 100063.5 100710.5 113704.0 125902.4 127040.1 974.7 998.4 1019.5 1024.4 1025.9 18695.0 19613.9 19658.8 19672.0 19687.2 50857.0 51026.0 51545.2 51913.5 52308.0 62487.4 78861.6 79415.6 79534.0 83016.6 5704.3 6609.9 7254.3 8135.9 8188.3 7214.5 9038.8 12582.9 12669.6 12931.8 10665.5 11360.6 11369.3 11505.9 11507.9 10864.9 11106.6 11174.4 11342.0 11456.5 10470.0 11192.2 11613.0 11615.2 11705.8 7880.6 8051.4 8069.5 8148.0 8164.7 6276.4 7763.9 7851.3 9439.8 11610.7 10:27:55 INFO - PROCESS | 2222 | 10:27:55 INFO - PROCESS | 2222 | [#3] mootools.html Cycles:180 Average:5685.74 Median:4807.18 stddev:3234.17 (67.3%) stddev-sans-first:3227.69 10:27:55 INFO - PROCESS | 2222 | Values: 1464.7 1529.1 1725.9 1833.5 1851.8 7960.4 8212.5 8545.6 9080.5 9096.3 8494.3 8821.3 8827.1 8934.2 8948.3 2346.2 2369.5 2370.0 2376.4 2384.7 2334.6 2359.2 2381.2 2382.2 2391.6 1992.3 2032.0 2154.3 2265.6 2339.6 2315.6 2326.6 2327.8 2332.7 2334.5 1976.0 2348.3 2351.3 2354.2 2355.7 8829.7 9030.2 9032.6 9034.8 9092.8 5267.0 5429.2 5432.6 5433.3 5460.3 3441.6 3498.2 3620.0 3631.9 3642.8 1024.2 1059.9 1066.4 1083.9 1084.1 11733.2 11739.9 11830.9 11861.9 11865.0 4561.5 4621.7 4794.2 4805.4 4809.0 9939.9 9999.8 10033.6 10036.1 10043.7 5379.5 5387.1 5393.9 5403.0 5413.2 4409.8 4563.4 4756.4 4926.9 4972.8 3867.4 3923.4 3994.3 4023.8 4028.9 1275.1 1290.4 1296.5 1300.6 1309.8 805.7 807.1 838.4 889.4 891.1 5533.3 5649.9 5696.4 5764.8 5973.9 409.8 422.0 424.8 429.9 440.9 3571.9 3645.0 3661.9 3754.4 3796.4 9053.2 10564.0 10667.5 10703.2 10707.2 10608.8 10652.6 10655.3 10663.7 10675.4 8132.0 8195.7 8196.3 8203.8 8278.9 5626.5 5667.9 5724.7 5745.5 5806.0 9655.5 9950.1 9962.5 9998.3 10001.1 10038.5 10063.4 10088.2 10179.4 10345.6 6843.5 6864.2 7127.9 7404.1 7562.1 8265.8 8399.2 8407.0 8429.8 8442.4 7455.4 7589.4 7594.5 7649.6 7727.8 7318.6 7401.6 7408.2 7559.1 7604.1 6899.6 7030.8 7068.4 7074.6 7085.9 4783.2 4915.0 4939.6 4953.1 4958.4 4821.4 4906.7 4923.6 5021.0 5164.2 10:27:55 INFO - PROCESS | 2222 | 10:27:55 INFO - PROCESS | 2222 | [#4] prototype.html Cycles:180 Average:4330.86 Median:4712.94 stddev:1308.09 (27.8%) stddev-sans-first:1275.60 10:27:55 INFO - PROCESS | 2222 | Values: 261.5 275.6 287.7 300.3 315.3 5191.5 5227.5 5358.9 5384.7 5511.8 4424.0 5017.5 5198.4 5208.7 5333.3 3581.6 4157.0 4158.8 4176.9 4184.6 3948.6 4135.6 4174.0 4197.7 4229.0 3389.5 4082.5 4088.9 4120.0 4154.9 4127.8 4138.0 4154.4 4155.2 4163.5 3312.8 3601.6 3616.5 3632.2 3642.1 4525.8 4544.0 4653.8 4696.3 5209.4 4680.5 4704.7 4712.7 4713.2 4722.4 4686.5 5089.6 5238.6 5608.6 5678.7 3711.1 3829.2 3870.2 3937.7 3975.2 5042.6 5214.6 5377.9 5742.5 5971.6 3775.9 4021.1 4022.8 4023.4 4157.5 3926.2 4057.7 4066.0 4077.9 4134.9 4686.4 4690.3 4715.6 4730.8 4786.1 5696.2 5699.4 5702.7 5775.2 5797.6 1071.7 1125.6 1188.7 1344.6 1379.9 903.1 911.2 930.7 945.2 949.9 4513.5 4762.9 5215.4 5222.3 5242.6 5098.7 5592.6 5746.9 5817.6 5826.8 4944.5 5135.8 5263.6 5268.2 5303.9 2186.7 2209.5 2545.7 2549.2 2563.3 4157.7 4247.3 4840.5 4884.4 5011.7 4040.9 4685.4 4947.4 4998.9 5020.5 4195.7 5005.4 5013.0 5043.6 5086.7 4117.5 4383.5 4765.9 4886.9 4889.8 3904.3 3989.7 4062.3 4259.7 4690.9 4000.9 4159.7 4214.9 4466.6 4508.6 3163.5 3259.5 3463.3 3475.9 3490.7 4179.5 4662.8 4720.3 4829.6 4925.3 4741.4 4771.1 5414.8 5428.5 5749.5 5056.5 5744.6 5780.8 5819.7 5821.7 5372.0 5487.6 5536.6 5569.6 5623.7 5220.3 5254.0 5287.8 5757.0 5760.8 4822.7 5162.7 5363.0 5633.4 5662.0 10:27:55 INFO - PROCESS | 2222 | 10:27:55 INFO - PROCESS | 2222 | [#5] yui.html Cycles:180 Average:23788.87 Median:3750.17 stddev:38241.30 (1019.7%) stddev-sans-first:38309.21 10:27:55 INFO - PROCESS | 2222 | Values: 679.5 690.4 696.8 749.0 793.5 12252.0 14569.3 15220.8 15903.1 16124.9 14370.7 14391.6 14464.9 14498.7 14546.3 655.7 681.0 814.3 824.9 833.8 841.1 845.9 846.2 847.4 847.9 884.2 885.3 885.7 886.4 886.8 873.5 878.7 879.7 879.8 880.4 637.9 650.5 651.1 653.3 654.8 14450.9 14473.1 14485.4 14551.6 14579.6 14161.3 14182.6 14236.1 14314.8 14324.1 11618.6 11622.6 11717.5 11781.4 11881.3 3720.1 3725.2 3775.2 3787.3 3799.3 112064.0 112882.0 113553.4 116082.4 117466.2 10281.2 10316.9 10984.4 11085.9 11270.4 19933.8 20052.8 21466.6 22115.4 22171.0 7272.0 7334.3 7396.8 7454.9 7487.9 4299.4 4367.9 4393.6 4399.5 4496.2 3463.9 3574.9 3579.8 3585.2 3586.8 627.3 633.6 644.5 659.3 662.4 545.7 565.3 644.3 665.9 669.6 8511.6 8943.3 9146.2 9160.2 9395.6 615.6 654.7 662.2 665.4 669.2 4370.1 4419.9 4607.1 4692.9 4753.3 130161.0 151329.0 154001.0 156339.4 160395.4 84153.3 110891.0 113918.4 114064.0 116410.4 79905.0 97221.0 102971.0 104645.0 108256.5 7608.3 8129.7 8157.3 8820.2 8957.9 53993.7 61000.0 61251.7 61896.1 64041.0 90612.1 93594.5 94841.5 95201.5 95850.0 11621.5 11644.5 11698.7 12141.9 12344.8 12677.1 12890.7 13001.0 13151.1 13505.5 11918.3 11996.6 12046.1 12121.4 12159.3 11994.6 12070.8 12089.9 12165.6 12594.5 11709.1 11890.7 11923.2 11982.2 12400.9 9891.6 9917.8 10081.7 10118.7 10328.3 9350.5 10037.7 10094.3 10227.0 10341.6 10:27:55 INFO - PROCESS | 2222 | -------- Summary: end -------- 10:27:55 INFO - PROCESS | 2222 | 10:27:56 INFO - TEST-INFO | 2222: exit 0 10:27:56 INFO - TEST-OK | dromaeo_css | took 1115798ms 10:27:56 INFO - TEST-START | kraken 10:27:56 INFO - operating with platform_type : mac_ 10:27:56 INFO - Initialising browser for kraken test... 10:27:56 INFO - TEST-INFO | started process 2339 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpOEXpTF/profile http://localhost:52500/getInfo.html) 10:27:59 INFO - PROCESS | 2339 | 2016-10-07 10:27:59.215 plugin-container[2340:18167] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c27, name = 'com.apple.tsm.portname' 10:27:59 INFO - PROCESS | 2339 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:27:59 INFO - PROCESS | 2339 | 2016-10-07 10:27:59.221 plugin-container[2340:18167] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f1b, name = 'com.apple.CFPasteboardClient' 10:27:59 INFO - PROCESS | 2339 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:27:59 INFO - PROCESS | 2339 | 2016-10-07 10:27:59.222 plugin-container[2340:18167] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:27:59 INFO - PROCESS | 2339 | __metrics Screen width/height:1600/1200 10:27:59 INFO - PROCESS | 2339 | colorDepth:24 10:27:59 INFO - PROCESS | 2339 | Browser inner width/height: 1024/689 10:27:59 INFO - PROCESS | 2339 | __metrics 10:27:59 ERROR - PROCESS | 2339 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 10:28:00 INFO - TEST-INFO | 2339: exit 0 10:28:00 INFO - Browser initialized. 10:28:00 INFO - Running cycle 1/1 for kraken test... 10:28:00 INFO - TEST-INFO | started process 2341 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/tmpOEXpTF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:28:02 INFO - PROCESS | 2341 | 2016-10-07 10:28:02.386 plugin-container[2342:18277] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x451f, name = 'com.apple.tsm.portname' 10:28:02 INFO - PROCESS | 2341 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:28:02 INFO - PROCESS | 2341 | 2016-10-07 10:28:02.392 plugin-container[2342:18277] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9007, name = 'com.apple.CFPasteboardClient' 10:28:02 INFO - PROCESS | 2341 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:28:02 INFO - PROCESS | 2341 | 2016-10-07 10:28:02.392 plugin-container[2342:18277] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:28:12 INFO - PROCESS | 2341 | RSS: Main: 238886912 10:28:12 INFO - PROCESS | 2341 | 10:28:15 INFO - PROCESS | 2341 | Cycle 1(1): loaded http://localhost:52500/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52500/tests/kraken/driver.html?testName=audio-beat-detection) 10:28:16 INFO - PROCESS | 2341 | RSS: Main: 252428288 10:28:16 INFO - PROCESS | 2341 | 10:28:18 INFO - PROCESS | 2341 | Cycle 1(1): loaded http://localhost:52500/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52500/tests/kraken/driver.html?testName=audio-dft) 10:28:19 INFO - PROCESS | 2341 | RSS: Main: 260874240 10:28:19 INFO - PROCESS | 2341 | 10:28:23 INFO - PROCESS | 2341 | Cycle 1(1): loaded http://localhost:52500/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52500/tests/kraken/driver.html?testName=audio-fft) 10:28:23 INFO - PROCESS | 2341 | RSS: Main: 260767744 10:28:23 INFO - PROCESS | 2341 | 10:28:25 INFO - PROCESS | 2341 | Cycle 1(1): loaded http://localhost:52500/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52500/tests/kraken/driver.html?testName=audio-oscillator) 10:28:26 INFO - PROCESS | 2341 | RSS: Main: 261722112 10:28:26 INFO - PROCESS | 2341 | 10:28:28 INFO - PROCESS | 2341 | Cycle 1(1): loaded http://localhost:52500/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52500/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:28:28 INFO - PROCESS | 2341 | RSS: Main: 263286784 10:28:28 INFO - PROCESS | 2341 | 10:28:31 INFO - PROCESS | 2341 | Cycle 1(1): loaded http://localhost:52500/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52500/tests/kraken/driver.html?testName=imaging-darkroom) 10:28:32 INFO - PROCESS | 2341 | RSS: Main: 263921664 10:28:32 INFO - PROCESS | 2341 | 10:28:35 INFO - PROCESS | 2341 | Cycle 1(1): loaded http://localhost:52500/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52500/tests/kraken/driver.html?testName=imaging-desaturate) 10:28:36 INFO - PROCESS | 2341 | RSS: Main: 264200192 10:28:36 INFO - PROCESS | 2341 | 10:28:38 INFO - PROCESS | 2341 | Cycle 1(1): loaded http://localhost:52500/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52500/tests/kraken/driver.html?testName=json-parse-financial) 10:28:39 INFO - PROCESS | 2341 | RSS: Main: 264163328 10:28:39 INFO - PROCESS | 2341 | 10:28:41 INFO - PROCESS | 2341 | Cycle 1(1): loaded http://localhost:52500/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52500/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:28:41 INFO - PROCESS | 2341 | RSS: Main: 264036352 10:28:41 INFO - PROCESS | 2341 | 10:28:43 INFO - PROCESS | 2341 | Cycle 1(1): loaded http://localhost:52500/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52500/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:28:44 INFO - PROCESS | 2341 | RSS: Main: 264052736 10:28:44 INFO - PROCESS | 2341 | 10:28:46 INFO - PROCESS | 2341 | Cycle 1(1): loaded http://localhost:52500/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52500/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:28:47 INFO - PROCESS | 2341 | RSS: Main: 264093696 10:28:47 INFO - PROCESS | 2341 | 10:28:50 INFO - PROCESS | 2341 | Cycle 1(1): loaded http://localhost:52500/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:28:51 INFO - PROCESS | 2341 | RSS: Main: 264503296 10:28:51 INFO - PROCESS | 2341 | 10:28:53 INFO - PROCESS | 2341 | Cycle 1(1): loaded http://localhost:52500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:28:54 INFO - PROCESS | 2341 | RSS: Main: 264290304 10:28:54 INFO - PROCESS | 2341 | 10:28:56 INFO - PROCESS | 2341 | Cycle 1(1): loaded http://localhost:52500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52500/tests/kraken/driver.html?testName=ai-astar) 10:28:56 INFO - PROCESS | 2341 | RSS: Main: 265781248 10:28:56 INFO - PROCESS | 2341 | 10:28:56 INFO - PROCESS | 2341 | __start_tp_report 10:28:56 INFO - PROCESS | 2341 | _x_x_mozilla_page_load 10:28:56 INFO - PROCESS | 2341 | _x_x_mozilla_page_load_details 10:28:56 INFO - PROCESS | 2341 | |i|pagename|runs| 10:28:56 INFO - PROCESS | 2341 | |0;ai-astar;167;167;132;114;116;117;116;116;125;119 10:28:56 INFO - PROCESS | 2341 | |1;audio-beat-detection;153;118;116;153;119;117;130;144;166;106 10:28:56 INFO - PROCESS | 2341 | |2;audio-dft;209;259;244;267;271;199;197;197;199;202 10:28:56 INFO - PROCESS | 2341 | |3;audio-fft;84;59;61;88;61;61;62;60;87;76 10:28:56 INFO - PROCESS | 2341 | |4;audio-oscillator;82;74;116;99;98;83;90;71;66;89 10:28:56 INFO - PROCESS | 2341 | |5;imaging-gaussian-blur;91;103;92;77;133;121;92;88;133;89 10:28:56 INFO - PROCESS | 2341 | |6;imaging-darkroom;111;124;98;97;98;97;104;97;98;106 10:28:56 INFO - PROCESS | 2341 | |7;imaging-desaturate;91;103;91;124;109;91;93;93;90;92 10:28:56 INFO - PROCESS | 2341 | |8;json-parse-financial;57;55;56;54;56;59;56;58;59;57 10:28:56 INFO - PROCESS | 2341 | |9;json-stringify-tinderbox;71;83;104;105;76;70;73;71;76;74 10:28:56 INFO - PROCESS | 2341 | |10;stanford-crypto-aes;92;91;90;88;90;95;96;93;91;84 10:28:56 INFO - PROCESS | 2341 | |11;stanford-crypto-ccm;147;148;151;157;149;142;151;181;264;146 10:28:56 INFO - PROCESS | 2341 | |12;stanford-crypto-pbkdf2;178;176;179;173;179;177;176;180;175;178 10:28:56 INFO - PROCESS | 2341 | |13;stanford-crypto-sha256-iterative;73;72;68;70;72;70;70;72;72;77 10:28:56 INFO - PROCESS | 2341 | __end_tp_report 10:28:56 INFO - PROCESS | 2341 | __start_cc_report 10:28:56 INFO - PROCESS | 2341 | _x_x_mozilla_cycle_collect,954 10:28:56 INFO - PROCESS | 2341 | __end_cc_report 10:28:56 INFO - PROCESS | 2341 | __startTimestamp1475861336618__endTimestamp 10:28:56 INFO - PROCESS | 2341 | 10:28:56 INFO - PROCESS | 2341 | ------- Summary: start ------- 10:28:56 INFO - PROCESS | 2341 | Number of tests: 14 10:28:56 INFO - PROCESS | 2341 | 10:28:56 INFO - PROCESS | 2341 | [#0] ai-astar Cycles:10 Average:128.90 Median:122.00 stddev:20.79 (17.0%) stddev-sans-first:16.87 10:28:56 INFO - PROCESS | 2341 | Values: 167.0 167.0 132.0 114.0 116.0 117.0 116.0 116.0 125.0 119.0 10:28:56 INFO - PROCESS | 2341 | 10:28:56 INFO - PROCESS | 2341 | [#1] audio-beat-detection Cycles:10 Average:132.20 Median:137.00 stddev:20.30 (14.8%) stddev-sans-first:20.08 10:28:56 INFO - PROCESS | 2341 | Values: 153.0 118.0 116.0 153.0 119.0 117.0 130.0 144.0 166.0 106.0 10:28:56 INFO - PROCESS | 2341 | 10:28:56 INFO - PROCESS | 2341 | [#2] audio-dft Cycles:10 Average:224.40 Median:226.50 stddev:31.80 (14.0%) stddev-sans-first:33.23 10:28:56 INFO - PROCESS | 2341 | Values: 209.0 259.0 244.0 267.0 271.0 199.0 197.0 197.0 199.0 202.0 10:28:56 INFO - PROCESS | 2341 | 10:28:56 INFO - PROCESS | 2341 | [#3] audio-fft Cycles:10 Average:69.90 Median:69.00 stddev:12.35 (17.9%) stddev-sans-first:12.00 10:28:56 INFO - PROCESS | 2341 | Values: 84.0 59.0 61.0 88.0 61.0 61.0 62.0 60.0 87.0 76.0 10:28:56 INFO - PROCESS | 2341 | 10:28:56 INFO - PROCESS | 2341 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:86.00 stddev:15.00 (17.4%) stddev-sans-first:15.81 10:28:56 INFO - PROCESS | 2341 | Values: 82.0 74.0 116.0 99.0 98.0 83.0 90.0 71.0 66.0 89.0 10:28:56 INFO - PROCESS | 2341 | 10:28:56 INFO - PROCESS | 2341 | [#5] imaging-gaussian-blur Cycles:10 Average:101.90 Median:88.50 stddev:19.99 (22.6%) stddev-sans-first:20.81 10:28:56 INFO - PROCESS | 2341 | Values: 91.0 103.0 92.0 77.0 133.0 121.0 92.0 88.0 133.0 89.0 10:28:56 INFO - PROCESS | 2341 | 10:28:56 INFO - PROCESS | 2341 | [#6] imaging-darkroom Cycles:10 Average:103.00 Median:97.00 stddev:8.81 (9.1%) stddev-sans-first:8.85 10:28:56 INFO - PROCESS | 2341 | Values: 111.0 124.0 98.0 97.0 98.0 97.0 104.0 97.0 98.0 106.0 10:28:56 INFO - PROCESS | 2341 | 10:28:56 INFO - PROCESS | 2341 | [#7] imaging-desaturate Cycles:10 Average:97.70 Median:91.00 stddev:11.15 (12.2%) stddev-sans-first:11.56 10:28:56 INFO - PROCESS | 2341 | Values: 91.0 103.0 91.0 124.0 109.0 91.0 93.0 93.0 90.0 92.0 10:28:56 INFO - PROCESS | 2341 | 10:28:56 INFO - PROCESS | 2341 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:1.64 (2.9%) stddev-sans-first:1.73 10:28:56 INFO - PROCESS | 2341 | Values: 57.0 55.0 56.0 54.0 56.0 59.0 56.0 58.0 59.0 57.0 10:28:56 INFO - PROCESS | 2341 | 10:28:56 INFO - PROCESS | 2341 | [#9] json-stringify-tinderbox Cycles:10 Average:80.30 Median:73.50 stddev:13.28 (18.1%) stddev-sans-first:13.66 10:28:56 INFO - PROCESS | 2341 | Values: 71.0 83.0 104.0 105.0 76.0 70.0 73.0 71.0 76.0 74.0 10:28:56 INFO - PROCESS | 2341 | 10:28:56 INFO - PROCESS | 2341 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:91.50 stddev:3.43 (3.8%) stddev-sans-first:3.62 10:28:56 INFO - PROCESS | 2341 | Values: 92.0 91.0 90.0 88.0 90.0 95.0 96.0 93.0 91.0 84.0 10:28:56 INFO - PROCESS | 2341 | 10:28:56 INFO - PROCESS | 2341 | [#11] stanford-crypto-ccm Cycles:10 Average:163.60 Median:151.00 stddev:36.90 (24.4%) stddev-sans-first:38.64 10:28:56 INFO - PROCESS | 2341 | Values: 147.0 148.0 151.0 157.0 149.0 142.0 151.0 181.0 264.0 146.0 10:28:56 INFO - PROCESS | 2341 | 10:28:56 INFO - PROCESS | 2341 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:178.00 stddev:2.13 (1.2%) stddev-sans-first:2.24 10:28:56 INFO - PROCESS | 2341 | Values: 178.0 176.0 179.0 173.0 179.0 177.0 176.0 180.0 175.0 178.0 10:28:56 INFO - PROCESS | 2341 | 10:28:56 INFO - PROCESS | 2341 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.00 stddev:2.41 (3.4%) stddev-sans-first:2.51 10:28:56 INFO - PROCESS | 2341 | Values: 73.0 72.0 68.0 70.0 72.0 70.0 70.0 72.0 72.0 77.0 10:28:56 INFO - PROCESS | 2341 | -------- Summary: end -------- 10:28:56 INFO - PROCESS | 2341 | 10:28:57 INFO - TEST-INFO | 2341: exit 0 10:28:57 INFO - TEST-OK | kraken | took 61114ms 10:28:57 INFO - SUITE-END | took 1176s 10:28:57 INFO - Completed test suite (00:19:37) 10:28:57 INFO - javascript benchmark 10:28:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7157.703267971223, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3147.4806656901615, 3315.270640459098, 3360.714339281161, 3372.8988130356065, 3377.273886114486, 5610.158476228567, 5722.341930677968, 5736.368999410067, 5782.826515204545, 5855.824325270249, 5635.915461268084, 5781.959247335478, 5828.621139625921, 5830.970845145779, 5912.201852749878, 5230.0, 5233.0, 5242.108841496935, 5380.91928621071, 5406.91889621656, 5349.117395629716, 5388.946110538884, 5401.594880383967, 5414.864628384283, 5452.154915988009, 5150.948490515084, 5230.712310822903, 5301.416844147141, 5305.920411193835, 5357.303550538444, 5250.684958902478, 5261.158214685632, 5279.841604751864, 5302.708351040691, 5308.6549374290935, 5154.0, 5178.741062946875, 5179.637425380187, 5213.947860521384, 5229.189475631283, 5539.806106786243, 5741.569382296345, 5758.424157584208, 5764.913526297109, 5765.250517432749, 6084.5132389408745, 6110.589135957139, 6143.051335359052, 6147.354527774609, 6174.38256174379, 6106.236720409949, 6134.4978165938865, 6156.168917196166, 6181.907271390933, 6186.412290832363, 5903.203067585821, 5916.911246331266, 5924.289085309791, 5925.851853703605, 5936.257967754031, 6104.701693046543, 6129.939558357133, 6130.000698177752, 6298.086777417248, 6300.180976473029, 6110.022396416552, 6133.0, 6152.169457123231, 6153.661608588708, 6162.630242185483, 6159.599626024384, 6172.660503672341, 6180.690965451709, 6200.751969921243, 6252.468540174136, 4911.8280860169725, 6059.424354686298, 6059.878802423927, 6100.328963813977, 6123.343628574293, 4479.193745125844, 5981.79063732776, 6138.0, 6184.226971628546, 6208.968955155286, 4025.577314382006, 4872.610191184696, 4884.9511504884495, 4899.926501102486, 4945.653804233741, 3625.619309972468, 4305.677074219446, 4322.200392927319, 4353.651707863363, 4393.20922234001, 5781.306243250837, 5831.854203644943, 5839.591228613956, 5841.795537156264, 5918.408159184133, 5186.974065129651, 6130.325664176937, 6188.1027251048345, 6236.688165591702, 6246.937530624727, 5699.74351154199, 5838.2702162229725, 5853.326867410217, 5916.408359164136, 5942.435468630473, 5452.890942181134, 5472.671639701631, 5482.945170548243, 5534.52956498694, 5542.418046105182, 6378.521610879296, 6395.456386207132, 6396.5522413431545, 6397.552171348148, 6445.838854028687, 6058.666773327509, 6206.441420272197, 6219.751209951552, 6221.440070393686, 6252.531060170596, 5329.706866122246, 6150.753969841336, 6236.656983865931, 6245.5628106032145, 6247.250329960434, 6090.573659843769, 6102.298235702773, 6103.145559621567, 6110.358412366638, 6130.846728831815, 6095.116208149882, 6101.725422356093, 6167.907481387693, 6182.412670796267, 6194.132821404917, 5975.521958243417, 5999.160117583455, 6019.849503762441, 6020.036794112921, 6047.183630209865, 5985.970070149796, 6015.759369625341, 6040.818775436744, 6057.333693293646, 6065.545084118797, 5825.300963884191, 5830.737616807169, 5933.821985340447, 5958.731857066529, 6000.759969601341, 6062.42406971337, 6113.962834745811, 6116.327204007466, 6118.7714669719035, 6122.703114648804, 5976.910346344721, 6013.428724271187, 6028.487578555696, 6051.667158306159, 6052.485538729257], "value": 5670.034315738858, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [512.4772731813549, 521.3483146067416, 531.8298144593732, 547.3759913698384, 560.0507140397026, 29602.407951840978, 40702.0, 40730.18539629206, 40731.18537629246, 40813.79593102038, 41235.58764412355, 41628.37557436641, 41909.74270771874, 41937.580624193746, 41945.0, 9581.952090239574, 9747.171490423323, 9777.511124443785, 9797.167240784542, 9799.608015679365, 9673.129418352348, 9754.975727548612, 9772.657956971507, 9774.51127443625, 9793.657221997231, 9738.561764720569, 9760.365576237557, 9768.07203315684, 9782.706518804447, 9788.657396991106, 9726.951365243163, 9737.221022318197, 9762.267829912786, 9764.365316254421, 9790.167835733972, 9645.324827262095, 9702.320837541374, 9739.853902191402, 9750.951245243728, 9764.609415623367, 35925.82037089798, 36163.276734465166, 36205.81897090524, 36289.81855090734, 36304.45543316852, 3281.7210537104374, 3764.0, 4015.437838702584, 4029.959700403017, 4030.2745505808944, 30333.938312158967, 31334.52998205006, 31614.0, 31857.0, 32109.1972700682, 2830.787690923189, 2836.801423900328, 2901.970980290191, 3190.872365105393, 3345.7156141727983, 482138.0, 494687.9999999964, 494830.0, 497700.0, 509030.0, 60193.69903150456, 60372.69813650991, 60377.69811150916, 60802.39197607967, 61188.77622447526, 59360.703196483744, 59895.0, 59978.400215998154, 60052.39947600556, 60147.0, 13865.168089914436, 15798.9210053949, 15965.760513592073, 16044.598885027968, 16155.515334539983, 12207.450664720109, 12367.93816030914, 12391.814122788166, 12399.690007749698, 12437.315947622968, 16077.839221607634, 17318.96086234805, 17335.046572438638, 17346.566335841704, 17375.73936390955, 5872.794452194238, 6812.523123381415, 6831.6242606656115, 6951.270116637781, 7022.12223472066, 762.359617920938, 825.2861274997205, 841.146236569882, 968.2883080935507, 1109.9556017759198, 28472.715272847006, 28915.710842891724, 30437.543436848464, 30538.847305763775, 30927.0, 920.7283851263893, 924.0805398628273, 929.809389075238, 1009.6062535611118, 1058.4866339825178, 15012.699746005019, 15563.564384150463, 15577.753779697598, 15701.764473532907, 15932.36270549165, 678377.0, 713749.0, 734871.0, 739765.0, 940937.0, 58284.125738113966, 58720.41279587235, 58836.41163588395, 58879.41120588825, 58970.410295896494, 1219.5426714981882, 1297.4096785962554, 1343.3014832287156, 1343.482759137739, 1361.3737680666807, 27683.615819208557, 27995.58006629943, 31267.37465250728, 31470.527942081346, 32136.87520936756, 47896.521034789206, 51233.97532049413, 51269.743651282995, 51434.48565514447, 51793.7410312946, 596790.0, 598373.0, 601048.0, 601962.0, 602671.0, 26928.865355673097, 27274.727252727218, 27337.45325093447, 27339.58990615182, 27350.72649273482, 38726.0, 46340.536594633624, 46450.76774616105, 47675.046499070515, 47728.761356193, 32329.030129096165, 38697.03257418587, 38853.417198741474, 39874.601253987086, 40084.398734019596, 29037.27406814762, 38068.238635227695, 38123.0, 39369.22838472333, 39581.604183958945, 34342.0, 37163.628363716016, 38067.238655227295, 38333.0, 39714.60285397109, 33008.83495582603, 33157.66842331642, 34251.314973700886, 34587.82706086453, 34807.47788783221, 22896.084156633548, 25419.745802541736, 25428.491430171664, 25550.23349299524, 25844.483110338064], "value": 19797.842485362686, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.3695538241152, 367.7940353402094, 370.7830918912436, 384.22578504313793, 386.3007955600362, 19398.612027759453, 19923.40229793107, 20031.899840500777, 20666.07002684881, 20863.687044694343, 11348.09215262779, 11875.049996000322, 12036.81944770829, 12042.217255878362, 12048.337341446238, 4888.877778055541, 4912.435069966946, 5293.417724050351, 5671.63134396265, 5761.279840019997, 3936.566977632458, 4152.709310348277, 4460.0, 4840.0, 6150.077488376734, 5567.610267281292, 6031.0048841941025, 6236.095766113934, 6237.625742455444, 6243.843903902416, 5958.731857066442, 6152.107944348045, 6156.38436156383, 6203.4416902479, 6205.9379406206035, 5196.506331898464, 5397.325334333208, 6026.969865150646, 6045.909311360289, 6046.2744470663365, 20438.897805511027, 20586.691199632016, 20825.791742082536, 23665.526689466285, 24830.5033899321, 1810.837024667773, 2163.167180635451, 2226.576950379439, 2476.603743401065, 2919.8102123361914, 9668.661596844147, 9901.603935842557, 10252.538635761408, 10278.903503968042, 10455.0, 1838.4117082533594, 1919.5872887329292, 1924.288013435038, 1928.6817675083594, 1951.1219951022097, 98822.50588747082, 119392.40303798512, 120542.0, 122528.38735806264, 128790.0, 11095.72260693489, 11309.943450282695, 11392.715182120348, 11542.769144617228, 11722.824157637642, 14478.565643030515, 14491.710165796625, 14500.347484363228, 14524.0, 14555.19946402958, 8089.878651820228, 8375.994880614244, 8437.0, 8501.0, 8523.0, 8198.508089514648, 8214.089362397654, 8296.211859873423, 8406.369522285853, 8474.364422668325, 3870.806459677005, 4474.619657329164, 4590.839320623762, 4595.724256544618, 4604.148232576984, 1543.3672194400242, 1631.77970973917, 1659.6099916519609, 1905.1522072677526, 1967.7799764146034, 909.9363044586815, 909.9909000910038, 926.8285367207088, 961.8749562556962, 983.7899383758017, 16339.813736321541, 20414.877181754848, 20912.68630970537, 21197.36407907765, 21299.8935005324, 873.2189618950058, 900.7703035725979, 915.6108653822099, 959.0505399654292, 1022.0954455306958, 10682.145428365711, 10891.782164356828, 11194.888051119548, 11239.719007024889, 11251.606193783178, 571024.6784602083, 581608.0, 591693.0, 595368.0, 595448.0, 100063.49968250257, 100710.49644751729, 113704.0, 125902.37048814697, 127040.0943985841, 974.6978436684509, 998.3560603410905, 1019.5208252121491, 1024.3956065920993, 1025.9127974122134, 18695.0, 19613.921234332247, 19658.8034119657, 19672.0, 19687.21251149938, 50857.0, 51026.0, 51545.22682159846, 51913.48086519087, 52308.0, 62487.37512624815, 78861.60569197117, 79415.60292198733, 79534.0, 83016.58491707503, 5704.344000439836, 6609.933900660932, 7254.310840470147, 8135.877961830695, 8188.344932405274, 7214.494985350975, 9038.793897768288, 12582.937085314516, 12669.556565520163, 12931.806022909475, 10665.466726663792, 11360.602378917029, 11369.31784092957, 11505.884941150482, 11507.884921151017, 10864.945675271572, 11106.555737770723, 11174.441277936234, 11342.0, 11456.541738330707, 10470.0, 11192.216544841784, 11612.954834064636, 11615.24500907472, 11705.829417058567, 7880.605969701606, 8051.35589152878, 8069.515829050276, 8147.959260203661, 8164.714235001747, 6276.372362763687, 7763.883541746765, 7851.332636725942, 9439.811203776024, 11610.6516804496], "value": 9137.262887405679, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.7070585882823, 1529.1283968138162, 1725.8954269267663, 1833.4774589242068, 1851.8148185181476, 7960.442769006172, 8212.507249565031, 8545.61544730487, 9080.50057246852, 9096.317776166781, 8494.320454363651, 8821.250193733524, 8827.117288271169, 8934.195922366986, 8948.328875334344, 2346.1905642553334, 2369.5379401016808, 2369.95260094798, 2376.4058985253687, 2384.7138343398815, 2334.6381310896836, 2359.1507057459385, 2381.154690085012, 2382.19005538117, 2391.6412538119334, 1992.3026940570828, 2031.9796802032013, 2154.278316763878, 2265.5582161478437, 2339.5554844579474, 2315.617923042704, 2326.569584626841, 2327.8021368183727, 2332.650102484624, 2334.4747431827705, 1975.9506012349661, 2348.342464110035, 2351.294611616508, 2354.2348736660483, 2355.658429527726, 8829.69096081634, 9030.187283144549, 9032.638694452215, 9034.819303613891, 9092.772680683036, 5267.0, 5429.185622156669, 5432.592555558309, 5433.347998240197, 5460.34475862899, 3441.587009558844, 3498.1954150545516, 3620.0, 3631.94552081719, 3642.8360723767496, 1024.2011231239644, 1059.8728152621734, 1066.4188017530464, 1083.8753543342539, 1084.0839490630483, 11733.237339572986, 11739.882601173964, 11830.881691183064, 11861.881381186251, 11864.991475724573, 4561.498235194126, 4621.682820396171, 4794.161021821167, 4805.3512775775525, 4809.014152098812, 9939.900600994042, 9999.750006249757, 10033.648822291185, 10036.146927511098, 10043.69868903934, 5379.462053794668, 5387.138057910715, 5393.946060539344, 5402.972985135128, 5413.188021796762, 4409.823607055682, 4563.383943167696, 4756.381670382828, 4926.901461970812, 4972.776225069881, 3867.3812190049457, 3923.352646813244, 3994.3009973254566, 4023.7988100594853, 4028.8992775180855, 1275.1074248026418, 1290.3548225887057, 1296.5397283964057, 1300.6293206436121, 1309.803529470568, 805.7461899501639, 807.0517142357706, 838.4131108224267, 889.4440974391006, 891.0910870911633, 5533.280673512418, 5649.887002259932, 5696.401877802854, 5764.798232061858, 5973.880522389528, 409.84016233668893, 421.9746815191098, 424.8279446824041, 429.87533615251226, 440.89418539550275, 3571.94642080369, 3644.963550364462, 3661.9267614647556, 3754.3617585010065, 3796.449514820391, 9053.185213330831, 10564.0, 10667.466626668636, 10703.197260205516, 10707.196960228013, 10608.787824243473, 10652.573897044187, 10655.25413221067, 10663.73340666474, 10675.359478431164, 8132.0, 8195.71315003972, 8196.34429245659, 8203.794905127419, 8278.875816862752, 5626.493615574618, 5667.914981275367, 5724.656520608777, 5745.482906538432, 5806.012977793701, 9655.468949207861, 9950.094665274393, 9962.50187490608, 9998.250131240331, 10001.14990225839, 10038.498075096362, 10063.446510441703, 10088.192944564564, 10179.389236645826, 10345.586176553155, 6843.520953533404, 6864.21061577925, 7127.8574428512175, 7404.148522919718, 7562.130355009244, 8265.793355165928, 8399.202075802788, 8407.0, 8429.789255268668, 8442.36682248846, 7455.4035677146785, 7589.43079269046, 7594.468387212842, 7649.579273140031, 7727.845443091219, 7318.560886346836, 7401.629918504161, 7408.222136675571, 7559.1306999695735, 7604.087509498895, 6899.551529150589, 7030.824229394306, 7068.434525237866, 7074.610896400747, 7085.858282834418, 4783.212467211744, 4915.0415668944215, 4939.60483161339, 4953.083679519301, 4958.404991400911, 4821.421429428351, 4906.656534042583, 4923.606111510999, 5021.0, 5164.173732202829], "value": 4468.25134135203, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [261.48096029381674, 275.630654922404, 287.6778008630333, 300.3482443098476, 315.2748678040509, 5191.546367017241, 5227.503387178222, 5358.919616205751, 5384.7307634618255, 5511.779528818847, 4424.0, 5017.473165317644, 5198.428172900978, 5208.7395630218525, 5333.280007199027, 3581.641835816417, 4156.960759810047, 4158.812853421603, 4176.895577610554, 4184.623383895449, 3948.565657777642, 4135.627793498585, 4174.039970806701, 4197.7271477354025, 4228.97885510572, 3389.474631432132, 4082.5305089914596, 4088.9386659199986, 4120.031792528754, 4154.896127596804, 4127.834886604547, 4137.97931010343, 4154.376843473473, 4155.231282212785, 4163.542010378856, 3312.801231926092, 3601.621829707869, 3616.529851119364, 3632.1827588792576, 3642.1440961374055, 4525.751083690396, 4543.954560454419, 4653.837115700968, 4696.342512048282, 5209.374875014984, 4680.508546602626, 4704.741239231841, 4712.65689278554, 4713.222318317474, 4722.409698787652, 4686.484486706494, 5089.643724939256, 5238.642610825106, 5608.6073974821775, 5678.716064196774, 3711.1258814298876, 3829.248602154818, 3870.1872606752618, 3937.7440466369594, 3975.1652153047894, 5042.621803364762, 5214.634975551675, 5377.892442151174, 5742.483176514092, 5971.581989260753, 3775.9244815103543, 4021.130174468886, 4022.7988600569856, 4023.436718859362, 4157.459530261107, 3926.234384295035, 4057.736247143926, 4066.0038290618986, 4077.89805254871, 4134.91730165401, 4686.437627484724, 4690.273007683814, 4715.646326525524, 4730.834420795256, 4786.114568804782, 5696.177223288508, 5699.430056994267, 5702.7433765480655, 5775.220345253421, 5797.565182611321, 1071.7106381277167, 1125.6172901213627, 1188.7087663522493, 1344.5562964221783, 1379.9172049677052, 903.0878812399524, 911.166282851197, 930.6603089872148, 945.1729736480579, 949.9145076943108, 4513.526079761577, 4762.904741905142, 5215.400228973641, 5222.321098257202, 5242.61070816234, 5098.745062746848, 5592.552595792326, 5746.913796293059, 5817.556626216914, 5826.82519524415, 4944.505549445099, 5135.818761684759, 5263.552598029134, 5268.236105764643, 5303.893922121536, 2186.7047948526747, 2209.458682622768, 2545.694516657976, 2549.2352294312004, 2563.3207200091992, 4157.708960372805, 4247.312364620047, 4840.491748366441, 4884.438289596671, 5011.724355160502, 4040.919181616351, 4685.4143232095985, 4947.413125484068, 4998.875028124253, 5020.472850350734, 4195.685323600803, 5005.449400565934, 5013.0, 5043.596512279082, 5086.669366491166, 4117.464729585135, 4383.452068491439, 4765.904681906273, 4886.92669609949, 4889.804407823647, 3904.3255370071593, 3989.740666856645, 4062.3297155968935, 4259.680523960654, 4690.906181876275, 4000.879973600797, 4159.691371288964, 4214.873553793391, 4466.64266858657, 4508.594226519629, 3163.5254711793414, 3259.4947783093658, 3463.3202896595635, 3475.8957231283102, 3490.6909908784205, 4179.519355274182, 4662.836800711959, 4720.268358404453, 4829.637777166797, 4925.310456536159, 4741.383620129361, 4771.117343291502, 5414.835810300804, 5428.45715428454, 5749.54003679713, 5056.544910958031, 5744.569157313134, 5780.826575202751, 5819.6508209507565, 5821.679807610622, 5372.0, 5487.588430867621, 5536.584756143225, 5569.605069820016, 5623.694285343154, 5220.295260139833, 5254.0, 5287.814926477555, 5756.971215143897, 5760.8271751847515, 4822.68652537584, 5162.741862906914, 5363.0346537622045, 5633.408632029313, 5662.009148399096], "value": 3913.4716590505827, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.51414738462, 690.3924546399168, 696.8153439338575, 749.030006142046, 793.515955267287, 12252.0, 14569.344379502909, 15220.847791522081, 15903.12532810695, 16124.919375403122, 14370.712585748279, 14391.568252952427, 14464.855351446482, 14498.710025799477, 14546.345414456347, 655.7311502284065, 681.0295329155957, 814.2590242878981, 824.9092599814015, 833.791552111972, 841.1210285251926, 845.8773477845708, 846.191886748154, 847.3517758914436, 847.9406441549094, 884.2395539835736, 885.2740752582885, 885.7032893980492, 886.4193952960821, 886.8315020146151, 873.5064688451005, 878.7363790862747, 879.6525372477868, 879.7844528090659, 880.3573391424233, 637.9011253255753, 650.5348675696852, 651.1274891645218, 653.2944420026407, 654.7871941618993, 14450.855491445056, 14473.059251148747, 14485.42058317666, 14551.636209094751, 14579.635509112251, 14161.291935403291, 14182.574522764333, 14236.145831250158, 14314.785278220836, 14324.14055156694, 11618.593349232737, 11622.593209237637, 11717.53129874804, 11781.410929453494, 11881.34652594107, 3720.1443667956523, 3725.18046029873, 3775.169462718198, 3787.3182827091114, 3799.25914446683, 112064.0, 112882.0, 113553.43223283913, 116082.41958790236, 117466.23800642912, 10281.228907831794, 10316.896831031743, 10984.395858227874, 11085.94457027726, 11270.436478176058, 19933.800661993195, 20052.799472005387, 21466.57066858654, 22115.447113822283, 22171.004609585216, 7272.0, 7334.3032411920785, 7396.815079623052, 7454.85090298191, 7487.887681684779, 4299.398084268205, 4367.890802729958, 4393.626541743987, 4399.527913596315, 4496.1906856765445, 3463.9434972333174, 3574.9285014299567, 3579.785212887235, 3585.1933315004435, 3586.8027258501033, 627.2723640576909, 633.5596760251673, 644.5359341274275, 659.2682122843639, 662.4270006444391, 545.664416383921, 565.3074983145614, 644.3298969072113, 665.896785998171, 669.6383952665603, 8511.616977236039, 8943.329250306253, 9146.222571081533, 9160.22138118254, 9395.57719902606, 615.5937081526171, 654.6890227142069, 662.2450406536552, 665.4111111666114, 669.1702289161404, 4370.104128653618, 4419.867403977886, 4607.124646317189, 4692.929606055912, 4753.265058253713, 130161.0, 151329.0, 154001.0, 156339.43660563248, 160395.39604603805, 84153.31693366099, 110891.0, 113918.43040784742, 114064.0, 116410.41794790972, 79905.0, 97221.02778972262, 102971.0, 104645.0, 108256.4587177059, 7608.31525162738, 8129.715459958873, 8157.306628936607, 8820.162084601952, 8957.865632015655, 53993.730031349594, 61000.0, 61251.69374153101, 61896.07155892575, 64041.0, 90612.09387906037, 93594.53202733943, 94841.5257923706, 95201.52399237959, 95850.0, 11621.477033533341, 11644.475998579916, 11698.70753231176, 12141.878581214074, 12344.753104937672, 12677.112602117762, 12890.654126629834, 13000.95992320631, 13151.079424440197, 13505.459781609019, 11918.344491053076, 11996.591933582044, 12046.096542759504, 12121.393930303273, 12159.331236782062, 11994.580189693319, 12070.827251094886, 12089.911907928328, 12165.57420490314, 12594.496220151092, 11709.121815863675, 11890.681003583953, 11923.224990375598, 11982.161248712506, 12400.937995309965, 9891.554880030271, 9917.752056198653, 10081.747956300858, 10118.696439106838, 10328.328658637165, 9350.485723285285, 10037.656153493584, 10094.343867648578, 10227.0, 10341.586336546454], "value": 7496.77684999403, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1585.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 132.0, 114.0, 116.0, 117.0, 116.0, 116.0, 125.0, 119.0], "value": 128.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 118.0, 116.0, 153.0, 119.0, 117.0, 130.0, 144.0, 166.0, 106.0], "value": 132.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 259.0, 244.0, 267.0, 271.0, 199.0, 197.0, 197.0, 199.0, 202.0], "value": 224.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 61.0, 88.0, 61.0, 61.0, 62.0, 60.0, 87.0, 76.0], "value": 69.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 74.0, 116.0, 99.0, 98.0, 83.0, 90.0, 71.0, 66.0, 89.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 103.0, 92.0, 77.0, 133.0, 121.0, 92.0, 88.0, 133.0, 89.0], "value": 101.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 124.0, 98.0, 97.0, 98.0, 97.0, 104.0, 97.0, 98.0, 106.0], "value": 103.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 103.0, 91.0, 124.0, 109.0, 91.0, 93.0, 93.0, 90.0, 92.0], "value": 97.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 54.0, 56.0, 59.0, 56.0, 58.0, 59.0, 57.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 83.0, 104.0, 105.0, 76.0, 70.0, 73.0, 71.0, 76.0, 74.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 90.0, 88.0, 90.0, 95.0, 96.0, 93.0, 91.0, 84.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 151.0, 157.0, 149.0, 142.0, 151.0, 181.0, 264.0, 146.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 176.0, 179.0, 173.0, 179.0, 177.0, 176.0, 180.0, 175.0, 178.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 68.0, 70.0, 72.0, 70.0, 70.0, 72.0, 72.0, 77.0], "value": 71.6, "unit": "score"}]}]} 10:28:57 INFO - Return code: 0 10:28:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:28:57 ERROR - # TBPL SUCCESS # 10:28:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:28:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:28:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:28:57 INFO - 2016-10-07 10:28:57.970 screenresolution[2352:18658] starting screenresolution argv=screenresolution get 10:28:57 INFO - 2016-10-07 10:28:57.975 screenresolution[2352:18658] Display 0: 1600x1200x32@60 10:28:57 INFO - 2016-10-07 10:28:57.981 screenresolution[2353:18661] starting screenresolution argv=screenresolution list 10:28:57 INFO - Available Modes on Display 0 10:28:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:28:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:28:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:28:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:28:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:28:58 INFO - Intel Iris: 10:28:58 INFO - Chipset Model: Intel Iris 10:28:58 INFO - Type: GPU 10:28:58 INFO - Bus: Built-In 10:28:58 INFO - VRAM (Dynamic, Max): 1536 MB 10:28:58 INFO - Vendor: Intel (0x8086) 10:28:58 INFO - Device ID: 0x0a2e 10:28:58 INFO - Revision ID: 0x0009 10:28:58 INFO - Displays: 10:28:58 INFO - Display: 10:28:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:28:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:28:58 INFO - Display Serial Number: 1600x1200 60 10:28:58 INFO - Main Display: Yes 10:28:58 INFO - Mirror: Off 10:28:58 INFO - Online: Yes 10:28:58 INFO - Rotation: Supported 10:28:58 INFO - Return code: 0 10:28:58 INFO - Running post-action listener: _resource_record_post_action 10:28:58 INFO - [mozharness: 2016-10-07 17:28:58.216885Z] Finished run-tests step (success) 10:28:58 INFO - Running post-run listener: _resource_record_post_run 10:28:58 INFO - Total resource usage - Wall time: 1213s; CPU: 55.0%; Read bytes: 2209280; Write bytes: 712800768; Read time: 18; Write time: 2010 10:28:58 INFO - TinderboxPrint: CPU usage
54.6% 10:28:58 INFO - TinderboxPrint: I/O read bytes / time
2,209,280 / 18 10:28:58 INFO - TinderboxPrint: I/O write bytes / time
712,800,768 / 2,010 10:28:58 INFO - TinderboxPrint: CPU idle
2,202.1 (45.4%) 10:28:58 INFO - TinderboxPrint: CPU system
984.8 (20.3%) 10:28:58 INFO - TinderboxPrint: CPU user
1,666.7 (34.3%) 10:28:58 INFO - TinderboxPrint: Swap in / out
409,886,720 / 0 10:28:58 INFO - install - Wall time: 36s; CPU: 55.0%; Read bytes: 391735808; Write bytes: 387427840; Read time: 30340; Write time: 702 10:28:58 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 2209280; Write bytes: 300964864; Read time: 18; Write time: 1255 10:28:58 INFO - Running post-run listener: _upload_blobber_files 10:28:58 INFO - Blob upload gear active. 10:28:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:28:58 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 10:28:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:28:59 INFO - (blobuploader) - INFO - Open directory for files ... 10:28:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:28:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:28:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:59 INFO - (blobuploader) - INFO - Done attempting. 10:28:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:28:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:29:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:00 INFO - (blobuploader) - INFO - Done attempting. 10:29:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:29:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:29:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:29:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:29:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:29:03 INFO - (blobuploader) - INFO - Done attempting. 10:29:03 INFO - (blobuploader) - INFO - Iteration through files over. 10:29:03 INFO - Return code: 0 10:29:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:29:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:29:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fa09657c7a6432327074ec0ef9187e986bd5810f9676738da4ff3f303282705d6d0886eef114c690f7dc443034798b9a24ca6a48bb778b0ada1ba029bb2a00d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef5daf8326fbca440ec0806b1e644afc9498b252e681450d995e9feb8a66e055d64a1b63a6e7c680a93ca92b9a14330ade1b10b3805dbd0347a29bc8191008a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/858f2db98410c4f73631d027f4dbd10c91366ce218147f7c75d6501fb603999f838983ea0e165028603166c68eeded6c63ff68cf706d137e572be2fd045f740a"} 10:29:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:29:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:29:03 INFO - Contents: 10:29:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fa09657c7a6432327074ec0ef9187e986bd5810f9676738da4ff3f303282705d6d0886eef114c690f7dc443034798b9a24ca6a48bb778b0ada1ba029bb2a00d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef5daf8326fbca440ec0806b1e644afc9498b252e681450d995e9feb8a66e055d64a1b63a6e7c680a93ca92b9a14330ade1b10b3805dbd0347a29bc8191008a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/858f2db98410c4f73631d027f4dbd10c91366ce218147f7c75d6501fb603999f838983ea0e165028603166c68eeded6c63ff68cf706d137e572be2fd045f740a"} 10:29:03 INFO - Running post-run listener: copy_logs_to_upload_dir 10:29:03 INFO - Copying logs to upload dir... 10:29:03 INFO - mkdir: /builds/slave/test/build/upload/logs 10:29:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.294864 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-07 10:29:03.650587) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 10:29:03.653701) ========= 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.gjcrtBDeuH/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.IIslSXrNNi/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fa09657c7a6432327074ec0ef9187e986bd5810f9676738da4ff3f303282705d6d0886eef114c690f7dc443034798b9a24ca6a48bb778b0ada1ba029bb2a00d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef5daf8326fbca440ec0806b1e644afc9498b252e681450d995e9feb8a66e055d64a1b63a6e7c680a93ca92b9a14330ade1b10b3805dbd0347a29bc8191008a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/858f2db98410c4f73631d027f4dbd10c91366ce218147f7c75d6501fb603999f838983ea0e165028603166c68eeded6c63ff68cf706d137e572be2fd045f740a"} build_url:https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://queue.taskcluster.net/v1/task/fDv5H26uR1qskeaGlic7lA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fa09657c7a6432327074ec0ef9187e986bd5810f9676738da4ff3f303282705d6d0886eef114c690f7dc443034798b9a24ca6a48bb778b0ada1ba029bb2a00d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef5daf8326fbca440ec0806b1e644afc9498b252e681450d995e9feb8a66e055d64a1b63a6e7c680a93ca92b9a14330ade1b10b3805dbd0347a29bc8191008a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/858f2db98410c4f73631d027f4dbd10c91366ce218147f7c75d6501fb603999f838983ea0e165028603166c68eeded6c63ff68cf706d137e572be2fd045f740a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 10:29:03.687790) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 10:29:03.688143) ========= 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.gjcrtBDeuH/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.IIslSXrNNi/Listeners TMPDIR=/var/folders/vs/0sk_gyqd48x911v5vww2j48c00000w/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.005052 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 10:29:03.738636) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 10:29:03.739331) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 10:29:03.739831) ========= ========= Total master_lag: 0.19 =========