builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0084 starttime: 1457046747.03 results: success (0) buildid: 20160303135555 builduid: 616c6691b8064a5a90900f35345f7f47 revision: 6cf4691637dd061ab899ad984b17af92cb1e8d6e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 15:12:27.029349) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 15:12:27.029829) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 15:12:27.030187) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tK6SNQ9uxx/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.C0Mg6KbACn/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005957 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 15:12:27.058919) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 15:12:27.059634) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 15:12:27.077416) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 15:12:27.078093) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tK6SNQ9uxx/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.C0Mg6KbACn/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.005853 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 15:12:27.128234) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 15:12:27.128558) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 15:12:27.128960) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 15:12:27.129282) ========= 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.tK6SNQ9uxx/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.C0Mg6KbACn/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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-03-03 15:12:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 65.4M=0s 2016-03-03 15:12:27 (65.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097513 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 15:12:27.245783) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 15:12:27.246563) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tK6SNQ9uxx/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.C0Mg6KbACn/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.027056 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 15:12:27.298307) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-03 15:12:27.299099) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6cf4691637dd061ab899ad984b17af92cb1e8d6e --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 6cf4691637dd061ab899ad984b17af92cb1e8d6e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tK6SNQ9uxx/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.C0Mg6KbACn/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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-03-03 15:12:27,368 truncating revision to first 12 chars 2016-03-03 15:12:27,368 Setting DEBUG logging. 2016-03-03 15:12:27,368 attempt 1/10 2016-03-03 15:12:27,368 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6cf4691637dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-03 15:12:28,367 unpacking tar archive at: fx-team-6cf4691637dd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.249287 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-03 15:12:28.564574) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 15:12:28.565004) ========= echo 6cf4691637dd061ab899ad984b17af92cb1e8d6e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6cf4691637dd061ab899ad984b17af92cb1e8d6e'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tK6SNQ9uxx/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.C0Mg6KbACn/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 6cf4691637dd061ab899ad984b17af92cb1e8d6e program finished with exit code 0 elapsedTime=0.005447 script_repo_revision: '6cf4691637dd061ab899ad984b17af92cb1e8d6e' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 15:12:28.614807) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 15:12:28.615175) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 15:12:28.628030) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2016-03-03 15:12:28.628348) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.tK6SNQ9uxx/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.C0Mg6KbACn/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:12:28 INFO - MultiFileLogger online at 20160303 15:12:28 in /builds/slave/test 15:12:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:12:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:12:28 INFO - {'append_to_log': False, 15:12:28 INFO - 'base_work_dir': '/builds/slave/test', 15:12:28 INFO - 'blob_upload_branch': 'Fx-Team', 15:12:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:12:28 INFO - 'branch': 'Fx-Team', 15:12:28 INFO - 'buildbot_json_path': 'buildprops.json', 15:12:28 INFO - 'config_files': ('talos/mac_config.py',), 15:12:28 INFO - 'default_actions': ('clobber', 15:12:28 INFO - 'read-buildbot-config', 15:12:28 INFO - 'download-and-extract', 15:12:28 INFO - 'populate-webroot', 15:12:28 INFO - 'create-virtualenv', 15:12:28 INFO - 'install', 15:12:28 INFO - 'run-tests'), 15:12:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:12:28 INFO - 'download_minidump_stackwalk': True, 15:12:28 INFO - 'download_symbols': 'ondemand', 15:12:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:12:28 INFO - 'tooltool.py': '/tools/tooltool.py', 15:12:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:12:28 INFO - '/tools/misc-python/virtualenv.py')}, 15:12:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:12:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:12:28 INFO - 'installer_path': 'installer.exe', 15:12:28 INFO - 'log_level': 'info', 15:12:28 INFO - 'log_name': 'talos', 15:12:28 INFO - 'log_to_console': True, 15:12:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:12:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:12:28 INFO - 'opt_config_files': (), 15:12:28 INFO - 'pip_index': False, 15:12:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:12:28 INFO - 'cmd': ('bash', 15:12:28 INFO - '-c', 15:12:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:12:28 INFO - 'enabled': True, 15:12:28 INFO - 'halt_on_failure': False, 15:12:28 INFO - 'name': 'check_screen_resolution'},), 15:12:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:12:28 INFO - 'cmd': ('bash', 15:12:28 INFO - '-c', 15:12:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:12:28 INFO - 'enabled': True, 15:12:28 INFO - 'halt_on_failure': False, 15:12:28 INFO - 'name': 'check_screen_resolution'},), 15:12:28 INFO - 'run_cmd_checks_enabled': True, 15:12:28 INFO - 'sps_profile': False, 15:12:28 INFO - 'sps_profile_interval': 0, 15:12:28 INFO - 'suite': 'dromaeojs', 15:12:28 INFO - 'system_bits': '32', 15:12:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:12:28 INFO - 'title': 't-yosemite-r7-0084', 15:12:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:12:28 INFO - 'use_talos_json': True, 15:12:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:12:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:12:28 INFO - 'work_dir': 'build'} 15:12:28 INFO - ##### 15:12:28 INFO - ##### Running clobber step. 15:12:28 INFO - ##### 15:12:28 INFO - Running pre-action listener: _resource_record_pre_action 15:12:28 INFO - Running main action method: clobber 15:12:28 INFO - rmtree: /builds/slave/test/build 15:12:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:12:30 INFO - Running post-action listener: _resource_record_post_action 15:12:30 INFO - ##### 15:12:30 INFO - ##### Running read-buildbot-config step. 15:12:30 INFO - ##### 15:12:30 INFO - Running pre-action listener: _resource_record_pre_action 15:12:30 INFO - Running main action method: read_buildbot_config 15:12:30 INFO - Using buildbot properties: 15:12:30 INFO - { 15:12:30 INFO - "project": "", 15:12:30 INFO - "product": "firefox", 15:12:30 INFO - "script_repo_revision": "production", 15:12:30 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 15:12:30 INFO - "repository": "", 15:12:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 15:12:30 INFO - "buildid": "20160303135555", 15:12:30 INFO - "pgo_build": "False", 15:12:30 INFO - "basedir": "/builds/slave/test", 15:12:30 INFO - "buildnumber": 456, 15:12:30 INFO - "slavename": "t-yosemite-r7-0084", 15:12:30 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:12:30 INFO - "platform": "yosemite_r7", 15:12:30 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:12:30 INFO - "branch": "fx-team", 15:12:30 INFO - "repo_path": "integration/fx-team", 15:12:30 INFO - "revision": "6cf4691637dd061ab899ad984b17af92cb1e8d6e", 15:12:30 INFO - "stage_platform": "macosx64", 15:12:30 INFO - "builduid": "616c6691b8064a5a90900f35345f7f47", 15:12:30 INFO - "slavebuilddir": "test" 15:12:30 INFO - } 15:12:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 15:12:30 INFO - Running post-action listener: _resource_record_post_action 15:12:30 INFO - ##### 15:12:30 INFO - ##### Running download-and-extract step. 15:12:30 INFO - ##### 15:12:30 INFO - Running pre-action listener: _resource_record_pre_action 15:12:30 INFO - Running main action method: download_and_extract 15:12:30 INFO - mkdir: /builds/slave/test/build/tests 15:12: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:30 INFO - https://queue.taskcluster.net/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 15:12:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 15:12:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 15:12:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 15:12:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 15:12:31 INFO - Downloaded 1277 bytes. 15:12:31 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 15:12:31 INFO - Using the following test package requirements: 15:12:31 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:12:31 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:12:31 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 15:12:31 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:12:31 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 15:12:31 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:12:31 INFO - u'jsshell-mac.zip'], 15:12:31 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:12:31 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 15:12:31 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:12:31 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:12:31 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 15:12:31 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:12:31 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 15:12:31 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:12:31 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 15:12:31 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:12:31 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:12:31 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 15:12:31 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:12:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:12:31 INFO - https://queue.taskcluster.net/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:12:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:12:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:12:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:12:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:13:13 INFO - Downloaded 17855024 bytes. 15:13:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:13:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:13:16 INFO - Return code: 0 15:13:16 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 15:13:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:16 INFO - https://queue.taskcluster.net/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:13:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:13:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:13:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:13:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:13:31 INFO - Downloaded 17855024 bytes. 15:13:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:13:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:13:34 INFO - Return code: 0 15:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:34 INFO - https://queue.taskcluster.net/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:13:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:13:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:13:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:13:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:13:36 INFO - Downloaded 10808282 bytes. 15:13:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:13:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 15:13:36 INFO - Return code: 0 15:13:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:36 INFO - https://queue.taskcluster.net/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:13:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:13:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:13:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 15:13:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 15:13:41 INFO - Downloaded 110955920 bytes. 15:13:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:13:41 INFO - mkdir: /builds/slave/test/properties 15:13:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:13:41 INFO - Writing to file /builds/slave/test/properties/build_url 15:13:41 INFO - Contents: 15:13:41 INFO - build_url:https://queue.taskcluster.net/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:13:42 INFO - Running post-action listener: _resource_record_post_action 15:13:42 INFO - Running post-action listener: set_extra_try_arguments 15:13:42 INFO - ##### 15:13:42 INFO - ##### Running populate-webroot step. 15:13:42 INFO - ##### 15:13:42 INFO - Running pre-action listener: _resource_record_pre_action 15:13:42 INFO - Running main action method: populate_webroot 15:13:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:13:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:13:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:13:42 INFO - '--tppagecycles', 15:13:42 INFO - '7'], 15:13:42 INFO - 'tests': ['tsvgm']}}, 15:13:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:13:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:13:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:13:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:13:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:13:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:13:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:13:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:42 INFO - 'talos_options': ['--e10s'], 15:13:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:13:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:42 INFO - 'tests': ['damp', 'tps']}, 15:13:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:42 INFO - 'talos_options': ['--e10s'], 15:13:42 INFO - 'tests': ['damp', 'tps']}, 15:13:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:13:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:13:42 INFO - 'other': {'tests': ['a11yr', 15:13:42 INFO - 'ts_paint', 15:13:42 INFO - 'tpaint', 15:13:42 INFO - 'sessionrestore', 15:13:42 INFO - 'sessionrestore_no_auto_restore']}, 15:13:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:13:42 INFO - 'tests': ['a11yr', 15:13:42 INFO - 'ts_paint', 15:13:42 INFO - 'tpaint', 15:13:42 INFO - 'sessionrestore', 15:13:42 INFO - 'sessionrestore_no_auto_restore']}, 15:13:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:13:42 INFO - 'tests': ['a11yr', 15:13:42 INFO - 'ts_paint', 15:13:42 INFO - 'tpaint', 15:13:42 INFO - 'sessionrestore', 15:13:42 INFO - 'sessionrestore_no_auto_restore']}, 15:13:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:13:42 INFO - 'tests': ['a11yr', 15:13:42 INFO - 'ts_paint', 15:13:42 INFO - 'tpaint', 15:13:42 INFO - 'sessionrestore', 15:13:42 INFO - 'sessionrestore_no_auto_restore']}, 15:13:42 INFO - 'other_l64': {'tests': ['a11yr', 15:13:42 INFO - 'ts_paint', 15:13:42 INFO - 'tpaint', 15:13:42 INFO - 'sessionrestore', 15:13:42 INFO - 'sessionrestore_no_auto_restore']}, 15:13:42 INFO - 'other_nol64': {'tests': ['a11yr', 15:13:42 INFO - 'ts_paint', 15:13:42 INFO - 'tpaint', 15:13:42 INFO - 'sessionrestore', 15:13:42 INFO - 'sessionrestore_no_auto_restore']}, 15:13:42 INFO - 'svgr': {'tests': ['tsvgx', 15:13:42 INFO - 'tsvgr_opacity', 15:13:42 INFO - 'tart', 15:13:42 INFO - 'tscrollx', 15:13:42 INFO - 'cart']}, 15:13:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:13:42 INFO - 'tests': ['tsvgx', 15:13:42 INFO - 'tsvgr_opacity', 15:13:42 INFO - 'tart', 15:13:42 INFO - 'tscrollx', 15:13:42 INFO - 'cart']}, 15:13:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:42 INFO - 'tests': ['tp5o']}, 15:13:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:42 INFO - 'talos_options': ['--e10s'], 15:13:42 INFO - 'tests': ['tp5o']}, 15:13:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:42 INFO - 'talos_options': ['--xperf_path', 15:13:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:13:42 INFO - 'tests': ['tp5n']}, 15:13:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:42 INFO - 'talos_options': ['--e10s', 15:13:42 INFO - '--xperf_path', 15:13:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:13:42 INFO - 'tests': ['tp5n']}}, 15:13:42 INFO - 'talos.zip': {'path': '', 15:13:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:13:42 INFO - Running post-action listener: _resource_record_post_action 15:13:42 INFO - ##### 15:13:42 INFO - ##### Running create-virtualenv step. 15:13:42 INFO - ##### 15:13:42 INFO - Running pre-action listener: _resource_record_pre_action 15:13:42 INFO - Running main action method: create_virtualenv 15:13:42 INFO - Creating virtualenv /builds/slave/test/build/venv 15:13:42 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 15:13:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:13:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:13:42 INFO - Using real prefix '/tools/python27' 15:13:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:13:43 INFO - Installing distribute.............................................................................................................................................................................................done. 15:13:45 INFO - Installing pip.................done. 15:13:45 INFO - Return code: 0 15:13:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:13:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:45 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 0x10c22ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2344c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd270468b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0d30>, '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 0x10bef4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c7b20>, '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.tK6SNQ9uxx/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.C0Mg6KbACn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:13:45 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 15:13:45 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 15:13:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tK6SNQ9uxx/Render', 15:13:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:13:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:13:45 INFO - 'HOME': '/Users/cltbld', 15:13:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:13:45 INFO - 'LOGNAME': 'cltbld', 15:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:45 INFO - 'MOZ_NO_REMOTE': '1', 15:13:45 INFO - 'NO_EM_RESTART': '1', 15:13:45 INFO - 'PAGER': '/bin/cat', 15:13:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:45 INFO - 'PWD': '/builds/slave/test', 15:13:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:13:45 INFO - 'SHELL': '/bin/bash', 15:13:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0Mg6KbACn/Listeners', 15:13:45 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:13:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:13:45 INFO - 'USER': 'cltbld', 15:13:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:13:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:45 INFO - 'XPC_FLAGS': '0x0', 15:13:45 INFO - 'XPC_SERVICE_NAME': '0', 15:13:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:13:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:46 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 15:13:46 INFO - Cleaning up... 15:13:46 INFO - Return code: 0 15:13:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:46 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c22ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2344c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd270468b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0d30>, '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 0x10bef4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c7b20>, '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.tK6SNQ9uxx/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.C0Mg6KbACn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:13:46 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>=0.7.1'] in /builds/slave/test/build 15:13:46 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>=0.7.1 15:13:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tK6SNQ9uxx/Render', 15:13:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:13:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:13:46 INFO - 'HOME': '/Users/cltbld', 15:13:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:13:46 INFO - 'LOGNAME': 'cltbld', 15:13:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:46 INFO - 'MOZ_NO_REMOTE': '1', 15:13:46 INFO - 'NO_EM_RESTART': '1', 15:13:46 INFO - 'PAGER': '/bin/cat', 15:13:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:13:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:46 INFO - 'PWD': '/builds/slave/test', 15:13:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:13:46 INFO - 'SHELL': '/bin/bash', 15:13:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0Mg6KbACn/Listeners', 15:13:46 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:13:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:13:46 INFO - 'USER': 'cltbld', 15:13:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:13:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:13:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:46 INFO - 'XPC_FLAGS': '0x0', 15:13:46 INFO - 'XPC_SERVICE_NAME': '0', 15:13:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:13:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:46 INFO - Downloading/unpacking psutil>=0.7.1 15:13:46 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 15:13:46 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 15:13:46 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 15:13:46 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 15:13:46 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 15:13:46 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 15:13:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:13:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:13:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:13:49 INFO - Installing collected packages: psutil 15:13:49 INFO - Running setup.py install for psutil 15:13:49 INFO - building 'psutil._psutil_osx' extension 15:13:49 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 15:13:50 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 15:13:50 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 15:13:50 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 15:13:50 INFO - building 'psutil._psutil_posix' extension 15:13:50 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 15:13:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:13:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:13:50 INFO - ^ 15:13:50 INFO - 1 warning generated. 15:13:50 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 15:13:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:13:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:13:50 INFO - Successfully installed psutil 15:13:50 INFO - Cleaning up... 15:13:50 INFO - Return code: 0 15:13:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:13:50 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:50 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:50 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c22ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2344c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd270468b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0d30>, '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 0x10bef4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c7b20>, '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.tK6SNQ9uxx/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.C0Mg6KbACn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:13:50 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.0.0'] in /builds/slave/test/build 15:13:50 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.0.0 15:13:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tK6SNQ9uxx/Render', 15:13:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:13:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:13:50 INFO - 'HOME': '/Users/cltbld', 15:13:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:13:50 INFO - 'LOGNAME': 'cltbld', 15:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:50 INFO - 'MOZ_NO_REMOTE': '1', 15:13:50 INFO - 'NO_EM_RESTART': '1', 15:13:50 INFO - 'PAGER': '/bin/cat', 15:13:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:50 INFO - 'PWD': '/builds/slave/test', 15:13:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:13:50 INFO - 'SHELL': '/bin/bash', 15:13:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0Mg6KbACn/Listeners', 15:13:50 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:13:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:13:50 INFO - 'USER': 'cltbld', 15:13:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:13:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:50 INFO - 'XPC_FLAGS': '0x0', 15:13:50 INFO - 'XPC_SERVICE_NAME': '0', 15:13:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:13:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:13:50 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 15:13:50 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 15:13:50 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 15:13:50 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 15:13:50 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 15:13:50 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 15:13:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:13:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:13:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:13:53 INFO - Installing collected packages: mozsystemmonitor 15:13:53 INFO - Running setup.py install for mozsystemmonitor 15:13:53 INFO - Successfully installed mozsystemmonitor 15:13:53 INFO - Cleaning up... 15:13:53 INFO - Return code: 0 15:13:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:13:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:53 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:53 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 0x10c22ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2344c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd270468b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0d30>, '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 0x10bef4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c7b20>, '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.tK6SNQ9uxx/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.C0Mg6KbACn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:13:53 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 15:13:53 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 15:13:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tK6SNQ9uxx/Render', 15:13:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:13:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:13:53 INFO - 'HOME': '/Users/cltbld', 15:13:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:13:53 INFO - 'LOGNAME': 'cltbld', 15:13:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:53 INFO - 'MOZ_NO_REMOTE': '1', 15:13:53 INFO - 'NO_EM_RESTART': '1', 15:13:53 INFO - 'PAGER': '/bin/cat', 15:13:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:13:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:53 INFO - 'PWD': '/builds/slave/test', 15:13:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:13:53 INFO - 'SHELL': '/bin/bash', 15:13:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0Mg6KbACn/Listeners', 15:13:53 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:13:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:13:53 INFO - 'USER': 'cltbld', 15:13:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:13:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:13:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:53 INFO - 'XPC_FLAGS': '0x0', 15:13:53 INFO - 'XPC_SERVICE_NAME': '0', 15:13:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:13:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:53 INFO - Downloading/unpacking blobuploader==1.2.4 15:13:53 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 15:13:53 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 15:13:53 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 15:13:53 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 15:13:53 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 15:13:53 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 15:13:56 INFO - Downloading blobuploader-1.2.4.tar.gz 15:13:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:13:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:13:56 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 15:13:56 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 15:13:56 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 15:13:56 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 15:13:56 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 15:13:56 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 15:13:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:13:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:13:56 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 15:13:56 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 15:13:56 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 15:13:56 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 15:13:56 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 15:13:56 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 15:13:57 INFO - Downloading docopt-0.6.1.tar.gz 15:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:13:57 INFO - Installing collected packages: blobuploader, requests, docopt 15:13:57 INFO - Running setup.py install for blobuploader 15:13:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:13:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:13:57 INFO - Running setup.py install for requests 15:13:58 INFO - Running setup.py install for docopt 15:13:58 INFO - Successfully installed blobuploader requests docopt 15:13:58 INFO - Cleaning up... 15:13:58 INFO - Return code: 0 15:13:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:13:58 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:58 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:58 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 0x10c22ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2344c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd270468b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0d30>, '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 0x10bef4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c7b20>, '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.tK6SNQ9uxx/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.C0Mg6KbACn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:13:58 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 15:13:58 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 15:13:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tK6SNQ9uxx/Render', 15:13:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:13:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:13:58 INFO - 'HOME': '/Users/cltbld', 15:13:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:13:58 INFO - 'LOGNAME': 'cltbld', 15:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:58 INFO - 'MOZ_NO_REMOTE': '1', 15:13:58 INFO - 'NO_EM_RESTART': '1', 15:13:58 INFO - 'PAGER': '/bin/cat', 15:13:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:58 INFO - 'PWD': '/builds/slave/test', 15:13:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:13:58 INFO - 'SHELL': '/bin/bash', 15:13:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0Mg6KbACn/Listeners', 15:13:58 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:13:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:13:58 INFO - 'USER': 'cltbld', 15:13:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:13:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:58 INFO - 'XPC_FLAGS': '0x0', 15:13:58 INFO - 'XPC_SERVICE_NAME': '0', 15:13:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:13:58 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-suEkvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:13:58 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-lYlLlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:13:58 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-22ESbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:13:58 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-hpbnCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:13:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:13:58 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-YxFz7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:13:59 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-DGhi2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:13:59 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-rJjYSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:13:59 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ZPPZO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:13:59 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-hEaGSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:13:59 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-oUaO_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:13:59 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-WyZqf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:13:59 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-8_P1WY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:13:59 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-5zTAZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:13:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:13:59 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-UP_o9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:00 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-_USNp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:14:00 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-IL2f0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:14:00 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-BSOCXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:14:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:14:00 INFO - Running setup.py install for manifestparser 15:14:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:14:00 INFO - Running setup.py install for mozcrash 15:14:00 INFO - Running setup.py install for mozdebug 15:14:00 INFO - Running setup.py install for mozdevice 15:14:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:14:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:14:00 INFO - Running setup.py install for mozfile 15:14:01 INFO - Running setup.py install for mozhttpd 15:14:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:14:01 INFO - Running setup.py install for mozinfo 15:14:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:14:01 INFO - Running setup.py install for mozInstall 15:14:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:14:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:14:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:14:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:14:01 INFO - Running setup.py install for mozleak 15:14:01 INFO - Running setup.py install for mozlog 15:14:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:14:01 INFO - Running setup.py install for moznetwork 15:14:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:14:01 INFO - Running setup.py install for mozprocess 15:14:02 INFO - Running setup.py install for mozprofile 15:14:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Running setup.py install for mozrunner 15:14:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Running setup.py install for mozscreenshot 15:14:02 INFO - Running setup.py install for moztest 15:14:02 INFO - Running setup.py install for mozversion 15:14:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:14:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:14:02 INFO - Cleaning up... 15:14:02 INFO - Return code: 0 15:14:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:02 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 0x10c22ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2344c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd270468b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0d30>, '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 0x10bef4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c7b20>, '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.tK6SNQ9uxx/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.C0Mg6KbACn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:14:02 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 15:14:02 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 15:14:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tK6SNQ9uxx/Render', 15:14:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:14:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:14:02 INFO - 'HOME': '/Users/cltbld', 15:14:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:14:02 INFO - 'LOGNAME': 'cltbld', 15:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:02 INFO - 'MOZ_NO_REMOTE': '1', 15:14:02 INFO - 'NO_EM_RESTART': '1', 15:14:02 INFO - 'PAGER': '/bin/cat', 15:14:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:02 INFO - 'PWD': '/builds/slave/test', 15:14:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:14:02 INFO - 'SHELL': '/bin/bash', 15:14:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0Mg6KbACn/Listeners', 15:14:02 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:14:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:14:02 INFO - 'USER': 'cltbld', 15:14:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:14:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:02 INFO - 'XPC_FLAGS': '0x0', 15:14:02 INFO - 'XPC_SERVICE_NAME': '0', 15:14:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:14:03 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-dy8o5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:14:03 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)) 15:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:14:03 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-mY153T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 15:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:14:03 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-88XdAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:14:03 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)) 15:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:14:03 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-aHAVda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:14:03 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)) 15:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:14:03 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-SC_qrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:14:03 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)) 15:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:14:03 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-AwhiN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:14:03 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)) 15:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:14:03 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-5XcNwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:14:03 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)) 15:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:14:03 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-OYb53B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:14:03 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)) 15:14:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:14:03 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-cHQNlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:14:04 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-KC136X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:14:04 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-JM_yCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:14:04 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-MFAQSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:14:04 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-SrGMBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:14:04 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-psdtLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:04 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-zJM8Fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:14:04 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ek7L8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:14:04 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)) 15:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:14:04 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-5Nh_3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:14:04 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)) 15:14:04 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:14:04 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:14:04 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)) 15:14:04 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)) 15:14:04 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)) 15:14:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:14:04 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 15:14:04 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 15:14:04 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 15:14:04 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 15:14:04 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 15:14:04 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 15:14:07 INFO - Downloading blessings-1.6.tar.gz 15:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:14:07 INFO - Installing collected packages: blessings 15:14:07 INFO - Running setup.py install for blessings 15:14:07 INFO - Successfully installed blessings 15:14:07 INFO - Cleaning up... 15:14:07 INFO - Return code: 0 15:14:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:14:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:14:07 INFO - Reading from file tmpfile_stdout 15:14:07 INFO - Current package versions: 15:14:07 INFO - blessings == 1.6 15:14:07 INFO - blobuploader == 1.2.4 15:14:07 INFO - docopt == 0.6.1 15:14:07 INFO - manifestparser == 1.1 15:14:07 INFO - mozInstall == 1.12 15:14:07 INFO - mozcrash == 0.16 15:14:07 INFO - mozdebug == 0.1 15:14:07 INFO - mozdevice == 0.48 15:14:07 INFO - mozfile == 1.2 15:14:07 INFO - mozhttpd == 0.7 15:14:07 INFO - mozinfo == 0.9 15:14:07 INFO - mozleak == 0.1 15:14:07 INFO - mozlog == 3.1 15:14:07 INFO - moznetwork == 0.27 15:14:07 INFO - mozprocess == 0.22 15:14:07 INFO - mozprofile == 0.28 15:14:07 INFO - mozrunner == 6.11 15:14:07 INFO - mozscreenshot == 0.1 15:14:07 INFO - mozsystemmonitor == 0.0 15:14:07 INFO - moztest == 0.7 15:14:07 INFO - mozversion == 1.4 15:14:07 INFO - psutil == 3.1.1 15:14:07 INFO - requests == 1.2.3 15:14:07 INFO - wsgiref == 0.1.2 15:14:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:14:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:07 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 0x10c22ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2344c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd270468b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0d30>, '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 0x10bef4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c7b20>, '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.tK6SNQ9uxx/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.C0Mg6KbACn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:14:07 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 15:14:07 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 15:14:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tK6SNQ9uxx/Render', 15:14:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:14:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:14:07 INFO - 'HOME': '/Users/cltbld', 15:14:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:14:07 INFO - 'LOGNAME': 'cltbld', 15:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:07 INFO - 'MOZ_NO_REMOTE': '1', 15:14:07 INFO - 'NO_EM_RESTART': '1', 15:14:07 INFO - 'PAGER': '/bin/cat', 15:14:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:07 INFO - 'PWD': '/builds/slave/test', 15:14:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:14:07 INFO - 'SHELL': '/bin/bash', 15:14:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0Mg6KbACn/Listeners', 15:14:07 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:14:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:14:07 INFO - 'USER': 'cltbld', 15:14:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:14:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:07 INFO - 'XPC_FLAGS': '0x0', 15:14:07 INFO - 'XPC_SERVICE_NAME': '0', 15:14:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:08 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)) 15:14:08 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)) 15:14:08 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)) 15:14:08 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)) 15:14:08 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)) 15:14:08 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)) 15:14:08 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)) 15:14:08 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)) 15:14:08 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)) 15:14:08 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)) 15:14:08 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)) 15:14:08 INFO - Cleaning up... 15:14:08 INFO - Return code: 0 15:14:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c22ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2344c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd270468b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0d30>, '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 0x10bef4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c7b20>, '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.tK6SNQ9uxx/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.C0Mg6KbACn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:14:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:14:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tK6SNQ9uxx/Render', 15:14:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:14:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:14:08 INFO - 'HOME': '/Users/cltbld', 15:14:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:14:08 INFO - 'LOGNAME': 'cltbld', 15:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:08 INFO - 'MOZ_NO_REMOTE': '1', 15:14:08 INFO - 'NO_EM_RESTART': '1', 15:14:08 INFO - 'PAGER': '/bin/cat', 15:14:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:08 INFO - 'PWD': '/builds/slave/test', 15:14:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:14:08 INFO - 'SHELL': '/bin/bash', 15:14:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0Mg6KbACn/Listeners', 15:14:08 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:14:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:14:08 INFO - 'USER': 'cltbld', 15:14:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:14:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:08 INFO - 'XPC_FLAGS': '0x0', 15:14:08 INFO - 'XPC_SERVICE_NAME': '0', 15:14:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:08 INFO - Downloading/unpacking jsonschema 15:14: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 15:14: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 15:14: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 15:14: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 15:14: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 15:14: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 15:14:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:14:10 INFO - Downloading/unpacking functools32 (from jsonschema) 15:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:11 INFO - Downloading functools32-3.2.3-2.tar.gz 15:14:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:14:11 INFO - warning: no files found matching '*.txt' 15:14:11 INFO - no previously-included directories found matching 'build' 15:14:11 INFO - no previously-included directories found matching 'dist' 15:14:11 INFO - no previously-included directories found matching '.git*' 15:14:11 INFO - Installing collected packages: jsonschema, functools32 15:14:11 INFO - Running setup.py install for functools32 15:14:11 INFO - warning: no files found matching '*.txt' 15:14:11 INFO - no previously-included directories found matching 'build' 15:14:11 INFO - no previously-included directories found matching 'dist' 15:14:11 INFO - no previously-included directories found matching '.git*' 15:14:11 INFO - Successfully installed jsonschema functools32 15:14:11 INFO - Cleaning up... 15:14:11 INFO - Return code: 0 15:14:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:14:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c22ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c2344c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd270468b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0d30>, '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 0x10bef4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c7b20>, '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.tK6SNQ9uxx/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.C0Mg6KbACn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 15:14:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:14:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tK6SNQ9uxx/Render', 15:14:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:14:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:14:11 INFO - 'HOME': '/Users/cltbld', 15:14:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:14:11 INFO - 'LOGNAME': 'cltbld', 15:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:11 INFO - 'MOZ_NO_REMOTE': '1', 15:14:11 INFO - 'NO_EM_RESTART': '1', 15:14:11 INFO - 'PAGER': '/bin/cat', 15:14:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:11 INFO - 'PWD': '/builds/slave/test', 15:14:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:14:11 INFO - 'SHELL': '/bin/bash', 15:14:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0Mg6KbACn/Listeners', 15:14:11 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:14:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:14:11 INFO - 'USER': 'cltbld', 15:14:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:14:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:11 INFO - 'XPC_FLAGS': '0x0', 15:14:11 INFO - 'XPC_SERVICE_NAME': '0', 15:14:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:11 INFO - Downloading/unpacking flake8 15:14: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 15:14: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 15:14: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 15:14: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 15:14: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 15:14: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 15:14:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:14:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:14:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:14:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:14:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:14:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:14:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:14:15 INFO - no previously-included directories found matching 'docs/_build' 15:14:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:14:15 INFO - Running setup.py install for pep8 15:14:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:14:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:14:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:14:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:14:15 INFO - no previously-included directories found matching 'docs/_build' 15:14:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:14:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:14:15 INFO - Cleaning up... 15:14:15 INFO - Return code: 0 15:14:15 INFO - Running post-action listener: _resource_record_post_action 15:14:15 INFO - Running post-action listener: _start_resource_monitoring 15:14:15 INFO - Starting resource monitoring. 15:14:15 INFO - ##### 15:14:15 INFO - ##### Running install step. 15:14:15 INFO - ##### 15:14:15 INFO - Running pre-action listener: _resource_record_pre_action 15:14:15 INFO - Running main action method: install 15:14:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:14:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:14:15 INFO - Reading from file tmpfile_stdout 15:14:15 INFO - Detecting whether we're running mozinstall >=1.0... 15:14:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:14:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:14:15 INFO - Reading from file tmpfile_stdout 15:14:15 INFO - Output received: 15:14:15 INFO - Usage: mozinstall [options] installer 15:14:15 INFO - Options: 15:14:15 INFO - -h, --help show this help message and exit 15:14:15 INFO - -d DEST, --destination=DEST 15:14:15 INFO - Directory to install application into. [default: 15:14:15 INFO - "/builds/slave/test"] 15:14:15 INFO - --app=APP Application being installed. [default: firefox] 15:14:15 INFO - mkdir: /builds/slave/test/build/application 15:14:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:14:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 15:14:49 INFO - Reading from file tmpfile_stdout 15:14:49 INFO - Output received: 15:14:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:14:49 INFO - Running post-action listener: _resource_record_post_action 15:14:49 INFO - ##### 15:14:49 INFO - ##### Running run-tests step. 15:14:49 INFO - ##### 15:14:49 INFO - Running pre-action listener: _resource_record_pre_action 15:14:49 INFO - Running main action method: run_tests 15:14:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:14:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:14:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:14:49 INFO - 2016-03-03 15:14:49.617 screenresolution[1649:7654] starting screenresolution argv=screenresolution get 15:14:49 INFO - 2016-03-03 15:14:49.620 screenresolution[1649:7654] Display 0: 1600x1200x32@60 15:14:49 INFO - 2016-03-03 15:14:49.626 screenresolution[1650:7657] starting screenresolution argv=screenresolution list 15:14:49 INFO - Available Modes on Display 0 15:14:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:14:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:14:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:14:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:14:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:14:49 INFO - Intel Iris: 15:14:49 INFO - Chipset Model: Intel Iris 15:14:49 INFO - Type: GPU 15:14:49 INFO - Bus: Built-In 15:14:49 INFO - VRAM (Dynamic, Max): 1536 MB 15:14:49 INFO - Vendor: Intel (0x8086) 15:14:49 INFO - Device ID: 0x0a2e 15:14:49 INFO - Revision ID: 0x0009 15:14:49 INFO - Displays: 15:14:49 INFO - Display: 15:14:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:14:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:14:49 INFO - Display Serial Number: 1600x1200 60 15:14:49 INFO - Main Display: Yes 15:14:49 INFO - Mirror: Off 15:14:49 INFO - Online: Yes 15:14:49 INFO - Rotation: Supported 15:14:49 INFO - Return code: 0 15:14:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:14:49 INFO - Python 2.7.3 15:14:49 INFO - Return code: 0 15:14:49 INFO - grabbing minidump binary from tooltool 15:14:49 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:14:49 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0d0d30>, '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 0x10bef4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c0c7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:14:49 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 15:14:49 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 15:14:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:14:49 INFO - Return code: 0 15:14:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:14:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:14:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:14:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:14:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:14:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:14:51 INFO - Return code: 0 15:14:51 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:14:51 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0084 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:14:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tK6SNQ9uxx/Render', 15:14:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:14:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:14:51 INFO - 'HOME': '/Users/cltbld', 15:14:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:14:51 INFO - 'LOGNAME': 'cltbld', 15:14:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:14:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:51 INFO - 'MOZ_NO_REMOTE': '1', 15:14:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:14:51 INFO - 'NO_EM_RESTART': '1', 15:14:51 INFO - 'PAGER': '/bin/cat', 15:14:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:51 INFO - 'PWD': '/builds/slave/test', 15:14:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:14:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:14:51 INFO - 'SHELL': '/bin/bash', 15:14:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.C0Mg6KbACn/Listeners', 15:14:51 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 15:14:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:14:51 INFO - 'USER': 'cltbld', 15:14:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:14:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:51 INFO - 'XPC_FLAGS': '0x0', 15:14:51 INFO - 'XPC_SERVICE_NAME': '0', 15:14:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:14:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:14:51 INFO - mozversion application_buildid: 20160303135555 15:14:51 INFO - mozversion application_changeset: 6cf4691637dd061ab899ad984b17af92cb1e8d6e 15:14:51 INFO - mozversion application_display_name: Nightly 15:14:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:14:51 INFO - mozversion application_name: Firefox 15:14:51 INFO - mozversion application_remotingname: firefox 15:14:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:14:51 INFO - mozversion application_vendor: Mozilla 15:14:51 INFO - mozversion application_version: 47.0a1 15:14:51 INFO - mozversion platform_buildid: 20160303135555 15:14:51 INFO - mozversion platform_changeset: 6cf4691637dd061ab899ad984b17af92cb1e8d6e 15:14:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:14:51 INFO - mozversion platform_version: 47.0a1 15:14:51 INFO - using testdate: 1457046891 15:14:51 INFO - actual date: 1457046891 15:14:51 INFO - starting webserver on 'localhost:49280' 15:14:51 INFO - SUITE-START | Running 2 tests 15:14:51 INFO - TEST-START | dromaeo_css 15:14:51 INFO - operating with platform_type : mac_ 15:14:51 INFO - Initialising browser for dromaeo_css test... 15:14:51 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpKWeLaI/profile http://localhost:49280/getInfo.html) 15:14:53 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 15:14:53 INFO - PROCESS | 1668 | colorDepth:24 15:14:53 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 15:14:53 INFO - PROCESS | 1668 | __metrics 15:14:53 INFO - PROCESS | 1668 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:14:53 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:14:54 INFO - TEST-INFO | 1668: exit 0 15:14:54 INFO - Browser initialized. 15:14:54 INFO - Running cycle 1/1 for dromaeo_css test... 15:14:54 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpKWeLaI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:15:06 INFO - PROCESS | 1671 | RSS: Main: 243539968 15:15:06 INFO - PROCESS | 1671 | 15:15:57 INFO - PROCESS | 1671 | 1457046957475 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] 15:18:08 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 15:18:09 INFO - PROCESS | 1671 | RSS: Main: 383795200 15:18:09 INFO - PROCESS | 1671 | 15:21:12 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 15:21:13 INFO - PROCESS | 1671 | RSS: Main: 378396672 15:21:13 INFO - PROCESS | 1671 | 15:24:15 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 15:24:15 INFO - PROCESS | 1671 | RSS: Main: 372793344 15:24:15 INFO - PROCESS | 1671 | 15:27:17 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 15:27:18 INFO - PROCESS | 1671 | RSS: Main: 336867328 15:27:18 INFO - PROCESS | 1671 | 15:30:21 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 15:30:22 INFO - PROCESS | 1671 | RSS: Main: 335937536 15:30:22 INFO - PROCESS | 1671 | 15:33:25 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 15:33:25 INFO - PROCESS | 1671 | RSS: Main: 383754240 15:33:25 INFO - PROCESS | 1671 | 15:33:25 INFO - PROCESS | 1671 | __start_tp_report 15:33:25 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 15:33:25 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 15:33:25 INFO - PROCESS | 1671 | |i|pagename|runs| 15:33:25 INFO - PROCESS | 1671 | |0;dojo.html;2952.3504828937635;3235.7087862092408;3488.6860182583546;3507.0881570791585;3580.62403447638;5643.717814109294;5647.29408823897;5663.575231857607;5676.716164191785;5694.373618901917;5677.8580535486635;5764.365919748835;5817.767289308433;5897.3218079920825;5907.527397808176;5056.721880296592;5113.156329205676;5159.148740457838;5169.09540830355;5280.2079688046715;4961.429435614897;5178.300929374543;5282.867928301785;5284.075286824809;5360.2763626910455;5100;5115.360579927509;5175.0943584872875;5188.533032027117;5221.06020916235;5055.974720126413;5064.215046667772;5070.898582028339;5094.337736094321;5107.897842043139;4999.075171093323;5016.523430274118;5029.270755740397;5036.597072234213;5049.671771334852;5519.889602207973;5623.690697011662;5639.379668236491;5710.885782284331;5711.343195532525;4836.492168322346;6204.162438070848;6215.036669316263;6222.96888515559;6223.43989040984;6241.906371404432;6243.906341404882;6291.559590828644;6296.401841825065;6297.748090076391;5695.401982791788;5761.193432919353;5769.913451298234;5865.325487568899;5871.9706401468575;6244.562880598405;6252.468540174136;6258;6265.561410701298;6281.528885333618;6061;6064;6132.662703551258;6143.416375444325;6160.661163635953;5224.399194092652;6140.473573783541;6160;6282.874342513215;6284.340144284875;6133.662648554283;6157.107219453154;6158.1686472326555;6158.753649853956;6168.537359697951;6160.907586386208;6168.876622467616;6172.8765424691255;6182.28903676083;6187.3503282155625;4809.398825146856;4872.317875497433;4900.681455705368;4904.337914381585;4906.460289368167;4416.359627854007;4427.734335939854;4456.153330867125;4456.376107344974;4461.665375096881;5617.41017193197;5662.490375866192;5674.517665998354;5679.318481782213;5689.658620482702;6136.85608443425;6180.351063138396;6190.907136392958;6196.256449226032;6221.129041934133;5715.828525144252;5726.484616384545;5729.799457019068;5731.512821410143;5750;5353.38436079848;5359.785608575691;5366.892662146735;5373.167159090347;5378.704171270618;5301.787928482818;6179.938200618026;6233.0338797486465;6326.082718005771;6355.87288254223;6235.251769787655;6282.874342513215;6295.748170073146;6317.178766760292;6325.177726895658;6200.286966998672;6309.779157729457;6345.90481142774;6348.396902294275;6357.554971151975;6067;6151.231096112986;6151.630902145886;6165.383461653799;6182.072689096672;6192.164057852132;6247.031710084944;6266.561340706106;6270.184875966095;6289.622622642656;4938.506149385033;5941.287045554561;6053.273607167168;6073.908891366721;6089.360617135137;6082.60463069899;6106.511479081574;6111.04482360895;6123.892747182756;6132.477886260695;4968.751562421937;5921.348651648402;5924.437178468039;5929.0513517836935;5951.315598706031;5974.731137098928;5995.280566332068;6074;6111.694415279129;6125.081237814364;6008.54935879802;6030.849228769316;6031.788887388921;6039.667818270037;6056.878862422815 15:33:25 INFO - PROCESS | 1671 | |1;ext.html;480.9735464549448;572.8052462162864;581.4795757796769;636.4780879678663;644.6905485367024;35453.82273088634;37974.43038354423;38068.619313806856;38077.428838567444;38092.42861357075;40130;40472.78581642548;40661;40682.59317406825;40949.38575921356;9501.42991420517;9726.610935562569;9729.756756081119;9735.123838854503;9748.220142388627;9448.291378146632;9587;9588.137067663909;9591.66429174979;9616.519174041305;9679.854802177973;9748.220142388593;9753.414795112281;9760.365576237557;9772.97383774704;9640.903590964106;9726.805463890683;9733.902660973441;9734.707958761284;9745.31782775206;9647;9810.656627018092;9820.508974551243;9831.31180817343;9844.65543705974;37312.440313395324;37525.81237093824;37527.249455010744;37558;37603.05992350186;3143.7170654640963;3179.459491886385;3251.1872031992;3595.2449985503076;4023.5574086850424;27512.862435687694;27601.723982760115;28051.579226311416;28318.716812831815;28502.144935651962;2745.1901689001793;2770.279727270904;2828.632277803893;2844.1183233197776;2870.138958312498;363171.1841440802;367560;367704;368446;368968;44052.3392149118;44655.55344446514;58423.12365314524;62215;62367.37632623615;43267.78366108149;43403;43408.56591434108;43494.13011739747;43545;15479.922600386926;15566.377344906303;15599.298031588605;15629.765553516707;15647.139407332706;12347.19743216688;12579.74840503203;12609.684757881127;12633.052521060958;12656.620301390973;9744.756381090388;14183.574492765234;14237.288135593179;14247.572572822832;14326.856731432552;6309.968450157811;6378.84052898672;6404.967975160094;6416.529636090139;6445.581037232565;918.0406475233397;926.5089502563652;989.2382865193761;1039.365986748083;1098.3903933317085;24172.274831755076;27302.45395092087;27994.720052799617;28302.150935471967;29016.564751528746;1103.9724006899892;1139.3676509537286;1169.859616845967;1249.331607589935;1269.2955409747678;14644.414223431157;15491.612709682122;15523.37906483728;15529.534113976599;15676.451324203597;651910;660521;663331;664311;666412;57021;58435.123473147934;58591.70704146452;58605.41394586085;58615.70692146512;1329.056369977327;1354.3025341948903;1482.3774014913763;1550.34110503038;1606.5260748079345;27937.301567460163;28637.19889745599;29345.7065429343;29421.85289073541;29505.704942951153;47073;51853.740731297614;52777.736111319195;52818.471815282894;53012.73493632507;497061;497446;506842;507314;507325;34655;34887.302253955284;41777.44891684241;42292;43074.78462607667;40303;40709;41741.58258417377;41825;42248.78875605603;34855.65144348524;35938.64061359457;35965.82017089898;36659.63340366562;36767;35182.29635407226;35373.82313088418;35793.46309805303;36097.81951090228;36132.81933590315;34523.13692157616;35250;36135.63864361428;36343;36474.27051459009;31580.526292106097;31630.051098467084;31768.841155794074;31771;31792.682073179898;24106.63840042436;24342.90456929407;24362.147324843547;24922.252332430056;25023.12419065324 15:33:25 INFO - PROCESS | 1671 | |2;jquery.html;352.52057202205003;355.5306994766907;357.35675783589534;363.5655391806792;363.82536382536364;19820.70268945967;20257.898710506463;20365.49086272842;20801.479963000933;20813;11930.582429614966;19282.710759338584;20456.795432045674;20466.38600841977;20509.384718458434;5299.046171689094;5443.673379597237;5507.807226747064;5510.476504732044;5512.724363781815;4034.5360283567325;4204.579542045802;5477.67133971961;5857.648541087548;6100;6097.664628445434;6107.603005804631;6114.3579924108;6116.969415152918;6117.235345581802;5909.261342332208;5998.310194327642;6074.817755467343;6082.635041897501;6084.421979911879;3844.8077596120083;5578.330600327987;5784.30588329399;5784.68184249866;5802.361740208574;13038.21770693752;13381.330933453288;13548.59354219375;13574.117682350616;13601.387937542835;1990.3332383651493;2010.8994550272573;2168.0785666091847;2432.4526981429035;2868.7991840571167;10080.623046125207;10389.480525973746;12881;14757.40970361195;14899.553013409615;1511.5918701950523;1668.1992643531173;1727.535828993803;1805.9548511287192;1836.742856000161;77873.61063194704;90676;90985.54507227488;92493.53753231258;95727.52136239344;11326.490307935997;11383.203175777617;11434.256773309708;11455;11593.826092608617;13868.237246951514;13921.443142274398;13951.790723139162;13957.860421395859;13968.720625587432;8325.95837020811;8581.442206256574;8594.527300998505;8674.959004919323;8682.348823838238;8740.125987401208;8742.562871856382;8884.333674974403;8982.550872456351;9025.232855207381;4155.961009747563;4341.175176716414;4418.779061046935;4497.955020449819;4564.132814765184;1410.6473381654587;1513.8788896888223;1768.9469315920544;1816.5912669649224;1859.7024476083761;798.5129071266523;803.277050654404;818.5252553518944;825.0800357601352;1031.0771859186136;18906.716399254023;18927.337543185924;19199.232030718893;19459.22163113488;19651.31220407279;955.245356168633;962.8266911955915;964.3442459127721;975.7463059604412;990.0396615283164;10540.631077912236;10751.193660475496;10773.461326933622;10775.515101820436;10780.730481738019;504731;515432;515840;646498;646756;121254.78745212611;125710;127824.1652750419;128766;134066;1031.29356390871;1051.574112484445;1056.9312994655322;1067.503610820972;1067.5996501312009;14836.7774483385;17584.472465826046;17878.927264364178;17944;17989.460316190536;50204.49795502144;54127.458725412245;54534.45465545452;54903.17645235245;54924.45075549353;77910.22089779029;78929.60535197287;78957;79556.80664790148;79655;7305.3425191732995;7978.401619878417;7985.680572777024;8120.9848768903885;8353.289970352587;9467.384619999679;10098.646547370807;12589.93705031469;12993.220406775623;13404.396802143732;11193.048590869541;11431.542738290374;11635.941820290844;11751.294922304689;11775.76448471043;11495.8275625864;11584.884151158381;11600.88399115998;11613.767724645291;11923.701907452383;11376.033037191932;11750;11919;11988.880111199125;12133.817992730294;8055.838883222185;8102.5948702563455;8105.432619716563;8145.8370832584205;8145.918540814753;8511.06378298399;10768.676939691823;11722.355270460206;11914.344711040976;11926.522939082686 15:33:25 INFO - PROCESS | 1671 | |3;mootools.html;1348.298884580019;1496.6258435391153;1515.984840151598;1753.7720096387468;1949.7855235924055;7014.298570142983;7909.6836126554945;8625.309975201992;8641.351898607598;8646.394752367321;8392.706255281066;8655.870161947576;8660.956695216515;8678.47929124253;8682.479051256929;2148.2051640892814;2199.670049492581;2204.3166618348364;2442.450448649053;2463.7659422354936;2414.1912459326145;2478.4175718706088;2478.652988581591;2484.714257860342;2486.080150344375;2349.1073392110975;2364.290712786157;2366.479374537599;2373.8100951923893;2430.8419952703107;2126.8936553172434;2362.4802543440414;2428.963565546518;2429.538387706339;2438.402591365109;2389.498205376873;2428.987855060731;2432.270318904322;2434.415740222352;2435.488547405047;8543.743687689317;8629.43908645936;8643.956780216122;8660.566971651393;8662.566871656454;5177.715225662587;5363.919541206885;5363.973180134113;5367.194920761917;5373.952079344529;3445.638207988175;3493.2489514754448;3675.4119340905327;3678.5953545110015;3679.6136405677553;1047.193660881125;1053.0522529723235;1063.5373612478597;1069.8769641491251;1070.208046045928;11802.704932376588;11882.28706277626;11889.167758256925;11894.52421903123;11906.46420911061;4737.715737055788;4813.855584332476;4866.294387313819;4879.365682461257;4886.560209581155;10001.49992500372;10083.344582602107;10085.596576137019;10114;10129.848052279222;5371.006363822706;5411.431799661058;5412.83761487156;5416.0792665247;5422.240886275925;4405.537418571004;4514.300283456004;4721.763911804396;4936.654434189644;4968.428630707443;3844.058205739556;3902.746321489094;3908.511436070491;3930.5849894038124;3941.5664276929515;1275.9234445933273;1290.2774446309909;1295.8833704966598;1300.387519475862;1307.3332600373878;1333.5399287245884;1354.2416246901766;1356.85752995936;1358.7146699193083;1382.1499777636882;7961.6019199040975;8177.836443271221;8180.100188979208;8182.918170818216;8233;507.43167652229;510.16842546648724;519.7713006277226;523.9318888544465;526.0898645343577;6176.104464852571;6176.567640265228;6237.033259844731;6248.812535623939;6253.1245625612455;10323.793524129474;10680;10767.730806729738;10781.407022613832;10785.730356741144;10407.635732749317;10465.895341046493;10513.579456821795;10551.84172237417;10668.786624267626;8287.12985136552;8321.83356332882;8360.122187170382;8366.58167091643;8368.58157092143;7771.8834217485655;7849.568273744999;7857.096433910174;7857.567833769198;7918.445708800328;9517.952410237904;9599.616015359308;9698.030196980246;9729.805403892024;9785.36395134314;9742.415455072718;9882.802343953224;9911.405315681082;9952.601895924083;10033.046860548237;6206.72069756853;6687.431568316748;7007.929920700932;7486.6256687166515;7548.773536793905;8138.145494722969;8201.671933122847;8209.753707388787;8212.630431630472;8228.42401031922;7135.322144396274;7169.964150179216;7211.567305961659;7312.232215617283;7352.852942941218;6009.639421634716;7128.251533588898;7177.569345839266;7255.782326530212;7332.816679583053;7564.962175189089;7676.731314403969;7697.807554811175;7712.190220026816;7727.536347819148;6933.341332573397;6984.895226571504;7018.508704390848;7019.403350715246;7027.332403421667;6787.762428314985;7017.298270172942;7038.366547010589;7050.788476345718;7089.82275443118 15:33:25 INFO - PROCESS | 1671 | |4;prototype.html;250.3653239039036;283.53783333166933;323.4840429514924;326.70759670095265;327.2848825316685;6472.546921715481;6573.506986975978;6600.6369649669305;6745.156855393076;6747;6611.735530578771;6632.30360812115;6662.666866656672;6682.331766823315;6686.1308029956035;4263.680223983198;4568.794404251817;4744.976275118637;4842.152623290927;4850.175470170071;3644.908877278063;3908.902277443058;4520.864374068767;4762.499937506564;4774.307725379818;4722.008378240574;4744.14605371033;4775.4985726498735;4794.904101917959;4796.688215266014;4561.6806823522365;4751.3348131261655;4785.593224575915;4854.247591623269;4867.685724854269;4159.459270294842;4167.979160104211;4182;4186.476690413699;4186.727862688916;5100.642954993152;6300.401461861115;6330.17707698001;6366.363363663643;6379.936200638027;4714.95285047152;5848.1520179574145;5853.268341457318;5853.824385268406;5853.85365365865;7052.5768453892415;7068.540544864567;7075.363217310467;7084.36240738336;7086.822829429306;4533.342665313511;4694.319323698045;4719.787609557578;4727.881802954954;4739.194336962724;6330.493560515148;7430.145533263636;7475.588842613654;7504.512206706547;7506.662200201004;4799.176313001038;4800.591949684246;4801.759912004386;4801.879953001133;4814.20565606678;4850.078485087822;4868.488808675109;4872.513883265638;4884.804607815648;4893.755312234374;5637.041702910515;5801.245838041028;5807.477327040502;5810.012297909366;5825.650460972355;6060.727267272983;6780.559263647847;7029.89455158173;7064.32888875556;7087.92912070883;1679.8404151605578;1682.4784316861812;1696.5843368374826;1701.753245779355;1702.8041775195763;1100.1199040767515;1101.7906597746403;1117.0951529261324;1130.2145009218514;1134.750354921916;6511.674416279167;6610.8347291318105;6676.432503237279;6791.252962174256;6823.420009299265;7443.925560744323;7455.105387353444;7460.738874139379;7488.588127652923;7499.100107987077;6740.898886516707;6744.595324280559;6753.831154221184;6765.086713293741;6807.421369183576;3141.7643676724338;3942.6845852331744;3952.01199700075;3954.0905591714068;3969.126792105732;7069.328413800681;7411.332980031823;7818;7819.804504887309;7836.608169591497;7637.847243055107;7657.1959944205055;7658.157602663702;7670.0795904491815;7711.730089446843;7815.765527034198;7838.568878711726;7841.568713720686;7849.097353804385;7855.33229675484;6141.710240849472;7438.293362130589;7443.739469118555;7454.291842274975;7464.365528930101;5969.641821490724;6888.552244104118;7277.345038946521;7341.229170937188;7352.301531354513;7863.017122859643;7874.56689882062;7874.803129921569;7880.211978802074;7882.487638303492;4615.215413379667;4662.463816661128;4667.8599642010795;4669.906601868011;4675.929861052155;7012.597480503818;7391.1869694334655;7401.5189012714;7401.666924988496;7427.368673662799;5772.682502462405;7151.928480715334;7155.713771449292;7159.785206443815;7186.640667966685;5785.17766903424;7059.788206353817;7149.571025738473;7156.677949492181;7158.6420678964805;6985.336393042653;6990.720371185095;6991.091158149408;6994.33553812387;6997.405220556309;6859.519833611799;7156.713731450892;7157.1769246537315;7177.677004534913;7200.89198662031;6682.899756503753;6847.931520684929;6858.41703455192;7016.403605693573;7029.191642961125 15:33:25 INFO - PROCESS | 1671 | |5;yui.html;645.1838424393144;673.8483841135744;687.6773771012366;738.9187189409167;739.5969196787751;15159.014664046828;15379.00036497627;15390.461333853318;15412.998155119909;15428;13853.515126970558;14051.43794248229;14132;14316.35576399062;14324.570262892104;728.5009768308726;878.7451639024691;892.3129190523293;893.8301722672704;894.4812009034745;731.0240828493967;881.713443130985;896.995515022424;898.3666515106867;901.3330135699567;948.9383190092622;949.3259785552266;952.342883410448;952.380952380951;954.775627727487;748.7603966730649;764.4877931785661;943.4386540008684;945.7162851144664;948.3266880514877;564.8898464799365;565.2651552981149;690.1993687322681;702.1574111066741;702.7224246422686;14833;14859;14927.925360373238;14929;14931.552053438414;12500.874991250063;12560.183588066746;12722.491100355976;12756.489740410372;13044.108604252426;8267.875981860278;9955.70132896007;9975.401475911469;9982.850257246148;10665.826759056497;3640.2173532690335;3650.543682039745;3654.5614526256754;3701.241245544657;3749.212665340282;79475.20524794736;79550.60224698897;79562;79708.80436793453;90522.47387630658;8206.83586328282;9462;9751.65869194589;9871.062249086326;9928.503574821374;21790.673139902916;21797.237096701538;21829.563408731738;21850.453738656342;21852.344429666817;7405.555666660018;7490.325870671666;7491.288327608869;7607.239276072459;7689.846203075907;3374.7806392584403;4062.370332598452;4072.165206132736;4157.625813676784;4195.979020104941;3466.8093254871224;3468.739844511672;3514.894553163409;3516.876909308162;3518.4546395308766;550.2516577454659;593.4984937727613;629.3046183966651;639.9872002559923;674.9605607364701;487.5646147493223;568.8179782469653;585.3064119018891;590.1619700025973;610.5237914426755;7228.891566626505;7919.722809701633;7974.840503189904;8061;8192.795180120425;514.572904489273;562.8986782379211;564.7938502446577;587.7648940423779;594.5570549940322;3725.441183822394;3779.8866034019024;3888.863889763845;3907.5897030811925;3908.5309762828642;92803;94146.52926735459;94571.52714236385;94735.52632236933;95195.04804951862;73414.63292683609;74155;74166.62916685382;79408;79720.405591889;64345.67827160834;68090;71400.92898606525;72108.63945680238;74531.62734186294;7595.088589369311;7604.2395760423515;7742.961285193538;7767.1456139825705;7846.568438735924;47670;48627.756861215465;49359;50008.49991500184;50431;64586.35413645803;69239;69927.30072699208;70451.47742612746;71654;9854.408735475608;9959.950200248952;9961.701148965543;10049.095581397709;10435.00867417594;11094.667159985212;11164.832527512257;11212.719682008015;11411.942940285246;11429.257098288585;10454.529546170288;10628.627998020032;10711.732206694895;10727.356358618508;10741.89258107409;10403.375797452178;10436;10625.25623206368;10630.73423164427;10690.946545267223;10263;10286.948565257126;10471.42407167613;10522.684319470429;10534;8646.524441155545;8647.697330593399;8685.696000639948;8887;8914.777130571787;7308.707651693872;8442.788930276793;8624.827503449771;8697.608607612547;8751.387402881737 15:33:25 INFO - PROCESS | 1671 | __end_tp_report 15:33:25 INFO - PROCESS | 1671 | __start_cc_report 15:33:25 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1264 15:33:25 INFO - PROCESS | 1671 | __end_cc_report 15:33:25 INFO - PROCESS | 1671 | __startTimestamp1457048005565__endTimestamp 15:33:25 INFO - PROCESS | 1671 | 15:33:25 INFO - PROCESS | 1671 | ------- Summary: start ------- 15:33:25 INFO - PROCESS | 1671 | Number of tests: 6 15:33:25 INFO - PROCESS | 1671 | 15:33:25 INFO - PROCESS | 1671 | [#0] dojo.html Cycles:165 Average:5695.22 Median:5929.05 stddev:655.24 (11.1%) stddev-sans-first:620.91 15:33:25 INFO - PROCESS | 1671 | Values: 2952.4 3235.7 3488.7 3507.1 3580.6 5643.7 5647.3 5663.6 5676.7 5694.4 5677.9 5764.4 5817.8 5897.3 5907.5 5056.7 5113.2 5159.1 5169.1 5280.2 4961.4 5178.3 5282.9 5284.1 5360.3 5100.0 5115.4 5175.1 5188.5 5221.1 5056.0 5064.2 5070.9 5094.3 5107.9 4999.1 5016.5 5029.3 5036.6 5049.7 5519.9 5623.7 5639.4 5710.9 5711.3 4836.5 6204.2 6215.0 6223.0 6223.4 6241.9 6243.9 6291.6 6296.4 6297.7 5695.4 5761.2 5769.9 5865.3 5872.0 6244.6 6252.5 6258.0 6265.6 6281.5 6061.0 6064.0 6132.7 6143.4 6160.7 5224.4 6140.5 6160.0 6282.9 6284.3 6133.7 6157.1 6158.2 6158.8 6168.5 6160.9 6168.9 6172.9 6182.3 6187.4 4809.4 4872.3 4900.7 4904.3 4906.5 4416.4 4427.7 4456.2 4456.4 4461.7 5617.4 5662.5 5674.5 5679.3 5689.7 6136.9 6180.4 6190.9 6196.3 6221.1 5715.8 5726.5 5729.8 5731.5 5750.0 5353.4 5359.8 5366.9 5373.2 5378.7 5301.8 6179.9 6233.0 6326.1 6355.9 6235.3 6282.9 6295.7 6317.2 6325.2 6200.3 6309.8 6345.9 6348.4 6357.6 6067.0 6151.2 6151.6 6165.4 6182.1 6192.2 6247.0 6266.6 6270.2 6289.6 4938.5 5941.3 6053.3 6073.9 6089.4 6082.6 6106.5 6111.0 6123.9 6132.5 4968.8 5921.3 5924.4 5929.1 5951.3 5974.7 5995.3 6074.0 6111.7 6125.1 6008.5 6030.8 6031.8 6039.7 6056.9 15:33:25 INFO - PROCESS | 1671 | 15:33:25 INFO - PROCESS | 1671 | [#1] ext.html Cycles:180 Average:64051.14 Median:37542.62 stddev:140388.91 (373.9%) stddev-sans-first:140701.61 15:33:25 INFO - PROCESS | 1671 | Values: 481.0 572.8 581.5 636.5 644.7 35453.8 37974.4 38068.6 38077.4 38092.4 40130.0 40472.8 40661.0 40682.6 40949.4 9501.4 9726.6 9729.8 9735.1 9748.2 9448.3 9587.0 9588.1 9591.7 9616.5 9679.9 9748.2 9753.4 9760.4 9773.0 9640.9 9726.8 9733.9 9734.7 9745.3 9647.0 9810.7 9820.5 9831.3 9844.7 37312.4 37525.8 37527.2 37558.0 37603.1 3143.7 3179.5 3251.2 3595.2 4023.6 27512.9 27601.7 28051.6 28318.7 28502.1 2745.2 2770.3 2828.6 2844.1 2870.1 363171.2 367560.0 367704.0 368446.0 368968.0 44052.3 44655.6 58423.1 62215.0 62367.4 43267.8 43403.0 43408.6 43494.1 43545.0 15479.9 15566.4 15599.3 15629.8 15647.1 12347.2 12579.7 12609.7 12633.1 12656.6 9744.8 14183.6 14237.3 14247.6 14326.9 6310.0 6378.8 6405.0 6416.5 6445.6 918.0 926.5 989.2 1039.4 1098.4 24172.3 27302.5 27994.7 28302.2 29016.6 1104.0 1139.4 1169.9 1249.3 1269.3 14644.4 15491.6 15523.4 15529.5 15676.5 651910.0 660521.0 663331.0 664311.0 666412.0 57021.0 58435.1 58591.7 58605.4 58615.7 1329.1 1354.3 1482.4 1550.3 1606.5 27937.3 28637.2 29345.7 29421.9 29505.7 47073.0 51853.7 52777.7 52818.5 53012.7 497061.0 497446.0 506842.0 507314.0 507325.0 34655.0 34887.3 41777.4 42292.0 43074.8 40303.0 40709.0 41741.6 41825.0 42248.8 34855.7 35938.6 35965.8 36659.6 36767.0 35182.3 35373.8 35793.5 36097.8 36132.8 34523.1 35250.0 36135.6 36343.0 36474.3 31580.5 31630.1 31768.8 31771.0 31792.7 24106.6 24342.9 24362.1 24922.3 25023.1 15:33:25 INFO - PROCESS | 1671 | 15:33:25 INFO - PROCESS | 1671 | [#2] jquery.html Cycles:180 Average:32939.80 Median:11490.54 stddev:94887.58 (825.8%) stddev-sans-first:95122.21 15:33:25 INFO - PROCESS | 1671 | Values: 352.5 355.5 357.4 363.6 363.8 19820.7 20257.9 20365.5 20801.5 20813.0 11930.6 19282.7 20456.8 20466.4 20509.4 5299.0 5443.7 5507.8 5510.5 5512.7 4034.5 4204.6 5477.7 5857.6 6100.0 6097.7 6107.6 6114.4 6117.0 6117.2 5909.3 5998.3 6074.8 6082.6 6084.4 3844.8 5578.3 5784.3 5784.7 5802.4 13038.2 13381.3 13548.6 13574.1 13601.4 1990.3 2010.9 2168.1 2432.5 2868.8 10080.6 10389.5 12881.0 14757.4 14899.6 1511.6 1668.2 1727.5 1806.0 1836.7 77873.6 90676.0 90985.5 92493.5 95727.5 11326.5 11383.2 11434.3 11455.0 11593.8 13868.2 13921.4 13951.8 13957.9 13968.7 8326.0 8581.4 8594.5 8675.0 8682.3 8740.1 8742.6 8884.3 8982.6 9025.2 4156.0 4341.2 4418.8 4498.0 4564.1 1410.6 1513.9 1768.9 1816.6 1859.7 798.5 803.3 818.5 825.1 1031.1 18906.7 18927.3 19199.2 19459.2 19651.3 955.2 962.8 964.3 975.7 990.0 10540.6 10751.2 10773.5 10775.5 10780.7 504731.0 515432.0 515840.0 646498.0 646756.0 121254.8 125710.0 127824.2 128766.0 134066.0 1031.3 1051.6 1056.9 1067.5 1067.6 14836.8 17584.5 17878.9 17944.0 17989.5 50204.5 54127.5 54534.5 54903.2 54924.5 77910.2 78929.6 78957.0 79556.8 79655.0 7305.3 7978.4 7985.7 8121.0 8353.3 9467.4 10098.6 12589.9 12993.2 13404.4 11193.0 11431.5 11635.9 11751.3 11775.8 11495.8 11584.9 11600.9 11613.8 11923.7 11376.0 11750.0 11919.0 11988.9 12133.8 8055.8 8102.6 8105.4 8145.8 8145.9 8511.1 10768.7 11722.4 11914.3 11926.5 15:33:25 INFO - PROCESS | 1671 | 15:33:25 INFO - PROCESS | 1671 | [#3] mootools.html Cycles:180 Average:5980.54 Median:525.01 stddev:3193.73 (608.3%) stddev-sans-first:3183.71 15:33:25 INFO - PROCESS | 1671 | Values: 1348.3 1496.6 1516.0 1753.8 1949.8 7014.3 7909.7 8625.3 8641.4 8646.4 8392.7 8655.9 8661.0 8678.5 8682.5 2148.2 2199.7 2204.3 2442.5 2463.8 2414.2 2478.4 2478.7 2484.7 2486.1 2349.1 2364.3 2366.5 2373.8 2430.8 2126.9 2362.5 2429.0 2429.5 2438.4 2389.5 2429.0 2432.3 2434.4 2435.5 8543.7 8629.4 8644.0 8660.6 8662.6 5177.7 5363.9 5364.0 5367.2 5374.0 3445.6 3493.2 3675.4 3678.6 3679.6 1047.2 1053.1 1063.5 1069.9 1070.2 11802.7 11882.3 11889.2 11894.5 11906.5 4737.7 4813.9 4866.3 4879.4 4886.6 10001.5 10083.3 10085.6 10114.0 10129.8 5371.0 5411.4 5412.8 5416.1 5422.2 4405.5 4514.3 4721.8 4936.7 4968.4 3844.1 3902.7 3908.5 3930.6 3941.6 1275.9 1290.3 1295.9 1300.4 1307.3 1333.5 1354.2 1356.9 1358.7 1382.1 7961.6 8177.8 8180.1 8182.9 8233.0 507.4 510.2 519.8 523.9 526.1 6176.1 6176.6 6237.0 6248.8 6253.1 10323.8 10680.0 10767.7 10781.4 10785.7 10407.6 10465.9 10513.6 10551.8 10668.8 8287.1 8321.8 8360.1 8366.6 8368.6 7771.9 7849.6 7857.1 7857.6 7918.4 9518.0 9599.6 9698.0 9729.8 9785.4 9742.4 9882.8 9911.4 9952.6 10033.0 6206.7 6687.4 7007.9 7486.6 7548.8 8138.1 8201.7 8209.8 8212.6 8228.4 7135.3 7170.0 7211.6 7312.2 7352.9 6009.6 7128.3 7177.6 7255.8 7332.8 7565.0 7676.7 7697.8 7712.2 7727.5 6933.3 6984.9 7018.5 7019.4 7027.3 6787.8 7017.3 7038.4 7050.8 7089.8 15:33:25 INFO - PROCESS | 1671 | 15:33:25 INFO - PROCESS | 1671 | [#4] prototype.html Cycles:180 Average:5794.95 Median:6611.29 stddev:1879.31 (28.4%) stddev-sans-first:1837.93 15:33:25 INFO - PROCESS | 1671 | Values: 250.4 283.5 323.5 326.7 327.3 6472.5 6573.5 6600.6 6745.2 6747.0 6611.7 6632.3 6662.7 6682.3 6686.1 4263.7 4568.8 4745.0 4842.2 4850.2 3644.9 3908.9 4520.9 4762.5 4774.3 4722.0 4744.1 4775.5 4794.9 4796.7 4561.7 4751.3 4785.6 4854.2 4867.7 4159.5 4168.0 4182.0 4186.5 4186.7 5100.6 6300.4 6330.2 6366.4 6379.9 4715.0 5848.2 5853.3 5853.8 5853.9 7052.6 7068.5 7075.4 7084.4 7086.8 4533.3 4694.3 4719.8 4727.9 4739.2 6330.5 7430.1 7475.6 7504.5 7506.7 4799.2 4800.6 4801.8 4801.9 4814.2 4850.1 4868.5 4872.5 4884.8 4893.8 5637.0 5801.2 5807.5 5810.0 5825.7 6060.7 6780.6 7029.9 7064.3 7087.9 1679.8 1682.5 1696.6 1701.8 1702.8 1100.1 1101.8 1117.1 1130.2 1134.8 6511.7 6610.8 6676.4 6791.3 6823.4 7443.9 7455.1 7460.7 7488.6 7499.1 6740.9 6744.6 6753.8 6765.1 6807.4 3141.8 3942.7 3952.0 3954.1 3969.1 7069.3 7411.3 7818.0 7819.8 7836.6 7637.8 7657.2 7658.2 7670.1 7711.7 7815.8 7838.6 7841.6 7849.1 7855.3 6141.7 7438.3 7443.7 7454.3 7464.4 5969.6 6888.6 7277.3 7341.2 7352.3 7863.0 7874.6 7874.8 7880.2 7882.5 4615.2 4662.5 4667.9 4669.9 4675.9 7012.6 7391.2 7401.5 7401.7 7427.4 5772.7 7151.9 7155.7 7159.8 7186.6 5785.2 7059.8 7149.6 7156.7 7158.6 6985.3 6990.7 6991.1 6994.3 6997.4 6859.5 7156.7 7157.2 7177.7 7200.9 6682.9 6847.9 6858.4 7016.4 7029.2 15:33:25 INFO - PROCESS | 1671 | 15:33:25 INFO - PROCESS | 1671 | [#5] yui.html Cycles:180 Average:18157.33 Median:32615.77 stddev:25949.34 (79.6%) stddev-sans-first:25988.82 15:33:25 INFO - PROCESS | 1671 | Values: 645.2 673.8 687.7 738.9 739.6 15159.0 15379.0 15390.5 15413.0 15428.0 13853.5 14051.4 14132.0 14316.4 14324.6 728.5 878.7 892.3 893.8 894.5 731.0 881.7 897.0 898.4 901.3 948.9 949.3 952.3 952.4 954.8 748.8 764.5 943.4 945.7 948.3 564.9 565.3 690.2 702.2 702.7 14833.0 14859.0 14927.9 14929.0 14931.6 12500.9 12560.2 12722.5 12756.5 13044.1 8267.9 9955.7 9975.4 9982.9 10665.8 3640.2 3650.5 3654.6 3701.2 3749.2 79475.2 79550.6 79562.0 79708.8 90522.5 8206.8 9462.0 9751.7 9871.1 9928.5 21790.7 21797.2 21829.6 21850.5 21852.3 7405.6 7490.3 7491.3 7607.2 7689.8 3374.8 4062.4 4072.2 4157.6 4196.0 3466.8 3468.7 3514.9 3516.9 3518.5 550.3 593.5 629.3 640.0 675.0 487.6 568.8 585.3 590.2 610.5 7228.9 7919.7 7974.8 8061.0 8192.8 514.6 562.9 564.8 587.8 594.6 3725.4 3779.9 3888.9 3907.6 3908.5 92803.0 94146.5 94571.5 94735.5 95195.0 73414.6 74155.0 74166.6 79408.0 79720.4 64345.7 68090.0 71400.9 72108.6 74531.6 7595.1 7604.2 7743.0 7767.1 7846.6 47670.0 48627.8 49359.0 50008.5 50431.0 64586.4 69239.0 69927.3 70451.5 71654.0 9854.4 9960.0 9961.7 10049.1 10435.0 11094.7 11164.8 11212.7 11411.9 11429.3 10454.5 10628.6 10711.7 10727.4 10741.9 10403.4 10436.0 10625.3 10630.7 10690.9 10263.0 10286.9 10471.4 10522.7 10534.0 8646.5 8647.7 8685.7 8887.0 8914.8 7308.7 8442.8 8624.8 8697.6 8751.4 15:33:25 INFO - PROCESS | 1671 | -------- Summary: end -------- 15:33:25 INFO - PROCESS | 1671 | 15:33:26 INFO - TEST-INFO | 1671: exit 0 15:33:26 INFO - TEST-OK | dromaeo_css | took 1114622ms 15:33:26 INFO - TEST-START | kraken 15:33:26 INFO - operating with platform_type : mac_ 15:33:26 INFO - Initialising browser for kraken test... 15:33:26 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmp_Df20W/profile http://localhost:49280/getInfo.html) 15:33:28 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 15:33:28 INFO - PROCESS | 1682 | colorDepth:24 15:33:28 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 15:33:28 INFO - PROCESS | 1682 | __metrics 15:33:28 INFO - PROCESS | 1682 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:33:28 INFO - PROCESS | 1682 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:33:28 INFO - TEST-INFO | 1682: exit 0 15:33:28 INFO - Browser initialized. 15:33:28 INFO - Running cycle 1/1 for kraken test... 15:33:28 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmp_Df20W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:33:40 INFO - PROCESS | 1684 | RSS: Main: 243699712 15:33:40 INFO - PROCESS | 1684 | 15:33:43 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 15:33:44 INFO - PROCESS | 1684 | RSS: Main: 288038912 15:33:44 INFO - PROCESS | 1684 | 15:33:46 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 15:33:47 INFO - PROCESS | 1684 | RSS: Main: 298680320 15:33:47 INFO - PROCESS | 1684 | 15:33:50 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 15:33:51 INFO - PROCESS | 1684 | RSS: Main: 284520448 15:33:51 INFO - PROCESS | 1684 | 15:33:53 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 15:33:53 INFO - PROCESS | 1684 | RSS: Main: 287342592 15:33:53 INFO - PROCESS | 1684 | 15:33:55 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:33:56 INFO - PROCESS | 1684 | RSS: Main: 289841152 15:33:56 INFO - PROCESS | 1684 | 15:33:58 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 15:33:59 INFO - PROCESS | 1684 | RSS: Main: 290009088 15:33:59 INFO - PROCESS | 1684 | 15:34:02 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 15:34:02 INFO - PROCESS | 1684 | RSS: Main: 290230272 15:34:02 INFO - PROCESS | 1684 | 15:34:05 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 15:34:06 INFO - PROCESS | 1684 | RSS: Main: 290115584 15:34:06 INFO - PROCESS | 1684 | 15:34:08 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:34:08 INFO - PROCESS | 1684 | RSS: Main: 322588672 15:34:08 INFO - PROCESS | 1684 | 15:34:10 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:34:11 INFO - PROCESS | 1684 | RSS: Main: 323006464 15:34:11 INFO - PROCESS | 1684 | 15:34:13 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:34:13 INFO - PROCESS | 1684 | RSS: Main: 331329536 15:34:13 INFO - PROCESS | 1684 | 15:34:16 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:34:16 INFO - PROCESS | 1684 | RSS: Main: 333041664 15:34:16 INFO - PROCESS | 1684 | 15:34:19 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:34:19 INFO - PROCESS | 1684 | RSS: Main: 331624448 15:34:19 INFO - PROCESS | 1684 | 15:34:21 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 15:34:21 INFO - PROCESS | 1684 | RSS: Main: 392806400 15:34:21 INFO - PROCESS | 1684 | 15:34:21 INFO - PROCESS | 1684 | __start_tp_report 15:34:21 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 15:34:21 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 15:34:21 INFO - PROCESS | 1684 | |i|pagename|runs| 15:34:21 INFO - PROCESS | 1684 | |0;ai-astar;110;106;111;111;109;110;114;110;110;108 15:34:21 INFO - PROCESS | 1684 | |1;audio-beat-detection;158;124;148;179;123;141;140;119;160;120 15:34:21 INFO - PROCESS | 1684 | |2;audio-dft;182;186;183;186;184;185;184;185;181;183 15:34:21 INFO - PROCESS | 1684 | |3;audio-fft;76;76;85;78;57;57;58;81;77;56 15:34:21 INFO - PROCESS | 1684 | |4;audio-oscillator;94;89;122;79;79;88;113;76;78;115 15:34:21 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;87;84;87;85;87;84;87;84;86;83 15:34:21 INFO - PROCESS | 1684 | |6;imaging-darkroom;94;92;92;93;94;92;93;93;93;93 15:34:21 INFO - PROCESS | 1684 | |7;imaging-desaturate;85;93;128;85;87;84;87;99;133;141 15:34:21 INFO - PROCESS | 1684 | |8;json-parse-financial;57;55;56;54;53;53;55;63;56;52 15:34:21 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;65;70;65;78;71;68;67;68;66;69 15:34:21 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;84;82;82;83;83;82;80;86;83;84 15:34:21 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;121;124;120;119;119;126;119;110;125;131 15:34:21 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;136;126;139;136;135;126;138;136;139;139 15:34:21 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;66;67;65;68;67;67;68;72;88;83 15:34:21 INFO - PROCESS | 1684 | __end_tp_report 15:34:21 INFO - PROCESS | 1684 | __start_cc_report 15:34:21 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1248 15:34:21 INFO - PROCESS | 1684 | __end_cc_report 15:34:21 INFO - PROCESS | 1684 | __startTimestamp1457048061931__endTimestamp 15:34:21 INFO - PROCESS | 1684 | 15:34:21 INFO - PROCESS | 1684 | ------- Summary: start ------- 15:34:21 INFO - PROCESS | 1684 | Number of tests: 14 15:34:21 INFO - PROCESS | 1684 | 15:34:21 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:2.08 (1.9%) stddev-sans-first:2.20 15:34:21 INFO - PROCESS | 1684 | Values: 110.0 106.0 111.0 111.0 109.0 110.0 114.0 110.0 110.0 108.0 15:34:21 INFO - PROCESS | 1684 | 15:34:21 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:144.50 stddev:20.23 (14.0%) stddev-sans-first:20.52 15:34:21 INFO - PROCESS | 1684 | Values: 158.0 124.0 148.0 179.0 123.0 141.0 140.0 119.0 160.0 120.0 15:34:21 INFO - PROCESS | 1684 | 15:34:21 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.50 stddev:1.66 (0.9%) stddev-sans-first:1.62 15:34:21 INFO - PROCESS | 1684 | Values: 182.0 186.0 183.0 186.0 184.0 185.0 184.0 185.0 181.0 183.0 15:34:21 INFO - PROCESS | 1684 | 15:34:21 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:70.10 Median:76.50 stddev:11.59 (15.1%) stddev-sans-first:12.09 15:34:21 INFO - PROCESS | 1684 | Values: 76.0 76.0 85.0 78.0 57.0 57.0 58.0 81.0 77.0 56.0 15:34:21 INFO - PROCESS | 1684 | 15:34:21 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:79.00 stddev:17.23 (21.8%) stddev-sans-first:18.27 15:34:21 INFO - PROCESS | 1684 | Values: 94.0 89.0 122.0 79.0 79.0 88.0 113.0 76.0 78.0 115.0 15:34:21 INFO - PROCESS | 1684 | 15:34:21 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:86.50 stddev:1.58 (1.8%) stddev-sans-first:1.56 15:34:21 INFO - PROCESS | 1684 | Values: 87.0 84.0 87.0 85.0 87.0 84.0 87.0 84.0 86.0 83.0 15:34:21 INFO - PROCESS | 1684 | 15:34:21 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 15:34:21 INFO - PROCESS | 1684 | Values: 94.0 92.0 92.0 93.0 94.0 92.0 93.0 93.0 93.0 93.0 15:34:21 INFO - PROCESS | 1684 | 15:34:21 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:102.20 Median:86.00 stddev:22.61 (26.3%) stddev-sans-first:23.11 15:34:21 INFO - PROCESS | 1684 | Values: 85.0 93.0 128.0 85.0 87.0 84.0 87.0 99.0 133.0 141.0 15:34:21 INFO - PROCESS | 1684 | 15:34:21 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:3.10 (5.6%) stddev-sans-first:3.23 15:34:21 INFO - PROCESS | 1684 | Values: 57.0 55.0 56.0 54.0 53.0 53.0 55.0 63.0 56.0 52.0 15:34:21 INFO - PROCESS | 1684 | 15:34:21 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:68.50 stddev:3.83 (5.6%) stddev-sans-first:3.82 15:34:21 INFO - PROCESS | 1684 | Values: 65.0 70.0 65.0 78.0 71.0 68.0 67.0 68.0 66.0 69.0 15:34:21 INFO - PROCESS | 1684 | 15:34:21 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:1.60 (1.9%) stddev-sans-first:1.64 15:34:21 INFO - PROCESS | 1684 | Values: 84.0 82.0 82.0 83.0 83.0 82.0 80.0 86.0 83.0 84.0 15:34:21 INFO - PROCESS | 1684 | 15:34:21 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:121.40 Median:122.50 stddev:5.60 (4.6%) stddev-sans-first:5.94 15:34:21 INFO - PROCESS | 1684 | Values: 121.0 124.0 120.0 119.0 119.0 126.0 119.0 110.0 125.0 131.0 15:34:21 INFO - PROCESS | 1684 | 15:34:21 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.00 Median:137.00 stddev:4.97 (3.6%) stddev-sans-first:5.25 15:34:21 INFO - PROCESS | 1684 | Values: 136.0 126.0 139.0 136.0 135.0 126.0 138.0 136.0 139.0 139.0 15:34:21 INFO - PROCESS | 1684 | 15:34:21 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:68.00 stddev:7.89 (11.6%) stddev-sans-first:8.15 15:34:21 INFO - PROCESS | 1684 | Values: 66.0 67.0 65.0 68.0 67.0 67.0 68.0 72.0 88.0 83.0 15:34:21 INFO - PROCESS | 1684 | -------- Summary: end -------- 15:34:21 INFO - PROCESS | 1684 | 15:34:22 INFO - TEST-INFO | 1684: exit 0 15:34:22 INFO - TEST-OK | kraken | took 56616ms 15:34:22 INFO - SUITE-END | took 1171s 15:34:23 INFO - Completed test suite (00:19:31) 15:34:23 INFO - Working with test: dromaeo_css 15:34:23 INFO - Generating results file: dromaeo_css 15:34:23 INFO - Working with test: kraken 15:34:23 INFO - Generating results file: kraken 15:34:23 INFO - javascript benchmark 15:34:23 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:34:23 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 15:34:23 INFO - process_Request line: dromaeo_css 7406.42 graph.html#tests=[[72,64,59]] 15:34:23 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:34:23 INFO - process_Request line: kraken 1413.40 graph.html#tests=[[232,64,59]] 15:34:23 INFO - RETURN: dromaeo_css: 7406.42 15:34:23 INFO - RETURN: kraken: 1413.40 15:34:23 INFO - javascript benchmark 15:34:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2952.3504828937635, 3235.7087862092408, 3488.6860182583546, 3507.0881570791585, 3580.62403447638, 5643.717814109294, 5647.29408823897, 5663.575231857607, 5676.716164191785, 5694.373618901917, 5677.8580535486635, 5764.365919748835, 5817.767289308433, 5897.3218079920825, 5907.527397808176, 5056.721880296592, 5113.156329205676, 5159.148740457838, 5169.09540830355, 5280.2079688046715, 4961.429435614897, 5178.300929374543, 5282.867928301785, 5284.075286824809, 5360.2763626910455, 5100.0, 5115.360579927509, 5175.0943584872875, 5188.533032027117, 5221.06020916235, 5055.974720126413, 5064.215046667772, 5070.898582028339, 5094.337736094321, 5107.897842043139, 4999.075171093323, 5016.523430274118, 5029.270755740397, 5036.597072234213, 5049.671771334852, 5519.889602207973, 5623.690697011662, 5639.379668236491, 5710.885782284331, 5711.343195532525, 4836.492168322346, 6204.162438070848, 6215.036669316263, 6222.96888515559, 6223.43989040984, 6241.906371404432, 6243.906341404882, 6291.559590828644, 6296.401841825065, 6297.748090076391, 5695.401982791788, 5761.193432919353, 5769.913451298234, 5865.325487568899, 5871.9706401468575, 6244.562880598405, 6252.468540174136, 6258.0, 6265.561410701298, 6281.528885333618, 6061.0, 6064.0, 6132.662703551258, 6143.416375444325, 6160.661163635953, 5224.399194092652, 6140.473573783541, 6160.0, 6282.874342513215, 6284.340144284875, 6133.662648554283, 6157.107219453154, 6158.1686472326555, 6158.753649853956, 6168.537359697951, 6160.907586386208, 6168.876622467616, 6172.8765424691255, 6182.28903676083, 6187.3503282155625, 4809.398825146856, 4872.317875497433, 4900.681455705368, 4904.337914381585, 4906.460289368167, 4416.359627854007, 4427.734335939854, 4456.153330867125, 4456.376107344974, 4461.665375096881, 5617.41017193197, 5662.490375866192, 5674.517665998354, 5679.318481782213, 5689.658620482702, 6136.85608443425, 6180.351063138396, 6190.907136392958, 6196.256449226032, 6221.129041934133, 5715.828525144252, 5726.484616384545, 5729.799457019068, 5731.512821410143, 5750.0, 5353.38436079848, 5359.785608575691, 5366.892662146735, 5373.167159090347, 5378.704171270618, 5301.787928482818, 6179.938200618026, 6233.0338797486465, 6326.082718005771, 6355.87288254223, 6235.251769787655, 6282.874342513215, 6295.748170073146, 6317.178766760292, 6325.177726895658, 6200.286966998672, 6309.779157729457, 6345.90481142774, 6348.396902294275, 6357.554971151975, 6067.0, 6151.231096112986, 6151.630902145886, 6165.383461653799, 6182.072689096672, 6192.164057852132, 6247.031710084944, 6266.561340706106, 6270.184875966095, 6289.622622642656, 4938.506149385033, 5941.287045554561, 6053.273607167168, 6073.908891366721, 6089.360617135137, 6082.60463069899, 6106.511479081574, 6111.04482360895, 6123.892747182756, 6132.477886260695, 4968.751562421937, 5921.348651648402, 5924.437178468039, 5929.0513517836935, 5951.315598706031, 5974.731137098928, 5995.280566332068, 6074.0, 6111.694415279129, 6125.081237814364, 6008.54935879802, 6030.849228769316, 6031.788887388921, 6039.667818270037, 6056.878862422815], "unit": "score", "name": "dojo.html", "value": 5654.188547478815}, {"lowerIsBetter": false, "replicates": [480.9735464549448, 572.8052462162864, 581.4795757796769, 636.4780879678663, 644.6905485367024, 35453.82273088634, 37974.43038354423, 38068.619313806856, 38077.428838567444, 38092.42861357075, 40130.0, 40472.78581642548, 40661.0, 40682.59317406825, 40949.38575921356, 9501.42991420517, 9726.610935562569, 9729.756756081119, 9735.123838854503, 9748.220142388627, 9448.291378146632, 9587.0, 9588.137067663909, 9591.66429174979, 9616.519174041305, 9679.854802177973, 9748.220142388593, 9753.414795112281, 9760.365576237557, 9772.97383774704, 9640.903590964106, 9726.805463890683, 9733.902660973441, 9734.707958761284, 9745.31782775206, 9647.0, 9810.656627018092, 9820.508974551243, 9831.31180817343, 9844.65543705974, 37312.440313395324, 37525.81237093824, 37527.249455010744, 37558.0, 37603.05992350186, 3143.7170654640963, 3179.459491886385, 3251.1872031992, 3595.2449985503076, 4023.5574086850424, 27512.862435687694, 27601.723982760115, 28051.579226311416, 28318.716812831815, 28502.144935651962, 2745.1901689001793, 2770.279727270904, 2828.632277803893, 2844.1183233197776, 2870.138958312498, 363171.1841440802, 367560.0, 367704.0, 368446.0, 368968.0, 44052.3392149118, 44655.55344446514, 58423.12365314524, 62215.0, 62367.37632623615, 43267.78366108149, 43403.0, 43408.56591434108, 43494.13011739747, 43545.0, 15479.922600386926, 15566.377344906303, 15599.298031588605, 15629.765553516707, 15647.139407332706, 12347.19743216688, 12579.74840503203, 12609.684757881127, 12633.052521060958, 12656.620301390973, 9744.756381090388, 14183.574492765234, 14237.288135593179, 14247.572572822832, 14326.856731432552, 6309.968450157811, 6378.84052898672, 6404.967975160094, 6416.529636090139, 6445.581037232565, 918.0406475233397, 926.5089502563652, 989.2382865193761, 1039.365986748083, 1098.3903933317085, 24172.274831755076, 27302.45395092087, 27994.720052799617, 28302.150935471967, 29016.564751528746, 1103.9724006899892, 1139.3676509537286, 1169.859616845967, 1249.331607589935, 1269.2955409747678, 14644.414223431157, 15491.612709682122, 15523.37906483728, 15529.534113976599, 15676.451324203597, 651910.0, 660521.0, 663331.0, 664311.0, 666412.0, 57021.0, 58435.123473147934, 58591.70704146452, 58605.41394586085, 58615.70692146512, 1329.056369977327, 1354.3025341948903, 1482.3774014913763, 1550.34110503038, 1606.5260748079345, 27937.301567460163, 28637.19889745599, 29345.7065429343, 29421.85289073541, 29505.704942951153, 47073.0, 51853.740731297614, 52777.736111319195, 52818.471815282894, 53012.73493632507, 497061.0, 497446.0, 506842.0, 507314.0, 507325.0, 34655.0, 34887.302253955284, 41777.44891684241, 42292.0, 43074.78462607667, 40303.0, 40709.0, 41741.58258417377, 41825.0, 42248.78875605603, 34855.65144348524, 35938.64061359457, 35965.82017089898, 36659.63340366562, 36767.0, 35182.29635407226, 35373.82313088418, 35793.46309805303, 36097.81951090228, 36132.81933590315, 34523.13692157616, 35250.0, 36135.63864361428, 36343.0, 36474.27051459009, 31580.526292106097, 31630.051098467084, 31768.841155794074, 31771.0, 31792.682073179898, 24106.63840042436, 24342.90456929407, 24362.147324843547, 24922.252332430056, 25023.12419065324], "unit": "score", "name": "ext.html", "value": 19127.581316694537}, {"lowerIsBetter": false, "replicates": [352.52057202205003, 355.5306994766907, 357.35675783589534, 363.5655391806792, 363.82536382536364, 19820.70268945967, 20257.898710506463, 20365.49086272842, 20801.479963000933, 20813.0, 11930.582429614966, 19282.710759338584, 20456.795432045674, 20466.38600841977, 20509.384718458434, 5299.046171689094, 5443.673379597237, 5507.807226747064, 5510.476504732044, 5512.724363781815, 4034.5360283567325, 4204.579542045802, 5477.67133971961, 5857.648541087548, 6100.0, 6097.664628445434, 6107.603005804631, 6114.3579924108, 6116.969415152918, 6117.235345581802, 5909.261342332208, 5998.310194327642, 6074.817755467343, 6082.635041897501, 6084.421979911879, 3844.8077596120083, 5578.330600327987, 5784.30588329399, 5784.68184249866, 5802.361740208574, 13038.21770693752, 13381.330933453288, 13548.59354219375, 13574.117682350616, 13601.387937542835, 1990.3332383651493, 2010.8994550272573, 2168.0785666091847, 2432.4526981429035, 2868.7991840571167, 10080.623046125207, 10389.480525973746, 12881.0, 14757.40970361195, 14899.553013409615, 1511.5918701950523, 1668.1992643531173, 1727.535828993803, 1805.9548511287192, 1836.742856000161, 77873.61063194704, 90676.0, 90985.54507227488, 92493.53753231258, 95727.52136239344, 11326.490307935997, 11383.203175777617, 11434.256773309708, 11455.0, 11593.826092608617, 13868.237246951514, 13921.443142274398, 13951.790723139162, 13957.860421395859, 13968.720625587432, 8325.95837020811, 8581.442206256574, 8594.527300998505, 8674.959004919323, 8682.348823838238, 8740.125987401208, 8742.562871856382, 8884.333674974403, 8982.550872456351, 9025.232855207381, 4155.961009747563, 4341.175176716414, 4418.779061046935, 4497.955020449819, 4564.132814765184, 1410.6473381654587, 1513.8788896888223, 1768.9469315920544, 1816.5912669649224, 1859.7024476083761, 798.5129071266523, 803.277050654404, 818.5252553518944, 825.0800357601352, 1031.0771859186136, 18906.716399254023, 18927.337543185924, 19199.232030718893, 19459.22163113488, 19651.31220407279, 955.245356168633, 962.8266911955915, 964.3442459127721, 975.7463059604412, 990.0396615283164, 10540.631077912236, 10751.193660475496, 10773.461326933622, 10775.515101820436, 10780.730481738019, 504731.0, 515432.0, 515840.0, 646498.0, 646756.0, 121254.78745212611, 125710.0, 127824.1652750419, 128766.0, 134066.0, 1031.29356390871, 1051.574112484445, 1056.9312994655322, 1067.503610820972, 1067.5996501312009, 14836.7774483385, 17584.472465826046, 17878.927264364178, 17944.0, 17989.460316190536, 50204.49795502144, 54127.458725412245, 54534.45465545452, 54903.17645235245, 54924.45075549353, 77910.22089779029, 78929.60535197287, 78957.0, 79556.80664790148, 79655.0, 7305.3425191732995, 7978.401619878417, 7985.680572777024, 8120.9848768903885, 8353.289970352587, 9467.384619999679, 10098.646547370807, 12589.93705031469, 12993.220406775623, 13404.396802143732, 11193.048590869541, 11431.542738290374, 11635.941820290844, 11751.294922304689, 11775.76448471043, 11495.8275625864, 11584.884151158381, 11600.88399115998, 11613.767724645291, 11923.701907452383, 11376.033037191932, 11750.0, 11919.0, 11988.880111199125, 12133.817992730294, 8055.838883222185, 8102.5948702563455, 8105.432619716563, 8145.8370832584205, 8145.918540814753, 8511.06378298399, 10768.676939691823, 11722.355270460206, 11914.344711040976, 11926.522939082686], "unit": "score", "name": "jquery.html", "value": 9203.215751215048}, {"lowerIsBetter": false, "replicates": [1348.298884580019, 1496.6258435391153, 1515.984840151598, 1753.7720096387468, 1949.7855235924055, 7014.298570142983, 7909.6836126554945, 8625.309975201992, 8641.351898607598, 8646.394752367321, 8392.706255281066, 8655.870161947576, 8660.956695216515, 8678.47929124253, 8682.479051256929, 2148.2051640892814, 2199.670049492581, 2204.3166618348364, 2442.450448649053, 2463.7659422354936, 2414.1912459326145, 2478.4175718706088, 2478.652988581591, 2484.714257860342, 2486.080150344375, 2349.1073392110975, 2364.290712786157, 2366.479374537599, 2373.8100951923893, 2430.8419952703107, 2126.8936553172434, 2362.4802543440414, 2428.963565546518, 2429.538387706339, 2438.402591365109, 2389.498205376873, 2428.987855060731, 2432.270318904322, 2434.415740222352, 2435.488547405047, 8543.743687689317, 8629.43908645936, 8643.956780216122, 8660.566971651393, 8662.566871656454, 5177.715225662587, 5363.919541206885, 5363.973180134113, 5367.194920761917, 5373.952079344529, 3445.638207988175, 3493.2489514754448, 3675.4119340905327, 3678.5953545110015, 3679.6136405677553, 1047.193660881125, 1053.0522529723235, 1063.5373612478597, 1069.8769641491251, 1070.208046045928, 11802.704932376588, 11882.28706277626, 11889.167758256925, 11894.52421903123, 11906.46420911061, 4737.715737055788, 4813.855584332476, 4866.294387313819, 4879.365682461257, 4886.560209581155, 10001.49992500372, 10083.344582602107, 10085.596576137019, 10114.0, 10129.848052279222, 5371.006363822706, 5411.431799661058, 5412.83761487156, 5416.0792665247, 5422.240886275925, 4405.537418571004, 4514.300283456004, 4721.763911804396, 4936.654434189644, 4968.428630707443, 3844.058205739556, 3902.746321489094, 3908.511436070491, 3930.5849894038124, 3941.5664276929515, 1275.9234445933273, 1290.2774446309909, 1295.8833704966598, 1300.387519475862, 1307.3332600373878, 1333.5399287245884, 1354.2416246901766, 1356.85752995936, 1358.7146699193083, 1382.1499777636882, 7961.6019199040975, 8177.836443271221, 8180.100188979208, 8182.918170818216, 8233.0, 507.43167652229, 510.16842546648724, 519.7713006277226, 523.9318888544465, 526.0898645343577, 6176.104464852571, 6176.567640265228, 6237.033259844731, 6248.812535623939, 6253.1245625612455, 10323.793524129474, 10680.0, 10767.730806729738, 10781.407022613832, 10785.730356741144, 10407.635732749317, 10465.895341046493, 10513.579456821795, 10551.84172237417, 10668.786624267626, 8287.12985136552, 8321.83356332882, 8360.122187170382, 8366.58167091643, 8368.58157092143, 7771.8834217485655, 7849.568273744999, 7857.096433910174, 7857.567833769198, 7918.445708800328, 9517.952410237904, 9599.616015359308, 9698.030196980246, 9729.805403892024, 9785.36395134314, 9742.415455072718, 9882.802343953224, 9911.405315681082, 9952.601895924083, 10033.046860548237, 6206.72069756853, 6687.431568316748, 7007.929920700932, 7486.6256687166515, 7548.773536793905, 8138.145494722969, 8201.671933122847, 8209.753707388787, 8212.630431630472, 8228.42401031922, 7135.322144396274, 7169.964150179216, 7211.567305961659, 7312.232215617283, 7352.852942941218, 6009.639421634716, 7128.251533588898, 7177.569345839266, 7255.782326530212, 7332.816679583053, 7564.962175189089, 7676.731314403969, 7697.807554811175, 7712.190220026816, 7727.536347819148, 6933.341332573397, 6984.895226571504, 7018.508704390848, 7019.403350715246, 7027.332403421667, 6787.762428314985, 7017.298270172942, 7038.366547010589, 7050.788476345718, 7089.82275443118], "unit": "score", "name": "mootools.html", "value": 4790.263209509697}, {"lowerIsBetter": false, "replicates": [250.3653239039036, 283.53783333166933, 323.4840429514924, 326.70759670095265, 327.2848825316685, 6472.546921715481, 6573.506986975978, 6600.6369649669305, 6745.156855393076, 6747.0, 6611.735530578771, 6632.30360812115, 6662.666866656672, 6682.331766823315, 6686.1308029956035, 4263.680223983198, 4568.794404251817, 4744.976275118637, 4842.152623290927, 4850.175470170071, 3644.908877278063, 3908.902277443058, 4520.864374068767, 4762.499937506564, 4774.307725379818, 4722.008378240574, 4744.14605371033, 4775.4985726498735, 4794.904101917959, 4796.688215266014, 4561.6806823522365, 4751.3348131261655, 4785.593224575915, 4854.247591623269, 4867.685724854269, 4159.459270294842, 4167.979160104211, 4182.0, 4186.476690413699, 4186.727862688916, 5100.642954993152, 6300.401461861115, 6330.17707698001, 6366.363363663643, 6379.936200638027, 4714.95285047152, 5848.1520179574145, 5853.268341457318, 5853.824385268406, 5853.85365365865, 7052.5768453892415, 7068.540544864567, 7075.363217310467, 7084.36240738336, 7086.822829429306, 4533.342665313511, 4694.319323698045, 4719.787609557578, 4727.881802954954, 4739.194336962724, 6330.493560515148, 7430.145533263636, 7475.588842613654, 7504.512206706547, 7506.662200201004, 4799.176313001038, 4800.591949684246, 4801.759912004386, 4801.879953001133, 4814.20565606678, 4850.078485087822, 4868.488808675109, 4872.513883265638, 4884.804607815648, 4893.755312234374, 5637.041702910515, 5801.245838041028, 5807.477327040502, 5810.012297909366, 5825.650460972355, 6060.727267272983, 6780.559263647847, 7029.89455158173, 7064.32888875556, 7087.92912070883, 1679.8404151605578, 1682.4784316861812, 1696.5843368374826, 1701.753245779355, 1702.8041775195763, 1100.1199040767515, 1101.7906597746403, 1117.0951529261324, 1130.2145009218514, 1134.750354921916, 6511.674416279167, 6610.8347291318105, 6676.432503237279, 6791.252962174256, 6823.420009299265, 7443.925560744323, 7455.105387353444, 7460.738874139379, 7488.588127652923, 7499.100107987077, 6740.898886516707, 6744.595324280559, 6753.831154221184, 6765.086713293741, 6807.421369183576, 3141.7643676724338, 3942.6845852331744, 3952.01199700075, 3954.0905591714068, 3969.126792105732, 7069.328413800681, 7411.332980031823, 7818.0, 7819.804504887309, 7836.608169591497, 7637.847243055107, 7657.1959944205055, 7658.157602663702, 7670.0795904491815, 7711.730089446843, 7815.765527034198, 7838.568878711726, 7841.568713720686, 7849.097353804385, 7855.33229675484, 6141.710240849472, 7438.293362130589, 7443.739469118555, 7454.291842274975, 7464.365528930101, 5969.641821490724, 6888.552244104118, 7277.345038946521, 7341.229170937188, 7352.301531354513, 7863.017122859643, 7874.56689882062, 7874.803129921569, 7880.211978802074, 7882.487638303492, 4615.215413379667, 4662.463816661128, 4667.8599642010795, 4669.906601868011, 4675.929861052155, 7012.597480503818, 7391.1869694334655, 7401.5189012714, 7401.666924988496, 7427.368673662799, 5772.682502462405, 7151.928480715334, 7155.713771449292, 7159.785206443815, 7186.640667966685, 5785.17766903424, 7059.788206353817, 7149.571025738473, 7156.677949492181, 7158.6420678964805, 6985.336393042653, 6990.720371185095, 6991.091158149408, 6994.33553812387, 6997.405220556309, 6859.519833611799, 7156.713731450892, 7157.1769246537315, 7177.677004534913, 7200.89198662031, 6682.899756503753, 6847.931520684929, 6858.41703455192, 7016.403605693573, 7029.191642961125], "unit": "score", "name": "prototype.html", "value": 5163.928251764299}, {"lowerIsBetter": false, "replicates": [645.1838424393144, 673.8483841135744, 687.6773771012366, 738.9187189409167, 739.5969196787751, 15159.014664046828, 15379.00036497627, 15390.461333853318, 15412.998155119909, 15428.0, 13853.515126970558, 14051.43794248229, 14132.0, 14316.35576399062, 14324.570262892104, 728.5009768308726, 878.7451639024691, 892.3129190523293, 893.8301722672704, 894.4812009034745, 731.0240828493967, 881.713443130985, 896.995515022424, 898.3666515106867, 901.3330135699567, 948.9383190092622, 949.3259785552266, 952.342883410448, 952.380952380951, 954.775627727487, 748.7603966730649, 764.4877931785661, 943.4386540008684, 945.7162851144664, 948.3266880514877, 564.8898464799365, 565.2651552981149, 690.1993687322681, 702.1574111066741, 702.7224246422686, 14833.0, 14859.0, 14927.925360373238, 14929.0, 14931.552053438414, 12500.874991250063, 12560.183588066746, 12722.491100355976, 12756.489740410372, 13044.108604252426, 8267.875981860278, 9955.70132896007, 9975.401475911469, 9982.850257246148, 10665.826759056497, 3640.2173532690335, 3650.543682039745, 3654.5614526256754, 3701.241245544657, 3749.212665340282, 79475.20524794736, 79550.60224698897, 79562.0, 79708.80436793453, 90522.47387630658, 8206.83586328282, 9462.0, 9751.65869194589, 9871.062249086326, 9928.503574821374, 21790.673139902916, 21797.237096701538, 21829.563408731738, 21850.453738656342, 21852.344429666817, 7405.555666660018, 7490.325870671666, 7491.288327608869, 7607.239276072459, 7689.846203075907, 3374.7806392584403, 4062.370332598452, 4072.165206132736, 4157.625813676784, 4195.979020104941, 3466.8093254871224, 3468.739844511672, 3514.894553163409, 3516.876909308162, 3518.4546395308766, 550.2516577454659, 593.4984937727613, 629.3046183966651, 639.9872002559923, 674.9605607364701, 487.5646147493223, 568.8179782469653, 585.3064119018891, 590.1619700025973, 610.5237914426755, 7228.891566626505, 7919.722809701633, 7974.840503189904, 8061.0, 8192.795180120425, 514.572904489273, 562.8986782379211, 564.7938502446577, 587.7648940423779, 594.5570549940322, 3725.441183822394, 3779.8866034019024, 3888.863889763845, 3907.5897030811925, 3908.5309762828642, 92803.0, 94146.52926735459, 94571.52714236385, 94735.52632236933, 95195.04804951862, 73414.63292683609, 74155.0, 74166.62916685382, 79408.0, 79720.405591889, 64345.67827160834, 68090.0, 71400.92898606525, 72108.63945680238, 74531.62734186294, 7595.088589369311, 7604.2395760423515, 7742.961285193538, 7767.1456139825705, 7846.568438735924, 47670.0, 48627.756861215465, 49359.0, 50008.49991500184, 50431.0, 64586.35413645803, 69239.0, 69927.30072699208, 70451.47742612746, 71654.0, 9854.408735475608, 9959.950200248952, 9961.701148965543, 10049.095581397709, 10435.00867417594, 11094.667159985212, 11164.832527512257, 11212.719682008015, 11411.942940285246, 11429.257098288585, 10454.529546170288, 10628.627998020032, 10711.732206694895, 10727.356358618508, 10741.89258107409, 10403.375797452178, 10436.0, 10625.25623206368, 10630.73423164427, 10690.946545267223, 10263.0, 10286.948565257126, 10471.42407167613, 10522.684319470429, 10534.0, 8646.524441155545, 8647.697330593399, 8685.696000639948, 8887.0, 8914.777130571787, 7308.707651693872, 8442.788930276793, 8624.827503449771, 8697.608607612547, 8751.387402881737], "unit": "score", "name": "yui.html", "value": 6703.552993503731}], "name": "dromaeo_css", "value": 7406.417078779653}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 111.0, 111.0, 109.0, 110.0, 114.0, 110.0, 110.0, 108.0], "unit": "score", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [158.0, 124.0, 148.0, 179.0, 123.0, 141.0, 140.0, 119.0, 160.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 141.2}, {"lowerIsBetter": true, "replicates": [182.0, 186.0, 183.0, 186.0, 184.0, 185.0, 184.0, 185.0, 181.0, 183.0], "unit": "score", "name": "audio-dft", "value": 183.9}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 85.0, 78.0, 57.0, 57.0, 58.0, 81.0, 77.0, 56.0], "unit": "score", "name": "audio-fft", "value": 70.1}, {"lowerIsBetter": true, "replicates": [94.0, 89.0, 122.0, 79.0, 79.0, 88.0, 113.0, 76.0, 78.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 93.3}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 87.0, 85.0, 87.0, 84.0, 87.0, 84.0, 86.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.4}, {"lowerIsBetter": true, "replicates": [94.0, 92.0, 92.0, 93.0, 94.0, 92.0, 93.0, 93.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 92.9}, {"lowerIsBetter": true, "replicates": [85.0, 93.0, 128.0, 85.0, 87.0, 84.0, 87.0, 99.0, 133.0, 141.0], "unit": "score", "name": "imaging-desaturate", "value": 102.2}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 56.0, 54.0, 53.0, 53.0, 55.0, 63.0, 56.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [65.0, 70.0, 65.0, 78.0, 71.0, 68.0, 67.0, 68.0, 66.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 82.0, 83.0, 83.0, 82.0, 80.0, 86.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [121.0, 124.0, 120.0, 119.0, 119.0, 126.0, 119.0, 110.0, 125.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.4}, {"lowerIsBetter": true, "replicates": [136.0, 126.0, 139.0, 136.0, 135.0, 126.0, 138.0, 136.0, 139.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.0}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 65.0, 68.0, 67.0, 67.0, 68.0, 72.0, 88.0, 83.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.1}], "name": "kraken", "value": 1413.4}]} 15:34:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1413.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7406.42"}}} 15:34:23 INFO - Return code: 0 15:34:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:34:23 INFO - # TBPL SUCCESS # 15:34:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:34:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:34:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:34:23 INFO - 2016-03-03 15:34:23.791 screenresolution[1688:10095] starting screenresolution argv=screenresolution get 15:34:23 INFO - 2016-03-03 15:34:23.794 screenresolution[1688:10095] Display 0: 1600x1200x32@60 15:34:23 INFO - 2016-03-03 15:34:23.799 screenresolution[1689:10098] starting screenresolution argv=screenresolution list 15:34:23 INFO - Available Modes on Display 0 15:34:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:34:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:34:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:34:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:34:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:34:24 INFO - Intel Iris: 15:34:24 INFO - Chipset Model: Intel Iris 15:34:24 INFO - Type: GPU 15:34:24 INFO - Bus: Built-In 15:34:24 INFO - VRAM (Dynamic, Max): 1536 MB 15:34:24 INFO - Vendor: Intel (0x8086) 15:34:24 INFO - Device ID: 0x0a2e 15:34:24 INFO - Revision ID: 0x0009 15:34:24 INFO - Displays: 15:34:24 INFO - Display: 15:34:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:34:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:34:24 INFO - Display Serial Number: 1600x1200 60 15:34:24 INFO - Main Display: Yes 15:34:24 INFO - Mirror: Off 15:34:24 INFO - Online: Yes 15:34:24 INFO - Rotation: Supported 15:34:24 INFO - Return code: 0 15:34:24 INFO - Running post-action listener: _resource_record_post_action 15:34:24 INFO - Running post-run listener: _resource_record_post_run 15:34:25 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39462400; Write bytes: 706141184; Read time: 427; Write time: 2160 15:34:25 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 379722240; Write bytes: 375080448; Read time: 28298; Write time: 732 15:34:25 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 38540800; Write bytes: 301426176; Read time: 414; Write time: 1343 15:34:25 INFO - Running post-run listener: _upload_blobber_files 15:34:25 INFO - Blob upload gear active. 15:34:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:34:25 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 15:34:25 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'] 15:34:25 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 15:34:25 INFO - (blobuploader) - INFO - Open directory for files ... 15:34:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:34:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:34:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:26 INFO - (blobuploader) - INFO - Done attempting. 15:34:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:34:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:34:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:27 INFO - (blobuploader) - INFO - Done attempting. 15:34:27 INFO - (blobuploader) - INFO - Iteration through files over. 15:34:27 INFO - Return code: 0 15:34:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:34:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:34:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89aef3809c1522e5534d5c67fea76825f825e39a35dc1d3f7b26603578484d481412e57f887f423f6b254001c3bfad4309e5fc395b5d1346491cf752eb8ad0c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b441a54e91f02a501a8fb0b2ecdef4093596938abcfea2f2e945345dca93ab7d2e169b7882cda5df3a654a7c64a611973a33c07f60d6fb4ea0cd7d00b3997d51"} 15:34:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:34:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:34:27 INFO - Contents: 15:34:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89aef3809c1522e5534d5c67fea76825f825e39a35dc1d3f7b26603578484d481412e57f887f423f6b254001c3bfad4309e5fc395b5d1346491cf752eb8ad0c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b441a54e91f02a501a8fb0b2ecdef4093596938abcfea2f2e945345dca93ab7d2e169b7882cda5df3a654a7c64a611973a33c07f60d6fb4ea0cd7d00b3997d51"} 15:34:27 INFO - Running post-run listener: copy_logs_to_upload_dir 15:34:27 INFO - Copying logs to upload dir... 15:34:27 INFO - mkdir: /builds/slave/test/build/upload/logs 15:34:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1319.260655 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2016-03-03 15:34:27.925723) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 15:34:27.929327) ========= 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.tK6SNQ9uxx/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.C0Mg6KbACn/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89aef3809c1522e5534d5c67fea76825f825e39a35dc1d3f7b26603578484d481412e57f887f423f6b254001c3bfad4309e5fc395b5d1346491cf752eb8ad0c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b441a54e91f02a501a8fb0b2ecdef4093596938abcfea2f2e945345dca93ab7d2e169b7882cda5df3a654a7c64a611973a33c07f60d6fb4ea0cd7d00b3997d51"} build_url:https://queue.taskcluster.net/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/KoDWvwZNRe6_23inRDJI2g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/89aef3809c1522e5534d5c67fea76825f825e39a35dc1d3f7b26603578484d481412e57f887f423f6b254001c3bfad4309e5fc395b5d1346491cf752eb8ad0c7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b441a54e91f02a501a8fb0b2ecdef4093596938abcfea2f2e945345dca93ab7d2e169b7882cda5df3a654a7c64a611973a33c07f60d6fb4ea0cd7d00b3997d51"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 15:34:27.957971) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 15:34:27.958340) ========= 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.tK6SNQ9uxx/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.C0Mg6KbACn/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.005100 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 15:34:28.009236) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 15:34:28.009591) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 15:34:28.010060) ========= ========= Total master_lag: 0.27 =========