builder: cedar_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0262 starttime: 1480347222.07 results: success (0) buildid: 20161128052557 builduid: 7ef926ccd316431ab3f36776e0d684e7 revision: e411a5414a9d2685574dd5cd5b7843e629cf21b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 07:33:42.071435) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 07:33:42.071875) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 07:33:42.072158) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 07:33:42.209812) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 07:33:42.210179) ========= 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.T333ZICk3z/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.t9rhY8mzee/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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-11-28 07:33:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.3M=0.001s 2016-11-28 07:33:43 (20.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.803193 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 07:33:43.041877) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 07:33:43.042188) ========= 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.T333ZICk3z/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.t9rhY8mzee/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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.020573 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 07:33:43.094822) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-28 07:33:43.095140) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev e411a5414a9d2685574dd5cd5b7843e629cf21b8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev e411a5414a9d2685574dd5cd5b7843e629cf21b8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.T333ZICk3z/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.t9rhY8mzee/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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-11-28 07:33:43,181 truncating revision to first 12 chars 2016-11-28 07:33:43,181 Setting DEBUG logging. 2016-11-28 07:33:43,181 attempt 1/10 2016-11-28 07:33:43,182 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/e411a5414a9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-28 07:33:43,961 unpacking tar archive at: cedar-e411a5414a9d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.029761 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-28 07:33:44.152055) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 07:33:44.155391) ========= script_repo_revision: e411a5414a9d2685574dd5cd5b7843e629cf21b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 07:33:44.155778) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 07:33:44.156060) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 07:33:44.177374) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-11-28 07:33:44.177662) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Cedar', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.T333ZICk3z/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.t9rhY8mzee/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 07:33:44 INFO - MultiFileLogger online at 20161128 07:33:44 in /builds/slave/test 07:33:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 07:33:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:33:44 INFO - {'append_to_log': False, 07:33:44 INFO - 'base_work_dir': '/builds/slave/test', 07:33:44 INFO - 'blob_upload_branch': 'Cedar', 07:33:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:33:44 INFO - 'branch': 'Cedar', 07:33:44 INFO - 'buildbot_json_path': 'buildprops.json', 07:33:44 INFO - 'config_files': ('talos/mac_config.py',), 07:33:44 INFO - 'default_actions': ('clobber', 07:33:44 INFO - 'read-buildbot-config', 07:33:44 INFO - 'download-and-extract', 07:33:44 INFO - 'populate-webroot', 07:33:44 INFO - 'create-virtualenv', 07:33:44 INFO - 'install', 07:33:44 INFO - 'run-tests'), 07:33:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:33:44 INFO - 'download_minidump_stackwalk': True, 07:33:44 INFO - 'download_symbols': 'ondemand', 07:33:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:33:44 INFO - 'tooltool.py': '/tools/tooltool.py', 07:33:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:33:44 INFO - '/tools/misc-python/virtualenv.py')}, 07:33:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:33:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:33:44 INFO - 'installer_path': 'installer.exe', 07:33:44 INFO - 'log_level': 'info', 07:33:44 INFO - 'log_name': 'talos', 07:33:44 INFO - 'log_to_console': True, 07:33:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:33:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:33:44 INFO - 'opt_config_files': (), 07:33:44 INFO - 'pip_index': False, 07:33:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:33:44 INFO - 'cmd': ('bash', 07:33:44 INFO - '-c', 07:33:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:33:44 INFO - 'enabled': True, 07:33:44 INFO - 'halt_on_failure': False, 07:33:44 INFO - 'name': 'check_screen_resolution'},), 07:33:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:33:44 INFO - 'cmd': ('bash', 07:33:44 INFO - '-c', 07:33:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:33:44 INFO - 'enabled': True, 07:33:44 INFO - 'halt_on_failure': False, 07:33:44 INFO - 'name': 'check_screen_resolution'},), 07:33:44 INFO - 'run_cmd_checks_enabled': True, 07:33:44 INFO - 'sps_profile': False, 07:33:44 INFO - 'sps_profile_interval': 0, 07:33:44 INFO - 'suite': 'dromaeojs', 07:33:44 INFO - 'system_bits': '32', 07:33:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:33:44 INFO - 'title': 't-yosemite-r7-0262', 07:33:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:33:44 INFO - 'use_talos_json': True, 07:33:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:33:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:33:44 INFO - 'work_dir': 'build'} 07:33:44 INFO - [mozharness: 2016-11-28 15:33:44.379785Z] Running clobber step. 07:33:44 INFO - Running pre-action listener: _resource_record_pre_action 07:33:44 INFO - Running main action method: clobber 07:33:44 INFO - rmtree: /builds/slave/test/build 07:33:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:33:46 INFO - Running post-action listener: _resource_record_post_action 07:33:46 INFO - [mozharness: 2016-11-28 15:33:46.078033Z] Finished clobber step (success) 07:33:46 INFO - [mozharness: 2016-11-28 15:33:46.078165Z] Running read-buildbot-config step. 07:33:46 INFO - Running pre-action listener: _resource_record_pre_action 07:33:46 INFO - Running main action method: read_buildbot_config 07:33:46 INFO - Using buildbot properties: 07:33:46 INFO - { 07:33:46 INFO - "project": "", 07:33:46 INFO - "product": "firefox", 07:33:46 INFO - "script_repo_revision": "default", 07:33:46 INFO - "builddir": "cedar_yosemite_r7_test-dromaeojs", 07:33:46 INFO - "repository": "", 07:33:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 cedar talos dromaeojs", 07:33:46 INFO - "buildid": "20161128052557", 07:33:46 INFO - "pgo_build": "False", 07:33:46 INFO - "basedir": "/builds/slave/test", 07:33:46 INFO - "buildnumber": 0, 07:33:46 INFO - "slavename": "t-yosemite-r7-0262", 07:33:46 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 07:33:46 INFO - "platform": "yosemite_r7", 07:33:46 INFO - "scheduler": "tests-cedar-macosx64-talos", 07:33:46 INFO - "branch": "cedar", 07:33:46 INFO - "repo_path": "projects/cedar", 07:33:46 INFO - "revision": "e411a5414a9d2685574dd5cd5b7843e629cf21b8", 07:33:46 INFO - "stage_platform": "macosx64", 07:33:46 INFO - "builduid": "7ef926ccd316431ab3f36776e0d684e7", 07:33:46 INFO - "slavebuilddir": "test" 07:33:46 INFO - } 07:33:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 07:33:46 INFO - Running post-action listener: _resource_record_post_action 07:33:46 INFO - [mozharness: 2016-11-28 15:33:46.081681Z] Finished read-buildbot-config step (success) 07:33:46 INFO - [mozharness: 2016-11-28 15:33:46.081813Z] Running download-and-extract step. 07:33:46 INFO - Running pre-action listener: _resource_record_pre_action 07:33:46 INFO - Running main action method: download_and_extract 07:33:46 INFO - mkdir: /builds/slave/test/build/tests 07:33:46 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')]} 07:33:46 INFO - trying https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 07:33:46 INFO - Downloading https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:33:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 07:33:47 INFO - Downloaded 1199 bytes. 07:33:47 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:33:47 INFO - Using the following test package requirements: 07:33:47 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:33:47 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:33:47 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 07:33:47 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:33:47 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 07:33:47 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:33:47 INFO - u'jsshell-mac.zip'], 07:33:47 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:33:47 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 07:33:47 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:33:47 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:33:47 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 07:33:47 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:33:47 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 07:33:47 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:33:47 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 07:33:47 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:33:47 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 07:33:47 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:33:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:33:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:33:47 INFO - Fetch https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:33:48 INFO - Http code: 200 07:33:48 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 07:33:48 INFO - x-amz-cf-id: Kt0yS7CYYZwztWhCx5_-QcmjJJ81CyjNJ7mCKLF4V837H8mQZhXlTA== 07:33:48 INFO - x-amz-version-id: V9lLLDGtT8VLm2ysKj9cZnhZrap0UTkW 07:33:48 INFO - Expected file size: 16282614 07:33:48 INFO - Obtained file size: 16282614 07:33:55 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:33:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:33:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:33:55 INFO - Fetch https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:33:55 INFO - Http code: 200 07:33:55 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 07:33:55 INFO - x-amz-cf-id: gO33DJjJSiwbhJ6_24qtdYPO0gJtwScC1eUoDnwd2eGojyBPuwoEAw== 07:33:55 INFO - x-amz-version-id: V9lLLDGtT8VLm2ysKj9cZnhZrap0UTkW 07:33:56 INFO - Expected file size: 16282614 07:33:56 INFO - Obtained file size: 16282614 07:34:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 07:34:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:34:02 INFO - Fetch https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 07:34:02 INFO - Http code: 200 07:34:02 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 07:34:02 INFO - x-amz-cf-id: zA_Qpx6LGsPIZEYRh0kEnNhDR5Ro9UEfAb-YrkqMUkcjaLFl8LSqow== 07:34:02 INFO - x-amz-version-id: ollRQNT8AWRJQmvu1X7CQtWlJ8h_yb0h 07:34:03 INFO - Expected file size: 14409702 07:34:03 INFO - Obtained file size: 14409702 07:34:03 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')]} 07:34:03 INFO - trying https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:34:03 INFO - Downloading https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 07:34:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 07:34:09 INFO - Downloaded 107602275 bytes. 07:34:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:34:09 INFO - mkdir: /builds/slave/test/properties 07:34:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:34:09 INFO - Writing to file /builds/slave/test/properties/build_url 07:34:09 INFO - Contents: 07:34:09 INFO - build_url:https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:34:10 INFO - Running post-action listener: _resource_record_post_action 07:34:10 INFO - Running post-action listener: set_extra_try_arguments 07:34:10 INFO - [mozharness: 2016-11-28 15:34:10.176894Z] Finished download-and-extract step (success) 07:34:10 INFO - [mozharness: 2016-11-28 15:34:10.177040Z] Running populate-webroot step. 07:34:10 INFO - Running pre-action listener: _resource_record_pre_action 07:34:10 INFO - Running main action method: populate_webroot 07:34:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:34:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:34:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:34:10 INFO - '--tppagecycles', 07:34:10 INFO - '7'], 07:34:10 INFO - 'tests': ['tsvgm']}}, 07:34:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:34:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:34:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:34:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:34:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:34:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:34:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:34:10 INFO - 'talos_options': ['--disable-e10s'], 07:34:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:34:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:34:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:34:10 INFO - 'talos_options': ['--disable-e10s'], 07:34:10 INFO - 'tests': ['damp', 'tps']}, 07:34:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:34:10 INFO - 'tests': ['damp', 'tps']}, 07:34:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:34:10 INFO - 'tests': ['dromaeo_dom']}, 07:34:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:34:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:34:10 INFO - 'tests': ['basic_compositor_video']}, 07:34:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:34:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:34:10 INFO - 'tests': ['a11yr', 07:34:10 INFO - 'ts_paint', 07:34:10 INFO - 'tpaint', 07:34:10 INFO - 'sessionrestore', 07:34:10 INFO - 'sessionrestore_no_auto_restore', 07:34:10 INFO - 'tabpaint']}, 07:34:10 INFO - 'other-e10s': {'tests': ['a11yr', 07:34:10 INFO - 'ts_paint', 07:34:10 INFO - 'tpaint', 07:34:10 INFO - 'sessionrestore', 07:34:10 INFO - 'sessionrestore_no_auto_restore', 07:34:10 INFO - 'tabpaint']}, 07:34:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:34:10 INFO - 'ts_paint', 07:34:10 INFO - 'tpaint', 07:34:10 INFO - 'sessionrestore', 07:34:10 INFO - 'sessionrestore_no_auto_restore', 07:34:10 INFO - 'tabpaint']}, 07:34:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:34:10 INFO - 'ts_paint', 07:34:10 INFO - 'tpaint', 07:34:10 INFO - 'sessionrestore', 07:34:10 INFO - 'sessionrestore_no_auto_restore', 07:34:10 INFO - 'tabpaint']}, 07:34:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:34:10 INFO - 'tests': ['a11yr', 07:34:10 INFO - 'ts_paint', 07:34:10 INFO - 'tpaint', 07:34:10 INFO - 'sessionrestore', 07:34:10 INFO - 'sessionrestore_no_auto_restore', 07:34:10 INFO - 'tabpaint']}, 07:34:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:34:10 INFO - 'tests': ['a11yr', 07:34:10 INFO - 'ts_paint', 07:34:10 INFO - 'tpaint', 07:34:10 INFO - 'sessionrestore', 07:34:10 INFO - 'sessionrestore_no_auto_restore', 07:34:10 INFO - 'tabpaint']}, 07:34:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:34:10 INFO - 'tests': ['tsvgx', 07:34:10 INFO - 'tsvgr_opacity', 07:34:10 INFO - 'tart', 07:34:10 INFO - 'tscrollx', 07:34:10 INFO - 'cart', 07:34:10 INFO - 'tsvg_static']}, 07:34:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:34:10 INFO - 'tsvgr_opacity', 07:34:10 INFO - 'tart', 07:34:10 INFO - 'tscrollx', 07:34:10 INFO - 'cart', 07:34:10 INFO - 'tsvg_static']}, 07:34:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:34:10 INFO - 'talos_options': ['--disable-e10s'], 07:34:10 INFO - 'tests': ['tp5o']}, 07:34:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:34:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:34:10 INFO - 'talos_options': ['--disable-e10s', 07:34:10 INFO - '--xperf_path', 07:34:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:10 INFO - 'tests': ['tp5n']}, 07:34:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:34:10 INFO - 'talos_options': ['--xperf_path', 07:34:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:34:10 INFO - 'tests': ['tp5n']}}, 07:34:10 INFO - 'talos.zip': {'path': '', 07:34:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:34:10 INFO - Running post-action listener: _resource_record_post_action 07:34:10 INFO - [mozharness: 2016-11-28 15:34:10.195412Z] Finished populate-webroot step (success) 07:34:10 INFO - [mozharness: 2016-11-28 15:34:10.195543Z] Running create-virtualenv step. 07:34:10 INFO - Running pre-action listener: _resource_record_pre_action 07:34:10 INFO - Running main action method: create_virtualenv 07:34:10 INFO - Creating virtualenv /builds/slave/test/build/venv 07:34:10 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 07:34:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:34:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:34:10 INFO - Using real prefix '/tools/python27' 07:34:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:34:11 INFO - Installing distribute.............................................................................................................................................................................................done. 07:34:13 INFO - Installing pip.................done. 07:34:13 INFO - Return code: 0 07:34:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:34:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:34:14 INFO - Reading from file tmpfile_stdout 07:34:14 INFO - Output received: 07:34:14 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) 07:34:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:34:14 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')]} 07:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:14 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')]} 07:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:14 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 0x1080c63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10803c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9b94ad4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107edcd30>, '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 0x107d43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4b20>, '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.T333ZICk3z/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.t9rhY8mzee/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 07:34:14 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 07:34:14 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 07:34:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T333ZICk3z/Render', 07:34:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:14 INFO - 'HOME': '/Users/cltbld', 07:34:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:14 INFO - 'LOGNAME': 'cltbld', 07:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:14 INFO - 'MOZ_NO_REMOTE': '1', 07:34:14 INFO - 'NO_EM_RESTART': '1', 07:34:14 INFO - 'PAGER': '/bin/cat', 07:34:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:14 INFO - 'PWD': '/builds/slave/test', 07:34:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:14 INFO - 'SHELL': '/bin/bash', 07:34:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9rhY8mzee/Listeners', 07:34:14 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 07:34:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:14 INFO - 'USER': 'cltbld', 07:34:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:14 INFO - 'XPC_FLAGS': '0x0', 07:34:14 INFO - 'XPC_SERVICE_NAME': '0', 07:34:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:14 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 07:34:14 INFO - Cleaning up... 07:34:14 INFO - Return code: 0 07:34:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:34:14 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')]} 07:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:14 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')]} 07:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:14 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 0x1080c63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10803c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9b94ad4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107edcd30>, '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 0x107d43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4b20>, '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.T333ZICk3z/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.t9rhY8mzee/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 07:34:14 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 07:34:14 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 07:34:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T333ZICk3z/Render', 07:34:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:14 INFO - 'HOME': '/Users/cltbld', 07:34:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:14 INFO - 'LOGNAME': 'cltbld', 07:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:14 INFO - 'MOZ_NO_REMOTE': '1', 07:34:14 INFO - 'NO_EM_RESTART': '1', 07:34:14 INFO - 'PAGER': '/bin/cat', 07:34:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:14 INFO - 'PWD': '/builds/slave/test', 07:34:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:14 INFO - 'SHELL': '/bin/bash', 07:34:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9rhY8mzee/Listeners', 07:34:14 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 07:34:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:14 INFO - 'USER': 'cltbld', 07:34:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:14 INFO - 'XPC_FLAGS': '0x0', 07:34:14 INFO - 'XPC_SERVICE_NAME': '0', 07:34:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:14 INFO - Downloading/unpacking psutil>=3.1.1 07:34: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 07:34: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 07:34: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 07:34: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 07:34: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 07:34: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 07:34:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:34:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:18 INFO - Installing collected packages: psutil 07:34:18 INFO - Running setup.py install for psutil 07:34:18 INFO - building 'psutil._psutil_osx' extension 07:34:18 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 07:34:18 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 07:34:18 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 07:34:19 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 07:34:19 INFO - building 'psutil._psutil_posix' extension 07:34:19 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 07:34:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:34:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:34:19 INFO - ^ 07:34:19 INFO - 1 warning generated. 07:34:19 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 07:34:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:34:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:34:19 INFO - Successfully installed psutil 07:34:19 INFO - Cleaning up... 07:34:19 INFO - Return code: 0 07:34:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:19 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 0x1080c63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10803c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9b94ad4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107edcd30>, '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 0x107d43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4b20>, '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.T333ZICk3z/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.t9rhY8mzee/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 07:34:19 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 07:34:19 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 07:34:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T333ZICk3z/Render', 07:34:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:19 INFO - 'HOME': '/Users/cltbld', 07:34:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:19 INFO - 'LOGNAME': 'cltbld', 07:34:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:19 INFO - 'MOZ_NO_REMOTE': '1', 07:34:19 INFO - 'NO_EM_RESTART': '1', 07:34:19 INFO - 'PAGER': '/bin/cat', 07:34:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:19 INFO - 'PWD': '/builds/slave/test', 07:34:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:19 INFO - 'SHELL': '/bin/bash', 07:34:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9rhY8mzee/Listeners', 07:34:19 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 07:34:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:19 INFO - 'USER': 'cltbld', 07:34:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:19 INFO - 'XPC_FLAGS': '0x0', 07:34:19 INFO - 'XPC_SERVICE_NAME': '0', 07:34:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:34:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:34:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:34:22 INFO - Installing collected packages: mozsystemmonitor 07:34:22 INFO - Running setup.py install for mozsystemmonitor 07:34:22 INFO - Successfully installed mozsystemmonitor 07:34:22 INFO - Cleaning up... 07:34:22 INFO - Return code: 0 07:34:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1080c63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10803c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9b94ad4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107edcd30>, '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 0x107d43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4b20>, '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.T333ZICk3z/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.t9rhY8mzee/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 07:34:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:34:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:34:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T333ZICk3z/Render', 07:34:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:22 INFO - 'HOME': '/Users/cltbld', 07:34:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:22 INFO - 'LOGNAME': 'cltbld', 07:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:22 INFO - 'MOZ_NO_REMOTE': '1', 07:34:22 INFO - 'NO_EM_RESTART': '1', 07:34:22 INFO - 'PAGER': '/bin/cat', 07:34:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:22 INFO - 'PWD': '/builds/slave/test', 07:34:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:22 INFO - 'SHELL': '/bin/bash', 07:34:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9rhY8mzee/Listeners', 07:34:22 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 07:34:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:22 INFO - 'USER': 'cltbld', 07:34:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:22 INFO - 'XPC_FLAGS': '0x0', 07:34:22 INFO - 'XPC_SERVICE_NAME': '0', 07:34:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:22 INFO - Downloading/unpacking jsonschema==2.5.1 07:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:34:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:25 INFO - Downloading functools32-3.2.3-2.tar.gz 07:34:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:34:25 INFO - warning: no files found matching '*.txt' 07:34:25 INFO - no previously-included directories found matching 'build' 07:34:25 INFO - no previously-included directories found matching 'dist' 07:34:25 INFO - no previously-included directories found matching '.git*' 07:34:25 INFO - Installing collected packages: jsonschema, functools32 07:34:25 INFO - Running setup.py install for functools32 07:34:25 INFO - warning: no files found matching '*.txt' 07:34:25 INFO - no previously-included directories found matching 'build' 07:34:25 INFO - no previously-included directories found matching 'dist' 07:34:25 INFO - no previously-included directories found matching '.git*' 07:34:26 INFO - Successfully installed jsonschema functools32 07:34:26 INFO - Cleaning up... 07:34:26 INFO - Return code: 0 07:34:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:34: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')]} 07:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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')]} 07:34:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:26 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 0x1080c63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10803c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9b94ad4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107edcd30>, '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 0x107d43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4b20>, '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.T333ZICk3z/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.t9rhY8mzee/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 07:34:26 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 07:34:26 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 07:34:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T333ZICk3z/Render', 07:34:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:26 INFO - 'HOME': '/Users/cltbld', 07:34:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:26 INFO - 'LOGNAME': 'cltbld', 07:34:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:26 INFO - 'MOZ_NO_REMOTE': '1', 07:34:26 INFO - 'NO_EM_RESTART': '1', 07:34:26 INFO - 'PAGER': '/bin/cat', 07:34:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:26 INFO - 'PWD': '/builds/slave/test', 07:34:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:26 INFO - 'SHELL': '/bin/bash', 07:34:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9rhY8mzee/Listeners', 07:34:26 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 07:34:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:26 INFO - 'USER': 'cltbld', 07:34:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:26 INFO - 'XPC_FLAGS': '0x0', 07:34:26 INFO - 'XPC_SERVICE_NAME': '0', 07:34:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:34:26 INFO - Cleaning up... 07:34:26 INFO - Return code: 0 07:34:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:34: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')]} 07:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34: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')]} 07:34:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:26 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 0x1080c63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10803c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9b94ad4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107edcd30>, '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 0x107d43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4b20>, '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.T333ZICk3z/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.t9rhY8mzee/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 07:34:26 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 07:34:26 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 07:34:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T333ZICk3z/Render', 07:34:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:26 INFO - 'HOME': '/Users/cltbld', 07:34:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:26 INFO - 'LOGNAME': 'cltbld', 07:34:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:26 INFO - 'MOZ_NO_REMOTE': '1', 07:34:26 INFO - 'NO_EM_RESTART': '1', 07:34:26 INFO - 'PAGER': '/bin/cat', 07:34:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:26 INFO - 'PWD': '/builds/slave/test', 07:34:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:26 INFO - 'SHELL': '/bin/bash', 07:34:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9rhY8mzee/Listeners', 07:34:26 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 07:34:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:26 INFO - 'USER': 'cltbld', 07:34:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:26 INFO - 'XPC_FLAGS': '0x0', 07:34:26 INFO - 'XPC_SERVICE_NAME': '0', 07:34:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:26 INFO - Downloading/unpacking blobuploader==1.2.4 07:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:29 INFO - Downloading blobuploader-1.2.4.tar.gz 07:34:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:34:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:34:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:34:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:34:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:34:30 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 07:34:30 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 07:34:30 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 07:34:30 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 07:34:30 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 07:34:30 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 07:34:30 INFO - Downloading docopt-0.6.1.tar.gz 07:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:34:30 INFO - Installing collected packages: blobuploader, requests, docopt 07:34:30 INFO - Running setup.py install for blobuploader 07:34:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:34:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:34:30 INFO - Running setup.py install for requests 07:34:31 INFO - Running setup.py install for docopt 07:34:31 INFO - Successfully installed blobuploader requests docopt 07:34:31 INFO - Cleaning up... 07:34:31 INFO - Return code: 0 07:34:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:31 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')]} 07:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:31 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')]} 07:34:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:31 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 0x1080c63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10803c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9b94ad4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107edcd30>, '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 0x107d43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4b20>, '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.T333ZICk3z/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.t9rhY8mzee/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 07:34:31 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 07:34:31 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 07:34:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T333ZICk3z/Render', 07:34:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:31 INFO - 'HOME': '/Users/cltbld', 07:34:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:31 INFO - 'LOGNAME': 'cltbld', 07:34:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:31 INFO - 'MOZ_NO_REMOTE': '1', 07:34:31 INFO - 'NO_EM_RESTART': '1', 07:34:31 INFO - 'PAGER': '/bin/cat', 07:34:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:31 INFO - 'PWD': '/builds/slave/test', 07:34:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:31 INFO - 'SHELL': '/bin/bash', 07:34:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9rhY8mzee/Listeners', 07:34:31 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 07:34:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:31 INFO - 'USER': 'cltbld', 07:34:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:31 INFO - 'XPC_FLAGS': '0x0', 07:34:31 INFO - 'XPC_SERVICE_NAME': '0', 07:34:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-KIsYNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-txbRah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:31 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-Trkttx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:32 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-SqOHC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:32 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-mdKEXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:32 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-jQM8pQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:32 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-UALaDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:32 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-6mTQHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:32 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-xcKLvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:32 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-OmifTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:32 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-VkHRxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:32 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-tKURZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:33 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-_U8e2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:33 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-L8mw0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:33 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-cqcFZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:33 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-ioyD2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:33 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-BMum6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:34:33 INFO - Running setup.py install for manifestparser 07:34:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:34:33 INFO - Running setup.py install for mozcrash 07:34:33 INFO - Running setup.py install for mozdebug 07:34:33 INFO - Running setup.py install for mozdevice 07:34:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:34:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:34:34 INFO - Running setup.py install for mozfile 07:34:34 INFO - Running setup.py install for mozhttpd 07:34:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:34:34 INFO - Running setup.py install for mozinfo 07:34:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:34:34 INFO - Running setup.py install for mozInstall 07:34:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:34:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:34:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:34:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:34:34 INFO - Running setup.py install for mozleak 07:34:34 INFO - Running setup.py install for mozlog 07:34:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:34:35 INFO - Running setup.py install for moznetwork 07:34:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:34:35 INFO - Running setup.py install for mozprocess 07:34:35 INFO - Running setup.py install for mozprofile 07:34:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:34:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:34:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:34:35 INFO - Running setup.py install for mozrunner 07:34:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:34:35 INFO - Running setup.py install for mozscreenshot 07:34:35 INFO - Running setup.py install for moztest 07:34:35 INFO - Running setup.py install for mozversion 07:34:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:34:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:34:36 INFO - Cleaning up... 07:34:36 INFO - Return code: 0 07:34:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:34:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:36 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 0x1080c63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10803c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9b94ad4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107edcd30>, '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 0x107d43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4b20>, '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.T333ZICk3z/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.t9rhY8mzee/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 07:34:36 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 07:34:36 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 07:34:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T333ZICk3z/Render', 07:34:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:36 INFO - 'HOME': '/Users/cltbld', 07:34:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:36 INFO - 'LOGNAME': 'cltbld', 07:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:36 INFO - 'MOZ_NO_REMOTE': '1', 07:34:36 INFO - 'NO_EM_RESTART': '1', 07:34:36 INFO - 'PAGER': '/bin/cat', 07:34:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:36 INFO - 'PWD': '/builds/slave/test', 07:34:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:36 INFO - 'SHELL': '/bin/bash', 07:34:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9rhY8mzee/Listeners', 07:34:36 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 07:34:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:36 INFO - 'USER': 'cltbld', 07:34:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:36 INFO - 'XPC_FLAGS': '0x0', 07:34:36 INFO - 'XPC_SERVICE_NAME': '0', 07:34:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:34:36 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-Lz8e5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:34:36 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)) 07:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:34:36 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-TsxeQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:34:36 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-8a63rY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:34:36 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)) 07:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:34:36 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-enblUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:34:36 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-jWpQCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:34:36 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)) 07:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:34:36 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-Ln0lke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:34:37 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)) 07:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:34:37 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-Si8GJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:34:37 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)) 07:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:34:37 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-knbtYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:34:37 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)) 07:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:34:37 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-xd4H5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:34:37 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)) 07:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:34:37 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-LUPcMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:34:37 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)) 07:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:34:37 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-Sy8Cog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:34:37 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)) 07:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:34:37 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-nOxb0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:34:37 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)) 07:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:34:37 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-dOlpv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:34:37 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)) 07:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:34:37 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-s3TT2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:34:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:34:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:37 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-T1IWzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:34:38 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)) 07:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:34:38 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-gBS0Zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:34:38 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)) 07:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:34:38 INFO - Running setup.py (path:/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/pip-omfbKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:34:38 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)) 07:34:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:34:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:34:38 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)) 07:34:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:34:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:34:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:34:38 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 07:34:38 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 07:34:38 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 07:34:38 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 07:34:38 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 07:34:38 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 07:34:40 INFO - Downloading blessings-1.6.tar.gz 07:34:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:34:40 INFO - Installing collected packages: blessings 07:34:40 INFO - Running setup.py install for blessings 07:34:41 INFO - Successfully installed blessings 07:34:41 INFO - Cleaning up... 07:34:41 INFO - Return code: 0 07:34:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:34:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:34:41 INFO - Reading from file tmpfile_stdout 07:34:41 INFO - Current package versions: 07:34:41 INFO - blessings == 1.6 07:34:41 INFO - blobuploader == 1.2.4 07:34:41 INFO - docopt == 0.6.1 07:34:41 INFO - functools32 == 3.2.3-2 07:34:41 INFO - jsonschema == 2.5.1 07:34:41 INFO - manifestparser == 1.1 07:34:41 INFO - mozInstall == 1.12 07:34:41 INFO - mozcrash == 1.0 07:34:41 INFO - mozdebug == 0.1 07:34:41 INFO - mozdevice == 0.49 07:34:41 INFO - mozfile == 1.2 07:34:41 INFO - mozhttpd == 0.7 07:34:41 INFO - mozinfo == 0.9 07:34:41 INFO - mozleak == 0.1 07:34:41 INFO - mozlog == 3.4 07:34:41 INFO - moznetwork == 0.27 07:34:41 INFO - mozprocess == 0.23 07:34:41 INFO - mozprofile == 0.28 07:34:41 INFO - mozrunner == 6.13 07:34:41 INFO - mozscreenshot == 0.1 07:34:41 INFO - mozsystemmonitor == 0.3 07:34:41 INFO - moztest == 0.7 07:34:41 INFO - mozversion == 1.4 07:34:41 INFO - psutil == 3.1.1 07:34:41 INFO - requests == 1.2.3 07:34:41 INFO - wsgiref == 0.1.2 07:34:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:34:41 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')]} 07:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:41 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')]} 07:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:41 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 0x1080c63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10803c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9b94ad4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107edcd30>, '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 0x107d43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4b20>, '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.T333ZICk3z/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.t9rhY8mzee/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 07:34:41 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 07:34:41 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 07:34:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T333ZICk3z/Render', 07:34:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:41 INFO - 'HOME': '/Users/cltbld', 07:34:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:41 INFO - 'LOGNAME': 'cltbld', 07:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:41 INFO - 'MOZ_NO_REMOTE': '1', 07:34:41 INFO - 'NO_EM_RESTART': '1', 07:34:41 INFO - 'PAGER': '/bin/cat', 07:34:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:41 INFO - 'PWD': '/builds/slave/test', 07:34:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:41 INFO - 'SHELL': '/bin/bash', 07:34:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9rhY8mzee/Listeners', 07:34:41 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 07:34:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:41 INFO - 'USER': 'cltbld', 07:34:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:41 INFO - 'XPC_FLAGS': '0x0', 07:34:41 INFO - 'XPC_SERVICE_NAME': '0', 07:34:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:41 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)) 07:34:41 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)) 07:34:41 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)) 07:34:41 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)) 07:34:41 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)) 07:34:41 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)) 07:34:41 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)) 07:34:41 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)) 07:34:41 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)) 07:34:41 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)) 07:34:41 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)) 07:34:41 INFO - Cleaning up... 07:34:41 INFO - Return code: 0 07:34:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:34:41 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')]} 07:34:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:34:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:41 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')]} 07:34:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:34:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:34:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1080c63f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10803c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9b94ad4a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107edcd30>, '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 0x107d43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4b20>, '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.T333ZICk3z/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.t9rhY8mzee/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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 07:34:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:34:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T333ZICk3z/Render', 07:34:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:34:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:34:41 INFO - 'HOME': '/Users/cltbld', 07:34:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:34:41 INFO - 'LOGNAME': 'cltbld', 07:34:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:34:41 INFO - 'MOZ_NO_REMOTE': '1', 07:34:41 INFO - 'NO_EM_RESTART': '1', 07:34:41 INFO - 'PAGER': '/bin/cat', 07:34:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:34:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:34:41 INFO - 'PWD': '/builds/slave/test', 07:34:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:34:41 INFO - 'SHELL': '/bin/bash', 07:34:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9rhY8mzee/Listeners', 07:34:41 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 07:34:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:34:41 INFO - 'USER': 'cltbld', 07:34:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:34:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:34:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:34:41 INFO - 'XPC_FLAGS': '0x0', 07:34:41 INFO - 'XPC_SERVICE_NAME': '0', 07:34:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:34:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:34:41 INFO - Cleaning up... 07:34:41 INFO - Return code: 0 07:34:41 INFO - Running post-action listener: _resource_record_post_action 07:34:41 INFO - Running post-action listener: _start_resource_monitoring 07:34:41 INFO - Starting resource monitoring. 07:34:41 INFO - [mozharness: 2016-11-28 15:34:41.973633Z] Finished create-virtualenv step (success) 07:34:41 INFO - [mozharness: 2016-11-28 15:34:41.974667Z] Running install step. 07:34:41 INFO - Running pre-action listener: _resource_record_pre_action 07:34:41 INFO - Running main action method: install 07:34:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:34:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:34:42 INFO - Reading from file tmpfile_stdout 07:34:42 INFO - Detecting whether we're running mozinstall >=1.0... 07:34:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:34:42 INFO - Reading from file tmpfile_stdout 07:34:42 INFO - Output received: 07:34:42 INFO - Usage: mozinstall [options] installer 07:34:42 INFO - Options: 07:34:42 INFO - -h, --help show this help message and exit 07:34:42 INFO - -d DEST, --destination=DEST 07:34:42 INFO - Directory to install application into. [default: 07:34:42 INFO - "/builds/slave/test"] 07:34:42 INFO - --app=APP Application being installed. [default: firefox] 07:34:42 INFO - mkdir: /builds/slave/test/build/application 07:34:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:35:15 INFO - Reading from file tmpfile_stdout 07:35:15 INFO - Output received: 07:35:15 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:35:15 INFO - Running post-action listener: _resource_record_post_action 07:35:15 INFO - [mozharness: 2016-11-28 15:35:15.035586Z] Finished install step (success) 07:35:15 INFO - [mozharness: 2016-11-28 15:35:15.035724Z] Running run-tests step. 07:35:15 INFO - Running pre-action listener: _resource_record_pre_action 07:35:15 INFO - Running main action method: run_tests 07:35:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:35:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:35:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:35:15 INFO - 2016-11-28 07:35:15.050 screenresolution[1924:17444] starting screenresolution argv=screenresolution get 07:35:15 INFO - 2016-11-28 07:35:15.053 screenresolution[1924:17444] Display 0: 1600x1200x32@60 07:35:15 INFO - 2016-11-28 07:35:15.058 screenresolution[1925:17446] starting screenresolution argv=screenresolution list 07:35:15 INFO - Available Modes on Display 0 07:35:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:35:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:35:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:35:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:35:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:35:15 INFO - Intel Iris: 07:35:15 INFO - Chipset Model: Intel Iris 07:35:15 INFO - Type: GPU 07:35:15 INFO - Bus: Built-In 07:35:15 INFO - VRAM (Dynamic, Max): 1536 MB 07:35:15 INFO - Vendor: Intel (0x8086) 07:35:15 INFO - Device ID: 0x0a2e 07:35:15 INFO - Revision ID: 0x0009 07:35:15 INFO - Displays: 07:35:15 INFO - Display: 07:35:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:35:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:35:15 INFO - Display Serial Number: 1600x1200 60 07:35:15 INFO - Main Display: Yes 07:35:15 INFO - Mirror: Off 07:35:15 INFO - Online: Yes 07:35:15 INFO - Rotation: Supported 07:35:15 INFO - Return code: 0 07:35:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:35:15 INFO - Python 2.7.3 07:35:15 INFO - Return code: 0 07:35:15 INFO - grabbing minidump binary from tooltool 07:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:15 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 0x107edcd30>, '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 0x107d43db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107ed4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:35:15 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 07:35:15 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 07:35:15 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 07:35:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:35:15 INFO - Return code: 0 07:35:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:35:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:35:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:35:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:35:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:35:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0262', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:35:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0262 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:35:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T333ZICk3z/Render', 07:35:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:35:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:35:15 INFO - 'HOME': '/Users/cltbld', 07:35:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:35:15 INFO - 'LOGNAME': 'cltbld', 07:35:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:35:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:35:15 INFO - 'MOZ_NO_REMOTE': '1', 07:35:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:35:15 INFO - 'NO_EM_RESTART': '1', 07:35:15 INFO - 'PAGER': '/bin/cat', 07:35:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:35:15 INFO - 'PWD': '/builds/slave/test', 07:35:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:35:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:35:15 INFO - 'SHELL': '/bin/bash', 07:35:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t9rhY8mzee/Listeners', 07:35:15 INFO - 'TMPDIR': '/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/', 07:35:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:35:15 INFO - 'USER': 'cltbld', 07:35:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:35:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:35:15 INFO - 'XPC_FLAGS': '0x0', 07:35:15 INFO - 'XPC_SERVICE_NAME': '0', 07:35:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:35:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0262', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:35:15 INFO - mozversion application_buildid: 20161128052557 07:35:15 INFO - mozversion application_changeset: e411a5414a9d2685574dd5cd5b7843e629cf21b8 07:35:15 INFO - mozversion application_display_name: Nightly 07:35:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:35:15 INFO - mozversion application_name: Firefox 07:35:15 INFO - mozversion application_remotingname: firefox 07:35:15 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 07:35:15 INFO - mozversion application_vendor: Mozilla 07:35:15 INFO - mozversion application_version: 53.0a1 07:35:15 INFO - mozversion platform_buildid: 20161128052557 07:35:15 INFO - mozversion platform_changeset: e411a5414a9d2685574dd5cd5b7843e629cf21b8 07:35:15 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 07:35:15 INFO - mozversion platform_version: 53.0a1 07:35:15 INFO - using testdate: 1480347315 07:35:15 INFO - actual date: 1480347315 07:35:15 INFO - starting webserver on 'localhost:52215' 07:35:15 INFO - SUITE-START | Running 2 tests 07:35:15 INFO - TEST-START | dromaeo_css 07:35:15 INFO - operating with platform_type : mac_ 07:35:15 INFO - Initialising browser for dromaeo_css test... 07:35:15 INFO - TEST-INFO | started process 1935 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmpio0apu/profile http://localhost:52215/getInfo.html) 07:35:18 INFO - PROCESS | 1935 | __metrics Screen width/height:1600/1200 07:35:18 INFO - PROCESS | 1935 | colorDepth:24 07:35:18 INFO - PROCESS | 1935 | Browser inner width/height: 1024/689 07:35:18 INFO - PROCESS | 1935 | __metrics 07:35:18 INFO - PROCESS | 1935 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:35:18 INFO - PROCESS | 1935 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:35:19 INFO - TEST-INFO | 1935: exit 0 07:35:19 INFO - Browser initialized. 07:35:19 INFO - Running cycle 1/1 for dromaeo_css test... 07:35:19 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmpio0apu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:31 INFO - PROCESS | 1937 | RSS: Main: 235741184 07:35:31 INFO - PROCESS | 1937 | 07:36:22 INFO - PROCESS | 1937 | 1480347382308 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] 07:38:36 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52215/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52215/tests/dromaeo/cssquery-ext.html) 07:38:38 INFO - PROCESS | 1937 | RSS: Main: 422440960 07:38:38 INFO - PROCESS | 1937 | 07:41:41 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52215/tests/dromaeo/cssquery-ext.html (next: http://localhost:52215/tests/dromaeo/cssquery-jquery.html) 07:41:41 INFO - PROCESS | 1937 | RSS: Main: 369340416 07:41:41 INFO - PROCESS | 1937 | 07:44:44 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52215/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52215/tests/dromaeo/cssquery-mootools.html) 07:44:44 INFO - PROCESS | 1937 | RSS: Main: 346267648 07:44:44 INFO - PROCESS | 1937 | 07:47:47 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52215/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52215/tests/dromaeo/cssquery-prototype.html) 07:47:48 INFO - PROCESS | 1937 | RSS: Main: 357085184 07:47:48 INFO - PROCESS | 1937 | 07:50:51 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52215/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52215/tests/dromaeo/cssquery-yui.html) 07:50:52 INFO - PROCESS | 1937 | RSS: Main: 336707584 07:50:52 INFO - PROCESS | 1937 | 07:53:55 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52215/tests/dromaeo/cssquery-yui.html (next: http://localhost:52215/tests/dromaeo/cssquery-dojo.html) 07:53:55 INFO - PROCESS | 1937 | RSS: Main: 455004160 07:53:55 INFO - PROCESS | 1937 | 07:53:55 INFO - PROCESS | 1937 | __start_tp_report 07:53:55 INFO - PROCESS | 1937 | _x_x_mozilla_page_load 07:53:55 INFO - PROCESS | 1937 | _x_x_mozilla_page_load_details 07:53:55 INFO - PROCESS | 1937 | |i|pagename|runs| 07:53:55 INFO - PROCESS | 1937 | |0;dojo.html;3285.375778602067;3308.999999999999;3313.039218626598;3327.068420842165;3371.7471189660764;5577.581681373893;5649.632773869701;5651.2653355063885;5761.107028410593;5778.50882674972;5679.602427830054;5709.685967271798;5748.223989761381;5803.071508558621;5803.535717142629;5164.561012313958;5200.973995130019;5233.973830130844;5245.449227831061;5245.7377131143485;5164.483551644843;5287.656302340336;5306.442823503535;5308.150695888658;5325.760340784674;5259.237410575445;5280.260763493114;5296.735163241842;5312.681239125645;5331.6534425262425;5134.845954621367;5197.168453047494;5203.843884683428;5207.765650545734;5211.843644690665;5194.454582268883;5217.947820521784;5246.816361427332;5256.500632439912;5258.07983602868;5691.260136182311;5708.828735137952;5720.427957204288;5764.51001664859;5775.191473193756;6075.33171351151;6138.263408391022;6142.938570614281;6269.059641053833;6291.1506946562085;6101.725422356005;6117.2184870185665;6121.3572574879445;6125.601835880653;6142.481582551177;5645.5483561314995;5650.491455769001;5650.886982260332;5655.123455864347;5676.347220069703;6205.22434695663;6236.469900058455;6264.123022776815;6277.654728989949;6280.811575652738;6007.339192688801;6048.395160483917;6102.481289090389;6117.571769976148;6122.846928826815;6309.716062777186;6309.936900631027;6312.179416675895;6321.399467050623;6334.429901308904;6191.102290167991;6262.436380725665;6264.091706702503;6270.996640537492;6290.685465726787;6084.665343406155;6108.068892179526;6109.404666050415;6164.599301045418;6292.622442653455;4868.221084626513;4885.780139893714;4901.730404827768;4906.092372911023;4906.435759887659;4311.1808756336195;4386.298192289219;4435.35687325336;4445.199864024442;4447.043885564619;5710.571707121982;5721.370649228582;5724.914126288109;5725.427457254241;5732.398098199712;6199.132121502993;6203.31763506014;6206;6206.937930620727;6207.844803879939;5675.347335056439;5700.885982280414;5702.116171993348;5705.771769129188;5711.6858572778065;5339.46605339463;5345.251664766935;5359.062164121341;5369.892602147936;5373.086575282211;6297.716602752796;6303.3066362700065;6312.053192021233;6312.274088479791;6326.746930122744;6113.993245360445;6168.722407491584;6321.462675672436;6324.778632747832;6329.90505142414;6106.642687876592;6225.533085018732;6231.626102433868;6245.406686364788;6309.274433440213;6219;6221.502279817694;6236.6258024518675;6238.064290356483;6238.625682459067;6135.9079613806725;6326.6520341381665;6329.778457753957;6331.018692102732;6338.809835704937;5758.913616295675;5958.910616340671;5997.340292567901;6006.549508786771;6144.938550614436;6103.176071230327;6104.06507294887;6121.117656725397;6127.464420129145;6140.688304616386;5896.498797602252;6001.3698561652145;6003.549733770072;6009.369016253405;6054.8183554493435;5950.553708471968;5996.820095397145;5998.430149135826;6133.202683651097;6144.907826382697;5899.056151015817;5911.763529458945;5918.556108291809;5919.556033297434;5936.495397891227 07:53:55 INFO - PROCESS | 1937 | |1;ext.html;437.7614200260858;446.8949796797752;488.4114641856562;515.9200323949789;523.5079025715827;28190;30366.089017329487;31112.533312000338;31151.532727009115;31154.68845311546;31719.841400793022;32493;39630.405543916866;40605.79697101518;40806.18387632246;9194.44833310002;9325.207357374631;9346.57940392684;9347.579358928864;9347.766305842375;9191.632334706605;9344.159025687686;9346.299027572959;9356.532173391302;9364.625414983426;8435.072142064368;8656.87014694777;9365.48489833059;11046.613368532104;11257.887421125806;11073.114150867912;11142;11147.219694621379;11151.665450036511;11163.386013769199;9846.916839147689;10996.670099897015;11102.833457498144;11116.833247501294;11150.66548003553;30334.696653033407;30903.845480772452;30930.0720978371;31971.360572788646;37413;3326.567546218976;3417.1457135716073;3520.7359448041498;3832.865849695247;3957.406389041638;28641.856790716123;29354.412911741645;29497.410051798845;29505.704942950724;29711.25721856949;3168.8098714077228;3178.920526986844;3239.8704051838135;3248.2366643838677;3250.6099268087746;470936;472518;474547;475201;475710;57868.42131578714;58229.126563101585;58338.416615833296;58440.896229716214;58452.707736461045;60537.69731151316;60548.39451605428;60603.69698151569;60614;60733;15047.774283385757;15426.84573154254;15455.30451129702;15459.458918937784;15478.148701821508;11987.400629968466;12069.698257543456;12075.939620301842;12083.335416552174;12090;15922.76115858263;16154.042259646461;16199.785016123838;16286.10426426558;16304.51086467408;4723.735520817759;5422.620416570881;6295.716692748837;6304.716287767062;6354.3010268870385;830.9293710034715;1053.931494452858;1071.7481391872905;1110.4558766204664;1129.158776711339;26963.460730785275;27830.860845695643;28672.42655146927;28833.855830720713;29621;1011.8279892418307;1037.4708898461838;1103.4868786014542;1128.8588926384202;1141.6860363399965;13013.934930325287;13431.93284033593;14446.349914253884;14553.61740634638;14870.256487175599;578746;587218;593362;595305;598085;56153;56439;56461.435385645615;56488.43511564914;56643;1214.7813393589063;1260.2942352282569;1283.972821742621;1330.0955350361846;1342.275171407429;28347.57478637781;29722;29861.70138298589;30586;30725.692743073178;46990.53009469862;47459.81350466128;47538.76230618825;47565.2004379191;47575.762121189175;498462;499890;507233;507820;510109;24659.013639454937;25704;25811;26376.4724705501;26482.337941550846;44488.55511444974;44560.331595025455;44972;45297.54702452933;45732.31401528913;36340.45489317715;36735.265294694495;36812.815935920145;37122.85687315839;37775.43336849895;36295.91112266636;36762.81618591997;37582.2483550322;37745.43381849329;37848.81075594604;34674.65325346714;35490.64509354976;35931.64068359283;36458.8177059113;36545;31725.682743172274;32961.67038329586;32987.835060824546;32997.50503742398;33045;24033.918473669077;24326.270211893672;24435.87782061078;24759.87620061888;25133.994640214187 07:53:55 INFO - PROCESS | 1937 | |2;jquery.html;349.45136136266075;365.9835307411166;368.12753773556693;379.59573054696745;399.9860004899827;14660.926695366521;14896.553103406888;15682.451114211019;19942.302019429324;20438.897805510987;19400.611987760272;19622.411327660157;19644.116014779334;20364.592708145865;20470.2835400761;5747.568932330071;5847.766089356421;6048.516118710515;6056.091586262074;6061.848453788646;4620.676552641316;5949.107633854935;5992.400759924017;5993.4006599340155;6007.309159446654;5623.690697011662;5824.271966004249;5867.823965281027;5934.139549765303;5941.821745347646;5769.7692092316465;5884.882302353972;5904.232449781501;5910.408959104056;5914.674692891889;4982.725950072744;5065.910829171746;5115.565176959963;5142.84571462853;5152.278680984665;21721;22004.559908801733;22567.77432225673;24458;24868.005279788787;2322.3497420722224;2389.438481956739;2629.7501737334924;2980.657224419198;3124.7500199983947;14389.064710793766;14833.406663733438;15088.924555377263;15267.236638168159;15272.854535909852;1756.8770186086979;1821.1977915872321;1853.508820162658;1867.2810967777368;1891.4609336339076;102768;103134.48432757863;104456;105632.94367056308;106166.93833061648;10176.491175441199;10479.68560943173;10507.474626268657;10856.945715271531;11304.434778261219;13525.932370338282;13541.526046588322;13565.660858478617;13575.759999600154;13593.59219223425;7949;8219.589020549069;8264.628091735887;8357.540335281496;8401.579921003926;8264.256216940505;8288.8342233155;8290.378221633402;8435.578221088921;8456.450330728607;5469.972650136724;5738.110592858114;6370.904436433457;6490.188726409199;6616.735330586723;1704.6761115388038;1765.267414023166;1767.293082766878;1767.5492749348834;1782.8306310900443;865.9350548708873;877.3726785348379;886.866969954499;921.235374639048;965.9130678238852;20614.896925515277;21047.05288262032;21235.46911327198;21632.35102946914;21645.891770541046;946.4463288976026;952.224266263847;964.782923842144;965.6958058211782;971.8677740432458;10546.419946902994;11443.37061461611;11518.193726439236;11543.595974140864;11608.883911160949;549694;559097;562511;576068;579967.0049492526;98016;108225.45887270513;120311;122049;123027.15459267939;970.6263088710756;980.0640388429175;1014.0164040880335;1015.6140666546665;1019.719577116299;19218.55860810473;19357;19358.322458713876;19409.51476213106;19411.611767764847;47531.28703069526;51782.48217517776;51873;52869;53718.46281537135;73534.32328383453;74692;74996;75115.24884751301;75366.24633753592;6163.506919446523;7872.527648341118;7927.12801591836;8016.83966320682;8124.715634952749;10979.670609881716;12905.806412903627;13025.739485210053;13173.868261317648;13348.332583370986;11014.779704406028;11246.100311975186;11493.597724079616;11498.885011150116;11525.538978440769;11054.613088542184;11190.888091118984;11219.831702524632;11530.59642912494;11574.421278936188;8820.5589720515;11374.033207177483;11485.253458525169;11589.956903878692;11896.405179740805;7846.489978151402;7944.7685608730735;8218.096009439076;11449.370284634091;11643.118525091943;10658.8401173984;11192.832107518556;11376.033037191932;11742.295462272292;12035.217710848767 07:53:55 INFO - PROCESS | 1937 | |3;mootools.html;1306.3141850528466;1427.2078996157131;1444.147952707902;1620.5057457475473;1832.7159290310008;7294.927050729491;7638.350740187084;7897.249761272684;8123.025236971557;8131.105578386373;8038.959805200981;8112.5943702814775;8129.634166462509;8133.349332053436;8139.308158806509;2044.1925439451409;2258.706368172135;2300.723913130427;2302.9884850575722;2308.595995700754;2119.6926445665445;2255.548890221954;2331.184085570054;2336.9532609347802;2347.8826058696995;2264.377296243538;2287.656851472284;2298.793108620224;2299.7240331160283;2300.459392042869;2277.87471689057;2303.5968705476644;2304;2304.827137964651;2304.9884750576307;2286.0969916882736;2326.139328448468;2327.150590034642;2328.7787660172257;2329.5457385809773;8122.553259570721;8145.674173033071;8211.753647390588;8230.09468958414;8240.299574536171;4991.800327986876;5155.200943853709;5162.148245539519;5182.559482443997;5192.039472697563;3000.4449176902126;3190.744740420761;3468.8265586720813;3490.127468132967;3493.074335301147;1007.7833265847878;1052.7157667429829;1081.5241293830768;1087.478010554938;1092.7650555130685;10603.045725884707;10612.097971672418;10613.36319820821;10618.522166502526;10647.94676026615;4452.465704115527;4618.976905115453;4673.112108699336;4694.95305046952;4778.4982576829625;8379.664813407517;8517.914820851836;8547.40168188221;8562.443441176303;8580.871286930702;5020.49795020495;5045.41977672565;5053.1157047516535;5054.898902021939;5066.417362003417;4222.514410842731;4368.563143685606;4501.144782491317;4641.512641172696;4742.312364707098;3359.882404115844;3414.607320158164;3593.885895372443;3647.5592141104116;3756.267527832101;1214.738831151289;1247.108317552936;1250.1249125612107;1263.1726219326356;1269.8285731426324;828.6975254032355;851.1616058182685;874.6807415293499;883.726044926075;932.1424289653535;5307.28351672527;5347.278117454094;5578.442155784389;5785.392533783892;5804;949.378157306965;969.3021024862088;972.1105188752213;972.7811242470387;976.5068640336584;3555.1112221944513;3587.01357126787;3712.3688972874675;3757.1922036762226;3884.1260716338597;8748.387612867165;9387.295952803566;9442.669506567237;9817.950910245403;9844.80310393788;9291.581878815334;9581.808363832684;9713.854292185622;9727.319087663796;9735.65925192629;7449.255074492507;7646.655900484491;7657.961710191414;7666.769996900102;7671.347935425551;5398.811041613525;5433.185022246536;5461.077366923629;5794.420557944172;5897.321807992136;8742.912570874465;9089.363744538083;9112.95443522778;9256.861147082935;9269.073092690676;8639.13608639131;8968.955155224183;9128.863067054132;9326.906730932604;9383.436993780395;6947.40947019509;7028.8594228114125;7053.294670532906;7079.008938748476;7089.82275443118;7004;7241.275872412927;7252;7401.48189626721;7638.656260468181;6909.032735416945;6919.6886140124825;6920.307969203241;6980;7096.680649370894;6839.384455399038;6863.176418829573;6872.037914691847;6922.411595014279;7022.262662420577;6404.719056188874;6469.708863101077;6548.83627909287;6583.934160658332;6585.670716464062;4145.274576949082;4789.137955168103;4797.904041919072;4842.104210721028;4911.8280860169725;4722.811087556596;4741.691790033637;4792.3530323407285;4856.368672072749;4993.15116430215 07:53:55 INFO - PROCESS | 1937 | |4;prototype.html;291.6106997158794;293.55379822669545;297.1501505693716;310.9595752552169;314.818979087025;4381.978090109553;4575.862724118273;5111.642185047043;5254.691153254333;5286.788528458857;4548.067646132543;4906.828261010865;5138.922916156261;5194.298769666094;5230.555402790757;4040.515138183422;4056.655184309337;4059.416827437287;4060.20825938942;4072.8370865165357;3403.0981789825714;3557.804320762357;3730.2912446635187;4065.7357271777387;4093.44738460307;3810.3522401191863;3904.297226499229;3957.0503079261057;4038.838446462138;4047.494063242095;3999.4000899864964;4006.939895901564;4010.57360297019;4032.173404452095;4047.372657238133;2787.4982503149427;3484.5470088888537;3519.9120021999397;3531.5408996830247;3533.787972721619;4239.922438005356;4467.843625473125;4885.462599114095;5120.871978200537;5122.154844450699;3819.2743378757946;4145.233131870614;4480.439945006874;4524.570165834273;4547.977260113711;4643.837465688718;4851.442084160296;5172.6379153459275;5187.5071868172845;5197.610179236573;3358.412277851366;3640.2355505343908;3745;3770.5663848657205;3773.396256598931;5452.345718513804;5505.587080968903;5653.293338332708;5742.6841523716175;5770.6249093808765;3158.0525842247234;3455.3262113888054;3541.451075083366;3735.869244576427;3794.1083845296334;3866.729328947003;3878.2825177342283;3886.8250928708276;3908.5309762828642;3913.5695073541888;3453.067671728619;3506.9298614027575;4059.939100913489;4557.453105627346;4627.444706635158;4543.136804007294;4852.4662287148385;5021.447640759587;5282.52457278839;5514.704044549528;1073.2540884085486;1125.622916323041;1166.9963831105242;1171.7597892432202;1202.5971299614553;809.6113865344549;849.8329260385991;857;857.0358346859783;860.8149247911729;4223.704340696122;4916.0905232532095;4925.827596034122;4980.77586508608;4985.725785081783;4587.9082418351445;5386.784528618811;5399.325084364455;5407.728324363782;5427.1045277528765;4295.763732994716;4591.150637132141;4851.587615052689;4882.511748825089;4897.534734200317;2816.5915942188267;2824.477471667748;2863.2555535560487;2876.856157192132;2877.309445733051;4716.1510928033285;4998.725070121178;5134.973005398935;5451.18417108026;5664.830055098354;4713.505081966344;5130.460861741462;5215.374155101336;5573.386927437979;5640.351359593617;4664.207084795593;5292.824305416796;5669.518090962314;5669.943300566942;5713.485786279255;4678.812847486062;5076.873078173076;5112.258722485293;5509.3664228612615;5537;4823.879403014953;4878.487758785418;5037.672551284155;5381.654586353412;5413.945860541344;4800.7359595221205;5406.945930540644;5632.634293596618;5666.025336698266;5775.566832487496;3149.008062460318;3398.796072235674;3742.5321834770652;3927.823247953792;3989.9800500997308;5336.573074153981;5424.335071838137;5467.371252306036;5766.106253530709;5769;5090.389153301628;5409.621326507264;5428.99127322893;5538.861528461821;5602.515333436561;4531.388262584641;5521.282233309644;5527.512619321402;5541.7808082221845;5562.605541622073;4593.1627349060645;5378.596605254544;5390.434004429479;5415.512603865671;5425.267588875609;4900.803967841389;5166.8966620668125;5500.22996780443;5501.339839219319;5502.9174562382395;5389.167682987803;5416.21464887597;5420.186971954238;5430.782768689208;5433.5924805640525 07:53:55 INFO - PROCESS | 1937 | |5;yui.html;716.7670507085198;742.5173637135861;760.1828034862523;788.2826627768732;789.3803364358978;15139.848601513995;15822.129782861937;15823;15838.049717016987;15840.683186336266;13441.193528388303;13522.526711565097;13533.864661353384;13537.255450950193;13559.661008474794;651.4983462733692;679.5073571660531;681.7239018197638;805.4080251015499;828.1883753921146;846.8137009857821;848.0798333807826;848.6308455821737;851.6082602003086;851.8679604661256;891.393852180517;901.2339511415278;901.9864702029442;902.057350069176;905.3798148268457;893.6648756716231;896.6951236579595;897.4166791585488;899.757065592293;902.9774255643596;510.4895104895105;533.679792124726;633.5375176121411;662.4336192555344;665.1984358847577;14310.49913253031;14878.256087195598;14893.404263829541;14903.329350179269;14930;13618.319084045757;13721;13800.240986745725;13842.169469831742;13988.650283742885;12325.131213953578;12475.500979960882;12531.624051278477;12707.110502264844;12978.87021129786;3914.921701565981;4327.112941846914;4387.451568553931;4445.955540444619;4454.398656181439;89216.10783892142;103095.48452257691;103871.48064259706;106290;113177;10607.681769546925;10677.092447141924;10803.351798892092;11050.557977680803;11324.94337528307;21298.893505532684;21664;21671.56656866854;21839.78160218409;21950.341489755334;7581.12817026038;7594.202608726115;7636.847263054708;7705.499142555828;7779.588327618457;3586.802725850051;4168.812403441852;4230.598093181143;4399.36209249657;4419.779011049434;3338.1320856577463;3450;3450.102973226979;3452.154222215573;3453.8273086346085;643.453064894845;662.4402379988902;675.7702381190419;696.864111498253;699.1854489519754;558.9092319473239;591.2195901410183;618.1932577985772;633.47105167185;656.8226578823691;8713.215810577078;9052.909470905206;9339.766505837408;9415;9795.363301385387;555.5250261026845;596.3708287756458;639.8752243312603;661.8186537031376;681.5501768832547;4526.705764125321;4527.456705195397;4533.5013148553635;4533.909321813611;4633.907321853544;103704.48147759213;106668;106791;107042;107692.46153769181;93159;96295;96402.51798740962;98436.50781746188;98533;80046.59976700196;82502;82713.58643206865;84320.57839710762;86266.98065567674;8850.955745221232;8861.335399845166;8875.201231888903;8944.955275223581;8990.86513702282;50700;52368.47631523789;54832.17751733647;55811;56332.718336408056;66468;77902;79811.60094199491;81499.77750333869;81644.59177704074;11688.94155529217;11821.468033938665;11925.940370298093;12065.215760975509;12170.634880953585;12901.612951611467;13090.410931508295;13442;13568.660783480493;13669.79495307591;11844.881551184379;12341.3829308536;12397.93801030989;12422.565210217599;12641.3679316032;11743;11879.940600296943;11881.5841445549;12157.331346776013;12597.622071337875;11628.244164129643;11907.76184476323;12007.339596322287;12038.458269378074;12443.93778031104;9743.512824358895;10093.69718908434;10165.44090075053;10168.84746728785;10599.311044782064;10106.747331316776;10396;10451.634192803216;10493.527791249564;10510.159187265153 07:53:55 INFO - PROCESS | 1937 | __end_tp_report 07:53:55 INFO - PROCESS | 1937 | __start_cc_report 07:53:55 INFO - PROCESS | 1937 | _x_x_mozilla_cycle_collect,2138 07:53:55 INFO - PROCESS | 1937 | __end_cc_report 07:53:55 INFO - PROCESS | 1937 | __startTimestamp1480348435833__endTimestamp 07:53:55 INFO - PROCESS | 1937 | 07:53:55 INFO - PROCESS | 1937 | ------- Summary: start ------- 07:53:55 INFO - PROCESS | 1937 | Number of tests: 6 07:53:55 INFO - PROCESS | 1937 | 07:53:55 INFO - PROCESS | 1937 | [#0] dojo.html Cycles:165 Average:5738.25 Median:5950.55 stddev:636.46 (10.7%) stddev-sans-first:608.63 07:53:55 INFO - PROCESS | 1937 | Values: 3285.4 3309.0 3313.0 3327.1 3371.7 5577.6 5649.6 5651.3 5761.1 5778.5 5679.6 5709.7 5748.2 5803.1 5803.5 5164.6 5201.0 5234.0 5245.4 5245.7 5164.5 5287.7 5306.4 5308.2 5325.8 5259.2 5280.3 5296.7 5312.7 5331.7 5134.8 5197.2 5203.8 5207.8 5211.8 5194.5 5217.9 5246.8 5256.5 5258.1 5691.3 5708.8 5720.4 5764.5 5775.2 6075.3 6138.3 6142.9 6269.1 6291.2 6101.7 6117.2 6121.4 6125.6 6142.5 5645.5 5650.5 5650.9 5655.1 5676.3 6205.2 6236.5 6264.1 6277.7 6280.8 6007.3 6048.4 6102.5 6117.6 6122.8 6309.7 6309.9 6312.2 6321.4 6334.4 6191.1 6262.4 6264.1 6271.0 6290.7 6084.7 6108.1 6109.4 6164.6 6292.6 4868.2 4885.8 4901.7 4906.1 4906.4 4311.2 4386.3 4435.4 4445.2 4447.0 5710.6 5721.4 5724.9 5725.4 5732.4 6199.1 6203.3 6206.0 6206.9 6207.8 5675.3 5700.9 5702.1 5705.8 5711.7 5339.5 5345.3 5359.1 5369.9 5373.1 6297.7 6303.3 6312.1 6312.3 6326.7 6114.0 6168.7 6321.5 6324.8 6329.9 6106.6 6225.5 6231.6 6245.4 6309.3 6219.0 6221.5 6236.6 6238.1 6238.6 6135.9 6326.7 6329.8 6331.0 6338.8 5758.9 5958.9 5997.3 6006.5 6144.9 6103.2 6104.1 6121.1 6127.5 6140.7 5896.5 6001.4 6003.5 6009.4 6054.8 5950.6 5996.8 5998.4 6133.2 6144.9 5899.1 5911.8 5918.6 5919.6 5936.5 07:53:55 INFO - PROCESS | 1937 | 07:53:55 INFO - PROCESS | 1937 | [#1] ext.html Cycles:180 Average:65049.87 Median:18185.78 stddev:140223.48 (771.1%) stddev-sans-first:140532.93 07:53:55 INFO - PROCESS | 1937 | Values: 437.8 446.9 488.4 515.9 523.5 28190.0 30366.1 31112.5 31151.5 31154.7 31719.8 32493.0 39630.4 40605.8 40806.2 9194.4 9325.2 9346.6 9347.6 9347.8 9191.6 9344.2 9346.3 9356.5 9364.6 8435.1 8656.9 9365.5 11046.6 11257.9 11073.1 11142.0 11147.2 11151.7 11163.4 9846.9 10996.7 11102.8 11116.8 11150.7 30334.7 30903.8 30930.1 31971.4 37413.0 3326.6 3417.1 3520.7 3832.9 3957.4 28641.9 29354.4 29497.4 29505.7 29711.3 3168.8 3178.9 3239.9 3248.2 3250.6 470936.0 472518.0 474547.0 475201.0 475710.0 57868.4 58229.1 58338.4 58440.9 58452.7 60537.7 60548.4 60603.7 60614.0 60733.0 15047.8 15426.8 15455.3 15459.5 15478.1 11987.4 12069.7 12075.9 12083.3 12090.0 15922.8 16154.0 16199.8 16286.1 16304.5 4723.7 5422.6 6295.7 6304.7 6354.3 830.9 1053.9 1071.7 1110.5 1129.2 26963.5 27830.9 28672.4 28833.9 29621.0 1011.8 1037.5 1103.5 1128.9 1141.7 13013.9 13431.9 14446.3 14553.6 14870.3 578746.0 587218.0 593362.0 595305.0 598085.0 56153.0 56439.0 56461.4 56488.4 56643.0 1214.8 1260.3 1284.0 1330.1 1342.3 28347.6 29722.0 29861.7 30586.0 30725.7 46990.5 47459.8 47538.8 47565.2 47575.8 498462.0 499890.0 507233.0 507820.0 510109.0 24659.0 25704.0 25811.0 26376.5 26482.3 44488.6 44560.3 44972.0 45297.5 45732.3 36340.5 36735.3 36812.8 37122.9 37775.4 36295.9 36762.8 37582.2 37745.4 37848.8 34674.7 35490.6 35931.6 36458.8 36545.0 31725.7 32961.7 32987.8 32997.5 33045.0 24033.9 24326.3 24435.9 24759.9 25134.0 07:53:55 INFO - PROCESS | 1937 | 07:53:55 INFO - PROCESS | 1937 | [#2] jquery.html Cycles:180 Average:33259.20 Median:12445.06 stddev:93990.24 (755.2%) stddev-sans-first:94221.42 07:53:55 INFO - PROCESS | 1937 | Values: 349.5 366.0 368.1 379.6 400.0 14660.9 14896.6 15682.5 19942.3 20438.9 19400.6 19622.4 19644.1 20364.6 20470.3 5747.6 5847.8 6048.5 6056.1 6061.8 4620.7 5949.1 5992.4 5993.4 6007.3 5623.7 5824.3 5867.8 5934.1 5941.8 5769.8 5884.9 5904.2 5910.4 5914.7 4982.7 5065.9 5115.6 5142.8 5152.3 21721.0 22004.6 22567.8 24458.0 24868.0 2322.3 2389.4 2629.8 2980.7 3124.8 14389.1 14833.4 15088.9 15267.2 15272.9 1756.9 1821.2 1853.5 1867.3 1891.5 102768.0 103134.5 104456.0 105632.9 106166.9 10176.5 10479.7 10507.5 10856.9 11304.4 13525.9 13541.5 13565.7 13575.8 13593.6 7949.0 8219.6 8264.6 8357.5 8401.6 8264.3 8288.8 8290.4 8435.6 8456.5 5470.0 5738.1 6370.9 6490.2 6616.7 1704.7 1765.3 1767.3 1767.5 1782.8 865.9 877.4 886.9 921.2 965.9 20614.9 21047.1 21235.5 21632.4 21645.9 946.4 952.2 964.8 965.7 971.9 10546.4 11443.4 11518.2 11543.6 11608.9 549694.0 559097.0 562511.0 576068.0 579967.0 98016.0 108225.5 120311.0 122049.0 123027.2 970.6 980.1 1014.0 1015.6 1019.7 19218.6 19357.0 19358.3 19409.5 19411.6 47531.3 51782.5 51873.0 52869.0 53718.5 73534.3 74692.0 74996.0 75115.2 75366.2 6163.5 7872.5 7927.1 8016.8 8124.7 10979.7 12905.8 13025.7 13173.9 13348.3 11014.8 11246.1 11493.6 11498.9 11525.5 11054.6 11190.9 11219.8 11530.6 11574.4 8820.6 11374.0 11485.3 11590.0 11896.4 7846.5 7944.8 8218.1 11449.4 11643.1 10658.8 11192.8 11376.0 11742.3 12035.2 07:53:55 INFO - PROCESS | 1937 | 07:53:55 INFO - PROCESS | 1937 | [#3] mootools.html Cycles:180 Average:5292.98 Median:5327.28 stddev:2844.42 (53.4%) stddev-sans-first:2836.61 07:53:55 INFO - PROCESS | 1937 | Values: 1306.3 1427.2 1444.1 1620.5 1832.7 7294.9 7638.4 7897.2 8123.0 8131.1 8039.0 8112.6 8129.6 8133.3 8139.3 2044.2 2258.7 2300.7 2303.0 2308.6 2119.7 2255.5 2331.2 2337.0 2347.9 2264.4 2287.7 2298.8 2299.7 2300.5 2277.9 2303.6 2304.0 2304.8 2305.0 2286.1 2326.1 2327.2 2328.8 2329.5 8122.6 8145.7 8211.8 8230.1 8240.3 4991.8 5155.2 5162.1 5182.6 5192.0 3000.4 3190.7 3468.8 3490.1 3493.1 1007.8 1052.7 1081.5 1087.5 1092.8 10603.0 10612.1 10613.4 10618.5 10647.9 4452.5 4619.0 4673.1 4695.0 4778.5 8379.7 8517.9 8547.4 8562.4 8580.9 5020.5 5045.4 5053.1 5054.9 5066.4 4222.5 4368.6 4501.1 4641.5 4742.3 3359.9 3414.6 3593.9 3647.6 3756.3 1214.7 1247.1 1250.1 1263.2 1269.8 828.7 851.2 874.7 883.7 932.1 5307.3 5347.3 5578.4 5785.4 5804.0 949.4 969.3 972.1 972.8 976.5 3555.1 3587.0 3712.4 3757.2 3884.1 8748.4 9387.3 9442.7 9818.0 9844.8 9291.6 9581.8 9713.9 9727.3 9735.7 7449.3 7646.7 7658.0 7666.8 7671.3 5398.8 5433.2 5461.1 5794.4 5897.3 8742.9 9089.4 9113.0 9256.9 9269.1 8639.1 8969.0 9128.9 9326.9 9383.4 6947.4 7028.9 7053.3 7079.0 7089.8 7004.0 7241.3 7252.0 7401.5 7638.7 6909.0 6919.7 6920.3 6980.0 7096.7 6839.4 6863.2 6872.0 6922.4 7022.3 6404.7 6469.7 6548.8 6583.9 6585.7 4145.3 4789.1 4797.9 4842.1 4911.8 4722.8 4741.7 4792.4 4856.4 4993.2 07:53:55 INFO - PROCESS | 1937 | 07:53:55 INFO - PROCESS | 1937 | [#4] prototype.html Cycles:180 Average:4344.06 Median:4852.03 stddev:1330.68 (27.4%) stddev-sans-first:1299.18 07:53:55 INFO - PROCESS | 1937 | Values: 291.6 293.6 297.2 311.0 314.8 4382.0 4575.9 5111.6 5254.7 5286.8 4548.1 4906.8 5138.9 5194.3 5230.6 4040.5 4056.7 4059.4 4060.2 4072.8 3403.1 3557.8 3730.3 4065.7 4093.4 3810.4 3904.3 3957.1 4038.8 4047.5 3999.4 4006.9 4010.6 4032.2 4047.4 2787.5 3484.5 3519.9 3531.5 3533.8 4239.9 4467.8 4885.5 5120.9 5122.2 3819.3 4145.2 4480.4 4524.6 4548.0 4643.8 4851.4 5172.6 5187.5 5197.6 3358.4 3640.2 3745.0 3770.6 3773.4 5452.3 5505.6 5653.3 5742.7 5770.6 3158.1 3455.3 3541.5 3735.9 3794.1 3866.7 3878.3 3886.8 3908.5 3913.6 3453.1 3506.9 4059.9 4557.5 4627.4 4543.1 4852.5 5021.4 5282.5 5514.7 1073.3 1125.6 1167.0 1171.8 1202.6 809.6 849.8 857.0 857.0 860.8 4223.7 4916.1 4925.8 4980.8 4985.7 4587.9 5386.8 5399.3 5407.7 5427.1 4295.8 4591.2 4851.6 4882.5 4897.5 2816.6 2824.5 2863.3 2876.9 2877.3 4716.2 4998.7 5135.0 5451.2 5664.8 4713.5 5130.5 5215.4 5573.4 5640.4 4664.2 5292.8 5669.5 5669.9 5713.5 4678.8 5076.9 5112.3 5509.4 5537.0 4823.9 4878.5 5037.7 5381.7 5413.9 4800.7 5406.9 5632.6 5666.0 5775.6 3149.0 3398.8 3742.5 3927.8 3990.0 5336.6 5424.3 5467.4 5766.1 5769.0 5090.4 5409.6 5429.0 5538.9 5602.5 4531.4 5521.3 5527.5 5541.8 5562.6 4593.2 5378.6 5390.4 5415.5 5425.3 4900.8 5166.9 5500.2 5501.3 5502.9 5389.2 5416.2 5420.2 5430.8 5433.6 07:53:55 INFO - PROCESS | 1937 | 07:53:55 INFO - PROCESS | 1937 | [#5] yui.html Cycles:180 Average:20967.13 Median:4432.87 stddev:30930.69 (697.8%) stddev-sans-first:30980.08 07:53:55 INFO - PROCESS | 1937 | Values: 716.8 742.5 760.2 788.3 789.4 15139.8 15822.1 15823.0 15838.0 15840.7 13441.2 13522.5 13533.9 13537.3 13559.7 651.5 679.5 681.7 805.4 828.2 846.8 848.1 848.6 851.6 851.9 891.4 901.2 902.0 902.1 905.4 893.7 896.7 897.4 899.8 903.0 510.5 533.7 633.5 662.4 665.2 14310.5 14878.3 14893.4 14903.3 14930.0 13618.3 13721.0 13800.2 13842.2 13988.7 12325.1 12475.5 12531.6 12707.1 12978.9 3914.9 4327.1 4387.5 4446.0 4454.4 89216.1 103095.5 103871.5 106290.0 113177.0 10607.7 10677.1 10803.4 11050.6 11324.9 21298.9 21664.0 21671.6 21839.8 21950.3 7581.1 7594.2 7636.8 7705.5 7779.6 3586.8 4168.8 4230.6 4399.4 4419.8 3338.1 3450.0 3450.1 3452.2 3453.8 643.5 662.4 675.8 696.9 699.2 558.9 591.2 618.2 633.5 656.8 8713.2 9052.9 9339.8 9415.0 9795.4 555.5 596.4 639.9 661.8 681.6 4526.7 4527.5 4533.5 4533.9 4633.9 103704.5 106668.0 106791.0 107042.0 107692.5 93159.0 96295.0 96402.5 98436.5 98533.0 80046.6 82502.0 82713.6 84320.6 86267.0 8851.0 8861.3 8875.2 8945.0 8990.9 50700.0 52368.5 54832.2 55811.0 56332.7 66468.0 77902.0 79811.6 81499.8 81644.6 11688.9 11821.5 11925.9 12065.2 12170.6 12901.6 13090.4 13442.0 13568.7 13669.8 11844.9 12341.4 12397.9 12422.6 12641.4 11743.0 11879.9 11881.6 12157.3 12597.6 11628.2 11907.8 12007.3 12038.5 12443.9 9743.5 10093.7 10165.4 10168.8 10599.3 10106.7 10396.0 10451.6 10493.5 10510.2 07:53:55 INFO - PROCESS | 1937 | -------- Summary: end -------- 07:53:55 INFO - PROCESS | 1937 | 07:53:56 INFO - TEST-INFO | 1937: exit 0 07:53:56 INFO - TEST-OK | dromaeo_css | took 1120845ms 07:53:56 INFO - TEST-START | kraken 07:53:56 INFO - operating with platform_type : mac_ 07:53:56 INFO - Initialising browser for kraken test... 07:53:56 INFO - TEST-INFO | started process 1940 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmpkvbgdq/profile http://localhost:52215/getInfo.html) 07:53:59 INFO - PROCESS | 1940 | __metrics Screen width/height:1600/1200 07:53:59 INFO - PROCESS | 1940 | colorDepth:24 07:53:59 INFO - PROCESS | 1940 | Browser inner width/height: 1024/689 07:53:59 INFO - PROCESS | 1940 | __metrics 07:53:59 INFO - PROCESS | 1940 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:53:59 INFO - PROCESS | 1940 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:54:00 INFO - TEST-INFO | 1940: exit 0 07:54:00 INFO - Browser initialized. 07:54:00 INFO - Running cycle 1/1 for kraken test... 07:54:00 INFO - TEST-INFO | started process 1941 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/7s/mgsnjszs56ld075hs__4729c00000w/T/tmpkvbgdq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:54:12 INFO - PROCESS | 1941 | RSS: Main: 237019136 07:54:12 INFO - PROCESS | 1941 | 07:54:15 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52215/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52215/tests/kraken/driver.html?testName=audio-beat-detection) 07:54:16 INFO - PROCESS | 1941 | RSS: Main: 293810176 07:54:16 INFO - PROCESS | 1941 | 07:54:18 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52215/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52215/tests/kraken/driver.html?testName=audio-dft) 07:54:19 INFO - PROCESS | 1941 | RSS: Main: 296034304 07:54:19 INFO - PROCESS | 1941 | 07:54:22 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52215/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52215/tests/kraken/driver.html?testName=audio-fft) 07:54:23 INFO - PROCESS | 1941 | RSS: Main: 390979584 07:54:23 INFO - PROCESS | 1941 | 07:54:25 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52215/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52215/tests/kraken/driver.html?testName=audio-oscillator) 07:54:25 INFO - PROCESS | 1941 | RSS: Main: 291389440 07:54:25 INFO - PROCESS | 1941 | 07:54:27 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52215/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52215/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:54:28 INFO - PROCESS | 1941 | RSS: Main: 295239680 07:54:28 INFO - PROCESS | 1941 | 07:54:31 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52215/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52215/tests/kraken/driver.html?testName=imaging-darkroom) 07:54:31 INFO - PROCESS | 1941 | RSS: Main: 338235392 07:54:31 INFO - PROCESS | 1941 | 07:54:34 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52215/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52215/tests/kraken/driver.html?testName=imaging-desaturate) 07:54:35 INFO - PROCESS | 1941 | RSS: Main: 339333120 07:54:35 INFO - PROCESS | 1941 | 07:54:38 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52215/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52215/tests/kraken/driver.html?testName=json-parse-financial) 07:54:38 INFO - PROCESS | 1941 | RSS: Main: 334827520 07:54:38 INFO - PROCESS | 1941 | 07:54:40 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52215/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52215/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:54:41 INFO - PROCESS | 1941 | RSS: Main: 310317056 07:54:41 INFO - PROCESS | 1941 | 07:54:42 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52215/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52215/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:54:43 INFO - PROCESS | 1941 | RSS: Main: 315400192 07:54:43 INFO - PROCESS | 1941 | 07:54:45 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52215/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52215/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:54:46 INFO - PROCESS | 1941 | RSS: Main: 317161472 07:54:46 INFO - PROCESS | 1941 | 07:54:49 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52215/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52215/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:54:50 INFO - PROCESS | 1941 | RSS: Main: 335040512 07:54:50 INFO - PROCESS | 1941 | 07:54:53 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52215/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52215/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:54:54 INFO - PROCESS | 1941 | RSS: Main: 328040448 07:54:54 INFO - PROCESS | 1941 | 07:54:56 INFO - PROCESS | 1941 | Cycle 1(1): loaded http://localhost:52215/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52215/tests/kraken/driver.html?testName=ai-astar) 07:54:56 INFO - PROCESS | 1941 | RSS: Main: 372289536 07:54:56 INFO - PROCESS | 1941 | 07:54:56 INFO - PROCESS | 1941 | __start_tp_report 07:54:56 INFO - PROCESS | 1941 | _x_x_mozilla_page_load 07:54:56 INFO - PROCESS | 1941 | _x_x_mozilla_page_load_details 07:54:56 INFO - PROCESS | 1941 | |i|pagename|runs| 07:54:56 INFO - PROCESS | 1941 | |0;ai-astar;103;115;114;114;114;115;114;115;115;114 07:54:56 INFO - PROCESS | 1941 | |1;audio-beat-detection;148;115;114;152;115;115;111;107;133;113 07:54:56 INFO - PROCESS | 1941 | |2;audio-dft;183;183;185;185;186;181;182;185;185;188 07:54:56 INFO - PROCESS | 1941 | |3;audio-fft;80;59;58;87;52;51;58;48;73;74 07:54:56 INFO - PROCESS | 1941 | |4;audio-oscillator;89;70;84;70;68;69;82;68;69;106 07:54:56 INFO - PROCESS | 1941 | |5;imaging-gaussian-blur;89;87;89;87;90;85;90;87;89;86 07:54:56 INFO - PROCESS | 1941 | |6;imaging-darkroom;94;95;96;95;95;95;95;96;95;101 07:54:56 INFO - PROCESS | 1941 | |7;imaging-desaturate;85;86;87;85;88;89;86;85;85;85 07:54:56 INFO - PROCESS | 1941 | |8;json-parse-financial;55;53;55;54;53;54;56;54;54;55 07:54:56 INFO - PROCESS | 1941 | |9;json-stringify-tinderbox;66;75;82;77;74;70;70;71;71;70 07:54:56 INFO - PROCESS | 1941 | |10;stanford-crypto-aes;88;88;86;78;88;97;105;105;103;88 07:54:56 INFO - PROCESS | 1941 | |11;stanford-crypto-ccm;153;137;168;153;144;148;162;153;215;157 07:54:56 INFO - PROCESS | 1941 | |12;stanford-crypto-pbkdf2;183;230;188;182;156;226;225;183;173;177 07:54:56 INFO - PROCESS | 1941 | |13;stanford-crypto-sha256-iterative;73;84;84;86;86;72;67;67;71;84 07:54:56 INFO - PROCESS | 1941 | __end_tp_report 07:54:56 INFO - PROCESS | 1941 | __start_cc_report 07:54:56 INFO - PROCESS | 1941 | _x_x_mozilla_cycle_collect,2177 07:54:56 INFO - PROCESS | 1941 | __end_cc_report 07:54:56 INFO - PROCESS | 1941 | __startTimestamp1480348496324__endTimestamp 07:54:56 INFO - PROCESS | 1941 | 07:54:56 INFO - PROCESS | 1941 | ------- Summary: start ------- 07:54:56 INFO - PROCESS | 1941 | Number of tests: 14 07:54:56 INFO - PROCESS | 1941 | 07:54:56 INFO - PROCESS | 1941 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.50 stddev:3.65 (3.2%) stddev-sans-first:0.53 07:54:56 INFO - PROCESS | 1941 | Values: 103.0 115.0 114.0 114.0 114.0 115.0 114.0 115.0 115.0 114.0 07:54:56 INFO - PROCESS | 1941 | 07:54:56 INFO - PROCESS | 1941 | [#1] audio-beat-detection Cycles:10 Average:122.30 Median:115.00 stddev:16.10 (14.0%) stddev-sans-first:14.14 07:54:56 INFO - PROCESS | 1941 | Values: 148.0 115.0 114.0 152.0 115.0 115.0 111.0 107.0 133.0 113.0 07:54:56 INFO - PROCESS | 1941 | 07:54:56 INFO - PROCESS | 1941 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.00 stddev:2.06 (1.1%) stddev-sans-first:2.13 07:54:56 INFO - PROCESS | 1941 | Values: 183.0 183.0 185.0 185.0 186.0 181.0 182.0 185.0 185.0 188.0 07:54:56 INFO - PROCESS | 1941 | 07:54:56 INFO - PROCESS | 1941 | [#3] audio-fft Cycles:10 Average:64.00 Median:66.00 stddev:13.47 (20.4%) stddev-sans-first:12.98 07:54:56 INFO - PROCESS | 1941 | Values: 80.0 59.0 58.0 87.0 52.0 51.0 58.0 48.0 73.0 74.0 07:54:56 INFO - PROCESS | 1941 | 07:54:56 INFO - PROCESS | 1941 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:70.00 stddev:12.67 (18.1%) stddev-sans-first:12.74 07:54:56 INFO - PROCESS | 1941 | Values: 89.0 70.0 84.0 70.0 68.0 69.0 82.0 68.0 69.0 106.0 07:54:56 INFO - PROCESS | 1941 | 07:54:56 INFO - PROCESS | 1941 | [#5] imaging-gaussian-blur Cycles:10 Average:87.90 Median:89.00 stddev:1.73 (1.9%) stddev-sans-first:1.79 07:54:56 INFO - PROCESS | 1941 | Values: 89.0 87.0 89.0 87.0 90.0 85.0 90.0 87.0 89.0 86.0 07:54:56 INFO - PROCESS | 1941 | 07:54:56 INFO - PROCESS | 1941 | [#6] imaging-darkroom Cycles:10 Average:95.70 Median:95.00 stddev:1.95 (2.0%) stddev-sans-first:1.96 07:54:56 INFO - PROCESS | 1941 | Values: 94.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 101.0 07:54:56 INFO - PROCESS | 1941 | 07:54:56 INFO - PROCESS | 1941 | [#7] imaging-desaturate Cycles:10 Average:86.10 Median:86.00 stddev:1.45 (1.7%) stddev-sans-first:1.48 07:54:56 INFO - PROCESS | 1941 | Values: 85.0 86.0 87.0 85.0 88.0 89.0 86.0 85.0 85.0 85.0 07:54:56 INFO - PROCESS | 1941 | 07:54:56 INFO - PROCESS | 1941 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.50 stddev:0.95 (1.7%) stddev-sans-first:0.97 07:54:56 INFO - PROCESS | 1941 | Values: 55.0 53.0 55.0 54.0 53.0 54.0 56.0 54.0 54.0 55.0 07:54:56 INFO - PROCESS | 1941 | 07:54:56 INFO - PROCESS | 1941 | [#9] json-stringify-tinderbox Cycles:10 Average:72.60 Median:72.50 stddev:4.53 (6.2%) stddev-sans-first:4.12 07:54:56 INFO - PROCESS | 1941 | Values: 66.0 75.0 82.0 77.0 74.0 70.0 70.0 71.0 71.0 70.0 07:54:56 INFO - PROCESS | 1941 | 07:54:56 INFO - PROCESS | 1941 | [#10] stanford-crypto-aes Cycles:10 Average:92.60 Median:88.00 stddev:9.29 (10.6%) stddev-sans-first:9.70 07:54:56 INFO - PROCESS | 1941 | Values: 88.0 88.0 86.0 78.0 88.0 97.0 105.0 105.0 103.0 88.0 07:54:56 INFO - PROCESS | 1941 | 07:54:56 INFO - PROCESS | 1941 | [#11] stanford-crypto-ccm Cycles:10 Average:159.00 Median:155.00 stddev:21.52 (13.9%) stddev-sans-first:22.72 07:54:56 INFO - PROCESS | 1941 | Values: 153.0 137.0 168.0 153.0 144.0 148.0 162.0 153.0 215.0 157.0 07:54:56 INFO - PROCESS | 1941 | 07:54:56 INFO - PROCESS | 1941 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.30 Median:185.50 stddev:25.49 (13.7%) stddev-sans-first:26.81 07:54:56 INFO - PROCESS | 1941 | Values: 183.0 230.0 188.0 182.0 156.0 226.0 225.0 183.0 173.0 177.0 07:54:56 INFO - PROCESS | 1941 | 07:54:56 INFO - PROCESS | 1941 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.40 Median:84.00 stddev:8.06 (9.6%) stddev-sans-first:8.39 07:54:56 INFO - PROCESS | 1941 | Values: 73.0 84.0 84.0 86.0 86.0 72.0 67.0 67.0 71.0 84.0 07:54:56 INFO - PROCESS | 1941 | -------- Summary: end -------- 07:54:56 INFO - PROCESS | 1941 | 07:54:57 INFO - TEST-INFO | 1941: exit 0 07:54:57 INFO - TEST-OK | kraken | took 60886ms 07:54:57 INFO - SUITE-END | took 1181s 07:54:57 INFO - Completed test suite (00:19:41) 07:54:57 INFO - javascript benchmark 07:54:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3285.375778602067, 3308.999999999999, 3313.039218626598, 3327.068420842165, 3371.7471189660764, 5577.581681373893, 5649.632773869701, 5651.2653355063885, 5761.107028410593, 5778.50882674972, 5679.602427830054, 5709.685967271798, 5748.223989761381, 5803.071508558621, 5803.535717142629, 5164.561012313958, 5200.973995130019, 5233.973830130844, 5245.449227831061, 5245.7377131143485, 5164.483551644843, 5287.656302340336, 5306.442823503535, 5308.150695888658, 5325.760340784674, 5259.237410575445, 5280.260763493114, 5296.735163241842, 5312.681239125645, 5331.6534425262425, 5134.845954621367, 5197.168453047494, 5203.843884683428, 5207.765650545734, 5211.843644690665, 5194.454582268883, 5217.947820521784, 5246.816361427332, 5256.500632439912, 5258.07983602868, 5691.260136182311, 5708.828735137952, 5720.427957204288, 5764.51001664859, 5775.191473193756, 6075.33171351151, 6138.263408391022, 6142.938570614281, 6269.059641053833, 6291.1506946562085, 6101.725422356005, 6117.2184870185665, 6121.3572574879445, 6125.601835880653, 6142.481582551177, 5645.5483561314995, 5650.491455769001, 5650.886982260332, 5655.123455864347, 5676.347220069703, 6205.22434695663, 6236.469900058455, 6264.123022776815, 6277.654728989949, 6280.811575652738, 6007.339192688801, 6048.395160483917, 6102.481289090389, 6117.571769976148, 6122.846928826815, 6309.716062777186, 6309.936900631027, 6312.179416675895, 6321.399467050623, 6334.429901308904, 6191.102290167991, 6262.436380725665, 6264.091706702503, 6270.996640537492, 6290.685465726787, 6084.665343406155, 6108.068892179526, 6109.404666050415, 6164.599301045418, 6292.622442653455, 4868.221084626513, 4885.780139893714, 4901.730404827768, 4906.092372911023, 4906.435759887659, 4311.1808756336195, 4386.298192289219, 4435.35687325336, 4445.199864024442, 4447.043885564619, 5710.571707121982, 5721.370649228582, 5724.914126288109, 5725.427457254241, 5732.398098199712, 6199.132121502993, 6203.31763506014, 6206.0, 6206.937930620727, 6207.844803879939, 5675.347335056439, 5700.885982280414, 5702.116171993348, 5705.771769129188, 5711.6858572778065, 5339.46605339463, 5345.251664766935, 5359.062164121341, 5369.892602147936, 5373.086575282211, 6297.716602752796, 6303.3066362700065, 6312.053192021233, 6312.274088479791, 6326.746930122744, 6113.993245360445, 6168.722407491584, 6321.462675672436, 6324.778632747832, 6329.90505142414, 6106.642687876592, 6225.533085018732, 6231.626102433868, 6245.406686364788, 6309.274433440213, 6219.0, 6221.502279817694, 6236.6258024518675, 6238.064290356483, 6238.625682459067, 6135.9079613806725, 6326.6520341381665, 6329.778457753957, 6331.018692102732, 6338.809835704937, 5758.913616295675, 5958.910616340671, 5997.340292567901, 6006.549508786771, 6144.938550614436, 6103.176071230327, 6104.06507294887, 6121.117656725397, 6127.464420129145, 6140.688304616386, 5896.498797602252, 6001.3698561652145, 6003.549733770072, 6009.369016253405, 6054.8183554493435, 5950.553708471968, 5996.820095397145, 5998.430149135826, 6133.202683651097, 6144.907826382697, 5899.056151015817, 5911.763529458945, 5918.556108291809, 5919.556033297434, 5936.495397891227], "value": 5696.301243469138, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [437.7614200260858, 446.8949796797752, 488.4114641856562, 515.9200323949789, 523.5079025715827, 28190.0, 30366.089017329487, 31112.533312000338, 31151.532727009115, 31154.68845311546, 31719.841400793022, 32493.0, 39630.405543916866, 40605.79697101518, 40806.18387632246, 9194.44833310002, 9325.207357374631, 9346.57940392684, 9347.579358928864, 9347.766305842375, 9191.632334706605, 9344.159025687686, 9346.299027572959, 9356.532173391302, 9364.625414983426, 8435.072142064368, 8656.87014694777, 9365.48489833059, 11046.613368532104, 11257.887421125806, 11073.114150867912, 11142.0, 11147.219694621379, 11151.665450036511, 11163.386013769199, 9846.916839147689, 10996.670099897015, 11102.833457498144, 11116.833247501294, 11150.66548003553, 30334.696653033407, 30903.845480772452, 30930.0720978371, 31971.360572788646, 37413.0, 3326.567546218976, 3417.1457135716073, 3520.7359448041498, 3832.865849695247, 3957.406389041638, 28641.856790716123, 29354.412911741645, 29497.410051798845, 29505.704942950724, 29711.25721856949, 3168.8098714077228, 3178.920526986844, 3239.8704051838135, 3248.2366643838677, 3250.6099268087746, 470936.0, 472518.0, 474547.0, 475201.0, 475710.0, 57868.42131578714, 58229.126563101585, 58338.416615833296, 58440.896229716214, 58452.707736461045, 60537.69731151316, 60548.39451605428, 60603.69698151569, 60614.0, 60733.0, 15047.774283385757, 15426.84573154254, 15455.30451129702, 15459.458918937784, 15478.148701821508, 11987.400629968466, 12069.698257543456, 12075.939620301842, 12083.335416552174, 12090.0, 15922.76115858263, 16154.042259646461, 16199.785016123838, 16286.10426426558, 16304.51086467408, 4723.735520817759, 5422.620416570881, 6295.716692748837, 6304.716287767062, 6354.3010268870385, 830.9293710034715, 1053.931494452858, 1071.7481391872905, 1110.4558766204664, 1129.158776711339, 26963.460730785275, 27830.860845695643, 28672.42655146927, 28833.855830720713, 29621.0, 1011.8279892418307, 1037.4708898461838, 1103.4868786014542, 1128.8588926384202, 1141.6860363399965, 13013.934930325287, 13431.93284033593, 14446.349914253884, 14553.61740634638, 14870.256487175599, 578746.0, 587218.0, 593362.0, 595305.0, 598085.0, 56153.0, 56439.0, 56461.435385645615, 56488.43511564914, 56643.0, 1214.7813393589063, 1260.2942352282569, 1283.972821742621, 1330.0955350361846, 1342.275171407429, 28347.57478637781, 29722.0, 29861.70138298589, 30586.0, 30725.692743073178, 46990.53009469862, 47459.81350466128, 47538.76230618825, 47565.2004379191, 47575.762121189175, 498462.0, 499890.0, 507233.0, 507820.0, 510109.0, 24659.013639454937, 25704.0, 25811.0, 26376.4724705501, 26482.337941550846, 44488.55511444974, 44560.331595025455, 44972.0, 45297.54702452933, 45732.31401528913, 36340.45489317715, 36735.265294694495, 36812.815935920145, 37122.85687315839, 37775.43336849895, 36295.91112266636, 36762.81618591997, 37582.2483550322, 37745.43381849329, 37848.81075594604, 34674.65325346714, 35490.64509354976, 35931.64068359283, 36458.8177059113, 36545.0, 31725.682743172274, 32961.67038329586, 32987.835060824546, 32997.50503742398, 33045.0, 24033.918473669077, 24326.270211893672, 24435.87782061078, 24759.87620061888, 25133.994640214187], "value": 19025.72137934134, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.45136136266075, 365.9835307411166, 368.12753773556693, 379.59573054696745, 399.9860004899827, 14660.926695366521, 14896.553103406888, 15682.451114211019, 19942.302019429324, 20438.897805510987, 19400.611987760272, 19622.411327660157, 19644.116014779334, 20364.592708145865, 20470.2835400761, 5747.568932330071, 5847.766089356421, 6048.516118710515, 6056.091586262074, 6061.848453788646, 4620.676552641316, 5949.107633854935, 5992.400759924017, 5993.4006599340155, 6007.309159446654, 5623.690697011662, 5824.271966004249, 5867.823965281027, 5934.139549765303, 5941.821745347646, 5769.7692092316465, 5884.882302353972, 5904.232449781501, 5910.408959104056, 5914.674692891889, 4982.725950072744, 5065.910829171746, 5115.565176959963, 5142.84571462853, 5152.278680984665, 21721.0, 22004.559908801733, 22567.77432225673, 24458.0, 24868.005279788787, 2322.3497420722224, 2389.438481956739, 2629.7501737334924, 2980.657224419198, 3124.7500199983947, 14389.064710793766, 14833.406663733438, 15088.924555377263, 15267.236638168159, 15272.854535909852, 1756.8770186086979, 1821.1977915872321, 1853.508820162658, 1867.2810967777368, 1891.4609336339076, 102768.0, 103134.48432757863, 104456.0, 105632.94367056308, 106166.93833061648, 10176.491175441199, 10479.68560943173, 10507.474626268657, 10856.945715271531, 11304.434778261219, 13525.932370338282, 13541.526046588322, 13565.660858478617, 13575.759999600154, 13593.59219223425, 7949.0, 8219.589020549069, 8264.628091735887, 8357.540335281496, 8401.579921003926, 8264.256216940505, 8288.8342233155, 8290.378221633402, 8435.578221088921, 8456.450330728607, 5469.972650136724, 5738.110592858114, 6370.904436433457, 6490.188726409199, 6616.735330586723, 1704.6761115388038, 1765.267414023166, 1767.293082766878, 1767.5492749348834, 1782.8306310900443, 865.9350548708873, 877.3726785348379, 886.866969954499, 921.235374639048, 965.9130678238852, 20614.896925515277, 21047.05288262032, 21235.46911327198, 21632.35102946914, 21645.891770541046, 946.4463288976026, 952.224266263847, 964.782923842144, 965.6958058211782, 971.8677740432458, 10546.419946902994, 11443.37061461611, 11518.193726439236, 11543.595974140864, 11608.883911160949, 549694.0, 559097.0, 562511.0, 576068.0, 579967.0049492526, 98016.0, 108225.45887270513, 120311.0, 122049.0, 123027.15459267939, 970.6263088710756, 980.0640388429175, 1014.0164040880335, 1015.6140666546665, 1019.719577116299, 19218.55860810473, 19357.0, 19358.322458713876, 19409.51476213106, 19411.611767764847, 47531.28703069526, 51782.48217517776, 51873.0, 52869.0, 53718.46281537135, 73534.32328383453, 74692.0, 74996.0, 75115.24884751301, 75366.24633753592, 6163.506919446523, 7872.527648341118, 7927.12801591836, 8016.83966320682, 8124.715634952749, 10979.670609881716, 12905.806412903627, 13025.739485210053, 13173.868261317648, 13348.332583370986, 11014.779704406028, 11246.100311975186, 11493.597724079616, 11498.885011150116, 11525.538978440769, 11054.613088542184, 11190.888091118984, 11219.831702524632, 11530.59642912494, 11574.421278936188, 8820.5589720515, 11374.033207177483, 11485.253458525169, 11589.956903878692, 11896.405179740805, 7846.489978151402, 7944.7685608730735, 8218.096009439076, 11449.370284634091, 11643.118525091943, 10658.8401173984, 11192.832107518556, 11376.033037191932, 11742.295462272292, 12035.217710848767], "value": 9582.66244692048, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.3141850528466, 1427.2078996157131, 1444.147952707902, 1620.5057457475473, 1832.7159290310008, 7294.927050729491, 7638.350740187084, 7897.249761272684, 8123.025236971557, 8131.105578386373, 8038.959805200981, 8112.5943702814775, 8129.634166462509, 8133.349332053436, 8139.308158806509, 2044.1925439451409, 2258.706368172135, 2300.723913130427, 2302.9884850575722, 2308.595995700754, 2119.6926445665445, 2255.548890221954, 2331.184085570054, 2336.9532609347802, 2347.8826058696995, 2264.377296243538, 2287.656851472284, 2298.793108620224, 2299.7240331160283, 2300.459392042869, 2277.87471689057, 2303.5968705476644, 2304.0, 2304.827137964651, 2304.9884750576307, 2286.0969916882736, 2326.139328448468, 2327.150590034642, 2328.7787660172257, 2329.5457385809773, 8122.553259570721, 8145.674173033071, 8211.753647390588, 8230.09468958414, 8240.299574536171, 4991.800327986876, 5155.200943853709, 5162.148245539519, 5182.559482443997, 5192.039472697563, 3000.4449176902126, 3190.744740420761, 3468.8265586720813, 3490.127468132967, 3493.074335301147, 1007.7833265847878, 1052.7157667429829, 1081.5241293830768, 1087.478010554938, 1092.7650555130685, 10603.045725884707, 10612.097971672418, 10613.36319820821, 10618.522166502526, 10647.94676026615, 4452.465704115527, 4618.976905115453, 4673.112108699336, 4694.95305046952, 4778.4982576829625, 8379.664813407517, 8517.914820851836, 8547.40168188221, 8562.443441176303, 8580.871286930702, 5020.49795020495, 5045.41977672565, 5053.1157047516535, 5054.898902021939, 5066.417362003417, 4222.514410842731, 4368.563143685606, 4501.144782491317, 4641.512641172696, 4742.312364707098, 3359.882404115844, 3414.607320158164, 3593.885895372443, 3647.5592141104116, 3756.267527832101, 1214.738831151289, 1247.108317552936, 1250.1249125612107, 1263.1726219326356, 1269.8285731426324, 828.6975254032355, 851.1616058182685, 874.6807415293499, 883.726044926075, 932.1424289653535, 5307.28351672527, 5347.278117454094, 5578.442155784389, 5785.392533783892, 5804.0, 949.378157306965, 969.3021024862088, 972.1105188752213, 972.7811242470387, 976.5068640336584, 3555.1112221944513, 3587.01357126787, 3712.3688972874675, 3757.1922036762226, 3884.1260716338597, 8748.387612867165, 9387.295952803566, 9442.669506567237, 9817.950910245403, 9844.80310393788, 9291.581878815334, 9581.808363832684, 9713.854292185622, 9727.319087663796, 9735.65925192629, 7449.255074492507, 7646.655900484491, 7657.961710191414, 7666.769996900102, 7671.347935425551, 5398.811041613525, 5433.185022246536, 5461.077366923629, 5794.420557944172, 5897.321807992136, 8742.912570874465, 9089.363744538083, 9112.95443522778, 9256.861147082935, 9269.073092690676, 8639.13608639131, 8968.955155224183, 9128.863067054132, 9326.906730932604, 9383.436993780395, 6947.40947019509, 7028.8594228114125, 7053.294670532906, 7079.008938748476, 7089.82275443118, 7004.0, 7241.275872412927, 7252.0, 7401.48189626721, 7638.656260468181, 6909.032735416945, 6919.6886140124825, 6920.307969203241, 6980.0, 7096.680649370894, 6839.384455399038, 6863.176418829573, 6872.037914691847, 6922.411595014279, 7022.262662420577, 6404.719056188874, 6469.708863101077, 6548.83627909287, 6583.934160658332, 6585.670716464062, 4145.274576949082, 4789.137955168103, 4797.904041919072, 4842.104210721028, 4911.8280860169725, 4722.811087556596, 4741.691790033637, 4792.3530323407285, 4856.368672072749, 4993.15116430215], "value": 4323.661756088795, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.6106997158794, 293.55379822669545, 297.1501505693716, 310.9595752552169, 314.818979087025, 4381.978090109553, 4575.862724118273, 5111.642185047043, 5254.691153254333, 5286.788528458857, 4548.067646132543, 4906.828261010865, 5138.922916156261, 5194.298769666094, 5230.555402790757, 4040.515138183422, 4056.655184309337, 4059.416827437287, 4060.20825938942, 4072.8370865165357, 3403.0981789825714, 3557.804320762357, 3730.2912446635187, 4065.7357271777387, 4093.44738460307, 3810.3522401191863, 3904.297226499229, 3957.0503079261057, 4038.838446462138, 4047.494063242095, 3999.4000899864964, 4006.939895901564, 4010.57360297019, 4032.173404452095, 4047.372657238133, 2787.4982503149427, 3484.5470088888537, 3519.9120021999397, 3531.5408996830247, 3533.787972721619, 4239.922438005356, 4467.843625473125, 4885.462599114095, 5120.871978200537, 5122.154844450699, 3819.2743378757946, 4145.233131870614, 4480.439945006874, 4524.570165834273, 4547.977260113711, 4643.837465688718, 4851.442084160296, 5172.6379153459275, 5187.5071868172845, 5197.610179236573, 3358.412277851366, 3640.2355505343908, 3745.0, 3770.5663848657205, 3773.396256598931, 5452.345718513804, 5505.587080968903, 5653.293338332708, 5742.6841523716175, 5770.6249093808765, 3158.0525842247234, 3455.3262113888054, 3541.451075083366, 3735.869244576427, 3794.1083845296334, 3866.729328947003, 3878.2825177342283, 3886.8250928708276, 3908.5309762828642, 3913.5695073541888, 3453.067671728619, 3506.9298614027575, 4059.939100913489, 4557.453105627346, 4627.444706635158, 4543.136804007294, 4852.4662287148385, 5021.447640759587, 5282.52457278839, 5514.704044549528, 1073.2540884085486, 1125.622916323041, 1166.9963831105242, 1171.7597892432202, 1202.5971299614553, 809.6113865344549, 849.8329260385991, 857.0, 857.0358346859783, 860.8149247911729, 4223.704340696122, 4916.0905232532095, 4925.827596034122, 4980.77586508608, 4985.725785081783, 4587.9082418351445, 5386.784528618811, 5399.325084364455, 5407.728324363782, 5427.1045277528765, 4295.763732994716, 4591.150637132141, 4851.587615052689, 4882.511748825089, 4897.534734200317, 2816.5915942188267, 2824.477471667748, 2863.2555535560487, 2876.856157192132, 2877.309445733051, 4716.1510928033285, 4998.725070121178, 5134.973005398935, 5451.18417108026, 5664.830055098354, 4713.505081966344, 5130.460861741462, 5215.374155101336, 5573.386927437979, 5640.351359593617, 4664.207084795593, 5292.824305416796, 5669.518090962314, 5669.943300566942, 5713.485786279255, 4678.812847486062, 5076.873078173076, 5112.258722485293, 5509.3664228612615, 5537.0, 4823.879403014953, 4878.487758785418, 5037.672551284155, 5381.654586353412, 5413.945860541344, 4800.7359595221205, 5406.945930540644, 5632.634293596618, 5666.025336698266, 5775.566832487496, 3149.008062460318, 3398.796072235674, 3742.5321834770652, 3927.823247953792, 3989.9800500997308, 5336.573074153981, 5424.335071838137, 5467.371252306036, 5766.106253530709, 5769.0, 5090.389153301628, 5409.621326507264, 5428.99127322893, 5538.861528461821, 5602.515333436561, 4531.388262584641, 5521.282233309644, 5527.512619321402, 5541.7808082221845, 5562.605541622073, 4593.1627349060645, 5378.596605254544, 5390.434004429479, 5415.512603865671, 5425.267588875609, 4900.803967841389, 5166.8966620668125, 5500.22996780443, 5501.339839219319, 5502.9174562382395, 5389.167682987803, 5416.21464887597, 5420.186971954238, 5430.782768689208, 5433.5924805640525], "value": 3917.669674561407, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.7670507085198, 742.5173637135861, 760.1828034862523, 788.2826627768732, 789.3803364358978, 15139.848601513995, 15822.129782861937, 15823.0, 15838.049717016987, 15840.683186336266, 13441.193528388303, 13522.526711565097, 13533.864661353384, 13537.255450950193, 13559.661008474794, 651.4983462733692, 679.5073571660531, 681.7239018197638, 805.4080251015499, 828.1883753921146, 846.8137009857821, 848.0798333807826, 848.6308455821737, 851.6082602003086, 851.8679604661256, 891.393852180517, 901.2339511415278, 901.9864702029442, 902.057350069176, 905.3798148268457, 893.6648756716231, 896.6951236579595, 897.4166791585488, 899.757065592293, 902.9774255643596, 510.4895104895105, 533.679792124726, 633.5375176121411, 662.4336192555344, 665.1984358847577, 14310.49913253031, 14878.256087195598, 14893.404263829541, 14903.329350179269, 14930.0, 13618.319084045757, 13721.0, 13800.240986745725, 13842.169469831742, 13988.650283742885, 12325.131213953578, 12475.500979960882, 12531.624051278477, 12707.110502264844, 12978.87021129786, 3914.921701565981, 4327.112941846914, 4387.451568553931, 4445.955540444619, 4454.398656181439, 89216.10783892142, 103095.48452257691, 103871.48064259706, 106290.0, 113177.0, 10607.681769546925, 10677.092447141924, 10803.351798892092, 11050.557977680803, 11324.94337528307, 21298.893505532684, 21664.0, 21671.56656866854, 21839.78160218409, 21950.341489755334, 7581.12817026038, 7594.202608726115, 7636.847263054708, 7705.499142555828, 7779.588327618457, 3586.802725850051, 4168.812403441852, 4230.598093181143, 4399.36209249657, 4419.779011049434, 3338.1320856577463, 3450.0, 3450.102973226979, 3452.154222215573, 3453.8273086346085, 643.453064894845, 662.4402379988902, 675.7702381190419, 696.864111498253, 699.1854489519754, 558.9092319473239, 591.2195901410183, 618.1932577985772, 633.47105167185, 656.8226578823691, 8713.215810577078, 9052.909470905206, 9339.766505837408, 9415.0, 9795.363301385387, 555.5250261026845, 596.3708287756458, 639.8752243312603, 661.8186537031376, 681.5501768832547, 4526.705764125321, 4527.456705195397, 4533.5013148553635, 4533.909321813611, 4633.907321853544, 103704.48147759213, 106668.0, 106791.0, 107042.0, 107692.46153769181, 93159.0, 96295.0, 96402.51798740962, 98436.50781746188, 98533.0, 80046.59976700196, 82502.0, 82713.58643206865, 84320.57839710762, 86266.98065567674, 8850.955745221232, 8861.335399845166, 8875.201231888903, 8944.955275223581, 8990.86513702282, 50700.0, 52368.47631523789, 54832.17751733647, 55811.0, 56332.718336408056, 66468.0, 77902.0, 79811.60094199491, 81499.77750333869, 81644.59177704074, 11688.94155529217, 11821.468033938665, 11925.940370298093, 12065.215760975509, 12170.634880953585, 12901.612951611467, 13090.410931508295, 13442.0, 13568.660783480493, 13669.79495307591, 11844.881551184379, 12341.3829308536, 12397.93801030989, 12422.565210217599, 12641.3679316032, 11743.0, 11879.940600296943, 11881.5841445549, 12157.331346776013, 12597.622071337875, 11628.244164129643, 11907.76184476323, 12007.339596322287, 12038.458269378074, 12443.93778031104, 9743.512824358895, 10093.69718908434, 10165.44090075053, 10168.84746728785, 10599.311044782064, 10106.747331316776, 10396.0, 10451.634192803216, 10493.527791249564, 10510.159187265153], "value": 7345.666344277234, "unit": "score"}], "name": "dromaeo_css", "value": 7110.4412759947145, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0, 115.0, 114.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 115.0, 114.0, 152.0, 115.0, 115.0, 111.0, 107.0, 133.0, 113.0], "value": 122.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 185.0, 185.0, 186.0, 181.0, 182.0, 185.0, 185.0, 188.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 58.0, 87.0, 52.0, 51.0, 58.0, 48.0, 73.0, 74.0], "value": 64.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 84.0, 70.0, 68.0, 69.0, 82.0, 68.0, 69.0, 106.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 87.0, 90.0, 85.0, 90.0, 87.0, 89.0, 86.0], "value": 87.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 101.0], "value": 95.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 87.0, 85.0, 88.0, 89.0, 86.0, 85.0, 85.0, 85.0], "value": 86.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 55.0, 54.0, 53.0, 54.0, 56.0, 54.0, 54.0, 55.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 75.0, 82.0, 77.0, 74.0, 70.0, 70.0, 71.0, 71.0, 70.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 86.0, 78.0, 88.0, 97.0, 105.0, 105.0, 103.0, 88.0], "value": 92.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 137.0, 168.0, 153.0, 144.0, 148.0, 162.0, 153.0, 215.0, 157.0], "value": 159.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 230.0, 188.0, 182.0, 156.0, 226.0, 225.0, 183.0, 173.0, 177.0], "value": 192.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 84.0, 84.0, 86.0, 86.0, 72.0, 67.0, 67.0, 71.0, 84.0], "value": 77.4, "unit": "score"}], "name": "kraken", "value": 1479.3, "alertThreshold": 2.0}]} 07:54:57 INFO - Return code: 0 07:54:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:54:57 INFO - # TBPL SUCCESS # 07:54:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:54:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:54:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:54:57 INFO - 2016-11-28 07:54:57.662 screenresolution[1945:19462] starting screenresolution argv=screenresolution get 07:54:57 INFO - 2016-11-28 07:54:57.666 screenresolution[1945:19462] Display 0: 1600x1200x32@60 07:54:57 INFO - 2016-11-28 07:54:57.672 screenresolution[1946:19465] starting screenresolution argv=screenresolution list 07:54:57 INFO - Available Modes on Display 0 07:54:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:54:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:54:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:54:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:54:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:54:57 INFO - Intel Iris: 07:54:57 INFO - Chipset Model: Intel Iris 07:54:57 INFO - Type: GPU 07:54:57 INFO - Bus: Built-In 07:54:57 INFO - VRAM (Dynamic, Max): 1536 MB 07:54:57 INFO - Vendor: Intel (0x8086) 07:54:57 INFO - Device ID: 0x0a2e 07:54:57 INFO - Revision ID: 0x0009 07:54:57 INFO - Displays: 07:54:57 INFO - Display: 07:54:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:54:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:54:57 INFO - Display Serial Number: 1600x1200 60 07:54:57 INFO - Main Display: Yes 07:54:57 INFO - Mirror: Off 07:54:57 INFO - Online: Yes 07:54:57 INFO - Rotation: Supported 07:54:57 INFO - Return code: 0 07:54:57 INFO - Running post-action listener: _resource_record_post_action 07:54:57 INFO - [mozharness: 2016-11-28 15:54:57.913833Z] Finished run-tests step (success) 07:54:57 INFO - Running post-run listener: _resource_record_post_run 07:54:57 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 581632; Write bytes: 694514176; Read time: 6; Write time: 1988 07:54:57 INFO - TinderboxPrint: CPU usage
54.0% 07:54:57 INFO - TinderboxPrint: I/O read bytes / time
581,632 / 6 07:54:57 INFO - TinderboxPrint: I/O write bytes / time
694,514,176 / 1,988 07:54:57 INFO - TinderboxPrint: CPU idle
2,236.4 (46.0%) 07:54:57 INFO - TinderboxPrint: CPU system
983.0 (20.2%) 07:54:57 INFO - TinderboxPrint: CPU user
1,642.3 (33.8%) 07:54:57 INFO - TinderboxPrint: Swap in / out
383,602,688 / 0 07:54:57 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 384340480; Write bytes: 386147840; Read time: 28864; Write time: 832 07:54:57 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 532480; Write bytes: 305370112; Read time: 4; Write time: 1139 07:54:58 INFO - Running post-run listener: _upload_blobber_files 07:54:58 INFO - Blob upload gear active. 07:54:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:54:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:54:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:54:58 INFO - (blobuploader) - INFO - Open directory for files ... 07:54:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:54:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:54:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:54:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:54:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:54:59 INFO - (blobuploader) - INFO - Done attempting. 07:54:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:54:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:54:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:55:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:00 INFO - (blobuploader) - INFO - Done attempting. 07:55:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:55:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:55:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:55:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:55:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:55:03 INFO - (blobuploader) - INFO - Done attempting. 07:55:03 INFO - (blobuploader) - INFO - Iteration through files over. 07:55:03 INFO - Return code: 0 07:55:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:55:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:55:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/3331ac9781c0d8da24dbff5ae393ce3c64f04184a53517d0b95e109666b3047ccba9ddef0bc053d55351d412e2041cb0edf6acca1c8772393d07cd24680dcbe0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/098928aba3268c0a5c49bbc3dc458b1a65a95cc3499630ef2573b1b11cecad2b0b25e305942fe4a232a10acca69c77ae21e1cc3092be43793981808a802fcdcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/1d92651f603eee2ef2d25f9a01018b45642e5a7d9fbabdd386b272bc141952df706fbb4db9cd17846eab422c8e43efef27e9dc348ca55753f5b3f136bfe238af"} 07:55:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:55:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:55:03 INFO - Contents: 07:55:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/3331ac9781c0d8da24dbff5ae393ce3c64f04184a53517d0b95e109666b3047ccba9ddef0bc053d55351d412e2041cb0edf6acca1c8772393d07cd24680dcbe0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/098928aba3268c0a5c49bbc3dc458b1a65a95cc3499630ef2573b1b11cecad2b0b25e305942fe4a232a10acca69c77ae21e1cc3092be43793981808a802fcdcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/1d92651f603eee2ef2d25f9a01018b45642e5a7d9fbabdd386b272bc141952df706fbb4db9cd17846eab422c8e43efef27e9dc348ca55753f5b3f136bfe238af"} 07:55:03 INFO - Running post-run listener: copy_logs_to_upload_dir 07:55:03 INFO - Copying logs to upload dir... 07:55:03 INFO - mkdir: /builds/slave/test/build/upload/logs 07:55:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.426882 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-11-28 07:55:03.660803) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 07:55:03.665856) ========= 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.T333ZICk3z/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.t9rhY8mzee/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/3331ac9781c0d8da24dbff5ae393ce3c64f04184a53517d0b95e109666b3047ccba9ddef0bc053d55351d412e2041cb0edf6acca1c8772393d07cd24680dcbe0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/098928aba3268c0a5c49bbc3dc458b1a65a95cc3499630ef2573b1b11cecad2b0b25e305942fe4a232a10acca69c77ae21e1cc3092be43793981808a802fcdcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/1d92651f603eee2ef2d25f9a01018b45642e5a7d9fbabdd386b272bc141952df706fbb4db9cd17846eab422c8e43efef27e9dc348ca55753f5b3f136bfe238af"} build_url:https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010261 build_url: 'https://queue.taskcluster.net/v1/task/B9y-3gLCRvi8Z3K1XyGB_A/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/3331ac9781c0d8da24dbff5ae393ce3c64f04184a53517d0b95e109666b3047ccba9ddef0bc053d55351d412e2041cb0edf6acca1c8772393d07cd24680dcbe0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/098928aba3268c0a5c49bbc3dc458b1a65a95cc3499630ef2573b1b11cecad2b0b25e305942fe4a232a10acca69c77ae21e1cc3092be43793981808a802fcdcf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/1d92651f603eee2ef2d25f9a01018b45642e5a7d9fbabdd386b272bc141952df706fbb4db9cd17846eab422c8e43efef27e9dc348ca55753f5b3f136bfe238af"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 07:55:03.702067) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 07:55:03.702410) ========= 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.T333ZICk3z/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.t9rhY8mzee/Listeners TMPDIR=/var/folders/7s/mgsnjszs56ld075hs__4729c00000w/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.005103 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 07:55:03.751098) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 07:55:03.754443) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 07:55:03.754774) ========= ========= Total master_lag: 0.21 =========