builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0220 starttime: 1475761353.75 results: success (0) buildid: 20161006041003 builduid: fcd1b113dbab46e1b7790fa553d58144 revision: 993bd0c52f8addd18cdf4163acd645e51090c679 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 06:42:33.749820) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 06:42:33.750296) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 06:42:33.750629) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 06:42:33.778805) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 06:42:33.779188) ========= 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.ckcuF8X9b1/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.26w1t1Emov/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-06 06:42:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.1M=0.001s 2016-10-06 06:42:33 (18.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153220 ========= master_lag: 0.48 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 06:42:34.411110) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 06:42:34.411543) ========= 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.ckcuF8X9b1/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.26w1t1Emov/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.026100 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 06:42:34.460798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 06:42:34.461328) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 993bd0c52f8addd18cdf4163acd645e51090c679 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 993bd0c52f8addd18cdf4163acd645e51090c679 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ckcuF8X9b1/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.26w1t1Emov/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-06 06:42:34,543 truncating revision to first 12 chars 2016-10-06 06:42:34,543 Setting DEBUG logging. 2016-10-06 06:42:34,543 attempt 1/10 2016-10-06 06:42:34,543 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/993bd0c52f8a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 06:42:35,569 unpacking tar archive at: fx-team-993bd0c52f8a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.319695 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 06:42:35.803969) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 06:42:35.804364) ========= script_repo_revision: 993bd0c52f8addd18cdf4163acd645e51090c679 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 06:42:35.804814) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 06:42:35.805125) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 06:42:35.824391) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-06 06:42:35.824807) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ckcuF8X9b1/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.26w1t1Emov/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 06:42:36 INFO - MultiFileLogger online at 20161006 06:42:36 in /builds/slave/test 06:42:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:42:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:42:36 INFO - {'append_to_log': False, 06:42:36 INFO - 'base_work_dir': '/builds/slave/test', 06:42:36 INFO - 'blob_upload_branch': 'Fx-Team', 06:42:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:42:36 INFO - 'branch': 'Fx-Team', 06:42:36 INFO - 'buildbot_json_path': 'buildprops.json', 06:42:36 INFO - 'config_files': ('talos/mac_config.py',), 06:42:36 INFO - 'default_actions': ('clobber', 06:42:36 INFO - 'read-buildbot-config', 06:42:36 INFO - 'download-and-extract', 06:42:36 INFO - 'populate-webroot', 06:42:36 INFO - 'create-virtualenv', 06:42:36 INFO - 'install', 06:42:36 INFO - 'run-tests'), 06:42:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:42:36 INFO - 'download_minidump_stackwalk': True, 06:42:36 INFO - 'download_symbols': 'ondemand', 06:42:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:42:36 INFO - 'tooltool.py': '/tools/tooltool.py', 06:42:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:42:36 INFO - '/tools/misc-python/virtualenv.py')}, 06:42:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:42:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:42:36 INFO - 'installer_path': 'installer.exe', 06:42:36 INFO - 'log_level': 'info', 06:42:36 INFO - 'log_name': 'talos', 06:42:36 INFO - 'log_to_console': True, 06:42:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:42:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:42:36 INFO - 'opt_config_files': (), 06:42:36 INFO - 'pip_index': False, 06:42:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:42:36 INFO - 'cmd': ('bash', 06:42:36 INFO - '-c', 06:42:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:42:36 INFO - 'enabled': True, 06:42:36 INFO - 'halt_on_failure': False, 06:42:36 INFO - 'name': 'check_screen_resolution'},), 06:42:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:42:36 INFO - 'cmd': ('bash', 06:42:36 INFO - '-c', 06:42:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:42:36 INFO - 'enabled': True, 06:42:36 INFO - 'halt_on_failure': False, 06:42:36 INFO - 'name': 'check_screen_resolution'},), 06:42:36 INFO - 'run_cmd_checks_enabled': True, 06:42:36 INFO - 'sps_profile': False, 06:42:36 INFO - 'sps_profile_interval': 0, 06:42:36 INFO - 'suite': 'dromaeojs-e10s', 06:42:36 INFO - 'system_bits': '32', 06:42:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:42:36 INFO - 'title': 't-yosemite-r7-0220', 06:42:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:42:36 INFO - 'use_talos_json': True, 06:42:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:42:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:42:36 INFO - 'work_dir': 'build'} 06:42:36 INFO - [mozharness: 2016-10-06 13:42:36.042721Z] Running clobber step. 06:42:36 INFO - Running pre-action listener: _resource_record_pre_action 06:42:36 INFO - Running main action method: clobber 06:42:36 INFO - rmtree: /builds/slave/test/build 06:42:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:42:38 INFO - Running post-action listener: _resource_record_post_action 06:42:38 INFO - [mozharness: 2016-10-06 13:42:38.287897Z] Finished clobber step (success) 06:42:38 INFO - [mozharness: 2016-10-06 13:42:38.288024Z] Running read-buildbot-config step. 06:42:38 INFO - Running pre-action listener: _resource_record_pre_action 06:42:38 INFO - Running main action method: read_buildbot_config 06:42:38 INFO - Using buildbot properties: 06:42:38 INFO - { 06:42:38 INFO - "project": "", 06:42:38 INFO - "product": "firefox", 06:42:38 INFO - "script_repo_revision": "production", 06:42:38 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 06:42:38 INFO - "repository": "", 06:42:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 06:42:38 INFO - "buildid": "20161006041003", 06:42:38 INFO - "pgo_build": "False", 06:42:38 INFO - "basedir": "/builds/slave/test", 06:42:38 INFO - "buildnumber": 793, 06:42:38 INFO - "slavename": "t-yosemite-r7-0220", 06:42:38 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:42:38 INFO - "platform": "yosemite_r7", 06:42:38 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 06:42:38 INFO - "branch": "fx-team", 06:42:38 INFO - "repo_path": "integration/fx-team", 06:42:38 INFO - "revision": "993bd0c52f8addd18cdf4163acd645e51090c679", 06:42:38 INFO - "stage_platform": "macosx64", 06:42:38 INFO - "builduid": "fcd1b113dbab46e1b7790fa553d58144", 06:42:38 INFO - "slavebuilddir": "test" 06:42:38 INFO - } 06:42:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 06:42:38 INFO - Running post-action listener: _resource_record_post_action 06:42:38 INFO - [mozharness: 2016-10-06 13:42:38.291420Z] Finished read-buildbot-config step (success) 06:42:38 INFO - [mozharness: 2016-10-06 13:42:38.291531Z] Running download-and-extract step. 06:42:38 INFO - Running pre-action listener: _resource_record_pre_action 06:42:38 INFO - Running main action method: download_and_extract 06:42:38 INFO - mkdir: /builds/slave/test/build/tests 06:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:42:38 INFO - trying https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 06:42:38 INFO - Downloading https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:42:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 06:42:39 INFO - Downloaded 1199 bytes. 06:42:39 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:42:39 INFO - Using the following test package requirements: 06:42:39 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:42:39 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:42:39 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 06:42:39 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:42:39 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 06:42:39 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:42:39 INFO - u'jsshell-mac.zip'], 06:42:39 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:42:39 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 06:42:39 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:42:39 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:42:39 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 06:42:39 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:42:39 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 06:42:39 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:42:39 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 06:42:39 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:42:39 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 06:42:39 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:42:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:42:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:42:39 INFO - Fetch https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:42:39 INFO - Http code: 200 06:42:39 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 06:42:39 INFO - x-amz-cf-id: Mrc-Z5tqQt1e0MISNw3PRKh1vzaFmTpPhPybcKfCFJ-Bebf_KRmLNg== 06:42:39 INFO - x-amz-version-id: ECAvNlXJTfqPU_McJ5joWXkjY7vPWt0m 06:42:40 INFO - Expected file size: 16478308 06:42:40 INFO - Obtained file size: 16478308 06:42:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:42:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:42:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:42:46 INFO - Fetch https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:42:47 INFO - Http code: 200 06:42:47 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 06:42:47 INFO - x-amz-cf-id: lmitu2dq3VitFrL-jx5mwUtUdp2EcGo7GPlxz8oduNPg56ihrY0PDA== 06:42:47 INFO - x-amz-version-id: ECAvNlXJTfqPU_McJ5joWXkjY7vPWt0m 06:42:47 INFO - Expected file size: 16478308 06:42:47 INFO - Obtained file size: 16478308 06:42:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 06:42:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:42:53 INFO - Fetch https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 06:42:54 INFO - Http code: 200 06:42:54 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 06:42:54 INFO - x-amz-cf-id: 2BoSOQRl3COhanf3dTtu5gSW7mCVPGp7dimax86JrrKcwZ5LJPFoLQ== 06:42:54 INFO - x-amz-version-id: v9Ymh0OKDxR5UJMNqnwnPNpb0V3WxK5T 06:42:55 INFO - Expected file size: 14409006 06:42:55 INFO - Obtained file size: 14409006 06:42:55 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')]} 06:42:55 INFO - trying https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:42:55 INFO - Downloading https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 06:42:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 06:42:58 INFO - Downloaded 111659133 bytes. 06:42:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:42:58 INFO - mkdir: /builds/slave/test/properties 06:42:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:42:58 INFO - Writing to file /builds/slave/test/properties/build_url 06:42:58 INFO - Contents: 06:42:58 INFO - build_url:https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:42:58 INFO - Running post-action listener: _resource_record_post_action 06:42:58 INFO - Running post-action listener: set_extra_try_arguments 06:42:58 INFO - [mozharness: 2016-10-06 13:42:58.923468Z] Finished download-and-extract step (success) 06:42:58 INFO - [mozharness: 2016-10-06 13:42:58.923601Z] Running populate-webroot step. 06:42:58 INFO - Running pre-action listener: _resource_record_pre_action 06:42:58 INFO - Running main action method: populate_webroot 06:42:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:42:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:42:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:42:58 INFO - '--tppagecycles', 06:42:58 INFO - '7'], 06:42:58 INFO - 'tests': ['tsvgm']}}, 06:42:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:42:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:42:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:42:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:42:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:58 INFO - 'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:42:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:42:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:58 INFO - 'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['damp', 'tps']}, 06:42:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:58 INFO - 'tests': ['damp', 'tps']}, 06:42:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['dromaeo_dom']}, 06:42:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:42:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['basic_compositor_video']}, 06:42:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:42:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['a11yr', 06:42:58 INFO - 'ts_paint', 06:42:58 INFO - 'tpaint', 06:42:58 INFO - 'sessionrestore', 06:42:58 INFO - 'sessionrestore_no_auto_restore', 06:42:58 INFO - 'tabpaint']}, 06:42:58 INFO - 'other-e10s': {'tests': ['a11yr', 06:42:58 INFO - 'ts_paint', 06:42:58 INFO - 'tpaint', 06:42:58 INFO - 'sessionrestore', 06:42:58 INFO - 'sessionrestore_no_auto_restore', 06:42:58 INFO - 'tabpaint']}, 06:42:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:42:58 INFO - 'ts_paint', 06:42:58 INFO - 'tpaint', 06:42:58 INFO - 'sessionrestore', 06:42:58 INFO - 'sessionrestore_no_auto_restore', 06:42:58 INFO - 'tabpaint']}, 06:42:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:42:58 INFO - 'ts_paint', 06:42:58 INFO - 'tpaint', 06:42:58 INFO - 'sessionrestore', 06:42:58 INFO - 'sessionrestore_no_auto_restore', 06:42:58 INFO - 'tabpaint']}, 06:42:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['a11yr', 06:42:58 INFO - 'ts_paint', 06:42:58 INFO - 'tpaint', 06:42:58 INFO - 'sessionrestore', 06:42:58 INFO - 'sessionrestore_no_auto_restore', 06:42:58 INFO - 'tabpaint']}, 06:42:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['a11yr', 06:42:58 INFO - 'ts_paint', 06:42:58 INFO - 'tpaint', 06:42:58 INFO - 'sessionrestore', 06:42:58 INFO - 'sessionrestore_no_auto_restore', 06:42:58 INFO - 'tabpaint']}, 06:42:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['tsvgx', 06:42:58 INFO - 'tsvgr_opacity', 06:42:58 INFO - 'tart', 06:42:58 INFO - 'tscrollx', 06:42:58 INFO - 'cart']}, 06:42:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:42:58 INFO - 'tsvgr_opacity', 06:42:58 INFO - 'tart', 06:42:58 INFO - 'tscrollx', 06:42:58 INFO - 'cart']}, 06:42:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:58 INFO - 'talos_options': ['--disable-e10s'], 06:42:58 INFO - 'tests': ['tp5o']}, 06:42:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:58 INFO - 'tests': ['tp5o']}, 06:42:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:58 INFO - 'talos_options': ['--disable-e10s', 06:42:58 INFO - '--xperf_path', 06:42:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:42:58 INFO - 'tests': ['tp5n']}, 06:42:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:42:58 INFO - 'talos_options': ['--xperf_path', 06:42:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:42:58 INFO - 'tests': ['tp5n']}}, 06:42:58 INFO - 'talos.zip': {'path': '', 06:42:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:42:58 INFO - Running post-action listener: _resource_record_post_action 06:42:58 INFO - [mozharness: 2016-10-06 13:42:58.942303Z] Finished populate-webroot step (success) 06:42:58 INFO - [mozharness: 2016-10-06 13:42:58.942434Z] Running create-virtualenv step. 06:42:58 INFO - Running pre-action listener: _resource_record_pre_action 06:42:58 INFO - Running main action method: create_virtualenv 06:42:58 INFO - Creating virtualenv /builds/slave/test/build/venv 06:42:58 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 06:42:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:42:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:42:59 INFO - Using real prefix '/tools/python27' 06:42:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:42:59 INFO - Installing distribute.............................................................................................................................................................................................done. 06:43:02 INFO - Installing pip.................done. 06:43:02 INFO - Return code: 0 06:43:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:43:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:43:02 INFO - Reading from file tmpfile_stdout 06:43:02 INFO - Output received: 06:43:02 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) 06:43:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:43:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:02 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 0x108107490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10807d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81eb58d010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f1bd30>, '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 0x107d41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f13b20>, '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.ckcuF8X9b1/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.26w1t1Emov/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 06:43:02 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 06:43:02 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 06:43:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ckcuF8X9b1/Render', 06:43:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:43:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:43:02 INFO - 'HOME': '/Users/cltbld', 06:43:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:43:02 INFO - 'LOGNAME': 'cltbld', 06:43:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:02 INFO - 'MOZ_NO_REMOTE': '1', 06:43:02 INFO - 'NO_EM_RESTART': '1', 06:43:02 INFO - 'PAGER': '/bin/cat', 06:43:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:43:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:02 INFO - 'PWD': '/builds/slave/test', 06:43:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:43:02 INFO - 'SHELL': '/bin/bash', 06:43:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.26w1t1Emov/Listeners', 06:43:02 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 06:43:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:43:02 INFO - 'USER': 'cltbld', 06:43:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:43:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:43:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:02 INFO - 'XPC_FLAGS': '0x0', 06:43:02 INFO - 'XPC_SERVICE_NAME': '0', 06:43:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:03 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 06:43:03 INFO - Cleaning up... 06:43:03 INFO - Return code: 0 06:43:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:43: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')]} 06:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43: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')]} 06:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:03 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 0x108107490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10807d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81eb58d010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f1bd30>, '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 0x107d41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f13b20>, '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.ckcuF8X9b1/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.26w1t1Emov/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 06:43:03 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 06:43:03 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 06:43:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ckcuF8X9b1/Render', 06:43:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:43:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:43:03 INFO - 'HOME': '/Users/cltbld', 06:43:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:43:03 INFO - 'LOGNAME': 'cltbld', 06:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:03 INFO - 'MOZ_NO_REMOTE': '1', 06:43:03 INFO - 'NO_EM_RESTART': '1', 06:43:03 INFO - 'PAGER': '/bin/cat', 06:43:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:03 INFO - 'PWD': '/builds/slave/test', 06:43:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:43:03 INFO - 'SHELL': '/bin/bash', 06:43:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.26w1t1Emov/Listeners', 06:43:03 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 06:43:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:43:03 INFO - 'USER': 'cltbld', 06:43:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:43:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:03 INFO - 'XPC_FLAGS': '0x0', 06:43:03 INFO - 'XPC_SERVICE_NAME': '0', 06:43:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:03 INFO - Downloading/unpacking psutil>=3.1.1 06:43:03 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 06:43:03 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 06:43:03 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 06:43:03 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 06:43:03 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 06:43:03 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 06:43:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:43:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:43:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:43:06 INFO - Installing collected packages: psutil 06:43:06 INFO - Running setup.py install for psutil 06:43:06 INFO - building 'psutil._psutil_osx' extension 06:43:06 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 06:43:07 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 06:43:07 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 06:43:07 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 06:43:07 INFO - building 'psutil._psutil_posix' extension 06:43:07 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 06:43:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:43:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:43:07 INFO - ^ 06:43:07 INFO - 1 warning generated. 06:43:07 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 06:43:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:43:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:43:07 INFO - Successfully installed psutil 06:43:07 INFO - Cleaning up... 06:43:08 INFO - Return code: 0 06:43:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:43:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108107490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10807d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81eb58d010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f1bd30>, '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 0x107d41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f13b20>, '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.ckcuF8X9b1/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.26w1t1Emov/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 06:43:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:43:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:43:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ckcuF8X9b1/Render', 06:43:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:43:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:43:08 INFO - 'HOME': '/Users/cltbld', 06:43:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:43:08 INFO - 'LOGNAME': 'cltbld', 06:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:08 INFO - 'MOZ_NO_REMOTE': '1', 06:43:08 INFO - 'NO_EM_RESTART': '1', 06:43:08 INFO - 'PAGER': '/bin/cat', 06:43:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:43:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:08 INFO - 'PWD': '/builds/slave/test', 06:43:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:43:08 INFO - 'SHELL': '/bin/bash', 06:43:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.26w1t1Emov/Listeners', 06:43:08 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 06:43:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:43:08 INFO - 'USER': 'cltbld', 06:43:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:43:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:08 INFO - 'XPC_FLAGS': '0x0', 06:43:08 INFO - 'XPC_SERVICE_NAME': '0', 06:43:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:43:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:43:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:43:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:43:10 INFO - Installing collected packages: mozsystemmonitor 06:43:10 INFO - Running setup.py install for mozsystemmonitor 06:43:10 INFO - Successfully installed mozsystemmonitor 06:43:10 INFO - Cleaning up... 06:43:10 INFO - Return code: 0 06:43:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:43:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108107490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10807d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81eb58d010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f1bd30>, '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 0x107d41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f13b20>, '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.ckcuF8X9b1/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.26w1t1Emov/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 06:43:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:43:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ckcuF8X9b1/Render', 06:43:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:43:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:43:10 INFO - 'HOME': '/Users/cltbld', 06:43:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:43:10 INFO - 'LOGNAME': 'cltbld', 06:43:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:10 INFO - 'MOZ_NO_REMOTE': '1', 06:43:10 INFO - 'NO_EM_RESTART': '1', 06:43:10 INFO - 'PAGER': '/bin/cat', 06:43:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:43:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:10 INFO - 'PWD': '/builds/slave/test', 06:43:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:43:10 INFO - 'SHELL': '/bin/bash', 06:43:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.26w1t1Emov/Listeners', 06:43:10 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 06:43:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:43:10 INFO - 'USER': 'cltbld', 06:43:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:43:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:43:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:10 INFO - 'XPC_FLAGS': '0x0', 06:43:10 INFO - 'XPC_SERVICE_NAME': '0', 06:43:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:11 INFO - Downloading/unpacking jsonschema==2.5.1 06:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:43:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:43:13 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 06:43:13 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 06:43:13 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 06:43:13 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 06:43:13 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 06:43:13 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 06:43:14 INFO - Downloading functools32-3.2.3-2.tar.gz 06:43:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:43:14 INFO - warning: no files found matching '*.txt' 06:43:14 INFO - no previously-included directories found matching 'build' 06:43:14 INFO - no previously-included directories found matching 'dist' 06:43:14 INFO - no previously-included directories found matching '.git*' 06:43:14 INFO - Installing collected packages: jsonschema, functools32 06:43:14 INFO - Running setup.py install for functools32 06:43:14 INFO - warning: no files found matching '*.txt' 06:43:14 INFO - no previously-included directories found matching 'build' 06:43:14 INFO - no previously-included directories found matching 'dist' 06:43:14 INFO - no previously-included directories found matching '.git*' 06:43:14 INFO - Successfully installed jsonschema functools32 06:43:14 INFO - Cleaning up... 06:43:14 INFO - Return code: 0 06:43:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:43: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')]} 06:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43: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')]} 06:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43: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', '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 0x108107490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10807d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81eb58d010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f1bd30>, '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 0x107d41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f13b20>, '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.ckcuF8X9b1/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.26w1t1Emov/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 06:43: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:43: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 functools32==3.2.3-2 06:43:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ckcuF8X9b1/Render', 06:43:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:43:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:43:14 INFO - 'HOME': '/Users/cltbld', 06:43:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:43:14 INFO - 'LOGNAME': 'cltbld', 06:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:14 INFO - 'MOZ_NO_REMOTE': '1', 06:43:14 INFO - 'NO_EM_RESTART': '1', 06:43:14 INFO - 'PAGER': '/bin/cat', 06:43:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:14 INFO - 'PWD': '/builds/slave/test', 06:43:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:43:14 INFO - 'SHELL': '/bin/bash', 06:43:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.26w1t1Emov/Listeners', 06:43:14 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 06:43:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:43:14 INFO - 'USER': 'cltbld', 06:43:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:43:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:14 INFO - 'XPC_FLAGS': '0x0', 06:43:14 INFO - 'XPC_SERVICE_NAME': '0', 06:43:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:43:14 INFO - Cleaning up... 06:43:14 INFO - Return code: 0 06:43:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:43: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')]} 06:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43: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')]} 06:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43: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', '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 0x108107490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10807d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81eb58d010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f1bd30>, '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 0x107d41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f13b20>, '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.ckcuF8X9b1/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.26w1t1Emov/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 06:43: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:43: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 blobuploader==1.2.4 06:43:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ckcuF8X9b1/Render', 06:43:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:43:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:43:14 INFO - 'HOME': '/Users/cltbld', 06:43:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:43:14 INFO - 'LOGNAME': 'cltbld', 06:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:14 INFO - 'MOZ_NO_REMOTE': '1', 06:43:14 INFO - 'NO_EM_RESTART': '1', 06:43:14 INFO - 'PAGER': '/bin/cat', 06:43:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:14 INFO - 'PWD': '/builds/slave/test', 06:43:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:43:14 INFO - 'SHELL': '/bin/bash', 06:43:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.26w1t1Emov/Listeners', 06:43:14 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 06:43:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:43:14 INFO - 'USER': 'cltbld', 06:43:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:43:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:14 INFO - 'XPC_FLAGS': '0x0', 06:43:14 INFO - 'XPC_SERVICE_NAME': '0', 06:43:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:15 INFO - Downloading/unpacking blobuploader==1.2.4 06:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:17 INFO - Downloading blobuploader-1.2.4.tar.gz 06:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:43:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:43:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:43:18 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 06:43:18 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 06:43:18 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 06:43:18 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 06:43:18 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 06:43:18 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 06:43:18 INFO - Downloading docopt-0.6.1.tar.gz 06:43:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:43:18 INFO - Installing collected packages: blobuploader, requests, docopt 06:43:18 INFO - Running setup.py install for blobuploader 06:43:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:43:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:43:18 INFO - Running setup.py install for requests 06:43:19 INFO - Running setup.py install for docopt 06:43:19 INFO - Successfully installed blobuploader requests docopt 06:43:19 INFO - Cleaning up... 06:43:19 INFO - Return code: 0 06:43:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:43: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')]} 06:43:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43: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')]} 06:43:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:19 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 0x108107490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10807d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81eb58d010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f1bd30>, '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 0x107d41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f13b20>, '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.ckcuF8X9b1/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.26w1t1Emov/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 06:43:19 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 06:43:19 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 06:43:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ckcuF8X9b1/Render', 06:43:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:43:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:43:19 INFO - 'HOME': '/Users/cltbld', 06:43:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:43:19 INFO - 'LOGNAME': 'cltbld', 06:43:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:19 INFO - 'MOZ_NO_REMOTE': '1', 06:43:19 INFO - 'NO_EM_RESTART': '1', 06:43:19 INFO - 'PAGER': '/bin/cat', 06:43:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:43:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:19 INFO - 'PWD': '/builds/slave/test', 06:43:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:43:19 INFO - 'SHELL': '/bin/bash', 06:43:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.26w1t1Emov/Listeners', 06:43:19 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 06:43:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:43:19 INFO - 'USER': 'cltbld', 06:43:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:43:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:43:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:19 INFO - 'XPC_FLAGS': '0x0', 06:43:19 INFO - 'XPC_SERVICE_NAME': '0', 06:43:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:43:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:43:20 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-PzAdfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:43:20 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-NjEptN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:43:20 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-9tqfVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:43:20 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-mzUPjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:43:20 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-lq902j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:43:20 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-tlq9z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:43:20 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-YfyIPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:43:20 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-cFrTy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:43:20 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-NKSFVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:43:20 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-F8Cllq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:43:21 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-EQuYH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:43:21 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-KgJ43V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:43:21 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-1FkRtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:43:21 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-JBZXbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:43:21 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-9OGMZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:43:21 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-cZLtg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:43:21 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-IIpXeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:43:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:43:21 INFO - Running setup.py install for manifestparser 06:43:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:43:21 INFO - Running setup.py install for mozcrash 06:43:22 INFO - Running setup.py install for mozdebug 06:43:22 INFO - Running setup.py install for mozdevice 06:43:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:43:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:43:22 INFO - Running setup.py install for mozfile 06:43:22 INFO - Running setup.py install for mozhttpd 06:43:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:43:22 INFO - Running setup.py install for mozinfo 06:43:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:43:22 INFO - Running setup.py install for mozInstall 06:43:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:43:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:43:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:43:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:43:22 INFO - Running setup.py install for mozleak 06:43:23 INFO - Running setup.py install for mozlog 06:43:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:43:23 INFO - Running setup.py install for moznetwork 06:43:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:43:23 INFO - Running setup.py install for mozprocess 06:43:23 INFO - Running setup.py install for mozprofile 06:43:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:43:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:43:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:43:23 INFO - Running setup.py install for mozrunner 06:43:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:43:23 INFO - Running setup.py install for mozscreenshot 06:43:24 INFO - Running setup.py install for moztest 06:43:24 INFO - Running setup.py install for mozversion 06:43:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:43:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:43:24 INFO - Cleaning up... 06:43:24 INFO - Return code: 0 06:43:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:43:24 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')]} 06:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:24 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')]} 06:43:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:25 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 0x108107490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10807d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81eb58d010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f1bd30>, '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 0x107d41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f13b20>, '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.ckcuF8X9b1/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.26w1t1Emov/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 06:43:25 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 06:43:25 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 06:43:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ckcuF8X9b1/Render', 06:43:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:43:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:43:25 INFO - 'HOME': '/Users/cltbld', 06:43:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:43:25 INFO - 'LOGNAME': 'cltbld', 06:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:25 INFO - 'MOZ_NO_REMOTE': '1', 06:43:25 INFO - 'NO_EM_RESTART': '1', 06:43:25 INFO - 'PAGER': '/bin/cat', 06:43:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:25 INFO - 'PWD': '/builds/slave/test', 06:43:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:43:25 INFO - 'SHELL': '/bin/bash', 06:43:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.26w1t1Emov/Listeners', 06:43:25 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 06:43:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:43:25 INFO - 'USER': 'cltbld', 06:43:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:43:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:25 INFO - 'XPC_FLAGS': '0x0', 06:43:25 INFO - 'XPC_SERVICE_NAME': '0', 06:43:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:43:25 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-fnIYog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:43:25 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)) 06:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:43:25 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-q0wuOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:43:25 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-J78gZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:43:25 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)) 06:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:43:25 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-wKfApH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:43:25 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-crIHMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:43:25 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)) 06:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:43:25 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-aF6M08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:43:26 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)) 06:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:43:26 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-wFvnfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:43:26 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)) 06:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:43:26 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-5t9Ql6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:43:26 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)) 06:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:43:26 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-XzgKRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:43:26 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)) 06:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:43:26 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-ER832U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:43:26 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)) 06:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:43:26 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-ZC33iV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:43:26 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)) 06:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:43:26 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-FRuwIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:43:26 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)) 06:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:43:26 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-hpqaX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:43:26 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)) 06:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:43:26 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-cX3h2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:43:26 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-AGlVPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:43:27 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)) 06:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:43:27 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-6uPRNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:43:27 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)) 06:43:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:43:27 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-8Bt_lA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:43:27 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)) 06:43:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:43:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:43:27 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)) 06:43:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:43:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:43:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:43:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:43:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:43:29 INFO - Downloading blessings-1.6.tar.gz 06:43:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:43:30 INFO - Installing collected packages: blessings 06:43:30 INFO - Running setup.py install for blessings 06:43:30 INFO - Successfully installed blessings 06:43:30 INFO - Cleaning up... 06:43:30 INFO - Return code: 0 06:43:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:43:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:43:30 INFO - Reading from file tmpfile_stdout 06:43:30 INFO - Current package versions: 06:43:30 INFO - blessings == 1.6 06:43:30 INFO - blobuploader == 1.2.4 06:43:30 INFO - docopt == 0.6.1 06:43:30 INFO - functools32 == 3.2.3-2 06:43:30 INFO - jsonschema == 2.5.1 06:43:30 INFO - manifestparser == 1.1 06:43:30 INFO - mozInstall == 1.12 06:43:30 INFO - mozcrash == 0.17 06:43:30 INFO - mozdebug == 0.1 06:43:30 INFO - mozdevice == 0.48 06:43:30 INFO - mozfile == 1.2 06:43:30 INFO - mozhttpd == 0.7 06:43:30 INFO - mozinfo == 0.9 06:43:30 INFO - mozleak == 0.1 06:43:30 INFO - mozlog == 3.4 06:43:30 INFO - moznetwork == 0.27 06:43:30 INFO - mozprocess == 0.23 06:43:30 INFO - mozprofile == 0.28 06:43:30 INFO - mozrunner == 6.12 06:43:30 INFO - mozscreenshot == 0.1 06:43:30 INFO - mozsystemmonitor == 0.3 06:43:30 INFO - moztest == 0.7 06:43:30 INFO - mozversion == 1.4 06:43:30 INFO - psutil == 3.1.1 06:43:30 INFO - requests == 1.2.3 06:43:30 INFO - wsgiref == 0.1.2 06:43:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:43:30 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')]} 06:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:30 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')]} 06:43:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:30 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 0x108107490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10807d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81eb58d010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f1bd30>, '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 0x107d41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f13b20>, '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.ckcuF8X9b1/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.26w1t1Emov/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 06:43:30 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 06:43:30 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 06:43:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ckcuF8X9b1/Render', 06:43:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:43:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:43:30 INFO - 'HOME': '/Users/cltbld', 06:43:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:43:30 INFO - 'LOGNAME': 'cltbld', 06:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:30 INFO - 'MOZ_NO_REMOTE': '1', 06:43:30 INFO - 'NO_EM_RESTART': '1', 06:43:30 INFO - 'PAGER': '/bin/cat', 06:43:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:30 INFO - 'PWD': '/builds/slave/test', 06:43:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:43:30 INFO - 'SHELL': '/bin/bash', 06:43:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.26w1t1Emov/Listeners', 06:43:30 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 06:43:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:43:30 INFO - 'USER': 'cltbld', 06:43:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:43:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:30 INFO - 'XPC_FLAGS': '0x0', 06:43:30 INFO - 'XPC_SERVICE_NAME': '0', 06:43:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:43:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:30 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)) 06:43:30 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)) 06:43:30 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)) 06:43:30 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)) 06:43:30 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)) 06:43:30 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)) 06:43:30 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)) 06:43:30 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)) 06:43:30 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)) 06:43:30 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)) 06:43:30 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)) 06:43:30 INFO - Cleaning up... 06:43:30 INFO - Return code: 0 06:43:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:43:30 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')]} 06:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:30 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')]} 06:43:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:43:30 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 0x108107490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10807d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81eb58d010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f1bd30>, '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 0x107d41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f13b20>, '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.ckcuF8X9b1/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.26w1t1Emov/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 06:43:30 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 06:43:30 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 06:43:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ckcuF8X9b1/Render', 06:43:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:43:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:43:30 INFO - 'HOME': '/Users/cltbld', 06:43:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:43:30 INFO - 'LOGNAME': 'cltbld', 06:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:30 INFO - 'MOZ_NO_REMOTE': '1', 06:43:30 INFO - 'NO_EM_RESTART': '1', 06:43:30 INFO - 'PAGER': '/bin/cat', 06:43:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:30 INFO - 'PWD': '/builds/slave/test', 06:43:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:43:30 INFO - 'SHELL': '/bin/bash', 06:43:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.26w1t1Emov/Listeners', 06:43:30 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 06:43:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:43:30 INFO - 'USER': 'cltbld', 06:43:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:43:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:30 INFO - 'XPC_FLAGS': '0x0', 06:43:30 INFO - 'XPC_SERVICE_NAME': '0', 06:43:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:43:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:43:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:43:31 INFO - Cleaning up... 06:43:31 INFO - Return code: 0 06:43:31 INFO - Running post-action listener: _resource_record_post_action 06:43:31 INFO - Running post-action listener: _start_resource_monitoring 06:43:31 INFO - Starting resource monitoring. 06:43:31 INFO - [mozharness: 2016-10-06 13:43:31.282870Z] Finished create-virtualenv step (success) 06:43:31 INFO - [mozharness: 2016-10-06 13:43:31.283829Z] Running install step. 06:43:31 INFO - Running pre-action listener: _resource_record_pre_action 06:43:31 INFO - Running main action method: install 06:43:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:43:31 INFO - Reading from file tmpfile_stdout 06:43:31 INFO - Detecting whether we're running mozinstall >=1.0... 06:43:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:43:31 INFO - Reading from file tmpfile_stdout 06:43:31 INFO - Output received: 06:43:31 INFO - Usage: mozinstall [options] installer 06:43:31 INFO - Options: 06:43:31 INFO - -h, --help show this help message and exit 06:43:31 INFO - -d DEST, --destination=DEST 06:43:31 INFO - Directory to install application into. [default: 06:43:31 INFO - "/builds/slave/test"] 06:43:31 INFO - --app=APP Application being installed. [default: firefox] 06:43:31 INFO - mkdir: /builds/slave/test/build/application 06:43:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:43:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:44:06 INFO - Reading from file tmpfile_stdout 06:44:06 INFO - Output received: 06:44:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:44:06 INFO - Running post-action listener: _resource_record_post_action 06:44:06 INFO - [mozharness: 2016-10-06 13:44:06.217300Z] Finished install step (success) 06:44:06 INFO - [mozharness: 2016-10-06 13:44:06.217436Z] Running run-tests step. 06:44:06 INFO - Running pre-action listener: _resource_record_pre_action 06:44:06 INFO - Running main action method: run_tests 06:44:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:44:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:44:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:44:06 INFO - 2016-10-06 06:44:06.231 screenresolution[1647:7496] starting screenresolution argv=screenresolution get 06:44:06 INFO - 2016-10-06 06:44:06.234 screenresolution[1647:7496] Display 0: 1600x1200x32@60 06:44:06 INFO - 2016-10-06 06:44:06.240 screenresolution[1648:7498] starting screenresolution argv=screenresolution list 06:44:06 INFO - Available Modes on Display 0 06:44:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:44:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:44:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:44:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:44:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:44:06 INFO - Intel Iris: 06:44:06 INFO - Chipset Model: Intel Iris 06:44:06 INFO - Type: GPU 06:44:06 INFO - Bus: Built-In 06:44:06 INFO - VRAM (Dynamic, Max): 1536 MB 06:44:06 INFO - Vendor: Intel (0x8086) 06:44:06 INFO - Device ID: 0x0a2e 06:44:06 INFO - Revision ID: 0x0009 06:44:06 INFO - Displays: 06:44:06 INFO - Display: 06:44:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:44:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:44:06 INFO - Display Serial Number: 1600x1200 60 06:44:06 INFO - Main Display: Yes 06:44:06 INFO - Mirror: Off 06:44:06 INFO - Online: Yes 06:44:06 INFO - Rotation: Supported 06:44:06 INFO - Return code: 0 06:44:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:44:06 INFO - Python 2.7.3 06:44:06 INFO - Return code: 0 06:44:06 INFO - grabbing minidump binary from tooltool 06:44:06 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')]} 06:44:06 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 0x107f1bd30>, '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 0x107d41db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f13b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:44:06 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 06:44:06 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 06:44:06 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 06:44:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:44:06 INFO - Return code: 0 06:44:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:44:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:44:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:44:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:44:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:44:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0220 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:44:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ckcuF8X9b1/Render', 06:44:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:44:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:44:06 INFO - 'HOME': '/Users/cltbld', 06:44:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:44:06 INFO - 'LOGNAME': 'cltbld', 06:44:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:44:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:06 INFO - 'MOZ_NO_REMOTE': '1', 06:44:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:44:06 INFO - 'NO_EM_RESTART': '1', 06:44:06 INFO - 'PAGER': '/bin/cat', 06:44:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:06 INFO - 'PWD': '/builds/slave/test', 06:44:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:44:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:44:06 INFO - 'SHELL': '/bin/bash', 06:44:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.26w1t1Emov/Listeners', 06:44:06 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 06:44:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:44:06 INFO - 'USER': 'cltbld', 06:44:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:44:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:06 INFO - 'XPC_FLAGS': '0x0', 06:44:06 INFO - 'XPC_SERVICE_NAME': '0', 06:44:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:44:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:44:06 INFO - mozversion application_buildid: 20161006041003 06:44:06 INFO - mozversion application_changeset: 993bd0c52f8addd18cdf4163acd645e51090c679 06:44:06 INFO - mozversion application_display_name: Nightly 06:44:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:44:06 INFO - mozversion application_name: Firefox 06:44:06 INFO - mozversion application_remotingname: firefox 06:44:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:44:06 INFO - mozversion application_vendor: Mozilla 06:44:06 INFO - mozversion application_version: 52.0a1 06:44:06 INFO - mozversion platform_buildid: 20161006041003 06:44:06 INFO - mozversion platform_changeset: 993bd0c52f8addd18cdf4163acd645e51090c679 06:44:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:44:06 INFO - mozversion platform_version: 52.0a1 06:44:06 INFO - using testdate: 1475761446 06:44:06 INFO - actual date: 1475761446 06:44:06 INFO - starting webserver on 'localhost:49277' 06:44:06 INFO - SUITE-START | Running 2 tests 06:44:06 INFO - TEST-START | dromaeo_css 06:44:06 INFO - operating with platform_type : mac_ 06:44:06 INFO - Initialising browser for dromaeo_css test... 06:44:06 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpMlVMu1/profile http://localhost:49277/getInfo.html) 06:44:09 INFO - PROCESS | 1658 | 2016-10-06 06:44:09.700 plugin-container[1660:7638] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c3f, name = 'com.apple.tsm.portname' 06:44:09 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:44:09 INFO - PROCESS | 1658 | 2016-10-06 06:44:09.704 plugin-container[1660:7638] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 06:44:09 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:44:09 INFO - PROCESS | 1658 | 2016-10-06 06:44:09.704 plugin-container[1660:7638] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:44:09 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 06:44:09 INFO - PROCESS | 1658 | colorDepth:24 06:44:09 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 06:44:09 INFO - PROCESS | 1658 | __metrics 06:44:09 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 06:44:10 INFO - TEST-INFO | 1658: exit 0 06:44:10 INFO - Browser initialized. 06:44:10 INFO - Running cycle 1/1 for dromaeo_css test... 06:44:10 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpMlVMu1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:44:13 INFO - PROCESS | 1661 | 2016-10-06 06:44:13.119 plugin-container[1662:7756] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a1f, name = 'com.apple.tsm.portname' 06:44:13 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:44:13 INFO - PROCESS | 1661 | 2016-10-06 06:44:13.121 plugin-container[1662:7756] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9203, name = 'com.apple.CFPasteboardClient' 06:44:13 INFO - PROCESS | 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:44:13 INFO - PROCESS | 1661 | 2016-10-06 06:44:13.121 plugin-container[1662:7756] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:44:22 INFO - PROCESS | 1661 | RSS: Main: 240275456 06:44:22 INFO - PROCESS | 1661 | 06:45:12 INFO - PROCESS | 1661 | 1475761512389 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] 06:47:25 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 06:47:27 INFO - PROCESS | 1661 | RSS: Main: 255713280 06:47:27 INFO - PROCESS | 1661 | 06:50:29 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 06:50:30 INFO - PROCESS | 1661 | RSS: Main: 265990144 06:50:30 INFO - PROCESS | 1661 | 06:53:32 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 06:53:32 INFO - PROCESS | 1661 | RSS: Main: 270462976 06:53:32 INFO - PROCESS | 1661 | 06:56:34 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 06:56:35 INFO - PROCESS | 1661 | RSS: Main: 270147584 06:56:35 INFO - PROCESS | 1661 | 06:59:38 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 06:59:38 INFO - PROCESS | 1661 | RSS: Main: 275611648 06:59:38 INFO - PROCESS | 1661 | 07:02:41 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 07:02:41 INFO - PROCESS | 1661 | RSS: Main: 278327296 07:02:41 INFO - PROCESS | 1661 | 07:02:41 INFO - PROCESS | 1661 | __start_tp_report 07:02:41 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 07:02:41 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 07:02:41 INFO - PROCESS | 1661 | |i|pagename|runs| 07:02:41 INFO - PROCESS | 1661 | |0;dojo.html;3299.554560134382;3303.8182899940493;3324.002799160253;3351.212465070708;3363.260082781788;5512.44875512449;5552.305961754786;5575.386707462176;5629.35262444819;5640.351359593648;5447.482489163533;5604.243427137335;5623.015972204868;5644.689542075184;5656.406077361879;5100.311457953175;5170.819021334254;5215.217717342391;5221.556167725748;5223.895522089556;4223.598758117974;4259.233337999159;4368.97815510922;5279.604029697769;5352;4974.527419895104;5208.9739551302;5249.763760630781;5275.788968441258;5277.182036784305;3865.1689886674217;4420.381146639473;5103.744812759347;5125.3080834087295;5147.408048074444;5018.5232402921665;5089.898202035975;5094.465081166498;5094.949050509485;5132.153194722866;5355.4109048005075;5477.1510415885605;5613.017721898651;5706.914396284059;5720.828375148711;6108.6759897029115;6180.907286390708;6240.219972503437;6266.717997690115;6269.310375858652;6187.4740647045055;6204.751809927598;6275.529335299871;6287.52843536732;6288.245410550718;5782.190493330937;5794.797182098607;5799.391063938226;5805.448482394166;5847.7953271635715;6164.445199932027;6210.472109870621;6219.378062193744;6280.968595157086;6300.779472718433;6064.636121832704;6108.602940808833;6138.07928810673;6145.047517634774;6159.168512250879;6154.366219588621;6207.441330280297;6219.595726277777;6229.065640154013;6251.937480625226;5029.245613157982;6033.607815491979;6096.103393722308;6104.267487901391;6208.627482351073;5137.640365174477;6139.29398119222;6208.534359923024;6209.6895155242055;6227.9377206227355;4879.975600121977;4898.093852637274;4915.48387419323;4929.531694489017;4984.476629953802;4299.398084268205;4342.261815491374;4357.716748411343;4401.735895846259;4443.933340999887;5558.666480011212;5730.226419433323;5754.712264386764;5772.826815195551;5777.942220577825;6227.221597300338;6258.655773932386;6274.215723034621;6287.371262873768;6298.716557754912;5584.804531841366;5658.830235092953;5721.942780572224;5755.683437410982;5756.971215143897;5331.600129990266;5373.489518495737;5404.189371594292;5415;5480.561555075664;6242.157308763441;6277.968610157011;6285.43431091204;6296.590721603081;6317.652529110943;5045.747712614281;6246.562740608114;6250.0937364082865;6278.905816412666;6284.497240220863;4755.904881902274;6206.813795586139;6207.068939658907;6249.906251406142;6310.5898116622275;6180.351063138485;6209.59637623553;6213.5339849510565;6222.222222222223;6239.438450539292;5394.676319420847;5934.732937017759;6212.378762123752;6298.811035668938;6315.115883776367;5069.3156423883775;5840.561957853263;6051.697415129314;6073.210482637229;6077.4834139098675;6010.579259451796;6078.635281883101;6080.48315893154;6110.114033465212;6114.174586430775;4908.9754551227015;5840.123981402654;5874.5887787854435;5931.258592675916;5952.196453478725;5044.47033061538;6008.03871380577;6025.457708806229;6028.939710602838;6093.817185484442;5905;5922.289325280994;5940.346561878104;5944.375840536854;5970.910436343545 07:02:41 INFO - PROCESS | 1661 | |1;ext.html;503.84632687030444;504.82627890155385;522.6863881670995;562.3336346429481;602.8583282928511;40727;42301.36547951779;42388.788056059675;44277;44403.77798111013;35499.64500354996;42425.36361954573;43087.13825723492;43580.782096089555;43790.56209437905;9853.65512207073;10005.899941000605;10012.199024078056;10028.598856045786;10050.49747512625;9782.26633002524;9869.457179855106;9879.604815807359;9891.455969921652;9917.851232231522;9901.603935842593;9932.6523571675;9940.055694709028;9940.950295248549;9947.602095916154;9806.705798826046;9834.213262938947;9893.653722119763;9903.603855845757;9923.851142232836;9717.125458708679;9787.46168960707;9805.754856128582;9818.558164882597;9845.45849978251;41428.37857432141;41687.583124168676;41703.374449383286;41995.79002105001;42167.94580135491;3023.5011223148153;3260.2990357073345;3336.249343897628;3456.4815277708294;3579.7534146027024;31067.291298978547;31152.688473115206;31185.37629247425;32170.678293217003;32465.51301730476;3190.840457977115;3196.3447493263825;3215.678432156789;3299.538064670948;3315.088350703552;497759;498134;500012;502006;502353.48823256016;61600.69199654063;62409.68795156086;62664.74670506656;62681;62901.370986290465;52322.21516677253;55832;56988;57829.710851445474;57928.20717928258;16774.993500390017;16965.91517042407;16977.320907163576;16985.980841149572;17075.573110672085;12908.419121139572;12992.545260915822;13099.2140471572;13101.672458188621;13122.868771312356;18271.294490911532;18914.43256702301;19069.523261918563;19092.040733686023;19105.426837194907;7238.493305468672;7529.661165247577;7694.307512323918;7759;7804.024496937883;811.7280710961776;859.5530324231489;935.4574346878794;1022.223110436074;1064.4624464645306;25251.494970100863;29793.25516862096;30686.38627227443;30806.38387232243;31453.37093258122;982.4841957971979;1053.083817079146;1053.8840727519967;1056.8361903904906;1157.6642773595563;11905.821412678817;15606.843931560767;15777.442828480258;15834.049957002617;15856.286467109008;662200;669555;671524;673445;675995;54707;59722;59750.40249597535;59819.70090149521;59962.40037599568;1169.6257197696825;1170.3621526268034;1338.3174580963778;1351.290572449472;1377.6831328794233;23851.284461466184;25985.350366240997;29406;29662.555061674524;30037.84981075168;35380.823095884356;49478.50521494739;50999.74500127476;51214.719632009495;51266.23100653419;625821;629679;629954;630533;631120;27226.72773272242;27552;27624.309392265353;27642.585361219197;27669.723302766713;47897.281540777614;47971;48490.757546212044;49163.75418122886;49363;39434.80282598569;39759.40360894531;39814.60185398225;40585.1882962345;41107.656004719196;32776.50835237426;39705.40441893316;39987.60012399839;40476.78569642916;40675.3898691514;27082.72917270802;33208.003759887244;36764.816175918946;37798.866034019025;38422.80788596039;27788.30529236785;34606.989065941176;34629;34740.652593474755;34869.302613947075;23942.281731548082;25471.872640636677;25502.617460737732;25830.749662135873;26017.47965040651 07:02:41 INFO - PROCESS | 1661 | |2;jquery.html;368.1036675694682;373.9476473293739;378.6421831369356;381.1006025779159;399.494639281309;18766.906165469172;20967.685484717742;21599.67600485992;21675.45811354717;21786.89106554465;17461.73807392887;17606.654735600227;17964.011979341132;20610.278640247594;20872.686909696367;5550.250716153308;5968.492678122354;6129.969350153266;6170;6272.59228150171;4876.804927802884;5467.480589344006;6233.937660623404;6235.501159907197;6238.220222472191;5874.676892770896;6126.724297406605;6154.692265386735;6162.5378096642935;6170.259568851721;5892.263467066617;6059.303180134253;6103.664298463583;6143.232095988002;6143.754249830002;5244.501772331622;5317.1492561190025;5328.413874473805;5343.957928204002;5368.463153684639;24417.389565260833;24616.5076698465;24802.751972480226;24990.5001899961;25014;2271.034810205656;2344.3963872911036;2427.5023620157826;2449.473363226915;2600.9609855852177;14980.925095374563;15554.066755994563;15593.37626494939;15828;16141.27364268599;1868.945755956328;1893.1102381880632;1895.1566552883971;1928.3540014095295;1970.8521860860492;128278.35860820636;128954;129445;130432;131061.99999999904;7977.401694872908;8107.756767296991;9905.702828915144;10048.79902401948;10627.946860265803;12346.197497162655;12456;12512.249265044127;12513;12544.184627999151;7985.880211796828;8006.039275286887;8074.798130046795;8159.95920020408;8265.95867020673;8622.26710729595;8637.611307491177;8672.60973256205;8730.563471826383;8819.779505512413;3867.7679339239735;3940.8817735467983;3941.034446560611;3965.246603145451;4023.8591649292134;1754.8418044090838;1859.748933893934;1956.5206524401613;1961.2449207055386;2024.631181517628;683.8290427393151;691.4226620771611;812.4881324765478;877.8770972063916;899.1637776867576;17442.389516366868;20091.49771255701;20804.855732934833;21093.15627374888;21355.35933921985;788.2393490281905;872.9912700873037;910.7586489580267;945.229637845154;989.9010098990187;7828.765137045898;10617.469126543796;11052.005319521282;11070.5571777128;11277.774444511064;543645;604301;629961;640650;655504;109260;135864.60338491618;140281;141175;147403;967.2503809547657;1002.8946960569181;1018.6485662446444;1019.0421004255976;1024.1243736605095;18206.635867282846;19108.044597770335;19160.425187244404;19161.041947902828;19271;47640.52359476361;50644.49355506545;51139.74430127825;51207.97584048373;51720.22419663633;58718;74538.62730686311;76702.6164869172;77546;77858.2214177851;7839.882401764092;7957.920420795718;8008.399370047387;8094.433389662902;8182.509049457051;9382.733331000501;10602.522886470282;12277.75444491123;12311;12437.440315186019;8473.025602055843;9658.508425316557;10773.784524309627;11118.332900026024;11159.609413670483;10595.417252051211;10755.516001779783;10836.67489975302;10864.674059778219;10947.288426252268;11089.445527723421;11097.445127743418;11307.265027773168;11337.26307790024;11511.251768635011;6344;6660.56706314088;6678.899816502659;7037.964810175917;7941.12647608751;7560.395168386626;8327.250547450758;8709.824173736464;9510.09654082861;9914.702558923243 07:02:41 INFO - PROCESS | 1661 | |3;mootools.html;1517.3247904682416;1548.9225538723065;1759.780027496563;1776.6674993754684;1863.7577114975052;8043.55760433176;8327.292180164679;8444.91555084449;8874.068222836606;8994.460332380062;8433.70482033129;8753.343499237566;8764.8685269721;8858.5570721464;8917.197452229299;1977.7626684797845;2312.2947501012227;2328.3364241191266;2339.6022676145094;2341.718993720756;2296.8392212545127;2311.838171328008;2347.284078356109;2348.154664320843;2351.8824058797077;2303.7005189325364;2323.465602911323;2323.965140522885;2336.158982766203;2342.941426464335;2279.350385140235;2285.2001799370255;2287.7597852225526;2293.598620241451;2296.8621882687007;2298.6666933294746;2303.896324665394;2306.411864974438;2309.595820731382;2322.6632138339846;8376.790580235544;8382.119877412844;8393.748187554384;8403.159684031609;8433.789155271106;4895.8776030599165;5059.74701264939;5183.326167598226;5339;5358.223057656618;3023.3953209358215;3435.2651910784894;3508.456189290664;3620.185458271868;3630.110622897381;1081.4646749858791;1085.1210519479168;1088.1458055426451;1096.2216826053511;1108.5288752280248;11521.539138434453;11527.538898444136;11549.480273387719;11602.76794464106;11659.183857130005;4574.405327307495;4696.107739529547;4784.497627749036;4801.51984801524;4827.396575428072;8520.764489149038;9758.560864761102;10017.298789084694;10024.498775061218;10030.749231269278;4597.241455159861;5262.894792093627;5321.8935621287355;5368.1679339702405;5371.650842695212;4394.121175764796;4574.199515084847;4873;4925.113479573711;4927.359443272351;3894.5910679378826;3941.428492868518;4005.6995725320717;4032.415299781574;4039.313316736162;1289.5615490733196;1298.2210673595766;1300.4343110746856;1310.3120861547764;1312.2389014371643;806.2300503019602;905.1220316293185;915.3889155086962;919.8475567172848;953.4612943686933;5108.438071812097;5744.942550574441;5854.795082172103;5987.760489580368;6009.128676341906;348.1835096698239;360.6519708481328;428.0924440186824;429.7636300034968;443.6738996837322;3980.5621381647998;4005.118873847749;4060.898477538026;4074.531428885716;4105.199486100182;9140.451572905647;10375.481225938673;10604.681859544226;10889.237753357347;10942.124630029579;10536.051755342056;10628.893711062945;10632.574697012033;10667.146628269875;10749;8039.598020098972;8282.213189746964;8298.958505207434;8299.377546683902;8303.792405189919;5905.40945905406;5948.583599148018;5993.220881285405;6018.127371531191;6069.696515174312;9926.007399260016;10070.69787906364;10179.083882450615;10194.286399951932;10209.285350025428;10414.739631509274;10419.635312764018;10434.634787782392;10447.320924139907;10447.58209671635;6934.549254298455;7173.10336207974;7342.816429589303;7578.621068946641;7670.884936725842;8212.548309842778;8388.161183881562;8519.74440766778;8541;8547.52988585609;6827.522073455009;6846.178458585002;7352.852942941218;7544.698212071456;7604.771856844303;7412.258774122544;7415.925840741524;7418.814529636802;7441.181470038183;7534.095908491016;7053.188883278489;7054.894176587458;7141.178764442156;7156.892646610409;7164.641767911688;4982.55157035854;5004.274380214922;5122.974385128051;5141.511556402285;5262.947370526245;5098.566621837037;5193.350831146106;5217.06092903281;5227.555657769132;5314.760835762323 07:02:41 INFO - PROCESS | 1661 | |4;prototype.html;263.40076326357536;302.80317793434267;310.2445545097687;313.5657114895869;315.63071206688187;4331.660903112315;4667.486576476589;5548.278723765905;5557.666540007603;5563.554915606752;5292.603054770898;5385.465142434407;5507.339119305689;5529.953917050697;5556.16657501375;3525.806080665562;4207.600277973603;4210.936835947463;4249.277622804116;4263.3178691409385;3402.8638854445794;3864.6908247340143;4124.649404800595;4154.442084218418;4267.423897773808;4102.897427564305;4115.650169735576;4127.669786417079;4152.68854835887;4159.292920203573;4118.805546391558;4138.606832350922;4139.627433530996;4158.521769996459;4168.979155104235;3156.510740835174;3258.4786434170655;3302.207470207157;3417.726581873444;3615.981920090409;4316.633086187678;5205.193195054772;5278.894422111536;5318.574514038867;5362.973185134049;4237.660987121023;4707.6233901287815;4710.552497512731;4754.7147171169845;4755.42934847817;5162.812553112805;5633.521150702154;5765.4522820332;5805.274340707411;5846.883062338772;3536.3104194682046;3785.886423407302;3863.826127824255;3907.5808667416013;3911.256861196392;5053.797848086072;5419.674819510842;5799.275090613715;5940.287165540163;6049.334573196945;3975;3996.4205190247253;4004.1591265833918;4011.1777085697363;4031.354983202732;3875.5736868944396;3925.4896863408144;3993.0416699991792;4051.716379853441;4055.7160998729805;4304.418903447994;4705.341252224691;4732.408448943882;4736.621070314367;4744.146053710365;5220.451852555503;5816.127580862904;5831.358550559435;5835.620684655484;5905.667261431797;1291.6040744419156;1296.4101333893057;1318.7340153452792;1349.5141748970364;1380.475419340644;765.5865832450414;790.7983464216703;811.7402431222071;825.8761185822175;850.9873250831614;4083.244599749056;4405.62969328464;4629.042168945571;4667.463241727245;4681.368015317888;4960.355153829979;5031.396232452129;5067.341245638044;5085.1355269604255;5107.923381149286;4039.2123535910805;4112.005677246533;4138.958610413857;4139.91720165595;4384.517703052662;2190.6713992900873;2218.3899427657525;2348.4246359641998;2432.97567024331;2613.5818269077236;5076.314697515788;5089.720065396365;5250.97374513125;5261.894762104736;5279.736013199325;4387.473503179575;4730.148573256778;4916.869120102397;5150.944056468415;5203.401608814959;4142.608834635236;4619.3994780678295;4894.730789806595;5003.749812509433;5157.6647517911215;4281.314989601648;4786.569208771228;5041.067402530543;5047.536214497754;5071.39143302806;4138.606832350922;4376.824927002885;5006.374203224597;5021.949780502148;5045.4450010498085;4696.7084051886;5183.740812959261;5184.351956005499;5233;5272.124988133795;2898.0001899344693;3035.787494875426;3296.027671836766;3472.211810917329;3490;4352.564743525749;4584.426946631671;4785.186518291829;4849.5025062092345;4904.754762261944;5389.75746091419;5621.482199805948;5887.793927212527;5943;5949.910751338647;5903.970480147572;5904.3210030845285;5911.408859114226;5923.200367950271;5940.346561878277;4928.507149285043;5025.924611130763;5711.457411545896;5823.5923485355615;5829.708514574169;4888.877778055577;5152.381714194321;5184.196449550326;5498.233709908725;5898.439648233411;5017.523335283142;5668.461496157858;5672.688002159921;5692.971535142297;5780.930527852361 07:02:41 INFO - PROCESS | 1661 | |5;yui.html;676.7259259999701;701.7017767448834;772.2239149654599;791.1337085890951;794.3049831397527;14001;14087.859121408783;15363.923180384083;15822.525324240263;15829.445969391074;14370.065945713548;15302.387904483807;15710.978786378906;15901.840981590181;16356.75464868025;832.950022998619;858.635080090962;860.0883063952231;860.5912191708951;862.3230763850379;678.4470656415031;698.0123125777019;826.0789220019694;832.5795473285982;834.2241715204857;870.651739304277;888.0231745080392;903.3992395057312;903.7379160043612;904.1049361132465;868.7176667582997;886.2289807867197;888.5201990924893;893.093510087262;893.7631527645179;648.9253735820347;658.5127006015562;662.5031226580065;665.2748504130521;667.1027468055457;14893;15463;15640.983336083118;15792.92103539475;15848.68302633941;10066.29535932485;13440.865591344156;13707.246101464416;14143.504977325847;14210.857891421058;11742.941285293518;11783.410829458493;11853.111016673698;11943.9847612953;12256.325902075383;3489.6859282664427;3670.614585468514;3720.5535335759882;3766.6610005099674;3819.560750513671;116149;117305.8269417312;118256;120250.9937251567;121722;9312.906870931203;10413;10837.891621083845;10855.565777368816;11102.389368584805;22102.668459973112;22300.107995680315;22368.664470032963;22375.87429194224;22383.104675813112;7860.9213907860185;7889.408294377945;7958.204179581995;8059.476134051268;8158.67365305393;4411.580899814512;4432.844850430284;4470.597646211857;4490.50604433512;4650.209464391061;3595.94606080909;3619.8914032579064;3683.5395575553057;3710.6103859094947;3715.368387374153;649.6297110646885;657.2277573850706;664.6012392564422;682.6006786030227;686.1217641418991;639.7728806273799;648.9740410383627;656.8325077105403;668.1814776898261;675.8850995330805;8768.912310876936;9332.16010559053;9430.481323527272;9598.275271103445;9609.087136722;537.3363895588944;631.2897989761518;662.8674265146893;673.1854456108066;675.6520391998125;4380.211561918822;4381.868543943687;4604.58558729716;4647.09381670571;4715.504871988461;113832;115051;135405;163867.1679699222;172872.27127728812;86196.13803862006;97484.07547773578;98989.5151572727;102186;103434.96565034403;97437;111139;114479.42760286311;121405.17892231447;122951;8827;8886.955565222133;8917.375783695079;8929.910700893168;8944.150305720947;60559.09161362671;61403;62767.37232627798;63713;69052.65473672599;91272.54363728139;99921;106002.93997059931;106503;107598;9624;11595.652130436101;11648.475818588353;11767.999720023552;11917.82123268169;11064.944675276573;12320.630381088582;12686.555970540987;12927.806082908575;12984.740305194033;10235.897641023494;11903.285802851857;12053.276803391474;12454.128211025503;12666.683332916751;11909.40452977365;12145.574904878287;12397.62807115788;12514.249145051326;12639;11828.940855295668;11904.285742855456;12066.75866482683;12172.756544868877;12353.444095015566;10127.59489620407;10243.487825608541;10379.584816607252;10513.158947284046;10520.105791007543;8896.777580560538;9054.004059553312;9462.479563624067;9571.521423928636;9869.210463163074 07:02:41 INFO - PROCESS | 1661 | __end_tp_report 07:02:41 INFO - PROCESS | 1661 | __start_cc_report 07:02:41 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,360 07:02:41 INFO - PROCESS | 1661 | __end_cc_report 07:02:41 INFO - PROCESS | 1661 | __startTimestamp1475762561857__endTimestamp 07:02:41 INFO - PROCESS | 1661 | 07:02:41 INFO - PROCESS | 1661 | ------- Summary: start ------- 07:02:41 INFO - PROCESS | 1661 | Number of tests: 6 07:02:41 INFO - PROCESS | 1661 | 07:02:41 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5634.74 Median:5840.12 stddev:694.83 (11.9%) stddev-sans-first:672.38 07:02:41 INFO - PROCESS | 1661 | Values: 3299.6 3303.8 3324.0 3351.2 3363.3 5512.4 5552.3 5575.4 5629.4 5640.4 5447.5 5604.2 5623.0 5644.7 5656.4 5100.3 5170.8 5215.2 5221.6 5223.9 4223.6 4259.2 4369.0 5279.6 5352.0 4974.5 5209.0 5249.8 5275.8 5277.2 3865.2 4420.4 5103.7 5125.3 5147.4 5018.5 5089.9 5094.5 5094.9 5132.2 5355.4 5477.2 5613.0 5706.9 5720.8 6108.7 6180.9 6240.2 6266.7 6269.3 6187.5 6204.8 6275.5 6287.5 6288.2 5782.2 5794.8 5799.4 5805.4 5847.8 6164.4 6210.5 6219.4 6281.0 6300.8 6064.6 6108.6 6138.1 6145.0 6159.2 6154.4 6207.4 6219.6 6229.1 6251.9 5029.2 6033.6 6096.1 6104.3 6208.6 5137.6 6139.3 6208.5 6209.7 6227.9 4880.0 4898.1 4915.5 4929.5 4984.5 4299.4 4342.3 4357.7 4401.7 4443.9 5558.7 5730.2 5754.7 5772.8 5777.9 6227.2 6258.7 6274.2 6287.4 6298.7 5584.8 5658.8 5721.9 5755.7 5757.0 5331.6 5373.5 5404.2 5415.0 5480.6 6242.2 6278.0 6285.4 6296.6 6317.7 5045.7 6246.6 6250.1 6278.9 6284.5 4755.9 6206.8 6207.1 6249.9 6310.6 6180.4 6209.6 6213.5 6222.2 6239.4 5394.7 5934.7 6212.4 6298.8 6315.1 5069.3 5840.6 6051.7 6073.2 6077.5 6010.6 6078.6 6080.5 6110.1 6114.2 4909.0 5840.1 5874.6 5931.3 5952.2 5044.5 6008.0 6025.5 6028.9 6093.8 5905.0 5922.3 5940.3 5944.4 5970.9 07:02:41 INFO - PROCESS | 1661 | 07:02:41 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:72779.55 Median:40701.19 stddev:161768.23 (397.5%) stddev-sans-first:162131.02 07:02:41 INFO - PROCESS | 1661 | Values: 503.8 504.8 522.7 562.3 602.9 40727.0 42301.4 42388.8 44277.0 44403.8 35499.6 42425.4 43087.1 43580.8 43790.6 9853.7 10005.9 10012.2 10028.6 10050.5 9782.3 9869.5 9879.6 9891.5 9917.9 9901.6 9932.7 9940.1 9941.0 9947.6 9806.7 9834.2 9893.7 9903.6 9923.9 9717.1 9787.5 9805.8 9818.6 9845.5 41428.4 41687.6 41703.4 41995.8 42167.9 3023.5 3260.3 3336.2 3456.5 3579.8 31067.3 31152.7 31185.4 32170.7 32465.5 3190.8 3196.3 3215.7 3299.5 3315.1 497759.0 498134.0 500012.0 502006.0 502353.5 61600.7 62409.7 62664.7 62681.0 62901.4 52322.2 55832.0 56988.0 57829.7 57928.2 16775.0 16965.9 16977.3 16986.0 17075.6 12908.4 12992.5 13099.2 13101.7 13122.9 18271.3 18914.4 19069.5 19092.0 19105.4 7238.5 7529.7 7694.3 7759.0 7804.0 811.7 859.6 935.5 1022.2 1064.5 25251.5 29793.3 30686.4 30806.4 31453.4 982.5 1053.1 1053.9 1056.8 1157.7 11905.8 15606.8 15777.4 15834.0 15856.3 662200.0 669555.0 671524.0 673445.0 675995.0 54707.0 59722.0 59750.4 59819.7 59962.4 1169.6 1170.4 1338.3 1351.3 1377.7 23851.3 25985.4 29406.0 29662.6 30037.8 35380.8 49478.5 50999.7 51214.7 51266.2 625821.0 629679.0 629954.0 630533.0 631120.0 27226.7 27552.0 27624.3 27642.6 27669.7 47897.3 47971.0 48490.8 49163.8 49363.0 39434.8 39759.4 39814.6 40585.2 41107.7 32776.5 39705.4 39987.6 40476.8 40675.4 27082.7 33208.0 36764.8 37798.9 38422.8 27788.3 34607.0 34629.0 34740.7 34869.3 23942.3 25471.9 25502.6 25830.7 26017.5 07:02:41 INFO - PROCESS | 1661 | 07:02:41 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:35588.73 Median:2124.43 stddev:103139.97 (4854.9%) stddev-sans-first:103395.40 07:02:41 INFO - PROCESS | 1661 | Values: 368.1 373.9 378.6 381.1 399.5 18766.9 20967.7 21599.7 21675.5 21786.9 17461.7 17606.7 17964.0 20610.3 20872.7 5550.3 5968.5 6130.0 6170.0 6272.6 4876.8 5467.5 6233.9 6235.5 6238.2 5874.7 6126.7 6154.7 6162.5 6170.3 5892.3 6059.3 6103.7 6143.2 6143.8 5244.5 5317.1 5328.4 5344.0 5368.5 24417.4 24616.5 24802.8 24990.5 25014.0 2271.0 2344.4 2427.5 2449.5 2601.0 14980.9 15554.1 15593.4 15828.0 16141.3 1868.9 1893.1 1895.2 1928.4 1970.9 128278.4 128954.0 129445.0 130432.0 131062.0 7977.4 8107.8 9905.7 10048.8 10627.9 12346.2 12456.0 12512.2 12513.0 12544.2 7985.9 8006.0 8074.8 8160.0 8266.0 8622.3 8637.6 8672.6 8730.6 8819.8 3867.8 3940.9 3941.0 3965.2 4023.9 1754.8 1859.7 1956.5 1961.2 2024.6 683.8 691.4 812.5 877.9 899.2 17442.4 20091.5 20804.9 21093.2 21355.4 788.2 873.0 910.8 945.2 989.9 7828.8 10617.5 11052.0 11070.6 11277.8 543645.0 604301.0 629961.0 640650.0 655504.0 109260.0 135864.6 140281.0 141175.0 147403.0 967.3 1002.9 1018.6 1019.0 1024.1 18206.6 19108.0 19160.4 19161.0 19271.0 47640.5 50644.5 51139.7 51208.0 51720.2 58718.0 74538.6 76702.6 77546.0 77858.2 7839.9 7957.9 8008.4 8094.4 8182.5 9382.7 10602.5 12277.8 12311.0 12437.4 8473.0 9658.5 10773.8 11118.3 11159.6 10595.4 10755.5 10836.7 10864.7 10947.3 11089.4 11097.4 11307.3 11337.3 11511.3 6344.0 6660.6 6678.9 7038.0 7941.1 7560.4 8327.3 8709.8 9510.1 9914.7 07:02:41 INFO - PROCESS | 1661 | 07:02:41 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5682.45 Median:4740.30 stddev:3206.64 (67.6%) stddev-sans-first:3200.36 07:02:41 INFO - PROCESS | 1661 | Values: 1517.3 1548.9 1759.8 1776.7 1863.8 8043.6 8327.3 8444.9 8874.1 8994.5 8433.7 8753.3 8764.9 8858.6 8917.2 1977.8 2312.3 2328.3 2339.6 2341.7 2296.8 2311.8 2347.3 2348.2 2351.9 2303.7 2323.5 2324.0 2336.2 2342.9 2279.4 2285.2 2287.8 2293.6 2296.9 2298.7 2303.9 2306.4 2309.6 2322.7 8376.8 8382.1 8393.7 8403.2 8433.8 4895.9 5059.7 5183.3 5339.0 5358.2 3023.4 3435.3 3508.5 3620.2 3630.1 1081.5 1085.1 1088.1 1096.2 1108.5 11521.5 11527.5 11549.5 11602.8 11659.2 4574.4 4696.1 4784.5 4801.5 4827.4 8520.8 9758.6 10017.3 10024.5 10030.7 4597.2 5262.9 5321.9 5368.2 5371.7 4394.1 4574.2 4873.0 4925.1 4927.4 3894.6 3941.4 4005.7 4032.4 4039.3 1289.6 1298.2 1300.4 1310.3 1312.2 806.2 905.1 915.4 919.8 953.5 5108.4 5744.9 5854.8 5987.8 6009.1 348.2 360.7 428.1 429.8 443.7 3980.6 4005.1 4060.9 4074.5 4105.2 9140.5 10375.5 10604.7 10889.2 10942.1 10536.1 10628.9 10632.6 10667.1 10749.0 8039.6 8282.2 8299.0 8299.4 8303.8 5905.4 5948.6 5993.2 6018.1 6069.7 9926.0 10070.7 10179.1 10194.3 10209.3 10414.7 10419.6 10434.6 10447.3 10447.6 6934.5 7173.1 7342.8 7578.6 7670.9 8212.5 8388.2 8519.7 8541.0 8547.5 6827.5 6846.2 7352.9 7544.7 7604.8 7412.3 7415.9 7418.8 7441.2 7534.1 7053.2 7054.9 7141.2 7156.9 7164.6 4982.6 5004.3 5123.0 5141.5 5262.9 5098.6 5193.4 5217.1 5227.6 5314.8 07:02:41 INFO - PROCESS | 1661 | 07:02:41 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:4372.90 Median:4749.43 stddev:1356.90 (28.6%) stddev-sans-first:1325.18 07:02:41 INFO - PROCESS | 1661 | Values: 263.4 302.8 310.2 313.6 315.6 4331.7 4667.5 5548.3 5557.7 5563.6 5292.6 5385.5 5507.3 5530.0 5556.2 3525.8 4207.6 4210.9 4249.3 4263.3 3402.9 3864.7 4124.6 4154.4 4267.4 4102.9 4115.7 4127.7 4152.7 4159.3 4118.8 4138.6 4139.6 4158.5 4169.0 3156.5 3258.5 3302.2 3417.7 3616.0 4316.6 5205.2 5278.9 5318.6 5363.0 4237.7 4707.6 4710.6 4754.7 4755.4 5162.8 5633.5 5765.5 5805.3 5846.9 3536.3 3785.9 3863.8 3907.6 3911.3 5053.8 5419.7 5799.3 5940.3 6049.3 3975.0 3996.4 4004.2 4011.2 4031.4 3875.6 3925.5 3993.0 4051.7 4055.7 4304.4 4705.3 4732.4 4736.6 4744.1 5220.5 5816.1 5831.4 5835.6 5905.7 1291.6 1296.4 1318.7 1349.5 1380.5 765.6 790.8 811.7 825.9 851.0 4083.2 4405.6 4629.0 4667.5 4681.4 4960.4 5031.4 5067.3 5085.1 5107.9 4039.2 4112.0 4139.0 4139.9 4384.5 2190.7 2218.4 2348.4 2433.0 2613.6 5076.3 5089.7 5251.0 5261.9 5279.7 4387.5 4730.1 4916.9 5150.9 5203.4 4142.6 4619.4 4894.7 5003.7 5157.7 4281.3 4786.6 5041.1 5047.5 5071.4 4138.6 4376.8 5006.4 5021.9 5045.4 4696.7 5183.7 5184.4 5233.0 5272.1 2898.0 3035.8 3296.0 3472.2 3490.0 4352.6 4584.4 4785.2 4849.5 4904.8 5389.8 5621.5 5887.8 5943.0 5949.9 5904.0 5904.3 5911.4 5923.2 5940.3 4928.5 5025.9 5711.5 5823.6 5829.7 4888.9 5152.4 5184.2 5498.2 5898.4 5017.5 5668.5 5672.7 5693.0 5780.9 07:02:41 INFO - PROCESS | 1661 | 07:02:41 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:24134.75 Median:3793.11 stddev:38589.68 (1017.4%) stddev-sans-first:38657.74 07:02:41 INFO - PROCESS | 1661 | Values: 676.7 701.7 772.2 791.1 794.3 14001.0 14087.9 15363.9 15822.5 15829.4 14370.1 15302.4 15711.0 15901.8 16356.8 833.0 858.6 860.1 860.6 862.3 678.4 698.0 826.1 832.6 834.2 870.7 888.0 903.4 903.7 904.1 868.7 886.2 888.5 893.1 893.8 648.9 658.5 662.5 665.3 667.1 14893.0 15463.0 15641.0 15792.9 15848.7 10066.3 13440.9 13707.2 14143.5 14210.9 11742.9 11783.4 11853.1 11944.0 12256.3 3489.7 3670.6 3720.6 3766.7 3819.6 116149.0 117305.8 118256.0 120251.0 121722.0 9312.9 10413.0 10837.9 10855.6 11102.4 22102.7 22300.1 22368.7 22375.9 22383.1 7860.9 7889.4 7958.2 8059.5 8158.7 4411.6 4432.8 4470.6 4490.5 4650.2 3595.9 3619.9 3683.5 3710.6 3715.4 649.6 657.2 664.6 682.6 686.1 639.8 649.0 656.8 668.2 675.9 8768.9 9332.2 9430.5 9598.3 9609.1 537.3 631.3 662.9 673.2 675.7 4380.2 4381.9 4604.6 4647.1 4715.5 113832.0 115051.0 135405.0 163867.2 172872.3 86196.1 97484.1 98989.5 102186.0 103435.0 97437.0 111139.0 114479.4 121405.2 122951.0 8827.0 8887.0 8917.4 8929.9 8944.2 60559.1 61403.0 62767.4 63713.0 69052.7 91272.5 99921.0 106002.9 106503.0 107598.0 9624.0 11595.7 11648.5 11768.0 11917.8 11064.9 12320.6 12686.6 12927.8 12984.7 10235.9 11903.3 12053.3 12454.1 12666.7 11909.4 12145.6 12397.6 12514.2 12639.0 11828.9 11904.3 12066.8 12172.8 12353.4 10127.6 10243.5 10379.6 10513.2 10520.1 8896.8 9054.0 9462.5 9571.5 9869.2 07:02:41 INFO - PROCESS | 1661 | -------- Summary: end -------- 07:02:41 INFO - PROCESS | 1661 | 07:02:42 INFO - TEST-INFO | 1661: exit 0 07:02:42 INFO - TEST-OK | dromaeo_css | took 1115621ms 07:02:42 INFO - TEST-START | kraken 07:02:42 INFO - operating with platform_type : mac_ 07:02:42 INFO - Initialising browser for kraken test... 07:02:42 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpczlZtJ/profile http://localhost:49277/getInfo.html) 07:02:45 INFO - PROCESS | 1670 | 2016-10-06 07:02:45.088 plugin-container[1671:9943] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c23, name = 'com.apple.tsm.portname' 07:02:45 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:02:45 INFO - PROCESS | 1670 | 2016-10-06 07:02:45.091 plugin-container[1671:9943] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9203, name = 'com.apple.CFPasteboardClient' 07:02:45 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:02:45 INFO - PROCESS | 1670 | 2016-10-06 07:02:45.091 plugin-container[1671:9943] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:02:45 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 07:02:45 INFO - PROCESS | 1670 | colorDepth:24 07:02:45 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 07:02:45 INFO - PROCESS | 1670 | __metrics 07:02:45 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 07:02:45 INFO - TEST-INFO | 1670: exit 0 07:02:45 INFO - Browser initialized. 07:02:45 INFO - Running cycle 1/1 for kraken test... 07:02:46 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpczlZtJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:02:48 INFO - PROCESS | 1672 | 2016-10-06 07:02:48.597 plugin-container[1673:10060] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b27, name = 'com.apple.tsm.portname' 07:02:48 INFO - PROCESS | 1672 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:02:48 INFO - PROCESS | 1672 | 2016-10-06 07:02:48.600 plugin-container[1673:10060] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0f, name = 'com.apple.CFPasteboardClient' 07:02:48 INFO - PROCESS | 1672 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:02:48 INFO - PROCESS | 1672 | 2016-10-06 07:02:48.600 plugin-container[1673:10060] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:02:58 INFO - PROCESS | 1672 | RSS: Main: 240353280 07:02:58 INFO - PROCESS | 1672 | 07:03:01 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 07:03:02 INFO - PROCESS | 1672 | RSS: Main: 253927424 07:03:02 INFO - PROCESS | 1672 | 07:03:04 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 07:03:05 INFO - PROCESS | 1672 | RSS: Main: 262520832 07:03:05 INFO - PROCESS | 1672 | 07:03:08 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 07:03:09 INFO - PROCESS | 1672 | RSS: Main: 262529024 07:03:09 INFO - PROCESS | 1672 | 07:03:11 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 07:03:11 INFO - PROCESS | 1672 | RSS: Main: 264761344 07:03:11 INFO - PROCESS | 1672 | 07:03:13 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:03:14 INFO - PROCESS | 1672 | RSS: Main: 265052160 07:03:14 INFO - PROCESS | 1672 | 07:03:17 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 07:03:18 INFO - PROCESS | 1672 | RSS: Main: 265805824 07:03:18 INFO - PROCESS | 1672 | 07:03:20 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 07:03:21 INFO - PROCESS | 1672 | RSS: Main: 265732096 07:03:21 INFO - PROCESS | 1672 | 07:03:24 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 07:03:25 INFO - PROCESS | 1672 | RSS: Main: 266231808 07:03:25 INFO - PROCESS | 1672 | 07:03:26 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:03:27 INFO - PROCESS | 1672 | RSS: Main: 265957376 07:03:27 INFO - PROCESS | 1672 | 07:03:29 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:03:29 INFO - PROCESS | 1672 | RSS: Main: 266022912 07:03:29 INFO - PROCESS | 1672 | 07:03:32 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:03:32 INFO - PROCESS | 1672 | RSS: Main: 266039296 07:03:32 INFO - PROCESS | 1672 | 07:03:35 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:03:36 INFO - PROCESS | 1672 | RSS: Main: 266080256 07:03:36 INFO - PROCESS | 1672 | 07:03:39 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:03:40 INFO - PROCESS | 1672 | RSS: Main: 266412032 07:03:40 INFO - PROCESS | 1672 | 07:03:41 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 07:03:41 INFO - PROCESS | 1672 | RSS: Main: 267812864 07:03:41 INFO - PROCESS | 1672 | 07:03:41 INFO - PROCESS | 1672 | __start_tp_report 07:03:41 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 07:03:41 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 07:03:41 INFO - PROCESS | 1672 | |i|pagename|runs| 07:03:41 INFO - PROCESS | 1672 | |0;ai-astar;113;117;121;117;118;117;117;116;138;119 07:03:41 INFO - PROCESS | 1672 | |1;audio-beat-detection;146;113;116;149;114;129;118;117;144;118 07:03:41 INFO - PROCESS | 1672 | |2;audio-dft;201;208;221;198;196;194;195;196;253;270 07:03:41 INFO - PROCESS | 1672 | |3;audio-fft;80;58;59;84;62;59;60;59;80;59 07:03:41 INFO - PROCESS | 1672 | |4;audio-oscillator;85;71;87;72;69;78;74;85;56;71 07:03:41 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;91;80;136;126;91;96;92;84;126;89 07:03:41 INFO - PROCESS | 1672 | |6;imaging-darkroom;96;97;119;128;97;97;97;97;96;96 07:03:41 INFO - PROCESS | 1672 | |7;imaging-desaturate;99;94;110;77;150;150;128;91;99;131 07:03:41 INFO - PROCESS | 1672 | |8;json-parse-financial;55;56;54;56;58;58;57;56;56;54 07:03:41 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;68;68;76;81;73;68;69;70;69;69 07:03:41 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;88;90;88;88;90;91;99;95;88;80 07:03:41 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;145;150;145;154;152;163;165;159;181;177 07:03:41 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;171;176;174;174;177;196;173;174;161;221 07:03:41 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;72;71;69;68;70;68;70;69;68;69 07:03:41 INFO - PROCESS | 1672 | __end_tp_report 07:03:41 INFO - PROCESS | 1672 | __start_cc_report 07:03:41 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,941 07:03:41 INFO - PROCESS | 1672 | __end_cc_report 07:03:41 INFO - PROCESS | 1672 | __startTimestamp1475762621948__endTimestamp 07:03:41 INFO - PROCESS | 1672 | 07:03:41 INFO - PROCESS | 1672 | ------- Summary: start ------- 07:03:41 INFO - PROCESS | 1672 | Number of tests: 14 07:03:41 INFO - PROCESS | 1672 | 07:03:41 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:119.30 Median:117.50 stddev:6.88 (5.9%) stddev-sans-first:6.91 07:03:41 INFO - PROCESS | 1672 | Values: 113.0 117.0 121.0 117.0 118.0 117.0 117.0 116.0 138.0 119.0 07:03:41 INFO - PROCESS | 1672 | 07:03:41 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:126.40 Median:123.50 stddev:14.46 (11.7%) stddev-sans-first:13.49 07:03:41 INFO - PROCESS | 1672 | Values: 146.0 113.0 116.0 149.0 114.0 129.0 118.0 117.0 144.0 118.0 07:03:41 INFO - PROCESS | 1672 | 07:03:41 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:213.20 Median:204.50 stddev:27.02 (13.2%) stddev-sans-first:28.29 07:03:41 INFO - PROCESS | 1672 | Values: 201.0 208.0 221.0 198.0 196.0 194.0 195.0 196.0 253.0 270.0 07:03:41 INFO - PROCESS | 1672 | 07:03:41 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:66.00 Median:61.00 stddev:10.69 (17.5%) stddev-sans-first:10.06 07:03:41 INFO - PROCESS | 1672 | Values: 80.0 58.0 59.0 84.0 62.0 59.0 60.0 59.0 80.0 59.0 07:03:41 INFO - PROCESS | 1672 | 07:03:41 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:74.80 Median:76.00 stddev:9.38 (12.3%) stddev-sans-first:9.19 07:03:41 INFO - PROCESS | 1672 | Values: 85.0 71.0 87.0 72.0 69.0 78.0 74.0 85.0 56.0 71.0 07:03:41 INFO - PROCESS | 1672 | 07:03:41 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:101.10 Median:90.00 stddev:20.15 (22.4%) stddev-sans-first:21.04 07:03:41 INFO - PROCESS | 1672 | Values: 91.0 80.0 136.0 126.0 91.0 96.0 92.0 84.0 126.0 89.0 07:03:41 INFO - PROCESS | 1672 | 07:03:41 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:102.00 Median:97.00 stddev:11.54 (11.9%) stddev-sans-first:12.03 07:03:41 INFO - PROCESS | 1672 | Values: 96.0 97.0 119.0 128.0 97.0 97.0 97.0 97.0 96.0 96.0 07:03:41 INFO - PROCESS | 1672 | 07:03:41 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:112.90 Median:84.00 stddev:25.45 (30.3%) stddev-sans-first:26.49 07:03:41 INFO - PROCESS | 1672 | Values: 99.0 94.0 110.0 77.0 150.0 150.0 128.0 91.0 99.0 131.0 07:03:41 INFO - PROCESS | 1672 | 07:03:41 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.41 (2.5%) stddev-sans-first:1.45 07:03:41 INFO - PROCESS | 1672 | Values: 55.0 56.0 54.0 56.0 58.0 58.0 57.0 56.0 56.0 54.0 07:03:41 INFO - PROCESS | 1672 | 07:03:41 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:69.50 stddev:4.33 (6.2%) stddev-sans-first:4.45 07:03:41 INFO - PROCESS | 1672 | Values: 68.0 68.0 76.0 81.0 73.0 68.0 69.0 70.0 69.0 69.0 07:03:41 INFO - PROCESS | 1672 | 07:03:41 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:90.00 stddev:4.97 (5.5%) stddev-sans-first:5.23 07:03:41 INFO - PROCESS | 1672 | Values: 88.0 90.0 88.0 88.0 90.0 91.0 99.0 95.0 88.0 80.0 07:03:41 INFO - PROCESS | 1672 | 07:03:41 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:159.10 Median:161.00 stddev:12.50 (7.8%) stddev-sans-first:12.18 07:03:41 INFO - PROCESS | 1672 | Values: 145.0 150.0 145.0 154.0 152.0 163.0 165.0 159.0 181.0 177.0 07:03:41 INFO - PROCESS | 1672 | 07:03:41 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.70 Median:175.00 stddev:16.87 (9.6%) stddev-sans-first:17.59 07:03:41 INFO - PROCESS | 1672 | Values: 171.0 176.0 174.0 174.0 177.0 196.0 173.0 174.0 161.0 221.0 07:03:41 INFO - PROCESS | 1672 | 07:03:41 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:1.35 (1.9%) stddev-sans-first:1.05 07:03:41 INFO - PROCESS | 1672 | Values: 72.0 71.0 69.0 68.0 70.0 68.0 70.0 69.0 68.0 69.0 07:03:41 INFO - PROCESS | 1672 | -------- Summary: end -------- 07:03:41 INFO - PROCESS | 1672 | 07:03:42 INFO - TEST-INFO | 1672: exit 0 07:03:42 INFO - TEST-OK | kraken | took 60351ms 07:03:42 INFO - SUITE-END | took 1175s 07:03:43 INFO - Completed test suite (00:19:36) 07:03:43 INFO - javascript benchmark 07:03:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7214.323077063462, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3299.554560134382, 3303.8182899940493, 3324.002799160253, 3351.212465070708, 3363.260082781788, 5512.44875512449, 5552.305961754786, 5575.386707462176, 5629.35262444819, 5640.351359593648, 5447.482489163533, 5604.243427137335, 5623.015972204868, 5644.689542075184, 5656.406077361879, 5100.311457953175, 5170.819021334254, 5215.217717342391, 5221.556167725748, 5223.895522089556, 4223.598758117974, 4259.233337999159, 4368.97815510922, 5279.604029697769, 5352.0, 4974.527419895104, 5208.9739551302, 5249.763760630781, 5275.788968441258, 5277.182036784305, 3865.1689886674217, 4420.381146639473, 5103.744812759347, 5125.3080834087295, 5147.408048074444, 5018.5232402921665, 5089.898202035975, 5094.465081166498, 5094.949050509485, 5132.153194722866, 5355.4109048005075, 5477.1510415885605, 5613.017721898651, 5706.914396284059, 5720.828375148711, 6108.6759897029115, 6180.907286390708, 6240.219972503437, 6266.717997690115, 6269.310375858652, 6187.4740647045055, 6204.751809927598, 6275.529335299871, 6287.52843536732, 6288.245410550718, 5782.190493330937, 5794.797182098607, 5799.391063938226, 5805.448482394166, 5847.7953271635715, 6164.445199932027, 6210.472109870621, 6219.378062193744, 6280.968595157086, 6300.779472718433, 6064.636121832704, 6108.602940808833, 6138.07928810673, 6145.047517634774, 6159.168512250879, 6154.366219588621, 6207.441330280297, 6219.595726277777, 6229.065640154013, 6251.937480625226, 5029.245613157982, 6033.607815491979, 6096.103393722308, 6104.267487901391, 6208.627482351073, 5137.640365174477, 6139.29398119222, 6208.534359923024, 6209.6895155242055, 6227.9377206227355, 4879.975600121977, 4898.093852637274, 4915.48387419323, 4929.531694489017, 4984.476629953802, 4299.398084268205, 4342.261815491374, 4357.716748411343, 4401.735895846259, 4443.933340999887, 5558.666480011212, 5730.226419433323, 5754.712264386764, 5772.826815195551, 5777.942220577825, 6227.221597300338, 6258.655773932386, 6274.215723034621, 6287.371262873768, 6298.716557754912, 5584.804531841366, 5658.830235092953, 5721.942780572224, 5755.683437410982, 5756.971215143897, 5331.600129990266, 5373.489518495737, 5404.189371594292, 5415.0, 5480.561555075664, 6242.157308763441, 6277.968610157011, 6285.43431091204, 6296.590721603081, 6317.652529110943, 5045.747712614281, 6246.562740608114, 6250.0937364082865, 6278.905816412666, 6284.497240220863, 4755.904881902274, 6206.813795586139, 6207.068939658907, 6249.906251406142, 6310.5898116622275, 6180.351063138485, 6209.59637623553, 6213.5339849510565, 6222.222222222223, 6239.438450539292, 5394.676319420847, 5934.732937017759, 6212.378762123752, 6298.811035668938, 6315.115883776367, 5069.3156423883775, 5840.561957853263, 6051.697415129314, 6073.210482637229, 6077.4834139098675, 6010.579259451796, 6078.635281883101, 6080.48315893154, 6110.114033465212, 6114.174586430775, 4908.9754551227015, 5840.123981402654, 5874.5887787854435, 5931.258592675916, 5952.196453478725, 5044.47033061538, 6008.03871380577, 6025.457708806229, 6028.939710602838, 6093.817185484442, 5905.0, 5922.289325280994, 5940.346561878104, 5944.375840536854, 5970.910436343545], "value": 5591.420439741894, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.84632687030444, 504.82627890155385, 522.6863881670995, 562.3336346429481, 602.8583282928511, 40727.0, 42301.36547951779, 42388.788056059675, 44277.0, 44403.77798111013, 35499.64500354996, 42425.36361954573, 43087.13825723492, 43580.782096089555, 43790.56209437905, 9853.65512207073, 10005.899941000605, 10012.199024078056, 10028.598856045786, 10050.49747512625, 9782.26633002524, 9869.457179855106, 9879.604815807359, 9891.455969921652, 9917.851232231522, 9901.603935842593, 9932.6523571675, 9940.055694709028, 9940.950295248549, 9947.602095916154, 9806.705798826046, 9834.213262938947, 9893.653722119763, 9903.603855845757, 9923.851142232836, 9717.125458708679, 9787.46168960707, 9805.754856128582, 9818.558164882597, 9845.45849978251, 41428.37857432141, 41687.583124168676, 41703.374449383286, 41995.79002105001, 42167.94580135491, 3023.5011223148153, 3260.2990357073345, 3336.249343897628, 3456.4815277708294, 3579.7534146027024, 31067.291298978547, 31152.688473115206, 31185.37629247425, 32170.678293217003, 32465.51301730476, 3190.840457977115, 3196.3447493263825, 3215.678432156789, 3299.538064670948, 3315.088350703552, 497759.0, 498134.0, 500012.0, 502006.0, 502353.48823256016, 61600.69199654063, 62409.68795156086, 62664.74670506656, 62681.0, 62901.370986290465, 52322.21516677253, 55832.0, 56988.0, 57829.710851445474, 57928.20717928258, 16774.993500390017, 16965.91517042407, 16977.320907163576, 16985.980841149572, 17075.573110672085, 12908.419121139572, 12992.545260915822, 13099.2140471572, 13101.672458188621, 13122.868771312356, 18271.294490911532, 18914.43256702301, 19069.523261918563, 19092.040733686023, 19105.426837194907, 7238.493305468672, 7529.661165247577, 7694.307512323918, 7759.0, 7804.024496937883, 811.7280710961776, 859.5530324231489, 935.4574346878794, 1022.223110436074, 1064.4624464645306, 25251.494970100863, 29793.25516862096, 30686.38627227443, 30806.38387232243, 31453.37093258122, 982.4841957971979, 1053.083817079146, 1053.8840727519967, 1056.8361903904906, 1157.6642773595563, 11905.821412678817, 15606.843931560767, 15777.442828480258, 15834.049957002617, 15856.286467109008, 662200.0, 669555.0, 671524.0, 673445.0, 675995.0, 54707.0, 59722.0, 59750.40249597535, 59819.70090149521, 59962.40037599568, 1169.6257197696825, 1170.3621526268034, 1338.3174580963778, 1351.290572449472, 1377.6831328794233, 23851.284461466184, 25985.350366240997, 29406.0, 29662.555061674524, 30037.84981075168, 35380.823095884356, 49478.50521494739, 50999.74500127476, 51214.719632009495, 51266.23100653419, 625821.0, 629679.0, 629954.0, 630533.0, 631120.0, 27226.72773272242, 27552.0, 27624.309392265353, 27642.585361219197, 27669.723302766713, 47897.281540777614, 47971.0, 48490.757546212044, 49163.75418122886, 49363.0, 39434.80282598569, 39759.40360894531, 39814.60185398225, 40585.1882962345, 41107.656004719196, 32776.50835237426, 39705.40441893316, 39987.60012399839, 40476.78569642916, 40675.3898691514, 27082.72917270802, 33208.003759887244, 36764.816175918946, 37798.866034019025, 38422.80788596039, 27788.30529236785, 34606.989065941176, 34629.0, 34740.652593474755, 34869.302613947075, 23942.281731548082, 25471.872640636677, 25502.617460737732, 25830.749662135873, 26017.47965040651], "value": 20102.566538051942, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.1036675694682, 373.9476473293739, 378.6421831369356, 381.1006025779159, 399.494639281309, 18766.906165469172, 20967.685484717742, 21599.67600485992, 21675.45811354717, 21786.89106554465, 17461.73807392887, 17606.654735600227, 17964.011979341132, 20610.278640247594, 20872.686909696367, 5550.250716153308, 5968.492678122354, 6129.969350153266, 6170.0, 6272.59228150171, 4876.804927802884, 5467.480589344006, 6233.937660623404, 6235.501159907197, 6238.220222472191, 5874.676892770896, 6126.724297406605, 6154.692265386735, 6162.5378096642935, 6170.259568851721, 5892.263467066617, 6059.303180134253, 6103.664298463583, 6143.232095988002, 6143.754249830002, 5244.501772331622, 5317.1492561190025, 5328.413874473805, 5343.957928204002, 5368.463153684639, 24417.389565260833, 24616.5076698465, 24802.751972480226, 24990.5001899961, 25014.0, 2271.034810205656, 2344.3963872911036, 2427.5023620157826, 2449.473363226915, 2600.9609855852177, 14980.925095374563, 15554.066755994563, 15593.37626494939, 15828.0, 16141.27364268599, 1868.945755956328, 1893.1102381880632, 1895.1566552883971, 1928.3540014095295, 1970.8521860860492, 128278.35860820636, 128954.0, 129445.0, 130432.0, 131061.99999999904, 7977.401694872908, 8107.756767296991, 9905.702828915144, 10048.79902401948, 10627.946860265803, 12346.197497162655, 12456.0, 12512.249265044127, 12513.0, 12544.184627999151, 7985.880211796828, 8006.039275286887, 8074.798130046795, 8159.95920020408, 8265.95867020673, 8622.26710729595, 8637.611307491177, 8672.60973256205, 8730.563471826383, 8819.779505512413, 3867.7679339239735, 3940.8817735467983, 3941.034446560611, 3965.246603145451, 4023.8591649292134, 1754.8418044090838, 1859.748933893934, 1956.5206524401613, 1961.2449207055386, 2024.631181517628, 683.8290427393151, 691.4226620771611, 812.4881324765478, 877.8770972063916, 899.1637776867576, 17442.389516366868, 20091.49771255701, 20804.855732934833, 21093.15627374888, 21355.35933921985, 788.2393490281905, 872.9912700873037, 910.7586489580267, 945.229637845154, 989.9010098990187, 7828.765137045898, 10617.469126543796, 11052.005319521282, 11070.5571777128, 11277.774444511064, 543645.0, 604301.0, 629961.0, 640650.0, 655504.0, 109260.0, 135864.60338491618, 140281.0, 141175.0, 147403.0, 967.2503809547657, 1002.8946960569181, 1018.6485662446444, 1019.0421004255976, 1024.1243736605095, 18206.635867282846, 19108.044597770335, 19160.425187244404, 19161.041947902828, 19271.0, 47640.52359476361, 50644.49355506545, 51139.74430127825, 51207.97584048373, 51720.22419663633, 58718.0, 74538.62730686311, 76702.6164869172, 77546.0, 77858.2214177851, 7839.882401764092, 7957.920420795718, 8008.399370047387, 8094.433389662902, 8182.509049457051, 9382.733331000501, 10602.522886470282, 12277.75444491123, 12311.0, 12437.440315186019, 8473.025602055843, 9658.508425316557, 10773.784524309627, 11118.332900026024, 11159.609413670483, 10595.417252051211, 10755.516001779783, 10836.67489975302, 10864.674059778219, 10947.288426252268, 11089.445527723421, 11097.445127743418, 11307.265027773168, 11337.26307790024, 11511.251768635011, 6344.0, 6660.56706314088, 6678.899816502659, 7037.964810175917, 7941.12647608751, 7560.395168386626, 8327.250547450758, 8709.824173736464, 9510.09654082861, 9914.702558923243], "value": 9355.264466595694, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1517.3247904682416, 1548.9225538723065, 1759.780027496563, 1776.6674993754684, 1863.7577114975052, 8043.55760433176, 8327.292180164679, 8444.91555084449, 8874.068222836606, 8994.460332380062, 8433.70482033129, 8753.343499237566, 8764.8685269721, 8858.5570721464, 8917.197452229299, 1977.7626684797845, 2312.2947501012227, 2328.3364241191266, 2339.6022676145094, 2341.718993720756, 2296.8392212545127, 2311.838171328008, 2347.284078356109, 2348.154664320843, 2351.8824058797077, 2303.7005189325364, 2323.465602911323, 2323.965140522885, 2336.158982766203, 2342.941426464335, 2279.350385140235, 2285.2001799370255, 2287.7597852225526, 2293.598620241451, 2296.8621882687007, 2298.6666933294746, 2303.896324665394, 2306.411864974438, 2309.595820731382, 2322.6632138339846, 8376.790580235544, 8382.119877412844, 8393.748187554384, 8403.159684031609, 8433.789155271106, 4895.8776030599165, 5059.74701264939, 5183.326167598226, 5339.0, 5358.223057656618, 3023.3953209358215, 3435.2651910784894, 3508.456189290664, 3620.185458271868, 3630.110622897381, 1081.4646749858791, 1085.1210519479168, 1088.1458055426451, 1096.2216826053511, 1108.5288752280248, 11521.539138434453, 11527.538898444136, 11549.480273387719, 11602.76794464106, 11659.183857130005, 4574.405327307495, 4696.107739529547, 4784.497627749036, 4801.51984801524, 4827.396575428072, 8520.764489149038, 9758.560864761102, 10017.298789084694, 10024.498775061218, 10030.749231269278, 4597.241455159861, 5262.894792093627, 5321.8935621287355, 5368.1679339702405, 5371.650842695212, 4394.121175764796, 4574.199515084847, 4873.0, 4925.113479573711, 4927.359443272351, 3894.5910679378826, 3941.428492868518, 4005.6995725320717, 4032.415299781574, 4039.313316736162, 1289.5615490733196, 1298.2210673595766, 1300.4343110746856, 1310.3120861547764, 1312.2389014371643, 806.2300503019602, 905.1220316293185, 915.3889155086962, 919.8475567172848, 953.4612943686933, 5108.438071812097, 5744.942550574441, 5854.795082172103, 5987.760489580368, 6009.128676341906, 348.1835096698239, 360.6519708481328, 428.0924440186824, 429.7636300034968, 443.6738996837322, 3980.5621381647998, 4005.118873847749, 4060.898477538026, 4074.531428885716, 4105.199486100182, 9140.451572905647, 10375.481225938673, 10604.681859544226, 10889.237753357347, 10942.124630029579, 10536.051755342056, 10628.893711062945, 10632.574697012033, 10667.146628269875, 10749.0, 8039.598020098972, 8282.213189746964, 8298.958505207434, 8299.377546683902, 8303.792405189919, 5905.40945905406, 5948.583599148018, 5993.220881285405, 6018.127371531191, 6069.696515174312, 9926.007399260016, 10070.69787906364, 10179.083882450615, 10194.286399951932, 10209.285350025428, 10414.739631509274, 10419.635312764018, 10434.634787782392, 10447.320924139907, 10447.58209671635, 6934.549254298455, 7173.10336207974, 7342.816429589303, 7578.621068946641, 7670.884936725842, 8212.548309842778, 8388.161183881562, 8519.74440766778, 8541.0, 8547.52988585609, 6827.522073455009, 6846.178458585002, 7352.852942941218, 7544.698212071456, 7604.771856844303, 7412.258774122544, 7415.925840741524, 7418.814529636802, 7441.181470038183, 7534.095908491016, 7053.188883278489, 7054.894176587458, 7141.178764442156, 7156.892646610409, 7164.641767911688, 4982.55157035854, 5004.274380214922, 5122.974385128051, 5141.511556402285, 5262.947370526245, 5098.566621837037, 5193.350831146106, 5217.06092903281, 5227.555657769132, 5314.760835762323], "value": 4478.861277772935, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [263.40076326357536, 302.80317793434267, 310.2445545097687, 313.5657114895869, 315.63071206688187, 4331.660903112315, 4667.486576476589, 5548.278723765905, 5557.666540007603, 5563.554915606752, 5292.603054770898, 5385.465142434407, 5507.339119305689, 5529.953917050697, 5556.16657501375, 3525.806080665562, 4207.600277973603, 4210.936835947463, 4249.277622804116, 4263.3178691409385, 3402.8638854445794, 3864.6908247340143, 4124.649404800595, 4154.442084218418, 4267.423897773808, 4102.897427564305, 4115.650169735576, 4127.669786417079, 4152.68854835887, 4159.292920203573, 4118.805546391558, 4138.606832350922, 4139.627433530996, 4158.521769996459, 4168.979155104235, 3156.510740835174, 3258.4786434170655, 3302.207470207157, 3417.726581873444, 3615.981920090409, 4316.633086187678, 5205.193195054772, 5278.894422111536, 5318.574514038867, 5362.973185134049, 4237.660987121023, 4707.6233901287815, 4710.552497512731, 4754.7147171169845, 4755.42934847817, 5162.812553112805, 5633.521150702154, 5765.4522820332, 5805.274340707411, 5846.883062338772, 3536.3104194682046, 3785.886423407302, 3863.826127824255, 3907.5808667416013, 3911.256861196392, 5053.797848086072, 5419.674819510842, 5799.275090613715, 5940.287165540163, 6049.334573196945, 3975.0, 3996.4205190247253, 4004.1591265833918, 4011.1777085697363, 4031.354983202732, 3875.5736868944396, 3925.4896863408144, 3993.0416699991792, 4051.716379853441, 4055.7160998729805, 4304.418903447994, 4705.341252224691, 4732.408448943882, 4736.621070314367, 4744.146053710365, 5220.451852555503, 5816.127580862904, 5831.358550559435, 5835.620684655484, 5905.667261431797, 1291.6040744419156, 1296.4101333893057, 1318.7340153452792, 1349.5141748970364, 1380.475419340644, 765.5865832450414, 790.7983464216703, 811.7402431222071, 825.8761185822175, 850.9873250831614, 4083.244599749056, 4405.62969328464, 4629.042168945571, 4667.463241727245, 4681.368015317888, 4960.355153829979, 5031.396232452129, 5067.341245638044, 5085.1355269604255, 5107.923381149286, 4039.2123535910805, 4112.005677246533, 4138.958610413857, 4139.91720165595, 4384.517703052662, 2190.6713992900873, 2218.3899427657525, 2348.4246359641998, 2432.97567024331, 2613.5818269077236, 5076.314697515788, 5089.720065396365, 5250.97374513125, 5261.894762104736, 5279.736013199325, 4387.473503179575, 4730.148573256778, 4916.869120102397, 5150.944056468415, 5203.401608814959, 4142.608834635236, 4619.3994780678295, 4894.730789806595, 5003.749812509433, 5157.6647517911215, 4281.314989601648, 4786.569208771228, 5041.067402530543, 5047.536214497754, 5071.39143302806, 4138.606832350922, 4376.824927002885, 5006.374203224597, 5021.949780502148, 5045.4450010498085, 4696.7084051886, 5183.740812959261, 5184.351956005499, 5233.0, 5272.124988133795, 2898.0001899344693, 3035.787494875426, 3296.027671836766, 3472.211810917329, 3490.0, 4352.564743525749, 4584.426946631671, 4785.186518291829, 4849.5025062092345, 4904.754762261944, 5389.75746091419, 5621.482199805948, 5887.793927212527, 5943.0, 5949.910751338647, 5903.970480147572, 5904.3210030845285, 5911.408859114226, 5923.200367950271, 5940.346561878277, 4928.507149285043, 5025.924611130763, 5711.457411545896, 5823.5923485355615, 5829.708514574169, 4888.877778055577, 5152.381714194321, 5184.196449550326, 5498.233709908725, 5898.439648233411, 5017.523335283142, 5668.461496157858, 5672.688002159921, 5692.971535142297, 5780.930527852361], "value": 3938.514962596175, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.7259259999701, 701.7017767448834, 772.2239149654599, 791.1337085890951, 794.3049831397527, 14001.0, 14087.859121408783, 15363.923180384083, 15822.525324240263, 15829.445969391074, 14370.065945713548, 15302.387904483807, 15710.978786378906, 15901.840981590181, 16356.75464868025, 832.950022998619, 858.635080090962, 860.0883063952231, 860.5912191708951, 862.3230763850379, 678.4470656415031, 698.0123125777019, 826.0789220019694, 832.5795473285982, 834.2241715204857, 870.651739304277, 888.0231745080392, 903.3992395057312, 903.7379160043612, 904.1049361132465, 868.7176667582997, 886.2289807867197, 888.5201990924893, 893.093510087262, 893.7631527645179, 648.9253735820347, 658.5127006015562, 662.5031226580065, 665.2748504130521, 667.1027468055457, 14893.0, 15463.0, 15640.983336083118, 15792.92103539475, 15848.68302633941, 10066.29535932485, 13440.865591344156, 13707.246101464416, 14143.504977325847, 14210.857891421058, 11742.941285293518, 11783.410829458493, 11853.111016673698, 11943.9847612953, 12256.325902075383, 3489.6859282664427, 3670.614585468514, 3720.5535335759882, 3766.6610005099674, 3819.560750513671, 116149.0, 117305.8269417312, 118256.0, 120250.9937251567, 121722.0, 9312.906870931203, 10413.0, 10837.891621083845, 10855.565777368816, 11102.389368584805, 22102.668459973112, 22300.107995680315, 22368.664470032963, 22375.87429194224, 22383.104675813112, 7860.9213907860185, 7889.408294377945, 7958.204179581995, 8059.476134051268, 8158.67365305393, 4411.580899814512, 4432.844850430284, 4470.597646211857, 4490.50604433512, 4650.209464391061, 3595.94606080909, 3619.8914032579064, 3683.5395575553057, 3710.6103859094947, 3715.368387374153, 649.6297110646885, 657.2277573850706, 664.6012392564422, 682.6006786030227, 686.1217641418991, 639.7728806273799, 648.9740410383627, 656.8325077105403, 668.1814776898261, 675.8850995330805, 8768.912310876936, 9332.16010559053, 9430.481323527272, 9598.275271103445, 9609.087136722, 537.3363895588944, 631.2897989761518, 662.8674265146893, 673.1854456108066, 675.6520391998125, 4380.211561918822, 4381.868543943687, 4604.58558729716, 4647.09381670571, 4715.504871988461, 113832.0, 115051.0, 135405.0, 163867.1679699222, 172872.27127728812, 86196.13803862006, 97484.07547773578, 98989.5151572727, 102186.0, 103434.96565034403, 97437.0, 111139.0, 114479.42760286311, 121405.17892231447, 122951.0, 8827.0, 8886.955565222133, 8917.375783695079, 8929.910700893168, 8944.150305720947, 60559.09161362671, 61403.0, 62767.37232627798, 63713.0, 69052.65473672599, 91272.54363728139, 99921.0, 106002.93997059931, 106503.0, 107598.0, 9624.0, 11595.652130436101, 11648.475818588353, 11767.999720023552, 11917.82123268169, 11064.944675276573, 12320.630381088582, 12686.555970540987, 12927.806082908575, 12984.740305194033, 10235.897641023494, 11903.285802851857, 12053.276803391474, 12454.128211025503, 12666.683332916751, 11909.40452977365, 12145.574904878287, 12397.62807115788, 12514.249145051326, 12639.0, 11828.940855295668, 11904.285742855456, 12066.75866482683, 12172.756544868877, 12353.444095015566, 10127.59489620407, 10243.487825608541, 10379.584816607252, 10513.158947284046, 10520.105791007543, 8896.777580560538, 9054.004059553312, 9462.479563624067, 9571.521423928636, 9869.210463163074], "value": 7599.6713969179, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 121.0, 117.0, 118.0, 117.0, 117.0, 116.0, 138.0, 119.0], "value": 119.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 113.0, 116.0, 149.0, 114.0, 129.0, 118.0, 117.0, 144.0, 118.0], "value": 126.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 208.0, 221.0, 198.0, 196.0, 194.0, 195.0, 196.0, 253.0, 270.0], "value": 213.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 59.0, 84.0, 62.0, 59.0, 60.0, 59.0, 80.0, 59.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 87.0, 72.0, 69.0, 78.0, 74.0, 85.0, 56.0, 71.0], "value": 74.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 80.0, 136.0, 126.0, 91.0, 96.0, 92.0, 84.0, 126.0, 89.0], "value": 101.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 119.0, 128.0, 97.0, 97.0, 97.0, 97.0, 96.0, 96.0], "value": 102.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 110.0, 77.0, 150.0, 150.0, 128.0, 91.0, 99.0, 131.0], "value": 112.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 54.0, 56.0, 58.0, 58.0, 57.0, 56.0, 56.0, 54.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 76.0, 81.0, 73.0, 68.0, 69.0, 70.0, 69.0, 69.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 88.0, 88.0, 90.0, 91.0, 99.0, 95.0, 88.0, 80.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 150.0, 145.0, 154.0, 152.0, 163.0, 165.0, 159.0, 181.0, 177.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 176.0, 174.0, 174.0, 177.0, 196.0, 173.0, 174.0, 161.0, 221.0], "value": 179.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 69.0, 68.0, 70.0, 68.0, 70.0, 69.0, 68.0, 69.0], "value": 69.4, "unit": "score"}]}]} 07:03:43 INFO - Return code: 0 07:03:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:03:43 ERROR - # TBPL SUCCESS # 07:03:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:03:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:03:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:03:43 INFO - 2016-10-06 07:03:43.275 screenresolution[1677:10446] starting screenresolution argv=screenresolution get 07:03:43 INFO - 2016-10-06 07:03:43.277 screenresolution[1677:10446] Display 0: 1600x1200x32@60 07:03:43 INFO - 2016-10-06 07:03:43.283 screenresolution[1678:10449] starting screenresolution argv=screenresolution list 07:03:43 INFO - Available Modes on Display 0 07:03:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:03:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:03:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:03:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:03:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:03:43 INFO - Intel Iris: 07:03:43 INFO - Chipset Model: Intel Iris 07:03:43 INFO - Type: GPU 07:03:43 INFO - Bus: Built-In 07:03:43 INFO - VRAM (Dynamic, Max): 1536 MB 07:03:43 INFO - Vendor: Intel (0x8086) 07:03:43 INFO - Device ID: 0x0a2e 07:03:43 INFO - Revision ID: 0x0009 07:03:43 INFO - Displays: 07:03:43 INFO - Display: 07:03:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:03:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:03:43 INFO - Display Serial Number: 1600x1200 60 07:03:43 INFO - Main Display: Yes 07:03:43 INFO - Mirror: Off 07:03:43 INFO - Online: Yes 07:03:43 INFO - Rotation: Supported 07:03:43 INFO - Return code: 0 07:03:43 INFO - Running post-action listener: _resource_record_post_action 07:03:43 INFO - [mozharness: 2016-10-06 14:03:43.518863Z] Finished run-tests step (success) 07:03:43 INFO - Running post-run listener: _resource_record_post_run 07:03:43 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 37751296; Write bytes: 710947328; Read time: 248; Write time: 2012 07:03:43 INFO - TinderboxPrint: CPU usage
54.7% 07:03:43 INFO - TinderboxPrint: I/O read bytes / time
37,751,296 / 248 07:03:43 INFO - TinderboxPrint: I/O write bytes / time
710,947,328 / 2,012 07:03:43 INFO - TinderboxPrint: CPU idle
2,196.1 (45.3%) 07:03:43 INFO - TinderboxPrint: CPU system
979.5 (20.2%) 07:03:43 INFO - TinderboxPrint: CPU user
1,670.1 (34.5%) 07:03:43 INFO - TinderboxPrint: Swap in / out
445,288,448 / 0 07:03:43 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 391995392; Write bytes: 381286400; Read time: 29092; Write time: 784 07:03:43 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 31576576; Write bytes: 301124096; Read time: 186; Write time: 1168 07:03:43 INFO - Running post-run listener: _upload_blobber_files 07:03:43 INFO - Blob upload gear active. 07:03:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:03:44 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:03:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:03:44 INFO - (blobuploader) - INFO - Open directory for files ... 07:03:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:03:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:03:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:03:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:03:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:03:45 INFO - (blobuploader) - INFO - Done attempting. 07:03:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:03:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:03:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:03:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:03:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:03:46 INFO - (blobuploader) - INFO - Done attempting. 07:03:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:03:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:03:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:03:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:03:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:03:48 INFO - (blobuploader) - INFO - Done attempting. 07:03:48 INFO - (blobuploader) - INFO - Iteration through files over. 07:03:48 INFO - Return code: 0 07:03:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:03:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:03:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fab2311959b5c4b7e74fffea19765138a5275966d10fb4ac6e5c93531ca8229d7fef9e5d4ab048086b5f9a93e03f01e917e45ba8e810bd0944a484390333b590", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95a8b110a6dcbfc392371c7ad842ff55db0d72774b9a41b8ad0bd0f24f855916a30dab7876055b0bbb5115fcb605fe146b5295a44f793761a544bf39545966e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44102ad1d2029052312956bcddd20422ac58185fa99b603e75fd401828b8c938e30e2ac89a187373c9c671de8d7657718b8d901481a44a86a5db9d7078994ee0"} 07:03:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:03:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:03:48 INFO - Contents: 07:03:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fab2311959b5c4b7e74fffea19765138a5275966d10fb4ac6e5c93531ca8229d7fef9e5d4ab048086b5f9a93e03f01e917e45ba8e810bd0944a484390333b590", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95a8b110a6dcbfc392371c7ad842ff55db0d72774b9a41b8ad0bd0f24f855916a30dab7876055b0bbb5115fcb605fe146b5295a44f793761a544bf39545966e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44102ad1d2029052312956bcddd20422ac58185fa99b603e75fd401828b8c938e30e2ac89a187373c9c671de8d7657718b8d901481a44a86a5db9d7078994ee0"} 07:03:48 INFO - Running post-run listener: copy_logs_to_upload_dir 07:03:48 INFO - Copying logs to upload dir... 07:03:48 INFO - mkdir: /builds/slave/test/build/upload/logs 07:03:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.955953 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-06 07:03:48.816248) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 07:03:48.819564) ========= 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.ckcuF8X9b1/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.26w1t1Emov/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fab2311959b5c4b7e74fffea19765138a5275966d10fb4ac6e5c93531ca8229d7fef9e5d4ab048086b5f9a93e03f01e917e45ba8e810bd0944a484390333b590", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95a8b110a6dcbfc392371c7ad842ff55db0d72774b9a41b8ad0bd0f24f855916a30dab7876055b0bbb5115fcb605fe146b5295a44f793761a544bf39545966e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44102ad1d2029052312956bcddd20422ac58185fa99b603e75fd401828b8c938e30e2ac89a187373c9c671de8d7657718b8d901481a44a86a5db9d7078994ee0"} build_url:https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010990 build_url: 'https://queue.taskcluster.net/v1/task/KaGnB60DRlitRzVeYWhEYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fab2311959b5c4b7e74fffea19765138a5275966d10fb4ac6e5c93531ca8229d7fef9e5d4ab048086b5f9a93e03f01e917e45ba8e810bd0944a484390333b590", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/95a8b110a6dcbfc392371c7ad842ff55db0d72774b9a41b8ad0bd0f24f855916a30dab7876055b0bbb5115fcb605fe146b5295a44f793761a544bf39545966e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44102ad1d2029052312956bcddd20422ac58185fa99b603e75fd401828b8c938e30e2ac89a187373c9c671de8d7657718b8d901481a44a86a5db9d7078994ee0"}' ========= master_lag: 0.34 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 07:03:49.172707) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 07:03:49.173050) ========= 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.ckcuF8X9b1/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.26w1t1Emov/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.005051 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 07:03:49.200176) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 07:03:49.200462) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 07:03:49.200738) ========= ========= Total master_lag: 0.92 =========