builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-042 starttime: 1474899178.91 results: success (0) buildid: 20160926043000 builduid: 677820cb55704fba957a06ad0bead4e6 revision: c55bcb7c777ea09431b4d16903ed079ae5632648 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 07:12:58.914540) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-26 07:12:58.915029) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 07:12:58.915354) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-26 07:12:58.988527) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 07:12:58.988842) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-26 07:12:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (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% 46.7M=0s 2016-09-26 07:12:59 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149133 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 07:12:59.167252) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 07:12:59.167571) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014000 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 07:12:59.220695) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 07:12:59.221056) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c55bcb7c777ea09431b4d16903ed079ae5632648 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c55bcb7c777ea09431b4d16903ed079ae5632648 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-26 07:12:59,294 truncating revision to first 12 chars 2016-09-26 07:12:59,294 Setting DEBUG logging. 2016-09-26 07:12:59,294 attempt 1/10 2016-09-26 07:12:59,294 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c55bcb7c777e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-26 07:12:59,723 unpacking tar archive at: mozilla-central-c55bcb7c777e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.764296 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 07:13:00.001302) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 07:13:00.001606) ========= script_repo_revision: c55bcb7c777ea09431b4d16903ed079ae5632648 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-26 07:13:00.002043) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 07:13:00.002392) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-26 07:13:00.016897) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-26 07:13:00.017225) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:13:00 INFO - MultiFileLogger online at 20160926 07:13:00 in /builds/slave/test 07:13:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:13:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:13:00 INFO - {'append_to_log': False, 07:13:00 INFO - 'base_work_dir': '/builds/slave/test', 07:13:00 INFO - 'blob_upload_branch': 'Firefox', 07:13:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:13:00 INFO - 'branch': 'Firefox', 07:13:00 INFO - 'buildbot_json_path': 'buildprops.json', 07:13:00 INFO - 'config_files': ('talos/linux_config.py',), 07:13:00 INFO - 'default_actions': ('clobber', 07:13:00 INFO - 'read-buildbot-config', 07:13:00 INFO - 'download-and-extract', 07:13:00 INFO - 'populate-webroot', 07:13:00 INFO - 'create-virtualenv', 07:13:00 INFO - 'install', 07:13:00 INFO - 'run-tests'), 07:13:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:13:00 INFO - 'download_minidump_stackwalk': True, 07:13:00 INFO - 'download_symbols': 'ondemand', 07:13:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:13:00 INFO - 'tooltool.py': '/tools/tooltool.py', 07:13:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:13:00 INFO - '/tools/misc-python/virtualenv.py')}, 07:13:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:13:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:13:00 INFO - 'installer_path': 'installer.exe', 07:13:00 INFO - 'log_level': 'info', 07:13:00 INFO - 'log_name': 'talos', 07:13:00 INFO - 'log_to_console': True, 07:13:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:13:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:13:00 INFO - 'opt_config_files': (), 07:13:00 INFO - 'pip_index': False, 07:13:00 INFO - 'sps_profile': False, 07:13:00 INFO - 'sps_profile_interval': 0, 07:13:00 INFO - 'suite': 'dromaeojs-e10s', 07:13:00 INFO - 'system_bits': '32', 07:13:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:13:00 INFO - 'title': 'talos-linux64-ix-042', 07:13:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:13:00 INFO - 'use_talos_json': True, 07:13:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:13:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:13:00 INFO - 'work_dir': 'build'} 07:13:00 INFO - [mozharness: 2016-09-26 14:13:00.283086Z] Running clobber step. 07:13:00 INFO - Running pre-action listener: _resource_record_pre_action 07:13:00 INFO - Running main action method: clobber 07:13:00 INFO - rmtree: /builds/slave/test/build 07:13:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:13:00 INFO - Running post-action listener: _resource_record_post_action 07:13:00 INFO - [mozharness: 2016-09-26 14:13:00.698898Z] Finished clobber step (success) 07:13:00 INFO - [mozharness: 2016-09-26 14:13:00.698998Z] Running read-buildbot-config step. 07:13:00 INFO - Running pre-action listener: _resource_record_pre_action 07:13:00 INFO - Running main action method: read_buildbot_config 07:13:00 INFO - Using buildbot properties: 07:13:00 INFO - { 07:13:00 INFO - "project": "", 07:13:00 INFO - "product": "firefox", 07:13:00 INFO - "script_repo_revision": "production", 07:13:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:13:00 INFO - "repository": "", 07:13:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:13:00 INFO - "buildid": "20160926043000", 07:13:00 INFO - "pgo_build": "True", 07:13:00 INFO - "basedir": "/builds/slave/test", 07:13:00 INFO - "buildnumber": 369, 07:13:00 INFO - "slavename": "talos-linux64-ix-042", 07:13:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:13:00 INFO - "platform": "ubuntu64_hw", 07:13:00 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:13:00 INFO - "branch": "mozilla-central", 07:13:00 INFO - "repo_path": "mozilla-central", 07:13:00 INFO - "revision": "c55bcb7c777ea09431b4d16903ed079ae5632648", 07:13:00 INFO - "stage_platform": "linux64-pgo", 07:13:00 INFO - "builduid": "677820cb55704fba957a06ad0bead4e6", 07:13:00 INFO - "slavebuilddir": "test" 07:13:00 INFO - } 07:13:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 07:13:00 INFO - Running post-action listener: _resource_record_post_action 07:13:00 INFO - [mozharness: 2016-09-26 14:13:00.701399Z] Finished read-buildbot-config step (success) 07:13:00 INFO - [mozharness: 2016-09-26 14:13:00.701487Z] Running download-and-extract step. 07:13:00 INFO - Running pre-action listener: _resource_record_pre_action 07:13:00 INFO - Running main action method: download_and_extract 07:13:00 INFO - mkdir: /builds/slave/test/build/tests 07:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:00 INFO - trying https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:13:00 INFO - Downloading https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:13:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:13:01 INFO - Downloaded 1361 bytes. 07:13:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:13:01 INFO - Using the following test package requirements: 07:13:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:13:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:13:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:13:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:01 INFO - u'jsshell-linux-x86_64.zip'], 07:13:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:13:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:13:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:13:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:13:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:13:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:13:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:13:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:13:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:13:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:13:01 INFO - Fetch https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:13:01 INFO - Expected file size: 21981382 07:13:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:13:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:13:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:13:06 INFO - Fetch https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:13:06 INFO - Expected file size: 21981382 07:13:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 07:13:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:13:11 INFO - Fetch https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:13:11 INFO - Expected file size: 14414057 07:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:12 INFO - trying https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:13:12 INFO - Downloading https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:13:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:13:14 INFO - Downloaded 59707936 bytes. 07:13:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:13:14 INFO - mkdir: /builds/slave/test/properties 07:13:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:13:14 INFO - Writing to file /builds/slave/test/properties/build_url 07:13:14 INFO - Contents: 07:13:14 INFO - build_url:https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:13:15 INFO - Running post-action listener: _resource_record_post_action 07:13:15 INFO - Running post-action listener: set_extra_try_arguments 07:13:15 INFO - [mozharness: 2016-09-26 14:13:15.124196Z] Finished download-and-extract step (success) 07:13:15 INFO - [mozharness: 2016-09-26 14:13:15.124424Z] Running populate-webroot step. 07:13:15 INFO - Running pre-action listener: _resource_record_pre_action 07:13:15 INFO - Running main action method: populate_webroot 07:13:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:13:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:13:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:13:15 INFO - '--tppagecycles', 07:13:15 INFO - '7'], 07:13:15 INFO - 'tests': ['tsvgm']}}, 07:13:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:13:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:13:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:13:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:13:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:13:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:13:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:15 INFO - 'talos_options': ['--disable-e10s'], 07:13:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:13:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:13:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:15 INFO - 'talos_options': ['--disable-e10s'], 07:13:15 INFO - 'tests': ['damp', 'tps']}, 07:13:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:15 INFO - 'tests': ['damp', 'tps']}, 07:13:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:13:15 INFO - 'tests': ['dromaeo_dom']}, 07:13:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:13:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:13:15 INFO - 'tests': ['basic_compositor_video']}, 07:13:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:13:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:13:15 INFO - 'tests': ['a11yr', 07:13:15 INFO - 'ts_paint', 07:13:15 INFO - 'tpaint', 07:13:15 INFO - 'sessionrestore', 07:13:15 INFO - 'sessionrestore_no_auto_restore', 07:13:15 INFO - 'tabpaint']}, 07:13:15 INFO - 'other-e10s': {'tests': ['a11yr', 07:13:15 INFO - 'ts_paint', 07:13:15 INFO - 'tpaint', 07:13:15 INFO - 'sessionrestore', 07:13:15 INFO - 'sessionrestore_no_auto_restore', 07:13:15 INFO - 'tabpaint']}, 07:13:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:13:15 INFO - 'ts_paint', 07:13:15 INFO - 'tpaint', 07:13:15 INFO - 'sessionrestore', 07:13:15 INFO - 'sessionrestore_no_auto_restore', 07:13:15 INFO - 'tabpaint']}, 07:13:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:13:15 INFO - 'ts_paint', 07:13:15 INFO - 'tpaint', 07:13:15 INFO - 'sessionrestore', 07:13:15 INFO - 'sessionrestore_no_auto_restore', 07:13:15 INFO - 'tabpaint']}, 07:13:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:13:15 INFO - 'tests': ['a11yr', 07:13:15 INFO - 'ts_paint', 07:13:15 INFO - 'tpaint', 07:13:15 INFO - 'sessionrestore', 07:13:15 INFO - 'sessionrestore_no_auto_restore', 07:13:15 INFO - 'tabpaint']}, 07:13:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:13:15 INFO - 'tests': ['a11yr', 07:13:15 INFO - 'ts_paint', 07:13:15 INFO - 'tpaint', 07:13:15 INFO - 'sessionrestore', 07:13:15 INFO - 'sessionrestore_no_auto_restore', 07:13:15 INFO - 'tabpaint']}, 07:13:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:13:15 INFO - 'tests': ['tsvgx', 07:13:15 INFO - 'tsvgr_opacity', 07:13:15 INFO - 'tart', 07:13:15 INFO - 'tscrollx', 07:13:15 INFO - 'cart']}, 07:13:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:13:15 INFO - 'tsvgr_opacity', 07:13:15 INFO - 'tart', 07:13:15 INFO - 'tscrollx', 07:13:15 INFO - 'cart']}, 07:13:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:15 INFO - 'talos_options': ['--disable-e10s'], 07:13:15 INFO - 'tests': ['tp5o']}, 07:13:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:15 INFO - 'tests': ['tp5o']}, 07:13:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:15 INFO - 'talos_options': ['--disable-e10s', 07:13:15 INFO - '--xperf_path', 07:13:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:13:15 INFO - 'tests': ['tp5n']}, 07:13:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:13:15 INFO - 'talos_options': ['--xperf_path', 07:13:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:13:15 INFO - 'tests': ['tp5n']}}, 07:13:15 INFO - 'talos.zip': {'path': '', 07:13:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:13:15 INFO - Running post-action listener: _resource_record_post_action 07:13:15 INFO - [mozharness: 2016-09-26 14:13:15.144180Z] Finished populate-webroot step (success) 07:13:15 INFO - [mozharness: 2016-09-26 14:13:15.144268Z] Running create-virtualenv step. 07:13:15 INFO - Running pre-action listener: _resource_record_pre_action 07:13:15 INFO - Running main action method: create_virtualenv 07:13:15 INFO - Creating virtualenv /builds/slave/test/build/venv 07:13:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:13:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:13:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:13:15 INFO - Using real prefix '/usr' 07:13:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:13:15 INFO - Installing distribute.............................................................................................................................................................................................done. 07:13:17 INFO - Installing pip.................done. 07:13:17 INFO - Return code: 0 07:13:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:13:18 INFO - Reading from file tmpfile_stdout 07:13:18 INFO - Output received: 07:13:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:13:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f924f447f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c790>, '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 0x282d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:13:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:13:18 INFO - Using env: {'DISPLAY': ':0', 07:13:18 INFO - 'HOME': '/home/cltbld', 07:13:18 INFO - 'LANG': 'en_US.UTF-8', 07:13:18 INFO - 'LANGUAGE': 'en_US:en', 07:13:18 INFO - 'LOGNAME': 'cltbld', 07:13:18 INFO - 'MAIL': '/var/mail/cltbld', 07:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:18 INFO - 'MOZ_NO_REMOTE': '1', 07:13:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:18 INFO - 'NO_EM_RESTART': '1', 07:13:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:18 INFO - 'PWD': '/builds/slave/test', 07:13:18 INFO - 'SHELL': '/bin/bash', 07:13:18 INFO - 'SHLVL': '1', 07:13:18 INFO - 'TERM': 'linux', 07:13:18 INFO - 'TMOUT': '86400', 07:13:18 INFO - 'USER': 'cltbld', 07:13:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 07:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:18 INFO - '_': '/tools/buildbot/bin/python'} 07:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:13:18 INFO - Cleaning up... 07:13:18 INFO - Return code: 0 07:13:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f924f447f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c790>, '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 0x282d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:13:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:13:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:13:18 INFO - Using env: {'DISPLAY': ':0', 07:13:18 INFO - 'HOME': '/home/cltbld', 07:13:18 INFO - 'LANG': 'en_US.UTF-8', 07:13:18 INFO - 'LANGUAGE': 'en_US:en', 07:13:18 INFO - 'LOGNAME': 'cltbld', 07:13:18 INFO - 'MAIL': '/var/mail/cltbld', 07:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:18 INFO - 'MOZ_NO_REMOTE': '1', 07:13:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:18 INFO - 'NO_EM_RESTART': '1', 07:13:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:18 INFO - 'PWD': '/builds/slave/test', 07:13:18 INFO - 'SHELL': '/bin/bash', 07:13:18 INFO - 'SHLVL': '1', 07:13:18 INFO - 'TERM': 'linux', 07:13:18 INFO - 'TMOUT': '86400', 07:13:18 INFO - 'USER': 'cltbld', 07:13:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 07:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:18 INFO - '_': '/tools/buildbot/bin/python'} 07:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:18 INFO - Downloading/unpacking psutil>=3.1.1 07:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:13:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:13:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:13:20 INFO - Installing collected packages: psutil 07:13:20 INFO - Running setup.py install for psutil 07:13:20 INFO - building 'psutil._psutil_linux' extension 07:13:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:13:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:13:21 INFO - building 'psutil._psutil_posix' extension 07:13:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:13:21 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:13:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:13:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:13:22 INFO - Successfully installed psutil 07:13:22 INFO - Cleaning up... 07:13:22 INFO - Return code: 0 07:13:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f924f447f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c790>, '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 0x282d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:13:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:13:22 INFO - Using env: {'DISPLAY': ':0', 07:13:22 INFO - 'HOME': '/home/cltbld', 07:13:22 INFO - 'LANG': 'en_US.UTF-8', 07:13:22 INFO - 'LANGUAGE': 'en_US:en', 07:13:22 INFO - 'LOGNAME': 'cltbld', 07:13:22 INFO - 'MAIL': '/var/mail/cltbld', 07:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:22 INFO - 'MOZ_NO_REMOTE': '1', 07:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:22 INFO - 'NO_EM_RESTART': '1', 07:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:22 INFO - 'PWD': '/builds/slave/test', 07:13:22 INFO - 'SHELL': '/bin/bash', 07:13:22 INFO - 'SHLVL': '1', 07:13:22 INFO - 'TERM': 'linux', 07:13:22 INFO - 'TMOUT': '86400', 07:13:22 INFO - 'USER': 'cltbld', 07:13:22 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 07:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:22 INFO - '_': '/tools/buildbot/bin/python'} 07:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:13:24 INFO - Installing collected packages: mozsystemmonitor 07:13:24 INFO - Running setup.py install for mozsystemmonitor 07:13:24 INFO - Successfully installed mozsystemmonitor 07:13:24 INFO - Cleaning up... 07:13:24 INFO - Return code: 0 07:13:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f924f447f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c790>, '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 0x282d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:13:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:13:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:13:24 INFO - Using env: {'DISPLAY': ':0', 07:13:24 INFO - 'HOME': '/home/cltbld', 07:13:24 INFO - 'LANG': 'en_US.UTF-8', 07:13:24 INFO - 'LANGUAGE': 'en_US:en', 07:13:24 INFO - 'LOGNAME': 'cltbld', 07:13:24 INFO - 'MAIL': '/var/mail/cltbld', 07:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:24 INFO - 'MOZ_NO_REMOTE': '1', 07:13:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:24 INFO - 'NO_EM_RESTART': '1', 07:13:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:24 INFO - 'PWD': '/builds/slave/test', 07:13:24 INFO - 'SHELL': '/bin/bash', 07:13:24 INFO - 'SHLVL': '1', 07:13:24 INFO - 'TERM': 'linux', 07:13:24 INFO - 'TMOUT': '86400', 07:13:24 INFO - 'USER': 'cltbld', 07:13:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 07:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:24 INFO - '_': '/tools/buildbot/bin/python'} 07:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:25 INFO - Downloading/unpacking jsonschema==2.5.1 07:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:13:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:26 INFO - Downloading functools32-3.2.3-2.tar.gz 07:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:13:26 INFO - warning: no files found matching '*.txt' 07:13:26 INFO - no previously-included directories found matching 'build' 07:13:26 INFO - no previously-included directories found matching 'dist' 07:13:26 INFO - no previously-included directories found matching '.git*' 07:13:26 INFO - Installing collected packages: jsonschema, functools32 07:13:26 INFO - Running setup.py install for functools32 07:13:26 INFO - warning: no files found matching '*.txt' 07:13:26 INFO - no previously-included directories found matching 'build' 07:13:26 INFO - no previously-included directories found matching 'dist' 07:13:26 INFO - no previously-included directories found matching '.git*' 07:13:26 INFO - Successfully installed jsonschema functools32 07:13:26 INFO - Cleaning up... 07:13:27 INFO - Return code: 0 07:13:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f924f447f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c790>, '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 0x282d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:13:27 INFO - Using env: {'DISPLAY': ':0', 07:13:27 INFO - 'HOME': '/home/cltbld', 07:13:27 INFO - 'LANG': 'en_US.UTF-8', 07:13:27 INFO - 'LANGUAGE': 'en_US:en', 07:13:27 INFO - 'LOGNAME': 'cltbld', 07:13:27 INFO - 'MAIL': '/var/mail/cltbld', 07:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:27 INFO - 'MOZ_NO_REMOTE': '1', 07:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:27 INFO - 'NO_EM_RESTART': '1', 07:13:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:27 INFO - 'PWD': '/builds/slave/test', 07:13:27 INFO - 'SHELL': '/bin/bash', 07:13:27 INFO - 'SHLVL': '1', 07:13:27 INFO - 'TERM': 'linux', 07:13:27 INFO - 'TMOUT': '86400', 07:13:27 INFO - 'USER': 'cltbld', 07:13:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 07:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:27 INFO - '_': '/tools/buildbot/bin/python'} 07:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:13:27 INFO - Cleaning up... 07:13:27 INFO - Return code: 0 07:13:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f924f447f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c790>, '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 0x282d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:13:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:13:27 INFO - Using env: {'DISPLAY': ':0', 07:13:27 INFO - 'HOME': '/home/cltbld', 07:13:27 INFO - 'LANG': 'en_US.UTF-8', 07:13:27 INFO - 'LANGUAGE': 'en_US:en', 07:13:27 INFO - 'LOGNAME': 'cltbld', 07:13:27 INFO - 'MAIL': '/var/mail/cltbld', 07:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:27 INFO - 'MOZ_NO_REMOTE': '1', 07:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:27 INFO - 'NO_EM_RESTART': '1', 07:13:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:27 INFO - 'PWD': '/builds/slave/test', 07:13:27 INFO - 'SHELL': '/bin/bash', 07:13:27 INFO - 'SHLVL': '1', 07:13:27 INFO - 'TERM': 'linux', 07:13:27 INFO - 'TMOUT': '86400', 07:13:27 INFO - 'USER': 'cltbld', 07:13:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 07:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:27 INFO - '_': '/tools/buildbot/bin/python'} 07:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:27 INFO - Downloading/unpacking blobuploader==1.2.4 07:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:29 INFO - Downloading blobuploader-1.2.4.tar.gz 07:13:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:13:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:13:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:30 INFO - Downloading docopt-0.6.1.tar.gz 07:13:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:13:30 INFO - Installing collected packages: blobuploader, requests, docopt 07:13:30 INFO - Running setup.py install for blobuploader 07:13:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:13:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:13:30 INFO - Running setup.py install for requests 07:13:30 INFO - Running setup.py install for docopt 07:13:30 INFO - Successfully installed blobuploader requests docopt 07:13:30 INFO - Cleaning up... 07:13:30 INFO - Return code: 0 07:13:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:30 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 0x7f924f447f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c790>, '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 0x282d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:13:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:13:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:13:30 INFO - Using env: {'DISPLAY': ':0', 07:13:30 INFO - 'HOME': '/home/cltbld', 07:13:30 INFO - 'LANG': 'en_US.UTF-8', 07:13:30 INFO - 'LANGUAGE': 'en_US:en', 07:13:30 INFO - 'LOGNAME': 'cltbld', 07:13:30 INFO - 'MAIL': '/var/mail/cltbld', 07:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:30 INFO - 'MOZ_NO_REMOTE': '1', 07:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:30 INFO - 'NO_EM_RESTART': '1', 07:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:30 INFO - 'PWD': '/builds/slave/test', 07:13:30 INFO - 'SHELL': '/bin/bash', 07:13:30 INFO - 'SHLVL': '1', 07:13:30 INFO - 'TERM': 'linux', 07:13:30 INFO - 'TMOUT': '86400', 07:13:30 INFO - 'USER': 'cltbld', 07:13:30 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 07:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:30 INFO - '_': '/tools/buildbot/bin/python'} 07:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:13:30 INFO - Running setup.py (path:/tmp/pip-N14C3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:13:31 INFO - Running setup.py (path:/tmp/pip-J9O7tB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:13:31 INFO - Running setup.py (path:/tmp/pip-IHicwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:13:31 INFO - Running setup.py (path:/tmp/pip-eOPa0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:13:31 INFO - Running setup.py (path:/tmp/pip-sXFTrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:13:31 INFO - Running setup.py (path:/tmp/pip-H88Q_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:13:31 INFO - Running setup.py (path:/tmp/pip-PavD5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:13:31 INFO - Running setup.py (path:/tmp/pip-2Tk_Zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:13:31 INFO - Running setup.py (path:/tmp/pip-Xv0eiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:13:31 INFO - Running setup.py (path:/tmp/pip-ArJsct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:13:31 INFO - Running setup.py (path:/tmp/pip-DAV3fj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:13:31 INFO - Running setup.py (path:/tmp/pip-30KurH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:13:31 INFO - Running setup.py (path:/tmp/pip-9pq8qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:13:31 INFO - Running setup.py (path:/tmp/pip-4pd689-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:31 INFO - Running setup.py (path:/tmp/pip-b9L7xY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:13:32 INFO - Running setup.py (path:/tmp/pip-Xpdz0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:13:32 INFO - Running setup.py (path:/tmp/pip-WtkEnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:13:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:13:32 INFO - Running setup.py install for manifestparser 07:13:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:13:32 INFO - Running setup.py install for mozcrash 07:13:32 INFO - Running setup.py install for mozdebug 07:13:32 INFO - Running setup.py install for mozdevice 07:13:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:13:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:13:32 INFO - Running setup.py install for mozfile 07:13:32 INFO - Running setup.py install for mozhttpd 07:13:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:13:32 INFO - Running setup.py install for mozinfo 07:13:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:13:32 INFO - Running setup.py install for mozInstall 07:13:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:13:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:13:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:13:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:13:32 INFO - Running setup.py install for mozleak 07:13:33 INFO - Running setup.py install for mozlog 07:13:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:13:33 INFO - Running setup.py install for moznetwork 07:13:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:13:33 INFO - Running setup.py install for mozprocess 07:13:33 INFO - Running setup.py install for mozprofile 07:13:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:13:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:13:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:13:33 INFO - Running setup.py install for mozrunner 07:13:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:13:33 INFO - Running setup.py install for mozscreenshot 07:13:33 INFO - Running setup.py install for moztest 07:13:33 INFO - Running setup.py install for mozversion 07:13:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:13:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:13:33 INFO - Cleaning up... 07:13:33 INFO - Return code: 0 07:13:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:33 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 0x7f924f447f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c790>, '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 0x282d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:13:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:13:33 INFO - Using env: {'DISPLAY': ':0', 07:13:33 INFO - 'HOME': '/home/cltbld', 07:13:33 INFO - 'LANG': 'en_US.UTF-8', 07:13:33 INFO - 'LANGUAGE': 'en_US:en', 07:13:33 INFO - 'LOGNAME': 'cltbld', 07:13:33 INFO - 'MAIL': '/var/mail/cltbld', 07:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:33 INFO - 'MOZ_NO_REMOTE': '1', 07:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:33 INFO - 'NO_EM_RESTART': '1', 07:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:33 INFO - 'PWD': '/builds/slave/test', 07:13:33 INFO - 'SHELL': '/bin/bash', 07:13:33 INFO - 'SHLVL': '1', 07:13:33 INFO - 'TERM': 'linux', 07:13:33 INFO - 'TMOUT': '86400', 07:13:33 INFO - 'USER': 'cltbld', 07:13:33 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 07:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:33 INFO - '_': '/tools/buildbot/bin/python'} 07:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:13:34 INFO - Running setup.py (path:/tmp/pip-ydQNmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:13:34 INFO - Running setup.py (path:/tmp/pip-HANclt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:13:34 INFO - Running setup.py (path:/tmp/pip-cyQmxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:13:34 INFO - Running setup.py (path:/tmp/pip-mGeEYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:13:34 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)) 07:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:13:34 INFO - Running setup.py (path:/tmp/pip-mN9V8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:13:34 INFO - Running setup.py (path:/tmp/pip-uVySsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:13:34 INFO - Running setup.py (path:/tmp/pip-VjkY1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:13:34 INFO - Running setup.py (path:/tmp/pip-9fFFgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:13:34 INFO - Running setup.py (path:/tmp/pip-aSo51I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:13:34 INFO - Running setup.py (path:/tmp/pip-7oIApT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:13:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:13:34 INFO - Running setup.py (path:/tmp/pip-UMr5yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:13:35 INFO - Running setup.py (path:/tmp/pip-pSLKqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:13:35 INFO - Running setup.py (path:/tmp/pip-8M0LnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:13:35 INFO - Running setup.py (path:/tmp/pip-QVdwKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:35 INFO - Running setup.py (path:/tmp/pip-yIEju8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:13:35 INFO - Running setup.py (path:/tmp/pip-0Evv2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:13:35 INFO - Running setup.py (path:/tmp/pip-pCYulF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:13:35 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)) 07:13:35 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)) 07:13:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:13:37 INFO - Downloading blessings-1.6.tar.gz 07:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:13:37 INFO - Installing collected packages: blessings 07:13:37 INFO - Running setup.py install for blessings 07:13:37 INFO - Successfully installed blessings 07:13:37 INFO - Cleaning up... 07:13:37 INFO - Return code: 0 07:13:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:13:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:13:37 INFO - Reading from file tmpfile_stdout 07:13:37 INFO - Current package versions: 07:13:37 INFO - argparse == 1.2.1 07:13:37 INFO - blessings == 1.6 07:13:37 INFO - blobuploader == 1.2.4 07:13:37 INFO - docopt == 0.6.1 07:13:37 INFO - functools32 == 3.2.3-2 07:13:37 INFO - jsonschema == 2.5.1 07:13:37 INFO - manifestparser == 1.1 07:13:37 INFO - mozInstall == 1.12 07:13:37 INFO - mozcrash == 0.17 07:13:37 INFO - mozdebug == 0.1 07:13:37 INFO - mozdevice == 0.48 07:13:37 INFO - mozfile == 1.2 07:13:37 INFO - mozhttpd == 0.7 07:13:37 INFO - mozinfo == 0.9 07:13:37 INFO - mozleak == 0.1 07:13:37 INFO - mozlog == 3.4 07:13:37 INFO - moznetwork == 0.27 07:13:37 INFO - mozprocess == 0.23 07:13:37 INFO - mozprofile == 0.28 07:13:37 INFO - mozrunner == 6.12 07:13:37 INFO - mozscreenshot == 0.1 07:13:37 INFO - mozsystemmonitor == 0.3 07:13:37 INFO - moztest == 0.7 07:13:37 INFO - mozversion == 1.4 07:13:37 INFO - psutil == 3.1.1 07:13:37 INFO - requests == 1.2.3 07:13:37 INFO - wsgiref == 0.1.2 07:13:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f924f447f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c790>, '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 0x282d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:13:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:13:37 INFO - Using env: {'DISPLAY': ':0', 07:13:37 INFO - 'HOME': '/home/cltbld', 07:13:37 INFO - 'LANG': 'en_US.UTF-8', 07:13:37 INFO - 'LANGUAGE': 'en_US:en', 07:13:37 INFO - 'LOGNAME': 'cltbld', 07:13:37 INFO - 'MAIL': '/var/mail/cltbld', 07:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:37 INFO - 'MOZ_NO_REMOTE': '1', 07:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:37 INFO - 'NO_EM_RESTART': '1', 07:13:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:37 INFO - 'PWD': '/builds/slave/test', 07:13:37 INFO - 'SHELL': '/bin/bash', 07:13:37 INFO - 'SHLVL': '1', 07:13:37 INFO - 'TERM': 'linux', 07:13:37 INFO - 'TMOUT': '86400', 07:13:37 INFO - 'USER': 'cltbld', 07:13:37 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 07:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:37 INFO - '_': '/tools/buildbot/bin/python'} 07:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:13:38 INFO - Cleaning up... 07:13:38 INFO - Return code: 0 07:13:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:13:38 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 0x7f924f447f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x279d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c790>, '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 0x282d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282db20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:13:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:13:38 INFO - Using env: {'DISPLAY': ':0', 07:13:38 INFO - 'HOME': '/home/cltbld', 07:13:38 INFO - 'LANG': 'en_US.UTF-8', 07:13:38 INFO - 'LANGUAGE': 'en_US:en', 07:13:38 INFO - 'LOGNAME': 'cltbld', 07:13:38 INFO - 'MAIL': '/var/mail/cltbld', 07:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:38 INFO - 'MOZ_NO_REMOTE': '1', 07:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:38 INFO - 'NO_EM_RESTART': '1', 07:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:38 INFO - 'PWD': '/builds/slave/test', 07:13:38 INFO - 'SHELL': '/bin/bash', 07:13:38 INFO - 'SHLVL': '1', 07:13:38 INFO - 'TERM': 'linux', 07:13:38 INFO - 'TMOUT': '86400', 07:13:38 INFO - 'USER': 'cltbld', 07:13:38 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 07:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:38 INFO - '_': '/tools/buildbot/bin/python'} 07:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:13:38 INFO - Cleaning up... 07:13:38 INFO - Return code: 0 07:13:38 INFO - Running post-action listener: _resource_record_post_action 07:13:38 INFO - Running post-action listener: _start_resource_monitoring 07:13:38 INFO - Starting resource monitoring. 07:13:38 INFO - [mozharness: 2016-09-26 14:13:38.321097Z] Finished create-virtualenv step (success) 07:13:38 INFO - [mozharness: 2016-09-26 14:13:38.322069Z] Running install step. 07:13:38 INFO - Running pre-action listener: _resource_record_pre_action 07:13:38 INFO - Running main action method: install 07:13:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:13:38 INFO - Reading from file tmpfile_stdout 07:13:38 INFO - Detecting whether we're running mozinstall >=1.0... 07:13:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:13:38 INFO - Reading from file tmpfile_stdout 07:13:38 INFO - Output received: 07:13:38 INFO - Usage: mozinstall [options] installer 07:13:38 INFO - Options: 07:13:38 INFO - -h, --help show this help message and exit 07:13:38 INFO - -d DEST, --destination=DEST 07:13:38 INFO - Directory to install application into. [default: 07:13:38 INFO - "/builds/slave/test"] 07:13:38 INFO - --app=APP Application being installed. [default: firefox] 07:13:38 INFO - mkdir: /builds/slave/test/build/application 07:13:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:13:55 INFO - Reading from file tmpfile_stdout 07:13:55 INFO - Output received: 07:13:55 INFO - /builds/slave/test/build/application/firefox/firefox 07:13:55 INFO - Running post-action listener: _resource_record_post_action 07:13:55 INFO - [mozharness: 2016-09-26 14:13:55.601368Z] Finished install step (success) 07:13:55 INFO - [mozharness: 2016-09-26 14:13:55.601615Z] Running run-tests step. 07:13:55 INFO - Running pre-action listener: _resource_record_pre_action 07:13:55 INFO - Running main action method: run_tests 07:13:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:13:55 INFO - Python 2.7.3 07:13:55 INFO - Return code: 0 07:13:55 INFO - grabbing minidump binary from tooltool 07:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:13:55 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x282c790>, '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 0x282d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x282db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:13:55 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:13:55 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/linux64/releng.manifest -o -c /builds/tooltool_cache 07:13:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:13:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:13:55 INFO - Return code: 0 07:13:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:13:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:13:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:13:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:13:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:13:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:13:55 INFO - Using env: {'DISPLAY': ':0', 07:13:55 INFO - 'HOME': '/home/cltbld', 07:13:55 INFO - 'LANG': 'en_US.UTF-8', 07:13:55 INFO - 'LANGUAGE': 'en_US:en', 07:13:55 INFO - 'LOGNAME': 'cltbld', 07:13:55 INFO - 'MAIL': '/var/mail/cltbld', 07:13:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:13:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:13:55 INFO - 'MOZ_NO_REMOTE': '1', 07:13:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:13:55 INFO - 'NO_EM_RESTART': '1', 07:13:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:13:55 INFO - 'PWD': '/builds/slave/test', 07:13:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:13:55 INFO - 'SHELL': '/bin/bash', 07:13:55 INFO - 'SHLVL': '1', 07:13:55 INFO - 'TERM': 'linux', 07:13:55 INFO - 'TMOUT': '86400', 07:13:55 INFO - 'USER': 'cltbld', 07:13:55 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617', 07:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:13:55 INFO - '_': '/tools/buildbot/bin/python'} 07:13:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:13:56 INFO - mozversion application_buildid: 20160926043000 07:13:56 INFO - mozversion application_changeset: c55bcb7c777ea09431b4d16903ed079ae5632648 07:13:56 INFO - mozversion application_display_name: Nightly 07:13:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:13:56 INFO - mozversion application_name: Firefox 07:13:56 INFO - mozversion application_remotingname: firefox 07:13:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:13:56 INFO - mozversion application_vendor: Mozilla 07:13:56 INFO - mozversion application_version: 52.0a1 07:13:56 INFO - mozversion platform_buildid: 20160926043000 07:13:56 INFO - mozversion platform_changeset: c55bcb7c777ea09431b4d16903ed079ae5632648 07:13:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:13:56 INFO - mozversion platform_version: 52.0a1 07:13:56 INFO - using testdate: 1474899236 07:13:56 INFO - actual date: 1474899236 07:13:56 INFO - starting webserver on 'localhost:51690' 07:13:56 INFO - SUITE-START | Running 2 tests 07:13:56 INFO - TEST-START | dromaeo_css 07:13:56 INFO - operating with platform_type : linux_ 07:13:56 INFO - Initialising browser for dromaeo_css test... 07:13:56 INFO - TEST-INFO | started process 3345 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR9dohQ/profile http://localhost:51690/getInfo.html) 07:14:02 INFO - PROCESS | 3345 | __metrics Screen width/height:1600/1200 07:14:02 INFO - PROCESS | 3345 | colorDepth:24 07:14:02 INFO - PROCESS | 3345 | Browser inner width/height: 1024/697 07:14:02 INFO - PROCESS | 3345 | __metrics 07:14:02 ERROR - PROCESS | 3345 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 07:14:03 INFO - TEST-INFO | 3345: exit 0 07:14:03 INFO - Browser initialized. 07:14:03 INFO - Running cycle 1/1 for dromaeo_css test... 07:14:03 INFO - TEST-INFO | started process 3469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR9dohQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:14:15 INFO - PROCESS | 3469 | RSS: Main: 185552896 07:14:15 INFO - PROCESS | 3469 | 07:15:05 INFO - PROCESS | 3469 | 1474899305656 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:17:15 INFO - PROCESS | 3469 | Cycle 1(1): loaded http://localhost:51690/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51690/tests/dromaeo/cssquery-ext.html) 07:17:16 INFO - PROCESS | 3469 | RSS: Main: 200208384 07:17:16 INFO - PROCESS | 3469 | 07:20:18 INFO - PROCESS | 3469 | Cycle 1(1): loaded http://localhost:51690/tests/dromaeo/cssquery-ext.html (next: http://localhost:51690/tests/dromaeo/cssquery-jquery.html) 07:20:19 INFO - PROCESS | 3469 | RSS: Main: 196046848 07:20:19 INFO - PROCESS | 3469 | 07:23:21 INFO - PROCESS | 3469 | Cycle 1(1): loaded http://localhost:51690/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51690/tests/dromaeo/cssquery-mootools.html) 07:23:21 INFO - PROCESS | 3469 | RSS: Main: 198172672 07:23:21 INFO - PROCESS | 3469 | 07:26:23 INFO - PROCESS | 3469 | Cycle 1(1): loaded http://localhost:51690/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51690/tests/dromaeo/cssquery-prototype.html) 07:26:24 INFO - PROCESS | 3469 | RSS: Main: 195018752 07:26:24 INFO - PROCESS | 3469 | 07:29:27 INFO - PROCESS | 3469 | Cycle 1(1): loaded http://localhost:51690/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51690/tests/dromaeo/cssquery-yui.html) 07:29:27 INFO - PROCESS | 3469 | RSS: Main: 198381568 07:29:27 INFO - PROCESS | 3469 | 07:32:30 INFO - PROCESS | 3469 | Cycle 1(1): loaded http://localhost:51690/tests/dromaeo/cssquery-yui.html (next: http://localhost:51690/tests/dromaeo/cssquery-dojo.html) 07:32:30 INFO - PROCESS | 3469 | RSS: Main: 199065600 07:32:30 INFO - PROCESS | 3469 | 07:32:30 INFO - PROCESS | 3469 | __start_tp_report 07:32:30 INFO - PROCESS | 3469 | _x_x_mozilla_page_load 07:32:30 INFO - PROCESS | 3469 | _x_x_mozilla_page_load_details 07:32:30 INFO - PROCESS | 3469 | |i|pagename|runs| 07:32:30 INFO - PROCESS | 3469 | |0;dojo.html;3075.53866919962;3078.2919928416477;3111.4243864884997;3114.517249826277;3119.7972131811443;5410.91883621746;5414.648047876885;5416.810411635589;5440.945590544094;5519.337679478458;5432;5433.1578605316145;5456.61803673743;5526.41972592878;5539.584531160159;4928.211486162215;5022.6233032522705;5060.746962651871;5092.439831618519;5140.5373516383515;4367.956320436802;5134.6662466939715;5137.614678899079;5144.125498665236;5148.8712782180555;4955.578775804061;5007.173816320303;5060.671056381323;5070.29015937769;5169.483051694838;5047.141985862412;5048.495150484959;5053.216751403538;5066.341375621182;5093.2105523643895;5006.74966251686;5030.270610761419;5038.546530812245;5049.64652474327;5097.23541468779;5363.704996225206;5409.675419474844;5422.376426710939;5501.642393244426;5519.172124181365;5916.142159386908;5922.289325280994;5937.346891841894;5985.042393217108;6000.96999515004;5954.672493012882;5955.166276721263;5957.821265362046;5959.612625179393;5960.672163031031;5425.891482170335;5463.180522921593;5480.095784195642;5537.1140617501005;5540.778368865241;6025.758969641253;6053.51571874249;6066.150738896558;6123.8162855114415;6126.081087836771;5763.85590360236;5797.507211886952;5798.637320229743;5799.333076696234;5811.128330750421;5731.971340143356;5761.308642962871;5829.76680932758;5853.180554722342;5898.793542226087;5801.88396232073;5892.1161825726485;5892.94107058924;5904.468597826216;5977.3126090500145;5848;5893.499052580493;5901.822945311562;5911.645301281937;5911.793087241926;4409.536998615099;4486.035502367007;4491.281394976788;4496.235639941217;4546.477155127137;3915.158240978203;3922.646961773454;3924.50943632046;4001.679865610744;4069.267531844237;5553.8333849984565;5554.2779438672715;5582.381109478287;5591.825716599478;5600.215969764236;5828.300603927556;5889;5923.555733319932;5934.109883517421;5955.3151387590115;5478.068728316116;5479.958807826501;5528.668279903139;5532.336119665666;5572.247746554244;4926.950730492721;4929;4933.210686290176;4934;5031.899362012739;6054.697265136813;6065.787697430569;6102.3983636914;6116.031445915052;6129.981545214243;5850.444207800252;5904.881902361843;5917.6745279010065;5949.762009519571;5962.4633782959745;6169.043798211284;6198.876022479615;6218.31598524171;6224.346443623354;6225.937740622536;5888.793892213752;5889.057750759858;5892.027815410409;5897.3807750185615;5959.91060134107;5815.389384114607;5865.706714664335;5897.616654917417;5920.555958303231;5993.400659933972;5747.568932330176;5791.507721843691;5808.738606762621;5856.531477481706;5861.1501332307425;5761.39505351932;5790.826275211751;5796.159556864147;5798.739056742373;5805.680687562224;5569.275994120739;5634.774609015593;5692.516136128475;5704.771809127588;5752.741126649227;5752.194692743103;5850.297964244318;5854.531637469077;5890.705464726832;5895.056790913433;5644.068728659725;5668.631538949955;5670.177824215548;5673.744681489426;5718.7998420056765 07:32:30 INFO - PROCESS | 3469 | |1;ext.html;543.2862393487907;582.8921649494844;586.5219845825654;588.7939221272552;591.6804925340316;42033.579664203346;43264.35103473446;43524.347134792966;46898;46932.765336173354;44082.33876491855;44168.779156104174;44420.3336949946;44654.10691786162;44870.55129448704;8769.824603507926;8897.95551022244;8898.688545900895;8900.8664870027;8951.149640784115;8821.735347939572;8930.687425940094;8946.597403116843;8988.46069235848;8989.505577193251;8881;8926.687565935194;8963.462192268453;8978.371513994023;9029.683961061364;8922;8936.106389361012;8951.149640784115;8966.148215919542;8971.596278167499;8829.955850220707;8905.643774249022;8921.598528066188;8924.813420711902;8929.151730585583;41644.33690609488;41949;41968.370474442905;42031.369529457086;42061;3184.601924759405;3235.175030367241;3284.556584861037;3389.1696534349244;3439.8796042138406;30610.54084188739;31053.689463105307;31500.21249468759;31805.84097079523;32730;4310.31035034393;4354.9564504355185;4400.713953593006;4406.757628330441;4538.795754191069;331858;332854;333783;333806;333909;31550.842245788623;55061.7691319324;55479.72260138673;55519.72240138854;55603.721981389834;36582;36694.633053669124;36732;36836.63163368386;36930.815345923635;12996.48014079445;13111.27887966171;13142.868571314164;13167.60497185086;13173.802392964113;10595.523201455953;10644.840327395095;10653.254272201026;10682.412467314372;10690.198235132397;8311.709090181814;8421.115782842835;8491.660333586711;8506.532140732195;8563.400561960727;3308.7849289796086;3321.236115693404;3349.748768842298;3362.882299119519;3372.325534893031;923.4690053219425;964.9228061755043;988.3526290279879;1026.1585499890168;1079.3092420850505;32106.678933210835;32116.19709507281;32559.186020349207;32761;32914.50628240578;974.7027156717269;1029.7683021320142;1059.2267644619471;1092.4373947417087;1110.7167672243688;15642.374305027899;16460.506184814476;16477.83522164787;16576.2540685667;16613.335466581444;545235;548985;550461;551374;553525;56620.71689641608;57092.143617845766;57101.71449142728;57371.13943290854;57483.71258143683;1278.26499762635;1315.7828958221787;1317.1899281941728;1323.9139455935333;1327.0843118248379;28854.567181491875;30101.849490752407;30773.538396924512;30813.845930770203;30927.69072309248;47502;48128;48194.27708584444;48590;48630.40750313759;456172;457821;458966;459458;460414;27895;27954.440911181257;28201;28369.29076773097;28448.857755711088;45390.31914521219;45690.31464528101;46147;46730;47890;39332;39699.60300396959;39815.203695926495;41110.38334425046;42049.15901682011;39823.805285841474;40021.39967900426;40170.39744403778;40221.396679049256;41525.792371037955;39524.604753952095;39899;39979;40081;43329.350059748496;30706.161729783777;34870.30259394849;36040.819795900854;36523;36736.89789306325;27474.725252747216;27952.44095118127;28276.85861570679;28317;28436.715632844236 07:32:30 INFO - PROCESS | 3469 | |2;jquery.html;389.5812002097746;391.7845185148168;403.7819577428189;410.4540960522505;417.89970407102305;18124.093795310233;19749.703754443675;19772.209111635537;20076.196952121933;20204.19183232669;18403.90798046008;18733.718994215098;18821.34125305611;18874.33939812107;19370.22519099238;5344.385395679507;5356.651817631841;5783.277090363705;5868.325142608591;5870.972579798539;5545.584081193906;5586.91619625706;5611.0741727614895;5615.354234263051;5629.296337957755;5544.085225937735;5700.572457065716;5968.462838344548;6044.879102417949;6065.514758819306;5911.054231322968;5991.3109992351;6028.336882942873;6052;6097.603655762384;5815.244018277639;5835.824925252249;5859.53123750099;5872.647641141502;5880.794172203952;14483.203423811687;15898.443554475654;22008.669869951962;23344.29967100973;23611.409714757097;2038.1337931379253;2540.720520742717;2591.5983022631335;2635.156749840052;2646.752344564081;9998.600055997751;10221;10512.1590272778;10653.733656658567;10672.733181670443;1909.484439201408;1959.4219705187004;1969.4387099676667;1971.7929617390112;2022.6157030164368;75507;83798;85314.57342713309;85359;89024;10020.949895250476;10462.63380781669;10620.893791062144;10637.414942178255;11826.88173118275;13747.312634368242;13755.449782008607;13764.449422023206;13799.172049677052;13813.861861381458;7067.293270672994;7176.425885929113;7251.637418129072;7426.925730742623;7537.283958023979;6872.725090996304;6916.377526022581;6983.615901125487;7108.253633368526;7164.570125792469;4132.504099508078;4135.8966025849595;4208.579142085767;4253.595908388698;4326.286162783105;2040.0015968701216;2052.8563000590116;2081.9479513012298;2087;2098.517341011576;409.39818466853677;444.8665400379873;451.8960639053036;819.762268942012;839.6221700234919;11845.052395808314;11887.70280742971;12089.637310880687;12147.392630368446;12352.25886446816;452.52258866895085;455.5740382742147;457.8145850930312;822.0944069813495;983.2232536296245;10745.570177192982;11216;11281.548738050386;11306.265092768943;11321.886781132083;477099;478015;483855.22651480767;486907;503522;88281;94733;97737;98221;98659.50670246746;972.5866506734609;997.8902320744712;1017.9083882450615;1025.5231317437429;1033.612395351728;17718.20268087965;17884.91057544704;18490.167942442353;18860.717089243946;19033.71449428232;42684.78657606692;43308.35037474504;43461.34807977946;43565.78217108894;44269.55730442654;57848.42151578431;58490;60338.39661603503;61362.465938351896;62502.37497624965;8044.758657240292;8191.549464779494;8297.128801476;8402.117777633504;8582.699605513777;9345.813083738423;12921.806172907225;13692.520761773689;13812;14063.226522541358;11579.13156513248;11769.234999724991;11817.940910295394;11995.520179192734;12392.31842248685;11213.15901307389;11383.829242561202;11574.6527604172;11888.821667675165;12119.333436661069;12003.63989080329;12026.27842329463;12035.699107522381;12098.213616114925;12301.355208630188;7606.847863042819;7892.131865494676;8037.919620803951;8214.917850821415;8230.42387032902;8797.692080777142;10594.31136976125;11160.386178760245;11464.082873370277;11596.420178990847 07:32:30 INFO - PROCESS | 3469 | |3;mootools.html;1476.9409223631055;1490.5826368616788;1662.6425318556514;1752.8159543247966;1798.7211982142771;7996.880046799302;8254.628541715621;8684.782880427992;9431.386959847605;9432.198263147631;8630.697925572606;8954;8960.462372257653;9228.8615670765;9253.398529095604;2306.8385213035094;2362.9291121266306;2363.775441333079;2367.869767162805;2367.9408014799683;2311.179531266393;2349.6710460535537;2377.7146742390937;2383.6067048936993;2384.201292566992;2333.9649905251435;2340.6372012338115;2353.3881190890406;2383.0586918167314;2389.653500242464;2315.6873822034063;2330.394097534653;2340.520193360357;2347.2840783561005;2364.47981444082;2330.4523436992295;2335.089315167086;2342.730585982617;2344.1443872986406;2354.176038386568;9191.678291259774;9261.398009129452;9348.1119293667;9352.719418417459;9354.672586459441;5297.788088476456;5361.115415956362;5415.702136382497;5430.294061771984;5463.562914966793;3400.625931147572;3403.3363494118657;3443.5695538057744;3453.8445769940413;3485.2855164691177;1084.614961688597;1106.4246591772232;1119.0376276402287;1134.9773004539863;1139.7435576995192;12799.360031998363;12807;12863.935680321538;12871.871281287255;12875.356232188447;4508.661850361171;4619.69971951822;4798.640101992364;4824.228123500223;4865.464798872121;10681.465926703633;10707.411092389837;10765.192610554239;10782.622608208674;10784.40685762275;5185.351831021122;5212.4266330703595;5227.60792940531;5229.660072095302;5241.42344342122;4816.301636262722;4856.490068542752;5003.74981250936;5035.974820125876;5089.898202035939;3848.5574158971517;3921.7254792164276;3931.5085614298214;3959.5248570171766;4005.9599404005585;1215.2222577550374;1219.8658147603755;1221.2794451273614;1222.1567118688076;1230.5693007447321;923.1968187676764;926.6802952981211;929.9581518831669;939.5161491831713;945.3713280668416;5923.259592550931;5984;6043.184170136975;6068.908966365508;6215.223097112861;458.0449762245688;458.8256462544212;464.1320730234483;465.39731048292543;493.6371766751435;4082.4896887889013;4110.136871257009;4158.2307273154565;4158.9376159357635;4180.728252663628;11271.830922536168;11543.19197656156;11555.2489088209;11641.359725215194;11659.708507287216;11442.542298307975;11482.59810906631;11493.77012459746;11501.252418592765;11505.13711471643;8066.395020373378;8392.832143357098;8421.115782842835;8511.404201705822;8540.74377768668;6262.436380725757;6276.686165691606;6439.517036222396;6471.805845824632;6516.674166291572;10275.948620256851;10345.534450949875;10448.164146868385;10570.947145264225;10663.840042399215;10437.425941573287;10548.894511054792;10559.841602375816;10748.193885458779;10751.569937202425;6992.195897471653;7960.4825686330205;7972.800679983046;8022.558759268296;8154.306883914696;8973.102689730975;9064.093590640883;9065.728028159167;9066.773330666787;9067.727968160965;7944.205579442009;8011.559364235023;8188.754337369888;8258.628361723857;8277.048139463797;7485.513441626277;7499.437542184249;7757.224277572198;7901.130875603794;7936.127026027248;7212.603306818175;7340.522866013692;7385.778426647209;7393.593352365671;7411.332980031823;5038.84883453497;5123.923141152811;5156.716380599103;5224.608154388512;5405.837824865261;5113.948860511347;5142.688614403303;5152.3044389007;5215.582753379645;5424.972875135599 07:32:30 INFO - PROCESS | 3469 | |4;prototype.html;325.76707654027365;329.3084522502744;336.9100958399577;341.8256689088564;346.15192777694654;5456.590755693319;5537.283442132942;5624.29696287964;5696.316442026958;5720.170575266589;5299.28459657946;5558.555315574755;5569.470900264469;5577.665340079598;5628.874225154965;4374.584414480627;4376.737395756249;4377.102693947749;4378.562143785628;4384.364267181257;4130.256553820311;4318.935215971763;4341.522432532419;4377.190219809329;4398.27428474303;4288.914221715564;4298.677599180059;4301.182775272704;4303.419038429804;4309.8707038788725;4297.828086876521;4305.892352691177;4313.309870420733;4328.285832837578;4335.761533115678;3618.6743193112748;3740.233252183296;3747.294980783764;3756.624337566249;3775.5658099318657;5403.432639572828;5411.21537377082;5435.613918450809;5454.59090568209;5458.699771512565;4934.161192597231;4970.801167953277;4978.178600530908;4980.82567110153;4991.276264941599;5604.8318550443555;5831.591788574801;5836.949349117157;5837.357890632027;5865.58940874139;4093.4678491795876;4118.5263694675195;4124.546299907008;4141.4409054777825;4187.706860519765;6073.362296958844;6082.300535438437;6129.295131059941;6142.6314421134875;6155.87688246237;4113.691473139526;4123.793810309473;4174.519930208005;4232.20131444135;4265.87202383929;4214.957850421457;4216.536181020086;4233.576642335742;4247.68142389322;4263.978680106579;4919.434265059493;4921.514635109247;4930.457649658535;4932.728699921467;4983.70423689836;5778.8266352009505;5920.822375328747;5929.555283353679;5952.285725712942;5990.820275391745;1460.3355473259642;1465.6042868425466;1467.576450842681;1469.390203065737;1469.8530146985215;915.4461550761827;952.8189643967625;960.9471479068718;969.0987381734914;975.6097560975667;4927;4980.452150263468;5007.574356179765;5052.343195384577;5088.491150884882;5232.895342093213;5249.475052494797;5285.471452854684;5300.761465734051;5361.892762144813;4956.677815941952;5028.346314979102;5068.4424713281505;5300.390455097636;5632.352279487829;3204.5673834032573;3225.483922572424;3227.064151396116;3233.9029829105166;3238.449463591195;6126.908096378558;6303.590266632654;6315.389575658178;6343.968280158662;6346.65173885656;6078.817635470943;6081.239845019372;6084.878302433926;6101.450869421773;6151.246894635007;6180.227471566054;6192.0711893215475;6203.100550420164;6222.719977601018;6247.2815626202655;5755.827325180251;5951.434613711691;5982.46157845796;6010.819675409744;6072.483838873745;5841.4450627192045;5879.059350503899;5905.704714764159;5945.940540594539;5965.821025369246;5971.91042134377;6181.84545386369;6186.350433204449;6217.937820621736;6228.688565571794;4111.938320925248;4212.262854000599;4249.745015299092;4269.893252668709;4273.380359847867;5974.850628734316;5989.790357337472;5998.790042348497;6035.366286540026;6062.514998799998;5708.600397972268;5821.738021788945;5860.94139058621;5863.2670916135485;5904.232449781501;5796.42035796417;5805.970970145122;5810.912836307543;5812.18629391877;5842.6921366061015;5704.3725190228215;5731.914021289767;5765.625234359753;5779.335376431596;5807.535397168301;5574.219609254788;5801.274840644919;5819.912701309569;5831.096180092092;5840.2115714378015;5692.402297758676;5692.857678558069;5745.166950792028;5764.616492041796;5766.481016708516 07:32:30 INFO - PROCESS | 3469 | |5;yui.html;715.6493318274046;715.6922523314976;716.0512321174442;725.2819708488598;734.669398770553;15614.921925390372;17322.740158897628;17335.133243337816;17348.3928062518;17375.739363909535;14038.438462461489;14087.29563521825;14119;14167.291635418214;14171.291435428213;633.6293268437969;645.6771614192903;750.1523278695067;755.746824813688;759.9854194650121;778.3150827271993;780.6331024418542;782.2607635784186;782.5930516131608;783.0251337085336;819.8319344534356;823.9917600823975;824.8020475085996;825.2737590919982;831.8835363049178;813.7640084375524;822.3749950037954;824.0235321144463;827.2058823529419;829.7510746775973;610.0726895119438;610.3713175429315;610.7282259394572;610.8167549735061;611.1535523300261;14062.437502499888;14216.715665686732;14254.216018119;14256.572302830931;14266.215358155298;14913.92543037278;14975.101493910292;15142.772858407132;15374.9231253843;15579.688406231926;9934.254930880214;9947.502624868728;10123.139533139693;10129.949350253275;10308.278420510567;3843.538775346948;3847;3868.1683438060672;3886.727929044968;4019.8593049243136;79157.20842791555;81339.18660813375;81389;82181.17818821795;83182.58408707978;9179.802244416305;9493.667721629849;9523.28575356851;9578.56896439662;9765.951170244103;23018.424539386648;23102.306930792103;23233.419164520685;23343.649845252334;23384.64923026156;7966.402519810921;8042.195780421911;8087.069986951458;8312.168783121639;8406.201410865959;4282.421873047161;4384.758838263862;4432.268675668479;4552.0668263006;4613.861584152481;3433.9313213735586;3493.7554371194283;3534.3638145134123;3534.876279330211;3539;577.7919948818422;587.7539616014078;593.1873333533088;593.483669207792;603.4478452216173;502.43552654353186;594.7502049139372;594.9647613153169;602.1690067706537;627.3068259573106;8962.417442866194;9025.41334813235;9082.727518174466;9348.345615806827;9403.57683904226;633.2337871175837;673.8517526144241;675.6554157379674;688.2944981394111;695.0929037605872;4180.728252663567;4340.392345071693;4380.277254253013;4391.538888416734;4435.512093669694;121154;123112;123715;125503;126279;62008.379916201164;64527.35472645213;65317;102012;108092.45953770181;90370;91395.54302228446;91869.99999999866;92319;97229.5138524317;7992.240737129963;8378.53918034514;8443.915560844558;8512.276456501268;8585.570721464026;52629;52937;53369;53790.041547713685;55036;49764;78141;81325.59337203276;82501.17498824935;85346.57326713327;11080.61217857371;11146.721331966766;11178.428961338775;11505.654830355103;11697.473613687234;13222.933885330513;13341;13398.330083495592;13649.795253071014;14080.718385632024;12300;12366.938165309115;12911.418986145834;13145.145565538209;13155.342232888126;12523.686907827378;12636.294100296342;13118.380279585046;13186.934065329995;13251.403686833923;11826.763464730486;12089.879101208875;12270.141090123963;12341.197822141532;12379.690507737017;9275.907240927774;9439.669611563562;9918.454485003394;10332.896671033193;10336.793264134825;8595;9749.951250243987;9830.262730295113;10357.9482102589;10802.16363218239 07:32:30 INFO - PROCESS | 3469 | __end_tp_report 07:32:30 INFO - PROCESS | 3469 | __start_cc_report 07:32:30 INFO - PROCESS | 3469 | _x_x_mozilla_cycle_collect,297 07:32:30 INFO - PROCESS | 3469 | __end_cc_report 07:32:30 INFO - PROCESS | 3469 | __startTimestamp1474900350676__endTimestamp 07:32:30 INFO - PROCESS | 3469 | 07:32:30 INFO - PROCESS | 3469 | ------- Summary: start ------- 07:32:30 INFO - PROCESS | 3469 | Number of tests: 6 07:32:30 INFO - PROCESS | 3469 | 07:32:30 INFO - PROCESS | 3469 | [#0] dojo.html Cycles:165 Average:5477.42 Median:5704.77 stddev:648.23 (11.4%) stddev-sans-first:622.23 07:32:30 INFO - PROCESS | 3469 | Values: 3075.5 3078.3 3111.4 3114.5 3119.8 5410.9 5414.6 5416.8 5440.9 5519.3 5432.0 5433.2 5456.6 5526.4 5539.6 4928.2 5022.6 5060.7 5092.4 5140.5 4368.0 5134.7 5137.6 5144.1 5148.9 4955.6 5007.2 5060.7 5070.3 5169.5 5047.1 5048.5 5053.2 5066.3 5093.2 5006.7 5030.3 5038.5 5049.6 5097.2 5363.7 5409.7 5422.4 5501.6 5519.2 5916.1 5922.3 5937.3 5985.0 6001.0 5954.7 5955.2 5957.8 5959.6 5960.7 5425.9 5463.2 5480.1 5537.1 5540.8 6025.8 6053.5 6066.2 6123.8 6126.1 5763.9 5797.5 5798.6 5799.3 5811.1 5732.0 5761.3 5829.8 5853.2 5898.8 5801.9 5892.1 5892.9 5904.5 5977.3 5848.0 5893.5 5901.8 5911.6 5911.8 4409.5 4486.0 4491.3 4496.2 4546.5 3915.2 3922.6 3924.5 4001.7 4069.3 5553.8 5554.3 5582.4 5591.8 5600.2 5828.3 5889.0 5923.6 5934.1 5955.3 5478.1 5480.0 5528.7 5532.3 5572.2 4927.0 4929.0 4933.2 4934.0 5031.9 6054.7 6065.8 6102.4 6116.0 6130.0 5850.4 5904.9 5917.7 5949.8 5962.5 6169.0 6198.9 6218.3 6224.3 6225.9 5888.8 5889.1 5892.0 5897.4 5959.9 5815.4 5865.7 5897.6 5920.6 5993.4 5747.6 5791.5 5808.7 5856.5 5861.2 5761.4 5790.8 5796.2 5798.7 5805.7 5569.3 5634.8 5692.5 5704.8 5752.7 5752.2 5850.3 5854.5 5890.7 5895.1 5644.1 5668.6 5670.2 5673.7 5718.8 07:32:30 INFO - PROCESS | 3469 | 07:32:30 INFO - PROCESS | 3469 | [#1] ext.html Cycles:180 Average:59078.41 Median:41796.67 stddev:121366.43 (290.4%) stddev-sans-first:121627.33 07:32:30 INFO - PROCESS | 3469 | Values: 543.3 582.9 586.5 588.8 591.7 42033.6 43264.4 43524.3 46898.0 46932.8 44082.3 44168.8 44420.3 44654.1 44870.6 8769.8 8898.0 8898.7 8900.9 8951.1 8821.7 8930.7 8946.6 8988.5 8989.5 8881.0 8926.7 8963.5 8978.4 9029.7 8922.0 8936.1 8951.1 8966.1 8971.6 8830.0 8905.6 8921.6 8924.8 8929.2 41644.3 41949.0 41968.4 42031.4 42061.0 3184.6 3235.2 3284.6 3389.2 3439.9 30610.5 31053.7 31500.2 31805.8 32730.0 4310.3 4355.0 4400.7 4406.8 4538.8 331858.0 332854.0 333783.0 333806.0 333909.0 31550.8 55061.8 55479.7 55519.7 55603.7 36582.0 36694.6 36732.0 36836.6 36930.8 12996.5 13111.3 13142.9 13167.6 13173.8 10595.5 10644.8 10653.3 10682.4 10690.2 8311.7 8421.1 8491.7 8506.5 8563.4 3308.8 3321.2 3349.7 3362.9 3372.3 923.5 964.9 988.4 1026.2 1079.3 32106.7 32116.2 32559.2 32761.0 32914.5 974.7 1029.8 1059.2 1092.4 1110.7 15642.4 16460.5 16477.8 16576.3 16613.3 545235.0 548985.0 550461.0 551374.0 553525.0 56620.7 57092.1 57101.7 57371.1 57483.7 1278.3 1315.8 1317.2 1323.9 1327.1 28854.6 30101.8 30773.5 30813.8 30927.7 47502.0 48128.0 48194.3 48590.0 48630.4 456172.0 457821.0 458966.0 459458.0 460414.0 27895.0 27954.4 28201.0 28369.3 28448.9 45390.3 45690.3 46147.0 46730.0 47890.0 39332.0 39699.6 39815.2 41110.4 42049.2 39823.8 40021.4 40170.4 40221.4 41525.8 39524.6 39899.0 39979.0 40081.0 43329.4 30706.2 34870.3 36040.8 36523.0 36736.9 27474.7 27952.4 28276.9 28317.0 28436.7 07:32:30 INFO - PROCESS | 3469 | 07:32:30 INFO - PROCESS | 3469 | [#2] jquery.html Cycles:180 Average:28769.23 Median:4134.20 stddev:80393.07 (1944.6%) stddev-sans-first:80590.36 07:32:30 INFO - PROCESS | 3469 | Values: 389.6 391.8 403.8 410.5 417.9 18124.1 19749.7 19772.2 20076.2 20204.2 18403.9 18733.7 18821.3 18874.3 19370.2 5344.4 5356.7 5783.3 5868.3 5871.0 5545.6 5586.9 5611.1 5615.4 5629.3 5544.1 5700.6 5968.5 6044.9 6065.5 5911.1 5991.3 6028.3 6052.0 6097.6 5815.2 5835.8 5859.5 5872.6 5880.8 14483.2 15898.4 22008.7 23344.3 23611.4 2038.1 2540.7 2591.6 2635.2 2646.8 9998.6 10221.0 10512.2 10653.7 10672.7 1909.5 1959.4 1969.4 1971.8 2022.6 75507.0 83798.0 85314.6 85359.0 89024.0 10020.9 10462.6 10620.9 10637.4 11826.9 13747.3 13755.4 13764.4 13799.2 13813.9 7067.3 7176.4 7251.6 7426.9 7537.3 6872.7 6916.4 6983.6 7108.3 7164.6 4132.5 4135.9 4208.6 4253.6 4326.3 2040.0 2052.9 2081.9 2087.0 2098.5 409.4 444.9 451.9 819.8 839.6 11845.1 11887.7 12089.6 12147.4 12352.3 452.5 455.6 457.8 822.1 983.2 10745.6 11216.0 11281.5 11306.3 11321.9 477099.0 478015.0 483855.2 486907.0 503522.0 88281.0 94733.0 97737.0 98221.0 98659.5 972.6 997.9 1017.9 1025.5 1033.6 17718.2 17884.9 18490.2 18860.7 19033.7 42684.8 43308.4 43461.3 43565.8 44269.6 57848.4 58490.0 60338.4 61362.5 62502.4 8044.8 8191.5 8297.1 8402.1 8582.7 9345.8 12921.8 13692.5 13812.0 14063.2 11579.1 11769.2 11817.9 11995.5 12392.3 11213.2 11383.8 11574.7 11888.8 12119.3 12003.6 12026.3 12035.7 12098.2 12301.4 7606.8 7892.1 8037.9 8214.9 8230.4 8797.7 10594.3 11160.4 11464.1 11596.4 07:32:30 INFO - PROCESS | 3469 | 07:32:30 INFO - PROCESS | 3469 | [#3] mootools.html Cycles:180 Average:5971.60 Median:2632.02 stddev:3486.49 (132.5%) stddev-sans-first:3479.91 07:32:30 INFO - PROCESS | 3469 | Values: 1476.9 1490.6 1662.6 1752.8 1798.7 7996.9 8254.6 8684.8 9431.4 9432.2 8630.7 8954.0 8960.5 9228.9 9253.4 2306.8 2362.9 2363.8 2367.9 2367.9 2311.2 2349.7 2377.7 2383.6 2384.2 2334.0 2340.6 2353.4 2383.1 2389.7 2315.7 2330.4 2340.5 2347.3 2364.5 2330.5 2335.1 2342.7 2344.1 2354.2 9191.7 9261.4 9348.1 9352.7 9354.7 5297.8 5361.1 5415.7 5430.3 5463.6 3400.6 3403.3 3443.6 3453.8 3485.3 1084.6 1106.4 1119.0 1135.0 1139.7 12799.4 12807.0 12863.9 12871.9 12875.4 4508.7 4619.7 4798.6 4824.2 4865.5 10681.5 10707.4 10765.2 10782.6 10784.4 5185.4 5212.4 5227.6 5229.7 5241.4 4816.3 4856.5 5003.7 5036.0 5089.9 3848.6 3921.7 3931.5 3959.5 4006.0 1215.2 1219.9 1221.3 1222.2 1230.6 923.2 926.7 930.0 939.5 945.4 5923.3 5984.0 6043.2 6068.9 6215.2 458.0 458.8 464.1 465.4 493.6 4082.5 4110.1 4158.2 4158.9 4180.7 11271.8 11543.2 11555.2 11641.4 11659.7 11442.5 11482.6 11493.8 11501.3 11505.1 8066.4 8392.8 8421.1 8511.4 8540.7 6262.4 6276.7 6439.5 6471.8 6516.7 10275.9 10345.5 10448.2 10570.9 10663.8 10437.4 10548.9 10559.8 10748.2 10751.6 6992.2 7960.5 7972.8 8022.6 8154.3 8973.1 9064.1 9065.7 9066.8 9067.7 7944.2 8011.6 8188.8 8258.6 8277.0 7485.5 7499.4 7757.2 7901.1 7936.1 7212.6 7340.5 7385.8 7393.6 7411.3 5038.8 5123.9 5156.7 5224.6 5405.8 5113.9 5142.7 5152.3 5215.6 5425.0 07:32:30 INFO - PROCESS | 3469 | 07:32:30 INFO - PROCESS | 3469 | [#4] prototype.html Cycles:180 Average:4864.60 Median:5497.99 stddev:1442.29 (26.2%) stddev-sans-first:1405.53 07:32:30 INFO - PROCESS | 3469 | Values: 325.8 329.3 336.9 341.8 346.2 5456.6 5537.3 5624.3 5696.3 5720.2 5299.3 5558.6 5569.5 5577.7 5628.9 4374.6 4376.7 4377.1 4378.6 4384.4 4130.3 4318.9 4341.5 4377.2 4398.3 4288.9 4298.7 4301.2 4303.4 4309.9 4297.8 4305.9 4313.3 4328.3 4335.8 3618.7 3740.2 3747.3 3756.6 3775.6 5403.4 5411.2 5435.6 5454.6 5458.7 4934.2 4970.8 4978.2 4980.8 4991.3 5604.8 5831.6 5836.9 5837.4 5865.6 4093.5 4118.5 4124.5 4141.4 4187.7 6073.4 6082.3 6129.3 6142.6 6155.9 4113.7 4123.8 4174.5 4232.2 4265.9 4215.0 4216.5 4233.6 4247.7 4264.0 4919.4 4921.5 4930.5 4932.7 4983.7 5778.8 5920.8 5929.6 5952.3 5990.8 1460.3 1465.6 1467.6 1469.4 1469.9 915.4 952.8 960.9 969.1 975.6 4927.0 4980.5 5007.6 5052.3 5088.5 5232.9 5249.5 5285.5 5300.8 5361.9 4956.7 5028.3 5068.4 5300.4 5632.4 3204.6 3225.5 3227.1 3233.9 3238.4 6126.9 6303.6 6315.4 6344.0 6346.7 6078.8 6081.2 6084.9 6101.5 6151.2 6180.2 6192.1 6203.1 6222.7 6247.3 5755.8 5951.4 5982.5 6010.8 6072.5 5841.4 5879.1 5905.7 5945.9 5965.8 5971.9 6181.8 6186.4 6217.9 6228.7 4111.9 4212.3 4249.7 4269.9 4273.4 5974.9 5989.8 5998.8 6035.4 6062.5 5708.6 5821.7 5860.9 5863.3 5904.2 5796.4 5806.0 5810.9 5812.2 5842.7 5704.4 5731.9 5765.6 5779.3 5807.5 5574.2 5801.3 5819.9 5831.1 5840.2 5692.4 5692.9 5745.2 5764.6 5766.5 07:32:30 INFO - PROCESS | 3469 | 07:32:30 INFO - PROCESS | 3469 | [#5] yui.html Cycles:180 Average:20595.94 Median:27806.90 stddev:30749.38 (110.6%) stddev-sans-first:30799.41 07:32:30 INFO - PROCESS | 3469 | Values: 715.6 715.7 716.1 725.3 734.7 15614.9 17322.7 17335.1 17348.4 17375.7 14038.4 14087.3 14119.0 14167.3 14171.3 633.6 645.7 750.2 755.7 760.0 778.3 780.6 782.3 782.6 783.0 819.8 824.0 824.8 825.3 831.9 813.8 822.4 824.0 827.2 829.8 610.1 610.4 610.7 610.8 611.2 14062.4 14216.7 14254.2 14256.6 14266.2 14913.9 14975.1 15142.8 15374.9 15579.7 9934.3 9947.5 10123.1 10129.9 10308.3 3843.5 3847.0 3868.2 3886.7 4019.9 79157.2 81339.2 81389.0 82181.2 83182.6 9179.8 9493.7 9523.3 9578.6 9766.0 23018.4 23102.3 23233.4 23343.6 23384.6 7966.4 8042.2 8087.1 8312.2 8406.2 4282.4 4384.8 4432.3 4552.1 4613.9 3433.9 3493.8 3534.4 3534.9 3539.0 577.8 587.8 593.2 593.5 603.4 502.4 594.8 595.0 602.2 627.3 8962.4 9025.4 9082.7 9348.3 9403.6 633.2 673.9 675.7 688.3 695.1 4180.7 4340.4 4380.3 4391.5 4435.5 121154.0 123112.0 123715.0 125503.0 126279.0 62008.4 64527.4 65317.0 102012.0 108092.5 90370.0 91395.5 91870.0 92319.0 97229.5 7992.2 8378.5 8443.9 8512.3 8585.6 52629.0 52937.0 53369.0 53790.0 55036.0 49764.0 78141.0 81325.6 82501.2 85346.6 11080.6 11146.7 11178.4 11505.7 11697.5 13222.9 13341.0 13398.3 13649.8 14080.7 12300.0 12366.9 12911.4 13145.1 13155.3 12523.7 12636.3 13118.4 13186.9 13251.4 11826.8 12089.9 12270.1 12341.2 12379.7 9275.9 9439.7 9918.5 10332.9 10336.8 8595.0 9750.0 9830.3 10357.9 10802.2 07:32:30 INFO - PROCESS | 3469 | -------- Summary: end -------- 07:32:30 INFO - PROCESS | 3469 | 07:32:31 INFO - TEST-INFO | 3469: exit 0 07:32:31 INFO - TEST-OK | dromaeo_css | took 1115602ms 07:32:31 INFO - TEST-START | kraken 07:32:31 INFO - operating with platform_type : linux_ 07:32:31 INFO - Initialising browser for kraken test... 07:32:31 INFO - TEST-INFO | started process 3836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUEb_tz/profile http://localhost:51690/getInfo.html) 07:32:36 INFO - PROCESS | 3836 | __metrics Screen width/height:1600/1200 07:32:36 INFO - PROCESS | 3836 | colorDepth:24 07:32:36 INFO - PROCESS | 3836 | Browser inner width/height: 1024/697 07:32:36 INFO - PROCESS | 3836 | __metrics 07:32:36 ERROR - PROCESS | 3836 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 07:32:37 INFO - TEST-INFO | 3836: exit 0 07:32:37 INFO - Browser initialized. 07:32:37 INFO - Running cycle 1/1 for kraken test... 07:32:37 INFO - TEST-INFO | started process 3955 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUEb_tz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:32:50 INFO - PROCESS | 3955 | RSS: Main: 185274368 07:32:50 INFO - PROCESS | 3955 | 07:32:52 INFO - PROCESS | 3955 | Cycle 1(1): loaded http://localhost:51690/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51690/tests/kraken/driver.html?testName=audio-beat-detection) 07:32:53 INFO - PROCESS | 3955 | RSS: Main: 199483392 07:32:53 INFO - PROCESS | 3955 | 07:32:56 INFO - PROCESS | 3955 | Cycle 1(1): loaded http://localhost:51690/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51690/tests/kraken/driver.html?testName=audio-dft) 07:32:56 INFO - PROCESS | 3955 | RSS: Main: 197353472 07:32:56 INFO - PROCESS | 3955 | 07:32:59 INFO - PROCESS | 3955 | Cycle 1(1): loaded http://localhost:51690/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51690/tests/kraken/driver.html?testName=audio-fft) 07:33:00 INFO - PROCESS | 3955 | RSS: Main: 193155072 07:33:00 INFO - PROCESS | 3955 | 07:33:02 INFO - PROCESS | 3955 | Cycle 1(1): loaded http://localhost:51690/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51690/tests/kraken/driver.html?testName=audio-oscillator) 07:33:03 INFO - PROCESS | 3955 | RSS: Main: 193740800 07:33:03 INFO - PROCESS | 3955 | 07:33:05 INFO - PROCESS | 3955 | Cycle 1(1): loaded http://localhost:51690/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51690/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:33:05 INFO - PROCESS | 3955 | RSS: Main: 194109440 07:33:05 INFO - PROCESS | 3955 | 07:33:09 INFO - PROCESS | 3955 | Cycle 1(1): loaded http://localhost:51690/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51690/tests/kraken/driver.html?testName=imaging-darkroom) 07:33:09 INFO - PROCESS | 3955 | RSS: Main: 194039808 07:33:09 INFO - PROCESS | 3955 | 07:33:13 INFO - PROCESS | 3955 | Cycle 1(1): loaded http://localhost:51690/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51690/tests/kraken/driver.html?testName=imaging-desaturate) 07:33:13 INFO - PROCESS | 3955 | RSS: Main: 192323584 07:33:13 INFO - PROCESS | 3955 | 07:33:16 INFO - PROCESS | 3955 | Cycle 1(1): loaded http://localhost:51690/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51690/tests/kraken/driver.html?testName=json-parse-financial) 07:33:17 INFO - PROCESS | 3955 | RSS: Main: 193552384 07:33:17 INFO - PROCESS | 3955 | 07:33:18 INFO - PROCESS | 3955 | Cycle 1(1): loaded http://localhost:51690/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51690/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:33:19 INFO - PROCESS | 3955 | RSS: Main: 193818624 07:33:19 INFO - PROCESS | 3955 | 07:33:21 INFO - PROCESS | 3955 | Cycle 1(1): loaded http://localhost:51690/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51690/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:33:21 INFO - PROCESS | 3955 | RSS: Main: 193662976 07:33:21 INFO - PROCESS | 3955 | 07:33:23 INFO - PROCESS | 3955 | Cycle 1(1): loaded http://localhost:51690/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51690/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:33:24 INFO - PROCESS | 3955 | RSS: Main: 193806336 07:33:24 INFO - PROCESS | 3955 | 07:33:27 INFO - PROCESS | 3955 | Cycle 1(1): loaded http://localhost:51690/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51690/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:33:27 INFO - PROCESS | 3955 | RSS: Main: 194125824 07:33:27 INFO - PROCESS | 3955 | 07:33:30 INFO - PROCESS | 3955 | Cycle 1(1): loaded http://localhost:51690/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51690/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:33:31 INFO - PROCESS | 3955 | RSS: Main: 194367488 07:33:31 INFO - PROCESS | 3955 | 07:33:32 INFO - PROCESS | 3955 | Cycle 1(1): loaded http://localhost:51690/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51690/tests/kraken/driver.html?testName=ai-astar) 07:33:33 INFO - PROCESS | 3955 | RSS: Main: 196005888 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | __start_tp_report 07:33:33 INFO - PROCESS | 3955 | _x_x_mozilla_page_load 07:33:33 INFO - PROCESS | 3955 | _x_x_mozilla_page_load_details 07:33:33 INFO - PROCESS | 3955 | |i|pagename|runs| 07:33:33 INFO - PROCESS | 3955 | |0;ai-astar;106;114;113;114;114;114;113;113;114;113 07:33:33 INFO - PROCESS | 3955 | |1;audio-beat-detection;149;124;121;177;129;123;125;126;167;120 07:33:33 INFO - PROCESS | 3955 | |2;audio-dft;162;163;168;173;162;161;161;163;164;162 07:33:33 INFO - PROCESS | 3955 | |3;audio-fft;76;77;77;110;77;77;78;77;105;78 07:33:33 INFO - PROCESS | 3955 | |4;audio-oscillator;83;82;105;83;83;82;103;82;81;108 07:33:33 INFO - PROCESS | 3955 | |5;imaging-gaussian-blur;118;118;118;118;118;119;118;118;119;119 07:33:33 INFO - PROCESS | 3955 | |6;imaging-darkroom;149;147;147;146;146;147;146;148;147;148 07:33:33 INFO - PROCESS | 3955 | |7;imaging-desaturate;96;97;96;96;95;96;95;96;95;96 07:33:33 INFO - PROCESS | 3955 | |8;json-parse-financial;52;53;53;54;54;52;56;53;53;54 07:33:33 INFO - PROCESS | 3955 | |9;json-stringify-tinderbox;60;60;61;60;62;60;60;60;61;61 07:33:33 INFO - PROCESS | 3955 | |10;stanford-crypto-aes;84;80;79;79;79;80;79;81;79;79 07:33:33 INFO - PROCESS | 3955 | |11;stanford-crypto-ccm;135;129;129;126;124;125;134;125;172;128 07:33:33 INFO - PROCESS | 3955 | |12;stanford-crypto-pbkdf2;169;162;167;168;171;166;170;174;166;165 07:33:33 INFO - PROCESS | 3955 | |13;stanford-crypto-sha256-iterative;67;67;67;65;66;67;66;65;64;63 07:33:33 INFO - PROCESS | 3955 | __end_tp_report 07:33:33 INFO - PROCESS | 3955 | __start_cc_report 07:33:33 INFO - PROCESS | 3955 | _x_x_mozilla_cycle_collect,772 07:33:33 INFO - PROCESS | 3955 | __end_cc_report 07:33:33 INFO - PROCESS | 3955 | __startTimestamp1474900413174__endTimestamp 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | ------- Summary: start ------- 07:33:33 INFO - PROCESS | 3955 | Number of tests: 14 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:2.44 (2.1%) stddev-sans-first:0.53 07:33:33 INFO - PROCESS | 3955 | Values: 106.0 114.0 113.0 114.0 114.0 114.0 113.0 113.0 114.0 113.0 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:127.50 stddev:20.75 (16.3%) stddev-sans-first:21.48 07:33:33 INFO - PROCESS | 3955 | Values: 149.0 124.0 121.0 177.0 129.0 123.0 125.0 126.0 167.0 120.0 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.00 stddev:3.78 (2.3%) stddev-sans-first:3.95 07:33:33 INFO - PROCESS | 3955 | Values: 162.0 163.0 168.0 173.0 162.0 161.0 161.0 163.0 164.0 162.0 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | [#3] audio-fft Cycles:10 Average:83.20 Median:77.00 stddev:12.87 (16.7%) stddev-sans-first:13.39 07:33:33 INFO - PROCESS | 3955 | Values: 76.0 77.0 77.0 110.0 77.0 77.0 78.0 77.0 105.0 78.0 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:82.00 stddev:11.21 (13.7%) stddev-sans-first:11.67 07:33:33 INFO - PROCESS | 3955 | Values: 83.0 82.0 105.0 83.0 83.0 82.0 103.0 82.0 81.0 108.0 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:33:33 INFO - PROCESS | 3955 | Values: 118.0 118.0 118.0 118.0 118.0 119.0 118.0 118.0 119.0 119.0 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:0.78 07:33:33 INFO - PROCESS | 3955 | Values: 149.0 147.0 147.0 146.0 146.0 147.0 146.0 148.0 147.0 148.0 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 07:33:33 INFO - PROCESS | 3955 | Values: 96.0 97.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.50 stddev:1.17 (2.2%) stddev-sans-first:1.13 07:33:33 INFO - PROCESS | 3955 | Values: 52.0 53.0 53.0 54.0 54.0 52.0 56.0 53.0 53.0 54.0 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:60.50 stddev:0.71 (1.2%) stddev-sans-first:0.73 07:33:33 INFO - PROCESS | 3955 | Values: 60.0 60.0 61.0 60.0 62.0 60.0 60.0 60.0 61.0 61.0 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.50 stddev:1.60 (2.0%) stddev-sans-first:0.73 07:33:33 INFO - PROCESS | 3955 | Values: 84.0 80.0 79.0 79.0 79.0 80.0 79.0 81.0 79.0 79.0 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | [#11] stanford-crypto-ccm Cycles:10 Average:132.70 Median:129.00 stddev:14.30 (11.1%) stddev-sans-first:15.14 07:33:33 INFO - PROCESS | 3955 | Values: 135.0 129.0 129.0 126.0 124.0 125.0 134.0 125.0 172.0 128.0 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:168.50 stddev:3.39 (2.0%) stddev-sans-first:3.57 07:33:33 INFO - PROCESS | 3955 | Values: 169.0 162.0 167.0 168.0 171.0 166.0 170.0 174.0 166.0 165.0 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.50 stddev:1.42 (2.1%) stddev-sans-first:1.42 07:33:33 INFO - PROCESS | 3955 | Values: 67.0 67.0 67.0 65.0 66.0 67.0 66.0 65.0 64.0 63.0 07:33:33 INFO - PROCESS | 3955 | -------- Summary: end -------- 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | 07:33:33 INFO - PROCESS | 3955 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 07:33:33 INFO - PROCESS | 3955 | 07:33:34 INFO - TEST-INFO | 3955: exit 0 07:33:34 INFO - TEST-OK | kraken | took 62602ms 07:33:34 INFO - SUITE-END | took 1178s 07:33:34 INFO - Completed test suite (00:19:38) 07:33:34 INFO - javascript benchmark 07:33:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7116.0520791664, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3075.53866919962, 3078.2919928416477, 3111.4243864884997, 3114.517249826277, 3119.7972131811443, 5410.91883621746, 5414.648047876885, 5416.810411635589, 5440.945590544094, 5519.337679478458, 5432.0, 5433.1578605316145, 5456.61803673743, 5526.41972592878, 5539.584531160159, 4928.211486162215, 5022.6233032522705, 5060.746962651871, 5092.439831618519, 5140.5373516383515, 4367.956320436802, 5134.6662466939715, 5137.614678899079, 5144.125498665236, 5148.8712782180555, 4955.578775804061, 5007.173816320303, 5060.671056381323, 5070.29015937769, 5169.483051694838, 5047.141985862412, 5048.495150484959, 5053.216751403538, 5066.341375621182, 5093.2105523643895, 5006.74966251686, 5030.270610761419, 5038.546530812245, 5049.64652474327, 5097.23541468779, 5363.704996225206, 5409.675419474844, 5422.376426710939, 5501.642393244426, 5519.172124181365, 5916.142159386908, 5922.289325280994, 5937.346891841894, 5985.042393217108, 6000.96999515004, 5954.672493012882, 5955.166276721263, 5957.821265362046, 5959.612625179393, 5960.672163031031, 5425.891482170335, 5463.180522921593, 5480.095784195642, 5537.1140617501005, 5540.778368865241, 6025.758969641253, 6053.51571874249, 6066.150738896558, 6123.8162855114415, 6126.081087836771, 5763.85590360236, 5797.507211886952, 5798.637320229743, 5799.333076696234, 5811.128330750421, 5731.971340143356, 5761.308642962871, 5829.76680932758, 5853.180554722342, 5898.793542226087, 5801.88396232073, 5892.1161825726485, 5892.94107058924, 5904.468597826216, 5977.3126090500145, 5848.0, 5893.499052580493, 5901.822945311562, 5911.645301281937, 5911.793087241926, 4409.536998615099, 4486.035502367007, 4491.281394976788, 4496.235639941217, 4546.477155127137, 3915.158240978203, 3922.646961773454, 3924.50943632046, 4001.679865610744, 4069.267531844237, 5553.8333849984565, 5554.2779438672715, 5582.381109478287, 5591.825716599478, 5600.215969764236, 5828.300603927556, 5889.0, 5923.555733319932, 5934.109883517421, 5955.3151387590115, 5478.068728316116, 5479.958807826501, 5528.668279903139, 5532.336119665666, 5572.247746554244, 4926.950730492721, 4929.0, 4933.210686290176, 4934.0, 5031.899362012739, 6054.697265136813, 6065.787697430569, 6102.3983636914, 6116.031445915052, 6129.981545214243, 5850.444207800252, 5904.881902361843, 5917.6745279010065, 5949.762009519571, 5962.4633782959745, 6169.043798211284, 6198.876022479615, 6218.31598524171, 6224.346443623354, 6225.937740622536, 5888.793892213752, 5889.057750759858, 5892.027815410409, 5897.3807750185615, 5959.91060134107, 5815.389384114607, 5865.706714664335, 5897.616654917417, 5920.555958303231, 5993.400659933972, 5747.568932330176, 5791.507721843691, 5808.738606762621, 5856.531477481706, 5861.1501332307425, 5761.39505351932, 5790.826275211751, 5796.159556864147, 5798.739056742373, 5805.680687562224, 5569.275994120739, 5634.774609015593, 5692.516136128475, 5704.771809127588, 5752.741126649227, 5752.194692743103, 5850.297964244318, 5854.531637469077, 5890.705464726832, 5895.056790913433, 5644.068728659725, 5668.631538949955, 5670.177824215548, 5673.744681489426, 5718.7998420056765], "value": 5431.6062635619965, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.2862393487907, 582.8921649494844, 586.5219845825654, 588.7939221272552, 591.6804925340316, 42033.579664203346, 43264.35103473446, 43524.347134792966, 46898.0, 46932.765336173354, 44082.33876491855, 44168.779156104174, 44420.3336949946, 44654.10691786162, 44870.55129448704, 8769.824603507926, 8897.95551022244, 8898.688545900895, 8900.8664870027, 8951.149640784115, 8821.735347939572, 8930.687425940094, 8946.597403116843, 8988.46069235848, 8989.505577193251, 8881.0, 8926.687565935194, 8963.462192268453, 8978.371513994023, 9029.683961061364, 8922.0, 8936.106389361012, 8951.149640784115, 8966.148215919542, 8971.596278167499, 8829.955850220707, 8905.643774249022, 8921.598528066188, 8924.813420711902, 8929.151730585583, 41644.33690609488, 41949.0, 41968.370474442905, 42031.369529457086, 42061.0, 3184.601924759405, 3235.175030367241, 3284.556584861037, 3389.1696534349244, 3439.8796042138406, 30610.54084188739, 31053.689463105307, 31500.21249468759, 31805.84097079523, 32730.0, 4310.31035034393, 4354.9564504355185, 4400.713953593006, 4406.757628330441, 4538.795754191069, 331858.0, 332854.0, 333783.0, 333806.0, 333909.0, 31550.842245788623, 55061.7691319324, 55479.72260138673, 55519.72240138854, 55603.721981389834, 36582.0, 36694.633053669124, 36732.0, 36836.63163368386, 36930.815345923635, 12996.48014079445, 13111.27887966171, 13142.868571314164, 13167.60497185086, 13173.802392964113, 10595.523201455953, 10644.840327395095, 10653.254272201026, 10682.412467314372, 10690.198235132397, 8311.709090181814, 8421.115782842835, 8491.660333586711, 8506.532140732195, 8563.400561960727, 3308.7849289796086, 3321.236115693404, 3349.748768842298, 3362.882299119519, 3372.325534893031, 923.4690053219425, 964.9228061755043, 988.3526290279879, 1026.1585499890168, 1079.3092420850505, 32106.678933210835, 32116.19709507281, 32559.186020349207, 32761.0, 32914.50628240578, 974.7027156717269, 1029.7683021320142, 1059.2267644619471, 1092.4373947417087, 1110.7167672243688, 15642.374305027899, 16460.506184814476, 16477.83522164787, 16576.2540685667, 16613.335466581444, 545235.0, 548985.0, 550461.0, 551374.0, 553525.0, 56620.71689641608, 57092.143617845766, 57101.71449142728, 57371.13943290854, 57483.71258143683, 1278.26499762635, 1315.7828958221787, 1317.1899281941728, 1323.9139455935333, 1327.0843118248379, 28854.567181491875, 30101.849490752407, 30773.538396924512, 30813.845930770203, 30927.69072309248, 47502.0, 48128.0, 48194.27708584444, 48590.0, 48630.40750313759, 456172.0, 457821.0, 458966.0, 459458.0, 460414.0, 27895.0, 27954.440911181257, 28201.0, 28369.29076773097, 28448.857755711088, 45390.31914521219, 45690.31464528101, 46147.0, 46730.0, 47890.0, 39332.0, 39699.60300396959, 39815.203695926495, 41110.38334425046, 42049.15901682011, 39823.805285841474, 40021.39967900426, 40170.39744403778, 40221.396679049256, 41525.792371037955, 39524.604753952095, 39899.0, 39979.0, 40081.0, 43329.350059748496, 30706.161729783777, 34870.30259394849, 36040.819795900854, 36523.0, 36736.89789306325, 27474.725252747216, 27952.44095118127, 28276.85861570679, 28317.0, 28436.715632844236], "value": 18483.51963464185, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.5812002097746, 391.7845185148168, 403.7819577428189, 410.4540960522505, 417.89970407102305, 18124.093795310233, 19749.703754443675, 19772.209111635537, 20076.196952121933, 20204.19183232669, 18403.90798046008, 18733.718994215098, 18821.34125305611, 18874.33939812107, 19370.22519099238, 5344.385395679507, 5356.651817631841, 5783.277090363705, 5868.325142608591, 5870.972579798539, 5545.584081193906, 5586.91619625706, 5611.0741727614895, 5615.354234263051, 5629.296337957755, 5544.085225937735, 5700.572457065716, 5968.462838344548, 6044.879102417949, 6065.514758819306, 5911.054231322968, 5991.3109992351, 6028.336882942873, 6052.0, 6097.603655762384, 5815.244018277639, 5835.824925252249, 5859.53123750099, 5872.647641141502, 5880.794172203952, 14483.203423811687, 15898.443554475654, 22008.669869951962, 23344.29967100973, 23611.409714757097, 2038.1337931379253, 2540.720520742717, 2591.5983022631335, 2635.156749840052, 2646.752344564081, 9998.600055997751, 10221.0, 10512.1590272778, 10653.733656658567, 10672.733181670443, 1909.484439201408, 1959.4219705187004, 1969.4387099676667, 1971.7929617390112, 2022.6157030164368, 75507.0, 83798.0, 85314.57342713309, 85359.0, 89024.0, 10020.949895250476, 10462.63380781669, 10620.893791062144, 10637.414942178255, 11826.88173118275, 13747.312634368242, 13755.449782008607, 13764.449422023206, 13799.172049677052, 13813.861861381458, 7067.293270672994, 7176.425885929113, 7251.637418129072, 7426.925730742623, 7537.283958023979, 6872.725090996304, 6916.377526022581, 6983.615901125487, 7108.253633368526, 7164.570125792469, 4132.504099508078, 4135.8966025849595, 4208.579142085767, 4253.595908388698, 4326.286162783105, 2040.0015968701216, 2052.8563000590116, 2081.9479513012298, 2087.0, 2098.517341011576, 409.39818466853677, 444.8665400379873, 451.8960639053036, 819.762268942012, 839.6221700234919, 11845.052395808314, 11887.70280742971, 12089.637310880687, 12147.392630368446, 12352.25886446816, 452.52258866895085, 455.5740382742147, 457.8145850930312, 822.0944069813495, 983.2232536296245, 10745.570177192982, 11216.0, 11281.548738050386, 11306.265092768943, 11321.886781132083, 477099.0, 478015.0, 483855.22651480767, 486907.0, 503522.0, 88281.0, 94733.0, 97737.0, 98221.0, 98659.50670246746, 972.5866506734609, 997.8902320744712, 1017.9083882450615, 1025.5231317437429, 1033.612395351728, 17718.20268087965, 17884.91057544704, 18490.167942442353, 18860.717089243946, 19033.71449428232, 42684.78657606692, 43308.35037474504, 43461.34807977946, 43565.78217108894, 44269.55730442654, 57848.42151578431, 58490.0, 60338.39661603503, 61362.465938351896, 62502.37497624965, 8044.758657240292, 8191.549464779494, 8297.128801476, 8402.117777633504, 8582.699605513777, 9345.813083738423, 12921.806172907225, 13692.520761773689, 13812.0, 14063.226522541358, 11579.13156513248, 11769.234999724991, 11817.940910295394, 11995.520179192734, 12392.31842248685, 11213.15901307389, 11383.829242561202, 11574.6527604172, 11888.821667675165, 12119.333436661069, 12003.63989080329, 12026.27842329463, 12035.699107522381, 12098.213616114925, 12301.355208630188, 7606.847863042819, 7892.131865494676, 8037.919620803951, 8214.917850821415, 8230.42387032902, 8797.692080777142, 10594.31136976125, 11160.386178760245, 11464.082873370277, 11596.420178990847], "value": 8786.477606380047, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1476.9409223631055, 1490.5826368616788, 1662.6425318556514, 1752.8159543247966, 1798.7211982142771, 7996.880046799302, 8254.628541715621, 8684.782880427992, 9431.386959847605, 9432.198263147631, 8630.697925572606, 8954.0, 8960.462372257653, 9228.8615670765, 9253.398529095604, 2306.8385213035094, 2362.9291121266306, 2363.775441333079, 2367.869767162805, 2367.9408014799683, 2311.179531266393, 2349.6710460535537, 2377.7146742390937, 2383.6067048936993, 2384.201292566992, 2333.9649905251435, 2340.6372012338115, 2353.3881190890406, 2383.0586918167314, 2389.653500242464, 2315.6873822034063, 2330.394097534653, 2340.520193360357, 2347.2840783561005, 2364.47981444082, 2330.4523436992295, 2335.089315167086, 2342.730585982617, 2344.1443872986406, 2354.176038386568, 9191.678291259774, 9261.398009129452, 9348.1119293667, 9352.719418417459, 9354.672586459441, 5297.788088476456, 5361.115415956362, 5415.702136382497, 5430.294061771984, 5463.562914966793, 3400.625931147572, 3403.3363494118657, 3443.5695538057744, 3453.8445769940413, 3485.2855164691177, 1084.614961688597, 1106.4246591772232, 1119.0376276402287, 1134.9773004539863, 1139.7435576995192, 12799.360031998363, 12807.0, 12863.935680321538, 12871.871281287255, 12875.356232188447, 4508.661850361171, 4619.69971951822, 4798.640101992364, 4824.228123500223, 4865.464798872121, 10681.465926703633, 10707.411092389837, 10765.192610554239, 10782.622608208674, 10784.40685762275, 5185.351831021122, 5212.4266330703595, 5227.60792940531, 5229.660072095302, 5241.42344342122, 4816.301636262722, 4856.490068542752, 5003.74981250936, 5035.974820125876, 5089.898202035939, 3848.5574158971517, 3921.7254792164276, 3931.5085614298214, 3959.5248570171766, 4005.9599404005585, 1215.2222577550374, 1219.8658147603755, 1221.2794451273614, 1222.1567118688076, 1230.5693007447321, 923.1968187676764, 926.6802952981211, 929.9581518831669, 939.5161491831713, 945.3713280668416, 5923.259592550931, 5984.0, 6043.184170136975, 6068.908966365508, 6215.223097112861, 458.0449762245688, 458.8256462544212, 464.1320730234483, 465.39731048292543, 493.6371766751435, 4082.4896887889013, 4110.136871257009, 4158.2307273154565, 4158.9376159357635, 4180.728252663628, 11271.830922536168, 11543.19197656156, 11555.2489088209, 11641.359725215194, 11659.708507287216, 11442.542298307975, 11482.59810906631, 11493.77012459746, 11501.252418592765, 11505.13711471643, 8066.395020373378, 8392.832143357098, 8421.115782842835, 8511.404201705822, 8540.74377768668, 6262.436380725757, 6276.686165691606, 6439.517036222396, 6471.805845824632, 6516.674166291572, 10275.948620256851, 10345.534450949875, 10448.164146868385, 10570.947145264225, 10663.840042399215, 10437.425941573287, 10548.894511054792, 10559.841602375816, 10748.193885458779, 10751.569937202425, 6992.195897471653, 7960.4825686330205, 7972.800679983046, 8022.558759268296, 8154.306883914696, 8973.102689730975, 9064.093590640883, 9065.728028159167, 9066.773330666787, 9067.727968160965, 7944.205579442009, 8011.559364235023, 8188.754337369888, 8258.628361723857, 8277.048139463797, 7485.513441626277, 7499.437542184249, 7757.224277572198, 7901.130875603794, 7936.127026027248, 7212.603306818175, 7340.522866013692, 7385.778426647209, 7393.593352365671, 7411.332980031823, 5038.84883453497, 5123.923141152811, 5156.716380599103, 5224.608154388512, 5405.837824865261, 5113.948860511347, 5142.688614403303, 5152.3044389007, 5215.582753379645, 5424.972875135599], "value": 4654.568365464346, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.76707654027365, 329.3084522502744, 336.9100958399577, 341.8256689088564, 346.15192777694654, 5456.590755693319, 5537.283442132942, 5624.29696287964, 5696.316442026958, 5720.170575266589, 5299.28459657946, 5558.555315574755, 5569.470900264469, 5577.665340079598, 5628.874225154965, 4374.584414480627, 4376.737395756249, 4377.102693947749, 4378.562143785628, 4384.364267181257, 4130.256553820311, 4318.935215971763, 4341.522432532419, 4377.190219809329, 4398.27428474303, 4288.914221715564, 4298.677599180059, 4301.182775272704, 4303.419038429804, 4309.8707038788725, 4297.828086876521, 4305.892352691177, 4313.309870420733, 4328.285832837578, 4335.761533115678, 3618.6743193112748, 3740.233252183296, 3747.294980783764, 3756.624337566249, 3775.5658099318657, 5403.432639572828, 5411.21537377082, 5435.613918450809, 5454.59090568209, 5458.699771512565, 4934.161192597231, 4970.801167953277, 4978.178600530908, 4980.82567110153, 4991.276264941599, 5604.8318550443555, 5831.591788574801, 5836.949349117157, 5837.357890632027, 5865.58940874139, 4093.4678491795876, 4118.5263694675195, 4124.546299907008, 4141.4409054777825, 4187.706860519765, 6073.362296958844, 6082.300535438437, 6129.295131059941, 6142.6314421134875, 6155.87688246237, 4113.691473139526, 4123.793810309473, 4174.519930208005, 4232.20131444135, 4265.87202383929, 4214.957850421457, 4216.536181020086, 4233.576642335742, 4247.68142389322, 4263.978680106579, 4919.434265059493, 4921.514635109247, 4930.457649658535, 4932.728699921467, 4983.70423689836, 5778.8266352009505, 5920.822375328747, 5929.555283353679, 5952.285725712942, 5990.820275391745, 1460.3355473259642, 1465.6042868425466, 1467.576450842681, 1469.390203065737, 1469.8530146985215, 915.4461550761827, 952.8189643967625, 960.9471479068718, 969.0987381734914, 975.6097560975667, 4927.0, 4980.452150263468, 5007.574356179765, 5052.343195384577, 5088.491150884882, 5232.895342093213, 5249.475052494797, 5285.471452854684, 5300.761465734051, 5361.892762144813, 4956.677815941952, 5028.346314979102, 5068.4424713281505, 5300.390455097636, 5632.352279487829, 3204.5673834032573, 3225.483922572424, 3227.064151396116, 3233.9029829105166, 3238.449463591195, 6126.908096378558, 6303.590266632654, 6315.389575658178, 6343.968280158662, 6346.65173885656, 6078.817635470943, 6081.239845019372, 6084.878302433926, 6101.450869421773, 6151.246894635007, 6180.227471566054, 6192.0711893215475, 6203.100550420164, 6222.719977601018, 6247.2815626202655, 5755.827325180251, 5951.434613711691, 5982.46157845796, 6010.819675409744, 6072.483838873745, 5841.4450627192045, 5879.059350503899, 5905.704714764159, 5945.940540594539, 5965.821025369246, 5971.91042134377, 6181.84545386369, 6186.350433204449, 6217.937820621736, 6228.688565571794, 4111.938320925248, 4212.262854000599, 4249.745015299092, 4269.893252668709, 4273.380359847867, 5974.850628734316, 5989.790357337472, 5998.790042348497, 6035.366286540026, 6062.514998799998, 5708.600397972268, 5821.738021788945, 5860.94139058621, 5863.2670916135485, 5904.232449781501, 5796.42035796417, 5805.970970145122, 5810.912836307543, 5812.18629391877, 5842.6921366061015, 5704.3725190228215, 5731.914021289767, 5765.625234359753, 5779.335376431596, 5807.535397168301, 5574.219609254788, 5801.274840644919, 5819.912701309569, 5831.096180092092, 5840.2115714378015, 5692.402297758676, 5692.857678558069, 5745.166950792028, 5764.616492041796, 5766.481016708516], "value": 4400.800891780548, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.6493318274046, 715.6922523314976, 716.0512321174442, 725.2819708488598, 734.669398770553, 15614.921925390372, 17322.740158897628, 17335.133243337816, 17348.3928062518, 17375.739363909535, 14038.438462461489, 14087.29563521825, 14119.0, 14167.291635418214, 14171.291435428213, 633.6293268437969, 645.6771614192903, 750.1523278695067, 755.746824813688, 759.9854194650121, 778.3150827271993, 780.6331024418542, 782.2607635784186, 782.5930516131608, 783.0251337085336, 819.8319344534356, 823.9917600823975, 824.8020475085996, 825.2737590919982, 831.8835363049178, 813.7640084375524, 822.3749950037954, 824.0235321144463, 827.2058823529419, 829.7510746775973, 610.0726895119438, 610.3713175429315, 610.7282259394572, 610.8167549735061, 611.1535523300261, 14062.437502499888, 14216.715665686732, 14254.216018119, 14256.572302830931, 14266.215358155298, 14913.92543037278, 14975.101493910292, 15142.772858407132, 15374.9231253843, 15579.688406231926, 9934.254930880214, 9947.502624868728, 10123.139533139693, 10129.949350253275, 10308.278420510567, 3843.538775346948, 3847.0, 3868.1683438060672, 3886.727929044968, 4019.8593049243136, 79157.20842791555, 81339.18660813375, 81389.0, 82181.17818821795, 83182.58408707978, 9179.802244416305, 9493.667721629849, 9523.28575356851, 9578.56896439662, 9765.951170244103, 23018.424539386648, 23102.306930792103, 23233.419164520685, 23343.649845252334, 23384.64923026156, 7966.402519810921, 8042.195780421911, 8087.069986951458, 8312.168783121639, 8406.201410865959, 4282.421873047161, 4384.758838263862, 4432.268675668479, 4552.0668263006, 4613.861584152481, 3433.9313213735586, 3493.7554371194283, 3534.3638145134123, 3534.876279330211, 3539.0, 577.7919948818422, 587.7539616014078, 593.1873333533088, 593.483669207792, 603.4478452216173, 502.43552654353186, 594.7502049139372, 594.9647613153169, 602.1690067706537, 627.3068259573106, 8962.417442866194, 9025.41334813235, 9082.727518174466, 9348.345615806827, 9403.57683904226, 633.2337871175837, 673.8517526144241, 675.6554157379674, 688.2944981394111, 695.0929037605872, 4180.728252663567, 4340.392345071693, 4380.277254253013, 4391.538888416734, 4435.512093669694, 121154.0, 123112.0, 123715.0, 125503.0, 126279.0, 62008.379916201164, 64527.35472645213, 65317.0, 102012.0, 108092.45953770181, 90370.0, 91395.54302228446, 91869.99999999866, 92319.0, 97229.5138524317, 7992.240737129963, 8378.53918034514, 8443.915560844558, 8512.276456501268, 8585.570721464026, 52629.0, 52937.0, 53369.0, 53790.041547713685, 55036.0, 49764.0, 78141.0, 81325.59337203276, 82501.17498824935, 85346.57326713327, 11080.61217857371, 11146.721331966766, 11178.428961338775, 11505.654830355103, 11697.473613687234, 13222.933885330513, 13341.0, 13398.330083495592, 13649.795253071014, 14080.718385632024, 12300.0, 12366.938165309115, 12911.418986145834, 13145.145565538209, 13155.342232888126, 12523.686907827378, 12636.294100296342, 13118.380279585046, 13186.934065329995, 13251.403686833923, 11826.763464730486, 12089.879101208875, 12270.141090123963, 12341.197822141532, 12379.690507737017, 9275.907240927774, 9439.669611563562, 9918.454485003394, 10332.896671033193, 10336.793264134825, 8595.0, 9749.951250243987, 9830.262730295113, 10357.9482102589, 10802.16363218239], "value": 7185.495038010632, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1506.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 121.0, 177.0, 129.0, 123.0, 125.0, 126.0, 167.0, 120.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 168.0, 173.0, 162.0, 161.0, 161.0, 163.0, 164.0, 162.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 110.0, 77.0, 77.0, 78.0, 77.0, 105.0, 78.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 105.0, 83.0, 83.0, 82.0, 103.0, 82.0, 81.0, 108.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 119.0, 119.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 148.0, 147.0, 148.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 54.0, 54.0, 52.0, 56.0, 53.0, 53.0, 54.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 60.0, 62.0, 60.0, 60.0, 60.0, 61.0, 61.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 79.0, 79.0, 79.0, 80.0, 79.0, 81.0, 79.0, 79.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 129.0, 129.0, 126.0, 124.0, 125.0, 134.0, 125.0, 172.0, 128.0], "value": 132.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 162.0, 167.0, 168.0, 171.0, 166.0, 170.0, 174.0, 166.0, 165.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 65.0, 66.0, 67.0, 66.0, 65.0, 64.0, 63.0], "value": 65.7, "unit": "score"}]}]} 07:33:34 INFO - Return code: 0 07:33:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:33:34 ERROR - # TBPL SUCCESS # 07:33:34 INFO - Running post-action listener: _resource_record_post_action 07:33:34 INFO - [mozharness: 2016-09-26 14:33:34.495640Z] Finished run-tests step (success) 07:33:34 INFO - Running post-run listener: _resource_record_post_run 07:33:34 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 7868416; Write bytes: 446484480; Read time: 1784; Write time: 364708 07:33:34 INFO - TinderboxPrint: CPU usage
13.4% 07:33:34 INFO - TinderboxPrint: I/O read bytes / time
7,868,416 / 1,784 07:33:34 INFO - TinderboxPrint: I/O write bytes / time
446,484,480 / 364,708 07:33:34 INFO - TinderboxPrint: CPU idle
8,259.2 (86.6%) 07:33:34 INFO - TinderboxPrint: CPU user
1,215.4 (12.7%) 07:33:34 INFO - TinderboxPrint: Swap in / out
0 / 0 07:33:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 76357632; Read time: 0; Write time: 50712 07:33:34 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 5652480; Write bytes: 362139648; Read time: 1576; Write time: 302544 07:33:35 INFO - Running post-run listener: _upload_blobber_files 07:33:35 INFO - Blob upload gear active. 07:33:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:33:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:33:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:33:35 INFO - (blobuploader) - INFO - Open directory for files ... 07:33:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:33:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:33:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:33:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:33:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:33:36 INFO - (blobuploader) - INFO - Done attempting. 07:33:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:33:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:33:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:33:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:33:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:33:37 INFO - (blobuploader) - INFO - Done attempting. 07:33:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:33:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:33:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:33:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:33:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:33:42 INFO - (blobuploader) - INFO - Done attempting. 07:33:42 INFO - (blobuploader) - INFO - Iteration through files over. 07:33:42 INFO - Return code: 0 07:33:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:33:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:33:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf2d6b9b7758b9905b847c17ebeebbd546c487b6dec01751be6140495e32c0241c271af777c0a3e4ede54b1f0bd5815511fc109b0f9c34853397f92103f15e49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d240588bc39107bd03e387ce23dff5449b4eb0edc5afd7ec1769c99836ebaf5361f7eb9a81dd049998341e2bcc14251b16c8ef2e8715fdfef98b3245b88214b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5207162a427fc840af0618ee67cea97d467615708a6363283059cda55b9ae9b6a52a537ee5dd532d6b3093670e3af0aa1f611d0120e18b360f3bee3ba764b77"} 07:33:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:33:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:33:42 INFO - Contents: 07:33:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf2d6b9b7758b9905b847c17ebeebbd546c487b6dec01751be6140495e32c0241c271af777c0a3e4ede54b1f0bd5815511fc109b0f9c34853397f92103f15e49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d240588bc39107bd03e387ce23dff5449b4eb0edc5afd7ec1769c99836ebaf5361f7eb9a81dd049998341e2bcc14251b16c8ef2e8715fdfef98b3245b88214b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5207162a427fc840af0618ee67cea97d467615708a6363283059cda55b9ae9b6a52a537ee5dd532d6b3093670e3af0aa1f611d0120e18b360f3bee3ba764b77"} 07:33:42 INFO - Running post-run listener: copy_logs_to_upload_dir 07:33:42 INFO - Copying logs to upload dir... 07:33:42 INFO - mkdir: /builds/slave/test/build/upload/logs 07:33:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.003011 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-26 07:33:42.032539) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 07:33:42.036569) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf2d6b9b7758b9905b847c17ebeebbd546c487b6dec01751be6140495e32c0241c271af777c0a3e4ede54b1f0bd5815511fc109b0f9c34853397f92103f15e49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d240588bc39107bd03e387ce23dff5449b4eb0edc5afd7ec1769c99836ebaf5361f7eb9a81dd049998341e2bcc14251b16c8ef2e8715fdfef98b3245b88214b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5207162a427fc840af0618ee67cea97d467615708a6363283059cda55b9ae9b6a52a537ee5dd532d6b3093670e3af0aa1f611d0120e18b360f3bee3ba764b77"} build_url:https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011391 build_url: 'https://queue.taskcluster.net/v1/task/LutVPGNLRsKpDdFMIYk0ow/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cf2d6b9b7758b9905b847c17ebeebbd546c487b6dec01751be6140495e32c0241c271af777c0a3e4ede54b1f0bd5815511fc109b0f9c34853397f92103f15e49", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d240588bc39107bd03e387ce23dff5449b4eb0edc5afd7ec1769c99836ebaf5361f7eb9a81dd049998341e2bcc14251b16c8ef2e8715fdfef98b3245b88214b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5207162a427fc840af0618ee67cea97d467615708a6363283059cda55b9ae9b6a52a537ee5dd532d6b3093670e3af0aa1f611d0120e18b360f3bee3ba764b77"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-26 07:33:42.062385) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 07:33:42.062752) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1474898972.942467-825179617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004388 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-26 07:33:42.144255) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 07:33:42.144603) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-26 07:33:42.144919) ========= ========= Total master_lag: 0.19 =========