builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-034 starttime: 1474647309.38 results: success (0) buildid: 20160923085159 builduid: 8d0d5d0626dd41359a3be50a639b950f revision: 771ccd7f60258468517d532705ad83bb09d6ff64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 09:15:09.377492) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 09:15:09.377927) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 09:15:09.378438) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 09:15:09.419275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:15:09.419574) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-23 09:15:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.7M=0s 2016-09-23 09:15:10 (45.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084745 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:15:09.523663) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:15:09.524371) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019286 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:15:09.575485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 09:15:09.575865) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 771ccd7f60258468517d532705ad83bb09d6ff64 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 771ccd7f60258468517d532705ad83bb09d6ff64 --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=d6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-23 09:15:10,653 truncating revision to first 12 chars 2016-09-23 09:15:10,653 Setting DEBUG logging. 2016-09-23 09:15:10,653 attempt 1/10 2016-09-23 09:15:10,653 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/771ccd7f6025?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 09:15:11,986 unpacking tar archive at: autoland-771ccd7f6025/testing/mozharness/ program finished with exit code 0 elapsedTime=1.647268 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 09:15:11.237875) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 09:15:11.238305) ========= script_repo_revision: 771ccd7f60258468517d532705ad83bb09d6ff64 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 09:15:11.238752) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 09:15:11.239058) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 09:15:11.247731) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-09-23 09:15:11.248012) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=d6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:15:12 INFO - MultiFileLogger online at 20160923 09:15:12 in /builds/slave/test 09:15:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 09:15:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:15:12 INFO - {'append_to_log': False, 09:15:12 INFO - 'base_work_dir': '/builds/slave/test', 09:15:12 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 09:15:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:15:12 INFO - 'branch': 'Autoland-Non-PGO', 09:15:12 INFO - 'buildbot_json_path': 'buildprops.json', 09:15:12 INFO - 'config_files': ('talos/linux_config.py',), 09:15:12 INFO - 'default_actions': ('clobber', 09:15:12 INFO - 'read-buildbot-config', 09:15:12 INFO - 'download-and-extract', 09:15:12 INFO - 'populate-webroot', 09:15:12 INFO - 'create-virtualenv', 09:15:12 INFO - 'install', 09:15:12 INFO - 'run-tests'), 09:15:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:15:12 INFO - 'download_minidump_stackwalk': True, 09:15:12 INFO - 'download_symbols': 'ondemand', 09:15:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:15:12 INFO - 'tooltool.py': '/tools/tooltool.py', 09:15:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:15:12 INFO - '/tools/misc-python/virtualenv.py')}, 09:15:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:15:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:15:12 INFO - 'installer_path': 'installer.exe', 09:15:12 INFO - 'log_level': 'info', 09:15:12 INFO - 'log_name': 'talos', 09:15:12 INFO - 'log_to_console': True, 09:15:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:15:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:15:12 INFO - 'opt_config_files': (), 09:15:12 INFO - 'pip_index': False, 09:15:12 INFO - 'sps_profile': False, 09:15:12 INFO - 'sps_profile_interval': 0, 09:15:12 INFO - 'suite': 'dromaeojs', 09:15:12 INFO - 'system_bits': '32', 09:15:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:15:12 INFO - 'title': 'talos-linux64-ix-034', 09:15:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:15:12 INFO - 'use_talos_json': True, 09:15:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:15:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:15:12 INFO - 'work_dir': 'build'} 09:15:12 INFO - [mozharness: 2016-09-23 16:15:12.419455Z] Running clobber step. 09:15:12 INFO - Running pre-action listener: _resource_record_pre_action 09:15:12 INFO - Running main action method: clobber 09:15:12 INFO - rmtree: /builds/slave/test/build 09:15:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:15:12 INFO - Running post-action listener: _resource_record_post_action 09:15:12 INFO - [mozharness: 2016-09-23 16:15:12.874687Z] Finished clobber step (success) 09:15:12 INFO - [mozharness: 2016-09-23 16:15:12.874786Z] Running read-buildbot-config step. 09:15:12 INFO - Running pre-action listener: _resource_record_pre_action 09:15:12 INFO - Running main action method: read_buildbot_config 09:15:12 INFO - Using buildbot properties: 09:15:12 INFO - { 09:15:12 INFO - "project": "", 09:15:12 INFO - "product": "firefox", 09:15:12 INFO - "script_repo_revision": "production", 09:15:12 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 09:15:12 INFO - "repository": "", 09:15:12 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 09:15:12 INFO - "buildid": "20160923085159", 09:15:12 INFO - "pgo_build": "False", 09:15:12 INFO - "basedir": "/builds/slave/test", 09:15:12 INFO - "buildnumber": 634, 09:15:12 INFO - "slavename": "talos-linux64-ix-034", 09:15:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:15:12 INFO - "platform": "ubuntu64_hw", 09:15:12 INFO - "scheduler": "tests-autoland-linux64-talos", 09:15:12 INFO - "branch": "autoland", 09:15:12 INFO - "repo_path": "integration/autoland", 09:15:12 INFO - "revision": "771ccd7f60258468517d532705ad83bb09d6ff64", 09:15:12 INFO - "stage_platform": "linux64", 09:15:12 INFO - "builduid": "8d0d5d0626dd41359a3be50a639b950f", 09:15:12 INFO - "slavebuilddir": "test" 09:15:12 INFO - } 09:15:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:15:12 INFO - Running post-action listener: _resource_record_post_action 09:15:12 INFO - [mozharness: 2016-09-23 16:15:12.877228Z] Finished read-buildbot-config step (success) 09:15:12 INFO - [mozharness: 2016-09-23 16:15:12.877316Z] Running download-and-extract step. 09:15:12 INFO - Running pre-action listener: _resource_record_pre_action 09:15:12 INFO - Running main action method: download_and_extract 09:15:12 INFO - mkdir: /builds/slave/test/build/tests 09:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:12 INFO - trying https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:15:12 INFO - Downloading https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/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 09:15:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/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 09:15:13 INFO - Downloaded 1361 bytes. 09:15:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:15:13 INFO - Using the following test package requirements: 09:15:13 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:15:13 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:15:13 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:15:13 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:13 INFO - u'jsshell-linux-x86_64.zip'], 09:15:13 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:15:13 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:15:13 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:15:13 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:15:13 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:15:13 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:15:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:15:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:15:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:15:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:15:13 INFO - Fetch https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:15:14 INFO - Expected file size: 20377870 09:15:18 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 09:15:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:15:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:15:18 INFO - Fetch https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:15:18 INFO - Expected file size: 20377870 09:15:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:15:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:15:23 INFO - Fetch https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:15:24 INFO - Expected file size: 14414059 09: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')]} 09:15:25 INFO - trying https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:15:25 INFO - Downloading https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/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 09:15:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/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 09:15:28 INFO - Downloaded 55730090 bytes. 09:15:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:15:28 INFO - mkdir: /builds/slave/test/properties 09:15:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:15:28 INFO - Writing to file /builds/slave/test/properties/build_url 09:15:28 INFO - Contents: 09:15:28 INFO - build_url:https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:15:28 INFO - Running post-action listener: _resource_record_post_action 09:15:28 INFO - Running post-action listener: set_extra_try_arguments 09:15:28 INFO - [mozharness: 2016-09-23 16:15:28.718836Z] Finished download-and-extract step (success) 09:15:28 INFO - [mozharness: 2016-09-23 16:15:28.719063Z] Running populate-webroot step. 09:15:28 INFO - Running pre-action listener: _resource_record_pre_action 09:15:28 INFO - Running main action method: populate_webroot 09:15:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:15:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:15:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:15:28 INFO - '--tppagecycles', 09:15:28 INFO - '7'], 09:15:28 INFO - 'tests': ['tsvgm']}}, 09:15:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:15:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:15:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:15:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:15:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:15:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:15:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:28 INFO - 'talos_options': ['--disable-e10s'], 09:15:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:15:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:15:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:28 INFO - 'talos_options': ['--disable-e10s'], 09:15:28 INFO - 'tests': ['damp', 'tps']}, 09:15:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:28 INFO - 'tests': ['damp', 'tps']}, 09:15:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:15:28 INFO - 'tests': ['dromaeo_dom']}, 09:15:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:15:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:15:28 INFO - 'tests': ['basic_compositor_video']}, 09:15:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:15:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:15:28 INFO - 'tests': ['a11yr', 09:15:28 INFO - 'ts_paint', 09:15:28 INFO - 'tpaint', 09:15:28 INFO - 'sessionrestore', 09:15:28 INFO - 'sessionrestore_no_auto_restore', 09:15:28 INFO - 'tabpaint']}, 09:15:28 INFO - 'other-e10s': {'tests': ['a11yr', 09:15:28 INFO - 'ts_paint', 09:15:28 INFO - 'tpaint', 09:15:28 INFO - 'sessionrestore', 09:15:28 INFO - 'sessionrestore_no_auto_restore', 09:15:28 INFO - 'tabpaint']}, 09:15:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:15:28 INFO - 'ts_paint', 09:15:28 INFO - 'tpaint', 09:15:28 INFO - 'sessionrestore', 09:15:28 INFO - 'sessionrestore_no_auto_restore', 09:15:28 INFO - 'tabpaint']}, 09:15:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:15:28 INFO - 'ts_paint', 09:15:28 INFO - 'tpaint', 09:15:28 INFO - 'sessionrestore', 09:15:28 INFO - 'sessionrestore_no_auto_restore', 09:15:28 INFO - 'tabpaint']}, 09:15:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:15:28 INFO - 'tests': ['a11yr', 09:15:28 INFO - 'ts_paint', 09:15:28 INFO - 'tpaint', 09:15:28 INFO - 'sessionrestore', 09:15:28 INFO - 'sessionrestore_no_auto_restore', 09:15:28 INFO - 'tabpaint']}, 09:15:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:15:28 INFO - 'tests': ['a11yr', 09:15:28 INFO - 'ts_paint', 09:15:28 INFO - 'tpaint', 09:15:28 INFO - 'sessionrestore', 09:15:28 INFO - 'sessionrestore_no_auto_restore', 09:15:28 INFO - 'tabpaint']}, 09:15:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:15:28 INFO - 'tests': ['tsvgx', 09:15:28 INFO - 'tsvgr_opacity', 09:15:28 INFO - 'tart', 09:15:28 INFO - 'tscrollx', 09:15:28 INFO - 'cart']}, 09:15:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:15:28 INFO - 'tsvgr_opacity', 09:15:28 INFO - 'tart', 09:15:28 INFO - 'tscrollx', 09:15:28 INFO - 'cart']}, 09:15:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:28 INFO - 'talos_options': ['--disable-e10s'], 09:15:28 INFO - 'tests': ['tp5o']}, 09:15:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:28 INFO - 'tests': ['tp5o']}, 09:15:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:28 INFO - 'talos_options': ['--disable-e10s', 09:15:28 INFO - '--xperf_path', 09:15:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:15:28 INFO - 'tests': ['tp5n']}, 09:15:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:15:28 INFO - 'talos_options': ['--xperf_path', 09:15:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:15:28 INFO - 'tests': ['tp5n']}}, 09:15:28 INFO - 'talos.zip': {'path': '', 09:15:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:15:28 INFO - Running post-action listener: _resource_record_post_action 09:15:28 INFO - [mozharness: 2016-09-23 16:15:28.736271Z] Finished populate-webroot step (success) 09:15:28 INFO - [mozharness: 2016-09-23 16:15:28.736359Z] Running create-virtualenv step. 09:15:28 INFO - Running pre-action listener: _resource_record_pre_action 09:15:28 INFO - Running main action method: create_virtualenv 09:15:28 INFO - Creating virtualenv /builds/slave/test/build/venv 09:15:28 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 09:15:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:15:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:15:28 INFO - Using real prefix '/usr' 09:15:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:15:29 INFO - Installing distribute.............................................................................................................................................................................................done. 09:15:31 INFO - Installing pip.................done. 09:15:31 INFO - Return code: 0 09:15:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:31 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 0x7eff589f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139af60>, '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 0x139bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139c1d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', '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 09:15:31 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 09:15:31 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 09:15:31 INFO - Using env: {'DISPLAY': ':0', 09:15:31 INFO - 'HOME': '/home/cltbld', 09:15:31 INFO - 'LANG': 'en_US.UTF-8', 09:15:31 INFO - 'LANGUAGE': 'en_US:en', 09:15:31 INFO - 'LOGNAME': 'cltbld', 09:15:31 INFO - 'MAIL': '/var/mail/cltbld', 09:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:31 INFO - 'MOZ_NO_REMOTE': '1', 09:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:31 INFO - 'NO_EM_RESTART': '1', 09:15:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:31 INFO - 'PWD': '/builds/slave/test', 09:15:31 INFO - 'SHELL': '/bin/bash', 09:15:31 INFO - 'SHLVL': '1', 09:15:31 INFO - 'TERM': 'linux', 09:15:31 INFO - 'TMOUT': '86400', 09:15:31 INFO - 'USER': 'cltbld', 09:15:31 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', 09:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:31 INFO - '_': '/tools/buildbot/bin/python'} 09:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:31 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 09:15:31 INFO - Cleaning up... 09:15:31 INFO - Return code: 0 09:15:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:31 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 0x7eff589f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139af60>, '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 0x139bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139c1d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', '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 09:15:31 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 09:15:31 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 09:15:31 INFO - Using env: {'DISPLAY': ':0', 09:15:31 INFO - 'HOME': '/home/cltbld', 09:15:31 INFO - 'LANG': 'en_US.UTF-8', 09:15:31 INFO - 'LANGUAGE': 'en_US:en', 09:15:31 INFO - 'LOGNAME': 'cltbld', 09:15:31 INFO - 'MAIL': '/var/mail/cltbld', 09:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:31 INFO - 'MOZ_NO_REMOTE': '1', 09:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:31 INFO - 'NO_EM_RESTART': '1', 09:15:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:31 INFO - 'PWD': '/builds/slave/test', 09:15:31 INFO - 'SHELL': '/bin/bash', 09:15:31 INFO - 'SHLVL': '1', 09:15:31 INFO - 'TERM': 'linux', 09:15:31 INFO - 'TMOUT': '86400', 09:15:31 INFO - 'USER': 'cltbld', 09:15:31 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', 09:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:31 INFO - '_': '/tools/buildbot/bin/python'} 09:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:31 INFO - Downloading/unpacking psutil>=3.1.1 09: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 09: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 09: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 09: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 09: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 09: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 09:15:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:15:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:15:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:15:33 INFO - Installing collected packages: psutil 09:15:33 INFO - Running setup.py install for psutil 09:15:33 INFO - building 'psutil._psutil_linux' extension 09:15:33 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 09:15:33 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 09:15:34 INFO - building 'psutil._psutil_posix' extension 09:15:34 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 09:15:34 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 09:15:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:15:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:15:34 INFO - Successfully installed psutil 09:15:34 INFO - Cleaning up... 09:15:34 INFO - Return code: 0 09:15:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:34 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 0x7eff589f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139af60>, '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 0x139bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139c1d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', '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 09:15:34 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 09:15:34 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 09:15:34 INFO - Using env: {'DISPLAY': ':0', 09:15:34 INFO - 'HOME': '/home/cltbld', 09:15:34 INFO - 'LANG': 'en_US.UTF-8', 09:15:34 INFO - 'LANGUAGE': 'en_US:en', 09:15:34 INFO - 'LOGNAME': 'cltbld', 09:15:34 INFO - 'MAIL': '/var/mail/cltbld', 09:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:34 INFO - 'MOZ_NO_REMOTE': '1', 09:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:34 INFO - 'NO_EM_RESTART': '1', 09:15:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:34 INFO - 'PWD': '/builds/slave/test', 09:15:34 INFO - 'SHELL': '/bin/bash', 09:15:34 INFO - 'SHLVL': '1', 09:15:34 INFO - 'TERM': 'linux', 09:15:34 INFO - 'TMOUT': '86400', 09:15:34 INFO - 'USER': 'cltbld', 09:15:34 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', 09:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:34 INFO - '_': '/tools/buildbot/bin/python'} 09:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:15:34 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 09:15:34 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 09:15:34 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 09:15:34 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 09:15:34 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 09:15:34 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 09:15:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:15:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:15:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:15:36 INFO - Installing collected packages: mozsystemmonitor 09:15:36 INFO - Running setup.py install for mozsystemmonitor 09:15:36 INFO - Successfully installed mozsystemmonitor 09:15:36 INFO - Cleaning up... 09:15:36 INFO - Return code: 0 09:15:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:36 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 0x7eff589f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139af60>, '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 0x139bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139c1d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', '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 09:15:36 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 09:15:36 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 09:15:36 INFO - Using env: {'DISPLAY': ':0', 09:15:36 INFO - 'HOME': '/home/cltbld', 09:15:36 INFO - 'LANG': 'en_US.UTF-8', 09:15:36 INFO - 'LANGUAGE': 'en_US:en', 09:15:36 INFO - 'LOGNAME': 'cltbld', 09:15:36 INFO - 'MAIL': '/var/mail/cltbld', 09:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:36 INFO - 'MOZ_NO_REMOTE': '1', 09:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:36 INFO - 'NO_EM_RESTART': '1', 09:15:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:36 INFO - 'PWD': '/builds/slave/test', 09:15:36 INFO - 'SHELL': '/bin/bash', 09:15:36 INFO - 'SHLVL': '1', 09:15:36 INFO - 'TERM': 'linux', 09:15:36 INFO - 'TMOUT': '86400', 09:15:36 INFO - 'USER': 'cltbld', 09:15:36 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', 09:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:36 INFO - '_': '/tools/buildbot/bin/python'} 09:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:36 INFO - Downloading/unpacking jsonschema==2.5.1 09: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 09: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 09: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 09: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 09: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 09: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 09:15:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:15:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:15:39 INFO - Downloading functools32-3.2.3-2.tar.gz 09:15:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:15:39 INFO - warning: no files found matching '*.txt' 09:15:39 INFO - no previously-included directories found matching 'build' 09:15:39 INFO - no previously-included directories found matching 'dist' 09:15:39 INFO - no previously-included directories found matching '.git*' 09:15:39 INFO - Installing collected packages: jsonschema, functools32 09:15:39 INFO - Running setup.py install for functools32 09:15:39 INFO - warning: no files found matching '*.txt' 09:15:39 INFO - no previously-included directories found matching 'build' 09:15:39 INFO - no previously-included directories found matching 'dist' 09:15:39 INFO - no previously-included directories found matching '.git*' 09:15:39 INFO - Successfully installed jsonschema functools32 09:15:39 INFO - Cleaning up... 09:15:39 INFO - Return code: 0 09:15:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:15:39 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')]} 09:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:39 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')]} 09:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:39 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 0x7eff589f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139af60>, '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 0x139bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139c1d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', '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 09:15:39 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 09:15:39 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 09:15:39 INFO - Using env: {'DISPLAY': ':0', 09:15:39 INFO - 'HOME': '/home/cltbld', 09:15:39 INFO - 'LANG': 'en_US.UTF-8', 09:15:39 INFO - 'LANGUAGE': 'en_US:en', 09:15:39 INFO - 'LOGNAME': 'cltbld', 09:15:39 INFO - 'MAIL': '/var/mail/cltbld', 09:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:39 INFO - 'MOZ_NO_REMOTE': '1', 09:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:39 INFO - 'NO_EM_RESTART': '1', 09:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:39 INFO - 'PWD': '/builds/slave/test', 09:15:39 INFO - 'SHELL': '/bin/bash', 09:15:39 INFO - 'SHLVL': '1', 09:15:39 INFO - 'TERM': 'linux', 09:15:39 INFO - 'TMOUT': '86400', 09:15:39 INFO - 'USER': 'cltbld', 09:15:39 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', 09:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:39 INFO - '_': '/tools/buildbot/bin/python'} 09:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:15:39 INFO - Cleaning up... 09:15:39 INFO - Return code: 0 09:15:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:15:39 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')]} 09:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:39 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')]} 09:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:39 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 0x7eff589f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139af60>, '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 0x139bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139c1d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', '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 09:15:39 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 09:15:39 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 09:15:39 INFO - Using env: {'DISPLAY': ':0', 09:15:39 INFO - 'HOME': '/home/cltbld', 09:15:39 INFO - 'LANG': 'en_US.UTF-8', 09:15:39 INFO - 'LANGUAGE': 'en_US:en', 09:15:39 INFO - 'LOGNAME': 'cltbld', 09:15:39 INFO - 'MAIL': '/var/mail/cltbld', 09:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:39 INFO - 'MOZ_NO_REMOTE': '1', 09:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:39 INFO - 'NO_EM_RESTART': '1', 09:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:39 INFO - 'PWD': '/builds/slave/test', 09:15:39 INFO - 'SHELL': '/bin/bash', 09:15:39 INFO - 'SHLVL': '1', 09:15:39 INFO - 'TERM': 'linux', 09:15:39 INFO - 'TMOUT': '86400', 09:15:39 INFO - 'USER': 'cltbld', 09:15:39 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', 09:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:39 INFO - '_': '/tools/buildbot/bin/python'} 09:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:39 INFO - Downloading/unpacking blobuploader==1.2.4 09:15:39 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 09:15:39 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 09:15:39 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 09:15:39 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 09:15:39 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 09:15:39 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 09:15:41 INFO - Downloading blobuploader-1.2.4.tar.gz 09:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:15:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09: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 09: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 09: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 09: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 09: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 09: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 09:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:15:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:15:42 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 09:15:42 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 09:15:42 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 09:15:42 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 09:15:42 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 09:15:42 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 09:15:42 INFO - Downloading docopt-0.6.1.tar.gz 09:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:15:42 INFO - Installing collected packages: blobuploader, requests, docopt 09:15:42 INFO - Running setup.py install for blobuploader 09:15:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:15:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:15:42 INFO - Running setup.py install for requests 09:15:43 INFO - Running setup.py install for docopt 09:15:43 INFO - Successfully installed blobuploader requests docopt 09:15:43 INFO - Cleaning up... 09:15:43 INFO - Return code: 0 09:15:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:43 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 0x7eff589f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139af60>, '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 0x139bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139c1d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', '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 09:15:43 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 09:15:43 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 09:15:43 INFO - Using env: {'DISPLAY': ':0', 09:15:43 INFO - 'HOME': '/home/cltbld', 09:15:43 INFO - 'LANG': 'en_US.UTF-8', 09:15:43 INFO - 'LANGUAGE': 'en_US:en', 09:15:43 INFO - 'LOGNAME': 'cltbld', 09:15:43 INFO - 'MAIL': '/var/mail/cltbld', 09:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:43 INFO - 'MOZ_NO_REMOTE': '1', 09:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:43 INFO - 'NO_EM_RESTART': '1', 09:15:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:43 INFO - 'PWD': '/builds/slave/test', 09:15:43 INFO - 'SHELL': '/bin/bash', 09:15:43 INFO - 'SHLVL': '1', 09:15:43 INFO - 'TERM': 'linux', 09:15:43 INFO - 'TMOUT': '86400', 09:15:43 INFO - 'USER': 'cltbld', 09:15:43 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', 09:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:43 INFO - '_': '/tools/buildbot/bin/python'} 09:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:15:43 INFO - Running setup.py (path:/tmp/pip-D2w4W0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:15:43 INFO - Running setup.py (path:/tmp/pip-aEq3vF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:15:43 INFO - Running setup.py (path:/tmp/pip-x0Ct7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:15:43 INFO - Running setup.py (path:/tmp/pip-ZA9rPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:15:43 INFO - Running setup.py (path:/tmp/pip-Efgcc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:15:43 INFO - Running setup.py (path:/tmp/pip-_zligE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:15:43 INFO - Running setup.py (path:/tmp/pip-p2vizE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:15:43 INFO - Running setup.py (path:/tmp/pip-LoW6Pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:15:43 INFO - Running setup.py (path:/tmp/pip-c8j2UR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:15:44 INFO - Running setup.py (path:/tmp/pip-7ZejOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:15:44 INFO - Running setup.py (path:/tmp/pip-iAZ1hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:15:44 INFO - Running setup.py (path:/tmp/pip-7Irzlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:15:44 INFO - Running setup.py (path:/tmp/pip-DwwyaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:15:44 INFO - Running setup.py (path:/tmp/pip-p0wpCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:44 INFO - Running setup.py (path:/tmp/pip-Vq4zsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:15:44 INFO - Running setup.py (path:/tmp/pip-hwf7Cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:15:44 INFO - Running setup.py (path:/tmp/pip-tJ2LaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:15:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:15:44 INFO - Running setup.py install for manifestparser 09:15:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:15:44 INFO - Running setup.py install for mozcrash 09:15:44 INFO - Running setup.py install for mozdebug 09:15:44 INFO - Running setup.py install for mozdevice 09:15:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:15:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:15:45 INFO - Running setup.py install for mozfile 09:15:45 INFO - Running setup.py install for mozhttpd 09:15:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:15:45 INFO - Running setup.py install for mozinfo 09:15:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:15:45 INFO - Running setup.py install for mozInstall 09:15:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:15:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:15:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:15:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:15:45 INFO - Running setup.py install for mozleak 09:15:45 INFO - Running setup.py install for mozlog 09:15:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:15:45 INFO - Running setup.py install for moznetwork 09:15:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:15:45 INFO - Running setup.py install for mozprocess 09:15:45 INFO - Running setup.py install for mozprofile 09:15:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:15:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:15:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:15:45 INFO - Running setup.py install for mozrunner 09:15:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:15:46 INFO - Running setup.py install for mozscreenshot 09:15:46 INFO - Running setup.py install for moztest 09:15:46 INFO - Running setup.py install for mozversion 09:15:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:15:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:15:46 INFO - Cleaning up... 09:15:46 INFO - Return code: 0 09:15:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:46 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 0x7eff589f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139af60>, '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 0x139bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139c1d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', '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 09:15:46 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 09:15:46 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 09:15:46 INFO - Using env: {'DISPLAY': ':0', 09:15:46 INFO - 'HOME': '/home/cltbld', 09:15:46 INFO - 'LANG': 'en_US.UTF-8', 09:15:46 INFO - 'LANGUAGE': 'en_US:en', 09:15:46 INFO - 'LOGNAME': 'cltbld', 09:15:46 INFO - 'MAIL': '/var/mail/cltbld', 09:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:46 INFO - 'MOZ_NO_REMOTE': '1', 09:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:46 INFO - 'NO_EM_RESTART': '1', 09:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:46 INFO - 'PWD': '/builds/slave/test', 09:15:46 INFO - 'SHELL': '/bin/bash', 09:15:46 INFO - 'SHLVL': '1', 09:15:46 INFO - 'TERM': 'linux', 09:15:46 INFO - 'TMOUT': '86400', 09:15:46 INFO - 'USER': 'cltbld', 09:15:46 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', 09:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:46 INFO - '_': '/tools/buildbot/bin/python'} 09:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:15:46 INFO - Running setup.py (path:/tmp/pip-ph5TF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:15:46 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)) 09:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:15:46 INFO - Running setup.py (path:/tmp/pip-tk_86e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:15:46 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)) 09:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:15:46 INFO - Running setup.py (path:/tmp/pip-TPoxlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:15:46 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)) 09:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:15:46 INFO - Running setup.py (path:/tmp/pip-_WBAVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:15:46 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)) 09:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:15:46 INFO - Running setup.py (path:/tmp/pip-eobdNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:15:47 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)) 09:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:15:47 INFO - Running setup.py (path:/tmp/pip-N8kJAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:15:47 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)) 09:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:15:47 INFO - Running setup.py (path:/tmp/pip-OEEfts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:15:47 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)) 09:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:15:47 INFO - Running setup.py (path:/tmp/pip-lbISBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:15:47 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)) 09:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:15:47 INFO - Running setup.py (path:/tmp/pip-OaQeEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:15:47 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)) 09:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:15:47 INFO - Running setup.py (path:/tmp/pip-xWIIpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:15:47 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)) 09:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:15:47 INFO - Running setup.py (path:/tmp/pip-JnKkk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:15:47 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)) 09:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:15:47 INFO - Running setup.py (path:/tmp/pip-NpORw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:15:47 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)) 09:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:15:47 INFO - Running setup.py (path:/tmp/pip-QfnpT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:15:47 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)) 09:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:15:47 INFO - Running setup.py (path:/tmp/pip-IqE5PI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:15:47 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)) 09:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:47 INFO - Running setup.py (path:/tmp/pip-niaLR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:15:47 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)) 09:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:15:47 INFO - Running setup.py (path:/tmp/pip-ACP0I6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:15:47 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)) 09:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:15:47 INFO - Running setup.py (path:/tmp/pip-Hg48bJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:15:47 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)) 09:15:47 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)) 09:15:47 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)) 09:15:47 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)) 09:15:47 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)) 09:15:47 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)) 09:15:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:15:47 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 09:15:47 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 09:15:47 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 09:15:47 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 09:15:47 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 09:15:47 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 09:15:49 INFO - Downloading blessings-1.6.tar.gz 09:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:15:49 INFO - Installing collected packages: blessings 09:15:49 INFO - Running setup.py install for blessings 09:15:49 INFO - Successfully installed blessings 09:15:49 INFO - Cleaning up... 09:15:50 INFO - Return code: 0 09:15:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:15:50 INFO - Reading from file tmpfile_stdout 09:15:50 INFO - Current package versions: 09:15:50 INFO - argparse == 1.2.1 09:15:50 INFO - blessings == 1.6 09:15:50 INFO - blobuploader == 1.2.4 09:15:50 INFO - docopt == 0.6.1 09:15:50 INFO - functools32 == 3.2.3-2 09:15:50 INFO - jsonschema == 2.5.1 09:15:50 INFO - manifestparser == 1.1 09:15:50 INFO - mozInstall == 1.12 09:15:50 INFO - mozcrash == 0.17 09:15:50 INFO - mozdebug == 0.1 09:15:50 INFO - mozdevice == 0.48 09:15:50 INFO - mozfile == 1.2 09:15:50 INFO - mozhttpd == 0.7 09:15:50 INFO - mozinfo == 0.9 09:15:50 INFO - mozleak == 0.1 09:15:50 INFO - mozlog == 3.4 09:15:50 INFO - moznetwork == 0.27 09:15:50 INFO - mozprocess == 0.23 09:15:50 INFO - mozprofile == 0.28 09:15:50 INFO - mozrunner == 6.12 09:15:50 INFO - mozscreenshot == 0.1 09:15:50 INFO - mozsystemmonitor == 0.3 09:15:50 INFO - moztest == 0.7 09:15:50 INFO - mozversion == 1.4 09:15:50 INFO - psutil == 3.1.1 09:15:50 INFO - requests == 1.2.3 09:15:50 INFO - wsgiref == 0.1.2 09:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:50 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 0x7eff589f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139af60>, '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 0x139bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139c1d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', '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 09:15:50 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 09:15:50 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 09:15:50 INFO - Using env: {'DISPLAY': ':0', 09:15:50 INFO - 'HOME': '/home/cltbld', 09:15:50 INFO - 'LANG': 'en_US.UTF-8', 09:15:50 INFO - 'LANGUAGE': 'en_US:en', 09:15:50 INFO - 'LOGNAME': 'cltbld', 09:15:50 INFO - 'MAIL': '/var/mail/cltbld', 09:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:50 INFO - 'MOZ_NO_REMOTE': '1', 09:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:50 INFO - 'NO_EM_RESTART': '1', 09:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:50 INFO - 'PWD': '/builds/slave/test', 09:15:50 INFO - 'SHELL': '/bin/bash', 09:15:50 INFO - 'SHLVL': '1', 09:15:50 INFO - 'TERM': 'linux', 09:15:50 INFO - 'TMOUT': '86400', 09:15:50 INFO - 'USER': 'cltbld', 09:15:50 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', 09:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:50 INFO - '_': '/tools/buildbot/bin/python'} 09:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:50 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)) 09:15:50 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)) 09:15:50 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)) 09:15:50 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)) 09:15:50 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)) 09:15:50 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)) 09:15:50 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)) 09:15:50 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)) 09:15:50 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)) 09:15:50 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)) 09:15:50 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)) 09:15:50 INFO - Cleaning up... 09:15:50 INFO - Return code: 0 09:15:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:15:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7eff589f4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x139dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139af60>, '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 0x139bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139c1d0>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', '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 09:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:15:50 INFO - Using env: {'DISPLAY': ':0', 09:15:50 INFO - 'HOME': '/home/cltbld', 09:15:50 INFO - 'LANG': 'en_US.UTF-8', 09:15:50 INFO - 'LANGUAGE': 'en_US:en', 09:15:50 INFO - 'LOGNAME': 'cltbld', 09:15:50 INFO - 'MAIL': '/var/mail/cltbld', 09:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:15:50 INFO - 'MOZ_NO_REMOTE': '1', 09:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:15:50 INFO - 'NO_EM_RESTART': '1', 09:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:15:50 INFO - 'PWD': '/builds/slave/test', 09:15:50 INFO - 'SHELL': '/bin/bash', 09:15:50 INFO - 'SHLVL': '1', 09:15:50 INFO - 'TERM': 'linux', 09:15:50 INFO - 'TMOUT': '86400', 09:15:50 INFO - 'USER': 'cltbld', 09:15:50 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', 09:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:15:50 INFO - '_': '/tools/buildbot/bin/python'} 09:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:15:50 INFO - Cleaning up... 09:15:50 INFO - Return code: 0 09:15:50 INFO - Running post-action listener: _resource_record_post_action 09:15:50 INFO - Running post-action listener: _start_resource_monitoring 09:15:50 INFO - Starting resource monitoring. 09:15:50 INFO - [mozharness: 2016-09-23 16:15:50.764350Z] Finished create-virtualenv step (success) 09:15:50 INFO - [mozharness: 2016-09-23 16:15:50.764851Z] Running install step. 09:15:50 INFO - Running pre-action listener: _resource_record_pre_action 09:15:50 INFO - Running main action method: install 09:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:15:50 INFO - Reading from file tmpfile_stdout 09:15:50 INFO - Detecting whether we're running mozinstall >=1.0... 09:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:15:51 INFO - Reading from file tmpfile_stdout 09:15:51 INFO - Output received: 09:15:51 INFO - Usage: mozinstall [options] installer 09:15:51 INFO - Options: 09:15:51 INFO - -h, --help show this help message and exit 09:15:51 INFO - -d DEST, --destination=DEST 09:15:51 INFO - Directory to install application into. [default: 09:15:51 INFO - "/builds/slave/test"] 09:15:51 INFO - --app=APP Application being installed. [default: firefox] 09:15:51 INFO - mkdir: /builds/slave/test/build/application 09:15:51 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'] 09:15:51 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 09:16:07 INFO - Reading from file tmpfile_stdout 09:16:07 INFO - Output received: 09:16:07 INFO - /builds/slave/test/build/application/firefox/firefox 09:16:07 INFO - Running post-action listener: _resource_record_post_action 09:16:07 INFO - [mozharness: 2016-09-23 16:16:07.150913Z] Finished install step (success) 09:16:07 INFO - [mozharness: 2016-09-23 16:16:07.151158Z] Running run-tests step. 09:16:07 INFO - Running pre-action listener: _resource_record_pre_action 09:16:07 INFO - Running main action method: run_tests 09:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:16:07 INFO - Python 2.7.3 09:16:07 INFO - Return code: 0 09:16:07 INFO - grabbing minidump binary from tooltool 09:16: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')]} 09:16:07 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 0x139af60>, '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 0x139bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x139c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:16:07 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 09:16:07 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 09:16:07 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 09:16:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:16:07 INFO - Return code: 0 09:16:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:16:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:16:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:16:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:16:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-034 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:16:07 INFO - Using env: {'DISPLAY': ':0', 09:16:07 INFO - 'HOME': '/home/cltbld', 09:16:07 INFO - 'LANG': 'en_US.UTF-8', 09:16:07 INFO - 'LANGUAGE': 'en_US:en', 09:16:07 INFO - 'LOGNAME': 'cltbld', 09:16:07 INFO - 'MAIL': '/var/mail/cltbld', 09:16:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:16:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:07 INFO - 'MOZ_NO_REMOTE': '1', 09:16:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:07 INFO - 'NO_EM_RESTART': '1', 09:16:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:07 INFO - 'PWD': '/builds/slave/test', 09:16:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:16:07 INFO - 'SHELL': '/bin/bash', 09:16:07 INFO - 'SHLVL': '1', 09:16:07 INFO - 'TERM': 'linux', 09:16:07 INFO - 'TMOUT': '86400', 09:16:07 INFO - 'USER': 'cltbld', 09:16:07 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697', 09:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:07 INFO - '_': '/tools/buildbot/bin/python'} 09:16:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-034', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:16:07 INFO - mozversion application_buildid: 20160923085159 09:16:07 INFO - mozversion application_changeset: 771ccd7f60258468517d532705ad83bb09d6ff64 09:16:07 INFO - mozversion application_display_name: Nightly 09:16:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:16:07 INFO - mozversion application_name: Firefox 09:16:07 INFO - mozversion application_remotingname: firefox 09:16:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:16:07 INFO - mozversion application_vendor: Mozilla 09:16:07 INFO - mozversion application_version: 52.0a1 09:16:07 INFO - mozversion platform_buildid: 20160923085159 09:16:07 INFO - mozversion platform_changeset: 771ccd7f60258468517d532705ad83bb09d6ff64 09:16:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:16:07 INFO - mozversion platform_version: 52.0a1 09:16:07 INFO - using testdate: 1474647367 09:16:07 INFO - actual date: 1474647367 09:16:07 INFO - starting webserver on 'localhost:43091' 09:16:07 INFO - SUITE-START | Running 2 tests 09:16:07 INFO - TEST-START | dromaeo_css 09:16:07 INFO - operating with platform_type : linux_ 09:16:07 INFO - Initialising browser for dromaeo_css test... 09:16:07 INFO - TEST-INFO | started process 14337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK9hNgH/profile http://localhost:43091/getInfo.html) 09:16:12 INFO - PROCESS | 14337 | __metrics Screen width/height:1600/1200 09:16:12 INFO - PROCESS | 14337 | colorDepth:24 09:16:12 INFO - PROCESS | 14337 | Browser inner width/height: 1024/697 09:16:12 INFO - PROCESS | 14337 | __metrics 09:16:12 INFO - PROCESS | 14337 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:16:12 INFO - PROCESS | 14337 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:16:13 INFO - PROCESS | 14337 | console.error: PushService: 09:16:13 INFO - PROCESS | 14337 | stateChangeProcessEnqueue: Error transitioning state 09:16:13 INFO - PROCESS | 14337 | UnknownError 09:16:13 INFO - TEST-INFO | 14337: exit 0 09:16:13 INFO - Browser initialized. 09:16:13 INFO - Running cycle 1/1 for dromaeo_css test... 09:16:13 INFO - TEST-INFO | started process 14418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK9hNgH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:16:26 INFO - PROCESS | 14418 | RSS: Main: 174829568 09:16:26 INFO - PROCESS | 14418 | 09:17:16 INFO - PROCESS | 14418 | 1474647436854 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] 09:19:30 INFO - PROCESS | 14418 | Cycle 1(1): loaded http://localhost:43091/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43091/tests/dromaeo/cssquery-ext.html) 09:19:31 INFO - PROCESS | 14418 | RSS: Main: 325136384 09:19:31 INFO - PROCESS | 14418 | 09:22:34 INFO - PROCESS | 14418 | Cycle 1(1): loaded http://localhost:43091/tests/dromaeo/cssquery-ext.html (next: http://localhost:43091/tests/dromaeo/cssquery-jquery.html) 09:22:35 INFO - PROCESS | 14418 | RSS: Main: 269471744 09:22:35 INFO - PROCESS | 14418 | 09:25:37 INFO - PROCESS | 14418 | Cycle 1(1): loaded http://localhost:43091/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43091/tests/dromaeo/cssquery-mootools.html) 09:25:38 INFO - PROCESS | 14418 | RSS: Main: 218480640 09:25:38 INFO - PROCESS | 14418 | 09:28:40 INFO - PROCESS | 14418 | Cycle 1(1): loaded http://localhost:43091/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43091/tests/dromaeo/cssquery-prototype.html) 09:28:40 INFO - PROCESS | 14418 | RSS: Main: 220409856 09:28:40 INFO - PROCESS | 14418 | 09:31:43 INFO - PROCESS | 14418 | Cycle 1(1): loaded http://localhost:43091/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43091/tests/dromaeo/cssquery-yui.html) 09:31:44 INFO - PROCESS | 14418 | RSS: Main: 219176960 09:31:44 INFO - PROCESS | 14418 | 09:34:47 INFO - PROCESS | 14418 | Cycle 1(1): loaded http://localhost:43091/tests/dromaeo/cssquery-yui.html (next: http://localhost:43091/tests/dromaeo/cssquery-dojo.html) 09:34:47 INFO - PROCESS | 14418 | RSS: Main: 310472704 09:34:47 INFO - PROCESS | 14418 | 09:34:47 INFO - PROCESS | 14418 | __start_tp_report 09:34:47 INFO - PROCESS | 14418 | _x_x_mozilla_page_load 09:34:47 INFO - PROCESS | 14418 | _x_x_mozilla_page_load_details 09:34:47 INFO - PROCESS | 14418 | |i|pagename|runs| 09:34:47 INFO - PROCESS | 14418 | |0;dojo.html;2623.6589243398357;2643.5770276755725;2665.067226470735;2684.8120631555785;2686.220995911186;4572.108438854425;4643.651726120537;4711.999999999995;4768.1417344877955;4811.903761924764;4704.129735998843;4737.170995075857;4795.088933102708;4804.351412559304;4845.982343707826;4344.413504176927;4345.587169218919;4400.911981760363;4402.471703395581;4423.646108311327;4403.383526306304;4520.50274469808;4521.344405061264;4523.3441151033085;4542.568455996675;4462.3752674625575;4503.617192538638;4521.841735539273;4523.389342438778;4559.202139625552;4322.2436073687295;4362.825486980549;4371.409859668967;4429.202743506167;4431.955680443187;4260.808263628144;4295.2912769393015;4311.1593239318345;4332.501762297345;4370.409994650713;4718.811247550094;4783.569478746895;4809.254565542346;4825.324454576362;4868.561829435333;5026.52248036436;5135.6148288878485;5150.072986862363;5151.356080489939;5216.191490319006;5077.238414237857;5099.643024988252;5136.383633963911;5165.380154381461;5182.870428239286;4791;4798.064377446434;4808.230683090689;4810.42274927011;4824.179889418807;5023.572996295283;5262.447443018428;5275.762590683428;5277.366715994029;5286.07493688603;4854.490278520775;5023.447420783711;5048.6718363307;5057.089723849743;5150.562202212779;5133.922991155136;5152.098382782998;5153.587712982952;5154.201098829687;5154.974225128925;5108.693478391308;5111.948880511147;5112.207607820794;5141.71720555373;5175.792968281226;4875.0493653737185;4924.679895806761;4926.261060840902;4980.302757613937;4994.2508623706735;4176.227397931392;4194.979025104855;4227.471566054243;4228.069824638575;4236.597523235288;3749.1939233064477;3752.4746535485056;3790.0903783092413;3797.6012518685693;3816.1222918728295;4353.782310884443;4359.912801743947;4361.563843615677;4366.148601022834;4419.270820314612;4997.100521906092;5037.697738135724;5121.641485096082;5143.177091665316;5203.765830537635;4313.97843010783;4338.826446942087;4356.825726970949;4395.978020109879;4447.199504089231;4602.723836569817;4604.470485894098;4606.700564463299;4650.046740418206;4653.232216684277;4829.541193586604;4839;4839.274108883696;4843.515648435128;4899.3385892904;5063.924041139312;5071.721055341992;5099.286099945936;5115.897682046264;5126.359205099363;4823.324734537237;4831.0820944020525;4831.275308703723;4881.682690625098;4891.5353041461;5001.749912504288;5037.319961805109;5039.168537191469;5044.495550444926;5104.1067813133295;5023.8492845214705;5089.9745501272255;5090.032893750175;5106.565941894981;5182.792688292577;4944.431390390151;4982.2775697524385;5002.699838009731;5010.87472813168;5017.347744793154;5011.223260394645;5019.32239147725;5030.37120359955;5030.421501527225;5093.719845408538;4748.810047598057;4956.578690811177;4971.676841005323;4980.452150263396;5046.34397528319;4863.076015557032;5047.4952504749235;5079.898402031865;5099.5410413063;5157.561607263425;4944.233643785219;4950.504949505021;4952.8761780955765;4965.329680493087;5024.623153263593 09:34:47 INFO - PROCESS | 14418 | |1;ext.html;535.6277387215887;547.3732576200254;566.7704579645243;577.0478710128291;580.0834681203698;27704.445911081766;28358.149255522316;36481;37855;38087.42868856969;39182.8040859796;39768;39800.80099599498;39801.40297895534;39830;7547.094348678166;7691.576963267018;7693.038370203724;7708.6916523339;7725.304722574967;7430.517016393917;7515.887261691079;7517.924820751778;7526.698932042712;7547.43394245431;7531.698732050711;7547.584882831469;7557.924420755777;7567.129780075279;7575.886361704579;7503.887441688379;7538.773836784905;7540.283673051052;7545.283198096172;7545.69817207311;7525.172231054579;7581.886271705929;7589.051368578927;7592.316691497792;7598.544087354721;37605.43591846125;37953;37973.62026379728;37996.43005354922;38007;3062.5712400263983;3119.4385010698065;3132.856507374792;3331.017349881791;3426.8971930842113;27443.451130977468;27989.86005069982;28084.438311233866;28091.71908280932;28258.434831303464;3393.592768867727;3455.5335029771163;3517.103138699641;3553;3604.5494313210847;244458.44269466138;244643;245080;245138;245958.7702061496;30842;51721.24181372749;51836.48163518392;52086.73956630193;52130;31618.209544761565;33202;33204.83397582997;33211.66788332134;33232;11715.472803723853;11843.230190037792;11850.822237666442;11853.111016673784;11860.466279017464;9465.763355916157;9557.569909354095;9570.138687518156;9570.712878613653;9575.521223938915;7745.993020907359;7754.612269386508;7811.336036436966;7863.13505514393;7880.802979925433;3031.5301128325145;3052.6794686558037;3053.114596766957;3088.336007758298;3114.065780265911;851.7862046583593;879.564615515324;912.8219997100634;914.2457472585144;933.5005771911995;27181.86409067942;27664.881996830652;27737.959143098644;27926.581101283497;28132;934.7195841247599;962.3744566032135;986.7582442301539;991.7718924647371;1018.9898101019044;13919.652008699864;14754.631134221516;14818.259087045604;14929.029613075116;15079.623009424633;397845;401258;402789;402961;403460;47811.28283075757;48192.27711584329;48296.27555586669;48360;48378.75810620924;1066.2909165405074;1079.390144568332;1124.1961997172061;1135.27909777292;1193.5583833981482;25114;28518.287042824097;28730.856345718137;29093.563596545646;29598.112056638336;39928;40263.597364027155;40307.79846100751;40373.39439908345;40570;290832;291943;292220;293060;293334;21163.25928592492;21652;21968;22340.553188935806;24676.259712208663;39976.200475990896;40567.39148912828;40575.59424405718;40642;41571.7921410391;33917.49123763195;35181.49142408663;35254;35307.82346088253;35394.64605353914;34144.14639634029;34483;34722;34774;35062.12344691403;34359.48460773141;34619.82690086634;34641.480377794855;34957.30085398329;34970.82514587411;29241;31588.526172106976;31630.683693163694;31676.5248521277;31891;24424.87787561051;24625;25054;28477.572836407886;31399.68600314059 09:34:47 INFO - PROCESS | 14418 | |2;jquery.html;360.60153530348964;379.4441143724443;381.36502722966264;383.7448097015485;393.2371199872248;15175.924120379397;15241.92379038106;16620.999999999985;16716.080615566138;16733.247003884822;15548.76676849848;15614.609634759137;15848.84151158488;16436.83563164368;16490.75263871043;4920.163572192736;5152.562032227265;5159.5614372778355;5165.276861239429;5173.715445650488;4898.461169271395;5034.244863270502;5097.439281679012;5119.206522988924;5122.590192784568;5042.82350117746;5076.64463487556;5080.364954380702;5080.720560369178;5083.974580127113;4894.339264199323;5080.034793389263;5082.669626474268;5082.949170508303;5083.872903177432;4531.977340113278;4541.45502539694;4552.385427967215;4559.088182363507;4561.7491037992895;20144.79855201444;20202.898985504977;20457.419951508575;20576.279830205873;20675.379738607866;1887.2639670528504;1900.7624046994126;1911.397909658453;2333.498297865967;2403.134871446278;12190.756184876342;12992.870071299356;13031.739365212738;13587.932060339734;13644.249566273851;1705.4031089118832;1717.8797484176112;1760.4014635024153;1763.188933090767;1767.6553072150937;42236.78881605603;56765.14852277219;59355.109673355364;67925.3207467924;68013.31986680119;9082.682106126254;9353.766155846022;9414.811703765887;9645.565949532287;9919.40483570988;12439.253644781342;12444.191127576678;12458.190217635825;12461.314627695563;12462.003039756797;6456.451201647913;6585.769498067544;6730.865382692319;6756;6771.762988295484;6215.9378406216265;6298.968505157445;6300.907783124181;6437.774677886251;6458.998855177455;5893;5898.14476900847;5984.670843103671;5999.160117583542;6198.931528893227;1676.5724740191174;1750.64111857069;1752.9386471473692;1792.587704827897;1814.4103166470686;849.4011721736161;860.2945584620676;898.7528429681759;911.544227886057;966.5891995901713;16693.861307332507;16830.326786928632;17830.732539011926;17957.64084718298;18276.725849112274;818.4025661267308;824.8638974569249;839.9790005249796;874.3660845886808;875.3478658399533;9679.903200968041;10010.599576016877;10131.898681013243;10250.38497690141;10338.328008679411;328907;333735;338264;347560.67075304483;352854;51411;64839.67580162069;70654;72892.27107728855;74468.62765686246;909.8999110097884;920.5995392004365;925.5233554719325;949.6676163342913;958.8993155718549;11883.087197630723;16279.430219942245;16908.830911690726;16966.321347145975;17018.14909254557;35941.460878087375;36504.452433212995;36988.26023479569;37020.814895925345;37226.627733722315;42465.36301955411;43844;44030;44255.77872110619;44450.333245001995;7569.697212111454;7574.469787114849;7601.923980760343;7692.692292308245;7975.2423519765525;12109.152359334763;12159.270443773403;12314.199577027464;12321.568745093879;12559.497620095093;10206.183505319408;10336.224783141144;10456.947715261374;10508.474576271003;11026.133205366503;10271.794564108526;10430.165586753194;10612.946935265274;10616.309939854194;10647.94676026615;10256.435896025492;10556.472176390997;10811.56753729842;10985.340879547253;11410.14423918226;7639.121501027453;7675.462717609714;7740.651670674946;7925.207479252029;7930.405219608437;10263.025012623788;10478.738031549272;10767.192460565333;10966.890331096905;11012.50443730018 09:34:47 INFO - PROCESS | 14418 | |3;mootools.html;1351.513455156144;1393.9512117075901;1432.8208973878266;1639.7376419772838;1677.5219062567178;7123.67943442545;7348.742794002211;7598.31615154636;8282.171782821722;8285.792855178624;7620.618969051539;7874.606269686521;7875.251851074153;8096.716614918479;8142.511449313045;2193.7148170737823;2220.9333719988426;2229.3423440085135;2238.1271304191378;2244.1584405847807;1857.7677790276216;1927.4603111128906;2163.3293678959494;2187.398465422014;2218.3234113595345;2097.276439628326;2167.4147980045377;2170.9565808683815;2177.150911144655;2183.9781602183934;2164.2857856907262;2164.8376371772024;2173.630482817917;2225.0765932138142;2228.2869481765842;2182.508935489518;2185.61751693453;2225.955480890373;2233.2630232023394;2236.463248820288;8018.558979256139;8140.674373025072;8158.551279679616;8159.55122468264;8170.509769413795;4702.435707715062;4856.3201151838775;4856.660033797635;4858.125537403266;4860.05228980349;2692.9192124236306;2836.773058155343;2891.5373540233463;2899.666538348096;2906.854657267128;915.8168366326761;926.4719110107242;943.3255222515866;947.1144479911305;959.5586030426012;10924.180686448548;10931.726706832313;10932.617358392497;10942.507587158518;10947;4303.978480107579;4307.332363483665;4393.890152746207;4403.207422663952;4442.133783912106;9420.764480888032;9434.764130896645;9442.480663563432;9445.347064263726;9450.007749186374;4816.277558366273;4835.202191638411;4835.419749629997;4836.298736683161;4838.806447742051;4128.814203360856;4143.917121657611;4402.757848318373;4413.58070983256;4414.602685758297;3650.324689932371;3654.7624404413627;3716.108134047809;3734.8879533614036;3817.0838998640684;1068.1188019883627;1098.1434481104752;1197.1918954705538;1265.367316341829;1276.5213045108085;604.7973928733835;694.4097517110416;760.8782594784918;771.2441807029143;781.4412694923158;4878;5008.874778130503;5029.245613157982;5092.9236061459105;5146.228065790161;871.8726307809053;880.1022956584249;880.9955950220208;881.290561098322;907.9137481939205;3478.1826270826336;3490.057684425191;3503.2818272254126;3505.4566542186003;3664.6885014774043;9611.375260608038;9898.455584942898;9980.800383992424;9986.500674966368;9993.950030249802;9899.356541824758;9900.702978910644;9902.207823374112;9902.465117906737;9910.752231194134;7326.974223608699;7390.815229619303;7466.477346585687;7525.473216874876;7551.471397002267;4975.228839529878;5089.949100509096;5122.1804511278015;5147.227915812508;5148.665336753099;8850.380473366802;8948.910510894808;9047;9051.411658242194;9078.409903356262;9174.174324310845;9195.172434480928;9206.539673016456;9249.676261330822;9273.211776999031;6844.349786770249;6915.965420172867;6916.066331045446;6918.308169183041;6923.030775691306;7584.810379740551;7603.353714934293;7612.923870761221;7665.118511371264;7698.384129269757;5367.919481207863;6758.189017317954;6824.52228344031;6872.140982377203;7094.361507464353;6744.7976560703255;6758.493113016445;6818.659067046727;6826.249112597709;6874.828129296808;6413.422791948747;6490.3185165558825;6501.642409667514;6509.218893732783;6535.869282614416;4506.481754598132;4622.768861556841;4667.463241727245;4673.953260467351;4698.130845793539;4501.18978583858;4538.841140560065;4638.976805116088;4663.720176789404;4719.976400117977 09:34:47 INFO - PROCESS | 14418 | |4;prototype.html;288.5671492760859;289.68713789107767;297.12052325117645;299.20560910781853;302.5612861351041;4829.275608658699;4861.48954359792;4866.343043689101;4874.731889746063;4883.6093112551;4776.737279449638;4801.615870730342;4819.734914579705;4834.274858771186;4849.248366503189;3565.8038807865555;3703.7222158355326;3724.2179142380132;3734.775913445202;3738.495303134069;3658.323210206107;3722.460243264725;3774.188549461865;3808.733388662795;3813.4068833193555;3727.5340582427198;3736.6263373662687;3746.2882052409955;3759.8120093995326;3767.9434808477895;3511.5083888255663;3674.4488326750934;3729.608391118934;3744.344739670574;3759.9624003760023;3239.6922292382424;3244.2700392411753;3251.6098068231727;3251.8048917065053;3254.8209848458328;4657.743824089674;4662.95337046632;4671.84650361005;4672.3692301539195;4687.437507499122;4205.11692544566;4207.368894665794;4211.957880421187;4215.873523794291;4246.893827654302;4753.809847606091;4888.242322440027;4960.702357858504;5003.574696150831;5012.699238045729;3507.930081325195;3524.559430071241;3525.894223173283;3539.94690079649;3548.4854696069183;5260.132078207092;5300.893982120336;5307.416184219733;5320.122179840322;5323.148296272578;3525.3125640499857;3607.2424790794225;3618.4029635109914;3633.9818300908855;3639.3085313790293;3662.5238718966366;3664.4320130379833;3665.596784353719;3681.3005528949416;3686.852525898934;4173.373993900939;4193.496780386312;4203.26442872496;4211.326187809936;4234.407182994321;4994.20324618215;5001.424836143818;5023.497650234947;5033.84898453047;5048.722320272347;1205.2828567002618;1270.9428075736614;1272.287518989369;1275.6428200103985;1282.3780466473752;770.210534202447;804.9275565199043;817.2767101115555;817.7219745286512;818.8536049530704;4228.18188179086;4332.913341733148;4383.49589797171;4474.485434175046;4476.194285028726;5149.2276158576515;5168.431472538018;5169.327987361694;5190.299309593157;5207.869803254949;4440.289553671397;4443.888902777392;4443.933340999887;4450.310201918708;4457.286834106592;2644.3124787555375;2720.40151166743;2730.9317267068086;2736.453903544491;2736.53478908586;4851.611871050308;4856.902861942742;4867.34290870735;4874.122657921537;4887.169181239126;5094.821681241138;5289.788408463618;5293.258943747878;5296.788128474895;5320.802819365612;4807.18277892759;4899.338589290472;4901.730404827626;4901.975490122527;4934.753262336869;5177.508136727005;5204.505571970657;5204.8178313758835;5216.400113986789;5218.095395180656;4848.854534363974;5029.371328583927;5047.167217409086;5076.314697515788;5086.745662716776;4833.613310935047;4841.402337228777;4863.392075990501;4876.171050921423;4878.878028049327;3603.7837729736298;3606.5852426971232;3616.8914932552066;3619.800910949923;3629.1834337273904;4897.706137631753;5149.794008239628;5159.793608255628;5164.638475306842;5179.710883588873;4945.2582112683385;4945.901081978268;4956.306117143675;4958.6281028923695;4985.604030871362;4954.8761280968265;4969.304297398295;4980.207125434913;5023.799048038184;5052.595792336678;4754.31062495943;4933.703977761345;4968.552830245295;4973.204287314013;4986.700797952134;4833.10587541306;4965.106280869478;4991.900161996812;5034.395872495324;5064.18972964324;4790.353302304145;4828.227483602606;4837.153498137882;4841.927371089507;4843.927341089816 09:34:47 INFO - PROCESS | 14418 | |5;yui.html;573.1202604002855;683.402023229674;727.8325985023448;741.9888701669472;749.8087987563172;10998.670039898805;11237.438128093583;11246.49390777415;11670.766584668301;11681.357525336103;13082.149660272076;13294.135881167716;13318.20090794553;13366.66583335417;13727.65680857979;752.834376437183;772.8145245141181;773.6789232468519;778.2451022508186;781.3007358414216;629.593911926807;771.7067514344541;776.351746291847;780.4926797581561;780.7072347869549;672.2537982839045;787.9015123109612;812.995935020324;813.4265342933247;818.0183779464636;809.4536188073057;809.9392545559107;810.3679130278392;810.3841080778592;810.4205493072482;433.41272575659843;593.4807043836643;593.5489028338451;594.04655527878;594.3551246897122;9857.802843943082;12624.24254544721;13182.538611148564;13284.867151328459;13308.201507909556;13271.469141234338;13859;14172;14245.287735613178;14386.280685965765;10257.640982565574;10385.84421233682;10551.577936882515;10556.630517931912;10651.414172220524;3317.5853018372704;3324.517944897976;3332.150301673058;3355.2115252915546;3392.4402473591826;67470;68165.3183468159;68173.65913170403;69095;70509.29490705079;10103.09072183507;10740;10750.247482676137;10806.243562950518;11000.614978475714;19376.44653506425;19487.123079461457;19549;20129.194832206547;21609.56780864374;7048.859022819515;7102.538335008208;7315.634218289064;7321.832100584362;7414;3747.9437808432895;3771.8114094295174;3846.9038274043373;3860.517435320585;3881.7088718346236;3046.329807442359;3169.4453470642547;3340.799552026886;3493.615702272748;3531.170175008871;553.6180035775383;555.3585608622049;558.4331903118339;563.7942151114813;570.6918264137403;550.5127961753797;569.7863301262026;583.7898356591623;595.1905408644241;598.3059650805045;7970.97103100818;8717.564121793885;8766.60550275239;8782.209601135928;8827.852379190792;547.3267880506999;576.3919065386058;583.7752465300805;600.4715850051927;601.4947444146937;3867.7099217558793;3951.3480275754177;3995.32079546472;4157.771322577227;4223.725457845292;88345.11654883498;100516.4974175139;100637;106293;106469.46765266279;51417.742911285204;51817.7409112952;52260.47739522632;52423.47576524262;52812.735936320074;63725.485294926744;73594;74562;75108.62445687846;79167;7786.532808031537;7855.764327070197;8008.639611217625;8022.438429310126;8138.633761480629;40122.59877401189;43097.78451107725;46175.84560386017;46423.53576464192;47732.52267477281;56439.71780141073;58876.41123588709;59336.703316483145;73683.63158184175;73865.6306718463;11565.768684626428;11887.28676279426;12313.56902508408;12328.630141095782;12715.237085774883;12620.495180192689;13036.608901732963;13325.267110309027;14222.715545689236;14661.340239689027;12368.876311236772;12386.938065309616;12637.2417654941;12757.872421275668;13128.277944713132;9540.809183816424;10800.891991079989;12587.99296056295;12616.49534018629;13706.794398083837;11484.655460336204;11692.35692036946;11728.296302221894;11843.822342664695;12183.269003859798;9444.763880902758;9628.518574071408;10093;10127.949360253151;10619.36283822973;9653.276004299565;10201.387916724723;10244.692659220234;10421.06210441064;10666.38788494254 09:34:47 INFO - PROCESS | 14418 | __end_tp_report 09:34:47 INFO - PROCESS | 14418 | __start_cc_report 09:34:47 INFO - PROCESS | 14418 | _x_x_mozilla_cycle_collect,1283 09:34:47 INFO - PROCESS | 14418 | __end_cc_report 09:34:47 INFO - PROCESS | 14418 | __startTimestamp1474648487758__endTimestamp 09:34:47 INFO - PROCESS | 14418 | 09:34:47 INFO - PROCESS | 14418 | ------- Summary: start ------- 09:34:47 INFO - PROCESS | 14418 | Number of tests: 6 09:34:47 INFO - PROCESS | 14418 | 09:34:47 INFO - PROCESS | 14418 | [#0] dojo.html Cycles:165 Average:4726.45 Median:4854.49 stddev:502.18 (10.3%) stddev-sans-first:475.86 09:34:47 INFO - PROCESS | 14418 | Values: 2623.7 2643.6 2665.1 2684.8 2686.2 4572.1 4643.7 4712.0 4768.1 4811.9 4704.1 4737.2 4795.1 4804.4 4846.0 4344.4 4345.6 4400.9 4402.5 4423.6 4403.4 4520.5 4521.3 4523.3 4542.6 4462.4 4503.6 4521.8 4523.4 4559.2 4322.2 4362.8 4371.4 4429.2 4432.0 4260.8 4295.3 4311.2 4332.5 4370.4 4718.8 4783.6 4809.3 4825.3 4868.6 5026.5 5135.6 5150.1 5151.4 5216.2 5077.2 5099.6 5136.4 5165.4 5182.9 4791.0 4798.1 4808.2 4810.4 4824.2 5023.6 5262.4 5275.8 5277.4 5286.1 4854.5 5023.4 5048.7 5057.1 5150.6 5133.9 5152.1 5153.6 5154.2 5155.0 5108.7 5111.9 5112.2 5141.7 5175.8 4875.0 4924.7 4926.3 4980.3 4994.3 4176.2 4195.0 4227.5 4228.1 4236.6 3749.2 3752.5 3790.1 3797.6 3816.1 4353.8 4359.9 4361.6 4366.1 4419.3 4997.1 5037.7 5121.6 5143.2 5203.8 4314.0 4338.8 4356.8 4396.0 4447.2 4602.7 4604.5 4606.7 4650.0 4653.2 4829.5 4839.0 4839.3 4843.5 4899.3 5063.9 5071.7 5099.3 5115.9 5126.4 4823.3 4831.1 4831.3 4881.7 4891.5 5001.7 5037.3 5039.2 5044.5 5104.1 5023.8 5090.0 5090.0 5106.6 5182.8 4944.4 4982.3 5002.7 5010.9 5017.3 5011.2 5019.3 5030.4 5030.4 5093.7 4748.8 4956.6 4971.7 4980.5 5046.3 4863.1 5047.5 5079.9 5099.5 5157.6 4944.2 4950.5 4952.9 4965.3 5024.6 09:34:47 INFO - PROCESS | 14418 | 09:34:47 INFO - PROCESS | 14418 | [#1] ext.html Cycles:180 Average:45104.68 Median:35351.23 stddev:84528.05 (239.1%) stddev-sans-first:84698.94 09:34:47 INFO - PROCESS | 14418 | Values: 535.6 547.4 566.8 577.0 580.1 27704.4 28358.1 36481.0 37855.0 38087.4 39182.8 39768.0 39800.8 39801.4 39830.0 7547.1 7691.6 7693.0 7708.7 7725.3 7430.5 7515.9 7517.9 7526.7 7547.4 7531.7 7547.6 7557.9 7567.1 7575.9 7503.9 7538.8 7540.3 7545.3 7545.7 7525.2 7581.9 7589.1 7592.3 7598.5 37605.4 37953.0 37973.6 37996.4 38007.0 3062.6 3119.4 3132.9 3331.0 3426.9 27443.5 27989.9 28084.4 28091.7 28258.4 3393.6 3455.5 3517.1 3553.0 3604.5 244458.4 244643.0 245080.0 245138.0 245958.8 30842.0 51721.2 51836.5 52086.7 52130.0 31618.2 33202.0 33204.8 33211.7 33232.0 11715.5 11843.2 11850.8 11853.1 11860.5 9465.8 9557.6 9570.1 9570.7 9575.5 7746.0 7754.6 7811.3 7863.1 7880.8 3031.5 3052.7 3053.1 3088.3 3114.1 851.8 879.6 912.8 914.2 933.5 27181.9 27664.9 27738.0 27926.6 28132.0 934.7 962.4 986.8 991.8 1019.0 13919.7 14754.6 14818.3 14929.0 15079.6 397845.0 401258.0 402789.0 402961.0 403460.0 47811.3 48192.3 48296.3 48360.0 48378.8 1066.3 1079.4 1124.2 1135.3 1193.6 25114.0 28518.3 28730.9 29093.6 29598.1 39928.0 40263.6 40307.8 40373.4 40570.0 290832.0 291943.0 292220.0 293060.0 293334.0 21163.3 21652.0 21968.0 22340.6 24676.3 39976.2 40567.4 40575.6 40642.0 41571.8 33917.5 35181.5 35254.0 35307.8 35394.6 34144.1 34483.0 34722.0 34774.0 35062.1 34359.5 34619.8 34641.5 34957.3 34970.8 29241.0 31588.5 31630.7 31676.5 31891.0 24424.9 24625.0 25054.0 28477.6 31399.7 09:34:47 INFO - PROCESS | 14418 | 09:34:47 INFO - PROCESS | 14418 | [#2] jquery.html Cycles:180 Average:22228.19 Median:380.40 stddev:56038.92 (14731.4%) stddev-sans-first:56172.07 09:34:47 INFO - PROCESS | 14418 | Values: 360.6 379.4 381.4 383.7 393.2 15175.9 15241.9 16621.0 16716.1 16733.2 15548.8 15614.6 15848.8 16436.8 16490.8 4920.2 5152.6 5159.6 5165.3 5173.7 4898.5 5034.2 5097.4 5119.2 5122.6 5042.8 5076.6 5080.4 5080.7 5084.0 4894.3 5080.0 5082.7 5082.9 5083.9 4532.0 4541.5 4552.4 4559.1 4561.7 20144.8 20202.9 20457.4 20576.3 20675.4 1887.3 1900.8 1911.4 2333.5 2403.1 12190.8 12992.9 13031.7 13587.9 13644.2 1705.4 1717.9 1760.4 1763.2 1767.7 42236.8 56765.1 59355.1 67925.3 68013.3 9082.7 9353.8 9414.8 9645.6 9919.4 12439.3 12444.2 12458.2 12461.3 12462.0 6456.5 6585.8 6730.9 6756.0 6771.8 6215.9 6299.0 6300.9 6437.8 6459.0 5893.0 5898.1 5984.7 5999.2 6198.9 1676.6 1750.6 1752.9 1792.6 1814.4 849.4 860.3 898.8 911.5 966.6 16693.9 16830.3 17830.7 17957.6 18276.7 818.4 824.9 840.0 874.4 875.3 9679.9 10010.6 10131.9 10250.4 10338.3 328907.0 333735.0 338264.0 347560.7 352854.0 51411.0 64839.7 70654.0 72892.3 74468.6 909.9 920.6 925.5 949.7 958.9 11883.1 16279.4 16908.8 16966.3 17018.1 35941.5 36504.5 36988.3 37020.8 37226.6 42465.4 43844.0 44030.0 44255.8 44450.3 7569.7 7574.5 7601.9 7692.7 7975.2 12109.2 12159.3 12314.2 12321.6 12559.5 10206.2 10336.2 10456.9 10508.5 11026.1 10271.8 10430.2 10612.9 10616.3 10647.9 10256.4 10556.5 10811.6 10985.3 11410.1 7639.1 7675.5 7740.7 7925.2 7930.4 10263.0 10478.7 10767.2 10966.9 11012.5 09:34:47 INFO - PROCESS | 14418 | 09:34:47 INFO - PROCESS | 14418 | [#3] mootools.html Cycles:180 Average:5219.73 Median:5107.55 stddev:2963.32 (58.0%) stddev-sans-first:2957.37 09:34:47 INFO - PROCESS | 14418 | Values: 1351.5 1394.0 1432.8 1639.7 1677.5 7123.7 7348.7 7598.3 8282.2 8285.8 7620.6 7874.6 7875.3 8096.7 8142.5 2193.7 2220.9 2229.3 2238.1 2244.2 1857.8 1927.5 2163.3 2187.4 2218.3 2097.3 2167.4 2171.0 2177.2 2184.0 2164.3 2164.8 2173.6 2225.1 2228.3 2182.5 2185.6 2226.0 2233.3 2236.5 8018.6 8140.7 8158.6 8159.6 8170.5 4702.4 4856.3 4856.7 4858.1 4860.1 2692.9 2836.8 2891.5 2899.7 2906.9 915.8 926.5 943.3 947.1 959.6 10924.2 10931.7 10932.6 10942.5 10947.0 4304.0 4307.3 4393.9 4403.2 4442.1 9420.8 9434.8 9442.5 9445.3 9450.0 4816.3 4835.2 4835.4 4836.3 4838.8 4128.8 4143.9 4402.8 4413.6 4414.6 3650.3 3654.8 3716.1 3734.9 3817.1 1068.1 1098.1 1197.2 1265.4 1276.5 604.8 694.4 760.9 771.2 781.4 4878.0 5008.9 5029.2 5092.9 5146.2 871.9 880.1 881.0 881.3 907.9 3478.2 3490.1 3503.3 3505.5 3664.7 9611.4 9898.5 9980.8 9986.5 9994.0 9899.4 9900.7 9902.2 9902.5 9910.8 7327.0 7390.8 7466.5 7525.5 7551.5 4975.2 5089.9 5122.2 5147.2 5148.7 8850.4 8948.9 9047.0 9051.4 9078.4 9174.2 9195.2 9206.5 9249.7 9273.2 6844.3 6916.0 6916.1 6918.3 6923.0 7584.8 7603.4 7612.9 7665.1 7698.4 5367.9 6758.2 6824.5 6872.1 7094.4 6744.8 6758.5 6818.7 6826.2 6874.8 6413.4 6490.3 6501.6 6509.2 6535.9 4506.5 4622.8 4667.5 4674.0 4698.1 4501.2 4538.8 4639.0 4663.7 4720.0 09:34:47 INFO - PROCESS | 14418 | 09:34:47 INFO - PROCESS | 14418 | [#4] prototype.html Cycles:180 Average:4153.81 Median:4813.46 stddev:1217.76 (25.3%) stddev-sans-first:1186.12 09:34:47 INFO - PROCESS | 14418 | Values: 288.6 289.7 297.1 299.2 302.6 4829.3 4861.5 4866.3 4874.7 4883.6 4776.7 4801.6 4819.7 4834.3 4849.2 3565.8 3703.7 3724.2 3734.8 3738.5 3658.3 3722.5 3774.2 3808.7 3813.4 3727.5 3736.6 3746.3 3759.8 3767.9 3511.5 3674.4 3729.6 3744.3 3760.0 3239.7 3244.3 3251.6 3251.8 3254.8 4657.7 4663.0 4671.8 4672.4 4687.4 4205.1 4207.4 4212.0 4215.9 4246.9 4753.8 4888.2 4960.7 5003.6 5012.7 3507.9 3524.6 3525.9 3539.9 3548.5 5260.1 5300.9 5307.4 5320.1 5323.1 3525.3 3607.2 3618.4 3634.0 3639.3 3662.5 3664.4 3665.6 3681.3 3686.9 4173.4 4193.5 4203.3 4211.3 4234.4 4994.2 5001.4 5023.5 5033.8 5048.7 1205.3 1270.9 1272.3 1275.6 1282.4 770.2 804.9 817.3 817.7 818.9 4228.2 4332.9 4383.5 4474.5 4476.2 5149.2 5168.4 5169.3 5190.3 5207.9 4440.3 4443.9 4443.9 4450.3 4457.3 2644.3 2720.4 2730.9 2736.5 2736.5 4851.6 4856.9 4867.3 4874.1 4887.2 5094.8 5289.8 5293.3 5296.8 5320.8 4807.2 4899.3 4901.7 4902.0 4934.8 5177.5 5204.5 5204.8 5216.4 5218.1 4848.9 5029.4 5047.2 5076.3 5086.7 4833.6 4841.4 4863.4 4876.2 4878.9 3603.8 3606.6 3616.9 3619.8 3629.2 4897.7 5149.8 5159.8 5164.6 5179.7 4945.3 4945.9 4956.3 4958.6 4985.6 4954.9 4969.3 4980.2 5023.8 5052.6 4754.3 4933.7 4968.6 4973.2 4986.7 4833.1 4965.1 4991.9 5034.4 5064.2 4790.4 4828.2 4837.2 4841.9 4843.9 09:34:47 INFO - PROCESS | 14418 | 09:34:47 INFO - PROCESS | 14418 | [#5] yui.html Cycles:180 Average:17297.03 Median:21765.60 stddev:24174.48 (111.1%) stddev-sans-first:24209.68 09:34:47 INFO - PROCESS | 14418 | Values: 573.1 683.4 727.8 742.0 749.8 10998.7 11237.4 11246.5 11670.8 11681.4 13082.1 13294.1 13318.2 13366.7 13727.7 752.8 772.8 773.7 778.2 781.3 629.6 771.7 776.4 780.5 780.7 672.3 787.9 813.0 813.4 818.0 809.5 809.9 810.4 810.4 810.4 433.4 593.5 593.5 594.0 594.4 9857.8 12624.2 13182.5 13284.9 13308.2 13271.5 13859.0 14172.0 14245.3 14386.3 10257.6 10385.8 10551.6 10556.6 10651.4 3317.6 3324.5 3332.2 3355.2 3392.4 67470.0 68165.3 68173.7 69095.0 70509.3 10103.1 10740.0 10750.2 10806.2 11000.6 19376.4 19487.1 19549.0 20129.2 21609.6 7048.9 7102.5 7315.6 7321.8 7414.0 3747.9 3771.8 3846.9 3860.5 3881.7 3046.3 3169.4 3340.8 3493.6 3531.2 553.6 555.4 558.4 563.8 570.7 550.5 569.8 583.8 595.2 598.3 7971.0 8717.6 8766.6 8782.2 8827.9 547.3 576.4 583.8 600.5 601.5 3867.7 3951.3 3995.3 4157.8 4223.7 88345.1 100516.5 100637.0 106293.0 106469.5 51417.7 51817.7 52260.5 52423.5 52812.7 63725.5 73594.0 74562.0 75108.6 79167.0 7786.5 7855.8 8008.6 8022.4 8138.6 40122.6 43097.8 46175.8 46423.5 47732.5 56439.7 58876.4 59336.7 73683.6 73865.6 11565.8 11887.3 12313.6 12328.6 12715.2 12620.5 13036.6 13325.3 14222.7 14661.3 12368.9 12386.9 12637.2 12757.9 13128.3 9540.8 10800.9 12588.0 12616.5 13706.8 11484.7 11692.4 11728.3 11843.8 12183.3 9444.8 9628.5 10093.0 10127.9 10619.4 9653.3 10201.4 10244.7 10421.1 10666.4 09:34:47 INFO - PROCESS | 14418 | -------- Summary: end -------- 09:34:47 INFO - PROCESS | 14418 | 09:34:48 INFO - TEST-INFO | 14418: exit 0 09:34:48 INFO - TEST-OK | dromaeo_css | took 1121373ms 09:34:48 INFO - TEST-START | kraken 09:34:48 INFO - operating with platform_type : linux_ 09:34:48 INFO - Initialising browser for kraken test... 09:34:48 INFO - TEST-INFO | started process 14722 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFCXT9Y/profile http://localhost:43091/getInfo.html) 09:34:53 INFO - PROCESS | 14722 | __metrics Screen width/height:1600/1200 09:34:53 INFO - PROCESS | 14722 | colorDepth:24 09:34:53 INFO - PROCESS | 14722 | Browser inner width/height: 1024/697 09:34:53 INFO - PROCESS | 14722 | __metrics 09:34:53 INFO - PROCESS | 14722 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:34:53 INFO - PROCESS | 14722 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:34:54 INFO - PROCESS | 14722 | console.error: PushService: 09:34:54 INFO - PROCESS | 14722 | stateChangeProcessEnqueue: Error transitioning state 09:34:54 INFO - PROCESS | 14722 | UnknownError 09:34:55 INFO - TEST-INFO | 14722: exit 0 09:34:55 INFO - Browser initialized. 09:34:55 INFO - Running cycle 1/1 for kraken test... 09:34:55 INFO - TEST-INFO | started process 14803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFCXT9Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:35:07 INFO - PROCESS | 14803 | RSS: Main: 175370240 09:35:07 INFO - PROCESS | 14803 | 09:35:10 INFO - PROCESS | 14803 | Cycle 1(1): loaded http://localhost:43091/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43091/tests/kraken/driver.html?testName=audio-beat-detection) 09:35:11 INFO - PROCESS | 14803 | RSS: Main: 233459712 09:35:11 INFO - PROCESS | 14803 | 09:35:13 INFO - PROCESS | 14803 | Cycle 1(1): loaded http://localhost:43091/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43091/tests/kraken/driver.html?testName=audio-dft) 09:35:14 INFO - PROCESS | 14803 | RSS: Main: 218685440 09:35:14 INFO - PROCESS | 14803 | 09:35:17 INFO - PROCESS | 14803 | Cycle 1(1): loaded http://localhost:43091/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43091/tests/kraken/driver.html?testName=audio-fft) 09:35:18 INFO - PROCESS | 14803 | RSS: Main: 301219840 09:35:18 INFO - PROCESS | 14803 | 09:35:20 INFO - PROCESS | 14803 | Cycle 1(1): loaded http://localhost:43091/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43091/tests/kraken/driver.html?testName=audio-oscillator) 09:35:21 INFO - PROCESS | 14803 | RSS: Main: 209981440 09:35:21 INFO - PROCESS | 14803 | 09:35:23 INFO - PROCESS | 14803 | Cycle 1(1): loaded http://localhost:43091/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43091/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:35:23 INFO - PROCESS | 14803 | RSS: Main: 214265856 09:35:23 INFO - PROCESS | 14803 | 09:35:27 INFO - PROCESS | 14803 | Cycle 1(1): loaded http://localhost:43091/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43091/tests/kraken/driver.html?testName=imaging-darkroom) 09:35:27 INFO - PROCESS | 14803 | RSS: Main: 250564608 09:35:27 INFO - PROCESS | 14803 | 09:35:31 INFO - PROCESS | 14803 | Cycle 1(1): loaded http://localhost:43091/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43091/tests/kraken/driver.html?testName=imaging-desaturate) 09:35:31 INFO - PROCESS | 14803 | RSS: Main: 244695040 09:35:31 INFO - PROCESS | 14803 | 09:35:34 INFO - PROCESS | 14803 | Cycle 1(1): loaded http://localhost:43091/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43091/tests/kraken/driver.html?testName=json-parse-financial) 09:35:35 INFO - PROCESS | 14803 | RSS: Main: 247750656 09:35:35 INFO - PROCESS | 14803 | 09:35:37 INFO - PROCESS | 14803 | Cycle 1(1): loaded http://localhost:43091/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43091/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:35:37 INFO - PROCESS | 14803 | RSS: Main: 210866176 09:35:37 INFO - PROCESS | 14803 | 09:35:39 INFO - PROCESS | 14803 | Cycle 1(1): loaded http://localhost:43091/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43091/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:35:40 INFO - PROCESS | 14803 | RSS: Main: 218529792 09:35:40 INFO - PROCESS | 14803 | 09:35:42 INFO - PROCESS | 14803 | Cycle 1(1): loaded http://localhost:43091/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43091/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:35:43 INFO - PROCESS | 14803 | RSS: Main: 222846976 09:35:43 INFO - PROCESS | 14803 | 09:35:46 INFO - PROCESS | 14803 | Cycle 1(1): loaded http://localhost:43091/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43091/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:35:46 INFO - PROCESS | 14803 | RSS: Main: 223481856 09:35:46 INFO - PROCESS | 14803 | 09:35:49 INFO - PROCESS | 14803 | Cycle 1(1): loaded http://localhost:43091/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43091/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:35:50 INFO - PROCESS | 14803 | RSS: Main: 221908992 09:35:50 INFO - PROCESS | 14803 | 09:35:52 INFO - PROCESS | 14803 | Cycle 1(1): loaded http://localhost:43091/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43091/tests/kraken/driver.html?testName=ai-astar) 09:35:52 INFO - PROCESS | 14803 | RSS: Main: 272359424 09:35:52 INFO - PROCESS | 14803 | 09:35:52 INFO - PROCESS | 14803 | __start_tp_report 09:35:52 INFO - PROCESS | 14803 | _x_x_mozilla_page_load 09:35:52 INFO - PROCESS | 14803 | _x_x_mozilla_page_load_details 09:35:52 INFO - PROCESS | 14803 | |i|pagename|runs| 09:35:52 INFO - PROCESS | 14803 | |0;ai-astar;113;115;114;114;113;114;114;115;114;115 09:35:52 INFO - PROCESS | 14803 | |1;audio-beat-detection;158;129;128;165;124;126;124;124;157;126 09:35:52 INFO - PROCESS | 14803 | |2;audio-dft;160;161;161;161;163;161;162;160;161;162 09:35:52 INFO - PROCESS | 14803 | |3;audio-fft;78;76;79;107;76;76;77;76;97;77 09:35:52 INFO - PROCESS | 14803 | |4;audio-oscillator;84;84;113;85;83;84;116;85;84;114 09:35:52 INFO - PROCESS | 14803 | |5;imaging-gaussian-blur;117;117;117;118;117;117;116;116;118;117 09:35:52 INFO - PROCESS | 14803 | |6;imaging-darkroom;146;146;146;147;146;147;146;147;147;147 09:35:52 INFO - PROCESS | 14803 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;95 09:35:52 INFO - PROCESS | 14803 | |8;json-parse-financial;64;63;63;63;63;65;65;64;64;64 09:35:52 INFO - PROCESS | 14803 | |9;json-stringify-tinderbox;65;67;76;65;66;66;65;65;65;65 09:35:52 INFO - PROCESS | 14803 | |10;stanford-crypto-aes;82;83;83;82;83;83;84;82;82;82 09:35:52 INFO - PROCESS | 14803 | |11;stanford-crypto-ccm;143;140;145;140;144;137;141;137;175;142 09:35:52 INFO - PROCESS | 14803 | |12;stanford-crypto-pbkdf2;174;176;172;174;177;182;178;176;170;171 09:35:52 INFO - PROCESS | 14803 | |13;stanford-crypto-sha256-iterative;71;70;70;69;69;68;69;68;69;73 09:35:52 INFO - PROCESS | 14803 | __end_tp_report 09:35:52 INFO - PROCESS | 14803 | __start_cc_report 09:35:52 INFO - PROCESS | 14803 | _x_x_mozilla_cycle_collect,1954 09:35:52 INFO - PROCESS | 14803 | __end_cc_report 09:35:52 INFO - PROCESS | 14803 | __startTimestamp1474648552287__endTimestamp 09:35:52 INFO - PROCESS | 14803 | 09:35:52 INFO - PROCESS | 14803 | ------- Summary: start ------- 09:35:52 INFO - PROCESS | 14803 | Number of tests: 14 09:35:52 INFO - PROCESS | 14803 | 09:35:52 INFO - PROCESS | 14803 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 09:35:52 INFO - PROCESS | 14803 | Values: 113.0 115.0 114.0 114.0 113.0 114.0 114.0 115.0 114.0 115.0 09:35:52 INFO - PROCESS | 14803 | 09:35:52 INFO - PROCESS | 14803 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:128.50 stddev:16.70 (13.0%) stddev-sans-first:15.72 09:35:52 INFO - PROCESS | 14803 | Values: 158.0 129.0 128.0 165.0 124.0 126.0 124.0 124.0 157.0 126.0 09:35:52 INFO - PROCESS | 14803 | 09:35:52 INFO - PROCESS | 14803 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 09:35:52 INFO - PROCESS | 14803 | Values: 160.0 161.0 161.0 161.0 163.0 161.0 162.0 160.0 161.0 162.0 09:35:52 INFO - PROCESS | 14803 | 09:35:52 INFO - PROCESS | 14803 | [#3] audio-fft Cycles:10 Average:81.90 Median:77.00 stddev:10.90 (14.2%) stddev-sans-first:11.47 09:35:52 INFO - PROCESS | 14803 | Values: 78.0 76.0 79.0 107.0 76.0 76.0 77.0 76.0 97.0 77.0 09:35:52 INFO - PROCESS | 14803 | 09:35:52 INFO - PROCESS | 14803 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:84.00 stddev:14.61 (17.4%) stddev-sans-first:15.11 09:35:52 INFO - PROCESS | 14803 | Values: 84.0 84.0 113.0 85.0 83.0 84.0 116.0 85.0 84.0 114.0 09:35:52 INFO - PROCESS | 14803 | 09:35:52 INFO - PROCESS | 14803 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 09:35:52 INFO - PROCESS | 14803 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 116.0 116.0 118.0 117.0 09:35:52 INFO - PROCESS | 14803 | 09:35:52 INFO - PROCESS | 14803 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 09:35:52 INFO - PROCESS | 14803 | Values: 146.0 146.0 146.0 147.0 146.0 147.0 146.0 147.0 147.0 147.0 09:35:52 INFO - PROCESS | 14803 | 09:35:52 INFO - PROCESS | 14803 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:35:52 INFO - PROCESS | 14803 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 09:35:52 INFO - PROCESS | 14803 | 09:35:52 INFO - PROCESS | 14803 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 09:35:52 INFO - PROCESS | 14803 | Values: 64.0 63.0 63.0 63.0 63.0 65.0 65.0 64.0 64.0 64.0 09:35:52 INFO - PROCESS | 14803 | 09:35:52 INFO - PROCESS | 14803 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:65.50 stddev:3.41 (5.2%) stddev-sans-first:3.57 09:35:52 INFO - PROCESS | 14803 | Values: 65.0 67.0 76.0 65.0 66.0 66.0 65.0 65.0 65.0 65.0 09:35:52 INFO - PROCESS | 14803 | 09:35:52 INFO - PROCESS | 14803 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 09:35:52 INFO - PROCESS | 14803 | Values: 82.0 83.0 83.0 82.0 83.0 83.0 84.0 82.0 82.0 82.0 09:35:52 INFO - PROCESS | 14803 | 09:35:52 INFO - PROCESS | 14803 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:142.50 stddev:11.08 (7.8%) stddev-sans-first:11.74 09:35:52 INFO - PROCESS | 14803 | Values: 143.0 140.0 145.0 140.0 144.0 137.0 141.0 137.0 175.0 142.0 09:35:52 INFO - PROCESS | 14803 | 09:35:52 INFO - PROCESS | 14803 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:176.00 stddev:3.59 (2.0%) stddev-sans-first:3.79 09:35:52 INFO - PROCESS | 14803 | Values: 174.0 176.0 172.0 174.0 177.0 182.0 178.0 176.0 170.0 171.0 09:35:52 INFO - PROCESS | 14803 | 09:35:52 INFO - PROCESS | 14803 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.50 stddev:1.51 (2.2%) stddev-sans-first:1.51 09:35:52 INFO - PROCESS | 14803 | Values: 71.0 70.0 70.0 69.0 69.0 68.0 69.0 68.0 69.0 73.0 09:35:52 INFO - PROCESS | 14803 | -------- Summary: end -------- 09:35:52 INFO - PROCESS | 14803 | 09:35:53 INFO - TEST-INFO | 14803: exit 0 09:35:53 INFO - TEST-OK | kraken | took 64833ms 09:35:53 INFO - SUITE-END | took 1186s 09:35:53 INFO - Completed test suite (00:19:46) 09:35:53 INFO - javascript benchmark 09:35:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.6589243398357, 2643.5770276755725, 2665.067226470735, 2684.8120631555785, 2686.220995911186, 4572.108438854425, 4643.651726120537, 4711.999999999995, 4768.1417344877955, 4811.903761924764, 4704.129735998843, 4737.170995075857, 4795.088933102708, 4804.351412559304, 4845.982343707826, 4344.413504176927, 4345.587169218919, 4400.911981760363, 4402.471703395581, 4423.646108311327, 4403.383526306304, 4520.50274469808, 4521.344405061264, 4523.3441151033085, 4542.568455996675, 4462.3752674625575, 4503.617192538638, 4521.841735539273, 4523.389342438778, 4559.202139625552, 4322.2436073687295, 4362.825486980549, 4371.409859668967, 4429.202743506167, 4431.955680443187, 4260.808263628144, 4295.2912769393015, 4311.1593239318345, 4332.501762297345, 4370.409994650713, 4718.811247550094, 4783.569478746895, 4809.254565542346, 4825.324454576362, 4868.561829435333, 5026.52248036436, 5135.6148288878485, 5150.072986862363, 5151.356080489939, 5216.191490319006, 5077.238414237857, 5099.643024988252, 5136.383633963911, 5165.380154381461, 5182.870428239286, 4791.0, 4798.064377446434, 4808.230683090689, 4810.42274927011, 4824.179889418807, 5023.572996295283, 5262.447443018428, 5275.762590683428, 5277.366715994029, 5286.07493688603, 4854.490278520775, 5023.447420783711, 5048.6718363307, 5057.089723849743, 5150.562202212779, 5133.922991155136, 5152.098382782998, 5153.587712982952, 5154.201098829687, 5154.974225128925, 5108.693478391308, 5111.948880511147, 5112.207607820794, 5141.71720555373, 5175.792968281226, 4875.0493653737185, 4924.679895806761, 4926.261060840902, 4980.302757613937, 4994.2508623706735, 4176.227397931392, 4194.979025104855, 4227.471566054243, 4228.069824638575, 4236.597523235288, 3749.1939233064477, 3752.4746535485056, 3790.0903783092413, 3797.6012518685693, 3816.1222918728295, 4353.782310884443, 4359.912801743947, 4361.563843615677, 4366.148601022834, 4419.270820314612, 4997.100521906092, 5037.697738135724, 5121.641485096082, 5143.177091665316, 5203.765830537635, 4313.97843010783, 4338.826446942087, 4356.825726970949, 4395.978020109879, 4447.199504089231, 4602.723836569817, 4604.470485894098, 4606.700564463299, 4650.046740418206, 4653.232216684277, 4829.541193586604, 4839.0, 4839.274108883696, 4843.515648435128, 4899.3385892904, 5063.924041139312, 5071.721055341992, 5099.286099945936, 5115.897682046264, 5126.359205099363, 4823.324734537237, 4831.0820944020525, 4831.275308703723, 4881.682690625098, 4891.5353041461, 5001.749912504288, 5037.319961805109, 5039.168537191469, 5044.495550444926, 5104.1067813133295, 5023.8492845214705, 5089.9745501272255, 5090.032893750175, 5106.565941894981, 5182.792688292577, 4944.431390390151, 4982.2775697524385, 5002.699838009731, 5010.87472813168, 5017.347744793154, 5011.223260394645, 5019.32239147725, 5030.37120359955, 5030.421501527225, 5093.719845408538, 4748.810047598057, 4956.578690811177, 4971.676841005323, 4980.452150263396, 5046.34397528319, 4863.076015557032, 5047.4952504749235, 5079.898402031865, 5099.5410413063, 5157.561607263425, 4944.233643785219, 4950.504949505021, 4952.8761780955765, 4965.329680493087, 5024.623153263593], "value": 4693.9797424582775, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.6277387215887, 547.3732576200254, 566.7704579645243, 577.0478710128291, 580.0834681203698, 27704.445911081766, 28358.149255522316, 36481.0, 37855.0, 38087.42868856969, 39182.8040859796, 39768.0, 39800.80099599498, 39801.40297895534, 39830.0, 7547.094348678166, 7691.576963267018, 7693.038370203724, 7708.6916523339, 7725.304722574967, 7430.517016393917, 7515.887261691079, 7517.924820751778, 7526.698932042712, 7547.43394245431, 7531.698732050711, 7547.584882831469, 7557.924420755777, 7567.129780075279, 7575.886361704579, 7503.887441688379, 7538.773836784905, 7540.283673051052, 7545.283198096172, 7545.69817207311, 7525.172231054579, 7581.886271705929, 7589.051368578927, 7592.316691497792, 7598.544087354721, 37605.43591846125, 37953.0, 37973.62026379728, 37996.43005354922, 38007.0, 3062.5712400263983, 3119.4385010698065, 3132.856507374792, 3331.017349881791, 3426.8971930842113, 27443.451130977468, 27989.86005069982, 28084.438311233866, 28091.71908280932, 28258.434831303464, 3393.592768867727, 3455.5335029771163, 3517.103138699641, 3553.0, 3604.5494313210847, 244458.44269466138, 244643.0, 245080.0, 245138.0, 245958.7702061496, 30842.0, 51721.24181372749, 51836.48163518392, 52086.73956630193, 52130.0, 31618.209544761565, 33202.0, 33204.83397582997, 33211.66788332134, 33232.0, 11715.472803723853, 11843.230190037792, 11850.822237666442, 11853.111016673784, 11860.466279017464, 9465.763355916157, 9557.569909354095, 9570.138687518156, 9570.712878613653, 9575.521223938915, 7745.993020907359, 7754.612269386508, 7811.336036436966, 7863.13505514393, 7880.802979925433, 3031.5301128325145, 3052.6794686558037, 3053.114596766957, 3088.336007758298, 3114.065780265911, 851.7862046583593, 879.564615515324, 912.8219997100634, 914.2457472585144, 933.5005771911995, 27181.86409067942, 27664.881996830652, 27737.959143098644, 27926.581101283497, 28132.0, 934.7195841247599, 962.3744566032135, 986.7582442301539, 991.7718924647371, 1018.9898101019044, 13919.652008699864, 14754.631134221516, 14818.259087045604, 14929.029613075116, 15079.623009424633, 397845.0, 401258.0, 402789.0, 402961.0, 403460.0, 47811.28283075757, 48192.27711584329, 48296.27555586669, 48360.0, 48378.75810620924, 1066.2909165405074, 1079.390144568332, 1124.1961997172061, 1135.27909777292, 1193.5583833981482, 25114.0, 28518.287042824097, 28730.856345718137, 29093.563596545646, 29598.112056638336, 39928.0, 40263.597364027155, 40307.79846100751, 40373.39439908345, 40570.0, 290832.0, 291943.0, 292220.0, 293060.0, 293334.0, 21163.25928592492, 21652.0, 21968.0, 22340.553188935806, 24676.259712208663, 39976.200475990896, 40567.39148912828, 40575.59424405718, 40642.0, 41571.7921410391, 33917.49123763195, 35181.49142408663, 35254.0, 35307.82346088253, 35394.64605353914, 34144.14639634029, 34483.0, 34722.0, 34774.0, 35062.12344691403, 34359.48460773141, 34619.82690086634, 34641.480377794855, 34957.30085398329, 34970.82514587411, 29241.0, 31588.526172106976, 31630.683693163694, 31676.5248521277, 31891.0, 24424.87787561051, 24625.0, 25054.0, 28477.572836407886, 31399.68600314059], "value": 15935.04987046816, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.60153530348964, 379.4441143724443, 381.36502722966264, 383.7448097015485, 393.2371199872248, 15175.924120379397, 15241.92379038106, 16620.999999999985, 16716.080615566138, 16733.247003884822, 15548.76676849848, 15614.609634759137, 15848.84151158488, 16436.83563164368, 16490.75263871043, 4920.163572192736, 5152.562032227265, 5159.5614372778355, 5165.276861239429, 5173.715445650488, 4898.461169271395, 5034.244863270502, 5097.439281679012, 5119.206522988924, 5122.590192784568, 5042.82350117746, 5076.64463487556, 5080.364954380702, 5080.720560369178, 5083.974580127113, 4894.339264199323, 5080.034793389263, 5082.669626474268, 5082.949170508303, 5083.872903177432, 4531.977340113278, 4541.45502539694, 4552.385427967215, 4559.088182363507, 4561.7491037992895, 20144.79855201444, 20202.898985504977, 20457.419951508575, 20576.279830205873, 20675.379738607866, 1887.2639670528504, 1900.7624046994126, 1911.397909658453, 2333.498297865967, 2403.134871446278, 12190.756184876342, 12992.870071299356, 13031.739365212738, 13587.932060339734, 13644.249566273851, 1705.4031089118832, 1717.8797484176112, 1760.4014635024153, 1763.188933090767, 1767.6553072150937, 42236.78881605603, 56765.14852277219, 59355.109673355364, 67925.3207467924, 68013.31986680119, 9082.682106126254, 9353.766155846022, 9414.811703765887, 9645.565949532287, 9919.40483570988, 12439.253644781342, 12444.191127576678, 12458.190217635825, 12461.314627695563, 12462.003039756797, 6456.451201647913, 6585.769498067544, 6730.865382692319, 6756.0, 6771.762988295484, 6215.9378406216265, 6298.968505157445, 6300.907783124181, 6437.774677886251, 6458.998855177455, 5893.0, 5898.14476900847, 5984.670843103671, 5999.160117583542, 6198.931528893227, 1676.5724740191174, 1750.64111857069, 1752.9386471473692, 1792.587704827897, 1814.4103166470686, 849.4011721736161, 860.2945584620676, 898.7528429681759, 911.544227886057, 966.5891995901713, 16693.861307332507, 16830.326786928632, 17830.732539011926, 17957.64084718298, 18276.725849112274, 818.4025661267308, 824.8638974569249, 839.9790005249796, 874.3660845886808, 875.3478658399533, 9679.903200968041, 10010.599576016877, 10131.898681013243, 10250.38497690141, 10338.328008679411, 328907.0, 333735.0, 338264.0, 347560.67075304483, 352854.0, 51411.0, 64839.67580162069, 70654.0, 72892.27107728855, 74468.62765686246, 909.8999110097884, 920.5995392004365, 925.5233554719325, 949.6676163342913, 958.8993155718549, 11883.087197630723, 16279.430219942245, 16908.830911690726, 16966.321347145975, 17018.14909254557, 35941.460878087375, 36504.452433212995, 36988.26023479569, 37020.814895925345, 37226.627733722315, 42465.36301955411, 43844.0, 44030.0, 44255.77872110619, 44450.333245001995, 7569.697212111454, 7574.469787114849, 7601.923980760343, 7692.692292308245, 7975.2423519765525, 12109.152359334763, 12159.270443773403, 12314.199577027464, 12321.568745093879, 12559.497620095093, 10206.183505319408, 10336.224783141144, 10456.947715261374, 10508.474576271003, 11026.133205366503, 10271.794564108526, 10430.165586753194, 10612.946935265274, 10616.309939854194, 10647.94676026615, 10256.435896025492, 10556.472176390997, 10811.56753729842, 10985.340879547253, 11410.14423918226, 7639.121501027453, 7675.462717609714, 7740.651670674946, 7925.207479252029, 7930.405219608437, 10263.025012623788, 10478.738031549272, 10767.192460565333, 10966.890331096905, 11012.50443730018], "value": 8139.6099514109255, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.513455156144, 1393.9512117075901, 1432.8208973878266, 1639.7376419772838, 1677.5219062567178, 7123.67943442545, 7348.742794002211, 7598.31615154636, 8282.171782821722, 8285.792855178624, 7620.618969051539, 7874.606269686521, 7875.251851074153, 8096.716614918479, 8142.511449313045, 2193.7148170737823, 2220.9333719988426, 2229.3423440085135, 2238.1271304191378, 2244.1584405847807, 1857.7677790276216, 1927.4603111128906, 2163.3293678959494, 2187.398465422014, 2218.3234113595345, 2097.276439628326, 2167.4147980045377, 2170.9565808683815, 2177.150911144655, 2183.9781602183934, 2164.2857856907262, 2164.8376371772024, 2173.630482817917, 2225.0765932138142, 2228.2869481765842, 2182.508935489518, 2185.61751693453, 2225.955480890373, 2233.2630232023394, 2236.463248820288, 8018.558979256139, 8140.674373025072, 8158.551279679616, 8159.55122468264, 8170.509769413795, 4702.435707715062, 4856.3201151838775, 4856.660033797635, 4858.125537403266, 4860.05228980349, 2692.9192124236306, 2836.773058155343, 2891.5373540233463, 2899.666538348096, 2906.854657267128, 915.8168366326761, 926.4719110107242, 943.3255222515866, 947.1144479911305, 959.5586030426012, 10924.180686448548, 10931.726706832313, 10932.617358392497, 10942.507587158518, 10947.0, 4303.978480107579, 4307.332363483665, 4393.890152746207, 4403.207422663952, 4442.133783912106, 9420.764480888032, 9434.764130896645, 9442.480663563432, 9445.347064263726, 9450.007749186374, 4816.277558366273, 4835.202191638411, 4835.419749629997, 4836.298736683161, 4838.806447742051, 4128.814203360856, 4143.917121657611, 4402.757848318373, 4413.58070983256, 4414.602685758297, 3650.324689932371, 3654.7624404413627, 3716.108134047809, 3734.8879533614036, 3817.0838998640684, 1068.1188019883627, 1098.1434481104752, 1197.1918954705538, 1265.367316341829, 1276.5213045108085, 604.7973928733835, 694.4097517110416, 760.8782594784918, 771.2441807029143, 781.4412694923158, 4878.0, 5008.874778130503, 5029.245613157982, 5092.9236061459105, 5146.228065790161, 871.8726307809053, 880.1022956584249, 880.9955950220208, 881.290561098322, 907.9137481939205, 3478.1826270826336, 3490.057684425191, 3503.2818272254126, 3505.4566542186003, 3664.6885014774043, 9611.375260608038, 9898.455584942898, 9980.800383992424, 9986.500674966368, 9993.950030249802, 9899.356541824758, 9900.702978910644, 9902.207823374112, 9902.465117906737, 9910.752231194134, 7326.974223608699, 7390.815229619303, 7466.477346585687, 7525.473216874876, 7551.471397002267, 4975.228839529878, 5089.949100509096, 5122.1804511278015, 5147.227915812508, 5148.665336753099, 8850.380473366802, 8948.910510894808, 9047.0, 9051.411658242194, 9078.409903356262, 9174.174324310845, 9195.172434480928, 9206.539673016456, 9249.676261330822, 9273.211776999031, 6844.349786770249, 6915.965420172867, 6916.066331045446, 6918.308169183041, 6923.030775691306, 7584.810379740551, 7603.353714934293, 7612.923870761221, 7665.118511371264, 7698.384129269757, 5367.919481207863, 6758.189017317954, 6824.52228344031, 6872.140982377203, 7094.361507464353, 6744.7976560703255, 6758.493113016445, 6818.659067046727, 6826.249112597709, 6874.828129296808, 6413.422791948747, 6490.3185165558825, 6501.642409667514, 6509.218893732783, 6535.869282614416, 4506.481754598132, 4622.768861556841, 4667.463241727245, 4673.953260467351, 4698.130845793539, 4501.18978583858, 4538.841140560065, 4638.976805116088, 4663.720176789404, 4719.976400117977], "value": 4174.40501045463, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.5671492760859, 289.68713789107767, 297.12052325117645, 299.20560910781853, 302.5612861351041, 4829.275608658699, 4861.48954359792, 4866.343043689101, 4874.731889746063, 4883.6093112551, 4776.737279449638, 4801.615870730342, 4819.734914579705, 4834.274858771186, 4849.248366503189, 3565.8038807865555, 3703.7222158355326, 3724.2179142380132, 3734.775913445202, 3738.495303134069, 3658.323210206107, 3722.460243264725, 3774.188549461865, 3808.733388662795, 3813.4068833193555, 3727.5340582427198, 3736.6263373662687, 3746.2882052409955, 3759.8120093995326, 3767.9434808477895, 3511.5083888255663, 3674.4488326750934, 3729.608391118934, 3744.344739670574, 3759.9624003760023, 3239.6922292382424, 3244.2700392411753, 3251.6098068231727, 3251.8048917065053, 3254.8209848458328, 4657.743824089674, 4662.95337046632, 4671.84650361005, 4672.3692301539195, 4687.437507499122, 4205.11692544566, 4207.368894665794, 4211.957880421187, 4215.873523794291, 4246.893827654302, 4753.809847606091, 4888.242322440027, 4960.702357858504, 5003.574696150831, 5012.699238045729, 3507.930081325195, 3524.559430071241, 3525.894223173283, 3539.94690079649, 3548.4854696069183, 5260.132078207092, 5300.893982120336, 5307.416184219733, 5320.122179840322, 5323.148296272578, 3525.3125640499857, 3607.2424790794225, 3618.4029635109914, 3633.9818300908855, 3639.3085313790293, 3662.5238718966366, 3664.4320130379833, 3665.596784353719, 3681.3005528949416, 3686.852525898934, 4173.373993900939, 4193.496780386312, 4203.26442872496, 4211.326187809936, 4234.407182994321, 4994.20324618215, 5001.424836143818, 5023.497650234947, 5033.84898453047, 5048.722320272347, 1205.2828567002618, 1270.9428075736614, 1272.287518989369, 1275.6428200103985, 1282.3780466473752, 770.210534202447, 804.9275565199043, 817.2767101115555, 817.7219745286512, 818.8536049530704, 4228.18188179086, 4332.913341733148, 4383.49589797171, 4474.485434175046, 4476.194285028726, 5149.2276158576515, 5168.431472538018, 5169.327987361694, 5190.299309593157, 5207.869803254949, 4440.289553671397, 4443.888902777392, 4443.933340999887, 4450.310201918708, 4457.286834106592, 2644.3124787555375, 2720.40151166743, 2730.9317267068086, 2736.453903544491, 2736.53478908586, 4851.611871050308, 4856.902861942742, 4867.34290870735, 4874.122657921537, 4887.169181239126, 5094.821681241138, 5289.788408463618, 5293.258943747878, 5296.788128474895, 5320.802819365612, 4807.18277892759, 4899.338589290472, 4901.730404827626, 4901.975490122527, 4934.753262336869, 5177.508136727005, 5204.505571970657, 5204.8178313758835, 5216.400113986789, 5218.095395180656, 4848.854534363974, 5029.371328583927, 5047.167217409086, 5076.314697515788, 5086.745662716776, 4833.613310935047, 4841.402337228777, 4863.392075990501, 4876.171050921423, 4878.878028049327, 3603.7837729736298, 3606.5852426971232, 3616.8914932552066, 3619.800910949923, 3629.1834337273904, 4897.706137631753, 5149.794008239628, 5159.793608255628, 5164.638475306842, 5179.710883588873, 4945.2582112683385, 4945.901081978268, 4956.306117143675, 4958.6281028923695, 4985.604030871362, 4954.8761280968265, 4969.304297398295, 4980.207125434913, 5023.799048038184, 5052.595792336678, 4754.31062495943, 4933.703977761345, 4968.552830245295, 4973.204287314013, 4986.700797952134, 4833.10587541306, 4965.106280869478, 4991.900161996812, 5034.395872495324, 5064.18972964324, 4790.353302304145, 4828.227483602606, 4837.153498137882, 4841.927371089507, 4843.927341089816], "value": 3762.9483063992, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.1202604002855, 683.402023229674, 727.8325985023448, 741.9888701669472, 749.8087987563172, 10998.670039898805, 11237.438128093583, 11246.49390777415, 11670.766584668301, 11681.357525336103, 13082.149660272076, 13294.135881167716, 13318.20090794553, 13366.66583335417, 13727.65680857979, 752.834376437183, 772.8145245141181, 773.6789232468519, 778.2451022508186, 781.3007358414216, 629.593911926807, 771.7067514344541, 776.351746291847, 780.4926797581561, 780.7072347869549, 672.2537982839045, 787.9015123109612, 812.995935020324, 813.4265342933247, 818.0183779464636, 809.4536188073057, 809.9392545559107, 810.3679130278392, 810.3841080778592, 810.4205493072482, 433.41272575659843, 593.4807043836643, 593.5489028338451, 594.04655527878, 594.3551246897122, 9857.802843943082, 12624.24254544721, 13182.538611148564, 13284.867151328459, 13308.201507909556, 13271.469141234338, 13859.0, 14172.0, 14245.287735613178, 14386.280685965765, 10257.640982565574, 10385.84421233682, 10551.577936882515, 10556.630517931912, 10651.414172220524, 3317.5853018372704, 3324.517944897976, 3332.150301673058, 3355.2115252915546, 3392.4402473591826, 67470.0, 68165.3183468159, 68173.65913170403, 69095.0, 70509.29490705079, 10103.09072183507, 10740.0, 10750.247482676137, 10806.243562950518, 11000.614978475714, 19376.44653506425, 19487.123079461457, 19549.0, 20129.194832206547, 21609.56780864374, 7048.859022819515, 7102.538335008208, 7315.634218289064, 7321.832100584362, 7414.0, 3747.9437808432895, 3771.8114094295174, 3846.9038274043373, 3860.517435320585, 3881.7088718346236, 3046.329807442359, 3169.4453470642547, 3340.799552026886, 3493.615702272748, 3531.170175008871, 553.6180035775383, 555.3585608622049, 558.4331903118339, 563.7942151114813, 570.6918264137403, 550.5127961753797, 569.7863301262026, 583.7898356591623, 595.1905408644241, 598.3059650805045, 7970.97103100818, 8717.564121793885, 8766.60550275239, 8782.209601135928, 8827.852379190792, 547.3267880506999, 576.3919065386058, 583.7752465300805, 600.4715850051927, 601.4947444146937, 3867.7099217558793, 3951.3480275754177, 3995.32079546472, 4157.771322577227, 4223.725457845292, 88345.11654883498, 100516.4974175139, 100637.0, 106293.0, 106469.46765266279, 51417.742911285204, 51817.7409112952, 52260.47739522632, 52423.47576524262, 52812.735936320074, 63725.485294926744, 73594.0, 74562.0, 75108.62445687846, 79167.0, 7786.532808031537, 7855.764327070197, 8008.639611217625, 8022.438429310126, 8138.633761480629, 40122.59877401189, 43097.78451107725, 46175.84560386017, 46423.53576464192, 47732.52267477281, 56439.71780141073, 58876.41123588709, 59336.703316483145, 73683.63158184175, 73865.6306718463, 11565.768684626428, 11887.28676279426, 12313.56902508408, 12328.630141095782, 12715.237085774883, 12620.495180192689, 13036.608901732963, 13325.267110309027, 14222.715545689236, 14661.340239689027, 12368.876311236772, 12386.938065309616, 12637.2417654941, 12757.872421275668, 13128.277944713132, 9540.809183816424, 10800.891991079989, 12587.99296056295, 12616.49534018629, 13706.794398083837, 11484.655460336204, 11692.35692036946, 11728.296302221894, 11843.822342664695, 12183.269003859798, 9444.763880902758, 9628.518574071408, 10093.0, 10127.949360253151, 10619.36283822973, 9653.276004299565, 10201.387916724723, 10244.692659220234, 10421.06210441064, 10666.38788494254], "value": 6595.328627056092, "unit": "score"}], "name": "dromaeo_css", "value": 6309.338387408015, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 114.0, 113.0, 114.0, 114.0, 115.0, 114.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 129.0, 128.0, 165.0, 124.0, 126.0, 124.0, 124.0, 157.0, 126.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 163.0, 161.0, 162.0, 160.0, 161.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 79.0, 107.0, 76.0, 76.0, 77.0, 76.0, 97.0, 77.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 113.0, 85.0, 83.0, 84.0, 116.0, 85.0, 84.0, 114.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0, 116.0, 118.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 63.0, 65.0, 65.0, 64.0, 64.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 76.0, 65.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 82.0, 83.0, 83.0, 84.0, 82.0, 82.0, 82.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 140.0, 145.0, 140.0, 144.0, 137.0, 141.0, 137.0, 175.0, 142.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 176.0, 172.0, 174.0, 177.0, 182.0, 178.0, 176.0, 170.0, 171.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 69.0, 69.0, 68.0, 69.0, 68.0, 69.0, 73.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1547.0, "alertThreshold": 2.0}]} 09:35:54 INFO - Return code: 0 09:35:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:35:54 INFO - # TBPL SUCCESS # 09:35:54 INFO - Running post-action listener: _resource_record_post_action 09:35:54 INFO - [mozharness: 2016-09-23 16:35:54.109027Z] Finished run-tests step (success) 09:35:54 INFO - Running post-run listener: _resource_record_post_run 09:35:54 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 12288; Write bytes: 390197248; Read time: 20; Write time: 251748 09:35:54 INFO - TinderboxPrint: CPU usage
13.0% 09:35:54 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 20 09:35:54 INFO - TinderboxPrint: I/O write bytes / time
390,197,248 / 251,748 09:35:54 INFO - TinderboxPrint: CPU idle
8,347.4 (87.0%) 09:35:54 INFO - TinderboxPrint: CPU user
1,202.8 (12.5%) 09:35:54 INFO - TinderboxPrint: Swap in / out
0 / 0 09:35:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99848192; Read time: 0; Write time: 78264 09:35:54 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 290349056; Read time: 12; Write time: 173484 09:35:54 INFO - Running post-run listener: _upload_blobber_files 09:35:54 INFO - Blob upload gear active. 09:35:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:35:54 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 09:35:54 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:35:54 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:35:55 INFO - (blobuploader) - INFO - Open directory for files ... 09:35:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:35:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:35:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:56 INFO - (blobuploader) - INFO - Done attempting. 09:35:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:35:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:35:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:35:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:35:57 INFO - (blobuploader) - INFO - Done attempting. 09:35:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:35:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:35:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:36:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:04 INFO - (blobuploader) - INFO - Done attempting. 09:36:04 INFO - (blobuploader) - INFO - Iteration through files over. 09:36:04 INFO - Return code: 0 09:36:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:36:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:36:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b2dd6a0be4546b9bde3f22080a475edd32b9963c582d46addff36b643bb718ed62683ea79884408dee6adee70d31c182cdbbdbbbc9c92f9bc7b9b3a2c0221ba8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0f42adabd905a180fe1864614a1736f50c5b1865f59fe5d780795e6710ff9592df7bf3de6113345045a948f26032e77b223ecc776ddb845c8a883a4d3fca13db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3dbfc9f6cddcc4bacfd0c68bd7eff3bd6d41039268f9f07415d24c008812760429cf2e296ece83ef433f2ef5d37f6b7fae4b0f5f04ded61c5cdb3672f5bcc581"} 09:36:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:36:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:36:04 INFO - Contents: 09:36:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b2dd6a0be4546b9bde3f22080a475edd32b9963c582d46addff36b643bb718ed62683ea79884408dee6adee70d31c182cdbbdbbbc9c92f9bc7b9b3a2c0221ba8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0f42adabd905a180fe1864614a1736f50c5b1865f59fe5d780795e6710ff9592df7bf3de6113345045a948f26032e77b223ecc776ddb845c8a883a4d3fca13db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3dbfc9f6cddcc4bacfd0c68bd7eff3bd6d41039268f9f07415d24c008812760429cf2e296ece83ef433f2ef5d37f6b7fae4b0f5f04ded61c5cdb3672f5bcc581"} 09:36:04 INFO - Running post-run listener: copy_logs_to_upload_dir 09:36:04 INFO - Copying logs to upload dir... 09:36:04 INFO - mkdir: /builds/slave/test/build/upload/logs 09:36:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.769656 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-09-23 09:36:03.024397) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 09:36:03.027672) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b2dd6a0be4546b9bde3f22080a475edd32b9963c582d46addff36b643bb718ed62683ea79884408dee6adee70d31c182cdbbdbbbc9c92f9bc7b9b3a2c0221ba8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0f42adabd905a180fe1864614a1736f50c5b1865f59fe5d780795e6710ff9592df7bf3de6113345045a948f26032e77b223ecc776ddb845c8a883a4d3fca13db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3dbfc9f6cddcc4bacfd0c68bd7eff3bd6d41039268f9f07415d24c008812760429cf2e296ece83ef433f2ef5d37f6b7fae4b0f5f04ded61c5cdb3672f5bcc581"} build_url:https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/ZAqQF0H-RVKtlPZ7YGqQcw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b2dd6a0be4546b9bde3f22080a475edd32b9963c582d46addff36b643bb718ed62683ea79884408dee6adee70d31c182cdbbdbbbc9c92f9bc7b9b3a2c0221ba8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/0f42adabd905a180fe1864614a1736f50c5b1865f59fe5d780795e6710ff9592df7bf3de6113345045a948f26032e77b223ecc776ddb845c8a883a4d3fca13db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3dbfc9f6cddcc4bacfd0c68bd7eff3bd6d41039268f9f07415d24c008812760429cf2e296ece83ef433f2ef5d37f6b7fae4b0f5f04ded61c5cdb3672f5bcc581"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 09:36:03.052626) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:36:03.052958) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1474645710.259951-1273770697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 09:36:03.137502) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 09:36:03.137837) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 09:36:03.138132) ========= ========= Total master_lag: 0.17 =========