builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1474571705.42 results: success (0) buildid: 20160922093055 builduid: b98a252e318f472ab80142df5fd82c7b revision: 190e45ee01153267e1507726381f41379d2e3673 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 12:15:05.424779) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 12:15:05.425137) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 12:15:05.425404) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 12:15:05.443724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 12:15:05.443991) ========= 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=337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-22 12:15:05-- 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% 112M=0s 2016-09-22 12:15:05 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111009 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 12:15:05.568395) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 12:15:05.569879) ========= 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=337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020980 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 12:15:05.619966) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 12:15:05.620276) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 190e45ee01153267e1507726381f41379d2e3673 --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 190e45ee01153267e1507726381f41379d2e3673 --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=337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-22 12:15:05,891 truncating revision to first 12 chars 2016-09-22 12:15:05,891 Setting DEBUG logging. 2016-09-22 12:15:05,891 attempt 1/10 2016-09-22 12:15:05,891 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/190e45ee0115?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 12:15:06,431 unpacking tar archive at: fx-team-190e45ee0115/testing/mozharness/ program finished with exit code 0 elapsedTime=0.853408 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 12:15:06.492946) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 12:15:06.493257) ========= script_repo_revision: 190e45ee01153267e1507726381f41379d2e3673 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 12:15:06.493668) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 12:15:06.493936) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 12:15:06.501726) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-22 12:15:06.502002) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:15:06 INFO - MultiFileLogger online at 20160922 12:15:06 in /builds/slave/test 12:15:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:15:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:15:06 INFO - {'append_to_log': False, 12:15:06 INFO - 'base_work_dir': '/builds/slave/test', 12:15:06 INFO - 'blob_upload_branch': 'Fx-Team', 12:15:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:15:06 INFO - 'branch': 'Fx-Team', 12:15:06 INFO - 'buildbot_json_path': 'buildprops.json', 12:15:06 INFO - 'config_files': ('talos/linux_config.py',), 12:15:06 INFO - 'default_actions': ('clobber', 12:15:06 INFO - 'read-buildbot-config', 12:15:06 INFO - 'download-and-extract', 12:15:06 INFO - 'populate-webroot', 12:15:06 INFO - 'create-virtualenv', 12:15:06 INFO - 'install', 12:15:06 INFO - 'run-tests'), 12:15:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:15:06 INFO - 'download_minidump_stackwalk': True, 12:15:06 INFO - 'download_symbols': 'ondemand', 12:15:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:15:06 INFO - 'tooltool.py': '/tools/tooltool.py', 12:15:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:15:06 INFO - '/tools/misc-python/virtualenv.py')}, 12:15:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:15:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:15:06 INFO - 'installer_path': 'installer.exe', 12:15:06 INFO - 'log_level': 'info', 12:15:06 INFO - 'log_name': 'talos', 12:15:06 INFO - 'log_to_console': True, 12:15:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:15:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:15:06 INFO - 'opt_config_files': (), 12:15:06 INFO - 'pip_index': False, 12:15:06 INFO - 'sps_profile': False, 12:15:06 INFO - 'sps_profile_interval': 0, 12:15:06 INFO - 'suite': 'dromaeojs-e10s', 12:15:06 INFO - 'system_bits': '32', 12:15:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:15:06 INFO - 'title': 'talos-linux64-ix-060', 12:15:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:15:06 INFO - 'use_talos_json': True, 12:15:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:15:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:15:06 INFO - 'work_dir': 'build'} 12:15:06 INFO - [mozharness: 2016-09-22 19:15:06.869583Z] Running clobber step. 12:15:06 INFO - Running pre-action listener: _resource_record_pre_action 12:15:06 INFO - Running main action method: clobber 12:15:06 INFO - rmtree: /builds/slave/test/build 12:15:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:15:07 INFO - Running post-action listener: _resource_record_post_action 12:15:07 INFO - [mozharness: 2016-09-22 19:15:07.851990Z] Finished clobber step (success) 12:15:07 INFO - [mozharness: 2016-09-22 19:15:07.852092Z] Running read-buildbot-config step. 12:15:07 INFO - Running pre-action listener: _resource_record_pre_action 12:15:07 INFO - Running main action method: read_buildbot_config 12:15:07 INFO - Using buildbot properties: 12:15:07 INFO - { 12:15:07 INFO - "project": "", 12:15:07 INFO - "product": "firefox", 12:15:07 INFO - "script_repo_revision": "production", 12:15:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:15:07 INFO - "repository": "", 12:15:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 12:15:07 INFO - "buildid": "20160922093055", 12:15:07 INFO - "pgo_build": "True", 12:15:07 INFO - "basedir": "/builds/slave/test", 12:15:07 INFO - "buildnumber": 1195, 12:15:07 INFO - "slavename": "talos-linux64-ix-060", 12:15:07 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:15:07 INFO - "platform": "ubuntu64_hw", 12:15:07 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:15:07 INFO - "branch": "fx-team", 12:15:07 INFO - "repo_path": "integration/fx-team", 12:15:07 INFO - "revision": "190e45ee01153267e1507726381f41379d2e3673", 12:15:07 INFO - "stage_platform": "linux64-pgo", 12:15:07 INFO - "builduid": "b98a252e318f472ab80142df5fd82c7b", 12:15:07 INFO - "slavebuilddir": "test" 12:15:07 INFO - } 12:15:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:15:07 INFO - Running post-action listener: _resource_record_post_action 12:15:07 INFO - [mozharness: 2016-09-22 19:15:07.854538Z] Finished read-buildbot-config step (success) 12:15:07 INFO - [mozharness: 2016-09-22 19:15:07.854628Z] Running download-and-extract step. 12:15:07 INFO - Running pre-action listener: _resource_record_pre_action 12:15:07 INFO - Running main action method: download_and_extract 12:15:07 INFO - mkdir: /builds/slave/test/build/tests 12:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:07 INFO - trying https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:15:07 INFO - Downloading https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/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 12:15:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/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 12:15:08 INFO - Downloaded 1361 bytes. 12:15:08 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:15:08 INFO - Using the following test package requirements: 12:15:08 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:15:08 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:15:08 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:15:08 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:08 INFO - u'jsshell-linux-x86_64.zip'], 12:15:08 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:15:08 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:15:08 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:15:08 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:15:08 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:15:08 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:15:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:15:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:15:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:15:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:15:08 INFO - Fetch https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:15:08 INFO - Expected file size: 21944119 12:15:13 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 12:15:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:15:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:15:13 INFO - Fetch https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:15:13 INFO - Expected file size: 21944119 12:15:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:15:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:15:18 INFO - Fetch https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:15:19 INFO - Expected file size: 14414059 12:15:20 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')]} 12:15:20 INFO - trying https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:15:20 INFO - Downloading https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/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 12:15:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/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 12:15:22 INFO - Downloaded 59628517 bytes. 12:15:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:15:22 INFO - mkdir: /builds/slave/test/properties 12:15:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:15:22 INFO - Writing to file /builds/slave/test/properties/build_url 12:15:22 INFO - Contents: 12:15:22 INFO - build_url:https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:15:22 INFO - Running post-action listener: _resource_record_post_action 12:15:22 INFO - Running post-action listener: set_extra_try_arguments 12:15:22 INFO - [mozharness: 2016-09-22 19:15:22.981403Z] Finished download-and-extract step (success) 12:15:22 INFO - [mozharness: 2016-09-22 19:15:22.981693Z] Running populate-webroot step. 12:15:22 INFO - Running pre-action listener: _resource_record_pre_action 12:15:22 INFO - Running main action method: populate_webroot 12:15:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:15:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:15:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:15:22 INFO - '--tppagecycles', 12:15:22 INFO - '7'], 12:15:22 INFO - 'tests': ['tsvgm']}}, 12:15:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:15:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:15:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:15:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:15:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:15:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:15:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:22 INFO - 'talos_options': ['--disable-e10s'], 12:15:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:15:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:15:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:22 INFO - 'talos_options': ['--disable-e10s'], 12:15:22 INFO - 'tests': ['damp', 'tps']}, 12:15:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:22 INFO - 'tests': ['damp', 'tps']}, 12:15:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:15:22 INFO - 'tests': ['dromaeo_dom']}, 12:15:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:15:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:15:22 INFO - 'tests': ['basic_compositor_video']}, 12:15:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:15:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:15:22 INFO - 'tests': ['a11yr', 12:15:22 INFO - 'ts_paint', 12:15:22 INFO - 'tpaint', 12:15:22 INFO - 'sessionrestore', 12:15:22 INFO - 'sessionrestore_no_auto_restore', 12:15:22 INFO - 'tabpaint']}, 12:15:22 INFO - 'other-e10s': {'tests': ['a11yr', 12:15:22 INFO - 'ts_paint', 12:15:22 INFO - 'tpaint', 12:15:22 INFO - 'sessionrestore', 12:15:22 INFO - 'sessionrestore_no_auto_restore', 12:15:22 INFO - 'tabpaint']}, 12:15:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:15:22 INFO - 'ts_paint', 12:15:22 INFO - 'tpaint', 12:15:22 INFO - 'sessionrestore', 12:15:22 INFO - 'sessionrestore_no_auto_restore', 12:15:22 INFO - 'tabpaint']}, 12:15:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:15:22 INFO - 'ts_paint', 12:15:22 INFO - 'tpaint', 12:15:22 INFO - 'sessionrestore', 12:15:22 INFO - 'sessionrestore_no_auto_restore', 12:15:22 INFO - 'tabpaint']}, 12:15:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:15:22 INFO - 'tests': ['a11yr', 12:15:22 INFO - 'ts_paint', 12:15:22 INFO - 'tpaint', 12:15:22 INFO - 'sessionrestore', 12:15:22 INFO - 'sessionrestore_no_auto_restore', 12:15:22 INFO - 'tabpaint']}, 12:15:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:15:22 INFO - 'tests': ['a11yr', 12:15:22 INFO - 'ts_paint', 12:15:22 INFO - 'tpaint', 12:15:22 INFO - 'sessionrestore', 12:15:22 INFO - 'sessionrestore_no_auto_restore', 12:15:22 INFO - 'tabpaint']}, 12:15:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:15:22 INFO - 'tests': ['tsvgx', 12:15:22 INFO - 'tsvgr_opacity', 12:15:22 INFO - 'tart', 12:15:22 INFO - 'tscrollx', 12:15:22 INFO - 'cart']}, 12:15:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:15:22 INFO - 'tsvgr_opacity', 12:15:22 INFO - 'tart', 12:15:22 INFO - 'tscrollx', 12:15:22 INFO - 'cart']}, 12:15:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:22 INFO - 'talos_options': ['--disable-e10s'], 12:15:22 INFO - 'tests': ['tp5o']}, 12:15:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:22 INFO - 'tests': ['tp5o']}, 12:15:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:22 INFO - 'talos_options': ['--disable-e10s', 12:15:22 INFO - '--xperf_path', 12:15:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:15:22 INFO - 'tests': ['tp5n']}, 12:15:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:22 INFO - 'talos_options': ['--xperf_path', 12:15:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:15:22 INFO - 'tests': ['tp5n']}}, 12:15:22 INFO - 'talos.zip': {'path': '', 12:15:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:15:23 INFO - Running post-action listener: _resource_record_post_action 12:15:23 INFO - [mozharness: 2016-09-22 19:15:23.000120Z] Finished populate-webroot step (success) 12:15:23 INFO - [mozharness: 2016-09-22 19:15:23.000210Z] Running create-virtualenv step. 12:15:23 INFO - Running pre-action listener: _resource_record_pre_action 12:15:23 INFO - Running main action method: create_virtualenv 12:15:23 INFO - Creating virtualenv /builds/slave/test/build/venv 12:15:23 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 12:15:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:15:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:15:23 INFO - Using real prefix '/usr' 12:15:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:15:23 INFO - Installing distribute.............................................................................................................................................................................................done. 12:15:25 INFO - Installing pip.................done. 12:15:25 INFO - Return code: 0 12:15:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:15:25 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')]} 12:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:25 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')]} 12:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:25 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 0x7f9cc939ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cd790>, '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 0x15ce690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ceb20>, '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': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', '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 12:15:25 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 12:15:25 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 12:15:25 INFO - Using env: {'DISPLAY': ':0', 12:15:25 INFO - 'HOME': '/home/cltbld', 12:15:25 INFO - 'LANG': 'en_US.UTF-8', 12:15:25 INFO - 'LANGUAGE': 'en_US:en', 12:15:25 INFO - 'LOGNAME': 'cltbld', 12:15:25 INFO - 'MAIL': '/var/mail/cltbld', 12:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:25 INFO - 'MOZ_NO_REMOTE': '1', 12:15:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:25 INFO - 'NO_EM_RESTART': '1', 12:15:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:25 INFO - 'PWD': '/builds/slave/test', 12:15:25 INFO - 'SHELL': '/bin/bash', 12:15:25 INFO - 'SHLVL': '1', 12:15:25 INFO - 'TERM': 'linux', 12:15:25 INFO - 'TMOUT': '86400', 12:15:25 INFO - 'USER': 'cltbld', 12:15:25 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', 12:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:25 INFO - '_': '/tools/buildbot/bin/python'} 12:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:25 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 12:15:25 INFO - Cleaning up... 12:15:25 INFO - Return code: 0 12:15:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:15:25 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')]} 12:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:25 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')]} 12:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:25 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 0x7f9cc939ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cd790>, '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 0x15ce690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ceb20>, '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': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', '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 12:15:25 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 12:15:25 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 12:15:25 INFO - Using env: {'DISPLAY': ':0', 12:15:25 INFO - 'HOME': '/home/cltbld', 12:15:25 INFO - 'LANG': 'en_US.UTF-8', 12:15:25 INFO - 'LANGUAGE': 'en_US:en', 12:15:25 INFO - 'LOGNAME': 'cltbld', 12:15:25 INFO - 'MAIL': '/var/mail/cltbld', 12:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:25 INFO - 'MOZ_NO_REMOTE': '1', 12:15:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:25 INFO - 'NO_EM_RESTART': '1', 12:15:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:25 INFO - 'PWD': '/builds/slave/test', 12:15:25 INFO - 'SHELL': '/bin/bash', 12:15:25 INFO - 'SHLVL': '1', 12:15:25 INFO - 'TERM': 'linux', 12:15:25 INFO - 'TMOUT': '86400', 12:15:25 INFO - 'USER': 'cltbld', 12:15:25 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', 12:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:25 INFO - '_': '/tools/buildbot/bin/python'} 12:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:25 INFO - Downloading/unpacking psutil>=3.1.1 12:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:15:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:28 INFO - Installing collected packages: psutil 12:15:28 INFO - Running setup.py install for psutil 12:15:28 INFO - building 'psutil._psutil_linux' extension 12:15:28 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 12:15:28 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 12:15:28 INFO - building 'psutil._psutil_posix' extension 12:15:28 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 12:15:28 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 12:15:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:28 INFO - Successfully installed psutil 12:15:28 INFO - Cleaning up... 12:15:28 INFO - Return code: 0 12:15:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:15:28 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')]} 12:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:28 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')]} 12:15:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:28 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 0x7f9cc939ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cd790>, '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 0x15ce690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ceb20>, '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': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', '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 12:15:28 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 12:15:28 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 12:15:28 INFO - Using env: {'DISPLAY': ':0', 12:15:28 INFO - 'HOME': '/home/cltbld', 12:15:28 INFO - 'LANG': 'en_US.UTF-8', 12:15:28 INFO - 'LANGUAGE': 'en_US:en', 12:15:28 INFO - 'LOGNAME': 'cltbld', 12:15:28 INFO - 'MAIL': '/var/mail/cltbld', 12:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:28 INFO - 'MOZ_NO_REMOTE': '1', 12:15:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:28 INFO - 'NO_EM_RESTART': '1', 12:15:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:28 INFO - 'PWD': '/builds/slave/test', 12:15:28 INFO - 'SHELL': '/bin/bash', 12:15:28 INFO - 'SHLVL': '1', 12:15:28 INFO - 'TERM': 'linux', 12:15:28 INFO - 'TMOUT': '86400', 12:15:28 INFO - 'USER': 'cltbld', 12:15:28 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', 12:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:28 INFO - '_': '/tools/buildbot/bin/python'} 12:15:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:15:28 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 12:15:28 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 12:15:28 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 12:15:28 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 12:15:28 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 12:15:28 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 12:15:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:15:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:15:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:15:30 INFO - Installing collected packages: mozsystemmonitor 12:15:30 INFO - Running setup.py install for mozsystemmonitor 12:15:30 INFO - Successfully installed mozsystemmonitor 12:15:30 INFO - Cleaning up... 12:15:30 INFO - Return code: 0 12:15:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9cc939ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cd790>, '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 0x15ce690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ceb20>, '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': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', '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 12:15:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:15:30 INFO - Using env: {'DISPLAY': ':0', 12:15:30 INFO - 'HOME': '/home/cltbld', 12:15:30 INFO - 'LANG': 'en_US.UTF-8', 12:15:30 INFO - 'LANGUAGE': 'en_US:en', 12:15:30 INFO - 'LOGNAME': 'cltbld', 12:15:30 INFO - 'MAIL': '/var/mail/cltbld', 12:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:30 INFO - 'MOZ_NO_REMOTE': '1', 12:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:30 INFO - 'NO_EM_RESTART': '1', 12:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:30 INFO - 'PWD': '/builds/slave/test', 12:15:30 INFO - 'SHELL': '/bin/bash', 12:15:30 INFO - 'SHLVL': '1', 12:15:30 INFO - 'TERM': 'linux', 12:15:30 INFO - 'TMOUT': '86400', 12:15:30 INFO - 'USER': 'cltbld', 12:15:30 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', 12:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:30 INFO - '_': '/tools/buildbot/bin/python'} 12:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:31 INFO - Downloading/unpacking jsonschema==2.5.1 12:15:31 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 12:15:31 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 12:15:31 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 12:15:31 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 12:15:31 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 12:15:31 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 12:15:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:15:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:15:32 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 12:15:32 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 12:15:32 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 12:15:32 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 12:15:32 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 12:15:32 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 12:15:33 INFO - Downloading functools32-3.2.3-2.tar.gz 12:15:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:15:33 INFO - warning: no files found matching '*.txt' 12:15:33 INFO - no previously-included directories found matching 'build' 12:15:33 INFO - no previously-included directories found matching 'dist' 12:15:33 INFO - no previously-included directories found matching '.git*' 12:15:33 INFO - Installing collected packages: jsonschema, functools32 12:15:33 INFO - Running setup.py install for functools32 12:15:33 INFO - warning: no files found matching '*.txt' 12:15:33 INFO - no previously-included directories found matching 'build' 12:15:33 INFO - no previously-included directories found matching 'dist' 12:15:33 INFO - no previously-included directories found matching '.git*' 12:15:33 INFO - Successfully installed jsonschema functools32 12:15:33 INFO - Cleaning up... 12:15:33 INFO - Return code: 0 12:15:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:15: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')]} 12:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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')]} 12:15:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:33 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 0x7f9cc939ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cd790>, '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 0x15ce690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ceb20>, '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': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', '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 12:15:33 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 12:15:33 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 12:15:33 INFO - Using env: {'DISPLAY': ':0', 12:15:33 INFO - 'HOME': '/home/cltbld', 12:15:33 INFO - 'LANG': 'en_US.UTF-8', 12:15:33 INFO - 'LANGUAGE': 'en_US:en', 12:15:33 INFO - 'LOGNAME': 'cltbld', 12:15:33 INFO - 'MAIL': '/var/mail/cltbld', 12:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:33 INFO - 'MOZ_NO_REMOTE': '1', 12:15:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:33 INFO - 'NO_EM_RESTART': '1', 12:15:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:33 INFO - 'PWD': '/builds/slave/test', 12:15:33 INFO - 'SHELL': '/bin/bash', 12:15:33 INFO - 'SHLVL': '1', 12:15:33 INFO - 'TERM': 'linux', 12:15:33 INFO - 'TMOUT': '86400', 12:15:33 INFO - 'USER': 'cltbld', 12:15:33 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', 12:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:33 INFO - '_': '/tools/buildbot/bin/python'} 12:15:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:15:33 INFO - Cleaning up... 12:15:33 INFO - Return code: 0 12:15:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:15: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')]} 12:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15: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')]} 12:15:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:33 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 0x7f9cc939ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cd790>, '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 0x15ce690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ceb20>, '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': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', '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 12:15:33 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 12:15:33 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 12:15:33 INFO - Using env: {'DISPLAY': ':0', 12:15:33 INFO - 'HOME': '/home/cltbld', 12:15:33 INFO - 'LANG': 'en_US.UTF-8', 12:15:33 INFO - 'LANGUAGE': 'en_US:en', 12:15:33 INFO - 'LOGNAME': 'cltbld', 12:15:33 INFO - 'MAIL': '/var/mail/cltbld', 12:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:33 INFO - 'MOZ_NO_REMOTE': '1', 12:15:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:33 INFO - 'NO_EM_RESTART': '1', 12:15:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:33 INFO - 'PWD': '/builds/slave/test', 12:15:33 INFO - 'SHELL': '/bin/bash', 12:15:33 INFO - 'SHLVL': '1', 12:15:33 INFO - 'TERM': 'linux', 12:15:33 INFO - 'TMOUT': '86400', 12:15:33 INFO - 'USER': 'cltbld', 12:15:33 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', 12:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:33 INFO - '_': '/tools/buildbot/bin/python'} 12:15:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:33 INFO - Downloading/unpacking blobuploader==1.2.4 12:15:33 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 12:15:33 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 12:15:33 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 12:15:33 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 12:15:33 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 12:15:33 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 12:15:35 INFO - Downloading blobuploader-1.2.4.tar.gz 12:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:15:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:15:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:15:36 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 12:15:36 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 12:15:36 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 12:15:36 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 12:15:36 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 12:15:36 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 12:15:36 INFO - Downloading docopt-0.6.1.tar.gz 12:15:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:15:36 INFO - Installing collected packages: blobuploader, requests, docopt 12:15:36 INFO - Running setup.py install for blobuploader 12:15:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:15:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:15:36 INFO - Running setup.py install for requests 12:15:36 INFO - Running setup.py install for docopt 12:15:37 INFO - Successfully installed blobuploader requests docopt 12:15:37 INFO - Cleaning up... 12:15:37 INFO - Return code: 0 12:15:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:15:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:37 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 0x7f9cc939ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cd790>, '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 0x15ce690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ceb20>, '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': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', '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 12:15:37 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 12:15:37 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 12:15:37 INFO - Using env: {'DISPLAY': ':0', 12:15:37 INFO - 'HOME': '/home/cltbld', 12:15:37 INFO - 'LANG': 'en_US.UTF-8', 12:15:37 INFO - 'LANGUAGE': 'en_US:en', 12:15:37 INFO - 'LOGNAME': 'cltbld', 12:15:37 INFO - 'MAIL': '/var/mail/cltbld', 12:15:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:37 INFO - 'MOZ_NO_REMOTE': '1', 12:15:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:37 INFO - 'NO_EM_RESTART': '1', 12:15:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:37 INFO - 'PWD': '/builds/slave/test', 12:15:37 INFO - 'SHELL': '/bin/bash', 12:15:37 INFO - 'SHLVL': '1', 12:15:37 INFO - 'TERM': 'linux', 12:15:37 INFO - 'TMOUT': '86400', 12:15:37 INFO - 'USER': 'cltbld', 12:15:37 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', 12:15:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:37 INFO - '_': '/tools/buildbot/bin/python'} 12:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:37 INFO - Running setup.py (path:/tmp/pip-ojuWWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:37 INFO - Running setup.py (path:/tmp/pip-lLjp4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:37 INFO - Running setup.py (path:/tmp/pip-4Shm6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:37 INFO - Running setup.py (path:/tmp/pip-nQoIkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:37 INFO - Running setup.py (path:/tmp/pip-PrxnG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:37 INFO - Running setup.py (path:/tmp/pip-_bQdrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:37 INFO - Running setup.py (path:/tmp/pip-l1UZS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:37 INFO - Running setup.py (path:/tmp/pip-VD9q_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:37 INFO - Running setup.py (path:/tmp/pip-W0znDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:38 INFO - Running setup.py (path:/tmp/pip-AZhxAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:38 INFO - Running setup.py (path:/tmp/pip-JXoWP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:38 INFO - Running setup.py (path:/tmp/pip-dF4u8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:38 INFO - Running setup.py (path:/tmp/pip-imsLJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:38 INFO - Running setup.py (path:/tmp/pip-VQ5Izo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:38 INFO - Running setup.py (path:/tmp/pip-fEyay5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:38 INFO - Running setup.py (path:/tmp/pip-mzulAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:38 INFO - Running setup.py (path:/tmp/pip-Ant8Mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:15:38 INFO - Running setup.py install for manifestparser 12:15:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:15:38 INFO - Running setup.py install for mozcrash 12:15:38 INFO - Running setup.py install for mozdebug 12:15:38 INFO - Running setup.py install for mozdevice 12:15:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:15:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:15:39 INFO - Running setup.py install for mozfile 12:15:39 INFO - Running setup.py install for mozhttpd 12:15:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:15:39 INFO - Running setup.py install for mozinfo 12:15:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:15:39 INFO - Running setup.py install for mozInstall 12:15:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:15:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:15:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:15:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:15:39 INFO - Running setup.py install for mozleak 12:15:39 INFO - Running setup.py install for mozlog 12:15:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:15:39 INFO - Running setup.py install for moznetwork 12:15:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:15:39 INFO - Running setup.py install for mozprocess 12:15:39 INFO - Running setup.py install for mozprofile 12:15:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:15:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:15:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:15:39 INFO - Running setup.py install for mozrunner 12:15:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:15:40 INFO - Running setup.py install for mozscreenshot 12:15:40 INFO - Running setup.py install for moztest 12:15:40 INFO - Running setup.py install for mozversion 12:15:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:15:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:15:40 INFO - Cleaning up... 12:15:40 INFO - Return code: 0 12:15:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:40 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')]} 12:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:40 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')]} 12:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:40 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 0x7f9cc939ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cd790>, '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 0x15ce690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ceb20>, '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': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', '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 12:15:40 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 12:15:40 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 12:15:40 INFO - Using env: {'DISPLAY': ':0', 12:15:40 INFO - 'HOME': '/home/cltbld', 12:15:40 INFO - 'LANG': 'en_US.UTF-8', 12:15:40 INFO - 'LANGUAGE': 'en_US:en', 12:15:40 INFO - 'LOGNAME': 'cltbld', 12:15:40 INFO - 'MAIL': '/var/mail/cltbld', 12:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:40 INFO - 'MOZ_NO_REMOTE': '1', 12:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:40 INFO - 'NO_EM_RESTART': '1', 12:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:40 INFO - 'PWD': '/builds/slave/test', 12:15:40 INFO - 'SHELL': '/bin/bash', 12:15:40 INFO - 'SHLVL': '1', 12:15:40 INFO - 'TERM': 'linux', 12:15:40 INFO - 'TMOUT': '86400', 12:15:40 INFO - 'USER': 'cltbld', 12:15:40 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', 12:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:40 INFO - '_': '/tools/buildbot/bin/python'} 12:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:40 INFO - Running setup.py (path:/tmp/pip-h63EOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:40 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)) 12:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:40 INFO - Running setup.py (path:/tmp/pip-u5CK7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:40 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)) 12:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:40 INFO - Running setup.py (path:/tmp/pip-r6B6G2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:40 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)) 12:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:40 INFO - Running setup.py (path:/tmp/pip-xtODhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:15:40 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)) 12:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:15:40 INFO - Running setup.py (path:/tmp/pip-5cy4RD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:15:40 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)) 12:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:15:40 INFO - Running setup.py (path:/tmp/pip-IVqOLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:15:41 INFO - Running setup.py (path:/tmp/pip-SYEP1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:15:41 INFO - Running setup.py (path:/tmp/pip-oD79U9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:15:41 INFO - Running setup.py (path:/tmp/pip-VN_Y2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:15:41 INFO - Running setup.py (path:/tmp/pip-akhOzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:15:41 INFO - Running setup.py (path:/tmp/pip-EZI4my-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:15:41 INFO - Running setup.py (path:/tmp/pip-7Y_3PQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:15:41 INFO - Running setup.py (path:/tmp/pip-bOFlLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:15:41 INFO - Running setup.py (path:/tmp/pip-QGdZXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:41 INFO - Running setup.py (path:/tmp/pip-Lk46qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:15:41 INFO - Running setup.py (path:/tmp/pip-X46POA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:15:41 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)) 12:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:15:41 INFO - Running setup.py (path:/tmp/pip-gLNh64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:15:41 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)) 12:15:41 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)) 12:15:41 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)) 12:15:41 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)) 12:15:41 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)) 12:15:41 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)) 12:15:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15: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 12:15:43 INFO - Downloading blessings-1.6.tar.gz 12:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:15:43 INFO - Installing collected packages: blessings 12:15:43 INFO - Running setup.py install for blessings 12:15:43 INFO - Successfully installed blessings 12:15:43 INFO - Cleaning up... 12:15:44 INFO - Return code: 0 12:15:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:15:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:44 INFO - Reading from file tmpfile_stdout 12:15:44 INFO - Current package versions: 12:15:44 INFO - argparse == 1.2.1 12:15:44 INFO - blessings == 1.6 12:15:44 INFO - blobuploader == 1.2.4 12:15:44 INFO - docopt == 0.6.1 12:15:44 INFO - functools32 == 3.2.3-2 12:15:44 INFO - jsonschema == 2.5.1 12:15:44 INFO - manifestparser == 1.1 12:15:44 INFO - mozInstall == 1.12 12:15:44 INFO - mozcrash == 0.17 12:15:44 INFO - mozdebug == 0.1 12:15:44 INFO - mozdevice == 0.48 12:15:44 INFO - mozfile == 1.2 12:15:44 INFO - mozhttpd == 0.7 12:15:44 INFO - mozinfo == 0.9 12:15:44 INFO - mozleak == 0.1 12:15:44 INFO - mozlog == 3.4 12:15:44 INFO - moznetwork == 0.27 12:15:44 INFO - mozprocess == 0.23 12:15:44 INFO - mozprofile == 0.28 12:15:44 INFO - mozrunner == 6.12 12:15:44 INFO - mozscreenshot == 0.1 12:15:44 INFO - mozsystemmonitor == 0.3 12:15:44 INFO - moztest == 0.7 12:15:44 INFO - mozversion == 1.4 12:15:44 INFO - psutil == 3.1.1 12:15:44 INFO - requests == 1.2.3 12:15:44 INFO - wsgiref == 0.1.2 12:15:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:44 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')]} 12:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:44 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')]} 12:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:44 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 0x7f9cc939ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cd790>, '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 0x15ce690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ceb20>, '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': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', '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 12:15:44 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 12:15:44 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 12:15:44 INFO - Using env: {'DISPLAY': ':0', 12:15:44 INFO - 'HOME': '/home/cltbld', 12:15:44 INFO - 'LANG': 'en_US.UTF-8', 12:15:44 INFO - 'LANGUAGE': 'en_US:en', 12:15:44 INFO - 'LOGNAME': 'cltbld', 12:15:44 INFO - 'MAIL': '/var/mail/cltbld', 12:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:44 INFO - 'MOZ_NO_REMOTE': '1', 12:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:44 INFO - 'NO_EM_RESTART': '1', 12:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:44 INFO - 'PWD': '/builds/slave/test', 12:15:44 INFO - 'SHELL': '/bin/bash', 12:15:44 INFO - 'SHLVL': '1', 12:15:44 INFO - 'TERM': 'linux', 12:15:44 INFO - 'TMOUT': '86400', 12:15:44 INFO - 'USER': 'cltbld', 12:15:44 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', 12:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:44 INFO - '_': '/tools/buildbot/bin/python'} 12:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:44 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)) 12:15:44 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)) 12:15:44 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)) 12:15:44 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)) 12:15:44 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)) 12:15:44 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)) 12:15:44 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)) 12:15:44 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)) 12:15:44 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)) 12:15:44 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)) 12:15:44 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)) 12:15:44 INFO - Cleaning up... 12:15:44 INFO - Return code: 0 12:15:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:15:44 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')]} 12:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:44 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')]} 12:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:44 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 0x7f9cc939ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x153e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15cd790>, '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 0x15ce690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ceb20>, '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': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', '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 12:15:44 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 12:15:44 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 12:15:44 INFO - Using env: {'DISPLAY': ':0', 12:15:44 INFO - 'HOME': '/home/cltbld', 12:15:44 INFO - 'LANG': 'en_US.UTF-8', 12:15:44 INFO - 'LANGUAGE': 'en_US:en', 12:15:44 INFO - 'LOGNAME': 'cltbld', 12:15:44 INFO - 'MAIL': '/var/mail/cltbld', 12:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:44 INFO - 'MOZ_NO_REMOTE': '1', 12:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:15:44 INFO - 'NO_EM_RESTART': '1', 12:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:44 INFO - 'PWD': '/builds/slave/test', 12:15:44 INFO - 'SHELL': '/bin/bash', 12:15:44 INFO - 'SHLVL': '1', 12:15:44 INFO - 'TERM': 'linux', 12:15:44 INFO - 'TMOUT': '86400', 12:15:44 INFO - 'USER': 'cltbld', 12:15:44 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', 12:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:44 INFO - '_': '/tools/buildbot/bin/python'} 12:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:15:44 INFO - Cleaning up... 12:15:44 INFO - Return code: 0 12:15:44 INFO - Running post-action listener: _resource_record_post_action 12:15:44 INFO - Running post-action listener: _start_resource_monitoring 12:15:44 INFO - Starting resource monitoring. 12:15:44 INFO - [mozharness: 2016-09-22 19:15:44.693250Z] Finished create-virtualenv step (success) 12:15:44 INFO - [mozharness: 2016-09-22 19:15:44.693850Z] Running install step. 12:15:44 INFO - Running pre-action listener: _resource_record_pre_action 12:15:44 INFO - Running main action method: install 12:15:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:15:44 INFO - Reading from file tmpfile_stdout 12:15:44 INFO - Detecting whether we're running mozinstall >=1.0... 12:15:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:15:44 INFO - Reading from file tmpfile_stdout 12:15:44 INFO - Output received: 12:15:44 INFO - Usage: mozinstall [options] installer 12:15:44 INFO - Options: 12:15:44 INFO - -h, --help show this help message and exit 12:15:44 INFO - -d DEST, --destination=DEST 12:15:44 INFO - Directory to install application into. [default: 12:15:44 INFO - "/builds/slave/test"] 12:15:44 INFO - --app=APP Application being installed. [default: firefox] 12:15:44 INFO - mkdir: /builds/slave/test/build/application 12:15:44 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'] 12:15:44 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 12:16:02 INFO - Reading from file tmpfile_stdout 12:16:02 INFO - Output received: 12:16:02 INFO - /builds/slave/test/build/application/firefox/firefox 12:16:02 INFO - Running post-action listener: _resource_record_post_action 12:16:02 INFO - [mozharness: 2016-09-22 19:16:02.396814Z] Finished install step (success) 12:16:02 INFO - [mozharness: 2016-09-22 19:16:02.397060Z] Running run-tests step. 12:16:02 INFO - Running pre-action listener: _resource_record_pre_action 12:16:02 INFO - Running main action method: run_tests 12:16:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:16:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:16:02 INFO - Python 2.7.3 12:16:02 INFO - Return code: 0 12:16:02 INFO - grabbing minidump binary from tooltool 12:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:16:02 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 0x15cd790>, '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 0x15ce690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15ceb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:16:02 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 12:16:02 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 12:16:02 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 12:16:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:16:02 INFO - Return code: 0 12:16:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:16:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:16:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:16:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:16:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:16:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:16:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:16:02 INFO - Using env: {'DISPLAY': ':0', 12:16:02 INFO - 'HOME': '/home/cltbld', 12:16:02 INFO - 'LANG': 'en_US.UTF-8', 12:16:02 INFO - 'LANGUAGE': 'en_US:en', 12:16:02 INFO - 'LOGNAME': 'cltbld', 12:16:02 INFO - 'MAIL': '/var/mail/cltbld', 12:16:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:16:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:02 INFO - 'MOZ_NO_REMOTE': '1', 12:16:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:02 INFO - 'NO_EM_RESTART': '1', 12:16:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:02 INFO - 'PWD': '/builds/slave/test', 12:16:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:16:02 INFO - 'SHELL': '/bin/bash', 12:16:02 INFO - 'SHLVL': '1', 12:16:02 INFO - 'TERM': 'linux', 12:16:02 INFO - 'TMOUT': '86400', 12:16:02 INFO - 'USER': 'cltbld', 12:16:02 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010', 12:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:02 INFO - '_': '/tools/buildbot/bin/python'} 12:16:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:16:02 INFO - mozversion application_buildid: 20160922093055 12:16:02 INFO - mozversion application_changeset: 190e45ee01153267e1507726381f41379d2e3673 12:16:02 INFO - mozversion application_display_name: Nightly 12:16:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:16:02 INFO - mozversion application_name: Firefox 12:16:02 INFO - mozversion application_remotingname: firefox 12:16:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:16:02 INFO - mozversion application_vendor: Mozilla 12:16:02 INFO - mozversion application_version: 52.0a1 12:16:02 INFO - mozversion platform_buildid: 20160922093055 12:16:02 INFO - mozversion platform_changeset: 190e45ee01153267e1507726381f41379d2e3673 12:16:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:16:02 INFO - mozversion platform_version: 52.0a1 12:16:02 INFO - using testdate: 1474571762 12:16:02 INFO - actual date: 1474571762 12:16:02 INFO - starting webserver on 'localhost:44093' 12:16:02 INFO - SUITE-START | Running 2 tests 12:16:02 INFO - TEST-START | dromaeo_css 12:16:02 INFO - operating with platform_type : linux_ 12:16:02 INFO - Initialising browser for dromaeo_css test... 12:16:02 INFO - TEST-INFO | started process 14671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMqzlgW/profile http://localhost:44093/getInfo.html) 12:16:07 INFO - PROCESS | 14671 | __metrics Screen width/height:1600/1200 12:16:07 INFO - PROCESS | 14671 | colorDepth:24 12:16:07 INFO - PROCESS | 14671 | Browser inner width/height: 1024/697 12:16:07 INFO - PROCESS | 14671 | __metrics 12:16:07 ERROR - PROCESS | 14671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 12:16:08 INFO - TEST-INFO | 14671: exit 0 12:16:08 INFO - Browser initialized. 12:16:08 INFO - Running cycle 1/1 for dromaeo_css test... 12:16:08 INFO - TEST-INFO | started process 14795 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMqzlgW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:16:20 INFO - PROCESS | 14795 | RSS: Main: 185212928 12:16:20 INFO - PROCESS | 14795 | 12:17:10 INFO - PROCESS | 14795 | 1474571830598 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] 12:19:20 INFO - PROCESS | 14795 | Cycle 1(1): loaded http://localhost:44093/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44093/tests/dromaeo/cssquery-ext.html) 12:19:21 INFO - PROCESS | 14795 | RSS: Main: 202059776 12:19:21 INFO - PROCESS | 14795 | 12:22:23 INFO - PROCESS | 14795 | Cycle 1(1): loaded http://localhost:44093/tests/dromaeo/cssquery-ext.html (next: http://localhost:44093/tests/dromaeo/cssquery-jquery.html) 12:22:24 INFO - PROCESS | 14795 | RSS: Main: 198705152 12:22:24 INFO - PROCESS | 14795 | 12:25:26 INFO - PROCESS | 14795 | Cycle 1(1): loaded http://localhost:44093/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44093/tests/dromaeo/cssquery-mootools.html) 12:25:26 INFO - PROCESS | 14795 | RSS: Main: 198213632 12:25:26 INFO - PROCESS | 14795 | 12:28:28 INFO - PROCESS | 14795 | Cycle 1(1): loaded http://localhost:44093/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44093/tests/dromaeo/cssquery-prototype.html) 12:28:29 INFO - PROCESS | 14795 | RSS: Main: 194863104 12:28:29 INFO - PROCESS | 14795 | 12:31:32 INFO - PROCESS | 14795 | Cycle 1(1): loaded http://localhost:44093/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44093/tests/dromaeo/cssquery-yui.html) 12:31:32 INFO - PROCESS | 14795 | RSS: Main: 198414336 12:31:32 INFO - PROCESS | 14795 | 12:34:35 INFO - PROCESS | 14795 | Cycle 1(1): loaded http://localhost:44093/tests/dromaeo/cssquery-yui.html (next: http://localhost:44093/tests/dromaeo/cssquery-dojo.html) 12:34:35 INFO - PROCESS | 14795 | RSS: Main: 198778880 12:34:35 INFO - PROCESS | 14795 | 12:34:35 INFO - PROCESS | 14795 | __start_tp_report 12:34:35 INFO - PROCESS | 14795 | _x_x_mozilla_page_load 12:34:35 INFO - PROCESS | 14795 | _x_x_mozilla_page_load_details 12:34:35 INFO - PROCESS | 14795 | |i|pagename|runs| 12:34:35 INFO - PROCESS | 14795 | |0;dojo.html;3059.5563643271726;3069.140640620627;3092.8453577321143;3100.6279246490426;3116.298832762628;5103.8468845934585;5352.688591295138;5361.678299302044;5367.516923476886;5495.395506494282;5163.612729045318;5304.310439642841;5308.495692909168;5342.278792363039;5392.9191062134005;4811.542903424169;4861.416630004404;4910.7299098549565;4930.556249937505;4958.975205123969;4986.431987526426;4986.5013498650205;5031.42138654054;5034.471380505049;5044.167712327461;4792.760361981887;4850.442199147073;4861.319415281863;4893.804247830082;4943.876403089916;4897.4123105227245;4926.655134140576;4939.407271127452;4979.1784355581285;4998.57512111471;4843.443004054544;4898.387701537308;4902.509749025105;4907.11671899058;4967.180415231519;5199.740012999373;5240.97800928819;5309.920351194735;5360.678359298416;5373.704446255454;5650.011248031619;5704.714764261812;5762.596618236725;5792.1311803229855;5795.710214489259;5695.060315048012;5695.886082278373;5703.372629010805;5705.058665320217;5714.9714251428895;5185.351831021122;5238.764255608507;5330.38700549434;5340.385855626614;5367.8389648311;5874.706264686749;5919.200907877382;5926.4666180044005;5940.61386009908;5990.101484777319;5641.492265696107;5692.402297758758;5695.202671625976;5701.885962280731;5704.030314846403;5580.051391263495;5646.520045796071;5755.6834374108985;5788.594798364158;5796.739146738407;5709.3434255060365;5746;5761.567882408836;5783.277090363705;5850.912236316459;5753.568482363839;5779.2775903012125;5780.768769249267;5784.768609255667;5789.9710501447225;4354.412154359185;4448.977755111204;4468.865934021985;4471.776411179428;4523.88690282739;3911.8044097794996;3912.080661044652;3952.01199700075;3976.741511801724;4030.979845100756;5436.157395603688;5465.043617367024;5468;5477.28795256622;5477.780888764405;5704.686242256633;5705.486506214377;5753.539716822645;5770.451807078321;5846.532277417797;5278.366596008504;5278.49854263852;5335.919961200585;5418.647787893774;5429.049916264638;4917.803287868445;4919.532644398776;4928.975355123202;4933.28467372229;4972.900541989212;5890.057590785454;5934.8813023739285;5952.553558483044;5962.731677074456;5974.522038236931;5582.49757521825;5650.067738823048;5651.124075768263;5674.4892959633835;5783.421657834351;5876.706164691663;5881.235439392852;5891.558133140117;5941.435563621449;5951.345352011362;5491.615586908878;5550.250716153268;5572.582056345709;5590.972045139748;5596.076647353141;5547.472990065938;5607.2149899014985;5629.521490673339;5658.349289831557;5660.15097735343;5508.9724551376985;5583.888322233452;5591.273134492652;5654;5660.320761508646;5507.173923911445;5526.751296191601;5544.1960915666195;5568.192612071146;5573.888522229614;5351.5718742501285;5453.345598528202;5497.312835895513;5507.779688812403;5529;5667.971660141838;5685.77256909719;5689.886202276014;5727;5754.510866576388;5506.64206826555;5535.612507124462;5539.972300138474;5546.140348246028;5559.888802223852 12:34:35 INFO - PROCESS | 14795 | |1;ext.html;552.6498495718583;569.9487046165845;583.5477504933676;584.9853753656156;599.5772980049065;40145.39781903274;41713.16573668529;41731.79134104325;45156;45251;43864;43923.56076439234;44323.33514997269;44355.11289774202;44494.55505444945;8822.647094116228;9026.909730902706;9028.50343231122;9035.322350823682;9038.638454461814;8810.735677929672;8880.73357799267;8884;8889.333300002525;8891.42205756627;8896.06591307913;8973.28213742899;8979.236764874993;8983.281337492985;8996.505192214425;8831.381803273773;8852;8864.335174861879;8865.601047952825;8874.245689116433;8850.468971861645;8884.911150888473;8886.822263554757;8938.68714594986;8948.68679596211;41725.16549668989;42120.57879421197;42134;42213;42215.788921055195;3016.351484430858;3181;3306.1073510152364;3446.913827154316;3603.045193023851;31606.525902111487;31613.683863161303;32115.51826722601;32137.357252855047;32151.51772723411;4192.538820729717;4195.202911446846;4389.890252743707;4400.295952647593;4539.296409056601;313816;320426;320998;323566;323592.38203809067;31042.223944401117;54304.72847635736;54590.72704636451;54656.72671636617;54780.452195477534;37208.25583488315;37300.81349593234;37345.439818402745;37410.43884341737;37455.625443745215;12170.513179472899;12242.326672033123;12243.510259589517;12283.754324913452;12303.56937507183;10037.197024238043;10100.646477373257;10178.18574514037;10184.694459166238;10188.032136946978;8349.373796965252;8502.149785021573;8502.234798868009;8553.914460855312;8575.228229459379;3346;3350.7989520628353;3395.609504906918;3405.591329040531;3430.468277417004;946.7917058247175;971.9757006074905;1008.5259927833906;1020.7597768710904;1022.4529876516028;31163.844180779404;31356.529652055237;31521.211969700482;31955.201119972186;32153.839230804166;948.62055177928;1042.8957104289661;1073.5759375046812;1081.4430568257353;1092.4537731134433;15379.307931143125;15584;15789.605259868595;15950.361985520682;16277.430289939795;501380;502086;502406;503082;503515;57605;57605;57722.711386442796;57793;58134.4186558129;1309.0509380699107;1314.9474021039052;1328.920264784116;1334.499562664001;1336.1715736243398;28395.858020709766;29306.56040159442;29355.85322073376;29510.294463133;29725.256868578457;47410.76294618643;47611;47643.76178119087;47763.76118119387;47790.52209477861;422895;424195;425758;426492;426539;28093.438131237668;28129.156125316273;28171.43657126805;28517.287067823472;28576.14271571856;45651.77229537049;47675.52324476711;47906;50257.24614130864;52445;39101.41347879841;39152.608473916036;39276.555540557776;40858.38712419375;41841.58158418498;41484.792576036925;41488;41557.58442415537;41561.792191038854;41980.886880722304;39292.410613841384;39538.604613953496;40521.79739101286;41604;41926.371104432845;33725.83137084299;36136.81931590325;36812;37041.91025851899;37524.812375937945;28161.859190703915;28180.792990229867;28620;28709.712902870702;28765 12:34:35 INFO - PROCESS | 14795 | |2;jquery.html;382.95787463379025;384.71204593345834;392.19599820368245;393.8995556133186;410.24310147777356;18140.18369173387;18952.62094758104;19515.219391224353;19518.21927122915;19833.20667173315;17449.563760905952;17642.206100725467;17760.200790964405;18819.623607527876;18848.811511884876;5394.136938089907;5619.185218143357;5660.688662123582;5829.8834023319505;5897.144913987469;5561.666300021991;5580.414056524047;5591.9720401397935;5625.38120806711;5631.465010823965;5423.240746295522;5515.972420137894;5595.104783234683;5607.046802043662;5638.802641907534;5557.221988921554;5572.888542229132;5605.103183490663;5625.971870140664;5633.830985070414;4965.230389289666;5215.687058776448;5284.339457567804;5345.705986170759;5463.453654634544;13811.171329720148;14018.299085045808;14053;20837.479063023395;22481.662775058387;2121.533262682223;2223.0774228695072;2230.431240033797;2428.890699918508;2871.425714857037;9410.106039926264;9626.422414655142;9762.9511852441;14325.283735813271;14544.636384090376;1764.9322160093088;1816.727490876379;1822.7630408047003;1840.9263629454806;1886.283212379287;69269.65365173192;82700;83156.58421707913;83639.16360836374;83676.58161709213;10047.196224302039;10086.092251697382;10163.898361016443;10336.224783141144;10378.169746420268;13835.446582136803;13871.861281387259;13907.096038757449;13919.304034798422;14046.297685115704;6706.820283407815;6809.353111454404;6924.065251191126;7033.683484243222;7039.472039597051;6324.3991820776955;6419.422251997249;6498.54510184292;6518.152640156749;6584.045313429621;4172.165566886574;4188.204241194163;4281.807318670667;4363.759993200404;4370.104128653618;1750.2211515875567;1785.2858856457522;1808.0223508281833;1840.74229607855;1878.3238034307637;915.7573243090586;969.8808104292144;977.5112443778111;989.9852651032749;1062.5112448273726;19225.903870480557;19276.132574034204;19436.611267774566;19539.609207816047;19753.308634197732;955.06880791228;962.7567767102634;966.7003228998892;979.4123525884412;995.2784231432154;9700.854487182698;10602.151827853908;10642.467876606139;10739.83890241647;10924.672259832218;424349;432244;434716;435349;436672;84488.57755711181;85039.57480212684;86330;91823;95247.52376238075;994.2642444591095;1031.8452232165084;1044.6657069737762;1047.1831971062584;1055.5935964653663;17327.393541225996;17363;17455.127243637515;17966;18103.18535665872;40910.79544602258;42011;42772.786136069124;43091.56908430876;44189.558104418546;56238.43761562332;59805;60418.395816043034;61433;61653;8110.635021423932;8545.786355341166;8788.560571971248;8793.560321984003;8888.200371799414;11775.941120294687;12655.746885062432;12841.871581284067;13262.204267743966;13468.5286014989;11614.361210133524;11886.227395219283;11956.521739130338;12014.75970480603;12448.439820208294;11349.092072634334;11366.318020918772;11530.308181509135;11667.941660291644;11788.882111178778;11615.76768464643;11676.88323116758;11692.70768230801;12068.155229134227;12076.818847717115;8322.875156872773;8474.66101355939;8508.702195423379;8524.104968978168;8686;11709.531618735497;11771.764564708828;11828.526858925547;11955.581554645545;12013.879861201625 12:34:35 INFO - PROCESS | 14795 | |3;mootools.html;1413.9929300353497;1456.30825357955;1578.5895667126551;1726.7668864703262;1736.201347380205;7640.656170472328;7879.330256928168;8487.363447741413;9233.076692330773;9244.67643632473;8524.147585241473;8925.642974281038;8926.285897128231;9065.728028159148;9100.044495327995;2233.15140246706;2267.8979445924892;2267.977320226793;2269.8638081715067;2273.102124660758;2301.746807851135;2328.69726935499;2329.04509151248;2338.5206032763244;2355.4346956730346;2315.7452680205165;2325.1745630301252;2330.1611419888827;2361.645753137026;2369.158948573249;2207.9889600551974;2214.324630987548;2217.8780167090804;2228.565429741201;2237.88810559473;2249.5725812095648;2250.8424410291286;2252.3468194223656;2256.2216035467736;2260.8191344692386;8468.957655211747;8573.314134869195;8589.398742088057;9099.590518426687;9169.633214671405;5094.6688465249645;5187.429382767892;5194.740262986836;5200.1939699346285;5211.9218211726475;3154.2429816844024;3246.9837650811833;3360.714339281164;3362.159460134966;3362.3443428531446;1158.6697791129488;1159.2812456277077;1164.7495788405533;1172.5192671004932;1192.7435601345753;12795.744085118245;12801.231926084372;12874.678133046655;12876.80684789729;12880.420381082873;4698.506656801055;4771.761411929389;4809.955768798247;4836.153673107192;5032.823851165192;10664.78670426587;10721.83917241242;10745.301555398873;10823.404712740874;10831.566737330577;5168.302279192261;5205.453427390145;5233.450487698813;5259.63182577216;5277.208418737144;4183.226103170923;4331.848385306499;4646.581807637329;4801.68789028712;4832.299316599074;4021.687529670451;4030.7581545107387;4157.189348077157;4173.436586060903;4179.728317659343;1319.960401187966;1335.6994676197778;1340.2963444191682;1341.496938648007;1347.0907137682025;910.4673765846921;957.262907561174;957.8515330123842;967.1392460709974;971.358903123949;5749.965006298823;6157.753689852445;6166.674165054445;6215.968920155461;6260.937390626035;460.0522922779086;467.39238989313753;474.9311349854321;475.1731986343737;479.12798706354795;4238.660907127422;4241.533431322552;4247.936280955788;4284.828606855754;4303.71902891468;10816.459177041117;11168.385738784445;11262.380569068617;11278.774424511465;11346.602868899548;10275.332103413255;10770.084542813793;10774.569017239222;11253.156013299036;11254.324740515594;8036.156203598655;8282.213189746964;8298.377621678399;8300.335973122135;8321.08468068512;6039.849003774941;6123.326434092335;6182.752689892354;6202.906956395567;6314.084457753508;10161.644342447978;10431.269811113149;10491.68524944253;10652.242380007521;10678.14574834027;9834.360766550151;10258.743531411774;10347.689569312932;10579.418132002813;10594.629187978691;6923.826904327432;7182.245864184394;7198.640067996684;7863.488873223222;8006.719764808437;8022.91977080245;8274.875876861972;8300.83398332042;8341.624626891684;8351.665933362598;7455.813604659927;7523.548587084792;7604.619769011638;7657.157712651492;7733.419993500397;7286.7085316586745;7301.379382752525;7377.5204611700065;7429.07136607924;7470.813229669302;6742.292059333699;6770.2891196425635;6777.322267773183;6829.282925292773;6839.281875403011;4930.5069493050405;4994.875128121681;5115.232715092766;5265.947340526545;5286.920696189637;4961.652684312208;5098.1588037973315;5164.715940623302;5265;5319.308489896289 12:34:35 INFO - PROCESS | 14795 | |4;prototype.html;327.8819624935023;333.70300432614977;340.2735160432476;343.5568117128904;344.4179336920602;5441.755121019553;5509.917351239735;5528.281323427958;5529.474699903502;5531.806386776464;5448.128299472085;5459.808906688267;5464.235007099;5464.508194262516;5469.179623056543;4122.69079819014;4142.7514349139;4224.514180869209;4230.323148296273;4287.892802679942;4276.935845962313;4280.186764514732;4283.464566929134;4290.656747460196;4290.76400797956;4251.426057482231;4256.957430425702;4269.097014030458;4273.551277115905;4284.001199160584;3969.960300396988;4181.60274773896;4230.090530535949;4251.213525497793;4275;3730.7015438765106;3730.9253814923823;3731.9253614927547;3733.4399840023943;3733.7946412947276;5339.759710812984;5346.4118946915805;5367.141257398797;5374.5700343972385;5375.596830237748;4612.262038073892;4801.351817504662;4858.805647774085;4861.951380486185;4910.1898186799135;5699.344575373843;5707.543396528309;5721.971390143064;5723.942760572424;5751.942480575182;4093.9385909211387;4119.97940010298;4121.793910304473;4125.164301885662;4126.8761937141935;5897.675627840467;5944.316403613597;5986.161937328778;6001.349628852101;6091;4167.1457351242925;4167.229062623424;4172.061286210578;4175.457190565207;4178.540360560397;4216.756056963142;4245.874843166564;4247.362895565628;4261.31818908973;4270.829166833292;4659.464161621457;4823.421189457287;4887.633427492952;4910.165271903785;4913.361263035782;5680.835428737099;5733.082706766897;5758.654480731086;5765.538756899438;5774.653520788766;1445.9083392039154;1455.5415044261024;1473.9705205896037;1475.1370448287657;1476.5496523560416;887.4937022826844;938.5166639180827;950.4297421547154;969.1374676537887;1000.1398797034544;5453.700046497481;5466.3440387153005;5466.781328746885;5472.26124473199;5547.947259513925;5790.855228619318;5822.563307751935;5835.416458354215;5881.765129107036;5887.322957859816;5378.78484860609;5409.106812615553;5486.670799752028;5506.284183056177;5538.778448862081;3120.625524937022;3136.341368312634;3141.7329526990006;3148.165736079941;3161.604799400075;5826.73779679907;6017.849553761103;6028.758849645965;6037.849053773603;6074.696265186812;6063.302275362906;6076.696165191723;6090.3605121461605;6105.358937311518;6156.569040167145;6221.129041934133;6234.781782637586;6237.750489980441;6243.531735119975;6246;5659.292588426447;5943.64338139713;5982.790602328898;5991.281046274475;6025;5945.732442040205;5975.16347711312;5977.880442391041;5978.282606087123;5996.490298324691;5878;6146.692665366624;6180.938190618036;6242.219722534684;6275.811725648238;4205.443985725301;4228.492580890313;4234.428352172417;4235.501054377809;4244.702870799015;5964.821055368346;5989.251343582052;6004.399560044136;6012.669303188191;6017.488513476404;5650.943490565206;5775.94224057754;5789.681567513659;5799.536037116936;5899.646021238739;5787.247657804459;5799.246098007232;5803.81021890503;5828.154917537018;5830.271216097988;5369.758360873692;5692.4876761090045;5728.598998070095;5736.483716465538;5749.223854779719;5804.796832110856;5817.94182058174;5837.620554664103;5874.295084589877;5877.823665290048;5721.284839395075;5742.799002035076;5752.482276595127;5757.5393968481585;5759.222504961944 12:34:35 INFO - PROCESS | 14795 | |5;yui.html;673.245964519738;686.1217641418983;689.4656641103147;723.1539099253872;817.5952903312857;15057.322420491077;16137.031778093307;16192;16232;16285.348586056558;13483.730325393512;13575.864241357584;13637.454501819915;13701.10942788718;13793.310334483285;763.7365109037373;779.4076501858572;787.8345547435017;787.8424315136967;788.5978151142901;775.8874963130343;797.2943944609034;800.3957012455588;804.264098350012;807.4267270238138;849.995750021249;851.3699862102031;853.0445900591346;854.4915775113798;855.5935930433056;848.0459483081534;848.1094850407048;850.3707256630111;850.6129710981488;851.3529717414748;614.1923370767471;614.9815505534841;617.219217689623;619.0343064818896;621.4220774679546;13803.309834508334;13911.234882081482;14020.719585608333;14021.158730476203;14071.859281407158;14597.197154156516;14677.26613669323;14727.631809204748;14841.332140053615;14944.476943306932;11043.83434248487;11045.39250341231;11055.447227638586;11440.19918605698;11552.942235288854;3748.3440397930253;3756.793376364299;3782.546094468654;3862.111714305697;3966.6231707987695;84818.15181848164;86122.56938715329;86156;86297;87604;10567.365958042543;10651.147908167328;10861.565537378574;10910.9809487635;11012.496837342558;20056;20063.598728025358;20261;20421.285255016002;20471;7994.960025199837;8026.719064832703;8058.798530036679;8089.352851771844;8151.8777218341775;4080.2859499587453;4170.082581831992;4196.895077623084;4340.392345071693;4373.584509471595;3451.2234747181683;3508.0528257370365;3547.609762926076;3550.005998320474;3550.3786837303887;585.3941170888111;593.902006168986;600.8858316919772;615.0865964043392;615.5321955313993;692.4598812925926;729.9343059124704;737.7458320854569;764.6024067484876;786.0606575142764;9921.305508614329;9961.601535938482;10113.747156321151;10185.30089526276;10243.795124097476;689.6344937183301;717.1322699533519;719.2268311565089;726.9709211631475;750.692216191359;4781.285849668327;4836.879078023007;4888.608911287089;4896.3389942358035;5035.79856805731;62075.689621552505;94200.52899735457;95508.52245738865;98675.50662246786;110763;96873.51563242139;97135.51432242793;97542;98087.50956245173;99323;81147.18852811515;81547;86235.56882215549;87413;87778.56110719405;9587.856182157133;9757.56090975922;10114.393136411838;10164.339317944607;10217.080462758388;49296.26055609097;50197.74901125471;50781.492185077674;52055.82157887964;53615.463845361046;73874;77269.61365193139;77779;78076;78537;12221.327826969602;12293.139480236297;12368.1960672556;12751.808722868978;12878.227306361649;14279.42882284697;14394.856051439352;14788.260586970824;14842.77735833985;15246;13111.868881311064;13426.597202083953;13491.73016539644;14440.061396009645;14451.349689264218;12681.365931703562;13492.932535337653;13560.93219533896;13664.93167534156;14198.148111113367;12860.392450943633;12929.741405172032;13336.733265334833;13733;13759.179368229688;10786.514606842868;11311.660650180507;11319.886801131883;11384.487698053774;11722.120840937134;11135.498902549243;11990.340531270514;12017.09871759604;12185.268883866996;12254.142210045211 12:34:35 INFO - PROCESS | 14795 | __end_tp_report 12:34:35 INFO - PROCESS | 14795 | __start_cc_report 12:34:35 INFO - PROCESS | 14795 | _x_x_mozilla_cycle_collect,307 12:34:35 INFO - PROCESS | 14795 | __end_cc_report 12:34:35 INFO - PROCESS | 14795 | __startTimestamp1474572875519__endTimestamp 12:34:35 INFO - PROCESS | 14795 | 12:34:35 INFO - PROCESS | 14795 | ------- Summary: start ------- 12:34:35 INFO - PROCESS | 14795 | Number of tests: 6 12:34:35 INFO - PROCESS | 14795 | 12:34:35 INFO - PROCESS | 14795 | [#0] dojo.html Cycles:165 Average:5325.41 Median:5508.97 stddev:594.08 (10.8%) stddev-sans-first:568.69 12:34:35 INFO - PROCESS | 14795 | Values: 3059.6 3069.1 3092.8 3100.6 3116.3 5103.8 5352.7 5361.7 5367.5 5495.4 5163.6 5304.3 5308.5 5342.3 5392.9 4811.5 4861.4 4910.7 4930.6 4959.0 4986.4 4986.5 5031.4 5034.5 5044.2 4792.8 4850.4 4861.3 4893.8 4943.9 4897.4 4926.7 4939.4 4979.2 4998.6 4843.4 4898.4 4902.5 4907.1 4967.2 5199.7 5241.0 5309.9 5360.7 5373.7 5650.0 5704.7 5762.6 5792.1 5795.7 5695.1 5695.9 5703.4 5705.1 5715.0 5185.4 5238.8 5330.4 5340.4 5367.8 5874.7 5919.2 5926.5 5940.6 5990.1 5641.5 5692.4 5695.2 5701.9 5704.0 5580.1 5646.5 5755.7 5788.6 5796.7 5709.3 5746.0 5761.6 5783.3 5850.9 5753.6 5779.3 5780.8 5784.8 5790.0 4354.4 4449.0 4468.9 4471.8 4523.9 3911.8 3912.1 3952.0 3976.7 4031.0 5436.2 5465.0 5468.0 5477.3 5477.8 5704.7 5705.5 5753.5 5770.5 5846.5 5278.4 5278.5 5335.9 5418.6 5429.0 4917.8 4919.5 4929.0 4933.3 4972.9 5890.1 5934.9 5952.6 5962.7 5974.5 5582.5 5650.1 5651.1 5674.5 5783.4 5876.7 5881.2 5891.6 5941.4 5951.3 5491.6 5550.3 5572.6 5591.0 5596.1 5547.5 5607.2 5629.5 5658.3 5660.2 5509.0 5583.9 5591.3 5654.0 5660.3 5507.2 5526.8 5544.2 5568.2 5573.9 5351.6 5453.3 5497.3 5507.8 5529.0 5668.0 5685.8 5689.9 5727.0 5754.5 5506.6 5535.6 5540.0 5546.1 5559.9 12:34:35 INFO - PROCESS | 14795 | 12:34:35 INFO - PROCESS | 14795 | [#1] ext.html Cycles:180 Average:56471.66 Median:41658.58 stddev:112180.23 (269.3%) stddev-sans-first:112416.36 12:34:35 INFO - PROCESS | 14795 | Values: 552.6 569.9 583.5 585.0 599.6 40145.4 41713.2 41731.8 45156.0 45251.0 43864.0 43923.6 44323.3 44355.1 44494.6 8822.6 9026.9 9028.5 9035.3 9038.6 8810.7 8880.7 8884.0 8889.3 8891.4 8896.1 8973.3 8979.2 8983.3 8996.5 8831.4 8852.0 8864.3 8865.6 8874.2 8850.5 8884.9 8886.8 8938.7 8948.7 41725.2 42120.6 42134.0 42213.0 42215.8 3016.4 3181.0 3306.1 3446.9 3603.0 31606.5 31613.7 32115.5 32137.4 32151.5 4192.5 4195.2 4389.9 4400.3 4539.3 313816.0 320426.0 320998.0 323566.0 323592.4 31042.2 54304.7 54590.7 54656.7 54780.5 37208.3 37300.8 37345.4 37410.4 37455.6 12170.5 12242.3 12243.5 12283.8 12303.6 10037.2 10100.6 10178.2 10184.7 10188.0 8349.4 8502.1 8502.2 8553.9 8575.2 3346.0 3350.8 3395.6 3405.6 3430.5 946.8 972.0 1008.5 1020.8 1022.5 31163.8 31356.5 31521.2 31955.2 32153.8 948.6 1042.9 1073.6 1081.4 1092.5 15379.3 15584.0 15789.6 15950.4 16277.4 501380.0 502086.0 502406.0 503082.0 503515.0 57605.0 57605.0 57722.7 57793.0 58134.4 1309.1 1314.9 1328.9 1334.5 1336.2 28395.9 29306.6 29355.9 29510.3 29725.3 47410.8 47611.0 47643.8 47763.8 47790.5 422895.0 424195.0 425758.0 426492.0 426539.0 28093.4 28129.2 28171.4 28517.3 28576.1 45651.8 47675.5 47906.0 50257.2 52445.0 39101.4 39152.6 39276.6 40858.4 41841.6 41484.8 41488.0 41557.6 41561.8 41980.9 39292.4 39538.6 40521.8 41604.0 41926.4 33725.8 36136.8 36812.0 37041.9 37524.8 28161.9 28180.8 28620.0 28709.7 28765.0 12:34:35 INFO - PROCESS | 14795 | 12:34:35 INFO - PROCESS | 14795 | [#2] jquery.html Cycles:180 Average:27047.56 Median:20660.52 stddev:71701.24 (347.0%) stddev-sans-first:71874.43 12:34:35 INFO - PROCESS | 14795 | Values: 383.0 384.7 392.2 393.9 410.2 18140.2 18952.6 19515.2 19518.2 19833.2 17449.6 17642.2 17760.2 18819.6 18848.8 5394.1 5619.2 5660.7 5829.9 5897.1 5561.7 5580.4 5592.0 5625.4 5631.5 5423.2 5516.0 5595.1 5607.0 5638.8 5557.2 5572.9 5605.1 5626.0 5633.8 4965.2 5215.7 5284.3 5345.7 5463.5 13811.2 14018.3 14053.0 20837.5 22481.7 2121.5 2223.1 2230.4 2428.9 2871.4 9410.1 9626.4 9763.0 14325.3 14544.6 1764.9 1816.7 1822.8 1840.9 1886.3 69269.7 82700.0 83156.6 83639.2 83676.6 10047.2 10086.1 10163.9 10336.2 10378.2 13835.4 13871.9 13907.1 13919.3 14046.3 6706.8 6809.4 6924.1 7033.7 7039.5 6324.4 6419.4 6498.5 6518.2 6584.0 4172.2 4188.2 4281.8 4363.8 4370.1 1750.2 1785.3 1808.0 1840.7 1878.3 915.8 969.9 977.5 990.0 1062.5 19225.9 19276.1 19436.6 19539.6 19753.3 955.1 962.8 966.7 979.4 995.3 9700.9 10602.2 10642.5 10739.8 10924.7 424349.0 432244.0 434716.0 435349.0 436672.0 84488.6 85039.6 86330.0 91823.0 95247.5 994.3 1031.8 1044.7 1047.2 1055.6 17327.4 17363.0 17455.1 17966.0 18103.2 40910.8 42011.0 42772.8 43091.6 44189.6 56238.4 59805.0 60418.4 61433.0 61653.0 8110.6 8545.8 8788.6 8793.6 8888.2 11775.9 12655.7 12841.9 13262.2 13468.5 11614.4 11886.2 11956.5 12014.8 12448.4 11349.1 11366.3 11530.3 11667.9 11788.9 11615.8 11676.9 11692.7 12068.2 12076.8 8322.9 8474.7 8508.7 8524.1 8686.0 11709.5 11771.8 11828.5 11955.6 12013.9 12:34:35 INFO - PROCESS | 14795 | 12:34:35 INFO - PROCESS | 14795 | [#3] mootools.html Cycles:180 Average:5813.59 Median:475.05 stddev:3377.26 (710.9%) stddev-sans-first:3370.55 12:34:35 INFO - PROCESS | 14795 | Values: 1414.0 1456.3 1578.6 1726.8 1736.2 7640.7 7879.3 8487.4 9233.1 9244.7 8524.1 8925.6 8926.3 9065.7 9100.0 2233.2 2267.9 2268.0 2269.9 2273.1 2301.7 2328.7 2329.0 2338.5 2355.4 2315.7 2325.2 2330.2 2361.6 2369.2 2208.0 2214.3 2217.9 2228.6 2237.9 2249.6 2250.8 2252.3 2256.2 2260.8 8469.0 8573.3 8589.4 9099.6 9169.6 5094.7 5187.4 5194.7 5200.2 5211.9 3154.2 3247.0 3360.7 3362.2 3362.3 1158.7 1159.3 1164.7 1172.5 1192.7 12795.7 12801.2 12874.7 12876.8 12880.4 4698.5 4771.8 4810.0 4836.2 5032.8 10664.8 10721.8 10745.3 10823.4 10831.6 5168.3 5205.5 5233.5 5259.6 5277.2 4183.2 4331.8 4646.6 4801.7 4832.3 4021.7 4030.8 4157.2 4173.4 4179.7 1320.0 1335.7 1340.3 1341.5 1347.1 910.5 957.3 957.9 967.1 971.4 5750.0 6157.8 6166.7 6216.0 6260.9 460.1 467.4 474.9 475.2 479.1 4238.7 4241.5 4247.9 4284.8 4303.7 10816.5 11168.4 11262.4 11278.8 11346.6 10275.3 10770.1 10774.6 11253.2 11254.3 8036.2 8282.2 8298.4 8300.3 8321.1 6039.8 6123.3 6182.8 6202.9 6314.1 10161.6 10431.3 10491.7 10652.2 10678.1 9834.4 10258.7 10347.7 10579.4 10594.6 6923.8 7182.2 7198.6 7863.5 8006.7 8022.9 8274.9 8300.8 8341.6 8351.7 7455.8 7523.5 7604.6 7657.2 7733.4 7286.7 7301.4 7377.5 7429.1 7470.8 6742.3 6770.3 6777.3 6829.3 6839.3 4930.5 4994.9 5115.2 5265.9 5286.9 4961.7 5098.2 5164.7 5265.0 5319.3 12:34:35 INFO - PROCESS | 14795 | 12:34:35 INFO - PROCESS | 14795 | [#4] prototype.html Cycles:180 Average:4854.18 Median:5508.10 stddev:1444.50 (26.2%) stddev-sans-first:1408.03 12:34:35 INFO - PROCESS | 14795 | Values: 327.9 333.7 340.3 343.6 344.4 5441.8 5509.9 5528.3 5529.5 5531.8 5448.1 5459.8 5464.2 5464.5 5469.2 4122.7 4142.8 4224.5 4230.3 4287.9 4276.9 4280.2 4283.5 4290.7 4290.8 4251.4 4257.0 4269.1 4273.6 4284.0 3970.0 4181.6 4230.1 4251.2 4275.0 3730.7 3730.9 3731.9 3733.4 3733.8 5339.8 5346.4 5367.1 5374.6 5375.6 4612.3 4801.4 4858.8 4862.0 4910.2 5699.3 5707.5 5722.0 5723.9 5751.9 4093.9 4120.0 4121.8 4125.2 4126.9 5897.7 5944.3 5986.2 6001.3 6091.0 4167.1 4167.2 4172.1 4175.5 4178.5 4216.8 4245.9 4247.4 4261.3 4270.8 4659.5 4823.4 4887.6 4910.2 4913.4 5680.8 5733.1 5758.7 5765.5 5774.7 1445.9 1455.5 1474.0 1475.1 1476.5 887.5 938.5 950.4 969.1 1000.1 5453.7 5466.3 5466.8 5472.3 5547.9 5790.9 5822.6 5835.4 5881.8 5887.3 5378.8 5409.1 5486.7 5506.3 5538.8 3120.6 3136.3 3141.7 3148.2 3161.6 5826.7 6017.8 6028.8 6037.8 6074.7 6063.3 6076.7 6090.4 6105.4 6156.6 6221.1 6234.8 6237.8 6243.5 6246.0 5659.3 5943.6 5982.8 5991.3 6025.0 5945.7 5975.2 5977.9 5978.3 5996.5 5878.0 6146.7 6180.9 6242.2 6275.8 4205.4 4228.5 4234.4 4235.5 4244.7 5964.8 5989.3 6004.4 6012.7 6017.5 5650.9 5775.9 5789.7 5799.5 5899.6 5787.2 5799.2 5803.8 5828.2 5830.3 5369.8 5692.5 5728.6 5736.5 5749.2 5804.8 5817.9 5837.6 5874.3 5877.8 5721.3 5742.8 5752.5 5757.5 5759.2 12:34:35 INFO - PROCESS | 14795 | 12:34:35 INFO - PROCESS | 14795 | [#5] yui.html Cycles:180 Average:20341.90 Median:4356.99 stddev:28795.91 (660.9%) stddev-sans-first:28838.81 12:34:35 INFO - PROCESS | 14795 | Values: 673.2 686.1 689.5 723.2 817.6 15057.3 16137.0 16192.0 16232.0 16285.3 13483.7 13575.9 13637.5 13701.1 13793.3 763.7 779.4 787.8 787.8 788.6 775.9 797.3 800.4 804.3 807.4 850.0 851.4 853.0 854.5 855.6 848.0 848.1 850.4 850.6 851.4 614.2 615.0 617.2 619.0 621.4 13803.3 13911.2 14020.7 14021.2 14071.9 14597.2 14677.3 14727.6 14841.3 14944.5 11043.8 11045.4 11055.4 11440.2 11552.9 3748.3 3756.8 3782.5 3862.1 3966.6 84818.2 86122.6 86156.0 86297.0 87604.0 10567.4 10651.1 10861.6 10911.0 11012.5 20056.0 20063.6 20261.0 20421.3 20471.0 7995.0 8026.7 8058.8 8089.4 8151.9 4080.3 4170.1 4196.9 4340.4 4373.6 3451.2 3508.1 3547.6 3550.0 3550.4 585.4 593.9 600.9 615.1 615.5 692.5 729.9 737.7 764.6 786.1 9921.3 9961.6 10113.7 10185.3 10243.8 689.6 717.1 719.2 727.0 750.7 4781.3 4836.9 4888.6 4896.3 5035.8 62075.7 94200.5 95508.5 98675.5 110763.0 96873.5 97135.5 97542.0 98087.5 99323.0 81147.2 81547.0 86235.6 87413.0 87778.6 9587.9 9757.6 10114.4 10164.3 10217.1 49296.3 50197.7 50781.5 52055.8 53615.5 73874.0 77269.6 77779.0 78076.0 78537.0 12221.3 12293.1 12368.2 12751.8 12878.2 14279.4 14394.9 14788.3 14842.8 15246.0 13111.9 13426.6 13491.7 14440.1 14451.3 12681.4 13492.9 13560.9 13664.9 14198.1 12860.4 12929.7 13336.7 13733.0 13759.2 10786.5 11311.7 11319.9 11384.5 11722.1 11135.5 11990.3 12017.1 12185.3 12254.1 12:34:35 INFO - PROCESS | 14795 | -------- Summary: end -------- 12:34:35 INFO - PROCESS | 14795 | 12:34:36 INFO - TEST-INFO | 14795: exit 0 12:34:36 INFO - TEST-OK | dromaeo_css | took 1113914ms 12:34:36 INFO - TEST-START | kraken 12:34:36 INFO - operating with platform_type : linux_ 12:34:36 INFO - Initialising browser for kraken test... 12:34:36 INFO - TEST-INFO | started process 15157 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc04JQo/profile http://localhost:44093/getInfo.html) 12:34:41 INFO - PROCESS | 15157 | __metrics Screen width/height:1600/1200 12:34:41 INFO - PROCESS | 15157 | colorDepth:24 12:34:41 INFO - PROCESS | 15157 | Browser inner width/height: 1024/697 12:34:41 INFO - PROCESS | 15157 | __metrics 12:34:41 ERROR - PROCESS | 15157 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 12:34:42 INFO - TEST-INFO | 15157: exit 0 12:34:42 INFO - Browser initialized. 12:34:42 INFO - Running cycle 1/1 for kraken test... 12:34:42 INFO - TEST-INFO | started process 15282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc04JQo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:34:54 INFO - PROCESS | 15282 | RSS: Main: 184934400 12:34:54 INFO - PROCESS | 15282 | 12:34:57 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:44093/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44093/tests/kraken/driver.html?testName=audio-beat-detection) 12:34:58 INFO - PROCESS | 15282 | RSS: Main: 199528448 12:34:58 INFO - PROCESS | 15282 | 12:35:01 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:44093/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44093/tests/kraken/driver.html?testName=audio-dft) 12:35:01 INFO - PROCESS | 15282 | RSS: Main: 197406720 12:35:01 INFO - PROCESS | 15282 | 12:35:04 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:44093/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44093/tests/kraken/driver.html?testName=audio-fft) 12:35:05 INFO - PROCESS | 15282 | RSS: Main: 192430080 12:35:05 INFO - PROCESS | 15282 | 12:35:07 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:44093/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44093/tests/kraken/driver.html?testName=audio-oscillator) 12:35:08 INFO - PROCESS | 15282 | RSS: Main: 193298432 12:35:08 INFO - PROCESS | 15282 | 12:35:10 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:44093/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44093/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:35:10 INFO - PROCESS | 15282 | RSS: Main: 193384448 12:35:10 INFO - PROCESS | 15282 | 12:35:13 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:44093/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44093/tests/kraken/driver.html?testName=imaging-darkroom) 12:35:14 INFO - PROCESS | 15282 | RSS: Main: 193380352 12:35:14 INFO - PROCESS | 15282 | 12:35:18 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:44093/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44093/tests/kraken/driver.html?testName=imaging-desaturate) 12:35:18 INFO - PROCESS | 15282 | RSS: Main: 192167936 12:35:18 INFO - PROCESS | 15282 | 12:35:21 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:44093/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44093/tests/kraken/driver.html?testName=json-parse-financial) 12:35:22 INFO - PROCESS | 15282 | RSS: Main: 193560576 12:35:22 INFO - PROCESS | 15282 | 12:35:23 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:44093/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44093/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:35:24 INFO - PROCESS | 15282 | RSS: Main: 193585152 12:35:24 INFO - PROCESS | 15282 | 12:35:26 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:44093/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44093/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:35:26 INFO - PROCESS | 15282 | RSS: Main: 193671168 12:35:26 INFO - PROCESS | 15282 | 12:35:28 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:44093/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44093/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:35:29 INFO - PROCESS | 15282 | RSS: Main: 193568768 12:35:29 INFO - PROCESS | 15282 | 12:35:32 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:44093/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44093/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:35:32 INFO - PROCESS | 15282 | RSS: Main: 193634304 12:35:32 INFO - PROCESS | 15282 | 12:35:35 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:44093/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44093/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:35:36 INFO - PROCESS | 15282 | RSS: Main: 194478080 12:35:36 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | Cycle 1(1): loaded http://localhost:44093/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44093/tests/kraken/driver.html?testName=ai-astar) 12:35:38 INFO - PROCESS | 15282 | RSS: Main: 195194880 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | __start_tp_report 12:35:38 INFO - PROCESS | 15282 | _x_x_mozilla_page_load 12:35:38 INFO - PROCESS | 15282 | _x_x_mozilla_page_load_details 12:35:38 INFO - PROCESS | 15282 | |i|pagename|runs| 12:35:38 INFO - PROCESS | 15282 | |0;ai-astar;105;113;113;115;112;113;113;113;112;112 12:35:38 INFO - PROCESS | 15282 | |1;audio-beat-detection;163;122;120;175;128;120;119;121;154;120 12:35:38 INFO - PROCESS | 15282 | |2;audio-dft;162;162;163;166;183;166;164;163;166;169 12:35:38 INFO - PROCESS | 15282 | |3;audio-fft;77;76;77;109;79;76;77;76;104;78 12:35:38 INFO - PROCESS | 15282 | |4;audio-oscillator;83;88;110;84;83;83;105;83;83;115 12:35:38 INFO - PROCESS | 15282 | |5;imaging-gaussian-blur;118;118;122;117;118;118;119;118;117;118 12:35:38 INFO - PROCESS | 15282 | |6;imaging-darkroom;148;149;147;146;148;149;148;149;146;149 12:35:38 INFO - PROCESS | 15282 | |7;imaging-desaturate;98;96;96;97;95;96;95;97;96;95 12:35:38 INFO - PROCESS | 15282 | |8;json-parse-financial;53;53;52;52;53;55;54;63;52;54 12:35:38 INFO - PROCESS | 15282 | |9;json-stringify-tinderbox;61;61;61;60;60;61;61;61;61;60 12:35:38 INFO - PROCESS | 15282 | |10;stanford-crypto-aes;90;81;80;86;79;79;81;80;81;79 12:35:38 INFO - PROCESS | 15282 | |11;stanford-crypto-ccm;136;132;134;128;129;133;137;131;162;137 12:35:38 INFO - PROCESS | 15282 | |12;stanford-crypto-pbkdf2;167;168;164;164;162;166;164;165;163;162 12:35:38 INFO - PROCESS | 15282 | |13;stanford-crypto-sha256-iterative;66;70;67;66;64;67;64;65;65;65 12:35:38 INFO - PROCESS | 15282 | __end_tp_report 12:35:38 INFO - PROCESS | 15282 | __start_cc_report 12:35:38 INFO - PROCESS | 15282 | _x_x_mozilla_cycle_collect,790 12:35:38 INFO - PROCESS | 15282 | __end_cc_report 12:35:38 INFO - PROCESS | 15282 | __startTimestamp1474572938262__endTimestamp 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | ------- Summary: start ------- 12:35:38 INFO - PROCESS | 15282 | Number of tests: 14 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:2.64 (2.3%) stddev-sans-first:0.93 12:35:38 INFO - PROCESS | 15282 | Values: 105.0 113.0 113.0 115.0 112.0 113.0 113.0 113.0 112.0 112.0 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:125.00 stddev:21.30 (17.0%) stddev-sans-first:19.88 12:35:38 INFO - PROCESS | 15282 | Values: 163.0 122.0 120.0 175.0 128.0 120.0 119.0 121.0 154.0 120.0 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | [#2] audio-dft Cycles:10 Average:166.40 Median:166.00 stddev:6.24 (3.8%) stddev-sans-first:6.41 12:35:38 INFO - PROCESS | 15282 | Values: 162.0 162.0 163.0 166.0 183.0 166.0 164.0 163.0 166.0 169.0 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | [#3] audio-fft Cycles:10 Average:82.90 Median:77.00 stddev:12.53 (16.3%) stddev-sans-first:13.11 12:35:38 INFO - PROCESS | 15282 | Values: 77.0 76.0 77.0 109.0 79.0 76.0 77.0 76.0 104.0 78.0 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:83.00 stddev:12.94 (15.6%) stddev-sans-first:13.33 12:35:38 INFO - PROCESS | 15282 | Values: 83.0 88.0 110.0 84.0 83.0 83.0 105.0 83.0 83.0 115.0 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:1.42 (1.2%) stddev-sans-first:1.50 12:35:38 INFO - PROCESS | 15282 | Values: 118.0 118.0 122.0 117.0 118.0 118.0 119.0 118.0 117.0 118.0 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.50 stddev:1.20 (0.8%) stddev-sans-first:1.27 12:35:38 INFO - PROCESS | 15282 | Values: 148.0 149.0 147.0 146.0 148.0 149.0 148.0 149.0 146.0 149.0 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.99 (1.0%) stddev-sans-first:0.78 12:35:38 INFO - PROCESS | 15282 | Values: 98.0 96.0 96.0 97.0 95.0 96.0 95.0 97.0 96.0 95.0 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:53.50 stddev:3.28 (6.1%) stddev-sans-first:3.46 12:35:38 INFO - PROCESS | 15282 | Values: 53.0 53.0 52.0 52.0 53.0 55.0 54.0 63.0 52.0 54.0 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 12:35:38 INFO - PROCESS | 15282 | Values: 61.0 61.0 61.0 60.0 60.0 61.0 61.0 61.0 61.0 60.0 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:81.00 stddev:3.60 (4.4%) stddev-sans-first:2.18 12:35:38 INFO - PROCESS | 15282 | Values: 90.0 81.0 80.0 86.0 79.0 79.0 81.0 80.0 81.0 79.0 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:135.00 stddev:9.69 (7.2%) stddev-sans-first:10.28 12:35:38 INFO - PROCESS | 15282 | Values: 136.0 132.0 134.0 128.0 129.0 133.0 137.0 131.0 162.0 137.0 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:164.50 stddev:2.01 (1.2%) stddev-sans-first:1.92 12:35:38 INFO - PROCESS | 15282 | Values: 167.0 168.0 164.0 164.0 162.0 166.0 164.0 165.0 163.0 162.0 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.79 (2.7%) stddev-sans-first:1.90 12:35:38 INFO - PROCESS | 15282 | Values: 66.0 70.0 67.0 66.0 64.0 67.0 64.0 65.0 65.0 65.0 12:35:38 INFO - PROCESS | 15282 | -------- Summary: end -------- 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | 12:35:38 INFO - PROCESS | 15282 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 12:35:38 INFO - PROCESS | 15282 | 12:35:39 INFO - TEST-INFO | 15282: exit 0 12:35:39 INFO - TEST-OK | kraken | took 62757ms 12:35:39 INFO - SUITE-END | took 1176s 12:35:39 INFO - Completed test suite (00:19:36) 12:35:39 INFO - javascript benchmark 12:35:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7107.112603725064, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3059.5563643271726, 3069.140640620627, 3092.8453577321143, 3100.6279246490426, 3116.298832762628, 5103.8468845934585, 5352.688591295138, 5361.678299302044, 5367.516923476886, 5495.395506494282, 5163.612729045318, 5304.310439642841, 5308.495692909168, 5342.278792363039, 5392.9191062134005, 4811.542903424169, 4861.416630004404, 4910.7299098549565, 4930.556249937505, 4958.975205123969, 4986.431987526426, 4986.5013498650205, 5031.42138654054, 5034.471380505049, 5044.167712327461, 4792.760361981887, 4850.442199147073, 4861.319415281863, 4893.804247830082, 4943.876403089916, 4897.4123105227245, 4926.655134140576, 4939.407271127452, 4979.1784355581285, 4998.57512111471, 4843.443004054544, 4898.387701537308, 4902.509749025105, 4907.11671899058, 4967.180415231519, 5199.740012999373, 5240.97800928819, 5309.920351194735, 5360.678359298416, 5373.704446255454, 5650.011248031619, 5704.714764261812, 5762.596618236725, 5792.1311803229855, 5795.710214489259, 5695.060315048012, 5695.886082278373, 5703.372629010805, 5705.058665320217, 5714.9714251428895, 5185.351831021122, 5238.764255608507, 5330.38700549434, 5340.385855626614, 5367.8389648311, 5874.706264686749, 5919.200907877382, 5926.4666180044005, 5940.61386009908, 5990.101484777319, 5641.492265696107, 5692.402297758758, 5695.202671625976, 5701.885962280731, 5704.030314846403, 5580.051391263495, 5646.520045796071, 5755.6834374108985, 5788.594798364158, 5796.739146738407, 5709.3434255060365, 5746.0, 5761.567882408836, 5783.277090363705, 5850.912236316459, 5753.568482363839, 5779.2775903012125, 5780.768769249267, 5784.768609255667, 5789.9710501447225, 4354.412154359185, 4448.977755111204, 4468.865934021985, 4471.776411179428, 4523.88690282739, 3911.8044097794996, 3912.080661044652, 3952.01199700075, 3976.741511801724, 4030.979845100756, 5436.157395603688, 5465.043617367024, 5468.0, 5477.28795256622, 5477.780888764405, 5704.686242256633, 5705.486506214377, 5753.539716822645, 5770.451807078321, 5846.532277417797, 5278.366596008504, 5278.49854263852, 5335.919961200585, 5418.647787893774, 5429.049916264638, 4917.803287868445, 4919.532644398776, 4928.975355123202, 4933.28467372229, 4972.900541989212, 5890.057590785454, 5934.8813023739285, 5952.553558483044, 5962.731677074456, 5974.522038236931, 5582.49757521825, 5650.067738823048, 5651.124075768263, 5674.4892959633835, 5783.421657834351, 5876.706164691663, 5881.235439392852, 5891.558133140117, 5941.435563621449, 5951.345352011362, 5491.615586908878, 5550.250716153268, 5572.582056345709, 5590.972045139748, 5596.076647353141, 5547.472990065938, 5607.2149899014985, 5629.521490673339, 5658.349289831557, 5660.15097735343, 5508.9724551376985, 5583.888322233452, 5591.273134492652, 5654.0, 5660.320761508646, 5507.173923911445, 5526.751296191601, 5544.1960915666195, 5568.192612071146, 5573.888522229614, 5351.5718742501285, 5453.345598528202, 5497.312835895513, 5507.779688812403, 5529.0, 5667.971660141838, 5685.77256909719, 5689.886202276014, 5727.0, 5754.510866576388, 5506.64206826555, 5535.612507124462, 5539.972300138474, 5546.140348246028, 5559.888802223852], "value": 5285.864895163098, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.6498495718583, 569.9487046165845, 583.5477504933676, 584.9853753656156, 599.5772980049065, 40145.39781903274, 41713.16573668529, 41731.79134104325, 45156.0, 45251.0, 43864.0, 43923.56076439234, 44323.33514997269, 44355.11289774202, 44494.55505444945, 8822.647094116228, 9026.909730902706, 9028.50343231122, 9035.322350823682, 9038.638454461814, 8810.735677929672, 8880.73357799267, 8884.0, 8889.333300002525, 8891.42205756627, 8896.06591307913, 8973.28213742899, 8979.236764874993, 8983.281337492985, 8996.505192214425, 8831.381803273773, 8852.0, 8864.335174861879, 8865.601047952825, 8874.245689116433, 8850.468971861645, 8884.911150888473, 8886.822263554757, 8938.68714594986, 8948.68679596211, 41725.16549668989, 42120.57879421197, 42134.0, 42213.0, 42215.788921055195, 3016.351484430858, 3181.0, 3306.1073510152364, 3446.913827154316, 3603.045193023851, 31606.525902111487, 31613.683863161303, 32115.51826722601, 32137.357252855047, 32151.51772723411, 4192.538820729717, 4195.202911446846, 4389.890252743707, 4400.295952647593, 4539.296409056601, 313816.0, 320426.0, 320998.0, 323566.0, 323592.38203809067, 31042.223944401117, 54304.72847635736, 54590.72704636451, 54656.72671636617, 54780.452195477534, 37208.25583488315, 37300.81349593234, 37345.439818402745, 37410.43884341737, 37455.625443745215, 12170.513179472899, 12242.326672033123, 12243.510259589517, 12283.754324913452, 12303.56937507183, 10037.197024238043, 10100.646477373257, 10178.18574514037, 10184.694459166238, 10188.032136946978, 8349.373796965252, 8502.149785021573, 8502.234798868009, 8553.914460855312, 8575.228229459379, 3346.0, 3350.7989520628353, 3395.609504906918, 3405.591329040531, 3430.468277417004, 946.7917058247175, 971.9757006074905, 1008.5259927833906, 1020.7597768710904, 1022.4529876516028, 31163.844180779404, 31356.529652055237, 31521.211969700482, 31955.201119972186, 32153.839230804166, 948.62055177928, 1042.8957104289661, 1073.5759375046812, 1081.4430568257353, 1092.4537731134433, 15379.307931143125, 15584.0, 15789.605259868595, 15950.361985520682, 16277.430289939795, 501380.0, 502086.0, 502406.0, 503082.0, 503515.0, 57605.0, 57605.0, 57722.711386442796, 57793.0, 58134.4186558129, 1309.0509380699107, 1314.9474021039052, 1328.920264784116, 1334.499562664001, 1336.1715736243398, 28395.858020709766, 29306.56040159442, 29355.85322073376, 29510.294463133, 29725.256868578457, 47410.76294618643, 47611.0, 47643.76178119087, 47763.76118119387, 47790.52209477861, 422895.0, 424195.0, 425758.0, 426492.0, 426539.0, 28093.438131237668, 28129.156125316273, 28171.43657126805, 28517.287067823472, 28576.14271571856, 45651.77229537049, 47675.52324476711, 47906.0, 50257.24614130864, 52445.0, 39101.41347879841, 39152.608473916036, 39276.555540557776, 40858.38712419375, 41841.58158418498, 41484.792576036925, 41488.0, 41557.58442415537, 41561.792191038854, 41980.886880722304, 39292.410613841384, 39538.604613953496, 40521.79739101286, 41604.0, 41926.371104432845, 33725.83137084299, 36136.81931590325, 36812.0, 37041.91025851899, 37524.812375937945, 28161.859190703915, 28180.792990229867, 28620.0, 28709.712902870702, 28765.0], "value": 18319.672064713865, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.95787463379025, 384.71204593345834, 392.19599820368245, 393.8995556133186, 410.24310147777356, 18140.18369173387, 18952.62094758104, 19515.219391224353, 19518.21927122915, 19833.20667173315, 17449.563760905952, 17642.206100725467, 17760.200790964405, 18819.623607527876, 18848.811511884876, 5394.136938089907, 5619.185218143357, 5660.688662123582, 5829.8834023319505, 5897.144913987469, 5561.666300021991, 5580.414056524047, 5591.9720401397935, 5625.38120806711, 5631.465010823965, 5423.240746295522, 5515.972420137894, 5595.104783234683, 5607.046802043662, 5638.802641907534, 5557.221988921554, 5572.888542229132, 5605.103183490663, 5625.971870140664, 5633.830985070414, 4965.230389289666, 5215.687058776448, 5284.339457567804, 5345.705986170759, 5463.453654634544, 13811.171329720148, 14018.299085045808, 14053.0, 20837.479063023395, 22481.662775058387, 2121.533262682223, 2223.0774228695072, 2230.431240033797, 2428.890699918508, 2871.425714857037, 9410.106039926264, 9626.422414655142, 9762.9511852441, 14325.283735813271, 14544.636384090376, 1764.9322160093088, 1816.727490876379, 1822.7630408047003, 1840.9263629454806, 1886.283212379287, 69269.65365173192, 82700.0, 83156.58421707913, 83639.16360836374, 83676.58161709213, 10047.196224302039, 10086.092251697382, 10163.898361016443, 10336.224783141144, 10378.169746420268, 13835.446582136803, 13871.861281387259, 13907.096038757449, 13919.304034798422, 14046.297685115704, 6706.820283407815, 6809.353111454404, 6924.065251191126, 7033.683484243222, 7039.472039597051, 6324.3991820776955, 6419.422251997249, 6498.54510184292, 6518.152640156749, 6584.045313429621, 4172.165566886574, 4188.204241194163, 4281.807318670667, 4363.759993200404, 4370.104128653618, 1750.2211515875567, 1785.2858856457522, 1808.0223508281833, 1840.74229607855, 1878.3238034307637, 915.7573243090586, 969.8808104292144, 977.5112443778111, 989.9852651032749, 1062.5112448273726, 19225.903870480557, 19276.132574034204, 19436.611267774566, 19539.609207816047, 19753.308634197732, 955.06880791228, 962.7567767102634, 966.7003228998892, 979.4123525884412, 995.2784231432154, 9700.854487182698, 10602.151827853908, 10642.467876606139, 10739.83890241647, 10924.672259832218, 424349.0, 432244.0, 434716.0, 435349.0, 436672.0, 84488.57755711181, 85039.57480212684, 86330.0, 91823.0, 95247.52376238075, 994.2642444591095, 1031.8452232165084, 1044.6657069737762, 1047.1831971062584, 1055.5935964653663, 17327.393541225996, 17363.0, 17455.127243637515, 17966.0, 18103.18535665872, 40910.79544602258, 42011.0, 42772.786136069124, 43091.56908430876, 44189.558104418546, 56238.43761562332, 59805.0, 60418.395816043034, 61433.0, 61653.0, 8110.635021423932, 8545.786355341166, 8788.560571971248, 8793.560321984003, 8888.200371799414, 11775.941120294687, 12655.746885062432, 12841.871581284067, 13262.204267743966, 13468.5286014989, 11614.361210133524, 11886.227395219283, 11956.521739130338, 12014.75970480603, 12448.439820208294, 11349.092072634334, 11366.318020918772, 11530.308181509135, 11667.941660291644, 11788.882111178778, 11615.76768464643, 11676.88323116758, 11692.70768230801, 12068.155229134227, 12076.818847717115, 8322.875156872773, 8474.66101355939, 8508.702195423379, 8524.104968978168, 8686.0, 11709.531618735497, 11771.764564708828, 11828.526858925547, 11955.581554645545, 12013.879861201625], "value": 8903.560110169847, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.9929300353497, 1456.30825357955, 1578.5895667126551, 1726.7668864703262, 1736.201347380205, 7640.656170472328, 7879.330256928168, 8487.363447741413, 9233.076692330773, 9244.67643632473, 8524.147585241473, 8925.642974281038, 8926.285897128231, 9065.728028159148, 9100.044495327995, 2233.15140246706, 2267.8979445924892, 2267.977320226793, 2269.8638081715067, 2273.102124660758, 2301.746807851135, 2328.69726935499, 2329.04509151248, 2338.5206032763244, 2355.4346956730346, 2315.7452680205165, 2325.1745630301252, 2330.1611419888827, 2361.645753137026, 2369.158948573249, 2207.9889600551974, 2214.324630987548, 2217.8780167090804, 2228.565429741201, 2237.88810559473, 2249.5725812095648, 2250.8424410291286, 2252.3468194223656, 2256.2216035467736, 2260.8191344692386, 8468.957655211747, 8573.314134869195, 8589.398742088057, 9099.590518426687, 9169.633214671405, 5094.6688465249645, 5187.429382767892, 5194.740262986836, 5200.1939699346285, 5211.9218211726475, 3154.2429816844024, 3246.9837650811833, 3360.714339281164, 3362.159460134966, 3362.3443428531446, 1158.6697791129488, 1159.2812456277077, 1164.7495788405533, 1172.5192671004932, 1192.7435601345753, 12795.744085118245, 12801.231926084372, 12874.678133046655, 12876.80684789729, 12880.420381082873, 4698.506656801055, 4771.761411929389, 4809.955768798247, 4836.153673107192, 5032.823851165192, 10664.78670426587, 10721.83917241242, 10745.301555398873, 10823.404712740874, 10831.566737330577, 5168.302279192261, 5205.453427390145, 5233.450487698813, 5259.63182577216, 5277.208418737144, 4183.226103170923, 4331.848385306499, 4646.581807637329, 4801.68789028712, 4832.299316599074, 4021.687529670451, 4030.7581545107387, 4157.189348077157, 4173.436586060903, 4179.728317659343, 1319.960401187966, 1335.6994676197778, 1340.2963444191682, 1341.496938648007, 1347.0907137682025, 910.4673765846921, 957.262907561174, 957.8515330123842, 967.1392460709974, 971.358903123949, 5749.965006298823, 6157.753689852445, 6166.674165054445, 6215.968920155461, 6260.937390626035, 460.0522922779086, 467.39238989313753, 474.9311349854321, 475.1731986343737, 479.12798706354795, 4238.660907127422, 4241.533431322552, 4247.936280955788, 4284.828606855754, 4303.71902891468, 10816.459177041117, 11168.385738784445, 11262.380569068617, 11278.774424511465, 11346.602868899548, 10275.332103413255, 10770.084542813793, 10774.569017239222, 11253.156013299036, 11254.324740515594, 8036.156203598655, 8282.213189746964, 8298.377621678399, 8300.335973122135, 8321.08468068512, 6039.849003774941, 6123.326434092335, 6182.752689892354, 6202.906956395567, 6314.084457753508, 10161.644342447978, 10431.269811113149, 10491.68524944253, 10652.242380007521, 10678.14574834027, 9834.360766550151, 10258.743531411774, 10347.689569312932, 10579.418132002813, 10594.629187978691, 6923.826904327432, 7182.245864184394, 7198.640067996684, 7863.488873223222, 8006.719764808437, 8022.91977080245, 8274.875876861972, 8300.83398332042, 8341.624626891684, 8351.665933362598, 7455.813604659927, 7523.548587084792, 7604.619769011638, 7657.157712651492, 7733.419993500397, 7286.7085316586745, 7301.379382752525, 7377.5204611700065, 7429.07136607924, 7470.813229669302, 6742.292059333699, 6770.2891196425635, 6777.322267773183, 6829.282925292773, 6839.281875403011, 4930.5069493050405, 4994.875128121681, 5115.232715092766, 5265.947340526545, 5286.920696189637, 4961.652684312208, 5098.1588037973315, 5164.715940623302, 5265.0, 5319.308489896289], "value": 4565.158622509116, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.8819624935023, 333.70300432614977, 340.2735160432476, 343.5568117128904, 344.4179336920602, 5441.755121019553, 5509.917351239735, 5528.281323427958, 5529.474699903502, 5531.806386776464, 5448.128299472085, 5459.808906688267, 5464.235007099, 5464.508194262516, 5469.179623056543, 4122.69079819014, 4142.7514349139, 4224.514180869209, 4230.323148296273, 4287.892802679942, 4276.935845962313, 4280.186764514732, 4283.464566929134, 4290.656747460196, 4290.76400797956, 4251.426057482231, 4256.957430425702, 4269.097014030458, 4273.551277115905, 4284.001199160584, 3969.960300396988, 4181.60274773896, 4230.090530535949, 4251.213525497793, 4275.0, 3730.7015438765106, 3730.9253814923823, 3731.9253614927547, 3733.4399840023943, 3733.7946412947276, 5339.759710812984, 5346.4118946915805, 5367.141257398797, 5374.5700343972385, 5375.596830237748, 4612.262038073892, 4801.351817504662, 4858.805647774085, 4861.951380486185, 4910.1898186799135, 5699.344575373843, 5707.543396528309, 5721.971390143064, 5723.942760572424, 5751.942480575182, 4093.9385909211387, 4119.97940010298, 4121.793910304473, 4125.164301885662, 4126.8761937141935, 5897.675627840467, 5944.316403613597, 5986.161937328778, 6001.349628852101, 6091.0, 4167.1457351242925, 4167.229062623424, 4172.061286210578, 4175.457190565207, 4178.540360560397, 4216.756056963142, 4245.874843166564, 4247.362895565628, 4261.31818908973, 4270.829166833292, 4659.464161621457, 4823.421189457287, 4887.633427492952, 4910.165271903785, 4913.361263035782, 5680.835428737099, 5733.082706766897, 5758.654480731086, 5765.538756899438, 5774.653520788766, 1445.9083392039154, 1455.5415044261024, 1473.9705205896037, 1475.1370448287657, 1476.5496523560416, 887.4937022826844, 938.5166639180827, 950.4297421547154, 969.1374676537887, 1000.1398797034544, 5453.700046497481, 5466.3440387153005, 5466.781328746885, 5472.26124473199, 5547.947259513925, 5790.855228619318, 5822.563307751935, 5835.416458354215, 5881.765129107036, 5887.322957859816, 5378.78484860609, 5409.106812615553, 5486.670799752028, 5506.284183056177, 5538.778448862081, 3120.625524937022, 3136.341368312634, 3141.7329526990006, 3148.165736079941, 3161.604799400075, 5826.73779679907, 6017.849553761103, 6028.758849645965, 6037.849053773603, 6074.696265186812, 6063.302275362906, 6076.696165191723, 6090.3605121461605, 6105.358937311518, 6156.569040167145, 6221.129041934133, 6234.781782637586, 6237.750489980441, 6243.531735119975, 6246.0, 5659.292588426447, 5943.64338139713, 5982.790602328898, 5991.281046274475, 6025.0, 5945.732442040205, 5975.16347711312, 5977.880442391041, 5978.282606087123, 5996.490298324691, 5878.0, 6146.692665366624, 6180.938190618036, 6242.219722534684, 6275.811725648238, 4205.443985725301, 4228.492580890313, 4234.428352172417, 4235.501054377809, 4244.702870799015, 5964.821055368346, 5989.251343582052, 6004.399560044136, 6012.669303188191, 6017.488513476404, 5650.943490565206, 5775.94224057754, 5789.681567513659, 5799.536037116936, 5899.646021238739, 5787.247657804459, 5799.246098007232, 5803.81021890503, 5828.154917537018, 5830.271216097988, 5369.758360873692, 5692.4876761090045, 5728.598998070095, 5736.483716465538, 5749.223854779719, 5804.796832110856, 5817.94182058174, 5837.620554664103, 5874.295084589877, 5877.823665290048, 5721.284839395075, 5742.799002035076, 5752.482276595127, 5757.5393968481585, 5759.222504961944], "value": 4389.7764715652365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.245964519738, 686.1217641418983, 689.4656641103147, 723.1539099253872, 817.5952903312857, 15057.322420491077, 16137.031778093307, 16192.0, 16232.0, 16285.348586056558, 13483.730325393512, 13575.864241357584, 13637.454501819915, 13701.10942788718, 13793.310334483285, 763.7365109037373, 779.4076501858572, 787.8345547435017, 787.8424315136967, 788.5978151142901, 775.8874963130343, 797.2943944609034, 800.3957012455588, 804.264098350012, 807.4267270238138, 849.995750021249, 851.3699862102031, 853.0445900591346, 854.4915775113798, 855.5935930433056, 848.0459483081534, 848.1094850407048, 850.3707256630111, 850.6129710981488, 851.3529717414748, 614.1923370767471, 614.9815505534841, 617.219217689623, 619.0343064818896, 621.4220774679546, 13803.309834508334, 13911.234882081482, 14020.719585608333, 14021.158730476203, 14071.859281407158, 14597.197154156516, 14677.26613669323, 14727.631809204748, 14841.332140053615, 14944.476943306932, 11043.83434248487, 11045.39250341231, 11055.447227638586, 11440.19918605698, 11552.942235288854, 3748.3440397930253, 3756.793376364299, 3782.546094468654, 3862.111714305697, 3966.6231707987695, 84818.15181848164, 86122.56938715329, 86156.0, 86297.0, 87604.0, 10567.365958042543, 10651.147908167328, 10861.565537378574, 10910.9809487635, 11012.496837342558, 20056.0, 20063.598728025358, 20261.0, 20421.285255016002, 20471.0, 7994.960025199837, 8026.719064832703, 8058.798530036679, 8089.352851771844, 8151.8777218341775, 4080.2859499587453, 4170.082581831992, 4196.895077623084, 4340.392345071693, 4373.584509471595, 3451.2234747181683, 3508.0528257370365, 3547.609762926076, 3550.005998320474, 3550.3786837303887, 585.3941170888111, 593.902006168986, 600.8858316919772, 615.0865964043392, 615.5321955313993, 692.4598812925926, 729.9343059124704, 737.7458320854569, 764.6024067484876, 786.0606575142764, 9921.305508614329, 9961.601535938482, 10113.747156321151, 10185.30089526276, 10243.795124097476, 689.6344937183301, 717.1322699533519, 719.2268311565089, 726.9709211631475, 750.692216191359, 4781.285849668327, 4836.879078023007, 4888.608911287089, 4896.3389942358035, 5035.79856805731, 62075.689621552505, 94200.52899735457, 95508.52245738865, 98675.50662246786, 110763.0, 96873.51563242139, 97135.51432242793, 97542.0, 98087.50956245173, 99323.0, 81147.18852811515, 81547.0, 86235.56882215549, 87413.0, 87778.56110719405, 9587.856182157133, 9757.56090975922, 10114.393136411838, 10164.339317944607, 10217.080462758388, 49296.26055609097, 50197.74901125471, 50781.492185077674, 52055.82157887964, 53615.463845361046, 73874.0, 77269.61365193139, 77779.0, 78076.0, 78537.0, 12221.327826969602, 12293.139480236297, 12368.1960672556, 12751.808722868978, 12878.227306361649, 14279.42882284697, 14394.856051439352, 14788.260586970824, 14842.77735833985, 15246.0, 13111.868881311064, 13426.597202083953, 13491.73016539644, 14440.061396009645, 14451.349689264218, 12681.365931703562, 13492.932535337653, 13560.93219533896, 13664.93167534156, 14198.148111113367, 12860.392450943633, 12929.741405172032, 13336.733265334833, 13733.0, 13759.179368229688, 10786.514606842868, 11311.660650180507, 11319.886801131883, 11384.487698053774, 11722.120840937134, 11135.498902549243, 11990.340531270514, 12017.09871759604, 12185.268883866996, 12254.142210045211], "value": 7458.013424629375, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1512.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 115.0, 112.0, 113.0, 113.0, 113.0, 112.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 122.0, 120.0, 175.0, 128.0, 120.0, 119.0, 121.0, 154.0, 120.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 166.0, 183.0, 166.0, 164.0, 163.0, 166.0, 169.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 109.0, 79.0, 76.0, 77.0, 76.0, 104.0, 78.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 88.0, 110.0, 84.0, 83.0, 83.0, 105.0, 83.0, 83.0, 115.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 122.0, 117.0, 118.0, 118.0, 119.0, 118.0, 117.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 146.0, 148.0, 149.0, 148.0, 149.0, 146.0, 149.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 96.0, 97.0, 95.0, 96.0, 95.0, 97.0, 96.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 52.0, 53.0, 55.0, 54.0, 63.0, 52.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 60.0, 60.0, 61.0, 61.0, 61.0, 61.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 81.0, 80.0, 86.0, 79.0, 79.0, 81.0, 80.0, 81.0, 79.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 134.0, 128.0, 129.0, 133.0, 137.0, 131.0, 162.0, 137.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 164.0, 164.0, 162.0, 166.0, 164.0, 165.0, 163.0, 162.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 67.0, 66.0, 64.0, 67.0, 64.0, 65.0, 65.0, 65.0], "value": 65.9, "unit": "score"}]}]} 12:35:39 INFO - Return code: 0 12:35:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:35:39 ERROR - # TBPL SUCCESS # 12:35:39 INFO - Running post-action listener: _resource_record_post_action 12:35:39 INFO - [mozharness: 2016-09-22 19:35:39.556082Z] Finished run-tests step (success) 12:35:39 INFO - Running post-run listener: _resource_record_post_run 12:35:39 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 408662016; Read time: 84; Write time: 216820 12:35:39 INFO - TinderboxPrint: CPU usage
13.3% 12:35:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 84 12:35:39 INFO - TinderboxPrint: I/O write bytes / time
408,662,016 / 216,820 12:35:39 INFO - TinderboxPrint: CPU idle
8,252.4 (86.7%) 12:35:39 INFO - TinderboxPrint: CPU user
1,205.9 (12.7%) 12:35:39 INFO - TinderboxPrint: Swap in / out
0 / 0 12:35:39 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 111337472; Read time: 0; Write time: 44808 12:35:39 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287948800; Read time: 84; Write time: 170680 12:35:40 INFO - Running post-run listener: _upload_blobber_files 12:35:40 INFO - Blob upload gear active. 12:35:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:35:40 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 12:35:40 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'] 12:35:40 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 12:35:40 INFO - (blobuploader) - INFO - Open directory for files ... 12:35:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:35:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:35:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:41 INFO - (blobuploader) - INFO - Done attempting. 12:35:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:35:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:35:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:45 INFO - (blobuploader) - INFO - Done attempting. 12:35:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:35:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:35:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:35:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:35:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:35:46 INFO - (blobuploader) - INFO - Done attempting. 12:35:46 INFO - (blobuploader) - INFO - Iteration through files over. 12:35:46 INFO - Return code: 0 12:35:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:35:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:35:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/baba376760063028e395e3b3bad8b5806e106f1264332ada03bb4d990c82f34f623aa08584c84e58f91317ca4c90fa61eccabd706ce2f9d063ffde967ac3cbd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/005ae3808a738acda341363f3b124ccb75dbc5a4bf9e90f4c881638f99b77ff26699c686623d11c01dec2d37e165661ecc3463313fcb2a273f9c9665d99f6dd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54643d6db99598333f538603549b10d004118c8efc12045f5541854e1e82c99c74c8622933a48d0baf81b8a1b0dcb8e9d3ffce45d32f49f1d79bd879fe785713"} 12:35:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:35:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:35:46 INFO - Contents: 12:35:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/baba376760063028e395e3b3bad8b5806e106f1264332ada03bb4d990c82f34f623aa08584c84e58f91317ca4c90fa61eccabd706ce2f9d063ffde967ac3cbd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/005ae3808a738acda341363f3b124ccb75dbc5a4bf9e90f4c881638f99b77ff26699c686623d11c01dec2d37e165661ecc3463313fcb2a273f9c9665d99f6dd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54643d6db99598333f538603549b10d004118c8efc12045f5541854e1e82c99c74c8622933a48d0baf81b8a1b0dcb8e9d3ffce45d32f49f1d79bd879fe785713"} 12:35:46 INFO - Running post-run listener: copy_logs_to_upload_dir 12:35:46 INFO - Copying logs to upload dir... 12:35:46 INFO - mkdir: /builds/slave/test/build/upload/logs 12:35:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.109271 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-22 12:35:46.627274) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 12:35:46.631132) ========= 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=337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/baba376760063028e395e3b3bad8b5806e106f1264332ada03bb4d990c82f34f623aa08584c84e58f91317ca4c90fa61eccabd706ce2f9d063ffde967ac3cbd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/005ae3808a738acda341363f3b124ccb75dbc5a4bf9e90f4c881638f99b77ff26699c686623d11c01dec2d37e165661ecc3463313fcb2a273f9c9665d99f6dd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54643d6db99598333f538603549b10d004118c8efc12045f5541854e1e82c99c74c8622933a48d0baf81b8a1b0dcb8e9d3ffce45d32f49f1d79bd879fe785713"} build_url:https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/WKhEa59jThOrom2-hPTvRQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/baba376760063028e395e3b3bad8b5806e106f1264332ada03bb4d990c82f34f623aa08584c84e58f91317ca4c90fa61eccabd706ce2f9d063ffde967ac3cbd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/005ae3808a738acda341363f3b124ccb75dbc5a4bf9e90f4c881638f99b77ff26699c686623d11c01dec2d37e165661ecc3463313fcb2a273f9c9665d99f6dd6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/54643d6db99598333f538603549b10d004118c8efc12045f5541854e1e82c99c74c8622933a48d0baf81b8a1b0dcb8e9d3ffce45d32f49f1d79bd879fe785713"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 12:35:46.660960) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 12:35:46.661780) ========= 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=337fe3f4b1febe37b85fccc40000019e-1474570913.862606-615459010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 12:35:46.745717) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 12:35:46.746468) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 12:35:46.747182) ========= ========= Total master_lag: 0.18 =========