builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0187 starttime: 1475637821.66 results: success (0) buildid: 20161004174100 builduid: 83b05d35a580463f92dcff8b133573dd revision: ea104eeb14cc54da9a06c3766da63f73117723a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 20:23:41.661787) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 20:23:41.662323) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 20:23:41.662643) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 20:23:41.699238) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 20:23:41.699537) ========= 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.WWqLrILol6/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.gJsKijMZUB/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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-04 20:23:41-- 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% 52.9M=0s 2016-10-04 20:23:41 (52.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121639 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 20:23:41.843184) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 20:23:41.843538) ========= 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.WWqLrILol6/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.gJsKijMZUB/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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.020508 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 20:23:41.892879) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 20:23:41.893294) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ea104eeb14cc54da9a06c3766da63f73117723a0 --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 ea104eeb14cc54da9a06c3766da63f73117723a0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WWqLrILol6/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.gJsKijMZUB/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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-04 20:23:41,960 truncating revision to first 12 chars 2016-10-04 20:23:41,960 Setting DEBUG logging. 2016-10-04 20:23:41,960 attempt 1/10 2016-10-04 20:23:41,960 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ea104eeb14cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 20:23:42,675 unpacking tar archive at: mozilla-central-ea104eeb14cc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.988452 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 20:23:42.903842) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 20:23:42.904207) ========= script_repo_revision: ea104eeb14cc54da9a06c3766da63f73117723a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 20:23:42.904639) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 20:23:42.904937) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 20:23:42.927775) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-04 20:23:42.928109) ========= /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.WWqLrILol6/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.gJsKijMZUB/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 20:23:43 INFO - MultiFileLogger online at 20161004 20:23:43 in /builds/slave/test 20:23:43 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 20:23:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:23:43 INFO - {'append_to_log': False, 20:23:43 INFO - 'base_work_dir': '/builds/slave/test', 20:23:43 INFO - 'blob_upload_branch': 'Firefox', 20:23:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:23:43 INFO - 'branch': 'Firefox', 20:23:43 INFO - 'buildbot_json_path': 'buildprops.json', 20:23:43 INFO - 'config_files': ('talos/mac_config.py',), 20:23:43 INFO - 'default_actions': ('clobber', 20:23:43 INFO - 'read-buildbot-config', 20:23:43 INFO - 'download-and-extract', 20:23:43 INFO - 'populate-webroot', 20:23:43 INFO - 'create-virtualenv', 20:23:43 INFO - 'install', 20:23:43 INFO - 'run-tests'), 20:23:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:23:43 INFO - 'download_minidump_stackwalk': True, 20:23:43 INFO - 'download_symbols': 'ondemand', 20:23:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:23:43 INFO - 'tooltool.py': '/tools/tooltool.py', 20:23:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:23:43 INFO - '/tools/misc-python/virtualenv.py')}, 20:23:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:23:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:23:43 INFO - 'installer_path': 'installer.exe', 20:23:43 INFO - 'log_level': 'info', 20:23:43 INFO - 'log_name': 'talos', 20:23:43 INFO - 'log_to_console': True, 20:23:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:23:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:23:43 INFO - 'opt_config_files': (), 20:23:43 INFO - 'pip_index': False, 20:23:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:23:43 INFO - 'cmd': ('bash', 20:23:43 INFO - '-c', 20:23:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:23:43 INFO - 'enabled': True, 20:23:43 INFO - 'halt_on_failure': False, 20:23:43 INFO - 'name': 'check_screen_resolution'},), 20:23:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:23:43 INFO - 'cmd': ('bash', 20:23:43 INFO - '-c', 20:23:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:23:43 INFO - 'enabled': True, 20:23:43 INFO - 'halt_on_failure': False, 20:23:43 INFO - 'name': 'check_screen_resolution'},), 20:23:43 INFO - 'run_cmd_checks_enabled': True, 20:23:43 INFO - 'sps_profile': False, 20:23:43 INFO - 'sps_profile_interval': 0, 20:23:43 INFO - 'suite': 'dromaeojs-e10s', 20:23:43 INFO - 'system_bits': '32', 20:23:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:23:43 INFO - 'title': 't-yosemite-r7-0187', 20:23:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:23:43 INFO - 'use_talos_json': True, 20:23:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:23:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:23:43 INFO - 'work_dir': 'build'} 20:23:43 INFO - [mozharness: 2016-10-05 03:23:43.132050Z] Running clobber step. 20:23:43 INFO - Running pre-action listener: _resource_record_pre_action 20:23:43 INFO - Running main action method: clobber 20:23:43 INFO - rmtree: /builds/slave/test/build 20:23:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:23:43 INFO - Running post-action listener: _resource_record_post_action 20:23:43 INFO - [mozharness: 2016-10-05 03:23:43.387475Z] Finished clobber step (success) 20:23:43 INFO - [mozharness: 2016-10-05 03:23:43.387657Z] Running read-buildbot-config step. 20:23:43 INFO - Running pre-action listener: _resource_record_pre_action 20:23:43 INFO - Running main action method: read_buildbot_config 20:23:43 INFO - Using buildbot properties: 20:23:43 INFO - { 20:23:43 INFO - "project": "", 20:23:43 INFO - "product": "firefox", 20:23:43 INFO - "script_repo_revision": "production", 20:23:43 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 20:23:43 INFO - "repository": "", 20:23:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 20:23:43 INFO - "buildid": "20161004174100", 20:23:43 INFO - "pgo_build": "False", 20:23:43 INFO - "basedir": "/builds/slave/test", 20:23:43 INFO - "buildnumber": 41, 20:23:43 INFO - "slavename": "t-yosemite-r7-0187", 20:23:43 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 20:23:43 INFO - "platform": "yosemite_r7", 20:23:43 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 20:23:43 INFO - "branch": "mozilla-central", 20:23:43 INFO - "repo_path": "mozilla-central", 20:23:43 INFO - "revision": "ea104eeb14cc54da9a06c3766da63f73117723a0", 20:23:43 INFO - "stage_platform": "macosx64", 20:23:43 INFO - "builduid": "83b05d35a580463f92dcff8b133573dd", 20:23:43 INFO - "slavebuilddir": "test" 20:23:43 INFO - } 20:23:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/c4P6JY-GSDOjOkoS17kbBg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 20:23:43 INFO - Running post-action listener: _resource_record_post_action 20:23:43 INFO - [mozharness: 2016-10-05 03:23:43.392693Z] Finished read-buildbot-config step (success) 20:23:43 INFO - [mozharness: 2016-10-05 03:23:43.392804Z] Running download-and-extract step. 20:23:43 INFO - Running pre-action listener: _resource_record_pre_action 20:23:43 INFO - Running main action method: download_and_extract 20:23:43 INFO - mkdir: /builds/slave/test/build/tests 20:23: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')]} 20:23:43 INFO - trying https://queue.taskcluster.net/v1/task/c4P6JY-GSDOjOkoS17kbBg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 20:23:43 INFO - Downloading https://queue.taskcluster.net/v1/task/c4P6JY-GSDOjOkoS17kbBg/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 20:23:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c4P6JY-GSDOjOkoS17kbBg/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 20:23:44 INFO - Downloaded 1199 bytes. 20:23:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 20:23:44 INFO - Using the following test package requirements: 20:23:44 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 20:23:44 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:23:44 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 20:23:44 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:23:44 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 20:23:44 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:23:44 INFO - u'jsshell-mac.zip'], 20:23:44 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:23:44 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 20:23:44 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 20:23:44 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:23:44 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 20:23:44 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:23:44 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 20:23:44 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:23:44 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 20:23:44 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:23:44 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 20:23:44 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:23:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c4P6JY-GSDOjOkoS17kbBg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 20:23:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c4P6JY-GSDOjOkoS17kbBg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:23:44 INFO - Fetch https://queue.taskcluster.net/v1/task/c4P6JY-GSDOjOkoS17kbBg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 20:23:45 INFO - Http code: 200 20:23:45 INFO - via: 1.1 02192a27c967e955f8c815efa939bfc8.cloudfront.net (CloudFront) 20:23:45 INFO - x-amz-cf-id: VwWJhcfZgnIXVpRxiv8n2x0YB-ajawxUEAFsE4QfsTB6n6xtugJx5g== 20:23:45 INFO - x-amz-version-id: 8V3uTVeEIWCC81qRsxKUy3XZkmX.l9eW 20:23:45 INFO - Expected file size: 16476870 20:23:45 INFO - Obtained file size: 16476870 20:23:52 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 20:23:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c4P6JY-GSDOjOkoS17kbBg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 20:23:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c4P6JY-GSDOjOkoS17kbBg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:23:52 INFO - Fetch https://queue.taskcluster.net/v1/task/c4P6JY-GSDOjOkoS17kbBg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 20:23:52 INFO - Http code: 200 20:23:52 INFO - via: 1.1 3d3d633d266d05d90a4eea7a6a59b514.cloudfront.net (CloudFront) 20:23:52 INFO - x-amz-cf-id: T1QXZgSKMzCyZ5Lfa20M-Q2xpXO7VNCQ9_b-hAZf9wNbSZautbPdvg== 20:23:52 INFO - x-amz-version-id: 8V3uTVeEIWCC81qRsxKUy3XZkmX.l9eW 20:23:53 INFO - Expected file size: 16476870 20:23:53 INFO - Obtained file size: 16476870 20:23:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/c4P6JY-GSDOjOkoS17kbBg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 20:23:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/c4P6JY-GSDOjOkoS17kbBg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:23:59 INFO - Fetch https://queue.taskcluster.net/v1/task/c4P6JY-GSDOjOkoS17kbBg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 20:24:00 INFO - Http code: 200 20:24:00 INFO - via: 1.1 b04a4cffa8fb4f524ff7edcab1b5ae31.cloudfront.net (CloudFront) 20:24:00 INFO - x-amz-cf-id: BtC59lRNcORiUiIK8NgRSd2oZnvifKXgdQ_vwxqqTlcincwXjD4osQ== 20:24:00 INFO - x-amz-version-id: IMcPepmEzaMUCI3_UmqQQ6yYB05DlSNE 20:24:01 INFO - Expected file size: 14409006 20:24:01 INFO - Obtained file size: 14409006 20:24:01 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')]} 20:24:01 INFO - trying https://queue.taskcluster.net/v1/task/c4P6JY-GSDOjOkoS17kbBg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:24:01 INFO - Downloading https://queue.taskcluster.net/v1/task/c4P6JY-GSDOjOkoS17kbBg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 20:24:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/c4P6JY-GSDOjOkoS17kbBg/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 20:24:05 INFO - Downloaded 111727681 bytes. 20:24:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c4P6JY-GSDOjOkoS17kbBg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:24:05 INFO - mkdir: /builds/slave/test/properties 20:24:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:24:05 INFO - Writing to file /builds/slave/test/properties/build_url 20:24:05 INFO - Contents: 20:24:05 INFO - build_url:https://queue.taskcluster.net/v1/task/c4P6JY-GSDOjOkoS17kbBg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:24:06 INFO - Running post-action listener: _resource_record_post_action 20:24:06 INFO - Running post-action listener: set_extra_try_arguments 20:24:06 INFO - [mozharness: 2016-10-05 03:24:06.800807Z] Finished download-and-extract step (success) 20:24:06 INFO - [mozharness: 2016-10-05 03:24:06.800971Z] Running populate-webroot step. 20:24:06 INFO - Running pre-action listener: _resource_record_pre_action 20:24:06 INFO - Running main action method: populate_webroot 20:24:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:24:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:24:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:24:06 INFO - '--tppagecycles', 20:24:06 INFO - '7'], 20:24:06 INFO - 'tests': ['tsvgm']}}, 20:24:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:24:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:24:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:24:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:24:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:24:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:24:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:06 INFO - 'talos_options': ['--disable-e10s'], 20:24:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:24:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:24:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:06 INFO - 'talos_options': ['--disable-e10s'], 20:24:06 INFO - 'tests': ['damp', 'tps']}, 20:24:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:06 INFO - 'tests': ['damp', 'tps']}, 20:24:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:24:06 INFO - 'tests': ['dromaeo_dom']}, 20:24:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:24:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:24:06 INFO - 'tests': ['basic_compositor_video']}, 20:24:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:24:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:24:06 INFO - 'tests': ['a11yr', 20:24:06 INFO - 'ts_paint', 20:24:06 INFO - 'tpaint', 20:24:06 INFO - 'sessionrestore', 20:24:06 INFO - 'sessionrestore_no_auto_restore', 20:24:06 INFO - 'tabpaint']}, 20:24:06 INFO - 'other-e10s': {'tests': ['a11yr', 20:24:06 INFO - 'ts_paint', 20:24:06 INFO - 'tpaint', 20:24:06 INFO - 'sessionrestore', 20:24:06 INFO - 'sessionrestore_no_auto_restore', 20:24:06 INFO - 'tabpaint']}, 20:24:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:24:06 INFO - 'ts_paint', 20:24:06 INFO - 'tpaint', 20:24:06 INFO - 'sessionrestore', 20:24:06 INFO - 'sessionrestore_no_auto_restore', 20:24:06 INFO - 'tabpaint']}, 20:24:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:24:06 INFO - 'ts_paint', 20:24:06 INFO - 'tpaint', 20:24:06 INFO - 'sessionrestore', 20:24:06 INFO - 'sessionrestore_no_auto_restore', 20:24:06 INFO - 'tabpaint']}, 20:24:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:24:06 INFO - 'tests': ['a11yr', 20:24:06 INFO - 'ts_paint', 20:24:06 INFO - 'tpaint', 20:24:06 INFO - 'sessionrestore', 20:24:06 INFO - 'sessionrestore_no_auto_restore', 20:24:06 INFO - 'tabpaint']}, 20:24:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:24:06 INFO - 'tests': ['a11yr', 20:24:06 INFO - 'ts_paint', 20:24:06 INFO - 'tpaint', 20:24:06 INFO - 'sessionrestore', 20:24:06 INFO - 'sessionrestore_no_auto_restore', 20:24:06 INFO - 'tabpaint']}, 20:24:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:24:06 INFO - 'tests': ['tsvgx', 20:24:06 INFO - 'tsvgr_opacity', 20:24:06 INFO - 'tart', 20:24:06 INFO - 'tscrollx', 20:24:06 INFO - 'cart']}, 20:24:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:24:06 INFO - 'tsvgr_opacity', 20:24:06 INFO - 'tart', 20:24:06 INFO - 'tscrollx', 20:24:06 INFO - 'cart']}, 20:24:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:06 INFO - 'talos_options': ['--disable-e10s'], 20:24:06 INFO - 'tests': ['tp5o']}, 20:24:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:06 INFO - 'tests': ['tp5o']}, 20:24:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:06 INFO - 'talos_options': ['--disable-e10s', 20:24:06 INFO - '--xperf_path', 20:24:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:24:06 INFO - 'tests': ['tp5n']}, 20:24:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:24:06 INFO - 'talos_options': ['--xperf_path', 20:24:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:24:06 INFO - 'tests': ['tp5n']}}, 20:24:06 INFO - 'talos.zip': {'path': '', 20:24:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:24:06 INFO - Running post-action listener: _resource_record_post_action 20:24:06 INFO - [mozharness: 2016-10-05 03:24:06.819860Z] Finished populate-webroot step (success) 20:24:06 INFO - [mozharness: 2016-10-05 03:24:06.820001Z] Running create-virtualenv step. 20:24:06 INFO - Running pre-action listener: _resource_record_pre_action 20:24:06 INFO - Running main action method: create_virtualenv 20:24:06 INFO - Creating virtualenv /builds/slave/test/build/venv 20:24:06 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 20:24:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:24:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:24:06 INFO - Using real prefix '/tools/python27' 20:24:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:24:07 INFO - Installing distribute.............................................................................................................................................................................................done. 20:24:10 INFO - Installing pip.................done. 20:24:10 INFO - Return code: 0 20:24:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:24:10 INFO - Reading from file tmpfile_stdout 20:24:10 INFO - Output received: 20:24:10 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) 20:24:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:10 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 0x10fbb4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb2a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd63bd8be20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c8d30>, '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 0x10f7eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c0b20>, '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.WWqLrILol6/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.gJsKijMZUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 20:24:10 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 20:24:10 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 20:24:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWqLrILol6/Render', 20:24:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:10 INFO - 'HOME': '/Users/cltbld', 20:24:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:10 INFO - 'LOGNAME': 'cltbld', 20:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:10 INFO - 'MOZ_NO_REMOTE': '1', 20:24:10 INFO - 'NO_EM_RESTART': '1', 20:24:10 INFO - 'PAGER': '/bin/cat', 20:24:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:10 INFO - 'PWD': '/builds/slave/test', 20:24:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:10 INFO - 'SHELL': '/bin/bash', 20:24:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gJsKijMZUB/Listeners', 20:24:10 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 20:24:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:10 INFO - 'USER': 'cltbld', 20:24:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:10 INFO - 'XPC_FLAGS': '0x0', 20:24:10 INFO - 'XPC_SERVICE_NAME': '0', 20:24:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:11 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 20:24:11 INFO - Cleaning up... 20:24:11 INFO - Return code: 0 20:24:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:24:11 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')]} 20:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:11 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')]} 20:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:11 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 0x10fbb4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb2a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd63bd8be20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c8d30>, '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 0x10f7eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c0b20>, '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.WWqLrILol6/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.gJsKijMZUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 20:24:11 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 20:24:11 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 20:24:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWqLrILol6/Render', 20:24:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:11 INFO - 'HOME': '/Users/cltbld', 20:24:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:11 INFO - 'LOGNAME': 'cltbld', 20:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:11 INFO - 'MOZ_NO_REMOTE': '1', 20:24:11 INFO - 'NO_EM_RESTART': '1', 20:24:11 INFO - 'PAGER': '/bin/cat', 20:24:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:11 INFO - 'PWD': '/builds/slave/test', 20:24:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:11 INFO - 'SHELL': '/bin/bash', 20:24:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gJsKijMZUB/Listeners', 20:24:11 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 20:24:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:11 INFO - 'USER': 'cltbld', 20:24:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:11 INFO - 'XPC_FLAGS': '0x0', 20:24:11 INFO - 'XPC_SERVICE_NAME': '0', 20:24:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:11 INFO - Downloading/unpacking psutil>=3.1.1 20:24:11 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 20:24:11 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 20:24:11 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 20:24:11 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 20:24:11 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 20:24:11 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 20:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:24:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:24:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:24:14 INFO - Installing collected packages: psutil 20:24:14 INFO - Running setup.py install for psutil 20:24:15 INFO - building 'psutil._psutil_osx' extension 20:24:15 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 20:24:15 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 20:24:15 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 20:24:15 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 20:24:15 INFO - building 'psutil._psutil_posix' extension 20:24:15 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 20:24:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:24:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:24:15 INFO - ^ 20:24:15 INFO - 1 warning generated. 20:24:15 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 20:24:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:24:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:24:15 INFO - Successfully installed psutil 20:24:15 INFO - Cleaning up... 20:24:15 INFO - Return code: 0 20:24:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:24:15 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')]} 20:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:15 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')]} 20:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:15 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 0x10fbb4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb2a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd63bd8be20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c8d30>, '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 0x10f7eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c0b20>, '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.WWqLrILol6/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.gJsKijMZUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 20:24:15 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 20:24:15 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 20:24:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWqLrILol6/Render', 20:24:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:15 INFO - 'HOME': '/Users/cltbld', 20:24:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:15 INFO - 'LOGNAME': 'cltbld', 20:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:15 INFO - 'MOZ_NO_REMOTE': '1', 20:24:15 INFO - 'NO_EM_RESTART': '1', 20:24:15 INFO - 'PAGER': '/bin/cat', 20:24:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:15 INFO - 'PWD': '/builds/slave/test', 20:24:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:15 INFO - 'SHELL': '/bin/bash', 20:24:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gJsKijMZUB/Listeners', 20:24:15 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 20:24:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:15 INFO - 'USER': 'cltbld', 20:24:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:15 INFO - 'XPC_FLAGS': '0x0', 20:24:15 INFO - 'XPC_SERVICE_NAME': '0', 20:24:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:24:16 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 20:24:16 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 20:24:16 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 20:24:16 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 20:24:16 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 20:24:16 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 20:24:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:24:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:24:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:24:18 INFO - Installing collected packages: mozsystemmonitor 20:24:18 INFO - Running setup.py install for mozsystemmonitor 20:24:18 INFO - Successfully installed mozsystemmonitor 20:24:18 INFO - Cleaning up... 20:24:18 INFO - Return code: 0 20:24:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:24:18 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')]} 20:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:18 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')]} 20:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:18 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 0x10fbb4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb2a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd63bd8be20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c8d30>, '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 0x10f7eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c0b20>, '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.WWqLrILol6/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.gJsKijMZUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 20:24:18 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 20:24:18 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 20:24:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWqLrILol6/Render', 20:24:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:18 INFO - 'HOME': '/Users/cltbld', 20:24:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:18 INFO - 'LOGNAME': 'cltbld', 20:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:19 INFO - 'MOZ_NO_REMOTE': '1', 20:24:19 INFO - 'NO_EM_RESTART': '1', 20:24:19 INFO - 'PAGER': '/bin/cat', 20:24:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:19 INFO - 'PWD': '/builds/slave/test', 20:24:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:19 INFO - 'SHELL': '/bin/bash', 20:24:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gJsKijMZUB/Listeners', 20:24:19 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 20:24:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:19 INFO - 'USER': 'cltbld', 20:24:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:19 INFO - 'XPC_FLAGS': '0x0', 20:24:19 INFO - 'XPC_SERVICE_NAME': '0', 20:24:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:19 INFO - Downloading/unpacking jsonschema==2.5.1 20:24:19 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 20:24:19 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 20:24:19 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 20:24:19 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 20:24:19 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 20:24:19 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 20:24:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:24:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:22 INFO - Downloading functools32-3.2.3-2.tar.gz 20:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:24:22 INFO - warning: no files found matching '*.txt' 20:24:22 INFO - no previously-included directories found matching 'build' 20:24:22 INFO - no previously-included directories found matching 'dist' 20:24:22 INFO - no previously-included directories found matching '.git*' 20:24:22 INFO - Installing collected packages: jsonschema, functools32 20:24:22 INFO - Running setup.py install for functools32 20:24:22 INFO - warning: no files found matching '*.txt' 20:24:22 INFO - no previously-included directories found matching 'build' 20:24:22 INFO - no previously-included directories found matching 'dist' 20:24:22 INFO - no previously-included directories found matching '.git*' 20:24:22 INFO - Successfully installed jsonschema functools32 20:24:22 INFO - Cleaning up... 20:24:22 INFO - Return code: 0 20:24:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:24: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')]} 20:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24: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')]} 20:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24: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', '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 0x10fbb4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb2a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd63bd8be20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c8d30>, '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 0x10f7eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c0b20>, '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.WWqLrILol6/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.gJsKijMZUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 20:24: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:24: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 functools32==3.2.3-2 20:24:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWqLrILol6/Render', 20:24:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:22 INFO - 'HOME': '/Users/cltbld', 20:24:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:22 INFO - 'LOGNAME': 'cltbld', 20:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:22 INFO - 'MOZ_NO_REMOTE': '1', 20:24:22 INFO - 'NO_EM_RESTART': '1', 20:24:22 INFO - 'PAGER': '/bin/cat', 20:24:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:22 INFO - 'PWD': '/builds/slave/test', 20:24:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:22 INFO - 'SHELL': '/bin/bash', 20:24:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gJsKijMZUB/Listeners', 20:24:22 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 20:24:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:22 INFO - 'USER': 'cltbld', 20:24:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:22 INFO - 'XPC_FLAGS': '0x0', 20:24:22 INFO - 'XPC_SERVICE_NAME': '0', 20:24:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:24:22 INFO - Cleaning up... 20:24:22 INFO - Return code: 0 20:24:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:24: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')]} 20:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24: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')]} 20:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24: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', '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 0x10fbb4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb2a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd63bd8be20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c8d30>, '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 0x10f7eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c0b20>, '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.WWqLrILol6/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.gJsKijMZUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 20:24: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:24: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 blobuploader==1.2.4 20:24:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWqLrILol6/Render', 20:24:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:22 INFO - 'HOME': '/Users/cltbld', 20:24:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:22 INFO - 'LOGNAME': 'cltbld', 20:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:22 INFO - 'MOZ_NO_REMOTE': '1', 20:24:22 INFO - 'NO_EM_RESTART': '1', 20:24:22 INFO - 'PAGER': '/bin/cat', 20:24:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:22 INFO - 'PWD': '/builds/slave/test', 20:24:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:22 INFO - 'SHELL': '/bin/bash', 20:24:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gJsKijMZUB/Listeners', 20:24:22 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 20:24:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:22 INFO - 'USER': 'cltbld', 20:24:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:22 INFO - 'XPC_FLAGS': '0x0', 20:24:22 INFO - 'XPC_SERVICE_NAME': '0', 20:24:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:23 INFO - Downloading/unpacking blobuploader==1.2.4 20:24:23 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 20:24:23 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 20:24:23 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 20:24:23 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 20:24:23 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 20:24:23 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 20:24:25 INFO - Downloading blobuploader-1.2.4.tar.gz 20:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:24:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:24: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 20:24: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 20:24: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 20:24: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 20:24: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 20:24: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 20:24:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:24:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:24:26 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 20:24:26 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 20:24:26 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 20:24:26 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 20:24:26 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 20:24:26 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 20:24:26 INFO - Downloading docopt-0.6.1.tar.gz 20:24:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:24:26 INFO - Installing collected packages: blobuploader, requests, docopt 20:24:26 INFO - Running setup.py install for blobuploader 20:24:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:24:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:24:26 INFO - Running setup.py install for requests 20:24:27 INFO - Running setup.py install for docopt 20:24:27 INFO - Successfully installed blobuploader requests docopt 20:24:27 INFO - Cleaning up... 20:24:27 INFO - Return code: 0 20:24:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:27 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 0x10fbb4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb2a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd63bd8be20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c8d30>, '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 0x10f7eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c0b20>, '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.WWqLrILol6/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.gJsKijMZUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 20:24:27 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 20:24:27 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 20:24:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWqLrILol6/Render', 20:24:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:27 INFO - 'HOME': '/Users/cltbld', 20:24:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:27 INFO - 'LOGNAME': 'cltbld', 20:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:27 INFO - 'MOZ_NO_REMOTE': '1', 20:24:27 INFO - 'NO_EM_RESTART': '1', 20:24:27 INFO - 'PAGER': '/bin/cat', 20:24:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:27 INFO - 'PWD': '/builds/slave/test', 20:24:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:27 INFO - 'SHELL': '/bin/bash', 20:24:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gJsKijMZUB/Listeners', 20:24:27 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 20:24:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:27 INFO - 'USER': 'cltbld', 20:24:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:27 INFO - 'XPC_FLAGS': '0x0', 20:24:27 INFO - 'XPC_SERVICE_NAME': '0', 20:24:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:24:27 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-r7KZLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:24:27 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-uwSGCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:24:28 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-p0Mb1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:24:28 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-Ax6cIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:24:28 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-qyEBZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:24:28 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-wnXgX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:24:28 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-6YWx0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:24:28 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-w10sK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:24:28 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-CutFqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:24:28 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-hPAxGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:24:28 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-GQk_8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:24:29 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-k91Wh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:24:29 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-9sfPvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:24:29 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-QkJ9O7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:29 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-m754jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:24:29 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-1Wd4UM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:24:29 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-Ecnmli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:24:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:24:29 INFO - Running setup.py install for manifestparser 20:24:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:24:29 INFO - Running setup.py install for mozcrash 20:24:29 INFO - Running setup.py install for mozdebug 20:24:30 INFO - Running setup.py install for mozdevice 20:24:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:24:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:24:30 INFO - Running setup.py install for mozfile 20:24:30 INFO - Running setup.py install for mozhttpd 20:24:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:24:30 INFO - Running setup.py install for mozinfo 20:24:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:24:30 INFO - Running setup.py install for mozInstall 20:24:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:24:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:24:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:24:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:24:30 INFO - Running setup.py install for mozleak 20:24:30 INFO - Running setup.py install for mozlog 20:24:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:24:31 INFO - Running setup.py install for moznetwork 20:24:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:24:31 INFO - Running setup.py install for mozprocess 20:24:31 INFO - Running setup.py install for mozprofile 20:24:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:24:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:24:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:24:31 INFO - Running setup.py install for mozrunner 20:24:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:24:31 INFO - Running setup.py install for mozscreenshot 20:24:31 INFO - Running setup.py install for moztest 20:24:32 INFO - Running setup.py install for mozversion 20:24:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:24:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:24:32 INFO - Cleaning up... 20:24:32 INFO - Return code: 0 20:24:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:24:32 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')]} 20:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:32 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')]} 20:24:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:32 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 0x10fbb4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb2a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd63bd8be20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c8d30>, '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 0x10f7eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c0b20>, '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.WWqLrILol6/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.gJsKijMZUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 20:24:32 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 20:24:32 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 20:24:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWqLrILol6/Render', 20:24:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:32 INFO - 'HOME': '/Users/cltbld', 20:24:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:32 INFO - 'LOGNAME': 'cltbld', 20:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:32 INFO - 'MOZ_NO_REMOTE': '1', 20:24:32 INFO - 'NO_EM_RESTART': '1', 20:24:32 INFO - 'PAGER': '/bin/cat', 20:24:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:32 INFO - 'PWD': '/builds/slave/test', 20:24:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:32 INFO - 'SHELL': '/bin/bash', 20:24:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gJsKijMZUB/Listeners', 20:24:32 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 20:24:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:32 INFO - 'USER': 'cltbld', 20:24:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:32 INFO - 'XPC_FLAGS': '0x0', 20:24:32 INFO - 'XPC_SERVICE_NAME': '0', 20:24:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:24:32 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-T07Fgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:24:32 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)) 20:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:24:32 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-IyjQwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:24:32 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)) 20:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:24:32 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-NkRkrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:24:32 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)) 20:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:24:32 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-chmuaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:24:32 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)) 20:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:24:32 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-KiWmpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:24:33 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)) 20:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:24:33 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-1rDEIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:24:33 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)) 20:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:24:33 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-aYoGf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:24:33 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)) 20:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:24:33 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-oIWjYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:24:33 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)) 20:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:24:33 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-0QYDAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:24:33 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)) 20:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:24:33 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-ysedBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:24:33 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)) 20:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:24:33 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-OaObKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:24:33 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)) 20:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:24:33 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-yhAoix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:24:33 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)) 20:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:24:33 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-dUdl0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:24:33 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)) 20:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:24:33 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-ja6U75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:24:33 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)) 20:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:33 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-jhghrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:34 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)) 20:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:24:34 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-XfXsWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:24:34 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)) 20:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:24:34 INFO - Running setup.py (path:/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/pip-NnhdC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:24:34 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)) 20:24:34 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)) 20:24:34 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)) 20:24:34 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)) 20:24:34 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)) 20:24:34 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)) 20:24:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:24:34 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 20:24:34 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 20:24:34 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 20:24:34 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 20:24:34 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 20:24:34 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 20:24:36 INFO - Downloading blessings-1.6.tar.gz 20:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:24:36 INFO - Installing collected packages: blessings 20:24:36 INFO - Running setup.py install for blessings 20:24:37 INFO - Successfully installed blessings 20:24:37 INFO - Cleaning up... 20:24:37 INFO - Return code: 0 20:24:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:24:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:24:37 INFO - Reading from file tmpfile_stdout 20:24:37 INFO - Current package versions: 20:24:37 INFO - blessings == 1.6 20:24:37 INFO - blobuploader == 1.2.4 20:24:37 INFO - docopt == 0.6.1 20:24:37 INFO - functools32 == 3.2.3-2 20:24:37 INFO - jsonschema == 2.5.1 20:24:37 INFO - manifestparser == 1.1 20:24:37 INFO - mozInstall == 1.12 20:24:37 INFO - mozcrash == 0.17 20:24:37 INFO - mozdebug == 0.1 20:24:37 INFO - mozdevice == 0.48 20:24:37 INFO - mozfile == 1.2 20:24:37 INFO - mozhttpd == 0.7 20:24:37 INFO - mozinfo == 0.9 20:24:37 INFO - mozleak == 0.1 20:24:37 INFO - mozlog == 3.4 20:24:37 INFO - moznetwork == 0.27 20:24:37 INFO - mozprocess == 0.23 20:24:37 INFO - mozprofile == 0.28 20:24:37 INFO - mozrunner == 6.12 20:24:37 INFO - mozscreenshot == 0.1 20:24:37 INFO - mozsystemmonitor == 0.3 20:24:37 INFO - moztest == 0.7 20:24:37 INFO - mozversion == 1.4 20:24:37 INFO - psutil == 3.1.1 20:24:37 INFO - requests == 1.2.3 20:24:37 INFO - wsgiref == 0.1.2 20:24:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:24:37 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')]} 20:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:37 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')]} 20:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:37 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 0x10fbb4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb2a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd63bd8be20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c8d30>, '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 0x10f7eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c0b20>, '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.WWqLrILol6/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.gJsKijMZUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 20:24:37 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 20:24:37 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 20:24:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWqLrILol6/Render', 20:24:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:37 INFO - 'HOME': '/Users/cltbld', 20:24:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:37 INFO - 'LOGNAME': 'cltbld', 20:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:37 INFO - 'MOZ_NO_REMOTE': '1', 20:24:37 INFO - 'NO_EM_RESTART': '1', 20:24:37 INFO - 'PAGER': '/bin/cat', 20:24:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:37 INFO - 'PWD': '/builds/slave/test', 20:24:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:37 INFO - 'SHELL': '/bin/bash', 20:24:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gJsKijMZUB/Listeners', 20:24:37 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 20:24:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:37 INFO - 'USER': 'cltbld', 20:24:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:37 INFO - 'XPC_FLAGS': '0x0', 20:24:37 INFO - 'XPC_SERVICE_NAME': '0', 20:24:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:37 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)) 20:24:37 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)) 20:24:37 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)) 20:24:37 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)) 20:24:37 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)) 20:24:37 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)) 20:24:37 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)) 20:24:37 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)) 20:24:37 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)) 20:24:37 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)) 20:24:37 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)) 20:24:37 INFO - Cleaning up... 20:24:37 INFO - Return code: 0 20:24:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:24:37 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')]} 20:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:37 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')]} 20:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fbb4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fb2a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd63bd8be20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c8d30>, '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 0x10f7eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c0b20>, '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.WWqLrILol6/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.gJsKijMZUB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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 20:24:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:24:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWqLrILol6/Render', 20:24:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:37 INFO - 'HOME': '/Users/cltbld', 20:24:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:37 INFO - 'LOGNAME': 'cltbld', 20:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:37 INFO - 'MOZ_NO_REMOTE': '1', 20:24:37 INFO - 'NO_EM_RESTART': '1', 20:24:37 INFO - 'PAGER': '/bin/cat', 20:24:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:37 INFO - 'PWD': '/builds/slave/test', 20:24:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:37 INFO - 'SHELL': '/bin/bash', 20:24:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gJsKijMZUB/Listeners', 20:24:37 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 20:24:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:37 INFO - 'USER': 'cltbld', 20:24:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:37 INFO - 'XPC_FLAGS': '0x0', 20:24:37 INFO - 'XPC_SERVICE_NAME': '0', 20:24:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:24:37 INFO - Cleaning up... 20:24:37 INFO - Return code: 0 20:24:37 INFO - Running post-action listener: _resource_record_post_action 20:24:37 INFO - Running post-action listener: _start_resource_monitoring 20:24:37 INFO - Starting resource monitoring. 20:24:37 INFO - [mozharness: 2016-10-05 03:24:37.994888Z] Finished create-virtualenv step (success) 20:24:37 INFO - [mozharness: 2016-10-05 03:24:37.995912Z] Running install step. 20:24:37 INFO - Running pre-action listener: _resource_record_pre_action 20:24:37 INFO - Running main action method: install 20:24:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:24:38 INFO - Reading from file tmpfile_stdout 20:24:38 INFO - Detecting whether we're running mozinstall >=1.0... 20:24:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:24:38 INFO - Reading from file tmpfile_stdout 20:24:38 INFO - Output received: 20:24:38 INFO - Usage: mozinstall [options] installer 20:24:38 INFO - Options: 20:24:38 INFO - -h, --help show this help message and exit 20:24:38 INFO - -d DEST, --destination=DEST 20:24:38 INFO - Directory to install application into. [default: 20:24:38 INFO - "/builds/slave/test"] 20:24:38 INFO - --app=APP Application being installed. [default: firefox] 20:24:38 INFO - mkdir: /builds/slave/test/build/application 20:24:38 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'] 20:24:38 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 20:25:13 INFO - Reading from file tmpfile_stdout 20:25:13 INFO - Output received: 20:25:13 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:25:13 INFO - Running post-action listener: _resource_record_post_action 20:25:13 INFO - [mozharness: 2016-10-05 03:25:13.105758Z] Finished install step (success) 20:25:13 INFO - [mozharness: 2016-10-05 03:25:13.105888Z] Running run-tests step. 20:25:13 INFO - Running pre-action listener: _resource_record_pre_action 20:25:13 INFO - Running main action method: run_tests 20:25:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:25:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:25:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:25:13 INFO - 2016-10-04 20:25:13.119 screenresolution[2098:25331] starting screenresolution argv=screenresolution get 20:25:13 INFO - 2016-10-04 20:25:13.121 screenresolution[2098:25331] Display 0: 1600x1200x32@60 20:25:13 INFO - 2016-10-04 20:25:13.126 screenresolution[2099:25333] starting screenresolution argv=screenresolution list 20:25:13 INFO - Available Modes on Display 0 20:25:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:25:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:25:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:25:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:25:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:25:13 INFO - Intel Iris: 20:25:13 INFO - Chipset Model: Intel Iris 20:25:13 INFO - Type: GPU 20:25:13 INFO - Bus: Built-In 20:25:13 INFO - VRAM (Dynamic, Max): 1536 MB 20:25:13 INFO - Vendor: Intel (0x8086) 20:25:13 INFO - Device ID: 0x0a2e 20:25:13 INFO - Revision ID: 0x0009 20:25:13 INFO - Displays: 20:25:13 INFO - Display: 20:25:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:25:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:25:13 INFO - Display Serial Number: 1600x1200 60 20:25:13 INFO - Main Display: Yes 20:25:13 INFO - Mirror: Off 20:25:13 INFO - Online: Yes 20:25:13 INFO - Rotation: Supported 20:25:13 INFO - Return code: 0 20:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:25:13 INFO - Python 2.7.3 20:25:13 INFO - Return code: 0 20:25:13 INFO - grabbing minidump binary from tooltool 20:25:13 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')]} 20:25:13 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 0x10f9c8d30>, '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 0x10f7eedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9c0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:25:13 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 20:25:13 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 20:25:13 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 20:25:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:25:13 INFO - Return code: 0 20:25:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:25:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:25:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:25:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:25:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:25:13 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/c4P6JY-GSDOjOkoS17kbBg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0187', '--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 20:25:13 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/c4P6JY-GSDOjOkoS17kbBg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0187 --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 20:25:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WWqLrILol6/Render', 20:25:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:13 INFO - 'HOME': '/Users/cltbld', 20:25:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:13 INFO - 'LOGNAME': 'cltbld', 20:25:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:25:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:13 INFO - 'MOZ_NO_REMOTE': '1', 20:25:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:25:13 INFO - 'NO_EM_RESTART': '1', 20:25:13 INFO - 'PAGER': '/bin/cat', 20:25:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:13 INFO - 'PWD': '/builds/slave/test', 20:25:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:25:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:13 INFO - 'SHELL': '/bin/bash', 20:25:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gJsKijMZUB/Listeners', 20:25:13 INFO - 'TMPDIR': '/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/', 20:25:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:13 INFO - 'USER': 'cltbld', 20:25:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:13 INFO - 'XPC_FLAGS': '0x0', 20:25:13 INFO - 'XPC_SERVICE_NAME': '0', 20:25:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:13 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/c4P6JY-GSDOjOkoS17kbBg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0187', '--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 20:25:13 INFO - mozversion application_buildid: 20161004174100 20:25:13 INFO - mozversion application_changeset: ea104eeb14cc54da9a06c3766da63f73117723a0 20:25:13 INFO - mozversion application_display_name: Nightly 20:25:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:25:13 INFO - mozversion application_name: Firefox 20:25:13 INFO - mozversion application_remotingname: firefox 20:25:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:25:13 INFO - mozversion application_vendor: Mozilla 20:25:13 INFO - mozversion application_version: 52.0a1 20:25:13 INFO - mozversion platform_buildid: 20161004174100 20:25:13 INFO - mozversion platform_changeset: ea104eeb14cc54da9a06c3766da63f73117723a0 20:25:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:25:13 INFO - mozversion platform_version: 52.0a1 20:25:13 INFO - using testdate: 1475637913 20:25:13 INFO - actual date: 1475637913 20:25:13 INFO - starting webserver on 'localhost:49361' 20:25:13 INFO - SUITE-START | Running 2 tests 20:25:13 INFO - TEST-START | dromaeo_css 20:25:13 INFO - operating with platform_type : mac_ 20:25:13 INFO - Initialising browser for dromaeo_css test... 20:25:13 INFO - TEST-INFO | started process 2109 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/tmp4u95w5/profile http://localhost:49361/getInfo.html) 20:25:16 INFO - PROCESS | 2109 | 2016-10-04 20:25:16.515 plugin-container[2112:25506] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d37, name = 'com.apple.tsm.portname' 20:25:16 INFO - PROCESS | 2109 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:25:16 INFO - PROCESS | 2109 | 2016-10-04 20:25:16.518 plugin-container[2112:25506] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c07, name = 'com.apple.CFPasteboardClient' 20:25:16 INFO - PROCESS | 2109 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:25:16 INFO - PROCESS | 2109 | 2016-10-04 20:25:16.518 plugin-container[2112:25506] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:25:16 INFO - PROCESS | 2109 | __metrics Screen width/height:1600/1200 20:25:16 INFO - PROCESS | 2109 | colorDepth:24 20:25:16 INFO - PROCESS | 2109 | Browser inner width/height: 1024/689 20:25:16 INFO - PROCESS | 2109 | __metrics 20:25:16 ERROR - PROCESS | 2109 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 20:25:17 INFO - TEST-INFO | 2109: exit 0 20:25:17 INFO - Browser initialized. 20:25:17 INFO - Running cycle 1/1 for dromaeo_css test... 20:25:17 INFO - TEST-INFO | started process 2113 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/tmp4u95w5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:19 INFO - PROCESS | 2113 | 2016-10-04 20:25:19.666 plugin-container[2114:25623] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a1f, name = 'com.apple.tsm.portname' 20:25:19 INFO - PROCESS | 2113 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:25:19 INFO - PROCESS | 2113 | 2016-10-04 20:25:19.668 plugin-container[2114:25623] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9103, name = 'com.apple.CFPasteboardClient' 20:25:19 INFO - PROCESS | 2113 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:25:19 INFO - PROCESS | 2113 | 2016-10-04 20:25:19.668 plugin-container[2114:25623] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:25:29 INFO - PROCESS | 2113 | RSS: Main: 239656960 20:25:29 INFO - PROCESS | 2113 | 20:26:18 INFO - PROCESS | 2113 | 1475637978893 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] 20:28:32 INFO - PROCESS | 2113 | Cycle 1(1): loaded http://localhost:49361/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49361/tests/dromaeo/cssquery-ext.html) 20:28:33 INFO - PROCESS | 2113 | RSS: Main: 253550592 20:28:33 INFO - PROCESS | 2113 | 20:31:36 INFO - PROCESS | 2113 | Cycle 1(1): loaded http://localhost:49361/tests/dromaeo/cssquery-ext.html (next: http://localhost:49361/tests/dromaeo/cssquery-jquery.html) 20:31:36 INFO - PROCESS | 2113 | RSS: Main: 266539008 20:31:36 INFO - PROCESS | 2113 | 20:34:38 INFO - PROCESS | 2113 | Cycle 1(1): loaded http://localhost:49361/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49361/tests/dromaeo/cssquery-mootools.html) 20:34:39 INFO - PROCESS | 2113 | RSS: Main: 270135296 20:34:39 INFO - PROCESS | 2113 | 20:37:41 INFO - PROCESS | 2113 | Cycle 1(1): loaded http://localhost:49361/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49361/tests/dromaeo/cssquery-prototype.html) 20:37:41 INFO - PROCESS | 2113 | RSS: Main: 269860864 20:37:41 INFO - PROCESS | 2113 | 20:40:44 INFO - PROCESS | 2113 | Cycle 1(1): loaded http://localhost:49361/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49361/tests/dromaeo/cssquery-yui.html) 20:40:45 INFO - PROCESS | 2113 | RSS: Main: 275251200 20:40:45 INFO - PROCESS | 2113 | 20:43:48 INFO - PROCESS | 2113 | Cycle 1(1): loaded http://localhost:49361/tests/dromaeo/cssquery-yui.html (next: http://localhost:49361/tests/dromaeo/cssquery-dojo.html) 20:43:48 INFO - PROCESS | 2113 | RSS: Main: 278061056 20:43:48 INFO - PROCESS | 2113 | 20:43:48 INFO - PROCESS | 2113 | __start_tp_report 20:43:48 INFO - PROCESS | 2113 | _x_x_mozilla_page_load 20:43:48 INFO - PROCESS | 2113 | _x_x_mozilla_page_load_details 20:43:48 INFO - PROCESS | 2113 | |i|pagename|runs| 20:43:48 INFO - PROCESS | 2113 | |0;dojo.html;3244.1889527618096;3316.9668303316957;3370.983145084275;3380.5098260752193;3401.6258211596705;5510.897820435909;5518.779248830042;5548.361938377087;5583.274174357333;5666.150077488379;4970.70175789452;5120.975804839038;5566.916496252559;5607.355154157273;5685.573581981347;3945.8359783863684;5067.79728810849;5087.7710503027265;5160.767765450564;5189.948100518985;4554.772261386934;4628.976855115719;5247.763850626712;5256.526912577867;5346.438623944488;4378.868633940987;5052.873678158038;5095.617828662828;5189.299444574972;5211.504907033864;5139.331886854722;5171.715555644438;5173.3533308336455;5206.583473322163;5239.318888544503;5098.388193416777;5115.590752739772;5137.357830271216;5138.7687554059785;5170.172772356443;4585.197590421662;5438.048341540215;5499.450054994509;5534.142207957773;5608;5283.154695248781;6128.662923539204;6158.630482171084;6180.2892667343385;6188.87622247557;6186.721597528122;6200.906986395207;6213.813585592439;6221.9688901555655;6234.407731265523;5638.774449022075;5676.971615141898;5744.569157313134;5748.19525266463;5801.680907550083;6178.41305076017;6179.28938172107;6192.628442293477;6227.719752611143;6242.032484964838;6076.787312444043;6102.5577043044295;6107.816765497042;6119.265688117454;6131.570790044743;6040.033594624839;6069.544784141207;6141.499429959709;6187.133801267826;6199.070139479114;6058;6096.786612468542;6105.755769769248;6106.278657334014;6110.358412366726;6110.205673262536;6131.724072416663;6170.290416602148;6192.195014648067;6204.7828326008375;4897.412310522689;4901.117798796251;4901.975490122527;4906.705597664151;4917.975410122926;4221.366794980778;4277.465316835395;4331.306990881444;4351.521332653406;4439.334099884978;5687.146927960839;5702.885942281131;5703.230063941315;5719.170720245541;5776.855578610568;6169.136320915076;6185;6211.875762484725;6225.3774622537385;6234.937650623527;5462.508374246337;5498.835034948878;5537.390887002426;5666.320041595035;5670.347909990404;5265.368155821326;5298.178782288752;5337.226102215157;5383.057964856134;5386.757595908193;6092.238470191226;6198.721057552421;6212.099245609271;6222.346653601488;6225.875482490415;6098.481629061579;6115.666295175977;6179.474744646755;6211.782587609412;6229.875402491834;6093.634381937098;6164.969175154275;6189.659568723763;6217.098520714561;6251.906221406592;4415.867523974158;4925.975370123127;5461.9076184764;5837.912431313619;6172.382761723792;4930.9506904930495;6051.7579296827635;6057.57596968208;6146.094710639716;6227.408396202353;5142.871428214175;5353.089974704231;5957.970210148921;5962.2249107615735;5986.790462333797;5868.38381969887;5910.970445147918;5918.201042859159;5950.851228719317;5957.731902064331;5141.38303403594;5637.098064309691;5790.01569733138;5795.797147099831;5825.097109947965;6017.879642407215;6080.543959203166;6094.055421409688;6119.112728654409;6127.172831667668;5854.151148083589;5885.61743486672;5901.026330655565;5911.645301281937;5919.970400147971 20:43:48 INFO - PROCESS | 2113 | |1;ext.html;518.1424742051904;531.5481840435629;546.8796864689767;564.9943500564993;566.0179588414103;27703;38889.805550972276;38942.610573894286;38962.22075558491;39119.82640520789;39389.212215755666;39640.60359396405;40156;40244.597554024454;40335.39496907549;9493.193078588329;9756.512174391288;9770.801569646808;9795.412275263472;9798.510074496282;9649.614015439374;9774.413535187876;9775.217982561413;9778.608855645802;9780.755481112958;9740.220782337396;9765.462899540522;9779.511024448784;9806.411615303068;9807.950960245189;9691.466969316685;9696.90303096967;9781.706548803548;9786.657466988621;9799.922008579051;9524.476153811538;9632.181264592518;9642.325037247396;9650.227981761442;9656.27577931658;36475.452868207;38478.80760596207;38838.22323553513;38915.83252502429;39030.02424939371;3031.4846476098896;3097.659257481675;3258.3157536917274;3339.782914110575;3381.830908454592;29422.411551768844;30438.239044023856;30483.69516304853;30715.9249426269;30890.84554577235;3200.775945683803;3256.462683657194;3263.526788615661;3332.23358627517;3347.815870127142;503909;506923;510254.9999999963;510623.4468827669;512388.43805781106;60171.78797484134;60211;60764.08853867195;60830;60856.391436085956;61680.45798855065;61967.690161548904;62096.68951655213;62102.378976210566;63189.68405158037;15656.530304090895;15840.366385344687;15912.681746365239;15937;15972.840271597368;12183.269003859798;12244.877551224374;12304.692382690326;12310.876891231152;12326.691832704255;18061.458156255332;18362.81637183638;18380.989045602353;18384.908075459538;18393.356232531798;6821.69302381394;7605.277498637621;8124.715634952749;8139.877901831477;8193.918060819315;837.3175861672718;909.8635204719345;929.953502324881;968.9002981615916;1071.164491696478;29381.97163099281;29485;29756.2560935974;30152.777777777777;30191.396172076435;885.7201344057903;972.8394814855611;1006.2754816532085;1010.6361709784471;1042.9113525350278;14894.925525372304;15368.308426120851;15415.460458883885;15461.922690386476;15778.842211577967;642080;667503;675120;675916;679605;56102.719486402304;56323;56374;56401.153982690295;56544;1143.816989281711;1366.6924941887996;1383.7993490943757;1385.6674398144573;1387.8820300274388;25670.87164564165;27936.86031569829;29665.406691866472;30629;31376.529352060195;48503.27245091397;48567.514324857715;48634.297799576845;48664.51335486741;48906.75546622244;416236;523266;528606;529102;529109;26492.735072649026;26706.19881403561;26919.461610768067;26945.73054269432;26956.191314260603;35395.115122121126;44238.11523769571;44709.10581788411;44969.775151124035;45923.31115033344;37222.44166337561;37271.25457490889;37777;38581.614183858925;39060.41409378805;37127.88616341514;37466.625333747405;38378.61621383862;38594.80702596469;38612.61387386203;29903;36514.26971460503;36916.89249322525;37005.81497092605;38252;29599;30177;32570;34045;34079.48880766741;21703.34889953304;22375.552488950456;24360.903759331228;24939.750602494467;25566.87216563905 20:43:48 INFO - PROCESS | 2113 | |2;jquery.html;366.5930816793359;372.19419955795706;372.37255224945983;376.5575448847603;395.88915103770955;19506.609867802636;20554;20629.690554641675;21036.263730769446;21356.932153392307;20598.69101963468;20702.826203248667;20788.960551972417;21122.260720874736;21126;5672.8865422691415;5771.50942169916;5941.346451890288;6069.271687397519;6157.876842463148;3299.2411745298596;4083.183363327332;6073.483753880903;6116.877662446771;6161.322254552018;4384.868453946371;4387.451568553931;5618.027336534909;6810.59136451812;6817.69320380584;5617.943820561783;6676.632785196813;6765.086713293692;6789.93210067898;6794.524383293171;5891.057430811093;5948.31594366649;5950.077737950624;5961.552883533709;5972.522198224132;13251.46994120234;17415.912920435316;25552.616710749353;25573.872130639415;25685;2067.8759274443432;2153.418576984221;2189.1243502599086;2350.3771500552366;2979.2105092150596;9277.860832087525;9403.952980235055;9892.703218903445;10004;10032.849507257397;1541.9383224671;1803.9729404058949;1845.151230434002;1846.7876194237701;1874.1378965675806;118030;123261;123760;123983;126120;10455.634052808267;11517.884821151682;11580.710482238012;11638;11833.467493962793;13015.088943773844;13876;14481.92759036198;14530.200838953959;14535.78196327056;6561.967190164019;6951.965240173767;7283.308085731847;7999.240072193133;8573.657053717781;6618.569792963442;7134.3579077882205;7187.353138217585;8296.917030829734;8504.829903402022;4497.145542346943;4539.795709193094;4559.635229181657;4626;4657.441107067106;1911.6559019376368;1961.6076784642844;1965.1058768260407;1965.2040923426036;1980.5543752655537;370.25024325740054;375.14841310226177;401.283708580183;412.8720096770011;651.3909494622543;11683.474243659055;11746.647600571996;11776.52893884235;12126.514939402501;12165.5133794649;422.7463521886905;424.5923913043513;425.68073944541595;429.24667209048545;445.2564217756355;6148.292946311231;6152.569320147636;6191.721372538246;6223.626582405071;6233.34549872266;581857;600431;605633.2560199845;607654;613167;86826;125031;129042.35478822734;137941;141389.5861041397;434.5871422148971;439.3366017313815;442.40938347306064;445.1319926144032;446.87487503499074;8129.8374032520205;11305.71735706614;11333.916302311056;11551.480183391599;11660.242084264495;54154.54635401301;54165;54792.45207548033;55293.61765955883;55655.72172139275;81614.59192703999;82295.354092919;82300;83106.58446707728;83162;7792.532448053135;7979.760607181794;8038.356931445353;8134;8157;9639.614415423304;12144.817827732415;12213.267203967791;12415.130940834055;12667.619971400873;10385.273030887765;10566.524506397383;10775.784484310114;11001.00990910822;11026.503807328529;8545.658173672984;9879.308448408543;10121.291509594257;10189.745256368353;10667.46662666848;8621.396502245034;10727.034566889017;10921.453927303763;11080.39057851826;11350.091992640404;7832.686692532235;8014.679412823421;8036.598170091355;8153.9184608153155;8169.877451838346;10271.486425678835;10650.147988160774;10741;10816.459177040959;11061.889381106408 20:43:48 INFO - PROCESS | 2113 | |3;mootools.html;1204.734958309172;1505.713914356272;1704.0542498913105;1878.4646375782904;1927.190579956418;8117.878231826513;8349.749507514769;8635.870461943068;9255.444673319596;9309.115634014766;8674.26268767154;8993.820123597525;9017.864732029026;9075.81848363034;9111.088891110885;2351.3651314145213;2374.560706269337;2382.940426489343;2385.105585405473;2386.8185248302116;2299.034405549665;2333.428310064037;2341.508283260509;2345.2143531916745;2357.281029286067;2328.662343960125;2346.9673343728705;2349.718033835942;2367.5501654685554;2371.490129622131;2281.1103669568884;2298.793108620224;2311.4221444638843;2314.4561028158287;2345.7185137783404;2344.120954642009;2348.5537747827857;2349.9060037598474;2352.1061996441244;2353.164626557582;8919.68781092665;9043;9044.8643270351;9104.499252541107;9110.954445227797;5264.947350526484;5273.683578985235;5324.866878328034;5375.22059301403;5429.321334833146;3549.94675079874;3685.281370132825;3735.2156047230114;3762.3792074307707;3768.4158955361963;1046.529061922138;1083.3608171179042;1083.913286937043;1107.2360071550686;1107.7341438054889;9699;11929.821052684216;12047.096467764954;12095.93952030243;12101.394930253453;4524.5927866492175;4723.95276047242;4804.2073057945045;4842.467328593852;4847.709137451764;10102.343347682525;10215.182785377152;10220.642277520252;10234.59061637541;10236.48817559134;5417.5395091416885;5418.83743487696;5426.945730542644;5433.157860531624;5433.782648694008;4448.7108337957925;4605.240135377692;4712.24604063355;4942.085714142895;4944.629152813553;3417.863285468603;3867.9806600967377;3885.8834234972996;3958.426028225949;4082.9387559186634;1274.1654216488214;1287.9484820607258;1296.7665820152463;1299.2074834351038;1311.0887932886742;774.3688893551737;827.6747574014125;834.2783492279256;885.8981217159981;935.1209862729013;5624.746886390122;5732.828015159552;5919.6152250103605;5999.970000149971;6038.8899716645965;842.9294795609542;909.4043401571848;945.432740355781;967.9467629280316;1063.7659714862718;3738.32710112177;3907.33575292201;3932.390479475686;4029.6171863672903;4071.1247081877536;8180.6501927182535;8422.326213902874;9680.903190968;9944.552495137736;10153.289269751194;9911.950440247752;10017.04838040385;10056.396616203052;10151.340162889388;10169.288149829588;7953.403494737918;8206.466579672422;8243.711470098518;8377.539235342114;8382.664693412195;5835.620684655484;5977.193078934288;6149.292831324455;6180.258368995569;6191;9122.677211804385;9398.248140148908;9752.46361450127;10021.799564008534;10124.493775311352;8528.360372971927;10030.247731420319;10191.694249172537;10273.486325683536;10375.325603835727;7589.013428254291;7647.464677472523;7687.5387476751575;7715.537067775951;7757.883631745415;8351.24838764514;8454.40819142654;8457.196566326189;8460.703875364332;8469.830603387774;7476.214997425192;7599.392048636207;7617.27635874591;7645.120811106794;7733.188015258542;5888.705564721832;6313.494920406449;7309.232530584425;7490.737824176128;7504.1370242420635;6953.20038195614;6968.581885086911;6977.1976222733;7039.908814133817;7051.153861536648;5018.920931999638;5056.64603477753;5108.872278193075;5112.3865136183895;5181.5595674368105;5050.898982020412;5059.772310245974;5171.715555644476;5219.582433405394;5253.789848406021 20:43:48 INFO - PROCESS | 2113 | |4;prototype.html;299.74671402664745;301.41074199939106;307.69384462459857;313.4076595235006;315.52198419394637;4772.308015337782;5154.896902061956;5419.187121931712;5535.501804837564;5581.469760372763;4001.859934902279;4446.310402047226;4867.902641947159;5344.866378340544;5418.241446197526;4007.418924255981;4145.502539695241;4155.31437312843;4177.579622928204;4179.79101044948;3517.891864062825;3963.4451176835264;4181.958180418187;4198.6011328923705;4213.9578604213875;3429.331280400323;3779.639329841255;4128.442660240874;4148.730332528391;4154.189932963073;3615.927681446383;3914.4324073009398;3980.5024371953505;3986.142979259444;4127.938080928789;3386.8306584670913;3528.8059156746367;3533.5406397168204;3631.8184090795353;3637.2361804020925;4216.409702641633;4383.671224658164;4808.783604737795;4955.355803745526;5236.633435659505;4710;4718.764061796931;4721.834735784231;4735.550122738335;4790.784414701347;4775.880602984918;5572.721363931828;5708.7145642718115;5742.425757424266;5793.536517078624;3896.2207558488417;3899.922001559953;3908.687305015592;3909.257241124206;3923.686105111613;4836.540528649773;6089.325435505271;6096.359882212349;6102.199851043953;6144.371741488464;3777.7711150421383;3952.703547233969;3958.9010274743364;3966.920661586752;3969.900752481153;3198.7441004719567;3567.2687099144614;3997.5003124609425;4014.197160567898;4042.8787136385367;4099.1801639672185;4721.551452611996;4733.83431579893;4743.31221972812;4775.570198682066;4228.9577104228565;5533.916991245134;5577.609567330248;5651.803326595655;5871.2073870027;1178.793711100571;1286.2796833773118;1301.4533895763802;1333.6532501549666;1337.5051231044577;734.372111844376;857.6355049104105;860.5095095795336;908.0692290402391;922.9953850230706;5356.223347614652;5384.461553844584;5390.946090539122;5395.892082158335;5419.674819510842;4446.5553444655925;5207.531322181022;5703.94477021744;5832.416758324219;5849.912251316234;4472.485664148599;4955.175549936502;5296.285001524822;5395.163749618815;5411.648242864201;2277.407873952784;2613.4773045391;2614.503244383561;2621.8164728469205;2655.8314341689593;4288.335308027261;4620.3993480847275;5042.621803364762;5044.949550504448;5046.571041461443;4031.1333063390925;4236.6187043166265;4241.151769646083;4853.95146048535;5033.395992480926;4582.862514124648;4617.353570500132;4909.852704418873;4910.386201724785;5009.874753131201;4824.541668541483;4904.239842824368;4939.925231402891;4991.376077990251;5000.574951129195;4391.8462853799965;4422.031438341026;4660.883477912944;4887.584555312838;4931.901361972668;4476.865694029184;4657.86026419208;4979.775910084128;4996.475370086088;5049.469805670498;3110.331278775074;3203.4714272144834;3398.3033478137418;3433.9656603433646;3435.9828200858838;4346.434963454731;4753;4854.3252577861995;4918.606511479002;5703.771849125988;5046.016026874724;5122.487751224997;5753.309602847685;5771.740271687868;5775.545393207954;4777.689450185727;5176.922346164886;5274.206769698321;5359.3032905722;5408.268294876522;4923.729194894315;5322.893542129058;5528.364238112507;5635.690037048002;5669.31968163823;5734.2258795062135;5764.971175144097;5779.450952159538;5795.710214489174;5847.502962248086;4752.52474752522;5402.837914862561;5670.234518339971;5684.8010319638615;5689.971550142222 20:43:48 INFO - PROCESS | 2113 | |5;yui.html;702.5960072958048;712.4905692429911;716.6631683108938;756.8788993761;761.9695212191515;12405.875941240585;15735.134567598778;15752.527424177293;15788.84211157888;15792.289346979385;14272;14391.424343026292;14426.495072672458;14427.206503642296;14428.85571144291;662.2847324889133;686.1491750229729;800.9599520024004;819.848328059308;820.9671613135482;848.0925409811504;848.321342925657;848.516345682961;851.5103815306193;853.0019876744193;905.5110240470138;906.542196190926;907.3013779389865;907.4782000349792;909.0318810466831;736.8121129112069;742.5618884857905;903.1781079217881;905.4341036851968;905.7871400220976;662.7945336945562;668.2815972829179;668.3683918696834;668.8227619680788;670.9261981182066;14257.144571325754;14473.710525789531;14696.412143514353;14717.92641036788;14752.704945901129;14349.78475322871;14432.567022989328;14460.421583136662;14462.638434039232;14500.564983050524;11711.121665875093;11819.34993575353;11916.106292028046;11922.22505537146;11935.343556104412;3745.550533935918;3765.6987441004653;3804.372278574032;3818.236352729465;3822.789746563938;103337;109181.90818091876;111478.32782508268;111589;111851.44074279658;11119.054880335101;11135;11239.325640461599;11461.312321260752;11618;22998;23085.653715194287;23136.53726925452;23137.53724925492;23147.305580832603;7926.24700653437;7960.840783184304;8029.076656184614;8046.275835174863;8226;4308;4333.285007973712;4401.317795741666;4410.691251612357;4510.864674059783;3552.573691157026;3653.324135035027;3668.4680721295263;3670.3943849265106;3683.686886614668;637.8819918315127;641.4611726150056;656.2682608891148;658.3120638932327;662.2285037930853;630.9747610095545;633.2306247908813;638.8658381739793;639.5331408072041;640.2381166411955;9285.164335209864;9328.580213890391;9334.299927505464;9387.389819661701;9567.665131720356;610.0807635464282;617.545679923773;622.1149915755269;648.2836465705328;691.0705101638289;3618.3848745713294;3633.7638053526434;4050.7772072536295;4379.540148284448;4477.082198149372;163700;165152;165612;165909.3409065918;168681;74089.88865167026;77014;93013;123841;125390;69746;70214.64892675504;94641;102092.48953755184;111817.99999999837;9764.804703906024;9797.412155270707;9940.552675129782;10015.899841001497;10062.89937100649;61907.690461547405;62976.37023629705;64369.35630643633;66023.33976660365;66203.66898165479;81544.59227703823;95266;98275.01724982659;99718;102487;10241.518028075023;11117.666470005914;12240.632781016584;12635.494580216688;12786.552470663482;12123.515059397525;14624.561263162122;14747.852521474648;14759.704805904037;15240.314185861442;10491.68524944253;13188.472461101448;13471.12437691547;13513.527026554024;13758.518451854137;13044.347782610641;13260.469581217028;13662.453501860213;13676.042677012514;13726.86273137256;12224.327661978676;12409.255444673348;12421.503139874303;12777.552785652457;12961.481540738265;11027.22809403334;11128.777424451304;11206.20700687886;11438.37088960082;11720.941395292968;8008.0669718405525;10655.733606659585;11477.483513241757;11484.138689598147;11533.942330288295 20:43:48 INFO - PROCESS | 2113 | __end_tp_report 20:43:48 INFO - PROCESS | 2113 | __start_cc_report 20:43:48 INFO - PROCESS | 2113 | _x_x_mozilla_cycle_collect,359 20:43:48 INFO - PROCESS | 2113 | __end_cc_report 20:43:48 INFO - PROCESS | 2113 | __startTimestamp1475639028353__endTimestamp 20:43:48 INFO - PROCESS | 2113 | 20:43:48 INFO - PROCESS | 2113 | ------- Summary: start ------- 20:43:48 INFO - PROCESS | 2113 | Number of tests: 6 20:43:48 INFO - PROCESS | 2113 | 20:43:48 INFO - PROCESS | 2113 | [#0] dojo.html Cycles:165 Average:5591.28 Median:5776.86 stddev:667.93 (11.6%) stddev-sans-first:644.10 20:43:48 INFO - PROCESS | 2113 | Values: 3244.2 3317.0 3371.0 3380.5 3401.6 5510.9 5518.8 5548.4 5583.3 5666.2 4970.7 5121.0 5566.9 5607.4 5685.6 3945.8 5067.8 5087.8 5160.8 5189.9 4554.8 4629.0 5247.8 5256.5 5346.4 4378.9 5052.9 5095.6 5189.3 5211.5 5139.3 5171.7 5173.4 5206.6 5239.3 5098.4 5115.6 5137.4 5138.8 5170.2 4585.2 5438.0 5499.5 5534.1 5608.0 5283.2 6128.7 6158.6 6180.3 6188.9 6186.7 6200.9 6213.8 6222.0 6234.4 5638.8 5677.0 5744.6 5748.2 5801.7 6178.4 6179.3 6192.6 6227.7 6242.0 6076.8 6102.6 6107.8 6119.3 6131.6 6040.0 6069.5 6141.5 6187.1 6199.1 6058.0 6096.8 6105.8 6106.3 6110.4 6110.2 6131.7 6170.3 6192.2 6204.8 4897.4 4901.1 4902.0 4906.7 4918.0 4221.4 4277.5 4331.3 4351.5 4439.3 5687.1 5702.9 5703.2 5719.2 5776.9 6169.1 6185.0 6211.9 6225.4 6234.9 5462.5 5498.8 5537.4 5666.3 5670.3 5265.4 5298.2 5337.2 5383.1 5386.8 6092.2 6198.7 6212.1 6222.3 6225.9 6098.5 6115.7 6179.5 6211.8 6229.9 6093.6 6165.0 6189.7 6217.1 6251.9 4415.9 4926.0 5461.9 5837.9 6172.4 4931.0 6051.8 6057.6 6146.1 6227.4 5142.9 5353.1 5958.0 5962.2 5986.8 5868.4 5911.0 5918.2 5950.9 5957.7 5141.4 5637.1 5790.0 5795.8 5825.1 6017.9 6080.5 6094.1 6119.1 6127.2 5854.2 5885.6 5901.0 5911.6 5920.0 20:43:48 INFO - PROCESS | 2113 | 20:43:48 INFO - PROCESS | 2113 | [#1] ext.html Cycles:180 Average:68894.24 Median:38952.42 stddev:151515.24 (389.0%) stddev-sans-first:151853.31 20:43:48 INFO - PROCESS | 2113 | Values: 518.1 531.5 546.9 565.0 566.0 27703.0 38889.8 38942.6 38962.2 39119.8 39389.2 39640.6 40156.0 40244.6 40335.4 9493.2 9756.5 9770.8 9795.4 9798.5 9649.6 9774.4 9775.2 9778.6 9780.8 9740.2 9765.5 9779.5 9806.4 9808.0 9691.5 9696.9 9781.7 9786.7 9799.9 9524.5 9632.2 9642.3 9650.2 9656.3 36475.5 38478.8 38838.2 38915.8 39030.0 3031.5 3097.7 3258.3 3339.8 3381.8 29422.4 30438.2 30483.7 30715.9 30890.8 3200.8 3256.5 3263.5 3332.2 3347.8 503909.0 506923.0 510255.0 510623.4 512388.4 60171.8 60211.0 60764.1 60830.0 60856.4 61680.5 61967.7 62096.7 62102.4 63189.7 15656.5 15840.4 15912.7 15937.0 15972.8 12183.3 12244.9 12304.7 12310.9 12326.7 18061.5 18362.8 18381.0 18384.9 18393.4 6821.7 7605.3 8124.7 8139.9 8193.9 837.3 909.9 930.0 968.9 1071.2 29382.0 29485.0 29756.3 30152.8 30191.4 885.7 972.8 1006.3 1010.6 1042.9 14894.9 15368.3 15415.5 15461.9 15778.8 642080.0 667503.0 675120.0 675916.0 679605.0 56102.7 56323.0 56374.0 56401.2 56544.0 1143.8 1366.7 1383.8 1385.7 1387.9 25670.9 27936.9 29665.4 30629.0 31376.5 48503.3 48567.5 48634.3 48664.5 48906.8 416236.0 523266.0 528606.0 529102.0 529109.0 26492.7 26706.2 26919.5 26945.7 26956.2 35395.1 44238.1 44709.1 44969.8 45923.3 37222.4 37271.3 37777.0 38581.6 39060.4 37127.9 37466.6 38378.6 38594.8 38612.6 29903.0 36514.3 36916.9 37005.8 38252.0 29599.0 30177.0 32570.0 34045.0 34079.5 21703.3 22375.6 24360.9 24939.8 25566.9 20:43:48 INFO - PROCESS | 2113 | 20:43:48 INFO - PROCESS | 2113 | [#2] jquery.html Cycles:180 Average:34430.41 Median:2248.03 stddev:100746.91 (4481.6%) stddev-sans-first:100997.07 20:43:48 INFO - PROCESS | 2113 | Values: 366.6 372.2 372.4 376.6 395.9 19506.6 20554.0 20629.7 21036.3 21356.9 20598.7 20702.8 20789.0 21122.3 21126.0 5672.9 5771.5 5941.3 6069.3 6157.9 3299.2 4083.2 6073.5 6116.9 6161.3 4384.9 4387.5 5618.0 6810.6 6817.7 5617.9 6676.6 6765.1 6789.9 6794.5 5891.1 5948.3 5950.1 5961.6 5972.5 13251.5 17415.9 25552.6 25573.9 25685.0 2067.9 2153.4 2189.1 2350.4 2979.2 9277.9 9404.0 9892.7 10004.0 10032.8 1541.9 1804.0 1845.2 1846.8 1874.1 118030.0 123261.0 123760.0 123983.0 126120.0 10455.6 11517.9 11580.7 11638.0 11833.5 13015.1 13876.0 14481.9 14530.2 14535.8 6562.0 6952.0 7283.3 7999.2 8573.7 6618.6 7134.4 7187.4 8296.9 8504.8 4497.1 4539.8 4559.6 4626.0 4657.4 1911.7 1961.6 1965.1 1965.2 1980.6 370.3 375.1 401.3 412.9 651.4 11683.5 11746.6 11776.5 12126.5 12165.5 422.7 424.6 425.7 429.2 445.3 6148.3 6152.6 6191.7 6223.6 6233.3 581857.0 600431.0 605633.3 607654.0 613167.0 86826.0 125031.0 129042.4 137941.0 141389.6 434.6 439.3 442.4 445.1 446.9 8129.8 11305.7 11333.9 11551.5 11660.2 54154.5 54165.0 54792.5 55293.6 55655.7 81614.6 82295.4 82300.0 83106.6 83162.0 7792.5 7979.8 8038.4 8134.0 8157.0 9639.6 12144.8 12213.3 12415.1 12667.6 10385.3 10566.5 10775.8 11001.0 11026.5 8545.7 9879.3 10121.3 10189.7 10667.5 8621.4 10727.0 10921.5 11080.4 11350.1 7832.7 8014.7 8036.6 8153.9 8169.9 10271.5 10650.1 10741.0 10816.5 11061.9 20:43:48 INFO - PROCESS | 2113 | 20:43:48 INFO - PROCESS | 2113 | [#3] mootools.html Cycles:180 Average:5687.07 Median:5110.63 stddev:3134.93 (61.3%) stddev-sans-first:3125.61 20:43:48 INFO - PROCESS | 2113 | Values: 1204.7 1505.7 1704.1 1878.5 1927.2 8117.9 8349.7 8635.9 9255.4 9309.1 8674.3 8993.8 9017.9 9075.8 9111.1 2351.4 2374.6 2382.9 2385.1 2386.8 2299.0 2333.4 2341.5 2345.2 2357.3 2328.7 2347.0 2349.7 2367.6 2371.5 2281.1 2298.8 2311.4 2314.5 2345.7 2344.1 2348.6 2349.9 2352.1 2353.2 8919.7 9043.0 9044.9 9104.5 9111.0 5264.9 5273.7 5324.9 5375.2 5429.3 3549.9 3685.3 3735.2 3762.4 3768.4 1046.5 1083.4 1083.9 1107.2 1107.7 9699.0 11929.8 12047.1 12095.9 12101.4 4524.6 4724.0 4804.2 4842.5 4847.7 10102.3 10215.2 10220.6 10234.6 10236.5 5417.5 5418.8 5426.9 5433.2 5433.8 4448.7 4605.2 4712.2 4942.1 4944.6 3417.9 3868.0 3885.9 3958.4 4082.9 1274.2 1287.9 1296.8 1299.2 1311.1 774.4 827.7 834.3 885.9 935.1 5624.7 5732.8 5919.6 6000.0 6038.9 842.9 909.4 945.4 967.9 1063.8 3738.3 3907.3 3932.4 4029.6 4071.1 8180.7 8422.3 9680.9 9944.6 10153.3 9912.0 10017.0 10056.4 10151.3 10169.3 7953.4 8206.5 8243.7 8377.5 8382.7 5835.6 5977.2 6149.3 6180.3 6191.0 9122.7 9398.2 9752.5 10021.8 10124.5 8528.4 10030.2 10191.7 10273.5 10375.3 7589.0 7647.5 7687.5 7715.5 7757.9 8351.2 8454.4 8457.2 8460.7 8469.8 7476.2 7599.4 7617.3 7645.1 7733.2 5888.7 6313.5 7309.2 7490.7 7504.1 6953.2 6968.6 6977.2 7039.9 7051.2 5018.9 5056.6 5108.9 5112.4 5181.6 5050.9 5059.8 5171.7 5219.6 5253.8 20:43:48 INFO - PROCESS | 2113 | 20:43:48 INFO - PROCESS | 2113 | [#4] prototype.html Cycles:180 Average:4362.78 Median:4773.94 stddev:1335.72 (28.0%) stddev-sans-first:1304.19 20:43:48 INFO - PROCESS | 2113 | Values: 299.7 301.4 307.7 313.4 315.5 4772.3 5154.9 5419.2 5535.5 5581.5 4001.9 4446.3 4867.9 5344.9 5418.2 4007.4 4145.5 4155.3 4177.6 4179.8 3517.9 3963.4 4182.0 4198.6 4214.0 3429.3 3779.6 4128.4 4148.7 4154.2 3615.9 3914.4 3980.5 3986.1 4127.9 3386.8 3528.8 3533.5 3631.8 3637.2 4216.4 4383.7 4808.8 4955.4 5236.6 4710.0 4718.8 4721.8 4735.6 4790.8 4775.9 5572.7 5708.7 5742.4 5793.5 3896.2 3899.9 3908.7 3909.3 3923.7 4836.5 6089.3 6096.4 6102.2 6144.4 3777.8 3952.7 3958.9 3966.9 3969.9 3198.7 3567.3 3997.5 4014.2 4042.9 4099.2 4721.6 4733.8 4743.3 4775.6 4229.0 5533.9 5577.6 5651.8 5871.2 1178.8 1286.3 1301.5 1333.7 1337.5 734.4 857.6 860.5 908.1 923.0 5356.2 5384.5 5390.9 5395.9 5419.7 4446.6 5207.5 5703.9 5832.4 5849.9 4472.5 4955.2 5296.3 5395.2 5411.6 2277.4 2613.5 2614.5 2621.8 2655.8 4288.3 4620.4 5042.6 5044.9 5046.6 4031.1 4236.6 4241.2 4854.0 5033.4 4582.9 4617.4 4909.9 4910.4 5009.9 4824.5 4904.2 4939.9 4991.4 5000.6 4391.8 4422.0 4660.9 4887.6 4931.9 4476.9 4657.9 4979.8 4996.5 5049.5 3110.3 3203.5 3398.3 3434.0 3436.0 4346.4 4753.0 4854.3 4918.6 5703.8 5046.0 5122.5 5753.3 5771.7 5775.5 4777.7 5176.9 5274.2 5359.3 5408.3 4923.7 5322.9 5528.4 5635.7 5669.3 5734.2 5765.0 5779.5 5795.7 5847.5 4752.5 5402.8 5670.2 5684.8 5690.0 20:43:48 INFO - PROCESS | 2113 | 20:43:48 INFO - PROCESS | 2113 | [#5] yui.html Cycles:180 Average:24028.80 Median:3669.43 stddev:38711.03 (1055.0%) stddev-sans-first:38780.00 20:43:48 INFO - PROCESS | 2113 | Values: 702.6 712.5 716.7 756.9 762.0 12405.9 15735.1 15752.5 15788.8 15792.3 14272.0 14391.4 14426.5 14427.2 14428.9 662.3 686.1 801.0 819.8 821.0 848.1 848.3 848.5 851.5 853.0 905.5 906.5 907.3 907.5 909.0 736.8 742.6 903.2 905.4 905.8 662.8 668.3 668.4 668.8 670.9 14257.1 14473.7 14696.4 14717.9 14752.7 14349.8 14432.6 14460.4 14462.6 14500.6 11711.1 11819.3 11916.1 11922.2 11935.3 3745.6 3765.7 3804.4 3818.2 3822.8 103337.0 109181.9 111478.3 111589.0 111851.4 11119.1 11135.0 11239.3 11461.3 11618.0 22998.0 23085.7 23136.5 23137.5 23147.3 7926.2 7960.8 8029.1 8046.3 8226.0 4308.0 4333.3 4401.3 4410.7 4510.9 3552.6 3653.3 3668.5 3670.4 3683.7 637.9 641.5 656.3 658.3 662.2 631.0 633.2 638.9 639.5 640.2 9285.2 9328.6 9334.3 9387.4 9567.7 610.1 617.5 622.1 648.3 691.1 3618.4 3633.8 4050.8 4379.5 4477.1 163700.0 165152.0 165612.0 165909.3 168681.0 74089.9 77014.0 93013.0 123841.0 125390.0 69746.0 70214.6 94641.0 102092.5 111818.0 9764.8 9797.4 9940.6 10015.9 10062.9 61907.7 62976.4 64369.4 66023.3 66203.7 81544.6 95266.0 98275.0 99718.0 102487.0 10241.5 11117.7 12240.6 12635.5 12786.6 12123.5 14624.6 14747.9 14759.7 15240.3 10491.7 13188.5 13471.1 13513.5 13758.5 13044.3 13260.5 13662.5 13676.0 13726.9 12224.3 12409.3 12421.5 12777.6 12961.5 11027.2 11128.8 11206.2 11438.4 11720.9 8008.1 10655.7 11477.5 11484.1 11533.9 20:43:48 INFO - PROCESS | 2113 | -------- Summary: end -------- 20:43:48 INFO - PROCESS | 2113 | 20:43:48 INFO - TEST-INFO | 2113: exit 0 20:43:49 INFO - TEST-OK | dromaeo_css | took 1115322ms 20:43:49 INFO - TEST-START | kraken 20:43:49 INFO - operating with platform_type : mac_ 20:43:49 INFO - Initialising browser for kraken test... 20:43:49 INFO - TEST-INFO | started process 2119 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/tmpf9kMkN/profile http://localhost:49361/getInfo.html) 20:43:51 INFO - PROCESS | 2119 | 2016-10-04 20:43:51.666 plugin-container[2120:27509] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c23, name = 'com.apple.tsm.portname' 20:43:51 INFO - PROCESS | 2119 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:43:51 INFO - PROCESS | 2119 | 2016-10-04 20:43:51.669 plugin-container[2120:27509] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9103, name = 'com.apple.CFPasteboardClient' 20:43:51 INFO - PROCESS | 2119 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:43:51 INFO - PROCESS | 2119 | 2016-10-04 20:43:51.669 plugin-container[2120:27509] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:43:51 INFO - PROCESS | 2119 | __metrics Screen width/height:1600/1200 20:43:51 INFO - PROCESS | 2119 | colorDepth:24 20:43:51 INFO - PROCESS | 2119 | Browser inner width/height: 1024/689 20:43:51 INFO - PROCESS | 2119 | __metrics 20:43:51 ERROR - PROCESS | 2119 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 20:43:52 INFO - TEST-INFO | 2119: exit 0 20:43:52 INFO - Browser initialized. 20:43:52 INFO - Running cycle 1/1 for kraken test... 20:43:52 INFO - TEST-INFO | started process 2121 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/T/tmpf9kMkN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:43:54 INFO - PROCESS | 2121 | 2016-10-04 20:43:54.903 plugin-container[2122:27628] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a1b, name = 'com.apple.tsm.portname' 20:43:54 INFO - PROCESS | 2121 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:43:54 INFO - PROCESS | 2121 | 2016-10-04 20:43:54.908 plugin-container[2122:27628] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9103, name = 'com.apple.CFPasteboardClient' 20:43:54 INFO - PROCESS | 2121 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:43:54 INFO - PROCESS | 2121 | 2016-10-04 20:43:54.908 plugin-container[2122:27628] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:44:04 INFO - PROCESS | 2121 | RSS: Main: 240300032 20:44:04 INFO - PROCESS | 2121 | 20:44:07 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49361/tests/kraken/driver.html?testName=audio-beat-detection) 20:44:08 INFO - PROCESS | 2121 | RSS: Main: 253681664 20:44:08 INFO - PROCESS | 2121 | 20:44:11 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49361/tests/kraken/driver.html?testName=audio-dft) 20:44:11 INFO - PROCESS | 2121 | RSS: Main: 261201920 20:44:11 INFO - PROCESS | 2121 | 20:44:15 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49361/tests/kraken/driver.html?testName=audio-fft) 20:44:16 INFO - PROCESS | 2121 | RSS: Main: 262213632 20:44:16 INFO - PROCESS | 2121 | 20:44:18 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49361/tests/kraken/driver.html?testName=audio-oscillator) 20:44:18 INFO - PROCESS | 2121 | RSS: Main: 263249920 20:44:18 INFO - PROCESS | 2121 | 20:44:20 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49361/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:44:21 INFO - PROCESS | 2121 | RSS: Main: 263569408 20:44:21 INFO - PROCESS | 2121 | 20:44:24 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49361/tests/kraken/driver.html?testName=imaging-darkroom) 20:44:24 INFO - PROCESS | 2121 | RSS: Main: 264564736 20:44:24 INFO - PROCESS | 2121 | 20:44:27 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49361/tests/kraken/driver.html?testName=imaging-desaturate) 20:44:28 INFO - PROCESS | 2121 | RSS: Main: 264806400 20:44:28 INFO - PROCESS | 2121 | 20:44:31 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49361/tests/kraken/driver.html?testName=json-parse-financial) 20:44:32 INFO - PROCESS | 2121 | RSS: Main: 264916992 20:44:32 INFO - PROCESS | 2121 | 20:44:33 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49361/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:44:34 INFO - PROCESS | 2121 | RSS: Main: 264134656 20:44:34 INFO - PROCESS | 2121 | 20:44:36 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49361/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:44:37 INFO - PROCESS | 2121 | RSS: Main: 265449472 20:44:37 INFO - PROCESS | 2121 | 20:44:39 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49361/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:44:39 INFO - PROCESS | 2121 | RSS: Main: 265515008 20:44:39 INFO - PROCESS | 2121 | 20:44:43 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:44:43 INFO - PROCESS | 2121 | RSS: Main: 266039296 20:44:43 INFO - PROCESS | 2121 | 20:44:46 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:44:47 INFO - PROCESS | 2121 | RSS: Main: 265924608 20:44:47 INFO - PROCESS | 2121 | 20:44:49 INFO - PROCESS | 2121 | Cycle 1(1): loaded http://localhost:49361/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49361/tests/kraken/driver.html?testName=ai-astar) 20:44:49 INFO - PROCESS | 2121 | RSS: Main: 267542528 20:44:49 INFO - PROCESS | 2121 | 20:44:49 INFO - PROCESS | 2121 | __start_tp_report 20:44:49 INFO - PROCESS | 2121 | _x_x_mozilla_page_load 20:44:49 INFO - PROCESS | 2121 | _x_x_mozilla_page_load_details 20:44:49 INFO - PROCESS | 2121 | |i|pagename|runs| 20:44:49 INFO - PROCESS | 2121 | |0;ai-astar;102;116;118;117;117;117;116;117;117;118 20:44:49 INFO - PROCESS | 2121 | |1;audio-beat-detection;184;122;105;190;172;130;114;123;176;130 20:44:49 INFO - PROCESS | 2121 | |2;audio-dft;202;205;220;201;193;190;197;284;275;195 20:44:49 INFO - PROCESS | 2121 | |3;audio-fft;81;59;60;85;62;64;77;86;101;58 20:44:49 INFO - PROCESS | 2121 | |4;audio-oscillator;94;74;119;103;104;74;102;88;59;90 20:44:49 INFO - PROCESS | 2121 | |5;imaging-gaussian-blur;90;88;91;88;90;87;95;132;137;86 20:44:49 INFO - PROCESS | 2121 | |6;imaging-darkroom;100;101;100;107;102;101;100;101;129;173 20:44:49 INFO - PROCESS | 2121 | |7;imaging-desaturate;117;157;147;95;146;119;92;130;153;88 20:44:49 INFO - PROCESS | 2121 | |8;json-parse-financial;56;57;56;56;57;59;57;58;58;60 20:44:49 INFO - PROCESS | 2121 | |9;json-stringify-tinderbox;68;75;84;75;76;70;70;73;71;74 20:44:49 INFO - PROCESS | 2121 | |10;stanford-crypto-aes;73;81;93;111;106;91;98;101;115;91 20:44:49 INFO - PROCESS | 2121 | |11;stanford-crypto-ccm;170;154;146;148;147;150;150;178;265;149 20:44:49 INFO - PROCESS | 2121 | |12;stanford-crypto-pbkdf2;174;180;174;173;179;179;174;178;173;174 20:44:49 INFO - PROCESS | 2121 | |13;stanford-crypto-sha256-iterative;72;73;71;71;69;71;70;67;71;75 20:44:49 INFO - PROCESS | 2121 | __end_tp_report 20:44:49 INFO - PROCESS | 2121 | __start_cc_report 20:44:49 INFO - PROCESS | 2121 | _x_x_mozilla_cycle_collect,932 20:44:49 INFO - PROCESS | 2121 | __end_cc_report 20:44:49 INFO - PROCESS | 2121 | __startTimestamp1475639089351__endTimestamp 20:44:49 INFO - PROCESS | 2121 | 20:44:49 INFO - PROCESS | 2121 | ------- Summary: start ------- 20:44:49 INFO - PROCESS | 2121 | Number of tests: 14 20:44:49 INFO - PROCESS | 2121 | 20:44:49 INFO - PROCESS | 2121 | [#0] ai-astar Cycles:10 Average:115.50 Median:117.00 stddev:4.79 (4.1%) stddev-sans-first:0.71 20:44:49 INFO - PROCESS | 2121 | Values: 102.0 116.0 118.0 117.0 117.0 117.0 116.0 117.0 117.0 118.0 20:44:49 INFO - PROCESS | 2121 | 20:44:49 INFO - PROCESS | 2121 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:151.00 stddev:32.07 (21.2%) stddev-sans-first:30.69 20:44:49 INFO - PROCESS | 2121 | Values: 184.0 122.0 105.0 190.0 172.0 130.0 114.0 123.0 176.0 130.0 20:44:49 INFO - PROCESS | 2121 | 20:44:49 INFO - PROCESS | 2121 | [#2] audio-dft Cycles:10 Average:216.20 Median:203.50 stddev:34.43 (16.9%) stddev-sans-first:36.13 20:44:49 INFO - PROCESS | 2121 | Values: 202.0 205.0 220.0 201.0 193.0 190.0 197.0 284.0 275.0 195.0 20:44:49 INFO - PROCESS | 2121 | 20:44:49 INFO - PROCESS | 2121 | [#3] audio-fft Cycles:10 Average:73.30 Median:70.50 stddev:14.79 (21.0%) stddev-sans-first:15.42 20:44:49 INFO - PROCESS | 2121 | Values: 81.0 59.0 60.0 85.0 62.0 64.0 77.0 86.0 101.0 58.0 20:44:49 INFO - PROCESS | 2121 | 20:44:49 INFO - PROCESS | 2121 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:74.00 stddev:17.76 (24.0%) stddev-sans-first:18.79 20:44:49 INFO - PROCESS | 2121 | Values: 94.0 74.0 119.0 103.0 104.0 74.0 102.0 88.0 59.0 90.0 20:44:49 INFO - PROCESS | 2121 | 20:44:49 INFO - PROCESS | 2121 | [#5] imaging-gaussian-blur Cycles:10 Average:98.40 Median:89.00 stddev:19.22 (21.6%) stddev-sans-first:20.15 20:44:49 INFO - PROCESS | 2121 | Values: 90.0 88.0 91.0 88.0 90.0 87.0 95.0 132.0 137.0 86.0 20:44:49 INFO - PROCESS | 2121 | 20:44:49 INFO - PROCESS | 2121 | [#6] imaging-darkroom Cycles:10 Average:111.40 Median:101.50 stddev:23.40 (23.1%) stddev-sans-first:24.45 20:44:49 INFO - PROCESS | 2121 | Values: 100.0 101.0 100.0 107.0 102.0 101.0 100.0 101.0 129.0 173.0 20:44:49 INFO - PROCESS | 2121 | 20:44:49 INFO - PROCESS | 2121 | [#7] imaging-desaturate Cycles:10 Average:124.40 Median:155.00 stddev:26.27 (17.0%) stddev-sans-first:27.73 20:44:49 INFO - PROCESS | 2121 | Values: 117.0 157.0 147.0 95.0 146.0 119.0 92.0 130.0 153.0 88.0 20:44:49 INFO - PROCESS | 2121 | 20:44:49 INFO - PROCESS | 2121 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.50 stddev:1.35 (2.3%) stddev-sans-first:1.33 20:44:49 INFO - PROCESS | 2121 | Values: 56.0 57.0 56.0 56.0 57.0 59.0 57.0 58.0 58.0 60.0 20:44:49 INFO - PROCESS | 2121 | 20:44:49 INFO - PROCESS | 2121 | [#9] json-stringify-tinderbox Cycles:10 Average:73.60 Median:74.50 stddev:4.50 (6.0%) stddev-sans-first:4.29 20:44:49 INFO - PROCESS | 2121 | Values: 68.0 75.0 84.0 75.0 76.0 70.0 70.0 73.0 71.0 74.0 20:44:49 INFO - PROCESS | 2121 | 20:44:49 INFO - PROCESS | 2121 | [#10] stanford-crypto-aes Cycles:10 Average:96.00 Median:86.00 stddev:13.03 (15.2%) stddev-sans-first:10.84 20:44:49 INFO - PROCESS | 2121 | Values: 73.0 81.0 93.0 111.0 106.0 91.0 98.0 101.0 115.0 91.0 20:44:49 INFO - PROCESS | 2121 | 20:44:49 INFO - PROCESS | 2121 | [#11] stanford-crypto-ccm Cycles:10 Average:165.70 Median:152.00 stddev:36.50 (24.0%) stddev-sans-first:38.68 20:44:49 INFO - PROCESS | 2121 | Values: 170.0 154.0 146.0 148.0 147.0 150.0 150.0 178.0 265.0 149.0 20:44:49 INFO - PROCESS | 2121 | 20:44:49 INFO - PROCESS | 2121 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:176.00 stddev:2.82 (1.6%) stddev-sans-first:2.92 20:44:49 INFO - PROCESS | 2121 | Values: 174.0 180.0 174.0 173.0 179.0 179.0 174.0 178.0 173.0 174.0 20:44:49 INFO - PROCESS | 2121 | 20:44:49 INFO - PROCESS | 2121 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:2.16 (3.0%) stddev-sans-first:2.26 20:44:49 INFO - PROCESS | 2121 | Values: 72.0 73.0 71.0 71.0 69.0 71.0 70.0 67.0 71.0 75.0 20:44:49 INFO - PROCESS | 2121 | -------- Summary: end -------- 20:44:49 INFO - PROCESS | 2121 | 20:44:50 INFO - TEST-INFO | 2121: exit 0 20:44:50 INFO - TEST-OK | kraken | took 61370ms 20:44:50 INFO - SUITE-END | took 1176s 20:44:50 INFO - Completed test suite (00:19:36) 20:44:50 INFO - javascript benchmark 20:44:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7088.303467932054, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3244.1889527618096, 3316.9668303316957, 3370.983145084275, 3380.5098260752193, 3401.6258211596705, 5510.897820435909, 5518.779248830042, 5548.361938377087, 5583.274174357333, 5666.150077488379, 4970.70175789452, 5120.975804839038, 5566.916496252559, 5607.355154157273, 5685.573581981347, 3945.8359783863684, 5067.79728810849, 5087.7710503027265, 5160.767765450564, 5189.948100518985, 4554.772261386934, 4628.976855115719, 5247.763850626712, 5256.526912577867, 5346.438623944488, 4378.868633940987, 5052.873678158038, 5095.617828662828, 5189.299444574972, 5211.504907033864, 5139.331886854722, 5171.715555644438, 5173.3533308336455, 5206.583473322163, 5239.318888544503, 5098.388193416777, 5115.590752739772, 5137.357830271216, 5138.7687554059785, 5170.172772356443, 4585.197590421662, 5438.048341540215, 5499.450054994509, 5534.142207957773, 5608.0, 5283.154695248781, 6128.662923539204, 6158.630482171084, 6180.2892667343385, 6188.87622247557, 6186.721597528122, 6200.906986395207, 6213.813585592439, 6221.9688901555655, 6234.407731265523, 5638.774449022075, 5676.971615141898, 5744.569157313134, 5748.19525266463, 5801.680907550083, 6178.41305076017, 6179.28938172107, 6192.628442293477, 6227.719752611143, 6242.032484964838, 6076.787312444043, 6102.5577043044295, 6107.816765497042, 6119.265688117454, 6131.570790044743, 6040.033594624839, 6069.544784141207, 6141.499429959709, 6187.133801267826, 6199.070139479114, 6058.0, 6096.786612468542, 6105.755769769248, 6106.278657334014, 6110.358412366726, 6110.205673262536, 6131.724072416663, 6170.290416602148, 6192.195014648067, 6204.7828326008375, 4897.412310522689, 4901.117798796251, 4901.975490122527, 4906.705597664151, 4917.975410122926, 4221.366794980778, 4277.465316835395, 4331.306990881444, 4351.521332653406, 4439.334099884978, 5687.146927960839, 5702.885942281131, 5703.230063941315, 5719.170720245541, 5776.855578610568, 6169.136320915076, 6185.0, 6211.875762484725, 6225.3774622537385, 6234.937650623527, 5462.508374246337, 5498.835034948878, 5537.390887002426, 5666.320041595035, 5670.347909990404, 5265.368155821326, 5298.178782288752, 5337.226102215157, 5383.057964856134, 5386.757595908193, 6092.238470191226, 6198.721057552421, 6212.099245609271, 6222.346653601488, 6225.875482490415, 6098.481629061579, 6115.666295175977, 6179.474744646755, 6211.782587609412, 6229.875402491834, 6093.634381937098, 6164.969175154275, 6189.659568723763, 6217.098520714561, 6251.906221406592, 4415.867523974158, 4925.975370123127, 5461.9076184764, 5837.912431313619, 6172.382761723792, 4930.9506904930495, 6051.7579296827635, 6057.57596968208, 6146.094710639716, 6227.408396202353, 5142.871428214175, 5353.089974704231, 5957.970210148921, 5962.2249107615735, 5986.790462333797, 5868.38381969887, 5910.970445147918, 5918.201042859159, 5950.851228719317, 5957.731902064331, 5141.38303403594, 5637.098064309691, 5790.01569733138, 5795.797147099831, 5825.097109947965, 6017.879642407215, 6080.543959203166, 6094.055421409688, 6119.112728654409, 6127.172831667668, 5854.151148083589, 5885.61743486672, 5901.026330655565, 5911.645301281937, 5919.970400147971], "value": 5550.362092307702, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.1424742051904, 531.5481840435629, 546.8796864689767, 564.9943500564993, 566.0179588414103, 27703.0, 38889.805550972276, 38942.610573894286, 38962.22075558491, 39119.82640520789, 39389.212215755666, 39640.60359396405, 40156.0, 40244.597554024454, 40335.39496907549, 9493.193078588329, 9756.512174391288, 9770.801569646808, 9795.412275263472, 9798.510074496282, 9649.614015439374, 9774.413535187876, 9775.217982561413, 9778.608855645802, 9780.755481112958, 9740.220782337396, 9765.462899540522, 9779.511024448784, 9806.411615303068, 9807.950960245189, 9691.466969316685, 9696.90303096967, 9781.706548803548, 9786.657466988621, 9799.922008579051, 9524.476153811538, 9632.181264592518, 9642.325037247396, 9650.227981761442, 9656.27577931658, 36475.452868207, 38478.80760596207, 38838.22323553513, 38915.83252502429, 39030.02424939371, 3031.4846476098896, 3097.659257481675, 3258.3157536917274, 3339.782914110575, 3381.830908454592, 29422.411551768844, 30438.239044023856, 30483.69516304853, 30715.9249426269, 30890.84554577235, 3200.775945683803, 3256.462683657194, 3263.526788615661, 3332.23358627517, 3347.815870127142, 503909.0, 506923.0, 510254.9999999963, 510623.4468827669, 512388.43805781106, 60171.78797484134, 60211.0, 60764.08853867195, 60830.0, 60856.391436085956, 61680.45798855065, 61967.690161548904, 62096.68951655213, 62102.378976210566, 63189.68405158037, 15656.530304090895, 15840.366385344687, 15912.681746365239, 15937.0, 15972.840271597368, 12183.269003859798, 12244.877551224374, 12304.692382690326, 12310.876891231152, 12326.691832704255, 18061.458156255332, 18362.81637183638, 18380.989045602353, 18384.908075459538, 18393.356232531798, 6821.69302381394, 7605.277498637621, 8124.715634952749, 8139.877901831477, 8193.918060819315, 837.3175861672718, 909.8635204719345, 929.953502324881, 968.9002981615916, 1071.164491696478, 29381.97163099281, 29485.0, 29756.2560935974, 30152.777777777777, 30191.396172076435, 885.7201344057903, 972.8394814855611, 1006.2754816532085, 1010.6361709784471, 1042.9113525350278, 14894.925525372304, 15368.308426120851, 15415.460458883885, 15461.922690386476, 15778.842211577967, 642080.0, 667503.0, 675120.0, 675916.0, 679605.0, 56102.719486402304, 56323.0, 56374.0, 56401.153982690295, 56544.0, 1143.816989281711, 1366.6924941887996, 1383.7993490943757, 1385.6674398144573, 1387.8820300274388, 25670.87164564165, 27936.86031569829, 29665.406691866472, 30629.0, 31376.529352060195, 48503.27245091397, 48567.514324857715, 48634.297799576845, 48664.51335486741, 48906.75546622244, 416236.0, 523266.0, 528606.0, 529102.0, 529109.0, 26492.735072649026, 26706.19881403561, 26919.461610768067, 26945.73054269432, 26956.191314260603, 35395.115122121126, 44238.11523769571, 44709.10581788411, 44969.775151124035, 45923.31115033344, 37222.44166337561, 37271.25457490889, 37777.0, 38581.614183858925, 39060.41409378805, 37127.88616341514, 37466.625333747405, 38378.61621383862, 38594.80702596469, 38612.61387386203, 29903.0, 36514.26971460503, 36916.89249322525, 37005.81497092605, 38252.0, 29599.0, 30177.0, 32570.0, 34045.0, 34079.48880766741, 21703.34889953304, 22375.552488950456, 24360.903759331228, 24939.750602494467, 25566.87216563905], "value": 19575.95722363877, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.5930816793359, 372.19419955795706, 372.37255224945983, 376.5575448847603, 395.88915103770955, 19506.609867802636, 20554.0, 20629.690554641675, 21036.263730769446, 21356.932153392307, 20598.69101963468, 20702.826203248667, 20788.960551972417, 21122.260720874736, 21126.0, 5672.8865422691415, 5771.50942169916, 5941.346451890288, 6069.271687397519, 6157.876842463148, 3299.2411745298596, 4083.183363327332, 6073.483753880903, 6116.877662446771, 6161.322254552018, 4384.868453946371, 4387.451568553931, 5618.027336534909, 6810.59136451812, 6817.69320380584, 5617.943820561783, 6676.632785196813, 6765.086713293692, 6789.93210067898, 6794.524383293171, 5891.057430811093, 5948.31594366649, 5950.077737950624, 5961.552883533709, 5972.522198224132, 13251.46994120234, 17415.912920435316, 25552.616710749353, 25573.872130639415, 25685.0, 2067.8759274443432, 2153.418576984221, 2189.1243502599086, 2350.3771500552366, 2979.2105092150596, 9277.860832087525, 9403.952980235055, 9892.703218903445, 10004.0, 10032.849507257397, 1541.9383224671, 1803.9729404058949, 1845.151230434002, 1846.7876194237701, 1874.1378965675806, 118030.0, 123261.0, 123760.0, 123983.0, 126120.0, 10455.634052808267, 11517.884821151682, 11580.710482238012, 11638.0, 11833.467493962793, 13015.088943773844, 13876.0, 14481.92759036198, 14530.200838953959, 14535.78196327056, 6561.967190164019, 6951.965240173767, 7283.308085731847, 7999.240072193133, 8573.657053717781, 6618.569792963442, 7134.3579077882205, 7187.353138217585, 8296.917030829734, 8504.829903402022, 4497.145542346943, 4539.795709193094, 4559.635229181657, 4626.0, 4657.441107067106, 1911.6559019376368, 1961.6076784642844, 1965.1058768260407, 1965.2040923426036, 1980.5543752655537, 370.25024325740054, 375.14841310226177, 401.283708580183, 412.8720096770011, 651.3909494622543, 11683.474243659055, 11746.647600571996, 11776.52893884235, 12126.514939402501, 12165.5133794649, 422.7463521886905, 424.5923913043513, 425.68073944541595, 429.24667209048545, 445.2564217756355, 6148.292946311231, 6152.569320147636, 6191.721372538246, 6223.626582405071, 6233.34549872266, 581857.0, 600431.0, 605633.2560199845, 607654.0, 613167.0, 86826.0, 125031.0, 129042.35478822734, 137941.0, 141389.5861041397, 434.5871422148971, 439.3366017313815, 442.40938347306064, 445.1319926144032, 446.87487503499074, 8129.8374032520205, 11305.71735706614, 11333.916302311056, 11551.480183391599, 11660.242084264495, 54154.54635401301, 54165.0, 54792.45207548033, 55293.61765955883, 55655.72172139275, 81614.59192703999, 82295.354092919, 82300.0, 83106.58446707728, 83162.0, 7792.532448053135, 7979.760607181794, 8038.356931445353, 8134.0, 8157.0, 9639.614415423304, 12144.817827732415, 12213.267203967791, 12415.130940834055, 12667.619971400873, 10385.273030887765, 10566.524506397383, 10775.784484310114, 11001.00990910822, 11026.503807328529, 8545.658173672984, 9879.308448408543, 10121.291509594257, 10189.745256368353, 10667.46662666848, 8621.396502245034, 10727.034566889017, 10921.453927303763, 11080.39057851826, 11350.091992640404, 7832.686692532235, 8014.679412823421, 8036.598170091355, 8153.9184608153155, 8169.877451838346, 10271.486425678835, 10650.147988160774, 10741.0, 10816.459177040959, 11061.889381106408], "value": 8408.500481172208, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1204.734958309172, 1505.713914356272, 1704.0542498913105, 1878.4646375782904, 1927.190579956418, 8117.878231826513, 8349.749507514769, 8635.870461943068, 9255.444673319596, 9309.115634014766, 8674.26268767154, 8993.820123597525, 9017.864732029026, 9075.81848363034, 9111.088891110885, 2351.3651314145213, 2374.560706269337, 2382.940426489343, 2385.105585405473, 2386.8185248302116, 2299.034405549665, 2333.428310064037, 2341.508283260509, 2345.2143531916745, 2357.281029286067, 2328.662343960125, 2346.9673343728705, 2349.718033835942, 2367.5501654685554, 2371.490129622131, 2281.1103669568884, 2298.793108620224, 2311.4221444638843, 2314.4561028158287, 2345.7185137783404, 2344.120954642009, 2348.5537747827857, 2349.9060037598474, 2352.1061996441244, 2353.164626557582, 8919.68781092665, 9043.0, 9044.8643270351, 9104.499252541107, 9110.954445227797, 5264.947350526484, 5273.683578985235, 5324.866878328034, 5375.22059301403, 5429.321334833146, 3549.94675079874, 3685.281370132825, 3735.2156047230114, 3762.3792074307707, 3768.4158955361963, 1046.529061922138, 1083.3608171179042, 1083.913286937043, 1107.2360071550686, 1107.7341438054889, 9699.0, 11929.821052684216, 12047.096467764954, 12095.93952030243, 12101.394930253453, 4524.5927866492175, 4723.95276047242, 4804.2073057945045, 4842.467328593852, 4847.709137451764, 10102.343347682525, 10215.182785377152, 10220.642277520252, 10234.59061637541, 10236.48817559134, 5417.5395091416885, 5418.83743487696, 5426.945730542644, 5433.157860531624, 5433.782648694008, 4448.7108337957925, 4605.240135377692, 4712.24604063355, 4942.085714142895, 4944.629152813553, 3417.863285468603, 3867.9806600967377, 3885.8834234972996, 3958.426028225949, 4082.9387559186634, 1274.1654216488214, 1287.9484820607258, 1296.7665820152463, 1299.2074834351038, 1311.0887932886742, 774.3688893551737, 827.6747574014125, 834.2783492279256, 885.8981217159981, 935.1209862729013, 5624.746886390122, 5732.828015159552, 5919.6152250103605, 5999.970000149971, 6038.8899716645965, 842.9294795609542, 909.4043401571848, 945.432740355781, 967.9467629280316, 1063.7659714862718, 3738.32710112177, 3907.33575292201, 3932.390479475686, 4029.6171863672903, 4071.1247081877536, 8180.6501927182535, 8422.326213902874, 9680.903190968, 9944.552495137736, 10153.289269751194, 9911.950440247752, 10017.04838040385, 10056.396616203052, 10151.340162889388, 10169.288149829588, 7953.403494737918, 8206.466579672422, 8243.711470098518, 8377.539235342114, 8382.664693412195, 5835.620684655484, 5977.193078934288, 6149.292831324455, 6180.258368995569, 6191.0, 9122.677211804385, 9398.248140148908, 9752.46361450127, 10021.799564008534, 10124.493775311352, 8528.360372971927, 10030.247731420319, 10191.694249172537, 10273.486325683536, 10375.325603835727, 7589.013428254291, 7647.464677472523, 7687.5387476751575, 7715.537067775951, 7757.883631745415, 8351.24838764514, 8454.40819142654, 8457.196566326189, 8460.703875364332, 8469.830603387774, 7476.214997425192, 7599.392048636207, 7617.27635874591, 7645.120811106794, 7733.188015258542, 5888.705564721832, 6313.494920406449, 7309.232530584425, 7490.737824176128, 7504.1370242420635, 6953.20038195614, 6968.581885086911, 6977.1976222733, 7039.908814133817, 7051.153861536648, 5018.920931999638, 5056.64603477753, 5108.872278193075, 5112.3865136183895, 5181.5595674368105, 5050.898982020412, 5059.772310245974, 5171.715555644476, 5219.582433405394, 5253.789848406021], "value": 4588.0451385248, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.74671402664745, 301.41074199939106, 307.69384462459857, 313.4076595235006, 315.52198419394637, 4772.308015337782, 5154.896902061956, 5419.187121931712, 5535.501804837564, 5581.469760372763, 4001.859934902279, 4446.310402047226, 4867.902641947159, 5344.866378340544, 5418.241446197526, 4007.418924255981, 4145.502539695241, 4155.31437312843, 4177.579622928204, 4179.79101044948, 3517.891864062825, 3963.4451176835264, 4181.958180418187, 4198.6011328923705, 4213.9578604213875, 3429.331280400323, 3779.639329841255, 4128.442660240874, 4148.730332528391, 4154.189932963073, 3615.927681446383, 3914.4324073009398, 3980.5024371953505, 3986.142979259444, 4127.938080928789, 3386.8306584670913, 3528.8059156746367, 3533.5406397168204, 3631.8184090795353, 3637.2361804020925, 4216.409702641633, 4383.671224658164, 4808.783604737795, 4955.355803745526, 5236.633435659505, 4710.0, 4718.764061796931, 4721.834735784231, 4735.550122738335, 4790.784414701347, 4775.880602984918, 5572.721363931828, 5708.7145642718115, 5742.425757424266, 5793.536517078624, 3896.2207558488417, 3899.922001559953, 3908.687305015592, 3909.257241124206, 3923.686105111613, 4836.540528649773, 6089.325435505271, 6096.359882212349, 6102.199851043953, 6144.371741488464, 3777.7711150421383, 3952.703547233969, 3958.9010274743364, 3966.920661586752, 3969.900752481153, 3198.7441004719567, 3567.2687099144614, 3997.5003124609425, 4014.197160567898, 4042.8787136385367, 4099.1801639672185, 4721.551452611996, 4733.83431579893, 4743.31221972812, 4775.570198682066, 4228.9577104228565, 5533.916991245134, 5577.609567330248, 5651.803326595655, 5871.2073870027, 1178.793711100571, 1286.2796833773118, 1301.4533895763802, 1333.6532501549666, 1337.5051231044577, 734.372111844376, 857.6355049104105, 860.5095095795336, 908.0692290402391, 922.9953850230706, 5356.223347614652, 5384.461553844584, 5390.946090539122, 5395.892082158335, 5419.674819510842, 4446.5553444655925, 5207.531322181022, 5703.94477021744, 5832.416758324219, 5849.912251316234, 4472.485664148599, 4955.175549936502, 5296.285001524822, 5395.163749618815, 5411.648242864201, 2277.407873952784, 2613.4773045391, 2614.503244383561, 2621.8164728469205, 2655.8314341689593, 4288.335308027261, 4620.3993480847275, 5042.621803364762, 5044.949550504448, 5046.571041461443, 4031.1333063390925, 4236.6187043166265, 4241.151769646083, 4853.95146048535, 5033.395992480926, 4582.862514124648, 4617.353570500132, 4909.852704418873, 4910.386201724785, 5009.874753131201, 4824.541668541483, 4904.239842824368, 4939.925231402891, 4991.376077990251, 5000.574951129195, 4391.8462853799965, 4422.031438341026, 4660.883477912944, 4887.584555312838, 4931.901361972668, 4476.865694029184, 4657.86026419208, 4979.775910084128, 4996.475370086088, 5049.469805670498, 3110.331278775074, 3203.4714272144834, 3398.3033478137418, 3433.9656603433646, 3435.9828200858838, 4346.434963454731, 4753.0, 4854.3252577861995, 4918.606511479002, 5703.771849125988, 5046.016026874724, 5122.487751224997, 5753.309602847685, 5771.740271687868, 5775.545393207954, 4777.689450185727, 5176.922346164886, 5274.206769698321, 5359.3032905722, 5408.268294876522, 4923.729194894315, 5322.893542129058, 5528.364238112507, 5635.690037048002, 5669.31968163823, 5734.2258795062135, 5764.971175144097, 5779.450952159538, 5795.710214489174, 5847.502962248086, 4752.52474752522, 5402.837914862561, 5670.234518339971, 5684.8010319638615, 5689.971550142222], "value": 3943.182992699926, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.5960072958048, 712.4905692429911, 716.6631683108938, 756.8788993761, 761.9695212191515, 12405.875941240585, 15735.134567598778, 15752.527424177293, 15788.84211157888, 15792.289346979385, 14272.0, 14391.424343026292, 14426.495072672458, 14427.206503642296, 14428.85571144291, 662.2847324889133, 686.1491750229729, 800.9599520024004, 819.848328059308, 820.9671613135482, 848.0925409811504, 848.321342925657, 848.516345682961, 851.5103815306193, 853.0019876744193, 905.5110240470138, 906.542196190926, 907.3013779389865, 907.4782000349792, 909.0318810466831, 736.8121129112069, 742.5618884857905, 903.1781079217881, 905.4341036851968, 905.7871400220976, 662.7945336945562, 668.2815972829179, 668.3683918696834, 668.8227619680788, 670.9261981182066, 14257.144571325754, 14473.710525789531, 14696.412143514353, 14717.92641036788, 14752.704945901129, 14349.78475322871, 14432.567022989328, 14460.421583136662, 14462.638434039232, 14500.564983050524, 11711.121665875093, 11819.34993575353, 11916.106292028046, 11922.22505537146, 11935.343556104412, 3745.550533935918, 3765.6987441004653, 3804.372278574032, 3818.236352729465, 3822.789746563938, 103337.0, 109181.90818091876, 111478.32782508268, 111589.0, 111851.44074279658, 11119.054880335101, 11135.0, 11239.325640461599, 11461.312321260752, 11618.0, 22998.0, 23085.653715194287, 23136.53726925452, 23137.53724925492, 23147.305580832603, 7926.24700653437, 7960.840783184304, 8029.076656184614, 8046.275835174863, 8226.0, 4308.0, 4333.285007973712, 4401.317795741666, 4410.691251612357, 4510.864674059783, 3552.573691157026, 3653.324135035027, 3668.4680721295263, 3670.3943849265106, 3683.686886614668, 637.8819918315127, 641.4611726150056, 656.2682608891148, 658.3120638932327, 662.2285037930853, 630.9747610095545, 633.2306247908813, 638.8658381739793, 639.5331408072041, 640.2381166411955, 9285.164335209864, 9328.580213890391, 9334.299927505464, 9387.389819661701, 9567.665131720356, 610.0807635464282, 617.545679923773, 622.1149915755269, 648.2836465705328, 691.0705101638289, 3618.3848745713294, 3633.7638053526434, 4050.7772072536295, 4379.540148284448, 4477.082198149372, 163700.0, 165152.0, 165612.0, 165909.3409065918, 168681.0, 74089.88865167026, 77014.0, 93013.0, 123841.0, 125390.0, 69746.0, 70214.64892675504, 94641.0, 102092.48953755184, 111817.99999999837, 9764.804703906024, 9797.412155270707, 9940.552675129782, 10015.899841001497, 10062.89937100649, 61907.690461547405, 62976.37023629705, 64369.35630643633, 66023.33976660365, 66203.66898165479, 81544.59227703823, 95266.0, 98275.01724982659, 99718.0, 102487.0, 10241.518028075023, 11117.666470005914, 12240.632781016584, 12635.494580216688, 12786.552470663482, 12123.515059397525, 14624.561263162122, 14747.852521474648, 14759.704805904037, 15240.314185861442, 10491.68524944253, 13188.472461101448, 13471.12437691547, 13513.527026554024, 13758.518451854137, 13044.347782610641, 13260.469581217028, 13662.453501860213, 13676.042677012514, 13726.86273137256, 12224.327661978676, 12409.255444673348, 12421.503139874303, 12777.552785652457, 12961.481540738265, 11027.22809403334, 11128.777424451304, 11206.20700687886, 11438.37088960082, 11720.941395292968, 8008.0669718405525, 10655.733606659585, 11477.483513241757, 11484.138689598147, 11533.942330288295], "value": 7673.093237828352, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1614.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 116.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 122.0, 105.0, 190.0, 172.0, 130.0, 114.0, 123.0, 176.0, 130.0], "value": 144.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 205.0, 220.0, 201.0, 193.0, 190.0, 197.0, 284.0, 275.0, 195.0], "value": 216.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 85.0, 62.0, 64.0, 77.0, 86.0, 101.0, 58.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 74.0, 119.0, 103.0, 104.0, 74.0, 102.0, 88.0, 59.0, 90.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 91.0, 88.0, 90.0, 87.0, 95.0, 132.0, 137.0, 86.0], "value": 98.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 101.0, 100.0, 107.0, 102.0, 101.0, 100.0, 101.0, 129.0, 173.0], "value": 111.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 157.0, 147.0, 95.0, 146.0, 119.0, 92.0, 130.0, 153.0, 88.0], "value": 124.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 56.0, 57.0, 59.0, 57.0, 58.0, 58.0, 60.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 84.0, 75.0, 76.0, 70.0, 70.0, 73.0, 71.0, 74.0], "value": 73.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 81.0, 93.0, 111.0, 106.0, 91.0, 98.0, 101.0, 115.0, 91.0], "value": 96.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 154.0, 146.0, 148.0, 147.0, 150.0, 150.0, 178.0, 265.0, 149.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 180.0, 174.0, 173.0, 179.0, 179.0, 174.0, 178.0, 173.0, 174.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 71.0, 71.0, 69.0, 71.0, 70.0, 67.0, 71.0, 75.0], "value": 71.0, "unit": "score"}]}]} 20:44:50 INFO - Return code: 0 20:44:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:44:50 ERROR - # TBPL SUCCESS # 20:44:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:44:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:44:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:44:50 INFO - 2016-10-04 20:44:50.661 screenresolution[2126:28001] starting screenresolution argv=screenresolution get 20:44:50 INFO - 2016-10-04 20:44:50.664 screenresolution[2126:28001] Display 0: 1600x1200x32@60 20:44:50 INFO - 2016-10-04 20:44:50.670 screenresolution[2127:28004] starting screenresolution argv=screenresolution list 20:44:50 INFO - Available Modes on Display 0 20:44:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:44:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:44:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:44:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:44:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:44:50 INFO - Intel Iris: 20:44:50 INFO - Chipset Model: Intel Iris 20:44:50 INFO - Type: GPU 20:44:50 INFO - Bus: Built-In 20:44:50 INFO - VRAM (Dynamic, Max): 1536 MB 20:44:50 INFO - Vendor: Intel (0x8086) 20:44:50 INFO - Device ID: 0x0a2e 20:44:50 INFO - Revision ID: 0x0009 20:44:50 INFO - Displays: 20:44:50 INFO - Display: 20:44:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:44:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:44:50 INFO - Display Serial Number: 1600x1200 60 20:44:50 INFO - Main Display: Yes 20:44:50 INFO - Mirror: Off 20:44:50 INFO - Online: Yes 20:44:50 INFO - Rotation: Supported 20:44:50 INFO - Return code: 0 20:44:50 INFO - Running post-action listener: _resource_record_post_action 20:44:50 INFO - [mozharness: 2016-10-05 03:44:50.920881Z] Finished run-tests step (success) 20:44:50 INFO - Running post-run listener: _resource_record_post_run 20:44:50 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 31175168; Write bytes: 710582272; Read time: 291; Write time: 2121 20:44:50 INFO - TinderboxPrint: CPU usage
54.4% 20:44:50 INFO - TinderboxPrint: I/O read bytes / time
31,175,168 / 291 20:44:50 INFO - TinderboxPrint: I/O write bytes / time
710,582,272 / 2,121 20:44:50 INFO - TinderboxPrint: CPU idle
2,210.0 (45.6%) 20:44:50 INFO - TinderboxPrint: CPU system
980.1 (20.2%) 20:44:50 INFO - TinderboxPrint: CPU user
1,659.6 (34.2%) 20:44:50 INFO - TinderboxPrint: Swap in / out
433,057,792 / 0 20:44:50 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 408443392; Write bytes: 410167296; Read time: 31062; Write time: 750 20:44:50 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 29549056; Write bytes: 298825728; Read time: 279; Write time: 1364 20:44:51 INFO - Running post-run listener: _upload_blobber_files 20:44:51 INFO - Blob upload gear active. 20:44:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:44:51 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:44:51 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'] 20:44:51 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 20:44:51 INFO - (blobuploader) - INFO - Open directory for files ... 20:44:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:44:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:44:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:44:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:44:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:44:53 INFO - (blobuploader) - INFO - Done attempting. 20:44:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:44:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:44:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:44:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:44:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:44:54 INFO - (blobuploader) - INFO - Done attempting. 20:44:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:44:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:44:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:44:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:44:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:44:56 INFO - (blobuploader) - INFO - Done attempting. 20:44:56 INFO - (blobuploader) - INFO - Iteration through files over. 20:44:56 INFO - Return code: 0 20:44:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:44:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:44:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04c0ec9d20c09b44ab79c7c34d87fc1e20aa62845ee0b5579868e6c20c48e642cd894b6a1d0836321ddfae5d26a054c8b8668c6b0284b01834c87534519d3905", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27bdeb3625d300d69528773fe62fa5022c9ec202464efd02781bec809ce72bdf9f8db35093b7aadb1b97e669bc593831db053bc7efd8d9dfba2741b938b08975", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ece507e55f0288543020fb708aae9f9b3e5c5b65e5a150aeeacf52da84a13afbcb3a6da9c9add4923702f9e6e0f65179a4d7bbc24a1aceb6dec735c2849cb5cb"} 20:44:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:44:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:44:56 INFO - Contents: 20:44:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/04c0ec9d20c09b44ab79c7c34d87fc1e20aa62845ee0b5579868e6c20c48e642cd894b6a1d0836321ddfae5d26a054c8b8668c6b0284b01834c87534519d3905", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27bdeb3625d300d69528773fe62fa5022c9ec202464efd02781bec809ce72bdf9f8db35093b7aadb1b97e669bc593831db053bc7efd8d9dfba2741b938b08975", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ece507e55f0288543020fb708aae9f9b3e5c5b65e5a150aeeacf52da84a13afbcb3a6da9c9add4923702f9e6e0f65179a4d7bbc24a1aceb6dec735c2849cb5cb"} 20:44:56 INFO - Running post-run listener: copy_logs_to_upload_dir 20:44:56 INFO - Copying logs to upload dir... 20:44:56 INFO - mkdir: /builds/slave/test/build/upload/logs 20:44:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.529151 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-04 20:44:56.493913) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 20:44:56.497416) ========= 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.WWqLrILol6/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.gJsKijMZUB/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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/04c0ec9d20c09b44ab79c7c34d87fc1e20aa62845ee0b5579868e6c20c48e642cd894b6a1d0836321ddfae5d26a054c8b8668c6b0284b01834c87534519d3905", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27bdeb3625d300d69528773fe62fa5022c9ec202464efd02781bec809ce72bdf9f8db35093b7aadb1b97e669bc593831db053bc7efd8d9dfba2741b938b08975", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ece507e55f0288543020fb708aae9f9b3e5c5b65e5a150aeeacf52da84a13afbcb3a6da9c9add4923702f9e6e0f65179a4d7bbc24a1aceb6dec735c2849cb5cb"} build_url:https://queue.taskcluster.net/v1/task/c4P6JY-GSDOjOkoS17kbBg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011008 build_url: 'https://queue.taskcluster.net/v1/task/c4P6JY-GSDOjOkoS17kbBg/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/04c0ec9d20c09b44ab79c7c34d87fc1e20aa62845ee0b5579868e6c20c48e642cd894b6a1d0836321ddfae5d26a054c8b8668c6b0284b01834c87534519d3905", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27bdeb3625d300d69528773fe62fa5022c9ec202464efd02781bec809ce72bdf9f8db35093b7aadb1b97e669bc593831db053bc7efd8d9dfba2741b938b08975", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ece507e55f0288543020fb708aae9f9b3e5c5b65e5a150aeeacf52da84a13afbcb3a6da9c9add4923702f9e6e0f65179a4d7bbc24a1aceb6dec735c2849cb5cb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 20:44:56.529848) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 20:44:56.530201) ========= 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.WWqLrILol6/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.gJsKijMZUB/Listeners TMPDIR=/var/folders/kx/qvhm4_gn43dcvvj7tsq112q000000w/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.005097 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 20:44:56.579094) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 20:44:56.579419) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 20:44:56.579737) ========= ========= Total master_lag: 0.17 =========