builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0258 starttime: 1475740648.32 results: success (0) buildid: 20161005213159 builduid: de44d41a926c45cf80dc03848a057d2e revision: 80d979342a04c163156c1b74235cb9c24f850658 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 00:57:28.320795) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 00:57:28.321497) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 00:57:28.321988) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 00:57:28.347505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 00:57:28.347845) ========= 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.3hAMk3tHFo/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.6McOJX3LvQ/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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-06 00:57:28-- 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% 19.4M=0.001s 2016-10-06 00:57:28 (19.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087439 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 00:57:28.458046) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 00:57:28.458408) ========= 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.3hAMk3tHFo/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.6McOJX3LvQ/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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.026902 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 00:57:28.506632) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-10-06 00:57:28.507022) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 80d979342a04c163156c1b74235cb9c24f850658 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 80d979342a04c163156c1b74235cb9c24f850658 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3hAMk3tHFo/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.6McOJX3LvQ/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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-06 00:57:28,589 truncating revision to first 12 chars 2016-10-06 00:57:28,589 Setting DEBUG logging. 2016-10-06 00:57:28,589 attempt 1/10 2016-10-06 00:57:28,589 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/80d979342a04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 00:57:30,483 unpacking tar archive at: fx-team-80d979342a04/testing/mozharness/ program finished with exit code 0 elapsedTime=2.169579 ========= master_lag: 1.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-10-06 00:57:31.950181) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 00:57:31.950548) ========= script_repo_revision: 80d979342a04c163156c1b74235cb9c24f850658 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 00:57:31.951028) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 00:57:31.951327) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 00:57:31.971482) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-06 00:57:31.971851) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3hAMk3tHFo/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.6McOJX3LvQ/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 00:57:32 INFO - MultiFileLogger online at 20161006 00:57:32 in /builds/slave/test 00:57:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:57:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:57:32 INFO - {'append_to_log': False, 00:57:32 INFO - 'base_work_dir': '/builds/slave/test', 00:57:32 INFO - 'blob_upload_branch': 'Fx-Team', 00:57:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:57:32 INFO - 'branch': 'Fx-Team', 00:57:32 INFO - 'buildbot_json_path': 'buildprops.json', 00:57:32 INFO - 'config_files': ('talos/mac_config.py',), 00:57:32 INFO - 'default_actions': ('clobber', 00:57:32 INFO - 'read-buildbot-config', 00:57:32 INFO - 'download-and-extract', 00:57:32 INFO - 'populate-webroot', 00:57:32 INFO - 'create-virtualenv', 00:57:32 INFO - 'install', 00:57:32 INFO - 'run-tests'), 00:57:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:57:32 INFO - 'download_minidump_stackwalk': True, 00:57:32 INFO - 'download_symbols': 'ondemand', 00:57:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:57:32 INFO - 'tooltool.py': '/tools/tooltool.py', 00:57:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:57:32 INFO - '/tools/misc-python/virtualenv.py')}, 00:57:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:57:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:57:32 INFO - 'installer_path': 'installer.exe', 00:57:32 INFO - 'log_level': 'info', 00:57:32 INFO - 'log_name': 'talos', 00:57:32 INFO - 'log_to_console': True, 00:57:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:57:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:57:32 INFO - 'opt_config_files': (), 00:57:32 INFO - 'pip_index': False, 00:57:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:57:32 INFO - 'cmd': ('bash', 00:57:32 INFO - '-c', 00:57:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:57:32 INFO - 'enabled': True, 00:57:32 INFO - 'halt_on_failure': False, 00:57:32 INFO - 'name': 'check_screen_resolution'},), 00:57:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:57:32 INFO - 'cmd': ('bash', 00:57:32 INFO - '-c', 00:57:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:57:32 INFO - 'enabled': True, 00:57:32 INFO - 'halt_on_failure': False, 00:57:32 INFO - 'name': 'check_screen_resolution'},), 00:57:32 INFO - 'run_cmd_checks_enabled': True, 00:57:32 INFO - 'sps_profile': False, 00:57:32 INFO - 'sps_profile_interval': 0, 00:57:32 INFO - 'suite': 'dromaeojs-e10s', 00:57:32 INFO - 'system_bits': '32', 00:57:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:57:32 INFO - 'title': 't-yosemite-r7-0258', 00:57:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:57:32 INFO - 'use_talos_json': True, 00:57:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:57:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:57:32 INFO - 'work_dir': 'build'} 00:57:32 INFO - [mozharness: 2016-10-06 07:57:32.171067Z] Running clobber step. 00:57:32 INFO - Running pre-action listener: _resource_record_pre_action 00:57:32 INFO - Running main action method: clobber 00:57:32 INFO - rmtree: /builds/slave/test/build 00:57:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:57:34 INFO - Running post-action listener: _resource_record_post_action 00:57:34 INFO - [mozharness: 2016-10-06 07:57:34.319253Z] Finished clobber step (success) 00:57:34 INFO - [mozharness: 2016-10-06 07:57:34.319414Z] Running read-buildbot-config step. 00:57:34 INFO - Running pre-action listener: _resource_record_pre_action 00:57:34 INFO - Running main action method: read_buildbot_config 00:57:34 INFO - Using buildbot properties: 00:57:34 INFO - { 00:57:34 INFO - "project": "", 00:57:34 INFO - "product": "firefox", 00:57:34 INFO - "script_repo_revision": "production", 00:57:34 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 00:57:34 INFO - "repository": "", 00:57:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 00:57:34 INFO - "buildid": "20161005213159", 00:57:34 INFO - "pgo_build": "False", 00:57:34 INFO - "basedir": "/builds/slave/test", 00:57:34 INFO - "buildnumber": 138, 00:57:34 INFO - "slavename": "t-yosemite-r7-0258", 00:57:34 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 00:57:34 INFO - "platform": "yosemite_r7", 00:57:34 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 00:57:34 INFO - "branch": "fx-team", 00:57:34 INFO - "repo_path": "integration/fx-team", 00:57:34 INFO - "revision": "80d979342a04c163156c1b74235cb9c24f850658", 00:57:34 INFO - "stage_platform": "macosx64", 00:57:34 INFO - "builduid": "de44d41a926c45cf80dc03848a057d2e", 00:57:34 INFO - "slavebuilddir": "test" 00:57:34 INFO - } 00:57:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 00:57:34 INFO - Running post-action listener: _resource_record_post_action 00:57:34 INFO - [mozharness: 2016-10-06 07:57:34.322869Z] Finished read-buildbot-config step (success) 00:57:34 INFO - [mozharness: 2016-10-06 07:57:34.322991Z] Running download-and-extract step. 00:57:34 INFO - Running pre-action listener: _resource_record_pre_action 00:57:34 INFO - Running main action method: download_and_extract 00:57:34 INFO - mkdir: /builds/slave/test/build/tests 00:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:34 INFO - trying https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 00:57:34 INFO - Downloading https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/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 00:57:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/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 00:57:35 INFO - Downloaded 1199 bytes. 00:57:35 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 00:57:35 INFO - Using the following test package requirements: 00:57:35 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 00:57:35 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:57:35 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 00:57:35 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:57:35 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 00:57:35 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:57:35 INFO - u'jsshell-mac.zip'], 00:57:35 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:57:35 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 00:57:35 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 00:57:35 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:57:35 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 00:57:35 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:57:35 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 00:57:35 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:57:35 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 00:57:35 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 00:57:35 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 00:57:35 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:57:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 00:57:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:57:35 INFO - Fetch https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 00:57:35 INFO - Http code: 200 00:57:35 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 00:57:35 INFO - x-amz-cf-id: 1w8aY_XEfKsL_iTYBck1DxtyWf0KmTP5Rwd5-Utl3-g4NqVB1MPHuw== 00:57:35 INFO - x-amz-version-id: RGPOZBu05dsYF3Fe0Gs.1kKInKYUzjkq 00:57:36 INFO - Expected file size: 16477179 00:57:36 INFO - Obtained file size: 16477179 00:57:42 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 00:57:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 00:57:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:57:42 INFO - Fetch https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 00:57:43 INFO - Http code: 200 00:57:43 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 00:57:43 INFO - x-amz-cf-id: zdTtlKlyC7mS3SWG2sGf0hjzY0eBIgVz041zJOrWkBoXX2ecR3SWxQ== 00:57:43 INFO - x-amz-version-id: RGPOZBu05dsYF3Fe0Gs.1kKInKYUzjkq 00:57:43 INFO - Expected file size: 16477179 00:57:43 INFO - Obtained file size: 16477179 00:57:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 00:57:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 00:57:49 INFO - Fetch https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 00:57:50 INFO - Http code: 200 00:57:50 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 00:57:50 INFO - x-amz-cf-id: WnIrc6ap_ebMVaTRyoCb3J_2m3jBdg653V42bIkqNAjDcnZy3Wwigg== 00:57:50 INFO - x-amz-version-id: aVwWzapyvcYpfCitf5sKLrH9_eXZ9jor 00:57:50 INFO - Expected file size: 14409006 00:57:50 INFO - Obtained file size: 14409006 00:57:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:51 INFO - trying https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:57:51 INFO - Downloading https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 00:57:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/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 00:57:55 INFO - Downloaded 111664614 bytes. 00:57:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:57:55 INFO - mkdir: /builds/slave/test/properties 00:57:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:57:55 INFO - Writing to file /builds/slave/test/properties/build_url 00:57:55 INFO - Contents: 00:57:55 INFO - build_url:https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 00:57:55 INFO - Running post-action listener: _resource_record_post_action 00:57:55 INFO - Running post-action listener: set_extra_try_arguments 00:57:55 INFO - [mozharness: 2016-10-06 07:57:55.916595Z] Finished download-and-extract step (success) 00:57:55 INFO - [mozharness: 2016-10-06 07:57:55.916718Z] Running populate-webroot step. 00:57:55 INFO - Running pre-action listener: _resource_record_pre_action 00:57:55 INFO - Running main action method: populate_webroot 00:57:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:57:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:57:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:57:55 INFO - '--tppagecycles', 00:57:55 INFO - '7'], 00:57:55 INFO - 'tests': ['tsvgm']}}, 00:57:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:57:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:57:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:57:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:57:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:57:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:57:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:57:55 INFO - 'talos_options': ['--disable-e10s'], 00:57:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:57:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:57:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:57:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:57:55 INFO - 'talos_options': ['--disable-e10s'], 00:57:55 INFO - 'tests': ['damp', 'tps']}, 00:57:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:57:55 INFO - 'tests': ['damp', 'tps']}, 00:57:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:57:55 INFO - 'tests': ['dromaeo_dom']}, 00:57:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:57:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:57:55 INFO - 'tests': ['basic_compositor_video']}, 00:57:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:57:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:57:55 INFO - 'tests': ['a11yr', 00:57:55 INFO - 'ts_paint', 00:57:55 INFO - 'tpaint', 00:57:55 INFO - 'sessionrestore', 00:57:55 INFO - 'sessionrestore_no_auto_restore', 00:57:55 INFO - 'tabpaint']}, 00:57:55 INFO - 'other-e10s': {'tests': ['a11yr', 00:57:55 INFO - 'ts_paint', 00:57:55 INFO - 'tpaint', 00:57:55 INFO - 'sessionrestore', 00:57:55 INFO - 'sessionrestore_no_auto_restore', 00:57:55 INFO - 'tabpaint']}, 00:57:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:57:55 INFO - 'ts_paint', 00:57:55 INFO - 'tpaint', 00:57:55 INFO - 'sessionrestore', 00:57:55 INFO - 'sessionrestore_no_auto_restore', 00:57:55 INFO - 'tabpaint']}, 00:57:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:57:55 INFO - 'ts_paint', 00:57:55 INFO - 'tpaint', 00:57:55 INFO - 'sessionrestore', 00:57:55 INFO - 'sessionrestore_no_auto_restore', 00:57:55 INFO - 'tabpaint']}, 00:57:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:57:55 INFO - 'tests': ['a11yr', 00:57:55 INFO - 'ts_paint', 00:57:55 INFO - 'tpaint', 00:57:55 INFO - 'sessionrestore', 00:57:55 INFO - 'sessionrestore_no_auto_restore', 00:57:55 INFO - 'tabpaint']}, 00:57:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:57:55 INFO - 'tests': ['a11yr', 00:57:55 INFO - 'ts_paint', 00:57:55 INFO - 'tpaint', 00:57:55 INFO - 'sessionrestore', 00:57:55 INFO - 'sessionrestore_no_auto_restore', 00:57:55 INFO - 'tabpaint']}, 00:57:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:57:55 INFO - 'tests': ['tsvgx', 00:57:55 INFO - 'tsvgr_opacity', 00:57:55 INFO - 'tart', 00:57:55 INFO - 'tscrollx', 00:57:55 INFO - 'cart']}, 00:57:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:57:55 INFO - 'tsvgr_opacity', 00:57:55 INFO - 'tart', 00:57:55 INFO - 'tscrollx', 00:57:55 INFO - 'cart']}, 00:57:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:57:55 INFO - 'talos_options': ['--disable-e10s'], 00:57:55 INFO - 'tests': ['tp5o']}, 00:57:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:57:55 INFO - 'tests': ['tp5o']}, 00:57:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:57:55 INFO - 'talos_options': ['--disable-e10s', 00:57:55 INFO - '--xperf_path', 00:57:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:57:55 INFO - 'tests': ['tp5n']}, 00:57:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:57:55 INFO - 'talos_options': ['--xperf_path', 00:57:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:57:55 INFO - 'tests': ['tp5n']}}, 00:57:55 INFO - 'talos.zip': {'path': '', 00:57:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:57:55 INFO - Running post-action listener: _resource_record_post_action 00:57:55 INFO - [mozharness: 2016-10-06 07:57:55.935105Z] Finished populate-webroot step (success) 00:57:55 INFO - [mozharness: 2016-10-06 07:57:55.935215Z] Running create-virtualenv step. 00:57:55 INFO - Running pre-action listener: _resource_record_pre_action 00:57:55 INFO - Running main action method: create_virtualenv 00:57:55 INFO - Creating virtualenv /builds/slave/test/build/venv 00:57:55 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 00:57:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:57:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:57:56 INFO - Using real prefix '/tools/python27' 00:57:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:57:56 INFO - Installing distribute.............................................................................................................................................................................................done. 00:57:59 INFO - Installing pip.................done. 00:57:59 INFO - Return code: 0 00:57:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:57:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:57:59 INFO - Reading from file tmpfile_stdout 00:57:59 INFO - Output received: 00:57:59 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) 00:57:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:57:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:57:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:57:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e446490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f954258a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e25ad30>, '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 0x10e080db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e252b20>, '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.3hAMk3tHFo/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.6McOJX3LvQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 00:57:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:57:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:57:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hAMk3tHFo/Render', 00:57:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:57:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:57:59 INFO - 'HOME': '/Users/cltbld', 00:57:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:57:59 INFO - 'LOGNAME': 'cltbld', 00:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:57:59 INFO - 'MOZ_NO_REMOTE': '1', 00:57:59 INFO - 'NO_EM_RESTART': '1', 00:57:59 INFO - 'PAGER': '/bin/cat', 00:57:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:57:59 INFO - 'PWD': '/builds/slave/test', 00:57:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:57:59 INFO - 'SHELL': '/bin/bash', 00:57:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6McOJX3LvQ/Listeners', 00:57:59 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 00:57:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:57:59 INFO - 'USER': 'cltbld', 00:57:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:57:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:57:59 INFO - 'XPC_FLAGS': '0x0', 00:57:59 INFO - 'XPC_SERVICE_NAME': '0', 00:57:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:00 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 00:58:00 INFO - Cleaning up... 00:58:00 INFO - Return code: 0 00:58:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:58:00 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')]} 00:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:00 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')]} 00:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:00 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 0x10e446490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f954258a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e25ad30>, '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 0x10e080db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e252b20>, '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.3hAMk3tHFo/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.6McOJX3LvQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 00:58:00 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 00:58:00 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 00:58:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hAMk3tHFo/Render', 00:58:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:58:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:58:00 INFO - 'HOME': '/Users/cltbld', 00:58:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:58:00 INFO - 'LOGNAME': 'cltbld', 00:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:00 INFO - 'MOZ_NO_REMOTE': '1', 00:58:00 INFO - 'NO_EM_RESTART': '1', 00:58:00 INFO - 'PAGER': '/bin/cat', 00:58:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:00 INFO - 'PWD': '/builds/slave/test', 00:58:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:58:00 INFO - 'SHELL': '/bin/bash', 00:58:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6McOJX3LvQ/Listeners', 00:58:00 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 00:58:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:58:00 INFO - 'USER': 'cltbld', 00:58:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:58:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:00 INFO - 'XPC_FLAGS': '0x0', 00:58:00 INFO - 'XPC_SERVICE_NAME': '0', 00:58:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:00 INFO - Downloading/unpacking psutil>=3.1.1 00:58:00 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 00:58:00 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 00:58:00 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 00:58:00 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 00:58:00 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 00:58:00 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 00:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:58:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:58:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:58:03 INFO - Installing collected packages: psutil 00:58:03 INFO - Running setup.py install for psutil 00:58:03 INFO - building 'psutil._psutil_osx' extension 00:58:03 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 00:58:04 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 00:58:04 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 00:58:04 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 00:58:04 INFO - building 'psutil._psutil_posix' extension 00:58:04 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 00:58:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:58:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:58:04 INFO - ^ 00:58:04 INFO - 1 warning generated. 00:58:04 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 00:58:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:58:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:58:04 INFO - Successfully installed psutil 00:58:04 INFO - Cleaning up... 00:58:04 INFO - Return code: 0 00:58:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:58:04 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')]} 00:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:04 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')]} 00:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:04 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 0x10e446490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f954258a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e25ad30>, '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 0x10e080db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e252b20>, '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.3hAMk3tHFo/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.6McOJX3LvQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 00:58:04 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 00:58:04 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 00:58:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hAMk3tHFo/Render', 00:58:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:58:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:58:04 INFO - 'HOME': '/Users/cltbld', 00:58:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:58:04 INFO - 'LOGNAME': 'cltbld', 00:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:04 INFO - 'MOZ_NO_REMOTE': '1', 00:58:04 INFO - 'NO_EM_RESTART': '1', 00:58:04 INFO - 'PAGER': '/bin/cat', 00:58:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:04 INFO - 'PWD': '/builds/slave/test', 00:58:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:58:04 INFO - 'SHELL': '/bin/bash', 00:58:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6McOJX3LvQ/Listeners', 00:58:04 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 00:58:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:58:04 INFO - 'USER': 'cltbld', 00:58:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:58:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:04 INFO - 'XPC_FLAGS': '0x0', 00:58:04 INFO - 'XPC_SERVICE_NAME': '0', 00:58:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:58:05 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 00:58:05 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 00:58:05 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 00:58:05 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 00:58:05 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 00:58:05 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 00:58:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:58:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:58:07 INFO - Installing collected packages: mozsystemmonitor 00:58:07 INFO - Running setup.py install for mozsystemmonitor 00:58:07 INFO - Successfully installed mozsystemmonitor 00:58:07 INFO - Cleaning up... 00:58:08 INFO - Return code: 0 00:58:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e446490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f954258a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e25ad30>, '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 0x10e080db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e252b20>, '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.3hAMk3tHFo/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.6McOJX3LvQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 00:58:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:58:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hAMk3tHFo/Render', 00:58:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:58:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:58:08 INFO - 'HOME': '/Users/cltbld', 00:58:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:58:08 INFO - 'LOGNAME': 'cltbld', 00:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:08 INFO - 'MOZ_NO_REMOTE': '1', 00:58:08 INFO - 'NO_EM_RESTART': '1', 00:58:08 INFO - 'PAGER': '/bin/cat', 00:58:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:08 INFO - 'PWD': '/builds/slave/test', 00:58:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:58:08 INFO - 'SHELL': '/bin/bash', 00:58:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6McOJX3LvQ/Listeners', 00:58:08 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 00:58:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:58:08 INFO - 'USER': 'cltbld', 00:58:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:58:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:08 INFO - 'XPC_FLAGS': '0x0', 00:58:08 INFO - 'XPC_SERVICE_NAME': '0', 00:58:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:08 INFO - Downloading/unpacking jsonschema==2.5.1 00:58:08 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 00:58:08 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 00:58:08 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 00:58:08 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 00:58:08 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 00:58:08 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 00:58:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:58:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:58:10 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 00:58:10 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 00:58:10 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 00:58:10 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 00:58:10 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 00:58:10 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 00:58:11 INFO - Downloading functools32-3.2.3-2.tar.gz 00:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:58:11 INFO - warning: no files found matching '*.txt' 00:58:11 INFO - no previously-included directories found matching 'build' 00:58:11 INFO - no previously-included directories found matching 'dist' 00:58:11 INFO - no previously-included directories found matching '.git*' 00:58:11 INFO - Installing collected packages: jsonschema, functools32 00:58:11 INFO - Running setup.py install for functools32 00:58:11 INFO - warning: no files found matching '*.txt' 00:58:11 INFO - no previously-included directories found matching 'build' 00:58:11 INFO - no previously-included directories found matching 'dist' 00:58:11 INFO - no previously-included directories found matching '.git*' 00:58:11 INFO - Successfully installed jsonschema functools32 00:58:11 INFO - Cleaning up... 00:58:11 INFO - Return code: 0 00:58:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:58: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')]} 00:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58: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')]} 00:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58: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', '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 0x10e446490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f954258a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e25ad30>, '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 0x10e080db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e252b20>, '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.3hAMk3tHFo/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.6McOJX3LvQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 00:58: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:58: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 functools32==3.2.3-2 00:58:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hAMk3tHFo/Render', 00:58:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:58:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:58:11 INFO - 'HOME': '/Users/cltbld', 00:58:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:58:11 INFO - 'LOGNAME': 'cltbld', 00:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:11 INFO - 'MOZ_NO_REMOTE': '1', 00:58:11 INFO - 'NO_EM_RESTART': '1', 00:58:11 INFO - 'PAGER': '/bin/cat', 00:58:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:11 INFO - 'PWD': '/builds/slave/test', 00:58:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:58:11 INFO - 'SHELL': '/bin/bash', 00:58:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6McOJX3LvQ/Listeners', 00:58:11 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 00:58:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:58:11 INFO - 'USER': 'cltbld', 00:58:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:58:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:11 INFO - 'XPC_FLAGS': '0x0', 00:58:11 INFO - 'XPC_SERVICE_NAME': '0', 00:58:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:58:11 INFO - Cleaning up... 00:58:11 INFO - Return code: 0 00:58:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:58: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')]} 00:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58: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')]} 00:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58: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', '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 0x10e446490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f954258a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e25ad30>, '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 0x10e080db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e252b20>, '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.3hAMk3tHFo/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.6McOJX3LvQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 00:58: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:58: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 blobuploader==1.2.4 00:58:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hAMk3tHFo/Render', 00:58:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:58:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:58:11 INFO - 'HOME': '/Users/cltbld', 00:58:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:58:11 INFO - 'LOGNAME': 'cltbld', 00:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:11 INFO - 'MOZ_NO_REMOTE': '1', 00:58:11 INFO - 'NO_EM_RESTART': '1', 00:58:11 INFO - 'PAGER': '/bin/cat', 00:58:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:11 INFO - 'PWD': '/builds/slave/test', 00:58:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:58:11 INFO - 'SHELL': '/bin/bash', 00:58:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6McOJX3LvQ/Listeners', 00:58:11 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 00:58:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:58:11 INFO - 'USER': 'cltbld', 00:58:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:58:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:11 INFO - 'XPC_FLAGS': '0x0', 00:58:11 INFO - 'XPC_SERVICE_NAME': '0', 00:58:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:12 INFO - Downloading/unpacking blobuploader==1.2.4 00:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:58:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:58:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:58:14 INFO - Downloading blobuploader-1.2.4.tar.gz 00:58:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:58:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:58:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:58:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:58:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:58:15 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 00:58:15 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 00:58:15 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 00:58:15 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 00:58:15 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 00:58:15 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 00:58:15 INFO - Downloading docopt-0.6.1.tar.gz 00:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:58:15 INFO - Installing collected packages: blobuploader, requests, docopt 00:58:15 INFO - Running setup.py install for blobuploader 00:58:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:58:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:58:15 INFO - Running setup.py install for requests 00:58:16 INFO - Running setup.py install for docopt 00:58:16 INFO - Successfully installed blobuploader requests docopt 00:58:16 INFO - Cleaning up... 00:58:16 INFO - Return code: 0 00:58:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:16 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 0x10e446490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f954258a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e25ad30>, '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 0x10e080db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e252b20>, '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.3hAMk3tHFo/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.6McOJX3LvQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 00:58:16 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 00:58:16 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 00:58:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hAMk3tHFo/Render', 00:58:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:58:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:58:16 INFO - 'HOME': '/Users/cltbld', 00:58:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:58:16 INFO - 'LOGNAME': 'cltbld', 00:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:16 INFO - 'MOZ_NO_REMOTE': '1', 00:58:16 INFO - 'NO_EM_RESTART': '1', 00:58:16 INFO - 'PAGER': '/bin/cat', 00:58:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:16 INFO - 'PWD': '/builds/slave/test', 00:58:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:58:16 INFO - 'SHELL': '/bin/bash', 00:58:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6McOJX3LvQ/Listeners', 00:58:16 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 00:58:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:58:16 INFO - 'USER': 'cltbld', 00:58:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:58:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:16 INFO - 'XPC_FLAGS': '0x0', 00:58:16 INFO - 'XPC_SERVICE_NAME': '0', 00:58:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:58:16 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-n4nTE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:58:17 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-7HBMY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:58:17 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-HcjlWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:58:17 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-TGCGoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:58:17 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-8Dy88X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:58:17 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-iPZDW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:58:17 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-H5i2kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:58:17 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-jZ_Ry4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:58:17 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-dIqUOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:58:17 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-ZazG56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:58:18 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-xtXgpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:58:18 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-fiIOnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:58:18 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-eRjvCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:58:18 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-9CTeaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:58:18 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-4i9xzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:58:18 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-GTswW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:58:18 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-tCQNBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:58:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:58:18 INFO - Running setup.py install for manifestparser 00:58:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:58:18 INFO - Running setup.py install for mozcrash 00:58:19 INFO - Running setup.py install for mozdebug 00:58:19 INFO - Running setup.py install for mozdevice 00:58:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:58:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:58:19 INFO - Running setup.py install for mozfile 00:58:19 INFO - Running setup.py install for mozhttpd 00:58:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:58:19 INFO - Running setup.py install for mozinfo 00:58:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:58:19 INFO - Running setup.py install for mozInstall 00:58:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:58:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:58:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:58:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:58:19 INFO - Running setup.py install for mozleak 00:58:20 INFO - Running setup.py install for mozlog 00:58:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:58:20 INFO - Running setup.py install for moznetwork 00:58:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:58:20 INFO - Running setup.py install for mozprocess 00:58:20 INFO - Running setup.py install for mozprofile 00:58:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:58:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:58:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:58:20 INFO - Running setup.py install for mozrunner 00:58:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:58:20 INFO - Running setup.py install for mozscreenshot 00:58:21 INFO - Running setup.py install for moztest 00:58:21 INFO - Running setup.py install for mozversion 00:58:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:58:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:58:21 INFO - Cleaning up... 00:58:21 INFO - Return code: 0 00:58:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:58:21 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')]} 00:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:21 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')]} 00:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:21 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 0x10e446490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f954258a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e25ad30>, '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 0x10e080db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e252b20>, '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.3hAMk3tHFo/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.6McOJX3LvQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 00:58:21 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 00:58:21 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 00:58:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hAMk3tHFo/Render', 00:58:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:58:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:58:21 INFO - 'HOME': '/Users/cltbld', 00:58:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:58:21 INFO - 'LOGNAME': 'cltbld', 00:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:21 INFO - 'MOZ_NO_REMOTE': '1', 00:58:21 INFO - 'NO_EM_RESTART': '1', 00:58:21 INFO - 'PAGER': '/bin/cat', 00:58:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:21 INFO - 'PWD': '/builds/slave/test', 00:58:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:58:21 INFO - 'SHELL': '/bin/bash', 00:58:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6McOJX3LvQ/Listeners', 00:58:21 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 00:58:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:58:21 INFO - 'USER': 'cltbld', 00:58:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:58:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:21 INFO - 'XPC_FLAGS': '0x0', 00:58:21 INFO - 'XPC_SERVICE_NAME': '0', 00:58:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:58:21 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-NYO6Q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:58:21 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)) 00:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:58:21 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-rcWmoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:58:21 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)) 00:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:58:21 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-eG8RAT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:58:21 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)) 00:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:58:21 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-AolL9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:58:22 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)) 00:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:58:22 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Yrcb5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:58:22 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)) 00:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:58:22 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-BcF7gb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:58:22 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)) 00:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:58:22 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-I_g99s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:58:22 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)) 00:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:58:22 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-jLk8iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:58:22 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)) 00:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:58:22 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-WEngy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:58:22 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)) 00:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:58:22 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-KZXXFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:58:22 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)) 00:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:58:22 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-WQJrjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:58:22 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)) 00:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:58:22 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-eSoDev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:58:22 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)) 00:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:58:22 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-u0vrk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:58:23 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)) 00:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:58:23 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-ZiX3Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:58:23 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)) 00:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:58:23 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Qrs50v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:58:23 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)) 00:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:58:23 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-TgBF4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:58:23 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)) 00:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:58:23 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-8Dpdmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:58:23 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)) 00:58:23 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)) 00:58:23 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)) 00:58:23 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)) 00:58:23 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)) 00:58:23 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)) 00:58:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:58: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 00:58: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 00:58: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 00:58: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 00:58: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 00:58: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 00:58:25 INFO - Downloading blessings-1.6.tar.gz 00:58:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:58:25 INFO - Installing collected packages: blessings 00:58:25 INFO - Running setup.py install for blessings 00:58:26 INFO - Successfully installed blessings 00:58:26 INFO - Cleaning up... 00:58:26 INFO - Return code: 0 00:58:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:58:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:58:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:58:26 INFO - Reading from file tmpfile_stdout 00:58:26 INFO - Current package versions: 00:58:26 INFO - blessings == 1.6 00:58:26 INFO - blobuploader == 1.2.4 00:58:26 INFO - docopt == 0.6.1 00:58:26 INFO - functools32 == 3.2.3-2 00:58:26 INFO - jsonschema == 2.5.1 00:58:26 INFO - manifestparser == 1.1 00:58:26 INFO - mozInstall == 1.12 00:58:26 INFO - mozcrash == 0.17 00:58:26 INFO - mozdebug == 0.1 00:58:26 INFO - mozdevice == 0.48 00:58:26 INFO - mozfile == 1.2 00:58:26 INFO - mozhttpd == 0.7 00:58:26 INFO - mozinfo == 0.9 00:58:26 INFO - mozleak == 0.1 00:58:26 INFO - mozlog == 3.4 00:58:26 INFO - moznetwork == 0.27 00:58:26 INFO - mozprocess == 0.23 00:58:26 INFO - mozprofile == 0.28 00:58:26 INFO - mozrunner == 6.12 00:58:26 INFO - mozscreenshot == 0.1 00:58:26 INFO - mozsystemmonitor == 0.3 00:58:26 INFO - moztest == 0.7 00:58:26 INFO - mozversion == 1.4 00:58:26 INFO - psutil == 3.1.1 00:58:26 INFO - requests == 1.2.3 00:58:26 INFO - wsgiref == 0.1.2 00:58:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:27 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 0x10e446490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f954258a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e25ad30>, '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 0x10e080db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e252b20>, '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.3hAMk3tHFo/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.6McOJX3LvQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 00:58:27 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 00:58:27 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 00:58:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hAMk3tHFo/Render', 00:58:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:58:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:58:27 INFO - 'HOME': '/Users/cltbld', 00:58:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:58:27 INFO - 'LOGNAME': 'cltbld', 00:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:27 INFO - 'MOZ_NO_REMOTE': '1', 00:58:27 INFO - 'NO_EM_RESTART': '1', 00:58:27 INFO - 'PAGER': '/bin/cat', 00:58:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:27 INFO - 'PWD': '/builds/slave/test', 00:58:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:58:27 INFO - 'SHELL': '/bin/bash', 00:58:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6McOJX3LvQ/Listeners', 00:58:27 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 00:58:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:58:27 INFO - 'USER': 'cltbld', 00:58:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:58:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:27 INFO - 'XPC_FLAGS': '0x0', 00:58:27 INFO - 'XPC_SERVICE_NAME': '0', 00:58:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:27 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)) 00:58:27 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)) 00:58:27 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)) 00:58:27 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)) 00:58:27 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)) 00:58:27 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)) 00:58:27 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)) 00:58:27 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)) 00:58:27 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)) 00:58:27 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)) 00:58:27 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)) 00:58:27 INFO - Cleaning up... 00:58:27 INFO - Return code: 0 00:58:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:58: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')]} 00:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58: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')]} 00:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:58:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e446490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e3bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f954258a670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e25ad30>, '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 0x10e080db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e252b20>, '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.3hAMk3tHFo/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.6McOJX3LvQ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 00:58:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:58:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hAMk3tHFo/Render', 00:58:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:58:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:58:27 INFO - 'HOME': '/Users/cltbld', 00:58:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:58:27 INFO - 'LOGNAME': 'cltbld', 00:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:58:27 INFO - 'MOZ_NO_REMOTE': '1', 00:58:27 INFO - 'NO_EM_RESTART': '1', 00:58:27 INFO - 'PAGER': '/bin/cat', 00:58:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:58:27 INFO - 'PWD': '/builds/slave/test', 00:58:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:58:27 INFO - 'SHELL': '/bin/bash', 00:58:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6McOJX3LvQ/Listeners', 00:58:27 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 00:58:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:58:27 INFO - 'USER': 'cltbld', 00:58:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:58:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:58:27 INFO - 'XPC_FLAGS': '0x0', 00:58:27 INFO - 'XPC_SERVICE_NAME': '0', 00:58:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:58:28 INFO - Cleaning up... 00:58:28 INFO - Return code: 0 00:58:28 INFO - Running post-action listener: _resource_record_post_action 00:58:28 INFO - Running post-action listener: _start_resource_monitoring 00:58:28 INFO - Starting resource monitoring. 00:58:28 INFO - [mozharness: 2016-10-06 07:58:28.073550Z] Finished create-virtualenv step (success) 00:58:28 INFO - [mozharness: 2016-10-06 07:58:28.074578Z] Running install step. 00:58:28 INFO - Running pre-action listener: _resource_record_pre_action 00:58:28 INFO - Running main action method: install 00:58:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:58:28 INFO - Reading from file tmpfile_stdout 00:58:28 INFO - Detecting whether we're running mozinstall >=1.0... 00:58:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:58:28 INFO - Reading from file tmpfile_stdout 00:58:28 INFO - Output received: 00:58:28 INFO - Usage: mozinstall [options] installer 00:58:28 INFO - Options: 00:58:28 INFO - -h, --help show this help message and exit 00:58:28 INFO - -d DEST, --destination=DEST 00:58:28 INFO - Directory to install application into. [default: 00:58:28 INFO - "/builds/slave/test"] 00:58:28 INFO - --app=APP Application being installed. [default: firefox] 00:58:28 INFO - mkdir: /builds/slave/test/build/application 00:58:28 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'] 00:58:28 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 00:59:02 INFO - Reading from file tmpfile_stdout 00:59:02 INFO - Output received: 00:59:02 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:59:02 INFO - Running post-action listener: _resource_record_post_action 00:59:02 INFO - [mozharness: 2016-10-06 07:59:02.572219Z] Finished install step (success) 00:59:02 INFO - [mozharness: 2016-10-06 07:59:02.572372Z] Running run-tests step. 00:59:02 INFO - Running pre-action listener: _resource_record_pre_action 00:59:02 INFO - Running main action method: run_tests 00:59:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:59:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:59:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:59:02 INFO - 2016-10-06 00:59:02.586 screenresolution[1655:7395] starting screenresolution argv=screenresolution get 00:59:02 INFO - 2016-10-06 00:59:02.589 screenresolution[1655:7395] Display 0: 1600x1200x32@60 00:59:02 INFO - 2016-10-06 00:59:02.595 screenresolution[1656:7397] starting screenresolution argv=screenresolution list 00:59:02 INFO - Available Modes on Display 0 00:59:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:59:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:59:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:59:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:59:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:59:02 INFO - Intel Iris: 00:59:02 INFO - Chipset Model: Intel Iris 00:59:02 INFO - Type: GPU 00:59:02 INFO - Bus: Built-In 00:59:02 INFO - VRAM (Dynamic, Max): 1536 MB 00:59:02 INFO - Vendor: Intel (0x8086) 00:59:02 INFO - Device ID: 0x0a2e 00:59:02 INFO - Revision ID: 0x0009 00:59:02 INFO - Displays: 00:59:02 INFO - Display: 00:59:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:59:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:59:02 INFO - Display Serial Number: 1600x1200 60 00:59:02 INFO - Main Display: Yes 00:59:02 INFO - Mirror: Off 00:59:02 INFO - Online: Yes 00:59:02 INFO - Rotation: Supported 00:59:02 INFO - Return code: 0 00:59:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:59:02 INFO - Python 2.7.3 00:59:02 INFO - Return code: 0 00:59:02 INFO - grabbing minidump binary from tooltool 00:59:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:59:02 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 0x10e25ad30>, '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 0x10e080db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e252b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:59:02 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 00:59:02 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 00:59:02 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 00:59:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:59:02 INFO - Return code: 0 00:59:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:59:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:59:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:59:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:59:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:59:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0258', '--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 00:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0258 --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 00:59:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hAMk3tHFo/Render', 00:59:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:59:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:59:02 INFO - 'HOME': '/Users/cltbld', 00:59:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:59:02 INFO - 'LOGNAME': 'cltbld', 00:59:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:59:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:59:02 INFO - 'MOZ_NO_REMOTE': '1', 00:59:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:59:02 INFO - 'NO_EM_RESTART': '1', 00:59:02 INFO - 'PAGER': '/bin/cat', 00:59:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:59:02 INFO - 'PWD': '/builds/slave/test', 00:59:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:59:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:59:02 INFO - 'SHELL': '/bin/bash', 00:59:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6McOJX3LvQ/Listeners', 00:59:02 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 00:59:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:59:02 INFO - 'USER': 'cltbld', 00:59:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:59:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:59:02 INFO - 'XPC_FLAGS': '0x0', 00:59:02 INFO - 'XPC_SERVICE_NAME': '0', 00:59:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:59:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0258', '--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 00:59:03 INFO - mozversion application_buildid: 20161005213159 00:59:03 INFO - mozversion application_changeset: 80d979342a04c163156c1b74235cb9c24f850658 00:59:03 INFO - mozversion application_display_name: Nightly 00:59:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:59:03 INFO - mozversion application_name: Firefox 00:59:03 INFO - mozversion application_remotingname: firefox 00:59:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:59:03 INFO - mozversion application_vendor: Mozilla 00:59:03 INFO - mozversion application_version: 52.0a1 00:59:03 INFO - mozversion platform_buildid: 20161005213159 00:59:03 INFO - mozversion platform_changeset: 80d979342a04c163156c1b74235cb9c24f850658 00:59:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:59:03 INFO - mozversion platform_version: 52.0a1 00:59:03 INFO - using testdate: 1475740743 00:59:03 INFO - actual date: 1475740743 00:59:03 INFO - starting webserver on 'localhost:49281' 00:59:03 INFO - SUITE-START | Running 2 tests 00:59:03 INFO - TEST-START | dromaeo_css 00:59:03 INFO - operating with platform_type : mac_ 00:59:03 INFO - Initialising browser for dromaeo_css test... 00:59:03 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpWczWAA/profile http://localhost:49281/getInfo.html) 00:59:06 INFO - PROCESS | 1666 | 2016-10-06 00:59:06.004 plugin-container[1669:7562] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c3f, name = 'com.apple.tsm.portname' 00:59:06 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:59:06 INFO - PROCESS | 1666 | 2016-10-06 00:59:06.007 plugin-container[1669:7562] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c17, name = 'com.apple.CFPasteboardClient' 00:59:06 INFO - PROCESS | 1666 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:59:06 INFO - PROCESS | 1666 | 2016-10-06 00:59:06.007 plugin-container[1669:7562] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:59:06 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 00:59:06 INFO - PROCESS | 1666 | colorDepth:24 00:59:06 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 00:59:06 INFO - PROCESS | 1666 | __metrics 00:59:06 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 00:59:06 INFO - TEST-INFO | 1666: exit 0 00:59:06 INFO - Browser initialized. 00:59:06 INFO - Running cycle 1/1 for dromaeo_css test... 00:59:06 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpWczWAA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:59:09 INFO - PROCESS | 1670 | 2016-10-06 00:59:09.402 plugin-container[1671:7677] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8927, name = 'com.apple.tsm.portname' 00:59:09 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:59:09 INFO - PROCESS | 1670 | 2016-10-06 00:59:09.405 plugin-container[1671:7677] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f1b, name = 'com.apple.CFPasteboardClient' 00:59:09 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:59:09 INFO - PROCESS | 1670 | 2016-10-06 00:59:09.405 plugin-container[1671:7677] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:59:19 INFO - PROCESS | 1670 | RSS: Main: 239992832 00:59:19 INFO - PROCESS | 1670 | 01:00:08 INFO - PROCESS | 1670 | 1475740808748 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] 01:02:22 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49281/tests/dromaeo/cssquery-ext.html) 01:02:23 INFO - PROCESS | 1670 | RSS: Main: 251502592 01:02:23 INFO - PROCESS | 1670 | 01:05:25 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-ext.html (next: http://localhost:49281/tests/dromaeo/cssquery-jquery.html) 01:05:26 INFO - PROCESS | 1670 | RSS: Main: 266555392 01:05:26 INFO - PROCESS | 1670 | 01:08:28 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49281/tests/dromaeo/cssquery-mootools.html) 01:08:29 INFO - PROCESS | 1670 | RSS: Main: 270352384 01:08:29 INFO - PROCESS | 1670 | 01:11:31 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49281/tests/dromaeo/cssquery-prototype.html) 01:11:31 INFO - PROCESS | 1670 | RSS: Main: 269934592 01:11:31 INFO - PROCESS | 1670 | 01:14:34 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49281/tests/dromaeo/cssquery-yui.html) 01:14:35 INFO - PROCESS | 1670 | RSS: Main: 275267584 01:14:35 INFO - PROCESS | 1670 | 01:17:37 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-yui.html (next: http://localhost:49281/tests/dromaeo/cssquery-dojo.html) 01:17:38 INFO - PROCESS | 1670 | RSS: Main: 279044096 01:17:38 INFO - PROCESS | 1670 | 01:17:38 INFO - PROCESS | 1670 | __start_tp_report 01:17:38 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 01:17:38 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 01:17:38 INFO - PROCESS | 1670 | |i|pagename|runs| 01:17:38 INFO - PROCESS | 1670 | |0;dojo.html;3358.4794356874686;3361.2101156228296;3390.0507857799807;3396.405629014922;3415.0779289591796;5622.915656265149;5696.202531645563;5732.5127364174095;5742.3109226892775;5762.855928601787;5665.971670141644;5705;5717.6283541569765;5794.0729483282685;5804.680742559158;5201.609879259052;5235.293235413227;5283.63014588977;5290.418054014055;5330.546903513206;5223.399309079447;5292.100342941709;5324.65389749667;5332.200169974496;5388.892222155555;5146.562542183919;5211.895762084775;5289.814856480005;5310.575153987672;5318.175682769177;5164.096283150471;5199.740012999335;5217.843464696065;5276.762545685453;5287.154055351164;5151.278820965068;5178.0679477694;5183.45573714762;5205.453427390107;5242.947570524322;5579.38626751057;5744.626599271034;5751;5763.567732420043;5818.1272809078555;6037.516998640098;6069.939300606981;6107.704691583745;6153.538484613672;6201.069839524062;5764.645308352534;6246.250449946036;6249.843753906189;6257.937420625826;6258.436740693314;4448.555144485558;5061.620378471629;5469.890602187974;5848.005839007379;5889.411058894077;6132.6627035513475;6148.800983808204;6175.135481032659;6265.342139075423;6293.748250069946;5103.566196873233;5933.9406605934255;5955.166276721263;5962.672053037125;5982.192404025401;6066.211392518944;6072.635641861414;6077.36187700294;6111.266648002268;6124.387561243929;6118.893302669218;6128.442013631005;6159.5688301818445;6180.103884936659;6232.283287422005;4556.951901062774;6250.874982500324;6266.154069200691;6275.121482992385;6330.272018717815;4916.680415772963;4931.802727890916;4935.827246046371;4941.604671626261;4948.826791062295;4315;4372.322290045048;4392.582704643054;4422.049259409242;4440.888977775517;5899.085641725539;5943.910841337383;5951.256092988377;5976.312724036705;6017.669028203403;6152.938470615326;6203.4416902479;6235.251769787564;6252.781152659635;6267.341929097471;5661.377248502661;5683.715814209273;5779.739911703983;5886.411358864079;5899.793507227227;5391.622586418913;5440.211169380497;5469.917951230735;5484.204790305464;5499.065158922993;6335.556511044367;6349.936500635027;6359.395857393541;6365.809025729235;6370.235571731515;6157.983932651063;6169.413905678954;6239.719212635351;6252.187215661935;6260.812175634738;6210.906836397548;6240.500759939285;6251.718672659832;6278.7488500461295;6309.842253943688;5746.2529871116485;5754.712264386848;6174.981128113811;6180.6600636965395;6210.627362358273;6091.360407157184;6095.238095238095;6265.154204182377;6266.968665156645;6296.087067375296;6074.058520929263;6087.604305720114;6088.847778805565;6136.702895113817;6139.508839292936;6133.110698948717;6171.876562468815;6178.783742568989;6193.225846769154;6210.5652604319075;5853.707314634336;5910.468057874812;5915.822525324247;6017;6039.939600603938;6117.431594453822;6126.509879209563;6145.569810113249;6157.476614487819;6181.721822518088;6022.247219097613;6027.517798576016;6027.638341699512;6032.155498230339;6049.304330002106 01:17:38 INFO - PROCESS | 1670 | |1;ext.html;468.8429376158987;519.5220397234544;540.7674699879053;555.5250261026822;557.6477043170311;37865.43201851971;40699.38950915739;40754.38868416976;40762.184756304894;40824.387634185514;33860.83069584649;41588;42609.360859587054;42779.35830962538;43077;9573.712788616334;9843.310968232227;9871.358361706467;9915.851262231072;9932.056454636833;7913.960430197841;8626.835377224088;9613.75965600862;9743;9772.120509154174;9320.580573874191;9621;9711.757206069835;9769.169620582259;9769.364991275579;9603.903960960371;9657.613695452208;9710.660126895526;9735.513224338754;9744.512774361254;9635.13283804461;9777.217822574248;9777.951110244474;9787;9829.311948163631;32885.50671739926;39382.80308598468;40993.59006409928;41037;41165.1766964662;3058.801177923428;3593.5148754918014;3880.1463677990796;4082.448869402622;4185.100203456272;30421.543676844864;31530;31740.206494837585;32026.679733202604;32073;3238.4170849247125;3370.3259348130473;3405.7786243894066;3442.9483557746653;3448.103493091789;316866;377200;378965;380184;383124;61812.38187618066;62497;62633.74732505324;62767.43081423001;62777.372226278065;55608.16587751187;64190.0371494428;65599.34400656028;65656;66054.66972665106;16104.436344727877;16297.674046519003;16446.259918303465;16483.752743708854;16521.091339976178;12570.748585028248;12703.936480317725;12793.232406055666;12807.423665935055;12816.743665126645;16893.408730694366;17458.127093645267;17529.56176095608;17612.911935440497;17651.470455886345;3196.4725820239864;6150.354212807681;7330;7385.778426647209;7485;865.3380164174412;900.4057322167338;986.9013098690217;994.0804755601184;1004.3271008424373;27170;28004;29732.256693582833;30366.392672146434;30880.845595771876;1025.7640742629237;1110.5335758981248;1122.410734364449;1128.5316593613722;1153.7404084081015;15093.773593396108;15287.645316273021;15990.040597564184;16096.275667594986;16205.675886482204;597435;623032;631170;631703.6829631737;631826;59401.702991484766;59870;60191.39808601858;60584.697076514334;60682.0897686535;1346.8989825763108;1354.688421663023;1378.4417310989065;1388.895832812523;1402.5581941688336;26328.868355658098;30342.69657303487;30472.695273046986;30854.53718194274;31125.688743112278;52525.47474525206;52565;52762.68093297698;52820.471795281555;53377.398678039724;520919.39540302055;521465;522439;522597;523347;26302;26874.462510749283;27177.86411067932;27529.03648372297;27551.173464796088;44910;45620.77189614031;45799.77100114478;46567.534324657674;46851.765741171075;35914.64085359113;37920.43119353267;40135.59864401319;40299.79850100731;41330.586694132675;39644;39713.2057358857;39978.600748973644;40312.1937561253;41333.96665083397;38677.64628237998;39299.803500982314;40117;40168;40424.191516168925;32890.67109328972;35354.46968295529;35628.64371356253;35752.46371304485;35839.82080089583;20929.372118836458;25545.23364299074;25904.352391190372;26255;26997.78509967017 01:17:38 INFO - PROCESS | 1670 | |2;jquery.html;295.05140971775745;323.78144752292206;372.15706424947484;374.6403452685422;388.0550858659165;19085.71371429428;19711.21155153794;20380.796192038077;20538.589228215445;20707.378778636627;20158.294459693912;20544;20636.38090857273;20836;20946.685799712977;4947.579455746257;5167.689938603696;5919.49684276837;5927.347991720929;5941.316748573904;6656.600603963753;6907.34380233877;6921.446284297269;6922.584644921296;6924.4114250288785;6516.055172000057;6561.704723287439;6600.108985286973;6624.370684784938;6865.382115609594;6446.903296450557;6554.180727409074;6597.769078082268;6607.141071660653;6609.570377925444;5742.196092547047;5753.510951569122;5809.331926828427;5811.215485909391;5816.592838501307;18738.718919216222;22759.658605120938;23721;23818.16636417717;24750.50498990028;2167.5014746608213;2194.188150384368;2318.953620927589;2979.955300670492;3000.534917087855;9519.000504946951;9529.285303602257;9781.364211326312;9937;14151.716965660733;1806.843620083148;1908.4465505003532;1931.806819318071;1946.9707954380697;1973.1219607274768;101237.4938125312;103554.48222758913;114651.99999999917;115274.89226016939;123305;11172.385518796382;11315.603953861575;11467.655970320904;11470.025047871024;11484.540618375338;13974.301284935713;14199.14805111676;14212;14261.64345891361;14269.857301426853;7077.504574679723;8290.212429819278;8515.105913879077;8542.145785421408;8548.786280343042;6170.784022559189;6637.834054148589;6828.658567071627;7742.7677169685;8189.385796065319;4504.369388285642;4504.887377815516;4522.525134860858;4527.59251667345;4573.176828170961;1762.55936015996;1793.5426466251022;1835.9902053870585;1897.117840204284;1942.796006419334;869.8042940338373;894.2488309819653;898.2454738020094;939.9060093990546;972.7665360313615;20719.58560828775;20877.060532276086;20878.79121208799;21000;21049.89475052615;901.9503927284062;927.6614035876856;953.9935368186491;962.2542529539663;972.231936769958;9487.810243795224;10669.413182274895;10719.624813131502;11129.332240065622;11137.665870023913;523035;529354;531329;606744;644751;101851.49074254729;107013;109654;126339;133733;937.7889974755761;965.6427121964917;978.6623614852864;979.7697541077841;998.5257002923553;15768.763468547751;18946.95791731468;18981;19325.874153842786;19541.316053938044;37624.62375376211;49580.264690735654;50078.74960625174;53021.93956120933;53216.73391633017;80862;81171;81628.65342119237;81968.59015704883;84229.15770842214;6543.822112019882;6639.933600664125;7742.419318551244;7863.449558530848;8061.516309021477;11294;12189.329586872807;12507.312097834343;12579;12709.4280757368;10414.47927603632;10504.894951050392;10705;10873.347599144077;10911.672649820519;9119.452832830051;9570.712878613653;10732.624358147428;10782.029617334478;10861.891381086089;10508.0034793389;10790.622328218475;10832.512536936014;10857;10904.400257985886;7747.767566973;7903.84192316162;7914.366850652049;8036.075851277178;8113.878291825509;9152.4966126861;9238.30712696564;10665.520051597852;10828.079613232649;10838.295510791773 01:17:38 INFO - PROCESS | 1670 | |3;mootools.html;1520.3614481917598;1566.8746500279976;1800.50486116318;1828.3235202974902;1899.7340372347865;8200.26197642212;8507.95746021269;8563.957180214098;9213.539323033847;9226.400283981537;8682.913170868289;9042.54787260636;9052.04953479885;9123.95438022809;9162.17540421362;2347.4014126397747;2383.6543701163323;2388.462595915914;2398.5202959408102;2400.219928523228;2257.3905045637666;2262.6606009098687;2301.6892719482908;2304.193532263711;2309.595820731374;2373.1100837186054;2373.4066483379156;2383.4041489627593;2399.664047033417;2411.7829395354415;2241.4620491082023;2249.640057590786;2263.7396699379533;2265.2184996176375;2277.4761804784825;2354.587947109249;2356.7996720278798;2364.7044119485063;2367.3963139399516;2376.3702618805855;9036.8644470333;9046.959599645994;9128.634854605807;9129.22401595865;9135.223506001998;5198.844034678966;5201.869953251161;5360.2227676987;5365.839024829262;5369.463053694639;3057.220408795743;3211.309568442796;3242.221866751986;3575.803330816804;3649.81750912456;1103.613735192684;1116.2911551164987;1787.356551641408;1846.4183782108594;1889.5559543507402;11572.18994670365;11781.94109029458;11801.881981180164;11972.401379930969;12086.456109475095;4467.776611169428;4519.954800452019;4704.129735998851;4709.529047095263;4731.219348807477;8957.462552246887;9404.717858464257;9423.670171543963;9423.952880235554;9424.670136545188;5231.215317702299;5256.237845512379;5278.8944221116135;5299.655522391032;5313.415524292324;4454.688171828006;4607.193741095295;4815.22956326986;4964.950350496521;4979.751012449436;3774.75464094833;3804.4673745675627;3910.276598829226;3922.5685174630767;3954.683625309968;1167.4571324334224;1177.8822117788325;1179.722765150189;1193.1528614683498;1197.8981786548068;715.8138883890122;742.2688651678093;849.6304107713164;917.5458148216542;935.3546053223254;5145.344782929249;5863.648181109147;5962.522998160137;6162.506999440034;6322.367763223733;916.4272329793879;925.250547056886;942.3215284994793;945.5981207986579;947.9525124737204;3718.4980027695915;4066.0851308455362;4089.1003979124544;4131.215069136854;4158.877103182184;10918.836217456745;10951.56193752241;11186.496607652674;11273.71815704614;11294.209405341548;9834.655787047563;10922.726931826768;11233.382163980896;11251.94374028141;11426.743058263584;8351.415400921998;8395.62219700115;8419.789505262295;8490.575471226413;8507.872381914152;5928.762849485972;5955;5955.970220148872;6089;6095.878082438415;10103.343282686601;10234.232432567438;10281.84577231357;10465.529051192867;10496.002879726413;10018.949905250718;10632.946835265775;10657.25399222078;10680.57277708883;10713.89286107129;6677.966610166918;6899.862002759816;6982;7137.607431591312;7251.456140789356;8484.872726908978;8520.275776559061;8768.649254030022;8785;8793.780155496164;7542.585157816154;7675.616219188906;7681.385489160742;7780.572068536285;7793.571353575608;7336.669849856876;7430.851382972202;7443.218462061405;7460.179380268275;7734.1105772836845;7079.362857342864;7212.42300615939;7230.313120253568;7235.710571577078;7241.927580724126;4421.513633500376;4682.906341873076;4890.413150421972;5212.947870521246;5233.581313494835;4491.483479399911;5168.560672342893;5192.299039629602;5258.106121959199;5374.032674118696 01:17:38 INFO - PROCESS | 1670 | |4;prototype.html;249.4773449623039;290.3409260977581;310.867881150511;316.09281362489656;324.39338437122586;5270.762815673294;5416;5481.506664400204;5703.201551782754;5706.7431965561545;5345.1447768357075;5364.356277246726;5474.42518535553;5566.359868615111;5574.832755017346;3558.5729712434413;3715.6470135337236;4185.267578173823;4250.702450828428;4251.744895306291;3538.752287339887;3850.7304488685804;3925.5878132796074;4112.917741645166;4216.936745948813;3298.5711857458496;3851.7496362736474;4088.2216235937312;4113.773742444165;4146.212219678251;3589.766665166756;3653.707703383723;4127.225293123955;4127.9174416511805;4146.502419709639;3417.5215469834243;3563.3430454838626;3582.623824498416;3587.551556055493;3608.621094785036;4219.177260434217;5056.317397151411;5352.464753524655;5358.651687640291;5381;3842.731008829383;4704.6001089907395;4705.505921878222;4756.381670382828;4771.642126840501;5805.93889169343;5816.970915145397;5822.767089316422;5833.154192642086;5856.209411729405;3653.780773153619;3690.741648084635;3787.1857550626746;3905.1603905160528;3936.9606303937167;5373.435789242151;5490.752916118744;6041.395860413923;6093.618041986696;6103.786367477117;3827.1962887793875;3924.529056513237;3945.467361906106;3946.960530394659;3955.624215699504;3617.113807117273;3767.6420740030203;3826.3598117298975;3869.3821277105994;3982.38273067675;4170.83316667336;4711.882202944954;4721.622270218374;4728.834490792806;4751;4617.861464156013;5726.3700992890745;5861.824145275648;5876.44173803488;5884.882302353929;1169.2750494693344;1182.5624518928053;1282.4165004922738;1331.6071758831167;1342.664333916521;717.8133685241875;745.6458182363334;899.5831565284702;915.5193523400268;919.650532797546;5469.425710300441;5496.477834605706;5505.229267902497;5506.669599824023;5537.280153580009;5017.498250174954;5277.551408130275;5953.523718102541;5961.374055724174;5971.7611295547695;5099.69401835891;5348.465153484621;5414.91174163504;5481.479259470344;5531.280933478622;2957.3882234181992;3185.5062465317915;3195.8814414955045;3202.9359412811614;3210.7270881974828;5093.185090385595;5350.732463376893;6279.654618995908;6327.651979141099;6337.9366206337345;5582.358028826656;5875.00249915031;5882.264716910387;6224.657643829632;6299.433051025429;5722.713864306768;6052.848678783065;6335.208098987534;6371.936280637227;6398.4561312287115;5359.356877174764;5843.678597677169;6000.639961602318;6053.427293400376;6180.845478863064;5142.948570514247;5294.602904782079;6003.309619393651;6011.27864656244;6066.332703402711;5528.91706624409;5922.644641321534;6383.457406120346;6401.743930242738;6461;4009.91980160401;4106.527749308868;4121.340585506305;4129.174165166918;4133.21468920904;4476.574725401082;5690.752152899664;5830.970845145747;5899.908516924383;6041.365656606169;4537.4328208973875;5215.982883337864;5686.952697029149;5837.708114594168;5838.211841401357;5109.007487079967;5407.83776486706;5866.208061911588;5893.557983151195;5922.73347699346;5431.2667789847865;5747.971260143672;5793.36273009977;5813.011787995966;5817.825465236049;5884.382139875252;5896.6756828374855;5923.229980102559;5940.316863560746;5953.374895635896;5103.923441148311;5549.805756798492;5734.2258795062135;5876.3536011039605;5930.881382372415 01:17:38 INFO - PROCESS | 1670 | |5;yui.html;717.2074857282703;738.9113306403233;749.4716225061333;780.8126049748058;832.9920795837035;14942.626434339147;15571.29929153188;16022.919885400586;16038.59903502413;16099.919500402497;14414.49549265776;14483.203423811687;14601;14626.561203163896;14627.78058329126;861.8707193920915;886.1271647427279;888.2449917570046;890.9599068041954;891.1177933845511;705.8164877131932;729.678941265844;867.7440155154245;892.1078921078921;893.1604291965532;936.8173206224789;945.5319616789665;946.0161432110597;946.2571881073359;949.8765160529122;914.2685851318919;943.9339246252765;944.5607792376544;944.6976967370445;944.8724422203018;646.9094326794252;691.7440546997643;701.3617607976716;703.4126504368807;709.8154479835229;14334.64163395913;14638.92680536601;14642.121472711671;14646.560603181922;14729.484468043674;12513.311767852765;14373.856261437357;14440.205788681618;14464.566063018126;14723.852761472355;11766.58816941403;11822.763544729058;11963.760724785456;11996.64010079699;12185.573504927284;3782.829772660237;3807.1814559869485;3822.5986271441375;3858.131920317934;3860.903477413059;85578.71631925525;103501;104788.47605761999;107885;111280.99999999919;10966.835497467384;11051;11082.22424430282;11103.389313587668;11513.30920144794;22660.320190394315;22676.65985010226;22685;22725.659115113285;22748;7826.491278067021;8024.0772311184965;8027.07688615805;8118.999350678356;8130.75607731769;4348.586884245991;4398.3842262083335;4424.13729322779;4448.377227188196;4536.160810250114;3272.460044092698;3526.2242306692488;3644.6173151819207;3653.415453527423;3664.5052917856283;585.6690969602162;659.2649196146358;724.4928550015011;724.5218156017004;739.7928579997609;495.30904388378013;559.4098226371217;655.3638707118836;664.9268580456146;679.7624304732028;8778.780530486789;8888.866667;9109.544522773835;9553.449662551977;9692.660756873476;571.074858728862;610.5359926455925;669.4410167510086;680.3502654964497;700.0458066957432;3902.5316961964177;4073.6944729145434;4448.866534003985;4626.560476754703;4832.710037397767;119943;153572;163061;164041;170882;109543.45228273967;121385;125725;128339;146182;71921;72389.2761072393;87024.12975870287;104434;104838;9274.397164184307;9772.31593788428;9934.652287169914;9980.60077596888;10062.295639305179;50084.49915500799;51188;63326.683366584715;63901.36098638954;65340.67329663321;82044;87422.68865966889;95184.52407737917;98002;98163;12566.193073956207;12938.482460701467;13228.14017088886;13379.933100334436;13965.511207107702;14664.117832026695;14927.626809329853;14940;15112.546623601309;15240.314185861442;13563.932180339036;13879.79180312276;14169.149851008973;14458;14587.703247497027;13628.114172578751;13646.795298070736;13796.241206733726;14252.717255446645;14341.211233382264;13339.733205336033;13469.663258418617;13590;13671.084480774462;14208.147511149364;11161.88838111641;11330.320180788849;11373.374464404205;11388.715282117682;11688.590899318484;7840.189558360859;7956.986047249774;8242.711505097293;10136.645217417356;11312.9434352831 01:17:38 INFO - PROCESS | 1670 | __end_tp_report 01:17:38 INFO - PROCESS | 1670 | __start_cc_report 01:17:38 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,348 01:17:38 INFO - PROCESS | 1670 | __end_cc_report 01:17:38 INFO - PROCESS | 1670 | __startTimestamp1475741858126__endTimestamp 01:17:38 INFO - PROCESS | 1670 | 01:17:38 INFO - PROCESS | 1670 | ------- Summary: start ------- 01:17:38 INFO - PROCESS | 1670 | Number of tests: 6 01:17:38 INFO - PROCESS | 1670 | 01:17:38 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5721.60 Median:5955.17 stddev:639.71 (10.7%) stddev-sans-first:614.22 01:17:38 INFO - PROCESS | 1670 | Values: 3358.5 3361.2 3390.1 3396.4 3415.1 5622.9 5696.2 5732.5 5742.3 5762.9 5666.0 5705.0 5717.6 5794.1 5804.7 5201.6 5235.3 5283.6 5290.4 5330.5 5223.4 5292.1 5324.7 5332.2 5388.9 5146.6 5211.9 5289.8 5310.6 5318.2 5164.1 5199.7 5217.8 5276.8 5287.2 5151.3 5178.1 5183.5 5205.5 5242.9 5579.4 5744.6 5751.0 5763.6 5818.1 6037.5 6069.9 6107.7 6153.5 6201.1 5764.6 6246.3 6249.8 6257.9 6258.4 4448.6 5061.6 5469.9 5848.0 5889.4 6132.7 6148.8 6175.1 6265.3 6293.7 5103.6 5933.9 5955.2 5962.7 5982.2 6066.2 6072.6 6077.4 6111.3 6124.4 6118.9 6128.4 6159.6 6180.1 6232.3 4557.0 6250.9 6266.2 6275.1 6330.3 4916.7 4931.8 4935.8 4941.6 4948.8 4315.0 4372.3 4392.6 4422.0 4440.9 5899.1 5943.9 5951.3 5976.3 6017.7 6152.9 6203.4 6235.3 6252.8 6267.3 5661.4 5683.7 5779.7 5886.4 5899.8 5391.6 5440.2 5469.9 5484.2 5499.1 6335.6 6349.9 6359.4 6365.8 6370.2 6158.0 6169.4 6239.7 6252.2 6260.8 6210.9 6240.5 6251.7 6278.7 6309.8 5746.3 5754.7 6175.0 6180.7 6210.6 6091.4 6095.2 6265.2 6267.0 6296.1 6074.1 6087.6 6088.8 6136.7 6139.5 6133.1 6171.9 6178.8 6193.2 6210.6 5853.7 5910.5 5915.8 6017.0 6039.9 6117.4 6126.5 6145.6 6157.5 6181.7 6022.2 6027.5 6027.6 6032.2 6049.3 01:17:38 INFO - PROCESS | 1670 | 01:17:38 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:65056.86 Median:40368.19 stddev:137519.51 (340.7%) stddev-sans-first:137819.79 01:17:38 INFO - PROCESS | 1670 | Values: 468.8 519.5 540.8 555.5 557.6 37865.4 40699.4 40754.4 40762.2 40824.4 33860.8 41588.0 42609.4 42779.4 43077.0 9573.7 9843.3 9871.4 9915.9 9932.1 7914.0 8626.8 9613.8 9743.0 9772.1 9320.6 9621.0 9711.8 9769.2 9769.4 9603.9 9657.6 9710.7 9735.5 9744.5 9635.1 9777.2 9778.0 9787.0 9829.3 32885.5 39382.8 40993.6 41037.0 41165.2 3058.8 3593.5 3880.1 4082.4 4185.1 30421.5 31530.0 31740.2 32026.7 32073.0 3238.4 3370.3 3405.8 3442.9 3448.1 316866.0 377200.0 378965.0 380184.0 383124.0 61812.4 62497.0 62633.7 62767.4 62777.4 55608.2 64190.0 65599.3 65656.0 66054.7 16104.4 16297.7 16446.3 16483.8 16521.1 12570.7 12703.9 12793.2 12807.4 12816.7 16893.4 17458.1 17529.6 17612.9 17651.5 3196.5 6150.4 7330.0 7385.8 7485.0 865.3 900.4 986.9 994.1 1004.3 27170.0 28004.0 29732.3 30366.4 30880.8 1025.8 1110.5 1122.4 1128.5 1153.7 15093.8 15287.6 15990.0 16096.3 16205.7 597435.0 623032.0 631170.0 631703.7 631826.0 59401.7 59870.0 60191.4 60584.7 60682.1 1346.9 1354.7 1378.4 1388.9 1402.6 26328.9 30342.7 30472.7 30854.5 31125.7 52525.5 52565.0 52762.7 52820.5 53377.4 520919.4 521465.0 522439.0 522597.0 523347.0 26302.0 26874.5 27177.9 27529.0 27551.2 44910.0 45620.8 45799.8 46567.5 46851.8 35914.6 37920.4 40135.6 40299.8 41330.6 39644.0 39713.2 39978.6 40312.2 41334.0 38677.6 39299.8 40117.0 40168.0 40424.2 32890.7 35354.5 35628.6 35752.5 35839.8 20929.4 25545.2 25904.4 26255.0 26997.8 01:17:38 INFO - PROCESS | 1670 | 01:17:38 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:33467.52 Median:19006.34 stddev:94927.96 (499.5%) stddev-sans-first:95161.58 01:17:38 INFO - PROCESS | 1670 | Values: 295.1 323.8 372.2 374.6 388.1 19085.7 19711.2 20380.8 20538.6 20707.4 20158.3 20544.0 20636.4 20836.0 20946.7 4947.6 5167.7 5919.5 5927.3 5941.3 6656.6 6907.3 6921.4 6922.6 6924.4 6516.1 6561.7 6600.1 6624.4 6865.4 6446.9 6554.2 6597.8 6607.1 6609.6 5742.2 5753.5 5809.3 5811.2 5816.6 18738.7 22759.7 23721.0 23818.2 24750.5 2167.5 2194.2 2319.0 2980.0 3000.5 9519.0 9529.3 9781.4 9937.0 14151.7 1806.8 1908.4 1931.8 1947.0 1973.1 101237.5 103554.5 114652.0 115274.9 123305.0 11172.4 11315.6 11467.7 11470.0 11484.5 13974.3 14199.1 14212.0 14261.6 14269.9 7077.5 8290.2 8515.1 8542.1 8548.8 6170.8 6637.8 6828.7 7742.8 8189.4 4504.4 4504.9 4522.5 4527.6 4573.2 1762.6 1793.5 1836.0 1897.1 1942.8 869.8 894.2 898.2 939.9 972.8 20719.6 20877.1 20878.8 21000.0 21049.9 902.0 927.7 954.0 962.3 972.2 9487.8 10669.4 10719.6 11129.3 11137.7 523035.0 529354.0 531329.0 606744.0 644751.0 101851.5 107013.0 109654.0 126339.0 133733.0 937.8 965.6 978.7 979.8 998.5 15768.8 18947.0 18981.0 19325.9 19541.3 37624.6 49580.3 50078.7 53021.9 53216.7 80862.0 81171.0 81628.7 81968.6 84229.2 6543.8 6639.9 7742.4 7863.4 8061.5 11294.0 12189.3 12507.3 12579.0 12709.4 10414.5 10504.9 10705.0 10873.3 10911.7 9119.5 9570.7 10732.6 10782.0 10861.9 10508.0 10790.6 10832.5 10857.0 10904.4 7747.8 7903.8 7914.4 8036.1 8113.9 9152.5 9238.3 10665.5 10828.1 10838.3 01:17:38 INFO - PROCESS | 1670 | 01:17:38 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:5789.20 Median:4927.68 stddev:3276.60 (66.5%) stddev-sans-first:3270.09 01:17:38 INFO - PROCESS | 1670 | Values: 1520.4 1566.9 1800.5 1828.3 1899.7 8200.3 8508.0 8564.0 9213.5 9226.4 8682.9 9042.5 9052.0 9124.0 9162.2 2347.4 2383.7 2388.5 2398.5 2400.2 2257.4 2262.7 2301.7 2304.2 2309.6 2373.1 2373.4 2383.4 2399.7 2411.8 2241.5 2249.6 2263.7 2265.2 2277.5 2354.6 2356.8 2364.7 2367.4 2376.4 9036.9 9047.0 9128.6 9129.2 9135.2 5198.8 5201.9 5360.2 5365.8 5369.5 3057.2 3211.3 3242.2 3575.8 3649.8 1103.6 1116.3 1787.4 1846.4 1889.6 11572.2 11781.9 11801.9 11972.4 12086.5 4467.8 4520.0 4704.1 4709.5 4731.2 8957.5 9404.7 9423.7 9424.0 9424.7 5231.2 5256.2 5278.9 5299.7 5313.4 4454.7 4607.2 4815.2 4965.0 4979.8 3774.8 3804.5 3910.3 3922.6 3954.7 1167.5 1177.9 1179.7 1193.2 1197.9 715.8 742.3 849.6 917.5 935.4 5145.3 5863.6 5962.5 6162.5 6322.4 916.4 925.3 942.3 945.6 948.0 3718.5 4066.1 4089.1 4131.2 4158.9 10918.8 10951.6 11186.5 11273.7 11294.2 9834.7 10922.7 11233.4 11251.9 11426.7 8351.4 8395.6 8419.8 8490.6 8507.9 5928.8 5955.0 5956.0 6089.0 6095.9 10103.3 10234.2 10281.8 10465.5 10496.0 10018.9 10632.9 10657.3 10680.6 10713.9 6678.0 6899.9 6982.0 7137.6 7251.5 8484.9 8520.3 8768.6 8785.0 8793.8 7542.6 7675.6 7681.4 7780.6 7793.6 7336.7 7430.9 7443.2 7460.2 7734.1 7079.4 7212.4 7230.3 7235.7 7241.9 4421.5 4682.9 4890.4 5212.9 5233.6 4491.5 5168.6 5192.3 5258.1 5374.0 01:17:38 INFO - PROCESS | 1670 | 01:17:38 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:4698.62 Median:5361.86 stddev:1491.36 (27.8%) stddev-sans-first:1457.68 01:17:38 INFO - PROCESS | 1670 | Values: 249.5 290.3 310.9 316.1 324.4 5270.8 5416.0 5481.5 5703.2 5706.7 5345.1 5364.4 5474.4 5566.4 5574.8 3558.6 3715.6 4185.3 4250.7 4251.7 3538.8 3850.7 3925.6 4112.9 4216.9 3298.6 3851.7 4088.2 4113.8 4146.2 3589.8 3653.7 4127.2 4127.9 4146.5 3417.5 3563.3 3582.6 3587.6 3608.6 4219.2 5056.3 5352.5 5358.7 5381.0 3842.7 4704.6 4705.5 4756.4 4771.6 5805.9 5817.0 5822.8 5833.2 5856.2 3653.8 3690.7 3787.2 3905.2 3937.0 5373.4 5490.8 6041.4 6093.6 6103.8 3827.2 3924.5 3945.5 3947.0 3955.6 3617.1 3767.6 3826.4 3869.4 3982.4 4170.8 4711.9 4721.6 4728.8 4751.0 4617.9 5726.4 5861.8 5876.4 5884.9 1169.3 1182.6 1282.4 1331.6 1342.7 717.8 745.6 899.6 915.5 919.7 5469.4 5496.5 5505.2 5506.7 5537.3 5017.5 5277.6 5953.5 5961.4 5971.8 5099.7 5348.5 5414.9 5481.5 5531.3 2957.4 3185.5 3195.9 3202.9 3210.7 5093.2 5350.7 6279.7 6327.7 6337.9 5582.4 5875.0 5882.3 6224.7 6299.4 5722.7 6052.8 6335.2 6371.9 6398.5 5359.4 5843.7 6000.6 6053.4 6180.8 5142.9 5294.6 6003.3 6011.3 6066.3 5528.9 5922.6 6383.5 6401.7 6461.0 4009.9 4106.5 4121.3 4129.2 4133.2 4476.6 5690.8 5831.0 5899.9 6041.4 4537.4 5216.0 5687.0 5837.7 5838.2 5109.0 5407.8 5866.2 5893.6 5922.7 5431.3 5748.0 5793.4 5813.0 5817.8 5884.4 5896.7 5923.2 5940.3 5953.4 5103.9 5549.8 5734.2 5876.4 5930.9 01:17:38 INFO - PROCESS | 1670 | 01:17:38 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:24099.32 Median:3814.89 stddev:38507.74 (1009.4%) stddev-sans-first:38575.75 01:17:38 INFO - PROCESS | 1670 | Values: 717.2 738.9 749.5 780.8 833.0 14942.6 15571.3 16022.9 16038.6 16099.9 14414.5 14483.2 14601.0 14626.6 14627.8 861.9 886.1 888.2 891.0 891.1 705.8 729.7 867.7 892.1 893.2 936.8 945.5 946.0 946.3 949.9 914.3 943.9 944.6 944.7 944.9 646.9 691.7 701.4 703.4 709.8 14334.6 14638.9 14642.1 14646.6 14729.5 12513.3 14373.9 14440.2 14464.6 14723.9 11766.6 11822.8 11963.8 11996.6 12185.6 3782.8 3807.2 3822.6 3858.1 3860.9 85578.7 103501.0 104788.5 107885.0 111281.0 10966.8 11051.0 11082.2 11103.4 11513.3 22660.3 22676.7 22685.0 22725.7 22748.0 7826.5 8024.1 8027.1 8119.0 8130.8 4348.6 4398.4 4424.1 4448.4 4536.2 3272.5 3526.2 3644.6 3653.4 3664.5 585.7 659.3 724.5 724.5 739.8 495.3 559.4 655.4 664.9 679.8 8778.8 8888.9 9109.5 9553.4 9692.7 571.1 610.5 669.4 680.4 700.0 3902.5 4073.7 4448.9 4626.6 4832.7 119943.0 153572.0 163061.0 164041.0 170882.0 109543.5 121385.0 125725.0 128339.0 146182.0 71921.0 72389.3 87024.1 104434.0 104838.0 9274.4 9772.3 9934.7 9980.6 10062.3 50084.5 51188.0 63326.7 63901.4 65340.7 82044.0 87422.7 95184.5 98002.0 98163.0 12566.2 12938.5 13228.1 13379.9 13965.5 14664.1 14927.6 14940.0 15112.5 15240.3 13563.9 13879.8 14169.1 14458.0 14587.7 13628.1 13646.8 13796.2 14252.7 14341.2 13339.7 13469.7 13590.0 13671.1 14208.1 11161.9 11330.3 11373.4 11388.7 11688.6 7840.2 7957.0 8242.7 10136.6 11312.9 01:17:38 INFO - PROCESS | 1670 | -------- Summary: end -------- 01:17:38 INFO - PROCESS | 1670 | 01:17:38 INFO - TEST-INFO | 1670: exit 0 01:17:38 INFO - TEST-OK | dromaeo_css | took 1115589ms 01:17:38 INFO - TEST-START | kraken 01:17:38 INFO - operating with platform_type : mac_ 01:17:38 INFO - Initialising browser for kraken test... 01:17:38 INFO - TEST-INFO | started process 1792 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmp6P6yNb/profile http://localhost:49281/getInfo.html) 01:17:41 INFO - PROCESS | 1792 | 2016-10-06 01:17:41.552 plugin-container[1793:10027] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d27, name = 'com.apple.tsm.portname' 01:17:41 INFO - PROCESS | 1792 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:17:41 INFO - PROCESS | 1792 | 2016-10-06 01:17:41.555 plugin-container[1793:10027] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x901b, name = 'com.apple.CFPasteboardClient' 01:17:41 INFO - PROCESS | 1792 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:17:41 INFO - PROCESS | 1792 | 2016-10-06 01:17:41.555 plugin-container[1793:10027] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:17:41 INFO - PROCESS | 1792 | __metrics Screen width/height:1600/1200 01:17:41 INFO - PROCESS | 1792 | colorDepth:24 01:17:41 INFO - PROCESS | 1792 | Browser inner width/height: 1024/689 01:17:41 INFO - PROCESS | 1792 | __metrics 01:17:41 ERROR - PROCESS | 1792 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 01:17:42 INFO - TEST-INFO | 1792: exit 0 01:17:42 INFO - Browser initialized. 01:17:42 INFO - Running cycle 1/1 for kraken test... 01:17:42 INFO - TEST-INFO | started process 1794 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmp6P6yNb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:17:44 INFO - PROCESS | 1794 | 2016-10-06 01:17:44.855 plugin-container[1795:10143] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461b, name = 'com.apple.tsm.portname' 01:17:44 INFO - PROCESS | 1794 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:17:44 INFO - PROCESS | 1794 | 2016-10-06 01:17:44.859 plugin-container[1795:10143] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e1b, name = 'com.apple.CFPasteboardClient' 01:17:44 INFO - PROCESS | 1794 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:17:44 INFO - PROCESS | 1794 | 2016-10-06 01:17:44.859 plugin-container[1795:10143] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:17:54 INFO - PROCESS | 1794 | RSS: Main: 240246784 01:17:54 INFO - PROCESS | 1794 | 01:17:57 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection) 01:17:58 INFO - PROCESS | 1794 | RSS: Main: 253640704 01:17:58 INFO - PROCESS | 1794 | 01:18:01 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-dft) 01:18:01 INFO - PROCESS | 1794 | RSS: Main: 262172672 01:18:01 INFO - PROCESS | 1794 | 01:18:05 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-fft) 01:18:06 INFO - PROCESS | 1794 | RSS: Main: 262328320 01:18:06 INFO - PROCESS | 1794 | 01:18:08 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator) 01:18:08 INFO - PROCESS | 1794 | RSS: Main: 263028736 01:18:08 INFO - PROCESS | 1794 | 01:18:10 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:18:11 INFO - PROCESS | 1794 | RSS: Main: 263491584 01:18:11 INFO - PROCESS | 1794 | 01:18:14 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom) 01:18:14 INFO - PROCESS | 1794 | RSS: Main: 263598080 01:18:14 INFO - PROCESS | 1794 | 01:18:17 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate) 01:18:18 INFO - PROCESS | 1794 | RSS: Main: 265150464 01:18:18 INFO - PROCESS | 1794 | 01:18:21 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial) 01:18:22 INFO - PROCESS | 1794 | RSS: Main: 265134080 01:18:22 INFO - PROCESS | 1794 | 01:18:23 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:18:24 INFO - PROCESS | 1794 | RSS: Main: 265048064 01:18:24 INFO - PROCESS | 1794 | 01:18:26 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:18:27 INFO - PROCESS | 1794 | RSS: Main: 264990720 01:18:27 INFO - PROCESS | 1794 | 01:18:29 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:18:29 INFO - PROCESS | 1794 | RSS: Main: 265064448 01:18:29 INFO - PROCESS | 1794 | 01:18:33 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:18:33 INFO - PROCESS | 1794 | RSS: Main: 265342976 01:18:33 INFO - PROCESS | 1794 | 01:18:36 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:18:37 INFO - PROCESS | 1794 | RSS: Main: 265240576 01:18:37 INFO - PROCESS | 1794 | 01:18:39 INFO - PROCESS | 1794 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49281/tests/kraken/driver.html?testName=ai-astar) 01:18:39 INFO - PROCESS | 1794 | RSS: Main: 267010048 01:18:39 INFO - PROCESS | 1794 | 01:18:39 INFO - PROCESS | 1794 | __start_tp_report 01:18:39 INFO - PROCESS | 1794 | _x_x_mozilla_page_load 01:18:39 INFO - PROCESS | 1794 | _x_x_mozilla_page_load_details 01:18:39 INFO - PROCESS | 1794 | |i|pagename|runs| 01:18:39 INFO - PROCESS | 1794 | |0;ai-astar;104;109;169;171;129;119;119;120;103;168 01:18:39 INFO - PROCESS | 1794 | |1;audio-beat-detection;146;116;115;151;118;116;118;143;158;112 01:18:39 INFO - PROCESS | 1794 | |2;audio-dft;199;235;195;269;272;222;195;196;195;193 01:18:39 INFO - PROCESS | 1794 | |3;audio-fft;83;56;59;84;58;55;55;60;79;59 01:18:39 INFO - PROCESS | 1794 | |4;audio-oscillator;86;69;89;78;57;69;111;97;100;116 01:18:39 INFO - PROCESS | 1794 | |5;imaging-gaussian-blur;134;122;88;97;90;83;136;129;90;86 01:18:39 INFO - PROCESS | 1794 | |6;imaging-darkroom;154;122;95;96;95;94;95;96;103;141 01:18:39 INFO - PROCESS | 1794 | |7;imaging-desaturate;92;92;144;149;93;90;110;150;115;91 01:18:39 INFO - PROCESS | 1794 | |8;json-parse-financial;54;56;55;56;57;60;81;67;57;58 01:18:39 INFO - PROCESS | 1794 | |9;json-stringify-tinderbox;63;69;71;92;97;95;68;74;100;103 01:18:39 INFO - PROCESS | 1794 | |10;stanford-crypto-aes;90;89;88;90;87;88;88;92;87;86 01:18:39 INFO - PROCESS | 1794 | |11;stanford-crypto-ccm;145;144;154;191;154;154;161;156;202;166 01:18:39 INFO - PROCESS | 1794 | |12;stanford-crypto-pbkdf2;180;228;237;178;171;173;193;235;169;230 01:18:39 INFO - PROCESS | 1794 | |13;stanford-crypto-sha256-iterative;65;88;89;69;72;71;68;70;71;71 01:18:39 INFO - PROCESS | 1794 | __end_tp_report 01:18:39 INFO - PROCESS | 1794 | __start_cc_report 01:18:39 INFO - PROCESS | 1794 | _x_x_mozilla_cycle_collect,936 01:18:39 INFO - PROCESS | 1794 | __end_cc_report 01:18:39 INFO - PROCESS | 1794 | __startTimestamp1475741919589__endTimestamp 01:18:39 INFO - PROCESS | 1794 | 01:18:39 INFO - PROCESS | 1794 | ------- Summary: start ------- 01:18:39 INFO - PROCESS | 1794 | Number of tests: 14 01:18:39 INFO - PROCESS | 1794 | 01:18:39 INFO - PROCESS | 1794 | [#0] ai-astar Cycles:10 Average:131.10 Median:124.50 stddev:27.53 (22.1%) stddev-sans-first:27.40 01:18:39 INFO - PROCESS | 1794 | Values: 104.0 109.0 169.0 171.0 129.0 119.0 119.0 120.0 103.0 168.0 01:18:39 INFO - PROCESS | 1794 | 01:18:39 INFO - PROCESS | 1794 | [#1] audio-beat-detection Cycles:10 Average:129.30 Median:130.50 stddev:17.87 (13.7%) stddev-sans-first:17.90 01:18:39 INFO - PROCESS | 1794 | Values: 146.0 116.0 115.0 151.0 118.0 116.0 118.0 143.0 158.0 112.0 01:18:39 INFO - PROCESS | 1794 | 01:18:39 INFO - PROCESS | 1794 | [#2] audio-dft Cycles:10 Average:217.10 Median:210.50 stddev:31.40 (14.9%) stddev-sans-first:32.61 01:18:39 INFO - PROCESS | 1794 | Values: 199.0 235.0 195.0 269.0 272.0 222.0 195.0 196.0 195.0 193.0 01:18:39 INFO - PROCESS | 1794 | 01:18:39 INFO - PROCESS | 1794 | [#3] audio-fft Cycles:10 Average:64.80 Median:59.50 stddev:12.05 (20.3%) stddev-sans-first:10.84 01:18:39 INFO - PROCESS | 1794 | Values: 83.0 56.0 59.0 84.0 58.0 55.0 55.0 60.0 79.0 59.0 01:18:39 INFO - PROCESS | 1794 | 01:18:39 INFO - PROCESS | 1794 | [#4] audio-oscillator Cycles:10 Average:87.20 Median:73.50 stddev:19.21 (26.1%) stddev-sans-first:20.37 01:18:39 INFO - PROCESS | 1794 | Values: 86.0 69.0 89.0 78.0 57.0 69.0 111.0 97.0 100.0 116.0 01:18:39 INFO - PROCESS | 1794 | 01:18:39 INFO - PROCESS | 1794 | [#5] imaging-gaussian-blur Cycles:10 Average:105.50 Median:87.00 stddev:21.89 (25.2%) stddev-sans-first:20.65 01:18:39 INFO - PROCESS | 1794 | Values: 134.0 122.0 88.0 97.0 90.0 83.0 136.0 129.0 90.0 86.0 01:18:39 INFO - PROCESS | 1794 | 01:18:39 INFO - PROCESS | 1794 | [#6] imaging-darkroom Cycles:10 Average:109.10 Median:95.00 stddev:22.12 (23.3%) stddev-sans-first:16.45 01:18:39 INFO - PROCESS | 1794 | Values: 154.0 122.0 95.0 96.0 95.0 94.0 95.0 96.0 103.0 141.0 01:18:39 INFO - PROCESS | 1794 | 01:18:39 INFO - PROCESS | 1794 | [#7] imaging-desaturate Cycles:10 Average:112.60 Median:90.50 stddev:25.67 (28.4%) stddev-sans-first:26.13 01:18:39 INFO - PROCESS | 1794 | Values: 92.0 92.0 144.0 149.0 93.0 90.0 110.0 150.0 115.0 91.0 01:18:39 INFO - PROCESS | 1794 | 01:18:39 INFO - PROCESS | 1794 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:57.50 stddev:8.20 (14.3%) stddev-sans-first:8.39 01:18:39 INFO - PROCESS | 1794 | Values: 54.0 56.0 55.0 56.0 57.0 60.0 81.0 67.0 57.0 58.0 01:18:39 INFO - PROCESS | 1794 | 01:18:39 INFO - PROCESS | 1794 | [#9] json-stringify-tinderbox Cycles:10 Average:83.20 Median:72.50 stddev:15.48 (21.3%) stddev-sans-first:14.59 01:18:39 INFO - PROCESS | 1794 | Values: 63.0 69.0 71.0 92.0 97.0 95.0 68.0 74.0 100.0 103.0 01:18:39 INFO - PROCESS | 1794 | 01:18:39 INFO - PROCESS | 1794 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:88.50 stddev:1.78 (2.0%) stddev-sans-first:1.80 01:18:39 INFO - PROCESS | 1794 | Values: 90.0 89.0 88.0 90.0 87.0 88.0 88.0 92.0 87.0 86.0 01:18:39 INFO - PROCESS | 1794 | 01:18:39 INFO - PROCESS | 1794 | [#11] stanford-crypto-ccm Cycles:10 Average:162.70 Median:158.50 stddev:19.13 (12.1%) stddev-sans-first:19.19 01:18:39 INFO - PROCESS | 1794 | Values: 145.0 144.0 154.0 191.0 154.0 154.0 161.0 156.0 202.0 166.0 01:18:39 INFO - PROCESS | 1794 | 01:18:39 INFO - PROCESS | 1794 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.40 Median:210.50 stddev:29.32 (13.9%) stddev-sans-first:30.25 01:18:39 INFO - PROCESS | 1794 | Values: 180.0 228.0 237.0 178.0 171.0 173.0 193.0 235.0 169.0 230.0 01:18:39 INFO - PROCESS | 1794 | 01:18:39 INFO - PROCESS | 1794 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:71.00 stddev:8.21 (11.6%) stddev-sans-first:8.12 01:18:39 INFO - PROCESS | 1794 | Values: 65.0 88.0 89.0 69.0 72.0 71.0 68.0 70.0 71.0 71.0 01:18:39 INFO - PROCESS | 1794 | -------- Summary: end -------- 01:18:39 INFO - PROCESS | 1794 | 01:18:40 INFO - TEST-INFO | 1794: exit 0 01:18:40 INFO - TEST-OK | kraken | took 61853ms 01:18:40 INFO - SUITE-END | took 1177s 01:18:40 INFO - Completed test suite (00:19:37) 01:18:40 INFO - javascript benchmark 01:18:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7384.507589399801, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3358.4794356874686, 3361.2101156228296, 3390.0507857799807, 3396.405629014922, 3415.0779289591796, 5622.915656265149, 5696.202531645563, 5732.5127364174095, 5742.3109226892775, 5762.855928601787, 5665.971670141644, 5705.0, 5717.6283541569765, 5794.0729483282685, 5804.680742559158, 5201.609879259052, 5235.293235413227, 5283.63014588977, 5290.418054014055, 5330.546903513206, 5223.399309079447, 5292.100342941709, 5324.65389749667, 5332.200169974496, 5388.892222155555, 5146.562542183919, 5211.895762084775, 5289.814856480005, 5310.575153987672, 5318.175682769177, 5164.096283150471, 5199.740012999335, 5217.843464696065, 5276.762545685453, 5287.154055351164, 5151.278820965068, 5178.0679477694, 5183.45573714762, 5205.453427390107, 5242.947570524322, 5579.38626751057, 5744.626599271034, 5751.0, 5763.567732420043, 5818.1272809078555, 6037.516998640098, 6069.939300606981, 6107.704691583745, 6153.538484613672, 6201.069839524062, 5764.645308352534, 6246.250449946036, 6249.843753906189, 6257.937420625826, 6258.436740693314, 4448.555144485558, 5061.620378471629, 5469.890602187974, 5848.005839007379, 5889.411058894077, 6132.6627035513475, 6148.800983808204, 6175.135481032659, 6265.342139075423, 6293.748250069946, 5103.566196873233, 5933.9406605934255, 5955.166276721263, 5962.672053037125, 5982.192404025401, 6066.211392518944, 6072.635641861414, 6077.36187700294, 6111.266648002268, 6124.387561243929, 6118.893302669218, 6128.442013631005, 6159.5688301818445, 6180.103884936659, 6232.283287422005, 4556.951901062774, 6250.874982500324, 6266.154069200691, 6275.121482992385, 6330.272018717815, 4916.680415772963, 4931.802727890916, 4935.827246046371, 4941.604671626261, 4948.826791062295, 4315.0, 4372.322290045048, 4392.582704643054, 4422.049259409242, 4440.888977775517, 5899.085641725539, 5943.910841337383, 5951.256092988377, 5976.312724036705, 6017.669028203403, 6152.938470615326, 6203.4416902479, 6235.251769787564, 6252.781152659635, 6267.341929097471, 5661.377248502661, 5683.715814209273, 5779.739911703983, 5886.411358864079, 5899.793507227227, 5391.622586418913, 5440.211169380497, 5469.917951230735, 5484.204790305464, 5499.065158922993, 6335.556511044367, 6349.936500635027, 6359.395857393541, 6365.809025729235, 6370.235571731515, 6157.983932651063, 6169.413905678954, 6239.719212635351, 6252.187215661935, 6260.812175634738, 6210.906836397548, 6240.500759939285, 6251.718672659832, 6278.7488500461295, 6309.842253943688, 5746.2529871116485, 5754.712264386848, 6174.981128113811, 6180.6600636965395, 6210.627362358273, 6091.360407157184, 6095.238095238095, 6265.154204182377, 6266.968665156645, 6296.087067375296, 6074.058520929263, 6087.604305720114, 6088.847778805565, 6136.702895113817, 6139.508839292936, 6133.110698948717, 6171.876562468815, 6178.783742568989, 6193.225846769154, 6210.5652604319075, 5853.707314634336, 5910.468057874812, 5915.822525324247, 6017.0, 6039.939600603938, 6117.431594453822, 6126.509879209563, 6145.569810113249, 6157.476614487819, 6181.721822518088, 6022.247219097613, 6027.517798576016, 6027.638341699512, 6032.155498230339, 6049.304330002106], "value": 5682.368889960388, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.8429376158987, 519.5220397234544, 540.7674699879053, 555.5250261026822, 557.6477043170311, 37865.43201851971, 40699.38950915739, 40754.38868416976, 40762.184756304894, 40824.387634185514, 33860.83069584649, 41588.0, 42609.360859587054, 42779.35830962538, 43077.0, 9573.712788616334, 9843.310968232227, 9871.358361706467, 9915.851262231072, 9932.056454636833, 7913.960430197841, 8626.835377224088, 9613.75965600862, 9743.0, 9772.120509154174, 9320.580573874191, 9621.0, 9711.757206069835, 9769.169620582259, 9769.364991275579, 9603.903960960371, 9657.613695452208, 9710.660126895526, 9735.513224338754, 9744.512774361254, 9635.13283804461, 9777.217822574248, 9777.951110244474, 9787.0, 9829.311948163631, 32885.50671739926, 39382.80308598468, 40993.59006409928, 41037.0, 41165.1766964662, 3058.801177923428, 3593.5148754918014, 3880.1463677990796, 4082.448869402622, 4185.100203456272, 30421.543676844864, 31530.0, 31740.206494837585, 32026.679733202604, 32073.0, 3238.4170849247125, 3370.3259348130473, 3405.7786243894066, 3442.9483557746653, 3448.103493091789, 316866.0, 377200.0, 378965.0, 380184.0, 383124.0, 61812.38187618066, 62497.0, 62633.74732505324, 62767.43081423001, 62777.372226278065, 55608.16587751187, 64190.0371494428, 65599.34400656028, 65656.0, 66054.66972665106, 16104.436344727877, 16297.674046519003, 16446.259918303465, 16483.752743708854, 16521.091339976178, 12570.748585028248, 12703.936480317725, 12793.232406055666, 12807.423665935055, 12816.743665126645, 16893.408730694366, 17458.127093645267, 17529.56176095608, 17612.911935440497, 17651.470455886345, 3196.4725820239864, 6150.354212807681, 7330.0, 7385.778426647209, 7485.0, 865.3380164174412, 900.4057322167338, 986.9013098690217, 994.0804755601184, 1004.3271008424373, 27170.0, 28004.0, 29732.256693582833, 30366.392672146434, 30880.845595771876, 1025.7640742629237, 1110.5335758981248, 1122.410734364449, 1128.5316593613722, 1153.7404084081015, 15093.773593396108, 15287.645316273021, 15990.040597564184, 16096.275667594986, 16205.675886482204, 597435.0, 623032.0, 631170.0, 631703.6829631737, 631826.0, 59401.702991484766, 59870.0, 60191.39808601858, 60584.697076514334, 60682.0897686535, 1346.8989825763108, 1354.688421663023, 1378.4417310989065, 1388.895832812523, 1402.5581941688336, 26328.868355658098, 30342.69657303487, 30472.695273046986, 30854.53718194274, 31125.688743112278, 52525.47474525206, 52565.0, 52762.68093297698, 52820.471795281555, 53377.398678039724, 520919.39540302055, 521465.0, 522439.0, 522597.0, 523347.0, 26302.0, 26874.462510749283, 27177.86411067932, 27529.03648372297, 27551.173464796088, 44910.0, 45620.77189614031, 45799.77100114478, 46567.534324657674, 46851.765741171075, 35914.64085359113, 37920.43119353267, 40135.59864401319, 40299.79850100731, 41330.586694132675, 39644.0, 39713.2057358857, 39978.600748973644, 40312.1937561253, 41333.96665083397, 38677.64628237998, 39299.803500982314, 40117.0, 40168.0, 40424.191516168925, 32890.67109328972, 35354.46968295529, 35628.64371356253, 35752.46371304485, 35839.82080089583, 20929.372118836458, 25545.23364299074, 25904.352391190372, 26255.0, 26997.78509967017], "value": 19850.42214380504, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.05140971775745, 323.78144752292206, 372.15706424947484, 374.6403452685422, 388.0550858659165, 19085.71371429428, 19711.21155153794, 20380.796192038077, 20538.589228215445, 20707.378778636627, 20158.294459693912, 20544.0, 20636.38090857273, 20836.0, 20946.685799712977, 4947.579455746257, 5167.689938603696, 5919.49684276837, 5927.347991720929, 5941.316748573904, 6656.600603963753, 6907.34380233877, 6921.446284297269, 6922.584644921296, 6924.4114250288785, 6516.055172000057, 6561.704723287439, 6600.108985286973, 6624.370684784938, 6865.382115609594, 6446.903296450557, 6554.180727409074, 6597.769078082268, 6607.141071660653, 6609.570377925444, 5742.196092547047, 5753.510951569122, 5809.331926828427, 5811.215485909391, 5816.592838501307, 18738.718919216222, 22759.658605120938, 23721.0, 23818.16636417717, 24750.50498990028, 2167.5014746608213, 2194.188150384368, 2318.953620927589, 2979.955300670492, 3000.534917087855, 9519.000504946951, 9529.285303602257, 9781.364211326312, 9937.0, 14151.716965660733, 1806.843620083148, 1908.4465505003532, 1931.806819318071, 1946.9707954380697, 1973.1219607274768, 101237.4938125312, 103554.48222758913, 114651.99999999917, 115274.89226016939, 123305.0, 11172.385518796382, 11315.603953861575, 11467.655970320904, 11470.025047871024, 11484.540618375338, 13974.301284935713, 14199.14805111676, 14212.0, 14261.64345891361, 14269.857301426853, 7077.504574679723, 8290.212429819278, 8515.105913879077, 8542.145785421408, 8548.786280343042, 6170.784022559189, 6637.834054148589, 6828.658567071627, 7742.7677169685, 8189.385796065319, 4504.369388285642, 4504.887377815516, 4522.525134860858, 4527.59251667345, 4573.176828170961, 1762.55936015996, 1793.5426466251022, 1835.9902053870585, 1897.117840204284, 1942.796006419334, 869.8042940338373, 894.2488309819653, 898.2454738020094, 939.9060093990546, 972.7665360313615, 20719.58560828775, 20877.060532276086, 20878.79121208799, 21000.0, 21049.89475052615, 901.9503927284062, 927.6614035876856, 953.9935368186491, 962.2542529539663, 972.231936769958, 9487.810243795224, 10669.413182274895, 10719.624813131502, 11129.332240065622, 11137.665870023913, 523035.0, 529354.0, 531329.0, 606744.0, 644751.0, 101851.49074254729, 107013.0, 109654.0, 126339.0, 133733.0, 937.7889974755761, 965.6427121964917, 978.6623614852864, 979.7697541077841, 998.5257002923553, 15768.763468547751, 18946.95791731468, 18981.0, 19325.874153842786, 19541.316053938044, 37624.62375376211, 49580.264690735654, 50078.74960625174, 53021.93956120933, 53216.73391633017, 80862.0, 81171.0, 81628.65342119237, 81968.59015704883, 84229.15770842214, 6543.822112019882, 6639.933600664125, 7742.419318551244, 7863.449558530848, 8061.516309021477, 11294.0, 12189.329586872807, 12507.312097834343, 12579.0, 12709.4280757368, 10414.47927603632, 10504.894951050392, 10705.0, 10873.347599144077, 10911.672649820519, 9119.452832830051, 9570.712878613653, 10732.624358147428, 10782.029617334478, 10861.891381086089, 10508.0034793389, 10790.622328218475, 10832.512536936014, 10857.0, 10904.400257985886, 7747.767566973, 7903.84192316162, 7914.366850652049, 8036.075851277178, 8113.878291825509, 9152.4966126861, 9238.30712696564, 10665.520051597852, 10828.079613232649, 10838.295510791773], "value": 9409.838142185474, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1520.3614481917598, 1566.8746500279976, 1800.50486116318, 1828.3235202974902, 1899.7340372347865, 8200.26197642212, 8507.95746021269, 8563.957180214098, 9213.539323033847, 9226.400283981537, 8682.913170868289, 9042.54787260636, 9052.04953479885, 9123.95438022809, 9162.17540421362, 2347.4014126397747, 2383.6543701163323, 2388.462595915914, 2398.5202959408102, 2400.219928523228, 2257.3905045637666, 2262.6606009098687, 2301.6892719482908, 2304.193532263711, 2309.595820731374, 2373.1100837186054, 2373.4066483379156, 2383.4041489627593, 2399.664047033417, 2411.7829395354415, 2241.4620491082023, 2249.640057590786, 2263.7396699379533, 2265.2184996176375, 2277.4761804784825, 2354.587947109249, 2356.7996720278798, 2364.7044119485063, 2367.3963139399516, 2376.3702618805855, 9036.8644470333, 9046.959599645994, 9128.634854605807, 9129.22401595865, 9135.223506001998, 5198.844034678966, 5201.869953251161, 5360.2227676987, 5365.839024829262, 5369.463053694639, 3057.220408795743, 3211.309568442796, 3242.221866751986, 3575.803330816804, 3649.81750912456, 1103.613735192684, 1116.2911551164987, 1787.356551641408, 1846.4183782108594, 1889.5559543507402, 11572.18994670365, 11781.94109029458, 11801.881981180164, 11972.401379930969, 12086.456109475095, 4467.776611169428, 4519.954800452019, 4704.129735998851, 4709.529047095263, 4731.219348807477, 8957.462552246887, 9404.717858464257, 9423.670171543963, 9423.952880235554, 9424.670136545188, 5231.215317702299, 5256.237845512379, 5278.8944221116135, 5299.655522391032, 5313.415524292324, 4454.688171828006, 4607.193741095295, 4815.22956326986, 4964.950350496521, 4979.751012449436, 3774.75464094833, 3804.4673745675627, 3910.276598829226, 3922.5685174630767, 3954.683625309968, 1167.4571324334224, 1177.8822117788325, 1179.722765150189, 1193.1528614683498, 1197.8981786548068, 715.8138883890122, 742.2688651678093, 849.6304107713164, 917.5458148216542, 935.3546053223254, 5145.344782929249, 5863.648181109147, 5962.522998160137, 6162.506999440034, 6322.367763223733, 916.4272329793879, 925.250547056886, 942.3215284994793, 945.5981207986579, 947.9525124737204, 3718.4980027695915, 4066.0851308455362, 4089.1003979124544, 4131.215069136854, 4158.877103182184, 10918.836217456745, 10951.56193752241, 11186.496607652674, 11273.71815704614, 11294.209405341548, 9834.655787047563, 10922.726931826768, 11233.382163980896, 11251.94374028141, 11426.743058263584, 8351.415400921998, 8395.62219700115, 8419.789505262295, 8490.575471226413, 8507.872381914152, 5928.762849485972, 5955.0, 5955.970220148872, 6089.0, 6095.878082438415, 10103.343282686601, 10234.232432567438, 10281.84577231357, 10465.529051192867, 10496.002879726413, 10018.949905250718, 10632.946835265775, 10657.25399222078, 10680.57277708883, 10713.89286107129, 6677.966610166918, 6899.862002759816, 6982.0, 7137.607431591312, 7251.456140789356, 8484.872726908978, 8520.275776559061, 8768.649254030022, 8785.0, 8793.780155496164, 7542.585157816154, 7675.616219188906, 7681.385489160742, 7780.572068536285, 7793.571353575608, 7336.669849856876, 7430.851382972202, 7443.218462061405, 7460.179380268275, 7734.1105772836845, 7079.362857342864, 7212.42300615939, 7230.313120253568, 7235.710571577078, 7241.927580724126, 4421.513633500376, 4682.906341873076, 4890.413150421972, 5212.947870521246, 5233.581313494835, 4491.483479399911, 5168.560672342893, 5192.299039629602, 5258.106121959199, 5374.032674118696], "value": 4651.492912440028, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [249.4773449623039, 290.3409260977581, 310.867881150511, 316.09281362489656, 324.39338437122586, 5270.762815673294, 5416.0, 5481.506664400204, 5703.201551782754, 5706.7431965561545, 5345.1447768357075, 5364.356277246726, 5474.42518535553, 5566.359868615111, 5574.832755017346, 3558.5729712434413, 3715.6470135337236, 4185.267578173823, 4250.702450828428, 4251.744895306291, 3538.752287339887, 3850.7304488685804, 3925.5878132796074, 4112.917741645166, 4216.936745948813, 3298.5711857458496, 3851.7496362736474, 4088.2216235937312, 4113.773742444165, 4146.212219678251, 3589.766665166756, 3653.707703383723, 4127.225293123955, 4127.9174416511805, 4146.502419709639, 3417.5215469834243, 3563.3430454838626, 3582.623824498416, 3587.551556055493, 3608.621094785036, 4219.177260434217, 5056.317397151411, 5352.464753524655, 5358.651687640291, 5381.0, 3842.731008829383, 4704.6001089907395, 4705.505921878222, 4756.381670382828, 4771.642126840501, 5805.93889169343, 5816.970915145397, 5822.767089316422, 5833.154192642086, 5856.209411729405, 3653.780773153619, 3690.741648084635, 3787.1857550626746, 3905.1603905160528, 3936.9606303937167, 5373.435789242151, 5490.752916118744, 6041.395860413923, 6093.618041986696, 6103.786367477117, 3827.1962887793875, 3924.529056513237, 3945.467361906106, 3946.960530394659, 3955.624215699504, 3617.113807117273, 3767.6420740030203, 3826.3598117298975, 3869.3821277105994, 3982.38273067675, 4170.83316667336, 4711.882202944954, 4721.622270218374, 4728.834490792806, 4751.0, 4617.861464156013, 5726.3700992890745, 5861.824145275648, 5876.44173803488, 5884.882302353929, 1169.2750494693344, 1182.5624518928053, 1282.4165004922738, 1331.6071758831167, 1342.664333916521, 717.8133685241875, 745.6458182363334, 899.5831565284702, 915.5193523400268, 919.650532797546, 5469.425710300441, 5496.477834605706, 5505.229267902497, 5506.669599824023, 5537.280153580009, 5017.498250174954, 5277.551408130275, 5953.523718102541, 5961.374055724174, 5971.7611295547695, 5099.69401835891, 5348.465153484621, 5414.91174163504, 5481.479259470344, 5531.280933478622, 2957.3882234181992, 3185.5062465317915, 3195.8814414955045, 3202.9359412811614, 3210.7270881974828, 5093.185090385595, 5350.732463376893, 6279.654618995908, 6327.651979141099, 6337.9366206337345, 5582.358028826656, 5875.00249915031, 5882.264716910387, 6224.657643829632, 6299.433051025429, 5722.713864306768, 6052.848678783065, 6335.208098987534, 6371.936280637227, 6398.4561312287115, 5359.356877174764, 5843.678597677169, 6000.639961602318, 6053.427293400376, 6180.845478863064, 5142.948570514247, 5294.602904782079, 6003.309619393651, 6011.27864656244, 6066.332703402711, 5528.91706624409, 5922.644641321534, 6383.457406120346, 6401.743930242738, 6461.0, 4009.91980160401, 4106.527749308868, 4121.340585506305, 4129.174165166918, 4133.21468920904, 4476.574725401082, 5690.752152899664, 5830.970845145747, 5899.908516924383, 6041.365656606169, 4537.4328208973875, 5215.982883337864, 5686.952697029149, 5837.708114594168, 5838.211841401357, 5109.007487079967, 5407.83776486706, 5866.208061911588, 5893.557983151195, 5922.73347699346, 5431.2667789847865, 5747.971260143672, 5793.36273009977, 5813.011787995966, 5817.825465236049, 5884.382139875252, 5896.6756828374855, 5923.229980102559, 5940.316863560746, 5953.374895635896, 5103.923441148311, 5549.805756798492, 5734.2258795062135, 5876.3536011039605, 5930.881382372415], "value": 4208.583141285707, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.2074857282703, 738.9113306403233, 749.4716225061333, 780.8126049748058, 832.9920795837035, 14942.626434339147, 15571.29929153188, 16022.919885400586, 16038.59903502413, 16099.919500402497, 14414.49549265776, 14483.203423811687, 14601.0, 14626.561203163896, 14627.78058329126, 861.8707193920915, 886.1271647427279, 888.2449917570046, 890.9599068041954, 891.1177933845511, 705.8164877131932, 729.678941265844, 867.7440155154245, 892.1078921078921, 893.1604291965532, 936.8173206224789, 945.5319616789665, 946.0161432110597, 946.2571881073359, 949.8765160529122, 914.2685851318919, 943.9339246252765, 944.5607792376544, 944.6976967370445, 944.8724422203018, 646.9094326794252, 691.7440546997643, 701.3617607976716, 703.4126504368807, 709.8154479835229, 14334.64163395913, 14638.92680536601, 14642.121472711671, 14646.560603181922, 14729.484468043674, 12513.311767852765, 14373.856261437357, 14440.205788681618, 14464.566063018126, 14723.852761472355, 11766.58816941403, 11822.763544729058, 11963.760724785456, 11996.64010079699, 12185.573504927284, 3782.829772660237, 3807.1814559869485, 3822.5986271441375, 3858.131920317934, 3860.903477413059, 85578.71631925525, 103501.0, 104788.47605761999, 107885.0, 111280.99999999919, 10966.835497467384, 11051.0, 11082.22424430282, 11103.389313587668, 11513.30920144794, 22660.320190394315, 22676.65985010226, 22685.0, 22725.659115113285, 22748.0, 7826.491278067021, 8024.0772311184965, 8027.07688615805, 8118.999350678356, 8130.75607731769, 4348.586884245991, 4398.3842262083335, 4424.13729322779, 4448.377227188196, 4536.160810250114, 3272.460044092698, 3526.2242306692488, 3644.6173151819207, 3653.415453527423, 3664.5052917856283, 585.6690969602162, 659.2649196146358, 724.4928550015011, 724.5218156017004, 739.7928579997609, 495.30904388378013, 559.4098226371217, 655.3638707118836, 664.9268580456146, 679.7624304732028, 8778.780530486789, 8888.866667, 9109.544522773835, 9553.449662551977, 9692.660756873476, 571.074858728862, 610.5359926455925, 669.4410167510086, 680.3502654964497, 700.0458066957432, 3902.5316961964177, 4073.6944729145434, 4448.866534003985, 4626.560476754703, 4832.710037397767, 119943.0, 153572.0, 163061.0, 164041.0, 170882.0, 109543.45228273967, 121385.0, 125725.0, 128339.0, 146182.0, 71921.0, 72389.2761072393, 87024.12975870287, 104434.0, 104838.0, 9274.397164184307, 9772.31593788428, 9934.652287169914, 9980.60077596888, 10062.295639305179, 50084.49915500799, 51188.0, 63326.683366584715, 63901.36098638954, 65340.67329663321, 82044.0, 87422.68865966889, 95184.52407737917, 98002.0, 98163.0, 12566.193073956207, 12938.482460701467, 13228.14017088886, 13379.933100334436, 13965.511207107702, 14664.117832026695, 14927.626809329853, 14940.0, 15112.546623601309, 15240.314185861442, 13563.932180339036, 13879.79180312276, 14169.149851008973, 14458.0, 14587.703247497027, 13628.114172578751, 13646.795298070736, 13796.241206733726, 14252.717255446645, 14341.211233382264, 13339.733205336033, 13469.663258418617, 13590.0, 13671.084480774462, 14208.147511149364, 11161.88838111641, 11330.320180788849, 11373.374464404205, 11388.715282117682, 11688.590899318484, 7840.189558360859, 7956.986047249774, 8242.711505097293, 10136.645217417356, 11312.9434352831], "value": 7803.255990151944, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1624.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 109.0, 169.0, 171.0, 129.0, 119.0, 119.0, 120.0, 103.0, 168.0], "value": 131.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 115.0, 151.0, 118.0, 116.0, 118.0, 143.0, 158.0, 112.0], "value": 129.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 235.0, 195.0, 269.0, 272.0, 222.0, 195.0, 196.0, 195.0, 193.0], "value": 217.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 56.0, 59.0, 84.0, 58.0, 55.0, 55.0, 60.0, 79.0, 59.0], "value": 64.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 89.0, 78.0, 57.0, 69.0, 111.0, 97.0, 100.0, 116.0], "value": 87.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 122.0, 88.0, 97.0, 90.0, 83.0, 136.0, 129.0, 90.0, 86.0], "value": 105.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 95.0, 96.0, 95.0, 94.0, 95.0, 96.0, 103.0, 141.0], "value": 109.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 144.0, 149.0, 93.0, 90.0, 110.0, 150.0, 115.0, 91.0], "value": 112.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 55.0, 56.0, 57.0, 60.0, 81.0, 67.0, 57.0, 58.0], "value": 60.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 69.0, 71.0, 92.0, 97.0, 95.0, 68.0, 74.0, 100.0, 103.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 88.0, 90.0, 87.0, 88.0, 88.0, 92.0, 87.0, 86.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 144.0, 154.0, 191.0, 154.0, 154.0, 161.0, 156.0, 202.0, 166.0], "value": 162.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 228.0, 237.0, 178.0, 171.0, 173.0, 193.0, 235.0, 169.0, 230.0], "value": 199.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 88.0, 89.0, 69.0, 72.0, 71.0, 68.0, 70.0, 71.0, 71.0], "value": 73.4, "unit": "score"}]}]} 01:18:40 INFO - Return code: 0 01:18:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:18:40 ERROR - # TBPL SUCCESS # 01:18:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:18:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:18:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:18:40 INFO - 2016-10-06 01:18:40.924 screenresolution[1805:10526] starting screenresolution argv=screenresolution get 01:18:40 INFO - 2016-10-06 01:18:40.928 screenresolution[1805:10526] Display 0: 1600x1200x32@60 01:18:40 INFO - 2016-10-06 01:18:40.935 screenresolution[1806:10529] starting screenresolution argv=screenresolution list 01:18:40 INFO - Available Modes on Display 0 01:18:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:18:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:18:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:18:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:18:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:18:41 INFO - Intel Iris: 01:18:41 INFO - Chipset Model: Intel Iris 01:18:41 INFO - Type: GPU 01:18:41 INFO - Bus: Built-In 01:18:41 INFO - VRAM (Dynamic, Max): 1536 MB 01:18:41 INFO - Vendor: Intel (0x8086) 01:18:41 INFO - Device ID: 0x0a2e 01:18:41 INFO - Revision ID: 0x0009 01:18:41 INFO - Displays: 01:18:41 INFO - Display: 01:18:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:18:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:18:41 INFO - Display Serial Number: 1600x1200 60 01:18:41 INFO - Main Display: Yes 01:18:41 INFO - Mirror: Off 01:18:41 INFO - Online: Yes 01:18:41 INFO - Rotation: Supported 01:18:41 INFO - Return code: 0 01:18:41 INFO - Running post-action listener: _resource_record_post_action 01:18:41 INFO - [mozharness: 2016-10-06 08:18:41.177537Z] Finished run-tests step (success) 01:18:41 INFO - Running post-run listener: _resource_record_post_run 01:18:41 INFO - Total resource usage - Wall time: 1212s; CPU: 55.0%; Read bytes: 38046208; Write bytes: 709764096; Read time: 239; Write time: 2051 01:18:41 INFO - TinderboxPrint: CPU usage
54.9% 01:18:41 INFO - TinderboxPrint: I/O read bytes / time
38,046,208 / 239 01:18:41 INFO - TinderboxPrint: I/O write bytes / time
709,764,096 / 2,051 01:18:41 INFO - TinderboxPrint: CPU idle
2,188.6 (45.1%) 01:18:41 INFO - TinderboxPrint: CPU system
988.8 (20.4%) 01:18:41 INFO - TinderboxPrint: CPU user
1,672.1 (34.5%) 01:18:41 INFO - TinderboxPrint: Swap in / out
446,238,720 / 0 01:18:41 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 398080512; Write bytes: 391366144; Read time: 29963; Write time: 787 01:18:41 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 36051456; Write bytes: 299449856; Read time: 222; Write time: 1214 01:18:41 INFO - Running post-run listener: _upload_blobber_files 01:18:41 INFO - Blob upload gear active. 01:18:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:18:41 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 01:18:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:18:42 INFO - (blobuploader) - INFO - Open directory for files ... 01:18:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:18:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:18:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:18:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:18:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:18:43 INFO - (blobuploader) - INFO - Done attempting. 01:18:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:18:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:18:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:18:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:18:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:18:44 INFO - (blobuploader) - INFO - Done attempting. 01:18:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:18:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:18:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:18:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:18:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:18:46 INFO - (blobuploader) - INFO - Done attempting. 01:18:46 INFO - (blobuploader) - INFO - Iteration through files over. 01:18:46 INFO - Return code: 0 01:18:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:18:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:18:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cde917d939faf8cebb4c4c10b9328fd12e30d6f71cff4e0130b3dc8a5762a8f969ceadcce6bb2e1ec0c1c288190c9bdb1f612fb84872f08b515f8f099d363ebd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67ad8f3eb98bb92dd40719a6c7dc2d37141beeed41f911ae5226ac50e7cd0d4a39f84dd5468615a3d27cdd49cec0e64bf2caf39db477601d835115ed1c51bf63", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ecdf542f60a29ce136cae9e3b1e0180716c61d6f79c412776894da8b26fd69a9f0aac38e9c9a143297705ed4c48122a783572e795db00391241af9c440d4ec8"} 01:18:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:18:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:18:46 INFO - Contents: 01:18:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cde917d939faf8cebb4c4c10b9328fd12e30d6f71cff4e0130b3dc8a5762a8f969ceadcce6bb2e1ec0c1c288190c9bdb1f612fb84872f08b515f8f099d363ebd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67ad8f3eb98bb92dd40719a6c7dc2d37141beeed41f911ae5226ac50e7cd0d4a39f84dd5468615a3d27cdd49cec0e64bf2caf39db477601d835115ed1c51bf63", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ecdf542f60a29ce136cae9e3b1e0180716c61d6f79c412776894da8b26fd69a9f0aac38e9c9a143297705ed4c48122a783572e795db00391241af9c440d4ec8"} 01:18:46 INFO - Running post-run listener: copy_logs_to_upload_dir 01:18:46 INFO - Copying logs to upload dir... 01:18:46 INFO - mkdir: /builds/slave/test/build/upload/logs 01:18:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.572643 ========= master_lag: 0.36 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-06 01:18:46.906929) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 01:18:46.910210) ========= 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.3hAMk3tHFo/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.6McOJX3LvQ/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cde917d939faf8cebb4c4c10b9328fd12e30d6f71cff4e0130b3dc8a5762a8f969ceadcce6bb2e1ec0c1c288190c9bdb1f612fb84872f08b515f8f099d363ebd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67ad8f3eb98bb92dd40719a6c7dc2d37141beeed41f911ae5226ac50e7cd0d4a39f84dd5468615a3d27cdd49cec0e64bf2caf39db477601d835115ed1c51bf63", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ecdf542f60a29ce136cae9e3b1e0180716c61d6f79c412776894da8b26fd69a9f0aac38e9c9a143297705ed4c48122a783572e795db00391241af9c440d4ec8"} build_url:https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010764 build_url: 'https://queue.taskcluster.net/v1/task/M0pX_PoKRGmY2m08slRJRA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cde917d939faf8cebb4c4c10b9328fd12e30d6f71cff4e0130b3dc8a5762a8f969ceadcce6bb2e1ec0c1c288190c9bdb1f612fb84872f08b515f8f099d363ebd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67ad8f3eb98bb92dd40719a6c7dc2d37141beeed41f911ae5226ac50e7cd0d4a39f84dd5468615a3d27cdd49cec0e64bf2caf39db477601d835115ed1c51bf63", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8ecdf542f60a29ce136cae9e3b1e0180716c61d6f79c412776894da8b26fd69a9f0aac38e9c9a143297705ed4c48122a783572e795db00391241af9c440d4ec8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 01:18:46.942468) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 01:18:46.942816) ========= 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.3hAMk3tHFo/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.6McOJX3LvQ/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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.005249 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 01:18:46.993738) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 01:18:46.994415) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 01:18:46.995182) ========= ========= Total master_lag: 1.75 =========