builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-055 starttime: 1474582940.21 results: success (0) buildid: 20160922123015 builduid: e595c438c6e140feaf6479be3bd18c17 revision: 46645a6bb7dc88603beb3ce3e55fd63a1d2fc75b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 15:22:20.206008) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 15:22:20.206512) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 15:22:20.206798) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 15:22:20.225478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 15:22:20.225839) ========= 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=bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-22 15:22:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 229M=0s 2016-09-22 15:22:20 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136080 ========= master_lag: 0.25 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 15:22:20.613901) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 15:22:20.614278) ========= 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=bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014106 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 15:22:20.646476) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 15:22:20.646830) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 46645a6bb7dc88603beb3ce3e55fd63a1d2fc75b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 46645a6bb7dc88603beb3ce3e55fd63a1d2fc75b --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=bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-22 15:22:20,887 truncating revision to first 12 chars 2016-09-22 15:22:20,887 Setting DEBUG logging. 2016-09-22 15:22:20,887 attempt 1/10 2016-09-22 15:22:20,887 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/46645a6bb7dc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 15:22:21,192 unpacking tar archive at: fx-team-46645a6bb7dc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.657957 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 15:22:21.322385) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 15:22:21.322661) ========= script_repo_revision: 46645a6bb7dc88603beb3ce3e55fd63a1d2fc75b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 15:22:21.323061) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 15:22:21.323346) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 15:22:21.334568) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-09-22 15:22:21.334886) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:22:21 INFO - MultiFileLogger online at 20160922 15:22:21 in /builds/slave/test 15:22:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:22:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:22:21 INFO - {'append_to_log': False, 15:22:21 INFO - 'base_work_dir': '/builds/slave/test', 15:22:21 INFO - 'blob_upload_branch': 'Fx-Team', 15:22:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:22:21 INFO - 'branch': 'Fx-Team', 15:22:21 INFO - 'buildbot_json_path': 'buildprops.json', 15:22:21 INFO - 'config_files': ('talos/linux_config.py',), 15:22:21 INFO - 'default_actions': ('clobber', 15:22:21 INFO - 'read-buildbot-config', 15:22:21 INFO - 'download-and-extract', 15:22:21 INFO - 'populate-webroot', 15:22:21 INFO - 'create-virtualenv', 15:22:21 INFO - 'install', 15:22:21 INFO - 'run-tests'), 15:22:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:22:21 INFO - 'download_minidump_stackwalk': True, 15:22:21 INFO - 'download_symbols': 'ondemand', 15:22:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:22:21 INFO - 'tooltool.py': '/tools/tooltool.py', 15:22:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:22:21 INFO - '/tools/misc-python/virtualenv.py')}, 15:22:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:22:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:22:21 INFO - 'installer_path': 'installer.exe', 15:22:21 INFO - 'log_level': 'info', 15:22:21 INFO - 'log_name': 'talos', 15:22:21 INFO - 'log_to_console': True, 15:22:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:22:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:22:21 INFO - 'opt_config_files': (), 15:22:21 INFO - 'pip_index': False, 15:22:21 INFO - 'sps_profile': False, 15:22:21 INFO - 'sps_profile_interval': 0, 15:22:21 INFO - 'suite': 'dromaeojs', 15:22:21 INFO - 'system_bits': '32', 15:22:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:22:21 INFO - 'title': 'talos-linux64-ix-055', 15:22:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:22:21 INFO - 'use_talos_json': True, 15:22:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:22:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:22:21 INFO - 'work_dir': 'build'} 15:22:21 INFO - [mozharness: 2016-09-22 22:22:21.665521Z] Running clobber step. 15:22:21 INFO - Running pre-action listener: _resource_record_pre_action 15:22:21 INFO - Running main action method: clobber 15:22:21 INFO - rmtree: /builds/slave/test/build 15:22:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:22:22 INFO - Running post-action listener: _resource_record_post_action 15:22:22 INFO - [mozharness: 2016-09-22 22:22:22.120941Z] Finished clobber step (success) 15:22:22 INFO - [mozharness: 2016-09-22 22:22:22.121043Z] Running read-buildbot-config step. 15:22:22 INFO - Running pre-action listener: _resource_record_pre_action 15:22:22 INFO - Running main action method: read_buildbot_config 15:22:22 INFO - Using buildbot properties: 15:22:22 INFO - { 15:22:22 INFO - "project": "", 15:22:22 INFO - "product": "firefox", 15:22:22 INFO - "script_repo_revision": "production", 15:22:22 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:22:22 INFO - "repository": "", 15:22:22 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 15:22:22 INFO - "buildid": "20160922123015", 15:22:22 INFO - "pgo_build": "True", 15:22:22 INFO - "basedir": "/builds/slave/test", 15:22:22 INFO - "buildnumber": 473, 15:22:22 INFO - "slavename": "talos-linux64-ix-055", 15:22:22 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:22:22 INFO - "platform": "ubuntu64_hw", 15:22:22 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 15:22:22 INFO - "branch": "fx-team", 15:22:22 INFO - "repo_path": "integration/fx-team", 15:22:22 INFO - "revision": "46645a6bb7dc88603beb3ce3e55fd63a1d2fc75b", 15:22:22 INFO - "stage_platform": "linux64-pgo", 15:22:22 INFO - "builduid": "e595c438c6e140feaf6479be3bd18c17", 15:22:22 INFO - "slavebuilddir": "test" 15:22:22 INFO - } 15:22:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:22:22 INFO - Running post-action listener: _resource_record_post_action 15:22:22 INFO - [mozharness: 2016-09-22 22:22:22.123512Z] Finished read-buildbot-config step (success) 15:22:22 INFO - [mozharness: 2016-09-22 22:22:22.123602Z] Running download-and-extract step. 15:22:22 INFO - Running pre-action listener: _resource_record_pre_action 15:22:22 INFO - Running main action method: download_and_extract 15:22:22 INFO - mkdir: /builds/slave/test/build/tests 15:22: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')]} 15:22:22 INFO - trying https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:22:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/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 15:22:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/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 15:22:22 INFO - Downloaded 1361 bytes. 15:22:22 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:22:22 INFO - Using the following test package requirements: 15:22:22 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:22:22 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:22:22 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:22:22 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:22 INFO - u'jsshell-linux-x86_64.zip'], 15:22:22 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:22:22 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:22:22 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:22:22 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:22:22 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:22:22 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:22:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:22:22 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:22:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:22:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:22:22 INFO - Fetch https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:22:23 INFO - Expected file size: 21944119 15:22:27 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 15:22:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:22:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:22:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:22:28 INFO - Expected file size: 21944119 15:22:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:22:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:22:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:22:33 INFO - Expected file size: 14414059 15:22: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')]} 15:22:33 INFO - trying https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:22:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/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 15:22:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/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 15:22:35 INFO - Downloaded 59645904 bytes. 15:22:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:22:35 INFO - mkdir: /builds/slave/test/properties 15:22:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:22:35 INFO - Writing to file /builds/slave/test/properties/build_url 15:22:35 INFO - Contents: 15:22:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:22:35 INFO - Running post-action listener: _resource_record_post_action 15:22:35 INFO - Running post-action listener: set_extra_try_arguments 15:22:35 INFO - [mozharness: 2016-09-22 22:22:35.837362Z] Finished download-and-extract step (success) 15:22:35 INFO - [mozharness: 2016-09-22 22:22:35.837593Z] Running populate-webroot step. 15:22:35 INFO - Running pre-action listener: _resource_record_pre_action 15:22:35 INFO - Running main action method: populate_webroot 15:22:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:22:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:22:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:22:35 INFO - '--tppagecycles', 15:22:35 INFO - '7'], 15:22:35 INFO - 'tests': ['tsvgm']}}, 15:22:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:22:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:22:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:22:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:22:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:22:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:22:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:35 INFO - 'talos_options': ['--disable-e10s'], 15:22:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:22:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:22:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:35 INFO - 'talos_options': ['--disable-e10s'], 15:22:35 INFO - 'tests': ['damp', 'tps']}, 15:22:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:35 INFO - 'tests': ['damp', 'tps']}, 15:22:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:22:35 INFO - 'tests': ['dromaeo_dom']}, 15:22:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:22:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:22:35 INFO - 'tests': ['basic_compositor_video']}, 15:22:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:22:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:22:35 INFO - 'tests': ['a11yr', 15:22:35 INFO - 'ts_paint', 15:22:35 INFO - 'tpaint', 15:22:35 INFO - 'sessionrestore', 15:22:35 INFO - 'sessionrestore_no_auto_restore', 15:22:35 INFO - 'tabpaint']}, 15:22:35 INFO - 'other-e10s': {'tests': ['a11yr', 15:22:35 INFO - 'ts_paint', 15:22:35 INFO - 'tpaint', 15:22:35 INFO - 'sessionrestore', 15:22:35 INFO - 'sessionrestore_no_auto_restore', 15:22:35 INFO - 'tabpaint']}, 15:22:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:22:35 INFO - 'ts_paint', 15:22:35 INFO - 'tpaint', 15:22:35 INFO - 'sessionrestore', 15:22:35 INFO - 'sessionrestore_no_auto_restore', 15:22:35 INFO - 'tabpaint']}, 15:22:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:22:35 INFO - 'ts_paint', 15:22:35 INFO - 'tpaint', 15:22:35 INFO - 'sessionrestore', 15:22:35 INFO - 'sessionrestore_no_auto_restore', 15:22:35 INFO - 'tabpaint']}, 15:22:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:22:35 INFO - 'tests': ['a11yr', 15:22:35 INFO - 'ts_paint', 15:22:35 INFO - 'tpaint', 15:22:35 INFO - 'sessionrestore', 15:22:35 INFO - 'sessionrestore_no_auto_restore', 15:22:35 INFO - 'tabpaint']}, 15:22:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:22:35 INFO - 'tests': ['a11yr', 15:22:35 INFO - 'ts_paint', 15:22:35 INFO - 'tpaint', 15:22:35 INFO - 'sessionrestore', 15:22:35 INFO - 'sessionrestore_no_auto_restore', 15:22:35 INFO - 'tabpaint']}, 15:22:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:22:35 INFO - 'tests': ['tsvgx', 15:22:35 INFO - 'tsvgr_opacity', 15:22:35 INFO - 'tart', 15:22:35 INFO - 'tscrollx', 15:22:35 INFO - 'cart']}, 15:22:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:22:35 INFO - 'tsvgr_opacity', 15:22:35 INFO - 'tart', 15:22:35 INFO - 'tscrollx', 15:22:35 INFO - 'cart']}, 15:22:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:35 INFO - 'talos_options': ['--disable-e10s'], 15:22:35 INFO - 'tests': ['tp5o']}, 15:22:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:35 INFO - 'tests': ['tp5o']}, 15:22:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:35 INFO - 'talos_options': ['--disable-e10s', 15:22:35 INFO - '--xperf_path', 15:22:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:22:35 INFO - 'tests': ['tp5n']}, 15:22:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:22:35 INFO - 'talos_options': ['--xperf_path', 15:22:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:22:35 INFO - 'tests': ['tp5n']}}, 15:22:35 INFO - 'talos.zip': {'path': '', 15:22:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:22:35 INFO - Running post-action listener: _resource_record_post_action 15:22:35 INFO - [mozharness: 2016-09-22 22:22:35.855853Z] Finished populate-webroot step (success) 15:22:35 INFO - [mozharness: 2016-09-22 22:22:35.855942Z] Running create-virtualenv step. 15:22:35 INFO - Running pre-action listener: _resource_record_pre_action 15:22:35 INFO - Running main action method: create_virtualenv 15:22:35 INFO - Creating virtualenv /builds/slave/test/build/venv 15:22:35 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:22:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:22:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:22:35 INFO - Using real prefix '/usr' 15:22:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:22:36 INFO - Installing distribute.............................................................................................................................................................................................done. 15:22:38 INFO - Installing pip.................done. 15:22:38 INFO - Return code: 0 15:22:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:22: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')]} 15:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22: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')]} 15:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1ce61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe790>, '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 0x14ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffb20>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', '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 15:22: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', 'pip>=1.5'] in /builds/slave/test/build 15:22: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 pip>=1.5 15:22:38 INFO - Using env: {'DISPLAY': ':0', 15:22:38 INFO - 'HOME': '/home/cltbld', 15:22:38 INFO - 'LANG': 'en_US.UTF-8', 15:22:38 INFO - 'LANGUAGE': 'en_US:en', 15:22:38 INFO - 'LOGNAME': 'cltbld', 15:22:38 INFO - 'MAIL': '/var/mail/cltbld', 15:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:38 INFO - 'MOZ_NO_REMOTE': '1', 15:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:38 INFO - 'NO_EM_RESTART': '1', 15:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:38 INFO - 'PWD': '/builds/slave/test', 15:22:38 INFO - 'SHELL': '/bin/bash', 15:22:38 INFO - 'SHLVL': '1', 15:22:38 INFO - 'TERM': 'linux', 15:22:38 INFO - 'TMOUT': '86400', 15:22:38 INFO - 'USER': 'cltbld', 15:22:38 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', 15:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:38 INFO - '_': '/tools/buildbot/bin/python'} 15:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:22:38 INFO - Cleaning up... 15:22:38 INFO - Return code: 0 15:22:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:22: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')]} 15:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22: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')]} 15:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22: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', '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 0x7fdf1ce61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe790>, '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 0x14ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffb20>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', '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 15:22: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:22: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 psutil>=3.1.1 15:22:38 INFO - Using env: {'DISPLAY': ':0', 15:22:38 INFO - 'HOME': '/home/cltbld', 15:22:38 INFO - 'LANG': 'en_US.UTF-8', 15:22:38 INFO - 'LANGUAGE': 'en_US:en', 15:22:38 INFO - 'LOGNAME': 'cltbld', 15:22:38 INFO - 'MAIL': '/var/mail/cltbld', 15:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:38 INFO - 'MOZ_NO_REMOTE': '1', 15:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:38 INFO - 'NO_EM_RESTART': '1', 15:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:38 INFO - 'PWD': '/builds/slave/test', 15:22:38 INFO - 'SHELL': '/bin/bash', 15:22:38 INFO - 'SHLVL': '1', 15:22:38 INFO - 'TERM': 'linux', 15:22:38 INFO - 'TMOUT': '86400', 15:22:38 INFO - 'USER': 'cltbld', 15:22:38 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', 15:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:38 INFO - '_': '/tools/buildbot/bin/python'} 15:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:38 INFO - Downloading/unpacking psutil>=3.1.1 15:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:22:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:22:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:22:40 INFO - Installing collected packages: psutil 15:22:40 INFO - Running setup.py install for psutil 15:22:40 INFO - building 'psutil._psutil_linux' extension 15:22:40 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 15:22:41 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 15:22:41 INFO - building 'psutil._psutil_posix' extension 15:22:41 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 15:22:41 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 15:22:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:22:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:22:41 INFO - Successfully installed psutil 15:22:41 INFO - Cleaning up... 15:22:41 INFO - Return code: 0 15:22:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf1ce61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe790>, '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 0x14ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffb20>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', '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 15:22:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:22:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:22:41 INFO - Using env: {'DISPLAY': ':0', 15:22:41 INFO - 'HOME': '/home/cltbld', 15:22:41 INFO - 'LANG': 'en_US.UTF-8', 15:22:41 INFO - 'LANGUAGE': 'en_US:en', 15:22:41 INFO - 'LOGNAME': 'cltbld', 15:22:41 INFO - 'MAIL': '/var/mail/cltbld', 15:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:41 INFO - 'MOZ_NO_REMOTE': '1', 15:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:41 INFO - 'NO_EM_RESTART': '1', 15:22:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:41 INFO - 'PWD': '/builds/slave/test', 15:22:41 INFO - 'SHELL': '/bin/bash', 15:22:41 INFO - 'SHLVL': '1', 15:22:41 INFO - 'TERM': 'linux', 15:22:41 INFO - 'TMOUT': '86400', 15:22:41 INFO - 'USER': 'cltbld', 15:22:41 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', 15:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:41 INFO - '_': '/tools/buildbot/bin/python'} 15:22:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:22:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:22:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:22:43 INFO - Installing collected packages: mozsystemmonitor 15:22:43 INFO - Running setup.py install for mozsystemmonitor 15:22:43 INFO - Successfully installed mozsystemmonitor 15:22:43 INFO - Cleaning up... 15:22:43 INFO - Return code: 0 15:22:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:22:43 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')]} 15:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:43 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')]} 15:22:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:43 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 0x7fdf1ce61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe790>, '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 0x14ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffb20>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', '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 15:22:43 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 15:22:43 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 15:22:43 INFO - Using env: {'DISPLAY': ':0', 15:22:43 INFO - 'HOME': '/home/cltbld', 15:22:43 INFO - 'LANG': 'en_US.UTF-8', 15:22:43 INFO - 'LANGUAGE': 'en_US:en', 15:22:43 INFO - 'LOGNAME': 'cltbld', 15:22:43 INFO - 'MAIL': '/var/mail/cltbld', 15:22:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:43 INFO - 'MOZ_NO_REMOTE': '1', 15:22:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:43 INFO - 'NO_EM_RESTART': '1', 15:22:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:43 INFO - 'PWD': '/builds/slave/test', 15:22:43 INFO - 'SHELL': '/bin/bash', 15:22:43 INFO - 'SHLVL': '1', 15:22:43 INFO - 'TERM': 'linux', 15:22:43 INFO - 'TMOUT': '86400', 15:22:43 INFO - 'USER': 'cltbld', 15:22:43 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', 15:22:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:43 INFO - '_': '/tools/buildbot/bin/python'} 15:22:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:43 INFO - Downloading/unpacking jsonschema==2.5.1 15:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:22:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:46 INFO - Downloading functools32-3.2.3-2.tar.gz 15:22:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:22:46 INFO - warning: no files found matching '*.txt' 15:22:46 INFO - no previously-included directories found matching 'build' 15:22:46 INFO - no previously-included directories found matching 'dist' 15:22:46 INFO - no previously-included directories found matching '.git*' 15:22:46 INFO - Installing collected packages: jsonschema, functools32 15:22:46 INFO - Running setup.py install for functools32 15:22:46 INFO - warning: no files found matching '*.txt' 15:22:46 INFO - no previously-included directories found matching 'build' 15:22:46 INFO - no previously-included directories found matching 'dist' 15:22:46 INFO - no previously-included directories found matching '.git*' 15:22:46 INFO - Successfully installed jsonschema functools32 15:22:46 INFO - Cleaning up... 15:22:46 INFO - Return code: 0 15:22:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdf1ce61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe790>, '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 0x14ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffb20>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', '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 15:22:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:22:46 INFO - Using env: {'DISPLAY': ':0', 15:22:46 INFO - 'HOME': '/home/cltbld', 15:22:46 INFO - 'LANG': 'en_US.UTF-8', 15:22:46 INFO - 'LANGUAGE': 'en_US:en', 15:22:46 INFO - 'LOGNAME': 'cltbld', 15:22:46 INFO - 'MAIL': '/var/mail/cltbld', 15:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:46 INFO - 'MOZ_NO_REMOTE': '1', 15:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:46 INFO - 'NO_EM_RESTART': '1', 15:22:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:46 INFO - 'PWD': '/builds/slave/test', 15:22:46 INFO - 'SHELL': '/bin/bash', 15:22:46 INFO - 'SHLVL': '1', 15:22:46 INFO - 'TERM': 'linux', 15:22:46 INFO - 'TMOUT': '86400', 15:22:46 INFO - 'USER': 'cltbld', 15:22:46 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', 15:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:46 INFO - '_': '/tools/buildbot/bin/python'} 15:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:22:46 INFO - Cleaning up... 15:22:46 INFO - Return code: 0 15:22:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdf1ce61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe790>, '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 0x14ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffb20>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', '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 15:22:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:22:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:22:46 INFO - Using env: {'DISPLAY': ':0', 15:22:46 INFO - 'HOME': '/home/cltbld', 15:22:46 INFO - 'LANG': 'en_US.UTF-8', 15:22:46 INFO - 'LANGUAGE': 'en_US:en', 15:22:46 INFO - 'LOGNAME': 'cltbld', 15:22:46 INFO - 'MAIL': '/var/mail/cltbld', 15:22:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:46 INFO - 'MOZ_NO_REMOTE': '1', 15:22:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:46 INFO - 'NO_EM_RESTART': '1', 15:22:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:46 INFO - 'PWD': '/builds/slave/test', 15:22:46 INFO - 'SHELL': '/bin/bash', 15:22:46 INFO - 'SHLVL': '1', 15:22:46 INFO - 'TERM': 'linux', 15:22:46 INFO - 'TMOUT': '86400', 15:22:46 INFO - 'USER': 'cltbld', 15:22:46 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', 15:22:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:46 INFO - '_': '/tools/buildbot/bin/python'} 15:22:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:46 INFO - Downloading/unpacking blobuploader==1.2.4 15:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:48 INFO - Downloading blobuploader-1.2.4.tar.gz 15:22:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:22:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:22:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:49 INFO - Downloading docopt-0.6.1.tar.gz 15:22:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:22:49 INFO - Installing collected packages: blobuploader, requests, docopt 15:22:49 INFO - Running setup.py install for blobuploader 15:22:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:22:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:22:49 INFO - Running setup.py install for requests 15:22:49 INFO - Running setup.py install for docopt 15:22:49 INFO - Successfully installed blobuploader requests docopt 15:22:49 INFO - Cleaning up... 15:22:49 INFO - Return code: 0 15:22:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:49 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 0x7fdf1ce61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe790>, '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 0x14ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffb20>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', '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 15:22:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:22:49 INFO - Using env: {'DISPLAY': ':0', 15:22:49 INFO - 'HOME': '/home/cltbld', 15:22:49 INFO - 'LANG': 'en_US.UTF-8', 15:22:49 INFO - 'LANGUAGE': 'en_US:en', 15:22:49 INFO - 'LOGNAME': 'cltbld', 15:22:49 INFO - 'MAIL': '/var/mail/cltbld', 15:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:49 INFO - 'MOZ_NO_REMOTE': '1', 15:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:49 INFO - 'NO_EM_RESTART': '1', 15:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:49 INFO - 'PWD': '/builds/slave/test', 15:22:49 INFO - 'SHELL': '/bin/bash', 15:22:49 INFO - 'SHLVL': '1', 15:22:49 INFO - 'TERM': 'linux', 15:22:49 INFO - 'TMOUT': '86400', 15:22:49 INFO - 'USER': 'cltbld', 15:22:49 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', 15:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:49 INFO - '_': '/tools/buildbot/bin/python'} 15:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:22:50 INFO - Running setup.py (path:/tmp/pip-bitwFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:22:50 INFO - Running setup.py (path:/tmp/pip-EmPRCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:22:50 INFO - Running setup.py (path:/tmp/pip-JAxfHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:22:50 INFO - Running setup.py (path:/tmp/pip-1R6eQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:22:50 INFO - Running setup.py (path:/tmp/pip-yDpjxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:22:50 INFO - Running setup.py (path:/tmp/pip-O_4Tph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:22:50 INFO - Running setup.py (path:/tmp/pip-H3Erni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:22:50 INFO - Running setup.py (path:/tmp/pip-Kg8aTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:22:50 INFO - Running setup.py (path:/tmp/pip-RfgWkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:22:50 INFO - Running setup.py (path:/tmp/pip-a5bzlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:22:50 INFO - Running setup.py (path:/tmp/pip-tOB5hV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:22:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:22:51 INFO - Running setup.py (path:/tmp/pip-bpQEX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:22:51 INFO - Running setup.py (path:/tmp/pip-Tj0lD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:22:51 INFO - Running setup.py (path:/tmp/pip-aLpV1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:51 INFO - Running setup.py (path:/tmp/pip-jW0Htg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:22:51 INFO - Running setup.py (path:/tmp/pip-fVxzLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:22:51 INFO - Running setup.py (path:/tmp/pip-jgWyEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:22:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:22:51 INFO - Running setup.py install for manifestparser 15:22:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:22:51 INFO - Running setup.py install for mozcrash 15:22:51 INFO - Running setup.py install for mozdebug 15:22:51 INFO - Running setup.py install for mozdevice 15:22:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:22:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:22:51 INFO - Running setup.py install for mozfile 15:22:51 INFO - Running setup.py install for mozhttpd 15:22:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:22:52 INFO - Running setup.py install for mozinfo 15:22:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:22:52 INFO - Running setup.py install for mozInstall 15:22:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:22:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:22:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:22:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:22:52 INFO - Running setup.py install for mozleak 15:22:52 INFO - Running setup.py install for mozlog 15:22:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:22:52 INFO - Running setup.py install for moznetwork 15:22:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:22:52 INFO - Running setup.py install for mozprocess 15:22:52 INFO - Running setup.py install for mozprofile 15:22:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:22:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:22:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:22:52 INFO - Running setup.py install for mozrunner 15:22:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:22:52 INFO - Running setup.py install for mozscreenshot 15:22:53 INFO - Running setup.py install for moztest 15:22:53 INFO - Running setup.py install for mozversion 15:22:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:22:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:22:53 INFO - Cleaning up... 15:22:53 INFO - Return code: 0 15:22:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:53 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 0x7fdf1ce61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe790>, '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 0x14ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffb20>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', '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 15:22:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:22:53 INFO - Using env: {'DISPLAY': ':0', 15:22:53 INFO - 'HOME': '/home/cltbld', 15:22:53 INFO - 'LANG': 'en_US.UTF-8', 15:22:53 INFO - 'LANGUAGE': 'en_US:en', 15:22:53 INFO - 'LOGNAME': 'cltbld', 15:22:53 INFO - 'MAIL': '/var/mail/cltbld', 15:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:53 INFO - 'MOZ_NO_REMOTE': '1', 15:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:53 INFO - 'NO_EM_RESTART': '1', 15:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:53 INFO - 'PWD': '/builds/slave/test', 15:22:53 INFO - 'SHELL': '/bin/bash', 15:22:53 INFO - 'SHLVL': '1', 15:22:53 INFO - 'TERM': 'linux', 15:22:53 INFO - 'TMOUT': '86400', 15:22:53 INFO - 'USER': 'cltbld', 15:22:53 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', 15:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:53 INFO - '_': '/tools/buildbot/bin/python'} 15:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:22:53 INFO - Running setup.py (path:/tmp/pip-lkRdyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:22:53 INFO - Running setup.py (path:/tmp/pip-9TqIC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:22:53 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)) 15:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:22:53 INFO - Running setup.py (path:/tmp/pip-ampTwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:22:53 INFO - Running setup.py (path:/tmp/pip-UUbwoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:22:53 INFO - Running setup.py (path:/tmp/pip-_tpEFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:22:53 INFO - Running setup.py (path:/tmp/pip-RMIdvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:22:53 INFO - Running setup.py (path:/tmp/pip-DrNXWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:22:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:22:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:22:53 INFO - Running setup.py (path:/tmp/pip-b5Zfjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:22:54 INFO - Running setup.py (path:/tmp/pip-IeGnso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:22:54 INFO - Running setup.py (path:/tmp/pip-uxHP2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:22:54 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)) 15:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:22:54 INFO - Running setup.py (path:/tmp/pip-n2KHHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:22:54 INFO - Running setup.py (path:/tmp/pip-5oPTtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:22:54 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)) 15:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:22:54 INFO - Running setup.py (path:/tmp/pip-4pDOg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:22:54 INFO - Running setup.py (path:/tmp/pip-rftBlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:22:54 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)) 15:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:54 INFO - Running setup.py (path:/tmp/pip-WboyTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:22:54 INFO - Running setup.py (path:/tmp/pip-conWNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:22:54 INFO - Running setup.py (path:/tmp/pip-0C1nUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:22:54 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)) 15:22:54 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)) 15:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:22:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:22:56 INFO - Downloading blessings-1.6.tar.gz 15:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:22:56 INFO - Installing collected packages: blessings 15:22:56 INFO - Running setup.py install for blessings 15:22:56 INFO - Successfully installed blessings 15:22:56 INFO - Cleaning up... 15:22:56 INFO - Return code: 0 15:22:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:22:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:22:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:22:57 INFO - Reading from file tmpfile_stdout 15:22:57 INFO - Current package versions: 15:22:57 INFO - argparse == 1.2.1 15:22:57 INFO - blessings == 1.6 15:22:57 INFO - blobuploader == 1.2.4 15:22:57 INFO - docopt == 0.6.1 15:22:57 INFO - functools32 == 3.2.3-2 15:22:57 INFO - jsonschema == 2.5.1 15:22:57 INFO - manifestparser == 1.1 15:22:57 INFO - mozInstall == 1.12 15:22:57 INFO - mozcrash == 0.17 15:22:57 INFO - mozdebug == 0.1 15:22:57 INFO - mozdevice == 0.48 15:22:57 INFO - mozfile == 1.2 15:22:57 INFO - mozhttpd == 0.7 15:22:57 INFO - mozinfo == 0.9 15:22:57 INFO - mozleak == 0.1 15:22:57 INFO - mozlog == 3.4 15:22:57 INFO - moznetwork == 0.27 15:22:57 INFO - mozprocess == 0.23 15:22:57 INFO - mozprofile == 0.28 15:22:57 INFO - mozrunner == 6.12 15:22:57 INFO - mozscreenshot == 0.1 15:22:57 INFO - mozsystemmonitor == 0.3 15:22:57 INFO - moztest == 0.7 15:22:57 INFO - mozversion == 1.4 15:22:57 INFO - psutil == 3.1.1 15:22:57 INFO - requests == 1.2.3 15:22:57 INFO - wsgiref == 0.1.2 15:22:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:22:57 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')]} 15:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:57 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')]} 15:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:57 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 0x7fdf1ce61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe790>, '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 0x14ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffb20>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', '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 15:22:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:22:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:22:57 INFO - Using env: {'DISPLAY': ':0', 15:22:57 INFO - 'HOME': '/home/cltbld', 15:22:57 INFO - 'LANG': 'en_US.UTF-8', 15:22:57 INFO - 'LANGUAGE': 'en_US:en', 15:22:57 INFO - 'LOGNAME': 'cltbld', 15:22:57 INFO - 'MAIL': '/var/mail/cltbld', 15:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:57 INFO - 'MOZ_NO_REMOTE': '1', 15:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:57 INFO - 'NO_EM_RESTART': '1', 15:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:57 INFO - 'PWD': '/builds/slave/test', 15:22:57 INFO - 'SHELL': '/bin/bash', 15:22:57 INFO - 'SHLVL': '1', 15:22:57 INFO - 'TERM': 'linux', 15:22:57 INFO - 'TMOUT': '86400', 15:22:57 INFO - 'USER': 'cltbld', 15:22:57 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', 15:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:57 INFO - '_': '/tools/buildbot/bin/python'} 15:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:22:57 INFO - Cleaning up... 15:22:57 INFO - Return code: 0 15:22:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:22:57 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')]} 15:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:57 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')]} 15:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:22:57 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 0x7fdf1ce61f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x146f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14fe790>, '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 0x14ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffb20>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', '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 15:22:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:22:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:22:57 INFO - Using env: {'DISPLAY': ':0', 15:22:57 INFO - 'HOME': '/home/cltbld', 15:22:57 INFO - 'LANG': 'en_US.UTF-8', 15:22:57 INFO - 'LANGUAGE': 'en_US:en', 15:22:57 INFO - 'LOGNAME': 'cltbld', 15:22:57 INFO - 'MAIL': '/var/mail/cltbld', 15:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:22:57 INFO - 'MOZ_NO_REMOTE': '1', 15:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:22:57 INFO - 'NO_EM_RESTART': '1', 15:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:22:57 INFO - 'PWD': '/builds/slave/test', 15:22:57 INFO - 'SHELL': '/bin/bash', 15:22:57 INFO - 'SHLVL': '1', 15:22:57 INFO - 'TERM': 'linux', 15:22:57 INFO - 'TMOUT': '86400', 15:22:57 INFO - 'USER': 'cltbld', 15:22:57 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', 15:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:22:57 INFO - '_': '/tools/buildbot/bin/python'} 15:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:22:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:22:57 INFO - Cleaning up... 15:22:57 INFO - Return code: 0 15:22:57 INFO - Running post-action listener: _resource_record_post_action 15:22:57 INFO - Running post-action listener: _start_resource_monitoring 15:22:57 INFO - Starting resource monitoring. 15:22:57 INFO - [mozharness: 2016-09-22 22:22:57.550139Z] Finished create-virtualenv step (success) 15:22:57 INFO - [mozharness: 2016-09-22 22:22:57.550608Z] Running install step. 15:22:57 INFO - Running pre-action listener: _resource_record_pre_action 15:22:57 INFO - Running main action method: install 15:22:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:22:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:22:57 INFO - Reading from file tmpfile_stdout 15:22:57 INFO - Detecting whether we're running mozinstall >=1.0... 15:22:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:22:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:22:57 INFO - Reading from file tmpfile_stdout 15:22:57 INFO - Output received: 15:22:57 INFO - Usage: mozinstall [options] installer 15:22:57 INFO - Options: 15:22:57 INFO - -h, --help show this help message and exit 15:22:57 INFO - -d DEST, --destination=DEST 15:22:57 INFO - Directory to install application into. [default: 15:22:57 INFO - "/builds/slave/test"] 15:22:57 INFO - --app=APP Application being installed. [default: firefox] 15:22:57 INFO - mkdir: /builds/slave/test/build/application 15:22:57 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'] 15:22:57 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 15:23:14 INFO - Reading from file tmpfile_stdout 15:23:14 INFO - Output received: 15:23:14 INFO - /builds/slave/test/build/application/firefox/firefox 15:23:14 INFO - Running post-action listener: _resource_record_post_action 15:23:14 INFO - [mozharness: 2016-09-22 22:23:14.804257Z] Finished install step (success) 15:23:14 INFO - [mozharness: 2016-09-22 22:23:14.804504Z] Running run-tests step. 15:23:14 INFO - Running pre-action listener: _resource_record_pre_action 15:23:14 INFO - Running main action method: run_tests 15:23:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:23:14 INFO - Python 2.7.3 15:23:14 INFO - Return code: 0 15:23:14 INFO - grabbing minidump binary from tooltool 15:23:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:14 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 0x14fe790>, '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 0x14ff690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ffb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:23:14 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 15:23:14 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 15:23:14 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 15:23:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:23:14 INFO - Return code: 0 15:23:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:23:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:23:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:23:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:23:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:23:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:23:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:23:14 INFO - Using env: {'DISPLAY': ':0', 15:23:14 INFO - 'HOME': '/home/cltbld', 15:23:14 INFO - 'LANG': 'en_US.UTF-8', 15:23:14 INFO - 'LANGUAGE': 'en_US:en', 15:23:14 INFO - 'LOGNAME': 'cltbld', 15:23:14 INFO - 'MAIL': '/var/mail/cltbld', 15:23:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:23:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:14 INFO - 'MOZ_NO_REMOTE': '1', 15:23:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:23:14 INFO - 'NO_EM_RESTART': '1', 15:23:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:14 INFO - 'PWD': '/builds/slave/test', 15:23:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:23:14 INFO - 'SHELL': '/bin/bash', 15:23:14 INFO - 'SHLVL': '1', 15:23:14 INFO - 'TERM': 'linux', 15:23:14 INFO - 'TMOUT': '86400', 15:23:14 INFO - 'USER': 'cltbld', 15:23:14 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517', 15:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:14 INFO - '_': '/tools/buildbot/bin/python'} 15:23:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:23:15 INFO - mozversion application_buildid: 20160922123015 15:23:15 INFO - mozversion application_changeset: 46645a6bb7dc88603beb3ce3e55fd63a1d2fc75b 15:23:15 INFO - mozversion application_display_name: Nightly 15:23:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:23:15 INFO - mozversion application_name: Firefox 15:23:15 INFO - mozversion application_remotingname: firefox 15:23:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:23:15 INFO - mozversion application_vendor: Mozilla 15:23:15 INFO - mozversion application_version: 52.0a1 15:23:15 INFO - mozversion platform_buildid: 20160922123015 15:23:15 INFO - mozversion platform_changeset: 46645a6bb7dc88603beb3ce3e55fd63a1d2fc75b 15:23:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:23:15 INFO - mozversion platform_version: 52.0a1 15:23:15 INFO - using testdate: 1474582995 15:23:15 INFO - actual date: 1474582995 15:23:15 INFO - starting webserver on 'localhost:45183' 15:23:15 INFO - SUITE-START | Running 2 tests 15:23:15 INFO - TEST-START | dromaeo_css 15:23:15 INFO - operating with platform_type : linux_ 15:23:15 INFO - Initialising browser for dromaeo_css test... 15:23:15 INFO - TEST-INFO | started process 14007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy9Rzf0/profile http://localhost:45183/getInfo.html) 15:23:19 INFO - PROCESS | 14007 | __metrics Screen width/height:1600/1200 15:23:19 INFO - PROCESS | 14007 | colorDepth:24 15:23:19 INFO - PROCESS | 14007 | Browser inner width/height: 1024/697 15:23:19 INFO - PROCESS | 14007 | __metrics 15:23:19 INFO - PROCESS | 14007 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:23:19 INFO - PROCESS | 14007 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:23:20 INFO - PROCESS | 14007 | console.error: PushService: 15:23:20 INFO - PROCESS | 14007 | stateChangeProcessEnqueue: Error transitioning state 15:23:20 INFO - PROCESS | 14007 | UnknownError 15:23:21 INFO - TEST-INFO | 14007: exit 0 15:23:21 INFO - Browser initialized. 15:23:21 INFO - Running cycle 1/1 for dromaeo_css test... 15:23:21 INFO - TEST-INFO | started process 14089 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy9Rzf0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:23:33 INFO - PROCESS | 14089 | RSS: Main: 173445120 15:23:33 INFO - PROCESS | 14089 | 15:24:24 INFO - PROCESS | 14089 | 1474583064445 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:26:34 INFO - PROCESS | 14089 | Cycle 1(1): loaded http://localhost:45183/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45183/tests/dromaeo/cssquery-ext.html) 15:26:35 INFO - PROCESS | 14089 | RSS: Main: 289808384 15:26:35 INFO - PROCESS | 14089 | 15:29:37 INFO - PROCESS | 14089 | Cycle 1(1): loaded http://localhost:45183/tests/dromaeo/cssquery-ext.html (next: http://localhost:45183/tests/dromaeo/cssquery-jquery.html) 15:29:38 INFO - PROCESS | 14089 | RSS: Main: 274665472 15:29:38 INFO - PROCESS | 14089 | 15:32:40 INFO - PROCESS | 14089 | Cycle 1(1): loaded http://localhost:45183/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45183/tests/dromaeo/cssquery-mootools.html) 15:32:40 INFO - PROCESS | 14089 | RSS: Main: 250679296 15:32:40 INFO - PROCESS | 14089 | 15:35:42 INFO - PROCESS | 14089 | Cycle 1(1): loaded http://localhost:45183/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45183/tests/dromaeo/cssquery-prototype.html) 15:35:43 INFO - PROCESS | 14089 | RSS: Main: 265383936 15:35:43 INFO - PROCESS | 14089 | 15:38:46 INFO - PROCESS | 14089 | Cycle 1(1): loaded http://localhost:45183/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45183/tests/dromaeo/cssquery-yui.html) 15:38:46 INFO - PROCESS | 14089 | RSS: Main: 215506944 15:38:46 INFO - PROCESS | 14089 | 15:41:49 INFO - PROCESS | 14089 | Cycle 1(1): loaded http://localhost:45183/tests/dromaeo/cssquery-yui.html (next: http://localhost:45183/tests/dromaeo/cssquery-dojo.html) 15:41:49 INFO - PROCESS | 14089 | RSS: Main: 307871744 15:41:49 INFO - PROCESS | 14089 | 15:41:49 INFO - PROCESS | 14089 | __start_tp_report 15:41:49 INFO - PROCESS | 14089 | _x_x_mozilla_page_load 15:41:49 INFO - PROCESS | 14089 | _x_x_mozilla_page_load_details 15:41:49 INFO - PROCESS | 14089 | |i|pagename|runs| 15:41:49 INFO - PROCESS | 14089 | |0;dojo.html;3013.623297087864;3036.5141577347613;3047.9542806857894;3074.9538756918637;3092.8298943558098;5213.348331458567;5229.163333866582;5267.762950667219;5269.5520880725135;5309.044372013036;5174.948250517494;5267.578593712504;5325.3077099976945;5358.035553600351;5360.517553420192;4785.138675038492;4794.784234709429;4815.759212039402;4820.975895120519;4869.732164730938;4826.831060912851;4863.586595139417;4877.853664390074;4903.82836600719;4935.407751069876;4937.185364414867;4956.1822299320565;4958.900821983558;5016.69899806011;5033.974830125844;4680.321353403771;4727.692699974491;4787.970586323922;4886;4971.229459433794;4793.281007848851;4813.518648135194;4827.058723548909;4876.878078048042;4903.681260718042;5294.285271488338;5309.123994540896;5352.892942141136;5355.250264962909;5365.141577347645;5552.583556233299;5621.184928185431;5664.716764161775;5668.631538949955;5678.971605141989;5654.180143879114;5710.086386178192;5711.40030296817;5740.397258287861;5793.073108302651;5318.069337865897;5320.308359913264;5327.147656375;5328.147496400557;5335.439778823206;5609.887802244014;5792.3323950362865;5792.82621521355;5801.94198058014;5809.302883653904;5409.78360865561;5453.072977593819;5507.339119305629;5511.200875872976;5592.972035139798;5555.472230138131;5598.1602759586385;5611.382747897728;5612.214289999403;5614.438556144353;5556.138798486241;5594.13290939905;5598.692071936001;5605.747741351649;5607.327120745536;5395.21769343443;5446.836594902159;5454.181872719124;5528.723563821793;5532.197831314517;4322.0491491871735;4329.328954012133;4334.046509767846;4376.956230437719;4389.18800021997;3900.570937196906;3952.2293152834923;3953.525576930787;3964.5638979712207;3987.1029018470613;5386.649867758583;5391.81128660495;5393.6763794172475;5398.91901621476;5402.91895621566;5493.752781124859;5538.44615538451;5622.971885140548;5626.324841019104;5681.147827825859;5291.973540132275;5335.119705248668;5341.786328546892;5353.357597088374;5419.864503387447;4848.3454733610515;4851.902961940741;4857.271409288635;4863.076015557032;4912.140375434285;5665.546756259571;5738.081906894877;5789.53683705311;5806.68063256525;5808.448197421239;5532.253145825423;5626.156076588544;5703.743331550173;5718.170865224436;5795.043817770021;5889.911651325319;5907.2911250650195;5911.408859114054;5913.113033045078;5918.496927761016;5606.215129881902;5628.493435590816;5629.071203251581;5633.63381380209;5635.042042852643;5539.7784088636;5582.944170558242;5770.826875193751;5795.94204057954;5821.388754180919;5661.122526008476;5663.8867222656145;5664.348599910898;5664.895345407606;5725.2843394575675;5549.556035517229;5569.19246709233;5592.608517403743;5608.4111168326735;5611.691356975405;5390;5442.945570544244;5486.094794359045;5506.2291279221745;5529.502344788988;5620.943790562042;5630.324361076697;5633.3521645009705;5652.773889044557;5680.659160450221;5327.174287985368;5517.337919449692;5518.779248830002;5521.4478552144465;5524.80663176803 15:41:49 INFO - PROCESS | 14089 | |1;ext.html;553.4808290309622;595.2499850188761;602.2381687165733;605.2253116011501;611.1901730207474;26905.192844214682;41653.375199372036;41736;42070;42219.36670949938;43363.78318108413;43764;43838.34242486357;43858.342124868075;43895.78052109735;8174.427790054699;8926.419782714136;9068.8639670405;9079.773005674844;9084.13700698436;8025.959870200641;10441.84337234942;10693.679189624285;10695.251332406735;11094.500747466343;10953.83569246462;10983.670489885277;11014.50434730435;11021.228514003982;11025.558977640885;8248.8350232995;8451.619677114544;10686.465676716172;10760.515776790064;10781.137508999262;8330.291925186306;8385.496870187808;10334.224933130045;10677.145828333792;10682;41196.38205426921;41507.377389339184;41521.37717934234;41585.37621935673;41606.79196604028;3271.2149084219855;3320.6181289151814;3360.6975372216375;3462.9307413851834;3796.506454160969;30848.691513084807;31033.379332413224;31168.53247201294;31277.374452510823;33076.83461582677;4193;4311.827526898952;4373.671974601918;4376.606105450524;4425.535318791545;346383;347408;348350;348741;348907;55499.44500555024;55711;55785.721071394386;55824.44175558274;55864.72067639717;58848.70575647095;58897.705511472166;58930.70534647299;58968.41031589715;58975;16743;16994.32022719102;16996;16997.660046798996;17001.40495082691;10677.145828333714;10965.780684386267;12982.415791289415;13381.799273010913;13485.325733713471;15621.843781562266;15624.3750249991;15763.684726305639;15774.211289435712;15795.21023948798;5916;5947.661776100429;5966.31387390447;6050.909236361458;6151.538634602333;920.5259291464901;1002.1031177096604;1019.8164330420448;1089.1450211584026;1109.112709832131;31471.41209424917;31556.842215789235;31977.52033719496;32247.67752322447;32767.542434317522;1041.8280983637615;1054.583439541377;1061.7027232374946;1117.6144230240554;1132.005844541184;16844.24200910962;16874.409395671093;16988.74516882248;16992.490225293262;17054.2325595346;524811;524923;524940;529148;529767;56753.14870276949;57065.14402283969;57122;57221.71389143111;57433.71283143557;1201.2492192379764;1221.157401393036;1250.493550112188;1280.692633767889;1282.7434513097419;30817.845910770302;31876.362472749952;32781.34437311288;32843.671563284064;33543.16142096467;43410.56589434192;43742.78128609336;43751.78124109359;43835.780821095694;43851;402871;404352;404770;405138;405577;26523.734762652897;27805.443891122468;27868.16395508138;29074.563881542217;29262.853685732287;46223.30665040094;46627.30059049185;47366.28950565675;48105.27842082441;48264.517354826;38883;39495.210095798495;39585.60414395819;41294.58705413028;41621.79189104035;39870.80064599658;40295.39556906708;40742.79628601838;41115.588844111175;41320.79339603283;40177.39733903935;40269.1946161081;40820.59179408168;41394;41521.169576607695;33959.660403396636;36148.63851361558;36520;36993;37146.25707485889;27022.864885676234;27490.587641185797;27712.722872771013;27832.304192394542;27915.302117446416 15:41:49 INFO - PROCESS | 14089 | |2;jquery.html;368.0889797750566;393.4079210787764;401.7408771342484;402.9234445455363;423.49603971274183;13217.537386191485;15423;17330.566735831595;19669.21323147076;19736.70394944077;17509.7373539397;18522.907385463088;18558.536036599093;18616.906915465403;19802.801971980276;5649.49154576088;5689.260396148495;5895.970520147414;5906.409359064102;5908.1433192187105;5673.375928647845;5716.28546431696;5726.198332233491;5743.224664670279;5752;5469.206964990094;5721.742521586518;5723.284589426322;5729;5730.942690573103;5681.659100453965;5693.686847223401;5713.485786279255;5729.856753581152;5732.5987180897355;4975.203967365204;5077.1876499759865;5087.236914462823;5142.717150556718;5149.716765577892;23297.301080967598;23301;23605.173818916257;23654.172103976278;23816.880915595484;2224.3882932193615;2287.5081857400737;2337.836351455399;2581.38046868752;2832.9942870281166;14323.212223327713;14501.854981450157;14688.779668304984;15222.923885380613;15248.466303679428;1648.6537827056331;1674.7990241171137;1697.4992377248618;1700.0904516083835;1752.1852338662457;80087;82494.76257856197;83119.16880831236;83406.58296708539;83822;10693.465326733787;10699.197560183018;10812.5134368952;10960.506777195045;11263.155263355282;15369.462068827761;15413.5375938722;15422.922885385502;15430.151341676315;15430.382784688487;8072.959635201786;8360.414770965974;8373.706920257762;8612.267957223581;8619.784505387415;8021.318187954089;8100.71647492335;8149;8422.284105851071;8476.364272679573;6412.487001039905;6650.53446258767;6664.233613134455;6752.696128674222;6813.4549236061985;1925.3550060729813;1967.5376286572643;1989.2242025610024;1999.5201151723481;2004.2684420186526;874.2743522875998;1027.814993301198;1033.9948300258602;1083.4041277297456;1086.625114335553;19839.900800496194;20536.79463205379;20670.586588268452;20861.061252243686;21141.68287475689;950.2635457520339;984.1044649369182;1008.1581879130861;1017.1354348803458;1048.0776916313596;10469.424181669929;11599.420028998516;11680.88319116815;11689.824652630217;11690.88309116898;427806;433727;442520;443500;444561;48776.5122348772;60102;80481.19518804736;82215;84182;992.8907820139779;1010.7921034364011;1016.3596933931576;1023.2785885950387;1032.055669062799;16855.494335169966;17125.828741712423;17800.821991780434;18173.90913045479;18290.256471477343;39728;39807.51837619785;40882.38676419797;41093;41603.92733235297;52574.737126314125;53775.46224537704;54018.459815402915;54560.72719636376;55343.44656553544;6249.375062493714;8467.49195048299;8607.655693772429;8691.130886911258;8905.109489051043;13031.934840325737;13079.476820927057;13079.757423044795;13329;13344.266065366499;11147.55409783632;11251.156163287622;11670.766584668429;11686.824697629372;11689.766204675689;11219.158563107636;11230.382328971986;11425.885741142481;11438.08495320389;11588.94205528967;11309.491072901574;11638.70903227426;11738.530458781554;11816.350100744541;11961.64115076549;8285.378596605158;8606.44058136219;8685.689236041913;8782.209601135928;8824.514651693962;11570.76858462843;11631.53473861036;11682.591109311134;11782.410879455821;12112.273263604213 15:41:49 INFO - PROCESS | 14089 | |3;mootools.html;1244.663940736002;1428.3643778518556;1481.6740317130232;1598;1747.7977748037476;7785.455018148725;8377.664893404264;8653.264472519828;8752.562371881413;8971.461712297267;9052.864207036882;9112.225460835836;9118;9121.087891210876;9123.133302336284;2316.83782135251;2344.6014177589764;2347.7652234776556;2351.459164392191;2353.8587684738886;2329.37106981115;2339.883005849709;2386.522695460906;2388.8088952883727;2389.51015041916;2321.4080409495555;2336.0305473228673;2349.706286714161;2359.49270906755;2360.775726305998;2183.4541364658835;2219.25654905606;2220.6335954567476;2223.8109760670363;2226.1540614566525;2256.2328808205125;2257.977420225793;2264.184893438361;2264.52444986553;2266.252136794854;8364.958175209145;8406.915930840736;8509.064002959669;8708.085651006617;8769.912300876973;4991.226359914219;5159.922601160985;5217.895642087175;5221.817236396708;5223.347081614798;3385.4075536780965;3409.8124603146816;3455.2053027803495;3478.130467383154;3483.3904066788464;1203.9097067719867;1217.5555922088463;1221.4869754703045;1241.540629966918;1256.805195194737;12519.749605007848;12742.745145097138;12782.744345113046;12788.808167877489;12821.743565128738;4349.325854492496;4672.789724462339;4681.250999840009;4806.711597304173;4863;10861.1854110942;10862.45687715611;10862.674119776262;10864.130869530418;10869;5019.42276638184;5078.5175408336145;5098.949010509921;5102.209157580581;5118.360204974379;4246.915061698749;4346.47842258931;4399.1641588098155;4569.9314510282375;4711.905761884812;3692.9630703693156;3833.3483307837732;3841.2125514270065;3858.344081506151;4120.464339635828;1280.353421522144;1289.5422125145626;1317.3874148520983;1318.7164759576738;1323.3184909771476;926.5228407370209;947.7204224753714;957.1003256938455;959.5490119643756;1000.6897861662908;5572.108462645957;5620.718964051863;5817.825465236049;5915.231019967377;6233.158523599347;471.6322664273634;483.59619717536253;967.4533888353058;975.770693886936;1041.1254546181092;4009.69927255457;4047.7571345719352;4048.3117869962175;4083.673306135502;4117.958820411757;10932.781344373068;11339.433028348549;11352.94323528377;11355.829662555068;11359.48882300282;11086.223964322582;11248.887511124947;11280.153988450898;11280.379579123228;11281;8278.875816862752;8385.748427547183;8455.196756308142;8493.702720404879;8495.980482342035;5696.971515142398;5835.591508594358;5840.620359676607;5879.029960056543;6141.539384546088;10219.437930913871;10303.278770486293;10308.226882983656;10461.68614941553;10465.633702820669;9503.809923801347;9986.400815951067;9997;10227.795444090927;10276.22928280367;7182.066331376887;7422.257774222535;7980.561069141253;8153.470024448392;8154.877676834971;8438.367122465963;8628.482291062557;8694.08712085222;8711.956440217758;8899.688510902088;7921.603919804102;8076.636551355085;8319.542425166674;8339.291160251447;8361.080281169188;7858.292753652198;7915.604219788872;7923.801904952422;8059.919400805917;8189.385796065199;7058.435325174077;7060.117485314336;7083.82290442743;7104.751333703295;7162.7493037743425;5143.588512918883;5280.551153152025;5364.839054828361;5365.543928766098;5387.757550910297;5265.131253343156;5317;5352.625316227826;5371.5971302153275;5491.423400543045 15:41:49 INFO - PROCESS | 14089 | |4;prototype.html;328.34822876589965;330.3327278896628;341.7573522798812;343.5362260947721;350.185817973212;5294.39114501832;5340.49265319795;5340.706261155635;5354.607801971486;5365.892682146359;4996.700197988123;5089.3638295213095;5135;5137.58899288057;5308.973455132728;4122.660135455982;4134.979325103371;4150.3359462486005;4159.958400416002;4182.2890108681595;4170.8540201092965;4171.728837625545;4178.686598505109;4184.8535301264465;4187.371894215877;3893.98053009736;3962.2075584882996;4155.459790227266;4156.771377574232;4173.269677806387;4091.774952377618;4095.4675892133982;4099.385092236159;4104.835806567764;4166.062635906927;3666.211764470625;3668.046307959923;3679.0802299425145;3685.649863262986;3691.1325838427947;5039.815643323816;5124.461931497176;5129.410117836459;5140.820071297487;5152.690838549699;4672.556107169813;4692.859214223578;4714.222153344694;4716.339712440261;4722.433308003027;5402.162664786964;5424.674519528841;5445.673259604437;5448.030823201365;5469.945300546983;3927.803609819526;3960.920781584381;4030.9116538534727;4044.090079732037;4044.5146582410007;5680.233168522238;5709.343425506078;5734.913976290359;5735.225744524478;5741.684207368593;4182.644475219579;4185.330347144442;4186.05348512943;4188.727732697365;4193.993441574061;4124.608162224584;4231.915361692749;4235.496398778389;4235.703500754979;4239.724417912826;4733.018198534901;4737.8341758038305;4750.527336525619;4756.096341695067;4760.64295177863;5524.1989911462615;5527.281453411031;5532.533878522115;5536.117719975227;5560.7219639017885;1411.9364628591738;1447.21126985793;1455.199640197887;1465.9780103298458;1468.1191285228776;942.6606421688186;955.1690029674228;956.7799406136628;960.2222200017868;970.2819913264275;4476.977615111904;4679.479169269933;4710.62315014798;4742.312364707098;4770.352454387848;4968.677035992649;5006.874828129326;5019.824306149268;5027.497250274943;5031.433968676001;4766.76166191689;4782.187028205213;4785.712857228577;4786.521347865186;4788.569028787356;2676.992255808144;2681.230387943948;2681.73393482507;2690.9596356054676;2842.630458040483;5885.61743486672;5910.113482977502;5917.319508256605;5920.674362909996;5930.970345148246;5821.79623713168;5824.708764561839;5834.795782147689;5835.936133529846;5841.977653910549;5666.291713535808;5831.88336233273;5861.7655293787775;5883.970580147072;5893.882122357529;5644.689542075225;5650.378458369658;5664.660120392789;5670.298910326803;5689.2319536862;5419.701916394479;5604.299462567179;5622.971885140548;5641.605087643826;5656.37779844225;5833.504152147115;5856.472917437451;5863.824085277449;5885.264341957255;5887.7056147191615;4052.5339585946813;4057.4522439471475;4063.5530091689297;4068.877933661995;4070.5929407059057;5365.87316663505;5566.443355664401;5592.636478628876;5637.7864617167825;5640.802571909963;5532.806351777668;5551.666899986014;5560.082586373203;5561.610687251854;5562.749676264497;5362.65142765719;5530.86172845666;5540.22436858832;5545.556355491632;5549.3363185671915;5558.249636299048;5579.911917176111;5585.106382978704;5588.720563971867;5591.10542313228;5587.69267690281;5587.860303492445;5611.709306859363;5621.735109600308;5634.154876768517;5296.867578310419;5503.504684578407;5504.366997795145;5509.47659972302;5530.806421775219 15:41:49 INFO - PROCESS | 14089 | |5;yui.html;768.3430666779904;774.9690012399504;810.8297257575908;813.5444151275283;834.6577903059747;13159.671008224786;13982.230977296245;14047.92976035121;14053.367598458068;14063.507777227785;12727.363631818394;12757.617271481848;12766.297853618047;12768.42542085606;12784.296863672495;647.5920170292709;671.1007250284617;778.6885245901628;782.3897360059149;799.5562462833125;792.5482474989259;805.7542449552884;810.0522388805083;810.6959890041235;811.7929927868386;859.9656013759442;862.0991064337782;862.8576284912982;862.9309655227598;863.0204717645486;679.6805501414327;702.8137543550963;848.8175042365921;850.3962186847345;852.3394369363762;605.5397897597858;622.6450922973906;626.589583822597;626.8746250749823;627.7175271128011;13425.932870335684;13432.328383580782;13459.596212113653;13461.192328460324;13475.326233688374;13466.865331346658;14011.229382383965;14127.434902603884;14207.78688319676;14355.56933292003;11925.522979080826;11994.64016079519;12035.39823008846;12039.819402708967;12083.818742718866;4349.586789255016;4350.590643100559;4399.5820397062225;4455.598996090367;4482.663800214997;74760.62619686867;75721;75819;76356.61821690912;76559;10843.67468975932;10929.211224970877;11206.551737930391;11463.254888432226;11546;20997.475063123544;21008.369748907557;21050.578988420144;21143.894280528806;21181.682274765582;7797.493162944391;7874.685012599546;7929.246721561442;8046.678132874619;8112.43212975086;4273.850415235452;4472.172648060119;4561.612262957619;4566.657500687462;4656.3946686930485;3259.7229235514774;3370.5786776652917;3372.494125881088;3375.206826395795;3378.1216883610437;549.228334190463;556.7327682712321;559.7033572206736;562.2297452490114;575.068389209475;527.1197100841604;603.7916918663054;658.8781075500951;690.2062627977765;705.1186017478152;8237.640789269823;8787.297016238814;8847.426121543387;8889;8898;644.4650939720021;654.1855390039432;665.3978149774462;674.2919934069208;703.2088899987514;3821.636944490269;4085.20338533983;4193.1194449165405;4209.473815773028;4230.682698797603;111978;120022.399888;123178;125947;127967;103416;105711;107248;107988.46005769921;110222.44888775665;56853.71573142191;58137.70931145402;89483;91131.53210807373;94553.52723236478;7831.882521762064;7867.685292588232;7938.960305198437;7985.441019128605;8020.518768873886;53731.19403209033;53990.460095400114;55111;55367;55891.72054139866;71052;76575;78037;78975.21024789909;81745.59127204325;10616;11393.886061139614;11565.537378505102;11741.823872642088;11970.640880773592;12743.553975610808;13062.216267024009;13098.148620339647;13433.462661493822;13484.190948543119;11865.347405892759;12052.027879918789;12362.938185309376;12390.75218495607;12403.25580465175;11096.11231101526;11338.768450991427;11633.53465861356;11646;11656.53373865036;10807.837882431613;11290;11299.152563557931;11660.941695291809;11662.94168529152;8884.600192991202;9086.273098152264;9480;9495.715128546155;9873.802523949624;8477.421604523102;8657.91342086571;9241.768955775891;9421.434713917188;9898.752531186778 15:41:49 INFO - PROCESS | 14089 | __end_tp_report 15:41:49 INFO - PROCESS | 14089 | __start_cc_report 15:41:49 INFO - PROCESS | 14089 | _x_x_mozilla_cycle_collect,902 15:41:49 INFO - PROCESS | 14089 | __end_cc_report 15:41:49 INFO - PROCESS | 14089 | __startTimestamp1474584109960__endTimestamp 15:41:49 INFO - PROCESS | 14089 | 15:41:49 INFO - PROCESS | 14089 | ------- Summary: start ------- 15:41:49 INFO - PROCESS | 14089 | Number of tests: 6 15:41:49 INFO - PROCESS | 14089 | 15:41:49 INFO - PROCESS | 14089 | [#0] dojo.html Cycles:165 Average:5270.18 Median:5454.18 stddev:584.68 (10.7%) stddev-sans-first:559.03 15:41:49 INFO - PROCESS | 14089 | Values: 3013.6 3036.5 3048.0 3075.0 3092.8 5213.3 5229.2 5267.8 5269.6 5309.0 5174.9 5267.6 5325.3 5358.0 5360.5 4785.1 4794.8 4815.8 4821.0 4869.7 4826.8 4863.6 4877.9 4903.8 4935.4 4937.2 4956.2 4958.9 5016.7 5034.0 4680.3 4727.7 4788.0 4886.0 4971.2 4793.3 4813.5 4827.1 4876.9 4903.7 5294.3 5309.1 5352.9 5355.3 5365.1 5552.6 5621.2 5664.7 5668.6 5679.0 5654.2 5710.1 5711.4 5740.4 5793.1 5318.1 5320.3 5327.1 5328.1 5335.4 5609.9 5792.3 5792.8 5801.9 5809.3 5409.8 5453.1 5507.3 5511.2 5593.0 5555.5 5598.2 5611.4 5612.2 5614.4 5556.1 5594.1 5598.7 5605.7 5607.3 5395.2 5446.8 5454.2 5528.7 5532.2 4322.0 4329.3 4334.0 4377.0 4389.2 3900.6 3952.2 3953.5 3964.6 3987.1 5386.6 5391.8 5393.7 5398.9 5402.9 5493.8 5538.4 5623.0 5626.3 5681.1 5292.0 5335.1 5341.8 5353.4 5419.9 4848.3 4851.9 4857.3 4863.1 4912.1 5665.5 5738.1 5789.5 5806.7 5808.4 5532.3 5626.2 5703.7 5718.2 5795.0 5889.9 5907.3 5911.4 5913.1 5918.5 5606.2 5628.5 5629.1 5633.6 5635.0 5539.8 5582.9 5770.8 5795.9 5821.4 5661.1 5663.9 5664.3 5664.9 5725.3 5549.6 5569.2 5592.6 5608.4 5611.7 5390.0 5442.9 5486.1 5506.2 5529.5 5620.9 5630.3 5633.4 5652.8 5680.7 5327.2 5517.3 5518.8 5521.4 5524.8 15:41:49 INFO - PROCESS | 14089 | 15:41:49 INFO - PROCESS | 14089 | [#1] ext.html Cycles:180 Average:58465.09 Median:39189.11 stddev:114664.41 (292.6%) stddev-sans-first:114903.64 15:41:49 INFO - PROCESS | 14089 | Values: 553.5 595.2 602.2 605.2 611.2 26905.2 41653.4 41736.0 42070.0 42219.4 43363.8 43764.0 43838.3 43858.3 43895.8 8174.4 8926.4 9068.9 9079.8 9084.1 8026.0 10441.8 10693.7 10695.3 11094.5 10953.8 10983.7 11014.5 11021.2 11025.6 8248.8 8451.6 10686.5 10760.5 10781.1 8330.3 8385.5 10334.2 10677.1 10682.0 41196.4 41507.4 41521.4 41585.4 41606.8 3271.2 3320.6 3360.7 3462.9 3796.5 30848.7 31033.4 31168.5 31277.4 33076.8 4193.0 4311.8 4373.7 4376.6 4425.5 346383.0 347408.0 348350.0 348741.0 348907.0 55499.4 55711.0 55785.7 55824.4 55864.7 58848.7 58897.7 58930.7 58968.4 58975.0 16743.0 16994.3 16996.0 16997.7 17001.4 10677.1 10965.8 12982.4 13381.8 13485.3 15621.8 15624.4 15763.7 15774.2 15795.2 5916.0 5947.7 5966.3 6050.9 6151.5 920.5 1002.1 1019.8 1089.1 1109.1 31471.4 31556.8 31977.5 32247.7 32767.5 1041.8 1054.6 1061.7 1117.6 1132.0 16844.2 16874.4 16988.7 16992.5 17054.2 524811.0 524923.0 524940.0 529148.0 529767.0 56753.1 57065.1 57122.0 57221.7 57433.7 1201.2 1221.2 1250.5 1280.7 1282.7 30817.8 31876.4 32781.3 32843.7 33543.2 43410.6 43742.8 43751.8 43835.8 43851.0 402871.0 404352.0 404770.0 405138.0 405577.0 26523.7 27805.4 27868.2 29074.6 29262.9 46223.3 46627.3 47366.3 48105.3 48264.5 38883.0 39495.2 39585.6 41294.6 41621.8 39870.8 40295.4 40742.8 41115.6 41320.8 40177.4 40269.2 40820.6 41394.0 41521.2 33959.7 36148.6 36520.0 36993.0 37146.3 27022.9 27490.6 27712.7 27832.3 27915.3 15:41:49 INFO - PROCESS | 14089 | 15:41:49 INFO - PROCESS | 14089 | [#2] jquery.html Cycles:180 Average:27055.79 Median:12971.51 stddev:72160.14 (556.3%) stddev-sans-first:72334.74 15:41:49 INFO - PROCESS | 14089 | Values: 368.1 393.4 401.7 402.9 423.5 13217.5 15423.0 17330.6 19669.2 19736.7 17509.7 18522.9 18558.5 18616.9 19802.8 5649.5 5689.3 5896.0 5906.4 5908.1 5673.4 5716.3 5726.2 5743.2 5752.0 5469.2 5721.7 5723.3 5729.0 5730.9 5681.7 5693.7 5713.5 5729.9 5732.6 4975.2 5077.2 5087.2 5142.7 5149.7 23297.3 23301.0 23605.2 23654.2 23816.9 2224.4 2287.5 2337.8 2581.4 2833.0 14323.2 14501.9 14688.8 15222.9 15248.5 1648.7 1674.8 1697.5 1700.1 1752.2 80087.0 82494.8 83119.2 83406.6 83822.0 10693.5 10699.2 10812.5 10960.5 11263.2 15369.5 15413.5 15422.9 15430.2 15430.4 8073.0 8360.4 8373.7 8612.3 8619.8 8021.3 8100.7 8149.0 8422.3 8476.4 6412.5 6650.5 6664.2 6752.7 6813.5 1925.4 1967.5 1989.2 1999.5 2004.3 874.3 1027.8 1034.0 1083.4 1086.6 19839.9 20536.8 20670.6 20861.1 21141.7 950.3 984.1 1008.2 1017.1 1048.1 10469.4 11599.4 11680.9 11689.8 11690.9 427806.0 433727.0 442520.0 443500.0 444561.0 48776.5 60102.0 80481.2 82215.0 84182.0 992.9 1010.8 1016.4 1023.3 1032.1 16855.5 17125.8 17800.8 18173.9 18290.3 39728.0 39807.5 40882.4 41093.0 41603.9 52574.7 53775.5 54018.5 54560.7 55343.4 6249.4 8467.5 8607.7 8691.1 8905.1 13031.9 13079.5 13079.8 13329.0 13344.3 11147.6 11251.2 11670.8 11686.8 11689.8 11219.2 11230.4 11425.9 11438.1 11588.9 11309.5 11638.7 11738.5 11816.4 11961.6 8285.4 8606.4 8685.7 8782.2 8824.5 11570.8 11631.5 11682.6 11782.4 12112.3 15:41:49 INFO - PROCESS | 14089 | 15:41:49 INFO - PROCESS | 14089 | [#3] mootools.html Cycles:180 Average:5867.10 Median:2576.44 stddev:3405.61 (132.2%) stddev-sans-first:3397.45 15:41:49 INFO - PROCESS | 14089 | Values: 1244.7 1428.4 1481.7 1598.0 1747.8 7785.5 8377.7 8653.3 8752.6 8971.5 9052.9 9112.2 9118.0 9121.1 9123.1 2316.8 2344.6 2347.8 2351.5 2353.9 2329.4 2339.9 2386.5 2388.8 2389.5 2321.4 2336.0 2349.7 2359.5 2360.8 2183.5 2219.3 2220.6 2223.8 2226.2 2256.2 2258.0 2264.2 2264.5 2266.3 8365.0 8406.9 8509.1 8708.1 8769.9 4991.2 5159.9 5217.9 5221.8 5223.3 3385.4 3409.8 3455.2 3478.1 3483.4 1203.9 1217.6 1221.5 1241.5 1256.8 12519.7 12742.7 12782.7 12788.8 12821.7 4349.3 4672.8 4681.3 4806.7 4863.0 10861.2 10862.5 10862.7 10864.1 10869.0 5019.4 5078.5 5098.9 5102.2 5118.4 4246.9 4346.5 4399.2 4569.9 4711.9 3693.0 3833.3 3841.2 3858.3 4120.5 1280.4 1289.5 1317.4 1318.7 1323.3 926.5 947.7 957.1 959.5 1000.7 5572.1 5620.7 5817.8 5915.2 6233.2 471.6 483.6 967.5 975.8 1041.1 4009.7 4047.8 4048.3 4083.7 4118.0 10932.8 11339.4 11352.9 11355.8 11359.5 11086.2 11248.9 11280.2 11280.4 11281.0 8278.9 8385.7 8455.2 8493.7 8496.0 5697.0 5835.6 5840.6 5879.0 6141.5 10219.4 10303.3 10308.2 10461.7 10465.6 9503.8 9986.4 9997.0 10227.8 10276.2 7182.1 7422.3 7980.6 8153.5 8154.9 8438.4 8628.5 8694.1 8712.0 8899.7 7921.6 8076.6 8319.5 8339.3 8361.1 7858.3 7915.6 7923.8 8059.9 8189.4 7058.4 7060.1 7083.8 7104.8 7162.7 5143.6 5280.6 5364.8 5365.5 5387.8 5265.1 5317.0 5352.6 5371.6 5491.4 15:41:49 INFO - PROCESS | 14089 | 15:41:49 INFO - PROCESS | 14089 | [#4] prototype.html Cycles:180 Average:4619.05 Median:5136.29 stddev:1354.90 (26.4%) stddev-sans-first:1319.87 15:41:49 INFO - PROCESS | 14089 | Values: 328.3 330.3 341.8 343.5 350.2 5294.4 5340.5 5340.7 5354.6 5365.9 4996.7 5089.4 5135.0 5137.6 5309.0 4122.7 4135.0 4150.3 4160.0 4182.3 4170.9 4171.7 4178.7 4184.9 4187.4 3894.0 3962.2 4155.5 4156.8 4173.3 4091.8 4095.5 4099.4 4104.8 4166.1 3666.2 3668.0 3679.1 3685.6 3691.1 5039.8 5124.5 5129.4 5140.8 5152.7 4672.6 4692.9 4714.2 4716.3 4722.4 5402.2 5424.7 5445.7 5448.0 5469.9 3927.8 3960.9 4030.9 4044.1 4044.5 5680.2 5709.3 5734.9 5735.2 5741.7 4182.6 4185.3 4186.1 4188.7 4194.0 4124.6 4231.9 4235.5 4235.7 4239.7 4733.0 4737.8 4750.5 4756.1 4760.6 5524.2 5527.3 5532.5 5536.1 5560.7 1411.9 1447.2 1455.2 1466.0 1468.1 942.7 955.2 956.8 960.2 970.3 4477.0 4679.5 4710.6 4742.3 4770.4 4968.7 5006.9 5019.8 5027.5 5031.4 4766.8 4782.2 4785.7 4786.5 4788.6 2677.0 2681.2 2681.7 2691.0 2842.6 5885.6 5910.1 5917.3 5920.7 5931.0 5821.8 5824.7 5834.8 5835.9 5842.0 5666.3 5831.9 5861.8 5884.0 5893.9 5644.7 5650.4 5664.7 5670.3 5689.2 5419.7 5604.3 5623.0 5641.6 5656.4 5833.5 5856.5 5863.8 5885.3 5887.7 4052.5 4057.5 4063.6 4068.9 4070.6 5365.9 5566.4 5592.6 5637.8 5640.8 5532.8 5551.7 5560.1 5561.6 5562.7 5362.7 5530.9 5540.2 5545.6 5549.3 5558.2 5579.9 5585.1 5588.7 5591.1 5587.7 5587.9 5611.7 5621.7 5634.2 5296.9 5503.5 5504.4 5509.5 5530.8 15:41:49 INFO - PROCESS | 14089 | 15:41:49 INFO - PROCESS | 14089 | [#5] yui.html Cycles:180 Average:20520.18 Median:27129.16 stddev:31210.55 (115.0%) stddev-sans-first:31262.87 15:41:49 INFO - PROCESS | 14089 | Values: 768.3 775.0 810.8 813.5 834.7 13159.7 13982.2 14047.9 14053.4 14063.5 12727.4 12757.6 12766.3 12768.4 12784.3 647.6 671.1 778.7 782.4 799.6 792.5 805.8 810.1 810.7 811.8 860.0 862.1 862.9 862.9 863.0 679.7 702.8 848.8 850.4 852.3 605.5 622.6 626.6 626.9 627.7 13425.9 13432.3 13459.6 13461.2 13475.3 13466.9 14011.2 14127.4 14207.8 14355.6 11925.5 11994.6 12035.4 12039.8 12083.8 4349.6 4350.6 4399.6 4455.6 4482.7 74760.6 75721.0 75819.0 76356.6 76559.0 10843.7 10929.2 11206.6 11463.3 11546.0 20997.5 21008.4 21050.6 21143.9 21181.7 7797.5 7874.7 7929.2 8046.7 8112.4 4273.9 4472.2 4561.6 4566.7 4656.4 3259.7 3370.6 3372.5 3375.2 3378.1 549.2 556.7 559.7 562.2 575.1 527.1 603.8 658.9 690.2 705.1 8237.6 8787.3 8847.4 8889.0 8898.0 644.5 654.2 665.4 674.3 703.2 3821.6 4085.2 4193.1 4209.5 4230.7 111978.0 120022.4 123178.0 125947.0 127967.0 103416.0 105711.0 107248.0 107988.5 110222.4 56853.7 58137.7 89483.0 91131.5 94553.5 7831.9 7867.7 7939.0 7985.4 8020.5 53731.2 53990.5 55111.0 55367.0 55891.7 71052.0 76575.0 78037.0 78975.2 81745.6 10616.0 11393.9 11565.5 11741.8 11970.6 12743.6 13062.2 13098.1 13433.5 13484.2 11865.3 12052.0 12362.9 12390.8 12403.3 11096.1 11338.8 11633.5 11646.0 11656.5 10807.8 11290.0 11299.2 11660.9 11662.9 8884.6 9086.3 9480.0 9495.7 9873.8 8477.4 8657.9 9241.8 9421.4 9898.8 15:41:49 INFO - PROCESS | 14089 | -------- Summary: end -------- 15:41:49 INFO - PROCESS | 14089 | 15:41:50 INFO - TEST-INFO | 14089: exit 0 15:41:50 INFO - TEST-OK | dromaeo_css | took 1115791ms 15:41:50 INFO - TEST-START | kraken 15:41:50 INFO - operating with platform_type : linux_ 15:41:50 INFO - Initialising browser for kraken test... 15:41:50 INFO - TEST-INFO | started process 14393 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprBsqJ0/profile http://localhost:45183/getInfo.html) 15:41:55 INFO - PROCESS | 14393 | __metrics Screen width/height:1600/1200 15:41:55 INFO - PROCESS | 14393 | colorDepth:24 15:41:55 INFO - PROCESS | 14393 | Browser inner width/height: 1024/697 15:41:55 INFO - PROCESS | 14393 | __metrics 15:41:55 INFO - PROCESS | 14393 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:41:55 INFO - PROCESS | 14393 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:41:56 INFO - PROCESS | 14393 | console.error: PushService: 15:41:56 INFO - PROCESS | 14393 | stateChangeProcessEnqueue: Error transitioning state 15:41:56 INFO - PROCESS | 14393 | UnknownError 15:41:56 INFO - TEST-INFO | 14393: exit 0 15:41:56 INFO - Browser initialized. 15:41:56 INFO - Running cycle 1/1 for kraken test... 15:41:56 INFO - TEST-INFO | started process 14476 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprBsqJ0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:42:09 INFO - PROCESS | 14476 | RSS: Main: 173686784 15:42:09 INFO - PROCESS | 14476 | 15:42:11 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:45183/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45183/tests/kraken/driver.html?testName=audio-beat-detection) 15:42:12 INFO - PROCESS | 14476 | RSS: Main: 233201664 15:42:12 INFO - PROCESS | 14476 | 15:42:15 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:45183/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45183/tests/kraken/driver.html?testName=audio-dft) 15:42:15 INFO - PROCESS | 14476 | RSS: Main: 218066944 15:42:15 INFO - PROCESS | 14476 | 15:42:18 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:45183/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45183/tests/kraken/driver.html?testName=audio-fft) 15:42:19 INFO - PROCESS | 14476 | RSS: Main: 299036672 15:42:19 INFO - PROCESS | 14476 | 15:42:21 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:45183/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45183/tests/kraken/driver.html?testName=audio-oscillator) 15:42:22 INFO - PROCESS | 14476 | RSS: Main: 207880192 15:42:22 INFO - PROCESS | 14476 | 15:42:24 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:45183/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45183/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:42:24 INFO - PROCESS | 14476 | RSS: Main: 212529152 15:42:24 INFO - PROCESS | 14476 | 15:42:27 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:45183/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45183/tests/kraken/driver.html?testName=imaging-darkroom) 15:42:28 INFO - PROCESS | 14476 | RSS: Main: 249274368 15:42:28 INFO - PROCESS | 14476 | 15:42:31 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:45183/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45183/tests/kraken/driver.html?testName=imaging-desaturate) 15:42:32 INFO - PROCESS | 14476 | RSS: Main: 248840192 15:42:32 INFO - PROCESS | 14476 | 15:42:35 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:45183/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45183/tests/kraken/driver.html?testName=json-parse-financial) 15:42:35 INFO - PROCESS | 14476 | RSS: Main: 248520704 15:42:35 INFO - PROCESS | 14476 | 15:42:37 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:45183/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45183/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:42:37 INFO - PROCESS | 14476 | RSS: Main: 211263488 15:42:37 INFO - PROCESS | 14476 | 15:42:39 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:45183/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45183/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:42:40 INFO - PROCESS | 14476 | RSS: Main: 217759744 15:42:40 INFO - PROCESS | 14476 | 15:42:42 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:45183/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45183/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:42:43 INFO - PROCESS | 14476 | RSS: Main: 222769152 15:42:43 INFO - PROCESS | 14476 | 15:42:45 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:45183/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45183/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:42:46 INFO - PROCESS | 14476 | RSS: Main: 223469568 15:42:46 INFO - PROCESS | 14476 | 15:42:48 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:45183/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45183/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:42:49 INFO - PROCESS | 14476 | RSS: Main: 222007296 15:42:49 INFO - PROCESS | 14476 | 15:42:51 INFO - PROCESS | 14476 | Cycle 1(1): loaded http://localhost:45183/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45183/tests/kraken/driver.html?testName=ai-astar) 15:42:51 INFO - PROCESS | 14476 | RSS: Main: 272363520 15:42:51 INFO - PROCESS | 14476 | 15:42:51 INFO - PROCESS | 14476 | __start_tp_report 15:42:51 INFO - PROCESS | 14476 | _x_x_mozilla_page_load 15:42:51 INFO - PROCESS | 14476 | _x_x_mozilla_page_load_details 15:42:51 INFO - PROCESS | 14476 | |i|pagename|runs| 15:42:51 INFO - PROCESS | 14476 | |0;ai-astar;110;112;111;112;112;112;111;112;111;111 15:42:51 INFO - PROCESS | 14476 | |1;audio-beat-detection;147;117;118;162;121;120;121;121;153;118 15:42:51 INFO - PROCESS | 14476 | |2;audio-dft;161;160;161;161;160;160;160;160;161;160 15:42:51 INFO - PROCESS | 14476 | |3;audio-fft;76;77;76;113;78;77;77;77;98;77 15:42:51 INFO - PROCESS | 14476 | |4;audio-oscillator;83;82;117;82;82;82;106;83;83;110 15:42:51 INFO - PROCESS | 14476 | |5;imaging-gaussian-blur;117;118;117;118;118;118;118;117;118;118 15:42:51 INFO - PROCESS | 14476 | |6;imaging-darkroom;145;147;146;145;145;146;147;147;147;147 15:42:51 INFO - PROCESS | 14476 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 15:42:51 INFO - PROCESS | 14476 | |8;json-parse-financial;51;51;51;51;51;53;52;52;51;51 15:42:51 INFO - PROCESS | 14476 | |9;json-stringify-tinderbox;59;60;59;60;60;59;61;59;60;60 15:42:51 INFO - PROCESS | 14476 | |10;stanford-crypto-aes;79;82;78;78;80;78;79;87;78;80 15:42:51 INFO - PROCESS | 14476 | |11;stanford-crypto-ccm;125;132;129;125;132;139;125;125;172;133 15:42:51 INFO - PROCESS | 14476 | |12;stanford-crypto-pbkdf2;166;166;167;160;166;166;167;165;162;163 15:42:51 INFO - PROCESS | 14476 | |13;stanford-crypto-sha256-iterative;65;67;67;67;65;64;66;67;64;66 15:42:51 INFO - PROCESS | 14476 | __end_tp_report 15:42:51 INFO - PROCESS | 14476 | __start_cc_report 15:42:51 INFO - PROCESS | 14476 | _x_x_mozilla_cycle_collect,1647 15:42:51 INFO - PROCESS | 14476 | __end_cc_report 15:42:51 INFO - PROCESS | 14476 | __startTimestamp1474584171548__endTimestamp 15:42:51 INFO - PROCESS | 14476 | 15:42:51 INFO - PROCESS | 14476 | ------- Summary: start ------- 15:42:51 INFO - PROCESS | 14476 | Number of tests: 14 15:42:51 INFO - PROCESS | 14476 | 15:42:51 INFO - PROCESS | 14476 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:0.70 (0.6%) stddev-sans-first:0.53 15:42:51 INFO - PROCESS | 14476 | Values: 110.0 112.0 111.0 112.0 112.0 112.0 111.0 112.0 111.0 111.0 15:42:51 INFO - PROCESS | 14476 | 15:42:51 INFO - PROCESS | 14476 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:121.00 stddev:17.13 (14.2%) stddev-sans-first:17.00 15:42:51 INFO - PROCESS | 14476 | Values: 147.0 117.0 118.0 162.0 121.0 120.0 121.0 121.0 153.0 118.0 15:42:51 INFO - PROCESS | 14476 | 15:42:51 INFO - PROCESS | 14476 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.52 (0.3%) stddev-sans-first:0.50 15:42:51 INFO - PROCESS | 14476 | Values: 161.0 160.0 161.0 161.0 160.0 160.0 160.0 160.0 161.0 160.0 15:42:51 INFO - PROCESS | 14476 | 15:42:51 INFO - PROCESS | 14476 | [#3] audio-fft Cycles:10 Average:82.60 Median:77.00 stddev:12.59 (16.3%) stddev-sans-first:13.12 15:42:51 INFO - PROCESS | 14476 | Values: 76.0 77.0 76.0 113.0 78.0 77.0 77.0 77.0 98.0 77.0 15:42:51 INFO - PROCESS | 14476 | 15:42:51 INFO - PROCESS | 14476 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:82.00 stddev:14.06 (17.1%) stddev-sans-first:14.61 15:42:51 INFO - PROCESS | 14476 | Values: 83.0 82.0 117.0 82.0 82.0 82.0 106.0 83.0 83.0 110.0 15:42:51 INFO - PROCESS | 14476 | 15:42:51 INFO - PROCESS | 14476 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 15:42:51 INFO - PROCESS | 14476 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 118.0 117.0 118.0 118.0 15:42:51 INFO - PROCESS | 14476 | 15:42:51 INFO - PROCESS | 14476 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 15:42:51 INFO - PROCESS | 14476 | Values: 145.0 147.0 146.0 145.0 145.0 146.0 147.0 147.0 147.0 147.0 15:42:51 INFO - PROCESS | 14476 | 15:42:51 INFO - PROCESS | 14476 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 15:42:51 INFO - PROCESS | 14476 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 15:42:51 INFO - PROCESS | 14476 | 15:42:51 INFO - PROCESS | 14476 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.00 stddev:0.70 (1.4%) stddev-sans-first:0.73 15:42:51 INFO - PROCESS | 14476 | Values: 51.0 51.0 51.0 51.0 51.0 53.0 52.0 52.0 51.0 51.0 15:42:51 INFO - PROCESS | 14476 | 15:42:51 INFO - PROCESS | 14476 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 15:42:51 INFO - PROCESS | 14476 | Values: 59.0 60.0 59.0 60.0 60.0 59.0 61.0 59.0 60.0 60.0 15:42:51 INFO - PROCESS | 14476 | 15:42:51 INFO - PROCESS | 14476 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.50 stddev:2.81 (3.5%) stddev-sans-first:2.96 15:42:51 INFO - PROCESS | 14476 | Values: 79.0 82.0 78.0 78.0 80.0 78.0 79.0 87.0 78.0 80.0 15:42:51 INFO - PROCESS | 14476 | 15:42:51 INFO - PROCESS | 14476 | [#11] stanford-crypto-ccm Cycles:10 Average:133.70 Median:132.00 stddev:14.24 (10.8%) stddev-sans-first:14.76 15:42:51 INFO - PROCESS | 14476 | Values: 125.0 132.0 129.0 125.0 132.0 139.0 125.0 125.0 172.0 133.0 15:42:51 INFO - PROCESS | 14476 | 15:42:51 INFO - PROCESS | 14476 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:166.00 stddev:2.35 (1.4%) stddev-sans-first:2.45 15:42:51 INFO - PROCESS | 14476 | Values: 166.0 166.0 167.0 160.0 166.0 166.0 167.0 165.0 162.0 163.0 15:42:51 INFO - PROCESS | 14476 | 15:42:51 INFO - PROCESS | 14476 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.50 stddev:1.23 (1.8%) stddev-sans-first:1.27 15:42:51 INFO - PROCESS | 14476 | Values: 65.0 67.0 67.0 67.0 65.0 64.0 66.0 67.0 64.0 66.0 15:42:51 INFO - PROCESS | 14476 | -------- Summary: end -------- 15:42:51 INFO - PROCESS | 14476 | 15:42:52 INFO - TEST-INFO | 14476: exit 0 15:42:52 INFO - TEST-OK | kraken | took 61864ms 15:42:52 INFO - SUITE-END | took 1177s 15:42:53 INFO - Completed test suite (00:19:38) 15:42:53 INFO - javascript benchmark 15:42:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3013.623297087864, 3036.5141577347613, 3047.9542806857894, 3074.9538756918637, 3092.8298943558098, 5213.348331458567, 5229.163333866582, 5267.762950667219, 5269.5520880725135, 5309.044372013036, 5174.948250517494, 5267.578593712504, 5325.3077099976945, 5358.035553600351, 5360.517553420192, 4785.138675038492, 4794.784234709429, 4815.759212039402, 4820.975895120519, 4869.732164730938, 4826.831060912851, 4863.586595139417, 4877.853664390074, 4903.82836600719, 4935.407751069876, 4937.185364414867, 4956.1822299320565, 4958.900821983558, 5016.69899806011, 5033.974830125844, 4680.321353403771, 4727.692699974491, 4787.970586323922, 4886.0, 4971.229459433794, 4793.281007848851, 4813.518648135194, 4827.058723548909, 4876.878078048042, 4903.681260718042, 5294.285271488338, 5309.123994540896, 5352.892942141136, 5355.250264962909, 5365.141577347645, 5552.583556233299, 5621.184928185431, 5664.716764161775, 5668.631538949955, 5678.971605141989, 5654.180143879114, 5710.086386178192, 5711.40030296817, 5740.397258287861, 5793.073108302651, 5318.069337865897, 5320.308359913264, 5327.147656375, 5328.147496400557, 5335.439778823206, 5609.887802244014, 5792.3323950362865, 5792.82621521355, 5801.94198058014, 5809.302883653904, 5409.78360865561, 5453.072977593819, 5507.339119305629, 5511.200875872976, 5592.972035139798, 5555.472230138131, 5598.1602759586385, 5611.382747897728, 5612.214289999403, 5614.438556144353, 5556.138798486241, 5594.13290939905, 5598.692071936001, 5605.747741351649, 5607.327120745536, 5395.21769343443, 5446.836594902159, 5454.181872719124, 5528.723563821793, 5532.197831314517, 4322.0491491871735, 4329.328954012133, 4334.046509767846, 4376.956230437719, 4389.18800021997, 3900.570937196906, 3952.2293152834923, 3953.525576930787, 3964.5638979712207, 3987.1029018470613, 5386.649867758583, 5391.81128660495, 5393.6763794172475, 5398.91901621476, 5402.91895621566, 5493.752781124859, 5538.44615538451, 5622.971885140548, 5626.324841019104, 5681.147827825859, 5291.973540132275, 5335.119705248668, 5341.786328546892, 5353.357597088374, 5419.864503387447, 4848.3454733610515, 4851.902961940741, 4857.271409288635, 4863.076015557032, 4912.140375434285, 5665.546756259571, 5738.081906894877, 5789.53683705311, 5806.68063256525, 5808.448197421239, 5532.253145825423, 5626.156076588544, 5703.743331550173, 5718.170865224436, 5795.043817770021, 5889.911651325319, 5907.2911250650195, 5911.408859114054, 5913.113033045078, 5918.496927761016, 5606.215129881902, 5628.493435590816, 5629.071203251581, 5633.63381380209, 5635.042042852643, 5539.7784088636, 5582.944170558242, 5770.826875193751, 5795.94204057954, 5821.388754180919, 5661.122526008476, 5663.8867222656145, 5664.348599910898, 5664.895345407606, 5725.2843394575675, 5549.556035517229, 5569.19246709233, 5592.608517403743, 5608.4111168326735, 5611.691356975405, 5390.0, 5442.945570544244, 5486.094794359045, 5506.2291279221745, 5529.502344788988, 5620.943790562042, 5630.324361076697, 5633.3521645009705, 5652.773889044557, 5680.659160450221, 5327.174287985368, 5517.337919449692, 5518.779248830002, 5521.4478552144465, 5524.80663176803], "value": 5231.341554695016, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.4808290309622, 595.2499850188761, 602.2381687165733, 605.2253116011501, 611.1901730207474, 26905.192844214682, 41653.375199372036, 41736.0, 42070.0, 42219.36670949938, 43363.78318108413, 43764.0, 43838.34242486357, 43858.342124868075, 43895.78052109735, 8174.427790054699, 8926.419782714136, 9068.8639670405, 9079.773005674844, 9084.13700698436, 8025.959870200641, 10441.84337234942, 10693.679189624285, 10695.251332406735, 11094.500747466343, 10953.83569246462, 10983.670489885277, 11014.50434730435, 11021.228514003982, 11025.558977640885, 8248.8350232995, 8451.619677114544, 10686.465676716172, 10760.515776790064, 10781.137508999262, 8330.291925186306, 8385.496870187808, 10334.224933130045, 10677.145828333792, 10682.0, 41196.38205426921, 41507.377389339184, 41521.37717934234, 41585.37621935673, 41606.79196604028, 3271.2149084219855, 3320.6181289151814, 3360.6975372216375, 3462.9307413851834, 3796.506454160969, 30848.691513084807, 31033.379332413224, 31168.53247201294, 31277.374452510823, 33076.83461582677, 4193.0, 4311.827526898952, 4373.671974601918, 4376.606105450524, 4425.535318791545, 346383.0, 347408.0, 348350.0, 348741.0, 348907.0, 55499.44500555024, 55711.0, 55785.721071394386, 55824.44175558274, 55864.72067639717, 58848.70575647095, 58897.705511472166, 58930.70534647299, 58968.41031589715, 58975.0, 16743.0, 16994.32022719102, 16996.0, 16997.660046798996, 17001.40495082691, 10677.145828333714, 10965.780684386267, 12982.415791289415, 13381.799273010913, 13485.325733713471, 15621.843781562266, 15624.3750249991, 15763.684726305639, 15774.211289435712, 15795.21023948798, 5916.0, 5947.661776100429, 5966.31387390447, 6050.909236361458, 6151.538634602333, 920.5259291464901, 1002.1031177096604, 1019.8164330420448, 1089.1450211584026, 1109.112709832131, 31471.41209424917, 31556.842215789235, 31977.52033719496, 32247.67752322447, 32767.542434317522, 1041.8280983637615, 1054.583439541377, 1061.7027232374946, 1117.6144230240554, 1132.005844541184, 16844.24200910962, 16874.409395671093, 16988.74516882248, 16992.490225293262, 17054.2325595346, 524811.0, 524923.0, 524940.0, 529148.0, 529767.0, 56753.14870276949, 57065.14402283969, 57122.0, 57221.71389143111, 57433.71283143557, 1201.2492192379764, 1221.157401393036, 1250.493550112188, 1280.692633767889, 1282.7434513097419, 30817.845910770302, 31876.362472749952, 32781.34437311288, 32843.671563284064, 33543.16142096467, 43410.56589434192, 43742.78128609336, 43751.78124109359, 43835.780821095694, 43851.0, 402871.0, 404352.0, 404770.0, 405138.0, 405577.0, 26523.734762652897, 27805.443891122468, 27868.16395508138, 29074.563881542217, 29262.853685732287, 46223.30665040094, 46627.30059049185, 47366.28950565675, 48105.27842082441, 48264.517354826, 38883.0, 39495.210095798495, 39585.60414395819, 41294.58705413028, 41621.79189104035, 39870.80064599658, 40295.39556906708, 40742.79628601838, 41115.588844111175, 41320.79339603283, 40177.39733903935, 40269.1946161081, 40820.59179408168, 41394.0, 41521.169576607695, 33959.660403396636, 36148.63851361558, 36520.0, 36993.0, 37146.25707485889, 27022.864885676234, 27490.587641185797, 27712.722872771013, 27832.304192394542, 27915.302117446416], "value": 19802.25593081588, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.0889797750566, 393.4079210787764, 401.7408771342484, 402.9234445455363, 423.49603971274183, 13217.537386191485, 15423.0, 17330.566735831595, 19669.21323147076, 19736.70394944077, 17509.7373539397, 18522.907385463088, 18558.536036599093, 18616.906915465403, 19802.801971980276, 5649.49154576088, 5689.260396148495, 5895.970520147414, 5906.409359064102, 5908.1433192187105, 5673.375928647845, 5716.28546431696, 5726.198332233491, 5743.224664670279, 5752.0, 5469.206964990094, 5721.742521586518, 5723.284589426322, 5729.0, 5730.942690573103, 5681.659100453965, 5693.686847223401, 5713.485786279255, 5729.856753581152, 5732.5987180897355, 4975.203967365204, 5077.1876499759865, 5087.236914462823, 5142.717150556718, 5149.716765577892, 23297.301080967598, 23301.0, 23605.173818916257, 23654.172103976278, 23816.880915595484, 2224.3882932193615, 2287.5081857400737, 2337.836351455399, 2581.38046868752, 2832.9942870281166, 14323.212223327713, 14501.854981450157, 14688.779668304984, 15222.923885380613, 15248.466303679428, 1648.6537827056331, 1674.7990241171137, 1697.4992377248618, 1700.0904516083835, 1752.1852338662457, 80087.0, 82494.76257856197, 83119.16880831236, 83406.58296708539, 83822.0, 10693.465326733787, 10699.197560183018, 10812.5134368952, 10960.506777195045, 11263.155263355282, 15369.462068827761, 15413.5375938722, 15422.922885385502, 15430.151341676315, 15430.382784688487, 8072.959635201786, 8360.414770965974, 8373.706920257762, 8612.267957223581, 8619.784505387415, 8021.318187954089, 8100.71647492335, 8149.0, 8422.284105851071, 8476.364272679573, 6412.487001039905, 6650.53446258767, 6664.233613134455, 6752.696128674222, 6813.4549236061985, 1925.3550060729813, 1967.5376286572643, 1989.2242025610024, 1999.5201151723481, 2004.2684420186526, 874.2743522875998, 1027.814993301198, 1033.9948300258602, 1083.4041277297456, 1086.625114335553, 19839.900800496194, 20536.79463205379, 20670.586588268452, 20861.061252243686, 21141.68287475689, 950.2635457520339, 984.1044649369182, 1008.1581879130861, 1017.1354348803458, 1048.0776916313596, 10469.424181669929, 11599.420028998516, 11680.88319116815, 11689.824652630217, 11690.88309116898, 427806.0, 433727.0, 442520.0, 443500.0, 444561.0, 48776.5122348772, 60102.0, 80481.19518804736, 82215.0, 84182.0, 992.8907820139779, 1010.7921034364011, 1016.3596933931576, 1023.2785885950387, 1032.055669062799, 16855.494335169966, 17125.828741712423, 17800.821991780434, 18173.90913045479, 18290.256471477343, 39728.0, 39807.51837619785, 40882.38676419797, 41093.0, 41603.92733235297, 52574.737126314125, 53775.46224537704, 54018.459815402915, 54560.72719636376, 55343.44656553544, 6249.375062493714, 8467.49195048299, 8607.655693772429, 8691.130886911258, 8905.109489051043, 13031.934840325737, 13079.476820927057, 13079.757423044795, 13329.0, 13344.266065366499, 11147.55409783632, 11251.156163287622, 11670.766584668429, 11686.824697629372, 11689.766204675689, 11219.158563107636, 11230.382328971986, 11425.885741142481, 11438.08495320389, 11588.94205528967, 11309.491072901574, 11638.70903227426, 11738.530458781554, 11816.350100744541, 11961.64115076549, 8285.378596605158, 8606.44058136219, 8685.689236041913, 8782.209601135928, 8824.514651693962, 11570.76858462843, 11631.53473861036, 11682.591109311134, 11782.410879455821, 12112.273263604213], "value": 9260.767303106137, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1244.663940736002, 1428.3643778518556, 1481.6740317130232, 1598.0, 1747.7977748037476, 7785.455018148725, 8377.664893404264, 8653.264472519828, 8752.562371881413, 8971.461712297267, 9052.864207036882, 9112.225460835836, 9118.0, 9121.087891210876, 9123.133302336284, 2316.83782135251, 2344.6014177589764, 2347.7652234776556, 2351.459164392191, 2353.8587684738886, 2329.37106981115, 2339.883005849709, 2386.522695460906, 2388.8088952883727, 2389.51015041916, 2321.4080409495555, 2336.0305473228673, 2349.706286714161, 2359.49270906755, 2360.775726305998, 2183.4541364658835, 2219.25654905606, 2220.6335954567476, 2223.8109760670363, 2226.1540614566525, 2256.2328808205125, 2257.977420225793, 2264.184893438361, 2264.52444986553, 2266.252136794854, 8364.958175209145, 8406.915930840736, 8509.064002959669, 8708.085651006617, 8769.912300876973, 4991.226359914219, 5159.922601160985, 5217.895642087175, 5221.817236396708, 5223.347081614798, 3385.4075536780965, 3409.8124603146816, 3455.2053027803495, 3478.130467383154, 3483.3904066788464, 1203.9097067719867, 1217.5555922088463, 1221.4869754703045, 1241.540629966918, 1256.805195194737, 12519.749605007848, 12742.745145097138, 12782.744345113046, 12788.808167877489, 12821.743565128738, 4349.325854492496, 4672.789724462339, 4681.250999840009, 4806.711597304173, 4863.0, 10861.1854110942, 10862.45687715611, 10862.674119776262, 10864.130869530418, 10869.0, 5019.42276638184, 5078.5175408336145, 5098.949010509921, 5102.209157580581, 5118.360204974379, 4246.915061698749, 4346.47842258931, 4399.1641588098155, 4569.9314510282375, 4711.905761884812, 3692.9630703693156, 3833.3483307837732, 3841.2125514270065, 3858.344081506151, 4120.464339635828, 1280.353421522144, 1289.5422125145626, 1317.3874148520983, 1318.7164759576738, 1323.3184909771476, 926.5228407370209, 947.7204224753714, 957.1003256938455, 959.5490119643756, 1000.6897861662908, 5572.108462645957, 5620.718964051863, 5817.825465236049, 5915.231019967377, 6233.158523599347, 471.6322664273634, 483.59619717536253, 967.4533888353058, 975.770693886936, 1041.1254546181092, 4009.69927255457, 4047.7571345719352, 4048.3117869962175, 4083.673306135502, 4117.958820411757, 10932.781344373068, 11339.433028348549, 11352.94323528377, 11355.829662555068, 11359.48882300282, 11086.223964322582, 11248.887511124947, 11280.153988450898, 11280.379579123228, 11281.0, 8278.875816862752, 8385.748427547183, 8455.196756308142, 8493.702720404879, 8495.980482342035, 5696.971515142398, 5835.591508594358, 5840.620359676607, 5879.029960056543, 6141.539384546088, 10219.437930913871, 10303.278770486293, 10308.226882983656, 10461.68614941553, 10465.633702820669, 9503.809923801347, 9986.400815951067, 9997.0, 10227.795444090927, 10276.22928280367, 7182.066331376887, 7422.257774222535, 7980.561069141253, 8153.470024448392, 8154.877676834971, 8438.367122465963, 8628.482291062557, 8694.08712085222, 8711.956440217758, 8899.688510902088, 7921.603919804102, 8076.636551355085, 8319.542425166674, 8339.291160251447, 8361.080281169188, 7858.292753652198, 7915.604219788872, 7923.801904952422, 8059.919400805917, 8189.385796065199, 7058.435325174077, 7060.117485314336, 7083.82290442743, 7104.751333703295, 7162.7493037743425, 5143.588512918883, 5280.551153152025, 5364.839054828361, 5365.543928766098, 5387.757550910297, 5265.131253343156, 5317.0, 5352.625316227826, 5371.5971302153275, 5491.423400543045], "value": 4652.253165411505, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.34822876589965, 330.3327278896628, 341.7573522798812, 343.5362260947721, 350.185817973212, 5294.39114501832, 5340.49265319795, 5340.706261155635, 5354.607801971486, 5365.892682146359, 4996.700197988123, 5089.3638295213095, 5135.0, 5137.58899288057, 5308.973455132728, 4122.660135455982, 4134.979325103371, 4150.3359462486005, 4159.958400416002, 4182.2890108681595, 4170.8540201092965, 4171.728837625545, 4178.686598505109, 4184.8535301264465, 4187.371894215877, 3893.98053009736, 3962.2075584882996, 4155.459790227266, 4156.771377574232, 4173.269677806387, 4091.774952377618, 4095.4675892133982, 4099.385092236159, 4104.835806567764, 4166.062635906927, 3666.211764470625, 3668.046307959923, 3679.0802299425145, 3685.649863262986, 3691.1325838427947, 5039.815643323816, 5124.461931497176, 5129.410117836459, 5140.820071297487, 5152.690838549699, 4672.556107169813, 4692.859214223578, 4714.222153344694, 4716.339712440261, 4722.433308003027, 5402.162664786964, 5424.674519528841, 5445.673259604437, 5448.030823201365, 5469.945300546983, 3927.803609819526, 3960.920781584381, 4030.9116538534727, 4044.090079732037, 4044.5146582410007, 5680.233168522238, 5709.343425506078, 5734.913976290359, 5735.225744524478, 5741.684207368593, 4182.644475219579, 4185.330347144442, 4186.05348512943, 4188.727732697365, 4193.993441574061, 4124.608162224584, 4231.915361692749, 4235.496398778389, 4235.703500754979, 4239.724417912826, 4733.018198534901, 4737.8341758038305, 4750.527336525619, 4756.096341695067, 4760.64295177863, 5524.1989911462615, 5527.281453411031, 5532.533878522115, 5536.117719975227, 5560.7219639017885, 1411.9364628591738, 1447.21126985793, 1455.199640197887, 1465.9780103298458, 1468.1191285228776, 942.6606421688186, 955.1690029674228, 956.7799406136628, 960.2222200017868, 970.2819913264275, 4476.977615111904, 4679.479169269933, 4710.62315014798, 4742.312364707098, 4770.352454387848, 4968.677035992649, 5006.874828129326, 5019.824306149268, 5027.497250274943, 5031.433968676001, 4766.76166191689, 4782.187028205213, 4785.712857228577, 4786.521347865186, 4788.569028787356, 2676.992255808144, 2681.230387943948, 2681.73393482507, 2690.9596356054676, 2842.630458040483, 5885.61743486672, 5910.113482977502, 5917.319508256605, 5920.674362909996, 5930.970345148246, 5821.79623713168, 5824.708764561839, 5834.795782147689, 5835.936133529846, 5841.977653910549, 5666.291713535808, 5831.88336233273, 5861.7655293787775, 5883.970580147072, 5893.882122357529, 5644.689542075225, 5650.378458369658, 5664.660120392789, 5670.298910326803, 5689.2319536862, 5419.701916394479, 5604.299462567179, 5622.971885140548, 5641.605087643826, 5656.37779844225, 5833.504152147115, 5856.472917437451, 5863.824085277449, 5885.264341957255, 5887.7056147191615, 4052.5339585946813, 4057.4522439471475, 4063.5530091689297, 4068.877933661995, 4070.5929407059057, 5365.87316663505, 5566.443355664401, 5592.636478628876, 5637.7864617167825, 5640.802571909963, 5532.806351777668, 5551.666899986014, 5560.082586373203, 5561.610687251854, 5562.749676264497, 5362.65142765719, 5530.86172845666, 5540.22436858832, 5545.556355491632, 5549.3363185671915, 5558.249636299048, 5579.911917176111, 5585.106382978704, 5588.720563971867, 5591.10542313228, 5587.69267690281, 5587.860303492445, 5611.709306859363, 5621.735109600308, 5634.154876768517, 5296.867578310419, 5503.504684578407, 5504.366997795145, 5509.47659972302, 5530.806421775219], "value": 4192.7810611276545, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.3430666779904, 774.9690012399504, 810.8297257575908, 813.5444151275283, 834.6577903059747, 13159.671008224786, 13982.230977296245, 14047.92976035121, 14053.367598458068, 14063.507777227785, 12727.363631818394, 12757.617271481848, 12766.297853618047, 12768.42542085606, 12784.296863672495, 647.5920170292709, 671.1007250284617, 778.6885245901628, 782.3897360059149, 799.5562462833125, 792.5482474989259, 805.7542449552884, 810.0522388805083, 810.6959890041235, 811.7929927868386, 859.9656013759442, 862.0991064337782, 862.8576284912982, 862.9309655227598, 863.0204717645486, 679.6805501414327, 702.8137543550963, 848.8175042365921, 850.3962186847345, 852.3394369363762, 605.5397897597858, 622.6450922973906, 626.589583822597, 626.8746250749823, 627.7175271128011, 13425.932870335684, 13432.328383580782, 13459.596212113653, 13461.192328460324, 13475.326233688374, 13466.865331346658, 14011.229382383965, 14127.434902603884, 14207.78688319676, 14355.56933292003, 11925.522979080826, 11994.64016079519, 12035.39823008846, 12039.819402708967, 12083.818742718866, 4349.586789255016, 4350.590643100559, 4399.5820397062225, 4455.598996090367, 4482.663800214997, 74760.62619686867, 75721.0, 75819.0, 76356.61821690912, 76559.0, 10843.67468975932, 10929.211224970877, 11206.551737930391, 11463.254888432226, 11546.0, 20997.475063123544, 21008.369748907557, 21050.578988420144, 21143.894280528806, 21181.682274765582, 7797.493162944391, 7874.685012599546, 7929.246721561442, 8046.678132874619, 8112.43212975086, 4273.850415235452, 4472.172648060119, 4561.612262957619, 4566.657500687462, 4656.3946686930485, 3259.7229235514774, 3370.5786776652917, 3372.494125881088, 3375.206826395795, 3378.1216883610437, 549.228334190463, 556.7327682712321, 559.7033572206736, 562.2297452490114, 575.068389209475, 527.1197100841604, 603.7916918663054, 658.8781075500951, 690.2062627977765, 705.1186017478152, 8237.640789269823, 8787.297016238814, 8847.426121543387, 8889.0, 8898.0, 644.4650939720021, 654.1855390039432, 665.3978149774462, 674.2919934069208, 703.2088899987514, 3821.636944490269, 4085.20338533983, 4193.1194449165405, 4209.473815773028, 4230.682698797603, 111978.0, 120022.399888, 123178.0, 125947.0, 127967.0, 103416.0, 105711.0, 107248.0, 107988.46005769921, 110222.44888775665, 56853.71573142191, 58137.70931145402, 89483.0, 91131.53210807373, 94553.52723236478, 7831.882521762064, 7867.685292588232, 7938.960305198437, 7985.441019128605, 8020.518768873886, 53731.19403209033, 53990.460095400114, 55111.0, 55367.0, 55891.72054139866, 71052.0, 76575.0, 78037.0, 78975.21024789909, 81745.59127204325, 10616.0, 11393.886061139614, 11565.537378505102, 11741.823872642088, 11970.640880773592, 12743.553975610808, 13062.216267024009, 13098.148620339647, 13433.462661493822, 13484.190948543119, 11865.347405892759, 12052.027879918789, 12362.938185309376, 12390.75218495607, 12403.25580465175, 11096.11231101526, 11338.768450991427, 11633.53465861356, 11646.0, 11656.53373865036, 10807.837882431613, 11290.0, 11299.152563557931, 11660.941695291809, 11662.94168529152, 8884.600192991202, 9086.273098152264, 9480.0, 9495.715128546155, 9873.802523949624, 8477.421604523102, 8657.91342086571, 9241.768955775891, 9421.434713917188, 9898.752531186778], "value": 7108.536492138202, "unit": "score"}], "name": "dromaeo_css", "value": 7144.868925373524, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 111.0, 112.0, 112.0, 112.0, 111.0, 112.0, 111.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 118.0, 162.0, 121.0, 120.0, 121.0, 121.0, 153.0, 118.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 160.0, 160.0, 160.0, 160.0, 161.0, 160.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 113.0, 78.0, 77.0, 77.0, 77.0, 98.0, 77.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 117.0, 82.0, 82.0, 82.0, 106.0, 83.0, 83.0, 110.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 146.0, 145.0, 145.0, 146.0, 147.0, 147.0, 147.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 51.0, 51.0, 53.0, 52.0, 52.0, 51.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 60.0, 59.0, 61.0, 59.0, 60.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 78.0, 78.0, 80.0, 78.0, 79.0, 87.0, 78.0, 80.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 132.0, 129.0, 125.0, 132.0, 139.0, 125.0, 125.0, 172.0, 133.0], "value": 133.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 167.0, 160.0, 166.0, 166.0, 167.0, 165.0, 162.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 67.0, 65.0, 64.0, 66.0, 67.0, 64.0, 66.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1489.5000000000002, "alertThreshold": 2.0}]} 15:42:53 INFO - Return code: 0 15:42:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:42:53 INFO - # TBPL SUCCESS # 15:42:53 INFO - Running post-action listener: _resource_record_post_action 15:42:53 INFO - [mozharness: 2016-09-22 22:42:53.345247Z] Finished run-tests step (success) 15:42:53 INFO - Running post-run listener: _resource_record_post_run 15:42:53 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 403349504; Read time: 0; Write time: 252284 15:42:53 INFO - TinderboxPrint: CPU usage
13.1% 15:42:53 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:42:53 INFO - TinderboxPrint: I/O write bytes / time
403,349,504 / 252,284 15:42:53 INFO - TinderboxPrint: CPU idle
8,286.3 (86.9%) 15:42:53 INFO - TinderboxPrint: CPU user
1,197.8 (12.6%) 15:42:53 INFO - TinderboxPrint: Swap in / out
0 / 0 15:42:53 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114376704; Read time: 0; Write time: 59872 15:42:53 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 287797248; Read time: 0; Write time: 192388 15:42:53 INFO - Running post-run listener: _upload_blobber_files 15:42:53 INFO - Blob upload gear active. 15:42:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:42:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:42:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:42:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:42:54 INFO - (blobuploader) - INFO - Open directory for files ... 15:42:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:42:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:42:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:55 INFO - (blobuploader) - INFO - Done attempting. 15:42:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:42:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:42:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:42:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:42:55 INFO - (blobuploader) - INFO - Done attempting. 15:42:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:42:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:42:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:43:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:43:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:43:00 INFO - (blobuploader) - INFO - Done attempting. 15:43:00 INFO - (blobuploader) - INFO - Iteration through files over. 15:43:00 INFO - Return code: 0 15:43:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:43:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:43:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee09e05a4a494aa0ade47ea1d877dc30dd907e06f32ebd182399d00219b3637433d1fbd22dd506ebc99b158b826df1db7698287b1111945bdd18ff7d1f18f601", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f225fba974cd7401499bdcfc48fc2c211066f3a97ce2c13bc6213b6ac7ace1372eca09ce7783edd5babeb6d7c4bdcea261060e8cea8dfb456b5b3ce1937aebe9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5277992f6383159f8676dc8ad5ff4f8810d8bf2341c0de9717239a4db4a3e53bdf3f190e328c6a8770f5542af8fc19234718c63acc30816ae368fc73e82c059f"} 15:43:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:43:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:43:00 INFO - Contents: 15:43:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee09e05a4a494aa0ade47ea1d877dc30dd907e06f32ebd182399d00219b3637433d1fbd22dd506ebc99b158b826df1db7698287b1111945bdd18ff7d1f18f601", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f225fba974cd7401499bdcfc48fc2c211066f3a97ce2c13bc6213b6ac7ace1372eca09ce7783edd5babeb6d7c4bdcea261060e8cea8dfb456b5b3ce1937aebe9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5277992f6383159f8676dc8ad5ff4f8810d8bf2341c0de9717239a4db4a3e53bdf3f190e328c6a8770f5542af8fc19234718c63acc30816ae368fc73e82c059f"} 15:43:00 INFO - Running post-run listener: copy_logs_to_upload_dir 15:43:00 INFO - Copying logs to upload dir... 15:43:00 INFO - mkdir: /builds/slave/test/build/upload/logs 15:43:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.823688 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-09-22 15:43:00.170544) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 15:43:00.173593) ========= 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=bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee09e05a4a494aa0ade47ea1d877dc30dd907e06f32ebd182399d00219b3637433d1fbd22dd506ebc99b158b826df1db7698287b1111945bdd18ff7d1f18f601", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f225fba974cd7401499bdcfc48fc2c211066f3a97ce2c13bc6213b6ac7ace1372eca09ce7783edd5babeb6d7c4bdcea261060e8cea8dfb456b5b3ce1937aebe9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5277992f6383159f8676dc8ad5ff4f8810d8bf2341c0de9717239a4db4a3e53bdf3f190e328c6a8770f5542af8fc19234718c63acc30816ae368fc73e82c059f"} build_url:https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/Xdn0RDCyRGS_444Vj6k0ng/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee09e05a4a494aa0ade47ea1d877dc30dd907e06f32ebd182399d00219b3637433d1fbd22dd506ebc99b158b826df1db7698287b1111945bdd18ff7d1f18f601", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f225fba974cd7401499bdcfc48fc2c211066f3a97ce2c13bc6213b6ac7ace1372eca09ce7783edd5babeb6d7c4bdcea261060e8cea8dfb456b5b3ce1937aebe9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5277992f6383159f8676dc8ad5ff4f8810d8bf2341c0de9717239a4db4a3e53bdf3f190e328c6a8770f5542af8fc19234718c63acc30816ae368fc73e82c059f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 15:43:00.198497) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 15:43:00.198828) ========= 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=bb9b54edd4a927dc735d112f000001d9-1474582886.60976-1813478517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 15:43:00.284244) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 15:43:00.284608) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 15:43:00.284987) ========= ========= Total master_lag: 0.39 =========