builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1474284978.74 results: success (0) buildid: 20160919032318 builduid: 7b9eef64605340e782be6ca3fe384208 revision: fc69febcbf6c0dcc4b3dfc7a346d8d348798a65f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-19 04:36:18.745245) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-19 04:36:18.745779) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-19 04:36:18.746156) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-19 04:36:18.761895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 04:36:18.762220) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-19 04:36:18-- 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% 101M=0s 2016-09-19 04:36:19 (101 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087921 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 04:36:18.864562) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 04:36:18.864932) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019774 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 04:36:18.915053) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-19 04:36:18.915446) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fc69febcbf6c0dcc4b3dfc7a346d8d348798a65f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev fc69febcbf6c0dcc4b3dfc7a346d8d348798a65f --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=56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-19 04:36:19,172 truncating revision to first 12 chars 2016-09-19 04:36:19,172 Setting DEBUG logging. 2016-09-19 04:36:19,172 attempt 1/10 2016-09-19 04:36:19,172 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fc69febcbf6c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-19 04:36:19,912 unpacking tar archive at: fx-team-fc69febcbf6c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.075091 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-19 04:36:20.004738) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-19 04:36:20.005101) ========= script_repo_revision: fc69febcbf6c0dcc4b3dfc7a346d8d348798a65f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-19 04:36:20.005531) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-19 04:36:20.005852) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-19 04:36:20.015264) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-19 04:36:20.015656) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:36:20 INFO - MultiFileLogger online at 20160919 04:36:20 in /builds/slave/test 04:36:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:36:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:36:20 INFO - {'append_to_log': False, 04:36:20 INFO - 'base_work_dir': '/builds/slave/test', 04:36:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:36:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:36:20 INFO - 'branch': 'Fx-Team-Non-PGO', 04:36:20 INFO - 'buildbot_json_path': 'buildprops.json', 04:36:20 INFO - 'config_files': ('talos/linux_config.py',), 04:36:20 INFO - 'default_actions': ('clobber', 04:36:20 INFO - 'read-buildbot-config', 04:36:20 INFO - 'download-and-extract', 04:36:20 INFO - 'populate-webroot', 04:36:20 INFO - 'create-virtualenv', 04:36:20 INFO - 'install', 04:36:20 INFO - 'run-tests'), 04:36:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:36:20 INFO - 'download_minidump_stackwalk': True, 04:36:20 INFO - 'download_symbols': 'ondemand', 04:36:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:36:20 INFO - 'tooltool.py': '/tools/tooltool.py', 04:36:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:36:20 INFO - '/tools/misc-python/virtualenv.py')}, 04:36:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:36:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:36:20 INFO - 'installer_path': 'installer.exe', 04:36:20 INFO - 'log_level': 'info', 04:36:20 INFO - 'log_name': 'talos', 04:36:20 INFO - 'log_to_console': True, 04:36:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:36:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:36:20 INFO - 'opt_config_files': (), 04:36:20 INFO - 'pip_index': False, 04:36:20 INFO - 'sps_profile': False, 04:36:20 INFO - 'sps_profile_interval': 0, 04:36:20 INFO - 'suite': 'dromaeojs', 04:36:20 INFO - 'system_bits': '32', 04:36:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:36:20 INFO - 'title': 'talos-linux64-ix-037', 04:36:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:36:20 INFO - 'use_talos_json': True, 04:36:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:36:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:36:20 INFO - 'work_dir': 'build'} 04:36:20 INFO - [mozharness: 2016-09-19 11:36:20.366601Z] Running clobber step. 04:36:20 INFO - Running pre-action listener: _resource_record_pre_action 04:36:20 INFO - Running main action method: clobber 04:36:20 INFO - rmtree: /builds/slave/test/build 04:36:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:36:20 INFO - Running post-action listener: _resource_record_post_action 04:36:20 INFO - [mozharness: 2016-09-19 11:36:20.816704Z] Finished clobber step (success) 04:36:20 INFO - [mozharness: 2016-09-19 11:36:20.816805Z] Running read-buildbot-config step. 04:36:20 INFO - Running pre-action listener: _resource_record_pre_action 04:36:20 INFO - Running main action method: read_buildbot_config 04:36:20 INFO - Using buildbot properties: 04:36:20 INFO - { 04:36:20 INFO - "project": "", 04:36:20 INFO - "product": "firefox", 04:36:20 INFO - "script_repo_revision": "production", 04:36:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:36:20 INFO - "repository": "", 04:36:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:36:20 INFO - "buildid": "20160919032318", 04:36:20 INFO - "pgo_build": "False", 04:36:20 INFO - "basedir": "/builds/slave/test", 04:36:20 INFO - "buildnumber": 1940, 04:36:20 INFO - "slavename": "talos-linux64-ix-037", 04:36:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:36:20 INFO - "platform": "ubuntu64_hw", 04:36:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:36:20 INFO - "branch": "fx-team", 04:36:20 INFO - "repo_path": "integration/fx-team", 04:36:20 INFO - "revision": "fc69febcbf6c0dcc4b3dfc7a346d8d348798a65f", 04:36:20 INFO - "stage_platform": "linux64", 04:36:20 INFO - "builduid": "7b9eef64605340e782be6ca3fe384208", 04:36:20 INFO - "slavebuilddir": "test" 04:36:20 INFO - } 04:36:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 04:36:20 INFO - Running post-action listener: _resource_record_post_action 04:36:20 INFO - [mozharness: 2016-09-19 11:36:20.819268Z] Finished read-buildbot-config step (success) 04:36:20 INFO - [mozharness: 2016-09-19 11:36:20.819357Z] Running download-and-extract step. 04:36:20 INFO - Running pre-action listener: _resource_record_pre_action 04:36:20 INFO - Running main action method: download_and_extract 04:36:20 INFO - mkdir: /builds/slave/test/build/tests 04:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:20 INFO - trying https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:36:20 INFO - Downloading https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:36:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:36:21 INFO - Downloaded 1361 bytes. 04:36:21 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:36:21 INFO - Using the following test package requirements: 04:36:21 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:36:21 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:36:21 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:36:21 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:21 INFO - u'jsshell-linux-x86_64.zip'], 04:36:21 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:36:21 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:36:21 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:36:21 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:36:21 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:36:21 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:36:21 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:36:21 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:36:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:36:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:36:21 INFO - Fetch https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:36:21 INFO - Expected file size: 20365610 04:36:26 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:36:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:36:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:36:26 INFO - Fetch https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:36:26 INFO - Expected file size: 20365610 04:36:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 04:36:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:36:31 INFO - Fetch https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:36:32 INFO - Expected file size: 14414059 04:36:32 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')]} 04:36:32 INFO - trying https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:36:32 INFO - Downloading https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:36:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:36:34 INFO - Downloaded 55596994 bytes. 04:36:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:36:34 INFO - mkdir: /builds/slave/test/properties 04:36:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:36:34 INFO - Writing to file /builds/slave/test/properties/build_url 04:36:34 INFO - Contents: 04:36:34 INFO - build_url:https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:36:34 INFO - Running post-action listener: _resource_record_post_action 04:36:34 INFO - Running post-action listener: set_extra_try_arguments 04:36:34 INFO - [mozharness: 2016-09-19 11:36:34.760212Z] Finished download-and-extract step (success) 04:36:34 INFO - [mozharness: 2016-09-19 11:36:34.760441Z] Running populate-webroot step. 04:36:34 INFO - Running pre-action listener: _resource_record_pre_action 04:36:34 INFO - Running main action method: populate_webroot 04:36:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:36:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:36:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:36:34 INFO - '--tppagecycles', 04:36:34 INFO - '7'], 04:36:34 INFO - 'tests': ['tsvgm']}}, 04:36:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:36:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:36:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:36:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:36:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:36:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:36:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:34 INFO - 'talos_options': ['--disable-e10s'], 04:36:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:34 INFO - 'talos_options': ['--disable-e10s'], 04:36:34 INFO - 'tests': ['damp', 'tps']}, 04:36:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:34 INFO - 'tests': ['damp', 'tps']}, 04:36:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:36:34 INFO - 'tests': ['dromaeo_dom']}, 04:36:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:36:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:36:34 INFO - 'tests': ['basic_compositor_video']}, 04:36:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:36:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:36:34 INFO - 'tests': ['a11yr', 04:36:34 INFO - 'ts_paint', 04:36:34 INFO - 'tpaint', 04:36:34 INFO - 'sessionrestore', 04:36:34 INFO - 'sessionrestore_no_auto_restore', 04:36:34 INFO - 'tabpaint']}, 04:36:34 INFO - 'other-e10s': {'tests': ['a11yr', 04:36:34 INFO - 'ts_paint', 04:36:34 INFO - 'tpaint', 04:36:34 INFO - 'sessionrestore', 04:36:34 INFO - 'sessionrestore_no_auto_restore', 04:36:34 INFO - 'tabpaint']}, 04:36:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:36:34 INFO - 'ts_paint', 04:36:34 INFO - 'tpaint', 04:36:34 INFO - 'sessionrestore', 04:36:34 INFO - 'sessionrestore_no_auto_restore', 04:36:34 INFO - 'tabpaint']}, 04:36:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:36:34 INFO - 'ts_paint', 04:36:34 INFO - 'tpaint', 04:36:34 INFO - 'sessionrestore', 04:36:34 INFO - 'sessionrestore_no_auto_restore', 04:36:34 INFO - 'tabpaint']}, 04:36:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:36:34 INFO - 'tests': ['a11yr', 04:36:34 INFO - 'ts_paint', 04:36:34 INFO - 'tpaint', 04:36:34 INFO - 'sessionrestore', 04:36:34 INFO - 'sessionrestore_no_auto_restore', 04:36:34 INFO - 'tabpaint']}, 04:36:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:36:34 INFO - 'tests': ['a11yr', 04:36:34 INFO - 'ts_paint', 04:36:34 INFO - 'tpaint', 04:36:34 INFO - 'sessionrestore', 04:36:34 INFO - 'sessionrestore_no_auto_restore', 04:36:34 INFO - 'tabpaint']}, 04:36:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:36:34 INFO - 'tests': ['tsvgx', 04:36:34 INFO - 'tsvgr_opacity', 04:36:34 INFO - 'tart', 04:36:34 INFO - 'tscrollx', 04:36:34 INFO - 'cart']}, 04:36:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:36:34 INFO - 'tsvgr_opacity', 04:36:34 INFO - 'tart', 04:36:34 INFO - 'tscrollx', 04:36:34 INFO - 'cart']}, 04:36:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:34 INFO - 'talos_options': ['--disable-e10s'], 04:36:34 INFO - 'tests': ['tp5o']}, 04:36:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:34 INFO - 'tests': ['tp5o']}, 04:36:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:34 INFO - 'talos_options': ['--disable-e10s', 04:36:34 INFO - '--xperf_path', 04:36:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:34 INFO - 'tests': ['tp5n']}, 04:36:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:34 INFO - 'talos_options': ['--xperf_path', 04:36:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:34 INFO - 'tests': ['tp5n']}}, 04:36:34 INFO - 'talos.zip': {'path': '', 04:36:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:36:34 INFO - Running post-action listener: _resource_record_post_action 04:36:34 INFO - [mozharness: 2016-09-19 11:36:34.777028Z] Finished populate-webroot step (success) 04:36:34 INFO - [mozharness: 2016-09-19 11:36:34.777118Z] Running create-virtualenv step. 04:36:34 INFO - Running pre-action listener: _resource_record_pre_action 04:36:34 INFO - Running main action method: create_virtualenv 04:36:34 INFO - Creating virtualenv /builds/slave/test/build/venv 04:36:34 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 04:36:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:36:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:36:34 INFO - Using real prefix '/usr' 04:36:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:36:35 INFO - Installing distribute.............................................................................................................................................................................................done. 04:36:37 INFO - Installing pip.................done. 04:36:37 INFO - Return code: 0 04:36:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:37 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 0x7f47df4e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9f60>, '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 0x14fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fb1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', '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 04:36:37 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 04:36:37 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 04:36:37 INFO - Using env: {'DISPLAY': ':0', 04:36:37 INFO - 'HOME': '/home/cltbld', 04:36:37 INFO - 'LANG': 'en_US.UTF-8', 04:36:37 INFO - 'LANGUAGE': 'en_US:en', 04:36:37 INFO - 'LOGNAME': 'cltbld', 04:36:37 INFO - 'MAIL': '/var/mail/cltbld', 04:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:37 INFO - 'MOZ_NO_REMOTE': '1', 04:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:37 INFO - 'NO_EM_RESTART': '1', 04:36:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:37 INFO - 'PWD': '/builds/slave/test', 04:36:37 INFO - 'SHELL': '/bin/bash', 04:36:37 INFO - 'SHLVL': '1', 04:36:37 INFO - 'TERM': 'linux', 04:36:37 INFO - 'TMOUT': '86400', 04:36:37 INFO - 'USER': 'cltbld', 04:36:37 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', 04:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:37 INFO - '_': '/tools/buildbot/bin/python'} 04:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:37 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 04:36:37 INFO - Cleaning up... 04:36:37 INFO - Return code: 0 04:36:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:37 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 0x7f47df4e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9f60>, '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 0x14fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fb1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', '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 04:36:37 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 04:36:37 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 04:36:37 INFO - Using env: {'DISPLAY': ':0', 04:36:37 INFO - 'HOME': '/home/cltbld', 04:36:37 INFO - 'LANG': 'en_US.UTF-8', 04:36:37 INFO - 'LANGUAGE': 'en_US:en', 04:36:37 INFO - 'LOGNAME': 'cltbld', 04:36:37 INFO - 'MAIL': '/var/mail/cltbld', 04:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:37 INFO - 'MOZ_NO_REMOTE': '1', 04:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:37 INFO - 'NO_EM_RESTART': '1', 04:36:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:37 INFO - 'PWD': '/builds/slave/test', 04:36:37 INFO - 'SHELL': '/bin/bash', 04:36:37 INFO - 'SHLVL': '1', 04:36:37 INFO - 'TERM': 'linux', 04:36:37 INFO - 'TMOUT': '86400', 04:36:37 INFO - 'USER': 'cltbld', 04:36:37 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', 04:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:37 INFO - '_': '/tools/buildbot/bin/python'} 04:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:37 INFO - Downloading/unpacking psutil>=3.1.1 04:36:37 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 04:36:37 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 04:36:37 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 04:36:37 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 04:36:37 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 04:36:37 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 04:36:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:36:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:39 INFO - Installing collected packages: psutil 04:36:39 INFO - Running setup.py install for psutil 04:36:39 INFO - building 'psutil._psutil_linux' extension 04:36:39 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 04:36:39 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 04:36:40 INFO - building 'psutil._psutil_posix' extension 04:36:40 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 04:36:40 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 04:36:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:40 INFO - Successfully installed psutil 04:36:40 INFO - Cleaning up... 04:36:40 INFO - Return code: 0 04:36:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:40 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 0x7f47df4e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9f60>, '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 0x14fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fb1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', '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 04:36:40 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 04:36:40 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 04:36:40 INFO - Using env: {'DISPLAY': ':0', 04:36:40 INFO - 'HOME': '/home/cltbld', 04:36:40 INFO - 'LANG': 'en_US.UTF-8', 04:36:40 INFO - 'LANGUAGE': 'en_US:en', 04:36:40 INFO - 'LOGNAME': 'cltbld', 04:36:40 INFO - 'MAIL': '/var/mail/cltbld', 04:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:40 INFO - 'MOZ_NO_REMOTE': '1', 04:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:40 INFO - 'NO_EM_RESTART': '1', 04:36:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:40 INFO - 'PWD': '/builds/slave/test', 04:36:40 INFO - 'SHELL': '/bin/bash', 04:36:40 INFO - 'SHLVL': '1', 04:36:40 INFO - 'TERM': 'linux', 04:36:40 INFO - 'TMOUT': '86400', 04:36:40 INFO - 'USER': 'cltbld', 04:36:40 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', 04:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:40 INFO - '_': '/tools/buildbot/bin/python'} 04:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:36:40 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 04:36:40 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 04:36:40 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 04:36:40 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 04:36:40 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 04:36:40 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 04:36:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:36:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:36:42 INFO - Installing collected packages: mozsystemmonitor 04:36:42 INFO - Running setup.py install for mozsystemmonitor 04:36:42 INFO - Successfully installed mozsystemmonitor 04:36:42 INFO - Cleaning up... 04:36:42 INFO - Return code: 0 04:36:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:36:42 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')]} 04:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:42 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')]} 04:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:42 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 0x7f47df4e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9f60>, '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 0x14fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fb1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', '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 04:36:42 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 04:36:42 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 04:36:42 INFO - Using env: {'DISPLAY': ':0', 04:36:42 INFO - 'HOME': '/home/cltbld', 04:36:42 INFO - 'LANG': 'en_US.UTF-8', 04:36:42 INFO - 'LANGUAGE': 'en_US:en', 04:36:42 INFO - 'LOGNAME': 'cltbld', 04:36:42 INFO - 'MAIL': '/var/mail/cltbld', 04:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:42 INFO - 'MOZ_NO_REMOTE': '1', 04:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:42 INFO - 'NO_EM_RESTART': '1', 04:36:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:42 INFO - 'PWD': '/builds/slave/test', 04:36:42 INFO - 'SHELL': '/bin/bash', 04:36:42 INFO - 'SHLVL': '1', 04:36:42 INFO - 'TERM': 'linux', 04:36:42 INFO - 'TMOUT': '86400', 04:36:42 INFO - 'USER': 'cltbld', 04:36:42 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', 04:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:42 INFO - '_': '/tools/buildbot/bin/python'} 04:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:42 INFO - Downloading/unpacking jsonschema==2.5.1 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:36:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:36:44 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 04:36:44 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 04:36:44 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 04:36:44 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 04:36:44 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 04:36:44 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 04:36:44 INFO - Downloading functools32-3.2.3-2.tar.gz 04:36:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:36:44 INFO - warning: no files found matching '*.txt' 04:36:44 INFO - no previously-included directories found matching 'build' 04:36:44 INFO - no previously-included directories found matching 'dist' 04:36:44 INFO - no previously-included directories found matching '.git*' 04:36:44 INFO - Installing collected packages: jsonschema, functools32 04:36:45 INFO - Running setup.py install for functools32 04:36:45 INFO - warning: no files found matching '*.txt' 04:36:45 INFO - no previously-included directories found matching 'build' 04:36:45 INFO - no previously-included directories found matching 'dist' 04:36:45 INFO - no previously-included directories found matching '.git*' 04:36:45 INFO - Successfully installed jsonschema functools32 04:36:45 INFO - Cleaning up... 04:36:45 INFO - Return code: 0 04:36:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f47df4e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9f60>, '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 0x14fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fb1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', '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 04:36:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:36:45 INFO - Using env: {'DISPLAY': ':0', 04:36:45 INFO - 'HOME': '/home/cltbld', 04:36:45 INFO - 'LANG': 'en_US.UTF-8', 04:36:45 INFO - 'LANGUAGE': 'en_US:en', 04:36:45 INFO - 'LOGNAME': 'cltbld', 04:36:45 INFO - 'MAIL': '/var/mail/cltbld', 04:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:45 INFO - 'MOZ_NO_REMOTE': '1', 04:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:45 INFO - 'NO_EM_RESTART': '1', 04:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:45 INFO - 'PWD': '/builds/slave/test', 04:36:45 INFO - 'SHELL': '/bin/bash', 04:36:45 INFO - 'SHLVL': '1', 04:36:45 INFO - 'TERM': 'linux', 04:36:45 INFO - 'TMOUT': '86400', 04:36:45 INFO - 'USER': 'cltbld', 04:36:45 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', 04:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:45 INFO - '_': '/tools/buildbot/bin/python'} 04:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:36:45 INFO - Cleaning up... 04:36:45 INFO - Return code: 0 04:36:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f47df4e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9f60>, '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 0x14fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fb1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', '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 04:36:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:36:45 INFO - Using env: {'DISPLAY': ':0', 04:36:45 INFO - 'HOME': '/home/cltbld', 04:36:45 INFO - 'LANG': 'en_US.UTF-8', 04:36:45 INFO - 'LANGUAGE': 'en_US:en', 04:36:45 INFO - 'LOGNAME': 'cltbld', 04:36:45 INFO - 'MAIL': '/var/mail/cltbld', 04:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:45 INFO - 'MOZ_NO_REMOTE': '1', 04:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:45 INFO - 'NO_EM_RESTART': '1', 04:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:45 INFO - 'PWD': '/builds/slave/test', 04:36:45 INFO - 'SHELL': '/bin/bash', 04:36:45 INFO - 'SHLVL': '1', 04:36:45 INFO - 'TERM': 'linux', 04:36:45 INFO - 'TMOUT': '86400', 04:36:45 INFO - 'USER': 'cltbld', 04:36:45 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', 04:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:45 INFO - '_': '/tools/buildbot/bin/python'} 04:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:45 INFO - Downloading/unpacking blobuploader==1.2.4 04:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:47 INFO - Downloading blobuploader-1.2.4.tar.gz 04:36:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:36:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:36:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36:48 INFO - Downloading docopt-0.6.1.tar.gz 04:36:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:36:48 INFO - Installing collected packages: blobuploader, requests, docopt 04:36:48 INFO - Running setup.py install for blobuploader 04:36:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:36:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:36:48 INFO - Running setup.py install for requests 04:36:48 INFO - Running setup.py install for docopt 04:36:48 INFO - Successfully installed blobuploader requests docopt 04:36:48 INFO - Cleaning up... 04:36:48 INFO - Return code: 0 04:36:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:48 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')]} 04:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:48 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')]} 04:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:48 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 0x7f47df4e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9f60>, '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 0x14fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fb1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', '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 04:36:48 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 04:36:48 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 04:36:48 INFO - Using env: {'DISPLAY': ':0', 04:36:48 INFO - 'HOME': '/home/cltbld', 04:36:48 INFO - 'LANG': 'en_US.UTF-8', 04:36:48 INFO - 'LANGUAGE': 'en_US:en', 04:36:48 INFO - 'LOGNAME': 'cltbld', 04:36:48 INFO - 'MAIL': '/var/mail/cltbld', 04:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:48 INFO - 'MOZ_NO_REMOTE': '1', 04:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:48 INFO - 'NO_EM_RESTART': '1', 04:36:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:48 INFO - 'PWD': '/builds/slave/test', 04:36:48 INFO - 'SHELL': '/bin/bash', 04:36:48 INFO - 'SHLVL': '1', 04:36:48 INFO - 'TERM': 'linux', 04:36:48 INFO - 'TMOUT': '86400', 04:36:48 INFO - 'USER': 'cltbld', 04:36:48 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', 04:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:48 INFO - '_': '/tools/buildbot/bin/python'} 04:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:49 INFO - Running setup.py (path:/tmp/pip-HcO6ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:49 INFO - Running setup.py (path:/tmp/pip-KqGBUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:49 INFO - Running setup.py (path:/tmp/pip-2N7wuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:49 INFO - Running setup.py (path:/tmp/pip-4SwpDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:49 INFO - Running setup.py (path:/tmp/pip-6fISYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:49 INFO - Running setup.py (path:/tmp/pip-92JijA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:49 INFO - Running setup.py (path:/tmp/pip-XqyN5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:49 INFO - Running setup.py (path:/tmp/pip-6aXgt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:49 INFO - Running setup.py (path:/tmp/pip-eurlTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:49 INFO - Running setup.py (path:/tmp/pip-hBvXtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:49 INFO - Running setup.py (path:/tmp/pip-rJqVqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:49 INFO - Running setup.py (path:/tmp/pip-UgqLeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:49 INFO - Running setup.py (path:/tmp/pip-HLgdhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:50 INFO - Running setup.py (path:/tmp/pip-erXc8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:50 INFO - Running setup.py (path:/tmp/pip-nDPpDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:50 INFO - Running setup.py (path:/tmp/pip-8n9Jcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:50 INFO - Running setup.py (path:/tmp/pip-dmIDor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:36:50 INFO - Running setup.py install for manifestparser 04:36:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:36:50 INFO - Running setup.py install for mozcrash 04:36:50 INFO - Running setup.py install for mozdebug 04:36:50 INFO - Running setup.py install for mozdevice 04:36:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:36:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:36:50 INFO - Running setup.py install for mozfile 04:36:50 INFO - Running setup.py install for mozhttpd 04:36:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:36:50 INFO - Running setup.py install for mozinfo 04:36:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:36:51 INFO - Running setup.py install for mozInstall 04:36:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:36:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:36:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:36:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:36:51 INFO - Running setup.py install for mozleak 04:36:51 INFO - Running setup.py install for mozlog 04:36:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:36:51 INFO - Running setup.py install for moznetwork 04:36:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:36:51 INFO - Running setup.py install for mozprocess 04:36:51 INFO - Running setup.py install for mozprofile 04:36:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:36:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:36:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:36:51 INFO - Running setup.py install for mozrunner 04:36:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:36:51 INFO - Running setup.py install for mozscreenshot 04:36:51 INFO - Running setup.py install for moztest 04:36:52 INFO - Running setup.py install for mozversion 04:36:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:36:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:36:52 INFO - Cleaning up... 04:36:52 INFO - Return code: 0 04:36:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:52 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')]} 04:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:52 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')]} 04:36:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:52 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 0x7f47df4e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9f60>, '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 0x14fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fb1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', '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 04:36:52 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 04:36:52 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 04:36:52 INFO - Using env: {'DISPLAY': ':0', 04:36:52 INFO - 'HOME': '/home/cltbld', 04:36:52 INFO - 'LANG': 'en_US.UTF-8', 04:36:52 INFO - 'LANGUAGE': 'en_US:en', 04:36:52 INFO - 'LOGNAME': 'cltbld', 04:36:52 INFO - 'MAIL': '/var/mail/cltbld', 04:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:52 INFO - 'MOZ_NO_REMOTE': '1', 04:36:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:52 INFO - 'NO_EM_RESTART': '1', 04:36:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:52 INFO - 'PWD': '/builds/slave/test', 04:36:52 INFO - 'SHELL': '/bin/bash', 04:36:52 INFO - 'SHLVL': '1', 04:36:52 INFO - 'TERM': 'linux', 04:36:52 INFO - 'TMOUT': '86400', 04:36:52 INFO - 'USER': 'cltbld', 04:36:52 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', 04:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:52 INFO - '_': '/tools/buildbot/bin/python'} 04:36:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:52 INFO - Running setup.py (path:/tmp/pip-xVu3aI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:52 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)) 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:52 INFO - Running setup.py (path:/tmp/pip-cerfeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:52 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)) 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:52 INFO - Running setup.py (path:/tmp/pip-i0B6UQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:52 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)) 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:52 INFO - Running setup.py (path:/tmp/pip-_QK8my-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:52 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)) 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:52 INFO - Running setup.py (path:/tmp/pip-42fZnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:52 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)) 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:52 INFO - Running setup.py (path:/tmp/pip-xZ8GV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:52 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)) 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:52 INFO - Running setup.py (path:/tmp/pip-JR9rMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:52 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)) 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:52 INFO - Running setup.py (path:/tmp/pip-z8WK8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:52 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)) 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:52 INFO - Running setup.py (path:/tmp/pip-x6BzE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:52 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)) 04:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:52 INFO - Running setup.py (path:/tmp/pip-Ggc0bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:53 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)) 04:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:53 INFO - Running setup.py (path:/tmp/pip-hd8vf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:53 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)) 04:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:53 INFO - Running setup.py (path:/tmp/pip-yVG2LF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:53 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)) 04:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:53 INFO - Running setup.py (path:/tmp/pip-rsjcyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:53 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)) 04:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:53 INFO - Running setup.py (path:/tmp/pip-mctwuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:53 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)) 04:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:53 INFO - Running setup.py (path:/tmp/pip-ly40lk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:53 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)) 04:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:53 INFO - Running setup.py (path:/tmp/pip-hkfgR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:53 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)) 04:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:53 INFO - Running setup.py (path:/tmp/pip-i03B4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:53 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)) 04:36:53 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)) 04:36:53 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)) 04:36:53 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)) 04:36:53 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)) 04:36:53 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)) 04:36:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:55 INFO - Downloading blessings-1.6.tar.gz 04:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:36:55 INFO - Installing collected packages: blessings 04:36:55 INFO - Running setup.py install for blessings 04:36:55 INFO - Successfully installed blessings 04:36:55 INFO - Cleaning up... 04:36:55 INFO - Return code: 0 04:36:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:36:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:55 INFO - Reading from file tmpfile_stdout 04:36:55 INFO - Current package versions: 04:36:55 INFO - argparse == 1.2.1 04:36:55 INFO - blessings == 1.6 04:36:55 INFO - blobuploader == 1.2.4 04:36:55 INFO - docopt == 0.6.1 04:36:55 INFO - functools32 == 3.2.3-2 04:36:55 INFO - jsonschema == 2.5.1 04:36:55 INFO - manifestparser == 1.1 04:36:55 INFO - mozInstall == 1.12 04:36:55 INFO - mozcrash == 0.17 04:36:55 INFO - mozdebug == 0.1 04:36:55 INFO - mozdevice == 0.48 04:36:55 INFO - mozfile == 1.2 04:36:55 INFO - mozhttpd == 0.7 04:36:55 INFO - mozinfo == 0.9 04:36:55 INFO - mozleak == 0.1 04:36:55 INFO - mozlog == 3.4 04:36:55 INFO - moznetwork == 0.27 04:36:55 INFO - mozprocess == 0.23 04:36:55 INFO - mozprofile == 0.28 04:36:55 INFO - mozrunner == 6.12 04:36:55 INFO - mozscreenshot == 0.1 04:36:55 INFO - mozsystemmonitor == 0.3 04:36:55 INFO - moztest == 0.7 04:36:55 INFO - mozversion == 1.4 04:36:55 INFO - psutil == 3.1.1 04:36:55 INFO - requests == 1.2.3 04:36:55 INFO - wsgiref == 0.1.2 04:36:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:55 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 0x7f47df4e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9f60>, '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 0x14fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fb1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', '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 04:36:55 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 04:36:55 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 04:36:55 INFO - Using env: {'DISPLAY': ':0', 04:36:55 INFO - 'HOME': '/home/cltbld', 04:36:55 INFO - 'LANG': 'en_US.UTF-8', 04:36:55 INFO - 'LANGUAGE': 'en_US:en', 04:36:55 INFO - 'LOGNAME': 'cltbld', 04:36:55 INFO - 'MAIL': '/var/mail/cltbld', 04:36:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:55 INFO - 'MOZ_NO_REMOTE': '1', 04:36:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:55 INFO - 'NO_EM_RESTART': '1', 04:36:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:55 INFO - 'PWD': '/builds/slave/test', 04:36:55 INFO - 'SHELL': '/bin/bash', 04:36:55 INFO - 'SHLVL': '1', 04:36:55 INFO - 'TERM': 'linux', 04:36:55 INFO - 'TMOUT': '86400', 04:36:55 INFO - 'USER': 'cltbld', 04:36:55 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', 04:36:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:55 INFO - '_': '/tools/buildbot/bin/python'} 04:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:56 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)) 04:36:56 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)) 04:36:56 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)) 04:36:56 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)) 04:36:56 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)) 04:36:56 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)) 04:36:56 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)) 04:36:56 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)) 04:36:56 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)) 04:36:56 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)) 04:36:56 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)) 04:36:56 INFO - Cleaning up... 04:36:56 INFO - Return code: 0 04:36:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:36:56 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')]} 04:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:56 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')]} 04:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:56 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 0x7f47df4e6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x142f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fcca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f9f60>, '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 0x14fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fb1d0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', '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 04:36:56 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 04:36:56 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 04:36:56 INFO - Using env: {'DISPLAY': ':0', 04:36:56 INFO - 'HOME': '/home/cltbld', 04:36:56 INFO - 'LANG': 'en_US.UTF-8', 04:36:56 INFO - 'LANGUAGE': 'en_US:en', 04:36:56 INFO - 'LOGNAME': 'cltbld', 04:36:56 INFO - 'MAIL': '/var/mail/cltbld', 04:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:56 INFO - 'MOZ_NO_REMOTE': '1', 04:36:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:36:56 INFO - 'NO_EM_RESTART': '1', 04:36:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:56 INFO - 'PWD': '/builds/slave/test', 04:36:56 INFO - 'SHELL': '/bin/bash', 04:36:56 INFO - 'SHLVL': '1', 04:36:56 INFO - 'TERM': 'linux', 04:36:56 INFO - 'TMOUT': '86400', 04:36:56 INFO - 'USER': 'cltbld', 04:36:56 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', 04:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:56 INFO - '_': '/tools/buildbot/bin/python'} 04:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:36:56 INFO - Cleaning up... 04:36:56 INFO - Return code: 0 04:36:56 INFO - Running post-action listener: _resource_record_post_action 04:36:56 INFO - Running post-action listener: _start_resource_monitoring 04:36:56 INFO - Starting resource monitoring. 04:36:56 INFO - [mozharness: 2016-09-19 11:36:56.418810Z] Finished create-virtualenv step (success) 04:36:56 INFO - [mozharness: 2016-09-19 11:36:56.419259Z] Running install step. 04:36:56 INFO - Running pre-action listener: _resource_record_pre_action 04:36:56 INFO - Running main action method: install 04:36:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:56 INFO - Reading from file tmpfile_stdout 04:36:56 INFO - Detecting whether we're running mozinstall >=1.0... 04:36:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:36:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:36:56 INFO - Reading from file tmpfile_stdout 04:36:56 INFO - Output received: 04:36:56 INFO - Usage: mozinstall [options] installer 04:36:56 INFO - Options: 04:36:56 INFO - -h, --help show this help message and exit 04:36:56 INFO - -d DEST, --destination=DEST 04:36:56 INFO - Directory to install application into. [default: 04:36:56 INFO - "/builds/slave/test"] 04:36:56 INFO - --app=APP Application being installed. [default: firefox] 04:36:56 INFO - mkdir: /builds/slave/test/build/application 04:36:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:36:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:37:12 INFO - Reading from file tmpfile_stdout 04:37:12 INFO - Output received: 04:37:12 INFO - /builds/slave/test/build/application/firefox/firefox 04:37:12 INFO - Running post-action listener: _resource_record_post_action 04:37:12 INFO - [mozharness: 2016-09-19 11:37:12.778329Z] Finished install step (success) 04:37:12 INFO - [mozharness: 2016-09-19 11:37:12.778573Z] Running run-tests step. 04:37:12 INFO - Running pre-action listener: _resource_record_pre_action 04:37:12 INFO - Running main action method: run_tests 04:37:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:37:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:37:12 INFO - Python 2.7.3 04:37:12 INFO - Return code: 0 04:37:12 INFO - grabbing minidump binary from tooltool 04:37: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')]} 04:37:12 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 0x14f9f60>, '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 0x14fad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14fb1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:37:12 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 04:37:12 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 04:37:12 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 04:37:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:37:12 INFO - Return code: 0 04:37:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:37:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:37:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:37:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:37:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:37:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 04:37:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 04:37:12 INFO - Using env: {'DISPLAY': ':0', 04:37:12 INFO - 'HOME': '/home/cltbld', 04:37:12 INFO - 'LANG': 'en_US.UTF-8', 04:37:12 INFO - 'LANGUAGE': 'en_US:en', 04:37:12 INFO - 'LOGNAME': 'cltbld', 04:37:12 INFO - 'MAIL': '/var/mail/cltbld', 04:37:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:37:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:37:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:12 INFO - 'MOZ_NO_REMOTE': '1', 04:37:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:37:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:37:12 INFO - 'NO_EM_RESTART': '1', 04:37:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:37:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:12 INFO - 'PWD': '/builds/slave/test', 04:37:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:37:12 INFO - 'SHELL': '/bin/bash', 04:37:12 INFO - 'SHLVL': '1', 04:37:12 INFO - 'TERM': 'linux', 04:37:12 INFO - 'TMOUT': '86400', 04:37:12 INFO - 'USER': 'cltbld', 04:37:12 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580', 04:37:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:12 INFO - '_': '/tools/buildbot/bin/python'} 04:37:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 04:37:13 INFO - mozversion application_buildid: 20160919032318 04:37:13 INFO - mozversion application_changeset: fc69febcbf6c0dcc4b3dfc7a346d8d348798a65f 04:37:13 INFO - mozversion application_display_name: Nightly 04:37:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:37:13 INFO - mozversion application_name: Firefox 04:37:13 INFO - mozversion application_remotingname: firefox 04:37:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:37:13 INFO - mozversion application_vendor: Mozilla 04:37:13 INFO - mozversion application_version: 51.0a1 04:37:13 INFO - mozversion platform_buildid: 20160919032318 04:37:13 INFO - mozversion platform_changeset: fc69febcbf6c0dcc4b3dfc7a346d8d348798a65f 04:37:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:37:13 INFO - mozversion platform_version: 51.0a1 04:37:13 INFO - using testdate: 1474285033 04:37:13 INFO - actual date: 1474285033 04:37:13 INFO - starting webserver on 'localhost:54309' 04:37:13 INFO - SUITE-START | Running 2 tests 04:37:13 INFO - TEST-START | dromaeo_css 04:37:13 INFO - operating with platform_type : linux_ 04:37:13 INFO - Initialising browser for dromaeo_css test... 04:37:13 INFO - TEST-INFO | started process 17430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqEuFzX/profile http://localhost:54309/getInfo.html) 04:37:17 INFO - PROCESS | 17430 | __metrics Screen width/height:1600/1200 04:37:17 INFO - PROCESS | 17430 | colorDepth:24 04:37:17 INFO - PROCESS | 17430 | Browser inner width/height: 1024/697 04:37:17 INFO - PROCESS | 17430 | __metrics 04:37:18 INFO - PROCESS | 17430 | 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" 04:37:18 INFO - PROCESS | 17430 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:37:18 INFO - PROCESS | 17430 | console.error: PushService: 04:37:18 INFO - PROCESS | 17430 | stateChangeProcessEnqueue: Error transitioning state 04:37:18 INFO - PROCESS | 17430 | UnknownError 04:37:19 INFO - TEST-INFO | 17430: exit 0 04:37:19 INFO - Browser initialized. 04:37:19 INFO - Running cycle 1/1 for dromaeo_css test... 04:37:19 INFO - TEST-INFO | started process 17509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqEuFzX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:37:31 INFO - PROCESS | 17509 | RSS: Main: 175468544 04:37:31 INFO - PROCESS | 17509 | 04:37:49 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 04:37:51 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:38:08 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.03334 seconds. 04:38:14 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 04:38:18 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01667 seconds. 04:38:20 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 04:38:23 INFO - PROCESS | 17509 | 1474285103753 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] 04:38:26 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.03335 seconds. 04:38:33 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01664 seconds. 04:38:37 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 04:38:48 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 04:38:59 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 04:39:02 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01663 seconds. 04:39:04 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.16669 seconds. 04:39:09 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.05002 seconds. 04:39:28 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.05004 seconds. 04:39:36 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:39:38 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:39:41 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.1667 seconds. 04:39:46 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.05002 seconds. 04:39:56 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:40:06 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 04:40:08 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 2.03334 seconds. 04:40:08 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 2.03334 seconds. 04:40:20 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.0166 seconds. 04:40:26 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 04:40:28 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:40:30 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:40:32 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.06669 seconds. 04:40:36 INFO - PROCESS | 17509 | Cycle 1(1): loaded http://localhost:54309/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54309/tests/dromaeo/cssquery-ext.html) 04:40:37 INFO - PROCESS | 17509 | RSS: Main: 284745728 04:40:37 INFO - PROCESS | 17509 | 04:40:58 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:41:00 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:41:10 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:41:42 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:42:02 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:42:04 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:42:18 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 04:42:23 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 04:42:31 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:42:38 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 04:42:49 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 04:42:51 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 04:43:02 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 04:43:08 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:43:21 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:43:25 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:43:29 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 04:43:32 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:43:40 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 04:43:40 INFO - PROCESS | 17509 | Cycle 1(1): loaded http://localhost:54309/tests/dromaeo/cssquery-ext.html (next: http://localhost:54309/tests/dromaeo/cssquery-jquery.html) 04:43:40 INFO - PROCESS | 17509 | RSS: Main: 273780736 04:43:40 INFO - PROCESS | 17509 | 04:43:46 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.03336 seconds. 04:43:51 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:43:57 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 04:43:59 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:44:06 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 04:44:38 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 04:44:45 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:44:59 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01679 seconds. 04:45:03 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:45:08 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 04:45:10 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 04:45:16 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:45:18 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 04:45:20 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 04:45:22 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00846 seconds. 04:45:24 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 04:45:27 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 2.01668 seconds. 04:45:27 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 2.01668 seconds. 04:45:29 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 04:45:35 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 04:45:44 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 04:45:46 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:45:50 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:45:58 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:46:10 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:46:22 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:46:24 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 04:46:36 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:46:42 INFO - PROCESS | 17509 | Cycle 1(1): loaded http://localhost:54309/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54309/tests/dromaeo/cssquery-mootools.html) 04:46:43 INFO - PROCESS | 17509 | RSS: Main: 249552896 04:46:43 INFO - PROCESS | 17509 | 04:46:47 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.03333 seconds. 04:46:54 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:46:58 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:47:12 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:47:16 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:47:18 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:47:19 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 2.01671 seconds. 04:47:50 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:47:53 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:48:11 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 04:48:19 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 04:48:27 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:48:35 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 04:48:41 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:48:49 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:48:51 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:49:03 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:49:07 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:49:09 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:49:27 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:49:33 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:49:35 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:49:37 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:49:45 INFO - PROCESS | 17509 | Cycle 1(1): loaded http://localhost:54309/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54309/tests/dromaeo/cssquery-prototype.html) 04:49:46 INFO - PROCESS | 17509 | RSS: Main: 219545600 04:49:46 INFO - PROCESS | 17509 | 04:49:53 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01667 seconds. 04:49:57 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:50:02 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.03336 seconds. 04:50:06 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.08339 seconds. 04:50:21 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 04:50:23 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 04:50:25 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 04:50:31 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:50:35 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 04:50:39 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 04:50:41 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 04:50:43 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:50:56 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:50:58 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 04:51:02 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:51:05 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 2.00001 seconds. 04:51:05 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 2.00001 seconds. 04:51:11 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 04:51:14 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:51:16 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 04:51:22 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01665 seconds. 04:51:24 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.03335 seconds. 04:51:28 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 04:51:33 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 04:51:46 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:51:50 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:51:52 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:51:54 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 04:51:56 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:51:59 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 04:52:05 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:52:15 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 04:52:23 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:52:27 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:52:29 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:52:31 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:52:48 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 04:52:49 INFO - PROCESS | 17509 | Cycle 1(1): loaded http://localhost:54309/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54309/tests/dromaeo/cssquery-yui.html) 04:52:50 INFO - PROCESS | 17509 | RSS: Main: 219873280 04:52:50 INFO - PROCESS | 17509 | 04:52:55 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.03334 seconds. 04:53:01 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 04:53:04 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:53:08 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:53:12 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 04:53:43 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 04:53:53 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:53:55 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:53:57 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 04:54:06 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01667 seconds. 04:54:11 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:54:19 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:54:25 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:54:35 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:54:46 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.01662 seconds. 04:54:48 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:54:56 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:55:02 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:55:05 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 04:55:16 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:55:31 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.03336 seconds. 04:55:34 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 04:55:35 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 2.03336 seconds. 04:55:39 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.03336 seconds. 04:55:45 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 04:55:49 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.03339 seconds. 04:55:53 INFO - PROCESS | 17509 | [GFX1-]: Refresh driver waiting for the compositor for 1.0334 seconds. 04:55:53 INFO - PROCESS | 17509 | Cycle 1(1): loaded http://localhost:54309/tests/dromaeo/cssquery-yui.html (next: http://localhost:54309/tests/dromaeo/cssquery-dojo.html) 04:55:53 INFO - PROCESS | 17509 | RSS: Main: 281612288 04:55:53 INFO - PROCESS | 17509 | 04:55:53 INFO - PROCESS | 17509 | __start_tp_report 04:55:53 INFO - PROCESS | 17509 | _x_x_mozilla_page_load 04:55:53 INFO - PROCESS | 17509 | _x_x_mozilla_page_load_details 04:55:53 INFO - PROCESS | 17509 | |i|pagename|runs| 04:55:53 INFO - PROCESS | 17509 | |0;dojo.html;2590.2876708905055;2610.569256072748;2640.2343320437076;2646.9073582424608;2658.9468210635787;4565.223911934971;4619.976900115495;4717.481235601574;4779.569838714515;4842.273658951159;4631.513691062441;4686.367340409044;4693.976530117353;4733.857984260478;4740.620750339973;4285.849995250167;4292.65658747301;4294.162638285536;4305.332673435622;4359.084592235635;4389.934150987738;4390.626796722282;4414.955850441503;4426.601605855472;4475.082608065339;4269.231538323101;4313.805878735465;4394.846180383671;4473.932891006638;4496.505384407713;4337.457817772778;4349.26062569364;4374.58441448062;4379.233634114017;4470.977645111786;4354.020345422255;4364.629006534448;4374.956250437487;4376.518582955872;4421.226285400042;4753.572178503951;4756.215224487955;4790.209615413452;4793.424789025305;4851.733154676492;4925.236588328815;4958.851234462972;4969.950300496985;5008.84973450797;5011.273365362002;5035.320231768737;5047.066292735855;5053.974730126362;5057.519535644108;5101.770420331057;4683.250679891235;4685.437747470257;4689.718616882998;4733.976330118362;4750.097481478508;5045.9747701261995;5104.081265372269;5104.719240441737;5135.666181698178;5193.7403129844115;4914.70511769295;4961.776720047606;4967.180415231519;4968.925466118011;4973.154563724175;5068.543831055223;5118.053160165381;5118.462561431071;5147.485251474897;5207.3230480037355;5039.521245481674;5074.264231686385;5088.720120393414;5094.129579694743;5124.948750512447;4844.079624871263;5076.0863044652315;5086.3133476980875;5087.008033433445;5090.796368145307;4241.681873859473;4265.232258193493;4292.5063617683745;4297.076128632359;4303.397524346594;3742.9625703742613;3744.981275093607;3755.8122093895195;3788.052986753312;3797.2025874566098;4365.432493775789;4369.3664418659755;4378.890527736832;4416.381706561084;4423.734575925455;4898.387701537308;4912.091263116335;4984.651074424755;5058.4435712071645;5093.694378337312;4384.912301753947;4388.385626012361;4425.911481770347;4429.756363400044;4440.067585807016;4566.13243483737;4576.244919588297;4576.633869290449;4580.564846339593;4631.536846315342;4686.554777296152;4748.382710247645;4753.358296629911;4778.378810754649;4784.808607655655;5069.5944324454695;5116.1046816806165;5124.718140502308;5157.020166168416;5183.740812959261;4791;4812.735299558558;4812.783424745965;4830.420349557935;4892.975535122301;4933.679310844784;4988.201887697951;5030.220315851049;5043.193089105725;5109.540141387293;4954.554090131761;5001.524855138756;5005.824796132118;5017.096922553976;5082.669626474268;4865.683730557503;4873.4882837301575;4877.561019508261;4879.926416188433;4940.530649588283;4779.283107533759;4832.081904438145;4841.661083724246;4844.4186697596515;4901.803927842846;4713.9057218856115;4767.284907263799;4811.109944660249;4815.3258543803195;4907.484714104968;5025;5036.143855544493;5042.798288068583;5043.2687260347775;5058.645894787477;4757.3577567028005;4770.308305295644;4800.66395352322;4893.388326459192;4928.728919909296 04:55:53 INFO - PROCESS | 17509 | |1;ext.html;552.3813329071438;566.7534622439237;569.4760820045558;581.6190395291086;583.3903570768547;27260.863695681517;38443.80778096109;38684.22631547367;38909.22181556367;43475.3478697819;41255;41629.167416651726;41663.58336416635;41742.791286043604;41781.7910910445;7628.427867909902;7770.4560680752365;7772.922270777276;7778;7781.416393770462;7441.516301440389;7521.135069466999;7531.472796904219;7539.132999705049;7539.736109236178;7548.924510754905;7592.772216833504;7604.695812167507;7624.809379765495;7625.351845093173;7528.623568821565;7531.5481071135355;7546.132194797614;7553.206913274082;7561.168271490159;7453.962730186368;7506.699732010713;7525.059367579052;7530.77407677765;7533.585652789095;37478.25043499142;37841;37850.81074594637;37893.81053094744;37999.24001519954;2905.7094290570985;2979.8808047678067;3032.3935212957495;3129.186411532995;3328.8169150696704;27620.44759104827;27625;27741.722582774117;27863.721362786317;28896.422071558452;3091.1035799618085;3152.290734584723;3166.936661266785;3207.1821685470054;3217.935641287161;240192;240505;241359.79320103463;241483;241760;53078;53266.7336663322;53423.46576534185;53425.794452332986;53448.465515344345;28661.14016579506;29080;29122.563161552593;29194.708052919625;29239.707602924125;15086.622834429227;15227.695446091016;15253.38986440552;15254.847451525564;15279.618009549627;11570.76858462843;11595.478203480694;11607.825882611767;11656.825147622792;11658.591949281905;18177.545561360806;18183.63632727338;18184.36354727578;18196.90901545484;18274.725879111826;6516.077757061678;6576.473882089422;6576.934230657728;6594.415046158819;6708.731650733916;749.5277974875794;764.5489161394804;888.1917455115813;906.9682561110329;973.255459573427;24338.391540211636;28262.71737282642;28644.570331445044;28820.135395938156;28828.279293017844;758.6396461680657;889.909860420992;908.3096846396786;913.7989642278689;939.6992962252014;14266.286685665675;14420.927895360455;14543.127412355081;14571.125732456087;14773.18747468878;373993;377080;377140;377219;378203;48962.75518622384;49486;49555.75222123866;49564;49611.751941240065;1047.261680515235;1079.63292480557;1082.0640146273574;1121.0975164992096;1158.80879654856;27444;28844.278893027844;29420.248628847785;29450;29993.70006299909;41206.587934120274;41761;41899;41915.580844191165;41953.580464194965;315708;319854;319863;320110;320938;37273.25453490969;37496;38228.23543529058;38479.807600961816;41444.79277603592;41630.79184604058;41864.790676046425;41899.7905010473;41993;42299.365509518;35574.28851423009;36036.4594531077;36273.27453450864;36401.27197456089;36562;36051;36070.27859442849;36345.636543634224;36625.45061824022;36756;35271.29457410786;35359.64640353563;36193.095172620895;36319.27361452703;36582.63417365792;30345.696543034286;32197.356052878342;32339.19152021218;32672.34655306928;32787;24656.698809755988;24861.87569062143;25130.24609261725;25135.74864251407;25629.743702562737 04:55:53 INFO - PROCESS | 17509 | |2;jquery.html;350.9227969846633;362.3278817792994;370.374067825375;370.6127097183443;390.32278995942033;11873.52505899764;12744.80882786759;13797.448102075918;15750.448734294301;16484;15939.920300398511;16005.599860003505;16201.10893900835;16203.83796162038;16355.182240887967;4898.24077268024;5085;5314.548263397616;5343.625946183769;5437.510624043835;3375.8818441354556;5325.4940780625775;5326.813561525348;5352.357717073937;5352.437994010631;3530.6292839251896;3589.6589823966683;3759.398496240602;5801.158831969362;5881.970590147043;5716.1711551825165;5871.55963302754;5892.793752218695;5912.231409916726;5915.201447804534;5204.141316682742;5245.160774276097;5262.289590905217;5263.078961181778;5267.130923397634;11943.641690749291;12049.401852072711;12110.81833772494;19643.508912277164;19890.70163947542;1697.176869218428;1779.5284249673846;1784.4914199453094;1792.9103544822838;1868.6636405447014;8539.018012928469;9006.954965225132;9192.080791920822;9429.528523573794;9436.764080897963;1622.399712106528;1635.852773250413;1651.4962936304423;1667.5664327274874;1683.9747403788954;67106;69097;69597;70640.29359706388;71693.28306716918;9740.805183896282;9884;9969.152622027064;9981;10042.297039207331;13277.614208376803;13296.601101966957;13299.867001330056;13313.068085233941;13371.866281337258;7165.547508039395;7220.3140701633265;7244.851054996181;7389.445791565654;7390.889136662954;6793.558418702769;6846.691898864563;7008.964955175192;7026.367626913602;7032.964835175791;4117.711760176759;4158.584141585818;4166.33338665812;4180.372944058355;4253.340732186516;1757.8593712502968;1794.6321004194108;1816.827401396865;1829.5334689654053;1831.7343985122084;766.8619648463218;813.6419975210888;824.4599787139433;831.4512421801581;835.807764214222;15571.143587102819;16069.196540172945;16249.350025999063;16416;17032.914835425745;792.9722459713882;817.0717107625998;823.3660081737148;843.2874221283006;855.3328403845011;7979.760607181794;9182.449053056838;9374.343795934356;9383.202427793578;9570.856437153308;351012;353413;361401;361942;362554;76609;77694.611526942;78340.60829695815;78838.81741773878;79262.6036869812;846.9576521173917;867.947923124602;868.5830801215326;869.9173578510031;870.2254993056185;14367.784483232968;14442.638934026734;14517.346719397441;14549.345279462661;15243.390264389744;36075;36385.818070909474;36460.635393646786;36650.26699466049;37548.62451375451;49451.50548494469;49548.75225623849;50134;51824.74087629538;52855.73572132115;7496.700131994659;7524.247575242432;7626.313631773167;7749.457537972288;7789.415793815373;9684.56419461112;11102;11864.288142711464;11937.46281417321;12162.209456385306;10036.94981525117;10048.497575121068;10057.647982320585;10086.8486972694;10523.05292523646;9791.902080979098;10008.58849142153;10062.547185376528;10341.689749307532;10411.375317480975;10108.292419530562;10131.64539241123;10463.529141188512;10529.842052369373;10718.464076795974;7545.6981720730555;7575.886361704469;7585.734499292498;7653.387728981556;8040.517568945882;7588.772336829904;8886.644534218558;9708.368956017835;10259.076683098558;10723.89276107229 04:55:53 INFO - PROCESS | 17509 | |3;mootools.html;1246.4515613130216;1359.4494229836916;1397.3572156807868;1451.5282533176714;1669.666066786643;6689.69896354664;7459.142198647157;7710.575918324483;7750.4187185961;7944.404169687267;7774;7821.960890195555;7835;7836.608169591526;7851.960740196305;2193.1775584155903;2196.6265734825038;2205.614017546931;2208.1719355241785;2213.457702862801;2107.399391173516;2161.729783777028;2166.9891650541726;2169.8915054247223;2172.3374370816896;2141.2077531313357;2141.5609799991043;2148.32327816738;2148.881811500367;2202.570498752744;2118.904649290778;2123.522207503307;2127.6489379252403;2129.158982202037;2133.146741303491;2087.185997460976;2145.002573803189;2145.3992881993067;2148;2153.6554151335868;7536.4724469287175;7821.335186509154;7867.803304917423;7876.73972164451;7894.763157105296;4396;4543.840965566189;4565.817367305303;4567.817287308504;4578.427696537933;2726.61827344172;2831.830090194595;2868.8565571721538;2871.1530098620956;2871.3826527296524;886.6586364249746;888.8800011998427;895.6104094718818;900.6352427266968;905.8414777413926;10585.629502967358;10611.628592999208;10654.09440197584;10666.14670826332;10730.839037414367;3790.2419516096893;3958.5249770027203;4063.0858056936954;4088.9591104088577;4193.7693426861815;8327.167283271625;8350.373721970876;8369;8377.413581049268;8397.790055248546;4459.576340247671;4496.797644106023;4505.594496495331;4510.120526497301;4512.729236245836;3643.908902277464;3754.6057663944894;4037;4194.727342722713;4196.559361267023;3301.752368572367;3331.883384081594;3438.2951494943477;3453.568303962005;3490.144914495914;1032.390889375257;1049.1030169205371;1053.910417614496;1064.4784055812752;1070.973225669349;750.0923882102608;761.3186198352444;776.5069181069948;780.5706861226303;793.2266040610359;5006.574441172468;5085.74571271435;5215.7913683453;5279.788808447696;5651.858703532363;764.2663043478323;772.1005029140988;780.5901901501644;856.2507805670039;856.5931182688298;3105.5186446100893;3167.55654208411;3184.1402821238134;3193.8722451101694;3202.5516427699677;9144.63421463134;9696.127348538665;9795.02049795029;9797.559109840075;9841.212702983745;9736.9026309736;9742.707718768448;9757.170640495495;9769.804603907882;9780.706578802647;6896.4827637926355;7142.035825163641;7161.570305781774;7183.8563228736175;7231.385332246818;4850.6119510438375;4869.123557759637;4903.166461701448;4913.43495498008;4931.556159945622;8656.43733157368;8758.12418758119;8786.560671966248;8858.247049000907;8897.243734282658;8894.665800129773;8930.01769805308;9082.273418126666;9083.18251357381;9212.078792120734;5314.3091398117995;5471.50756431923;5975.850603734942;6109.69451527413;6145.139680444652;7010.404115650227;7233.782986510413;7252.963735181291;7506.28690274423;7525.247475252431;6267.5299352549655;6405.19935008124;6463.353664633499;6483.7730679425995;6559.7376104955265;6535.2811190768025;6535.673216339259;6628.602283862983;6632.403083722488;6649.135612370361;5680.375158732619;5776.480116789509;5777.133429985368;5779.219805326227;5782.306123265235;4274.294741367639;4304.139172165516;4339.544347843431;4401.823927042882;4426.336049592587;4209.473815773028;4347.3261644445165;4379.627731642719;4407.074514352022;4440.378347031483 04:55:53 INFO - PROCESS | 17509 | |4;prototype.html;295.92749776304805;298.48511317976494;302.1223346179348;302.3031911444121;302.98333591652477;4835.709857408554;4865.270209468586;4882.951170488294;4887.413510378755;4891.559759621633;4546.840555658311;4811.412233962793;4830.710157390559;4831.420229572447;4913.606911447085;3703.333399988001;3725.105974566105;3804.6956243500454;3814.9618503815022;3819.2934307153128;3792.374258247386;3794.392897136459;3798.753081049737;3799.3920972644382;3801.1257410795533;3555.7510974231814;3764.5106136202257;3774.3017541754725;3775.490308808317;3776.811159442017;3691.2617476504674;3710.83301251443;3745.7190710696536;3771.509703738524;3777.660010599059;3321.5848018997626;3329.4839299908554;3336.899893003214;3337.1990722226733;3345.1971526833627;4651.279051746985;4659.439087905555;4661.603763680057;4692.624590032823;4698.600618947394;4166.229247589175;4248.553901840293;4266.6586673066395;4278.336857787048;4284.121755040241;4965.82619608312;4995.875103122451;5013.1227035268685;5016.924746128811;5017.613111149995;3635.4546817977252;3637.7089832813313;3645.143391303042;3645.453182022718;3665.8350374233223;5029.798808047673;5234.371875374942;5249.790008399659;5283.313169288006;5290.761915713802;3737.7757334560015;3742.962570374316;3748.9062773430883;3750.2124553843996;3753.7184711146774;3758;3759.774413535197;3783.5459744830246;3787.867424640124;3815.9236815264094;4257.169851878916;4269.5910349584565;4276.422682937826;4283.250431174532;4293.763842988603;4742.383490146259;5042.268871013683;5044.646874718808;5080.669756465818;5084.237364395371;1283.4481173095471;1287.575100216926;1288.6198571421453;1292.7737645911927;1293.644247831835;806.9031716194095;810.2424233341844;821.7919658102579;827.4786884262996;838.9580520973927;4299.624120281543;4335.479742430928;4348.195583817004;4438.312061630452;4485.394471746337;5234.555062819703;5248.580113590903;5252.868678283074;5257.658252213594;5264.473552644705;4373.628241599499;4498.910021799546;4500.549945005473;4504.481984571817;4520.214515266452;2729.2085295264546;2738.835669859815;2768.809411952839;2772.6672799263815;2777.6250206222307;4886.975565122151;4911.607071434277;4918.606511479073;4924.9507504925205;5020.899582008413;5076.238564215398;5333.280007199056;5341.305630268041;5342.358916929993;5359.490848369399;4955.851324460272;4959.256111583291;4966.652334336562;4970.17992031318;4972.179590367621;5228.947710522998;5234.2933703949475;5235.921461178009;5271.65734227274;5309.57523398135;4802.615790736662;5064.0756512525;5099.898002039864;5129.589632829439;5150.278960945546;4869.780859861386;4872.829450969199;4883.340748998839;4888.828890988798;4899.167141585867;3657.3233951719017;3665.193657395369;3670.4861319415836;3670.5778835434267;3717.3308804415465;4902.313676085279;5158.509941555546;5186.688798672092;5191.091558977088;5196.32447781786;5044.495550444926;5060.772265248146;5072;5091.389033316026;5099.464556221692;5075.416327122281;5101.974490127525;5107.157319042316;5109.795608175631;5209.557187638941;4807.206810876166;4883.462819089827;4919.827806026772;4949.109160351171;4960.23116416956;4911.410630724193;4980.352554167935;5061.595072394273;5131.717755523482;5139.460356662496;4986.601071914166;4999.15014447552;5005.8748531285555;5007.449180590205;5015.523525265094 04:55:53 INFO - PROCESS | 17509 | |5;yui.html;538.3620409814371;572.2360648534207;593.525179856115;631.819931319574;638.3967151042267;12620.36898155092;13741.725165496684;13752.724945501097;13764.449422023119;14105.57683269501;14535.200563968978;14605.707885842277;14670.413183472674;14705.926470367633;14742.705145897076;741.9183889772121;771.6064806948468;773.8800485924662;777.4052849570083;777.4130531448749;604.2899592978255;615.0712424239387;744.4342299852098;771.9035120609924;778.3150827271993;807.019471342319;813.0284310249255;813.5078277642031;813.7436707437139;813.8535063688533;792.4611264340247;800.8358286551243;801.4550105927966;801.7274126796888;801.7634797734682;467.8994016286481;474.8717846181546;570.3697414357158;593.7624950020027;593.9910901336483;12362;12973;13074.738505229938;13087.607371778862;13138.671533211651;11429.828552571718;11555.94222028893;11556.884431155664;11559.53761849525;11782.646520604396;10005.949970250102;10028.498575071217;10176.135028522585;10186.643467478676;10238.89761102387;3132.6867313268717;3157.5737275467745;3172.841357932094;3211.6467188609236;3243.2864769750618;72065.2793472069;72641.27358726451;72989;73082.26917730807;73790;8665.263452606472;8686.913130868737;8856.512891791013;8983;9461.24310055194;16199.190040497928;16795;18884.43346699601;18986.81013189878;19051.333203337817;6619.3380661933425;6652.101966234496;6695.698693558801;6704.597724136567;6708.295628958889;3522.788632682047;3551.8224088795455;3580.3018411410044;3596.6583174598372;3704.0924973381693;2861.7424431800823;2953.3354995126356;2971.881124755029;2975.910722678323;2976.1666733314705;489.5471688687949;496.18873142411695;500.6770632941732;506.45808984386355;511.15404006369516;410.17554715023016;465.2114665641772;476.1072988147224;482.10088185533726;492.29601669612083;6594.901076483857;6867.965660171667;6945.444364450832;7006.229314775371;7214.206437291894;468.29989166196754;474.1134079271784;486.3221884498494;494.1845954175639;500.5795132089063;3330.1508115430893;3358.9496157557655;3367.3602015616952;3425.880094196691;3469.150058235698;104730;105579;106116;108116.35069194603;111984.4400777991;93098;93642;93707;93945;94962.52518737363;79126;80687;82894;84404.57797711095;84525.57737211397;6673.9666301668185;7332.5967071811565;7568;7592.734254301073;8038.678452862054;37558.362608066716;42843.357349639155;43652.345214821165;43934.62947872477;45558.08883822371;59830.70084649549;59841.401585983585;61408.385916140265;62050;62426.37573624206;9557.569909353957;9915.603375865174;9949.850752238577;10122.240831937781;10258.640947566799;10955.726106847393;11157.553697851996;11580.826287605523;11777.234479758788;12120.878791211975;10333.689989300334;10515.737106572396;10745.677629671123;10877.891221088004;11280;10235.078842904175;10309.123724483203;10431.269811113149;10450.059494645518;10490.632827851294;10139.2395570334;10300.845487317845;10457.581696732046;10782.353058816496;11412.600558980395;8732;8734.257588105082;8792.560371981503;8937.508437036025;9202.677906273248;8436.409451338593;8834.514101724468;8916.420432671855;8922.152395522415;9374.281458376994 04:55:53 INFO - PROCESS | 17509 | __end_tp_report 04:55:53 INFO - PROCESS | 17509 | __start_cc_report 04:55:53 INFO - PROCESS | 17509 | _x_x_mozilla_cycle_collect,907 04:55:53 INFO - PROCESS | 17509 | __end_cc_report 04:55:53 INFO - PROCESS | 17509 | __startTimestamp1474286153541__endTimestamp 04:55:53 INFO - PROCESS | 17509 | 04:55:53 INFO - PROCESS | 17509 | ------- Summary: start ------- 04:55:53 INFO - PROCESS | 17509 | Number of tests: 6 04:55:53 INFO - PROCESS | 17509 | 04:55:53 INFO - PROCESS | 17509 | [#0] dojo.html Cycles:165 Average:4676.87 Median:4791.00 stddev:484.58 (10.1%) stddev-sans-first:457.59 04:55:53 INFO - PROCESS | 17509 | Values: 2590.3 2610.6 2640.2 2646.9 2658.9 4565.2 4620.0 4717.5 4779.6 4842.3 4631.5 4686.4 4694.0 4733.9 4740.6 4285.8 4292.7 4294.2 4305.3 4359.1 4389.9 4390.6 4415.0 4426.6 4475.1 4269.2 4313.8 4394.8 4473.9 4496.5 4337.5 4349.3 4374.6 4379.2 4471.0 4354.0 4364.6 4375.0 4376.5 4421.2 4753.6 4756.2 4790.2 4793.4 4851.7 4925.2 4958.9 4970.0 5008.8 5011.3 5035.3 5047.1 5054.0 5057.5 5101.8 4683.3 4685.4 4689.7 4734.0 4750.1 5046.0 5104.1 5104.7 5135.7 5193.7 4914.7 4961.8 4967.2 4968.9 4973.2 5068.5 5118.1 5118.5 5147.5 5207.3 5039.5 5074.3 5088.7 5094.1 5124.9 4844.1 5076.1 5086.3 5087.0 5090.8 4241.7 4265.2 4292.5 4297.1 4303.4 3743.0 3745.0 3755.8 3788.1 3797.2 4365.4 4369.4 4378.9 4416.4 4423.7 4898.4 4912.1 4984.7 5058.4 5093.7 4384.9 4388.4 4425.9 4429.8 4440.1 4566.1 4576.2 4576.6 4580.6 4631.5 4686.6 4748.4 4753.4 4778.4 4784.8 5069.6 5116.1 5124.7 5157.0 5183.7 4791.0 4812.7 4812.8 4830.4 4893.0 4933.7 4988.2 5030.2 5043.2 5109.5 4954.6 5001.5 5005.8 5017.1 5082.7 4865.7 4873.5 4877.6 4879.9 4940.5 4779.3 4832.1 4841.7 4844.4 4901.8 4713.9 4767.3 4811.1 4815.3 4907.5 5025.0 5036.1 5042.8 5043.3 5058.6 4757.4 4770.3 4800.7 4893.4 4928.7 04:55:53 INFO - PROCESS | 17509 | 04:55:53 INFO - PROCESS | 17509 | [#1] ext.html Cycles:180 Average:46446.27 Median:37014.63 stddev:83445.64 (225.4%) stddev-sans-first:83608.58 04:55:53 INFO - PROCESS | 17509 | Values: 552.4 566.8 569.5 581.6 583.4 27260.9 38443.8 38684.2 38909.2 43475.3 41255.0 41629.2 41663.6 41742.8 41781.8 7628.4 7770.5 7772.9 7778.0 7781.4 7441.5 7521.1 7531.5 7539.1 7539.7 7548.9 7592.8 7604.7 7624.8 7625.4 7528.6 7531.5 7546.1 7553.2 7561.2 7454.0 7506.7 7525.1 7530.8 7533.6 37478.3 37841.0 37850.8 37893.8 37999.2 2905.7 2979.9 3032.4 3129.2 3328.8 27620.4 27625.0 27741.7 27863.7 28896.4 3091.1 3152.3 3166.9 3207.2 3217.9 240192.0 240505.0 241359.8 241483.0 241760.0 53078.0 53266.7 53423.5 53425.8 53448.5 28661.1 29080.0 29122.6 29194.7 29239.7 15086.6 15227.7 15253.4 15254.8 15279.6 11570.8 11595.5 11607.8 11656.8 11658.6 18177.5 18183.6 18184.4 18196.9 18274.7 6516.1 6576.5 6576.9 6594.4 6708.7 749.5 764.5 888.2 907.0 973.3 24338.4 28262.7 28644.6 28820.1 28828.3 758.6 889.9 908.3 913.8 939.7 14266.3 14420.9 14543.1 14571.1 14773.2 373993.0 377080.0 377140.0 377219.0 378203.0 48962.8 49486.0 49555.8 49564.0 49611.8 1047.3 1079.6 1082.1 1121.1 1158.8 27444.0 28844.3 29420.2 29450.0 29993.7 41206.6 41761.0 41899.0 41915.6 41953.6 315708.0 319854.0 319863.0 320110.0 320938.0 37273.3 37496.0 38228.2 38479.8 41444.8 41630.8 41864.8 41899.8 41993.0 42299.4 35574.3 36036.5 36273.3 36401.3 36562.0 36051.0 36070.3 36345.6 36625.5 36756.0 35271.3 35359.6 36193.1 36319.3 36582.6 30345.7 32197.4 32339.2 32672.3 32787.0 24656.7 24861.9 25130.2 25135.7 25629.7 04:55:53 INFO - PROCESS | 17509 | 04:55:53 INFO - PROCESS | 17509 | [#2] jquery.html Cycles:180 Average:23056.63 Median:27174.87 stddev:59447.77 (218.8%) stddev-sans-first:59590.09 04:55:53 INFO - PROCESS | 17509 | Values: 350.9 362.3 370.4 370.6 390.3 11873.5 12744.8 13797.4 15750.4 16484.0 15939.9 16005.6 16201.1 16203.8 16355.2 4898.2 5085.0 5314.5 5343.6 5437.5 3375.9 5325.5 5326.8 5352.4 5352.4 3530.6 3589.7 3759.4 5801.2 5882.0 5716.2 5871.6 5892.8 5912.2 5915.2 5204.1 5245.2 5262.3 5263.1 5267.1 11943.6 12049.4 12110.8 19643.5 19890.7 1697.2 1779.5 1784.5 1792.9 1868.7 8539.0 9007.0 9192.1 9429.5 9436.8 1622.4 1635.9 1651.5 1667.6 1684.0 67106.0 69097.0 69597.0 70640.3 71693.3 9740.8 9884.0 9969.2 9981.0 10042.3 13277.6 13296.6 13299.9 13313.1 13371.9 7165.5 7220.3 7244.9 7389.4 7390.9 6793.6 6846.7 7009.0 7026.4 7033.0 4117.7 4158.6 4166.3 4180.4 4253.3 1757.9 1794.6 1816.8 1829.5 1831.7 766.9 813.6 824.5 831.5 835.8 15571.1 16069.2 16249.4 16416.0 17032.9 793.0 817.1 823.4 843.3 855.3 7979.8 9182.4 9374.3 9383.2 9570.9 351012.0 353413.0 361401.0 361942.0 362554.0 76609.0 77694.6 78340.6 78838.8 79262.6 847.0 867.9 868.6 869.9 870.2 14367.8 14442.6 14517.3 14549.3 15243.4 36075.0 36385.8 36460.6 36650.3 37548.6 49451.5 49548.8 50134.0 51824.7 52855.7 7496.7 7524.2 7626.3 7749.5 7789.4 9684.6 11102.0 11864.3 11937.5 12162.2 10036.9 10048.5 10057.6 10086.8 10523.1 9791.9 10008.6 10062.5 10341.7 10411.4 10108.3 10131.6 10463.5 10529.8 10718.5 7545.7 7575.9 7585.7 7653.4 8040.5 7588.8 8886.6 9708.4 10259.1 10723.9 04:55:53 INFO - PROCESS | 17509 | 04:55:53 INFO - PROCESS | 17509 | [#3] mootools.html Cycles:180 Average:4983.71 Median:5046.16 stddev:2854.85 (56.6%) stddev-sans-first:2849.04 04:55:53 INFO - PROCESS | 17509 | Values: 1246.5 1359.4 1397.4 1451.5 1669.7 6689.7 7459.1 7710.6 7750.4 7944.4 7774.0 7822.0 7835.0 7836.6 7852.0 2193.2 2196.6 2205.6 2208.2 2213.5 2107.4 2161.7 2167.0 2169.9 2172.3 2141.2 2141.6 2148.3 2148.9 2202.6 2118.9 2123.5 2127.6 2129.2 2133.1 2087.2 2145.0 2145.4 2148.0 2153.7 7536.5 7821.3 7867.8 7876.7 7894.8 4396.0 4543.8 4565.8 4567.8 4578.4 2726.6 2831.8 2868.9 2871.2 2871.4 886.7 888.9 895.6 900.6 905.8 10585.6 10611.6 10654.1 10666.1 10730.8 3790.2 3958.5 4063.1 4089.0 4193.8 8327.2 8350.4 8369.0 8377.4 8397.8 4459.6 4496.8 4505.6 4510.1 4512.7 3643.9 3754.6 4037.0 4194.7 4196.6 3301.8 3331.9 3438.3 3453.6 3490.1 1032.4 1049.1 1053.9 1064.5 1071.0 750.1 761.3 776.5 780.6 793.2 5006.6 5085.7 5215.8 5279.8 5651.9 764.3 772.1 780.6 856.3 856.6 3105.5 3167.6 3184.1 3193.9 3202.6 9144.6 9696.1 9795.0 9797.6 9841.2 9736.9 9742.7 9757.2 9769.8 9780.7 6896.5 7142.0 7161.6 7183.9 7231.4 4850.6 4869.1 4903.2 4913.4 4931.6 8656.4 8758.1 8786.6 8858.2 8897.2 8894.7 8930.0 9082.3 9083.2 9212.1 5314.3 5471.5 5975.9 6109.7 6145.1 7010.4 7233.8 7253.0 7506.3 7525.2 6267.5 6405.2 6463.4 6483.8 6559.7 6535.3 6535.7 6628.6 6632.4 6649.1 5680.4 5776.5 5777.1 5779.2 5782.3 4274.3 4304.1 4339.5 4401.8 4426.3 4209.5 4347.3 4379.6 4407.1 4440.4 04:55:53 INFO - PROCESS | 17509 | 04:55:53 INFO - PROCESS | 17509 | [#4] prototype.html Cycles:180 Average:4200.79 Median:4831.07 stddev:1220.07 (25.3%) stddev-sans-first:1187.76 04:55:53 INFO - PROCESS | 17509 | Values: 295.9 298.5 302.1 302.3 303.0 4835.7 4865.3 4883.0 4887.4 4891.6 4546.8 4811.4 4830.7 4831.4 4913.6 3703.3 3725.1 3804.7 3815.0 3819.3 3792.4 3794.4 3798.8 3799.4 3801.1 3555.8 3764.5 3774.3 3775.5 3776.8 3691.3 3710.8 3745.7 3771.5 3777.7 3321.6 3329.5 3336.9 3337.2 3345.2 4651.3 4659.4 4661.6 4692.6 4698.6 4166.2 4248.6 4266.7 4278.3 4284.1 4965.8 4995.9 5013.1 5016.9 5017.6 3635.5 3637.7 3645.1 3645.5 3665.8 5029.8 5234.4 5249.8 5283.3 5290.8 3737.8 3743.0 3748.9 3750.2 3753.7 3758.0 3759.8 3783.5 3787.9 3815.9 4257.2 4269.6 4276.4 4283.3 4293.8 4742.4 5042.3 5044.6 5080.7 5084.2 1283.4 1287.6 1288.6 1292.8 1293.6 806.9 810.2 821.8 827.5 839.0 4299.6 4335.5 4348.2 4438.3 4485.4 5234.6 5248.6 5252.9 5257.7 5264.5 4373.6 4498.9 4500.5 4504.5 4520.2 2729.2 2738.8 2768.8 2772.7 2777.6 4887.0 4911.6 4918.6 4925.0 5020.9 5076.2 5333.3 5341.3 5342.4 5359.5 4955.9 4959.3 4966.7 4970.2 4972.2 5228.9 5234.3 5235.9 5271.7 5309.6 4802.6 5064.1 5099.9 5129.6 5150.3 4869.8 4872.8 4883.3 4888.8 4899.2 3657.3 3665.2 3670.5 3670.6 3717.3 4902.3 5158.5 5186.7 5191.1 5196.3 5044.5 5060.8 5072.0 5091.4 5099.5 5075.4 5102.0 5107.2 5109.8 5209.6 4807.2 4883.5 4919.8 4949.1 4960.2 4911.4 4980.4 5061.6 5131.7 5139.5 4986.6 4999.2 5005.9 5007.4 5015.5 04:55:53 INFO - PROCESS | 17509 | 04:55:53 INFO - PROCESS | 17509 | [#5] yui.html Cycles:180 Average:18357.36 Median:487.93 stddev:27965.45 (5731.4%) stddev-sans-first:28011.90 04:55:53 INFO - PROCESS | 17509 | Values: 538.4 572.2 593.5 631.8 638.4 12620.4 13741.7 13752.7 13764.4 14105.6 14535.2 14605.7 14670.4 14705.9 14742.7 741.9 771.6 773.9 777.4 777.4 604.3 615.1 744.4 771.9 778.3 807.0 813.0 813.5 813.7 813.9 792.5 800.8 801.5 801.7 801.8 467.9 474.9 570.4 593.8 594.0 12362.0 12973.0 13074.7 13087.6 13138.7 11429.8 11555.9 11556.9 11559.5 11782.6 10005.9 10028.5 10176.1 10186.6 10238.9 3132.7 3157.6 3172.8 3211.6 3243.3 72065.3 72641.3 72989.0 73082.3 73790.0 8665.3 8686.9 8856.5 8983.0 9461.2 16199.2 16795.0 18884.4 18986.8 19051.3 6619.3 6652.1 6695.7 6704.6 6708.3 3522.8 3551.8 3580.3 3596.7 3704.1 2861.7 2953.3 2971.9 2975.9 2976.2 489.5 496.2 500.7 506.5 511.2 410.2 465.2 476.1 482.1 492.3 6594.9 6868.0 6945.4 7006.2 7214.2 468.3 474.1 486.3 494.2 500.6 3330.2 3358.9 3367.4 3425.9 3469.2 104730.0 105579.0 106116.0 108116.4 111984.4 93098.0 93642.0 93707.0 93945.0 94962.5 79126.0 80687.0 82894.0 84404.6 84525.6 6674.0 7332.6 7568.0 7592.7 8038.7 37558.4 42843.4 43652.3 43934.6 45558.1 59830.7 59841.4 61408.4 62050.0 62426.4 9557.6 9915.6 9949.9 10122.2 10258.6 10955.7 11157.6 11580.8 11777.2 12120.9 10333.7 10515.7 10745.7 10877.9 11280.0 10235.1 10309.1 10431.3 10450.1 10490.6 10139.2 10300.8 10457.6 10782.4 11412.6 8732.0 8734.3 8792.6 8937.5 9202.7 8436.4 8834.5 8916.4 8922.2 9374.3 04:55:53 INFO - PROCESS | 17509 | -------- Summary: end -------- 04:55:53 INFO - PROCESS | 17509 | 04:55:54 INFO - TEST-INFO | 17509: exit 0 04:55:54 INFO - TEST-OK | dromaeo_css | took 1121422ms 04:55:54 INFO - TEST-START | kraken 04:55:54 INFO - operating with platform_type : linux_ 04:55:54 INFO - Initialising browser for kraken test... 04:55:54 INFO - TEST-INFO | started process 17830 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYjmkFW/profile http://localhost:54309/getInfo.html) 04:55:59 INFO - PROCESS | 17830 | __metrics Screen width/height:1600/1200 04:55:59 INFO - PROCESS | 17830 | colorDepth:24 04:55:59 INFO - PROCESS | 17830 | Browser inner width/height: 1024/697 04:55:59 INFO - PROCESS | 17830 | __metrics 04:55:59 INFO - PROCESS | 17830 | 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" 04:55:59 INFO - PROCESS | 17830 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:56:00 INFO - PROCESS | 17830 | console.error: PushService: 04:56:00 INFO - PROCESS | 17830 | stateChangeProcessEnqueue: Error transitioning state 04:56:00 INFO - PROCESS | 17830 | UnknownError 04:56:00 INFO - TEST-INFO | 17830: exit 0 04:56:00 INFO - Browser initialized. 04:56:00 INFO - Running cycle 1/1 for kraken test... 04:56:00 INFO - TEST-INFO | started process 17910 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYjmkFW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:13 INFO - PROCESS | 17910 | RSS: Main: 174358528 04:56:13 INFO - PROCESS | 17910 | 04:56:15 INFO - PROCESS | 17910 | Cycle 1(1): loaded http://localhost:54309/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54309/tests/kraken/driver.html?testName=audio-beat-detection) 04:56:16 INFO - PROCESS | 17910 | RSS: Main: 233496576 04:56:16 INFO - PROCESS | 17910 | 04:56:19 INFO - PROCESS | 17910 | Cycle 1(1): loaded http://localhost:54309/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54309/tests/kraken/driver.html?testName=audio-dft) 04:56:20 INFO - PROCESS | 17910 | RSS: Main: 218488832 04:56:20 INFO - PROCESS | 17910 | 04:56:23 INFO - PROCESS | 17910 | Cycle 1(1): loaded http://localhost:54309/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54309/tests/kraken/driver.html?testName=audio-fft) 04:56:23 INFO - PROCESS | 17910 | RSS: Main: 300564480 04:56:23 INFO - PROCESS | 17910 | 04:56:26 INFO - PROCESS | 17910 | Cycle 1(1): loaded http://localhost:54309/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54309/tests/kraken/driver.html?testName=audio-oscillator) 04:56:26 INFO - PROCESS | 17910 | RSS: Main: 209649664 04:56:26 INFO - PROCESS | 17910 | 04:56:28 INFO - PROCESS | 17910 | Cycle 1(1): loaded http://localhost:54309/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54309/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:56:29 INFO - PROCESS | 17910 | RSS: Main: 213184512 04:56:29 INFO - PROCESS | 17910 | 04:56:32 INFO - PROCESS | 17910 | Cycle 1(1): loaded http://localhost:54309/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54309/tests/kraken/driver.html?testName=imaging-darkroom) 04:56:33 INFO - PROCESS | 17910 | RSS: Main: 250306560 04:56:33 INFO - PROCESS | 17910 | 04:56:36 INFO - PROCESS | 17910 | Cycle 1(1): loaded http://localhost:54309/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54309/tests/kraken/driver.html?testName=imaging-desaturate) 04:56:37 INFO - PROCESS | 17910 | RSS: Main: 249401344 04:56:37 INFO - PROCESS | 17910 | 04:56:40 INFO - PROCESS | 17910 | Cycle 1(1): loaded http://localhost:54309/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54309/tests/kraken/driver.html?testName=json-parse-financial) 04:56:40 INFO - PROCESS | 17910 | RSS: Main: 248803328 04:56:40 INFO - PROCESS | 17910 | 04:56:42 INFO - PROCESS | 17910 | Cycle 1(1): loaded http://localhost:54309/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54309/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:56:43 INFO - PROCESS | 17910 | RSS: Main: 211120128 04:56:43 INFO - PROCESS | 17910 | 04:56:45 INFO - PROCESS | 17910 | Cycle 1(1): loaded http://localhost:54309/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54309/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:56:45 INFO - PROCESS | 17910 | RSS: Main: 218869760 04:56:45 INFO - PROCESS | 17910 | 04:56:47 INFO - PROCESS | 17910 | Cycle 1(1): loaded http://localhost:54309/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54309/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:56:48 INFO - PROCESS | 17910 | RSS: Main: 222593024 04:56:48 INFO - PROCESS | 17910 | 04:56:51 INFO - PROCESS | 17910 | Cycle 1(1): loaded http://localhost:54309/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54309/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:56:52 INFO - PROCESS | 17910 | RSS: Main: 223776768 04:56:52 INFO - PROCESS | 17910 | 04:56:55 INFO - PROCESS | 17910 | Cycle 1(1): loaded http://localhost:54309/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54309/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:56:55 INFO - PROCESS | 17910 | RSS: Main: 222113792 04:56:55 INFO - PROCESS | 17910 | 04:56:57 INFO - PROCESS | 17910 | Cycle 1(1): loaded http://localhost:54309/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54309/tests/kraken/driver.html?testName=ai-astar) 04:56:57 INFO - PROCESS | 17910 | RSS: Main: 274108416 04:56:57 INFO - PROCESS | 17910 | 04:56:57 INFO - PROCESS | 17910 | __start_tp_report 04:56:57 INFO - PROCESS | 17910 | _x_x_mozilla_page_load 04:56:57 INFO - PROCESS | 17910 | _x_x_mozilla_page_load_details 04:56:57 INFO - PROCESS | 17910 | |i|pagename|runs| 04:56:57 INFO - PROCESS | 17910 | |0;ai-astar;113;115;115;113;114;115;115;114;115;113 04:56:57 INFO - PROCESS | 17910 | |1;audio-beat-detection;160;124;123;153;124;127;129;124;164;123 04:56:57 INFO - PROCESS | 17910 | |2;audio-dft;162;161;162;162;161;160;165;161;162;162 04:56:57 INFO - PROCESS | 17910 | |3;audio-fft;76;76;77;105;77;77;77;77;99;85 04:56:57 INFO - PROCESS | 17910 | |4;audio-oscillator;83;84;120;83;85;83;103;83;83;112 04:56:57 INFO - PROCESS | 17910 | |5;imaging-gaussian-blur;118;118;117;118;117;118;117;117;117;117 04:56:57 INFO - PROCESS | 17910 | |6;imaging-darkroom;147;147;147;146;147;147;147;148;146;146 04:56:57 INFO - PROCESS | 17910 | |7;imaging-desaturate;94;94;95;94;95;94;95;95;95;95 04:56:57 INFO - PROCESS | 17910 | |8;json-parse-financial;65;62;63;63;64;64;64;65;64;64 04:56:57 INFO - PROCESS | 17910 | |9;json-stringify-tinderbox;66;67;66;66;66;66;66;67;71;67 04:56:57 INFO - PROCESS | 17910 | |10;stanford-crypto-aes;85;84;83;83;83;83;85;83;84;84 04:56:57 INFO - PROCESS | 17910 | |11;stanford-crypto-ccm;146;140;136;136;140;134;137;134;189;137 04:56:57 INFO - PROCESS | 17910 | |12;stanford-crypto-pbkdf2;174;173;173;175;171;171;171;176;173;177 04:56:57 INFO - PROCESS | 17910 | |13;stanford-crypto-sha256-iterative;70;69;69;68;68;68;68;69;68;68 04:56:57 INFO - PROCESS | 17910 | __end_tp_report 04:56:57 INFO - PROCESS | 17910 | __start_cc_report 04:56:57 INFO - PROCESS | 17910 | _x_x_mozilla_cycle_collect,1926 04:56:57 INFO - PROCESS | 17910 | __end_cc_report 04:56:57 INFO - PROCESS | 17910 | __startTimestamp1474286217733__endTimestamp 04:56:57 INFO - PROCESS | 17910 | 04:56:57 INFO - PROCESS | 17910 | ------- Summary: start ------- 04:56:57 INFO - PROCESS | 17910 | Number of tests: 14 04:56:57 INFO - PROCESS | 17910 | 04:56:57 INFO - PROCESS | 17910 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.00 stddev:0.92 (0.8%) stddev-sans-first:0.87 04:56:57 INFO - PROCESS | 17910 | Values: 113.0 115.0 115.0 113.0 114.0 115.0 115.0 114.0 115.0 113.0 04:56:57 INFO - PROCESS | 17910 | 04:56:57 INFO - PROCESS | 17910 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:128.00 stddev:16.80 (13.1%) stddev-sans-first:15.22 04:56:57 INFO - PROCESS | 17910 | Values: 160.0 124.0 123.0 153.0 124.0 127.0 129.0 124.0 164.0 123.0 04:56:57 INFO - PROCESS | 17910 | 04:56:57 INFO - PROCESS | 17910 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.32 (0.8%) stddev-sans-first:1.39 04:56:57 INFO - PROCESS | 17910 | Values: 162.0 161.0 162.0 162.0 161.0 160.0 165.0 161.0 162.0 162.0 04:56:57 INFO - PROCESS | 17910 | 04:56:57 INFO - PROCESS | 17910 | [#3] audio-fft Cycles:10 Average:82.60 Median:77.00 stddev:10.65 (13.8%) stddev-sans-first:11.02 04:56:57 INFO - PROCESS | 17910 | Values: 76.0 76.0 77.0 105.0 77.0 77.0 77.0 77.0 99.0 85.0 04:56:57 INFO - PROCESS | 17910 | 04:56:57 INFO - PROCESS | 17910 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:83.00 stddev:14.23 (17.1%) stddev-sans-first:14.73 04:56:57 INFO - PROCESS | 17910 | Values: 83.0 84.0 120.0 83.0 85.0 83.0 103.0 83.0 83.0 112.0 04:56:57 INFO - PROCESS | 17910 | 04:56:57 INFO - PROCESS | 17910 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:56:57 INFO - PROCESS | 17910 | Values: 118.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 117.0 04:56:57 INFO - PROCESS | 17910 | 04:56:57 INFO - PROCESS | 17910 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 04:56:57 INFO - PROCESS | 17910 | Values: 147.0 147.0 147.0 146.0 147.0 147.0 147.0 148.0 146.0 146.0 04:56:57 INFO - PROCESS | 17910 | 04:56:57 INFO - PROCESS | 17910 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:56:57 INFO - PROCESS | 17910 | Values: 94.0 94.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 04:56:57 INFO - PROCESS | 17910 | 04:56:57 INFO - PROCESS | 17910 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 04:56:57 INFO - PROCESS | 17910 | Values: 65.0 62.0 63.0 63.0 64.0 64.0 64.0 65.0 64.0 64.0 04:56:57 INFO - PROCESS | 17910 | 04:56:57 INFO - PROCESS | 17910 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:66.50 stddev:1.55 (2.3%) stddev-sans-first:1.62 04:56:57 INFO - PROCESS | 17910 | Values: 66.0 67.0 66.0 66.0 66.0 66.0 66.0 67.0 71.0 67.0 04:56:57 INFO - PROCESS | 17910 | 04:56:57 INFO - PROCESS | 17910 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:0.82 (1.0%) stddev-sans-first:0.73 04:56:57 INFO - PROCESS | 17910 | Values: 85.0 84.0 83.0 83.0 83.0 83.0 85.0 83.0 84.0 84.0 04:56:57 INFO - PROCESS | 17910 | 04:56:57 INFO - PROCESS | 17910 | [#11] stanford-crypto-ccm Cycles:10 Average:142.90 Median:138.50 stddev:16.58 (12.0%) stddev-sans-first:17.55 04:56:57 INFO - PROCESS | 17910 | Values: 146.0 140.0 136.0 136.0 140.0 134.0 137.0 134.0 189.0 137.0 04:56:57 INFO - PROCESS | 17910 | 04:56:57 INFO - PROCESS | 17910 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:173.50 stddev:2.12 (1.2%) stddev-sans-first:2.24 04:56:57 INFO - PROCESS | 17910 | Values: 174.0 173.0 173.0 175.0 171.0 171.0 171.0 176.0 173.0 177.0 04:56:57 INFO - PROCESS | 17910 | 04:56:57 INFO - PROCESS | 17910 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:0.71 (1.0%) stddev-sans-first:0.50 04:56:57 INFO - PROCESS | 17910 | Values: 70.0 69.0 69.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 04:56:57 INFO - PROCESS | 17910 | -------- Summary: end -------- 04:56:57 INFO - PROCESS | 17910 | 04:56:58 INFO - TEST-INFO | 17910: exit 0 04:56:58 INFO - TEST-OK | kraken | took 64501ms 04:56:58 INFO - SUITE-END | took 1185s 04:56:59 INFO - Completed test suite (00:19:46) 04:56:59 INFO - javascript benchmark 04:56:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2590.2876708905055, 2610.569256072748, 2640.2343320437076, 2646.9073582424608, 2658.9468210635787, 4565.223911934971, 4619.976900115495, 4717.481235601574, 4779.569838714515, 4842.273658951159, 4631.513691062441, 4686.367340409044, 4693.976530117353, 4733.857984260478, 4740.620750339973, 4285.849995250167, 4292.65658747301, 4294.162638285536, 4305.332673435622, 4359.084592235635, 4389.934150987738, 4390.626796722282, 4414.955850441503, 4426.601605855472, 4475.082608065339, 4269.231538323101, 4313.805878735465, 4394.846180383671, 4473.932891006638, 4496.505384407713, 4337.457817772778, 4349.26062569364, 4374.58441448062, 4379.233634114017, 4470.977645111786, 4354.020345422255, 4364.629006534448, 4374.956250437487, 4376.518582955872, 4421.226285400042, 4753.572178503951, 4756.215224487955, 4790.209615413452, 4793.424789025305, 4851.733154676492, 4925.236588328815, 4958.851234462972, 4969.950300496985, 5008.84973450797, 5011.273365362002, 5035.320231768737, 5047.066292735855, 5053.974730126362, 5057.519535644108, 5101.770420331057, 4683.250679891235, 4685.437747470257, 4689.718616882998, 4733.976330118362, 4750.097481478508, 5045.9747701261995, 5104.081265372269, 5104.719240441737, 5135.666181698178, 5193.7403129844115, 4914.70511769295, 4961.776720047606, 4967.180415231519, 4968.925466118011, 4973.154563724175, 5068.543831055223, 5118.053160165381, 5118.462561431071, 5147.485251474897, 5207.3230480037355, 5039.521245481674, 5074.264231686385, 5088.720120393414, 5094.129579694743, 5124.948750512447, 4844.079624871263, 5076.0863044652315, 5086.3133476980875, 5087.008033433445, 5090.796368145307, 4241.681873859473, 4265.232258193493, 4292.5063617683745, 4297.076128632359, 4303.397524346594, 3742.9625703742613, 3744.981275093607, 3755.8122093895195, 3788.052986753312, 3797.2025874566098, 4365.432493775789, 4369.3664418659755, 4378.890527736832, 4416.381706561084, 4423.734575925455, 4898.387701537308, 4912.091263116335, 4984.651074424755, 5058.4435712071645, 5093.694378337312, 4384.912301753947, 4388.385626012361, 4425.911481770347, 4429.756363400044, 4440.067585807016, 4566.13243483737, 4576.244919588297, 4576.633869290449, 4580.564846339593, 4631.536846315342, 4686.554777296152, 4748.382710247645, 4753.358296629911, 4778.378810754649, 4784.808607655655, 5069.5944324454695, 5116.1046816806165, 5124.718140502308, 5157.020166168416, 5183.740812959261, 4791.0, 4812.735299558558, 4812.783424745965, 4830.420349557935, 4892.975535122301, 4933.679310844784, 4988.201887697951, 5030.220315851049, 5043.193089105725, 5109.540141387293, 4954.554090131761, 5001.524855138756, 5005.824796132118, 5017.096922553976, 5082.669626474268, 4865.683730557503, 4873.4882837301575, 4877.561019508261, 4879.926416188433, 4940.530649588283, 4779.283107533759, 4832.081904438145, 4841.661083724246, 4844.4186697596515, 4901.803927842846, 4713.9057218856115, 4767.284907263799, 4811.109944660249, 4815.3258543803195, 4907.484714104968, 5025.0, 5036.143855544493, 5042.798288068583, 5043.2687260347775, 5058.645894787477, 4757.3577567028005, 4770.308305295644, 4800.66395352322, 4893.388326459192, 4928.728919909296], "value": 4646.033788666177, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.3813329071438, 566.7534622439237, 569.4760820045558, 581.6190395291086, 583.3903570768547, 27260.863695681517, 38443.80778096109, 38684.22631547367, 38909.22181556367, 43475.3478697819, 41255.0, 41629.167416651726, 41663.58336416635, 41742.791286043604, 41781.7910910445, 7628.427867909902, 7770.4560680752365, 7772.922270777276, 7778.0, 7781.416393770462, 7441.516301440389, 7521.135069466999, 7531.472796904219, 7539.132999705049, 7539.736109236178, 7548.924510754905, 7592.772216833504, 7604.695812167507, 7624.809379765495, 7625.351845093173, 7528.623568821565, 7531.5481071135355, 7546.132194797614, 7553.206913274082, 7561.168271490159, 7453.962730186368, 7506.699732010713, 7525.059367579052, 7530.77407677765, 7533.585652789095, 37478.25043499142, 37841.0, 37850.81074594637, 37893.81053094744, 37999.24001519954, 2905.7094290570985, 2979.8808047678067, 3032.3935212957495, 3129.186411532995, 3328.8169150696704, 27620.44759104827, 27625.0, 27741.722582774117, 27863.721362786317, 28896.422071558452, 3091.1035799618085, 3152.290734584723, 3166.936661266785, 3207.1821685470054, 3217.935641287161, 240192.0, 240505.0, 241359.79320103463, 241483.0, 241760.0, 53078.0, 53266.7336663322, 53423.46576534185, 53425.794452332986, 53448.465515344345, 28661.14016579506, 29080.0, 29122.563161552593, 29194.708052919625, 29239.707602924125, 15086.622834429227, 15227.695446091016, 15253.38986440552, 15254.847451525564, 15279.618009549627, 11570.76858462843, 11595.478203480694, 11607.825882611767, 11656.825147622792, 11658.591949281905, 18177.545561360806, 18183.63632727338, 18184.36354727578, 18196.90901545484, 18274.725879111826, 6516.077757061678, 6576.473882089422, 6576.934230657728, 6594.415046158819, 6708.731650733916, 749.5277974875794, 764.5489161394804, 888.1917455115813, 906.9682561110329, 973.255459573427, 24338.391540211636, 28262.71737282642, 28644.570331445044, 28820.135395938156, 28828.279293017844, 758.6396461680657, 889.909860420992, 908.3096846396786, 913.7989642278689, 939.6992962252014, 14266.286685665675, 14420.927895360455, 14543.127412355081, 14571.125732456087, 14773.18747468878, 373993.0, 377080.0, 377140.0, 377219.0, 378203.0, 48962.75518622384, 49486.0, 49555.75222123866, 49564.0, 49611.751941240065, 1047.261680515235, 1079.63292480557, 1082.0640146273574, 1121.0975164992096, 1158.80879654856, 27444.0, 28844.278893027844, 29420.248628847785, 29450.0, 29993.70006299909, 41206.587934120274, 41761.0, 41899.0, 41915.580844191165, 41953.580464194965, 315708.0, 319854.0, 319863.0, 320110.0, 320938.0, 37273.25453490969, 37496.0, 38228.23543529058, 38479.807600961816, 41444.79277603592, 41630.79184604058, 41864.790676046425, 41899.7905010473, 41993.0, 42299.365509518, 35574.28851423009, 36036.4594531077, 36273.27453450864, 36401.27197456089, 36562.0, 36051.0, 36070.27859442849, 36345.636543634224, 36625.45061824022, 36756.0, 35271.29457410786, 35359.64640353563, 36193.095172620895, 36319.27361452703, 36582.63417365792, 30345.696543034286, 32197.356052878342, 32339.19152021218, 32672.34655306928, 32787.0, 24656.698809755988, 24861.87569062143, 25130.24609261725, 25135.74864251407, 25629.743702562737], "value": 17148.629993893475, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.9227969846633, 362.3278817792994, 370.374067825375, 370.6127097183443, 390.32278995942033, 11873.52505899764, 12744.80882786759, 13797.448102075918, 15750.448734294301, 16484.0, 15939.920300398511, 16005.599860003505, 16201.10893900835, 16203.83796162038, 16355.182240887967, 4898.24077268024, 5085.0, 5314.548263397616, 5343.625946183769, 5437.510624043835, 3375.8818441354556, 5325.4940780625775, 5326.813561525348, 5352.357717073937, 5352.437994010631, 3530.6292839251896, 3589.6589823966683, 3759.398496240602, 5801.158831969362, 5881.970590147043, 5716.1711551825165, 5871.55963302754, 5892.793752218695, 5912.231409916726, 5915.201447804534, 5204.141316682742, 5245.160774276097, 5262.289590905217, 5263.078961181778, 5267.130923397634, 11943.641690749291, 12049.401852072711, 12110.81833772494, 19643.508912277164, 19890.70163947542, 1697.176869218428, 1779.5284249673846, 1784.4914199453094, 1792.9103544822838, 1868.6636405447014, 8539.018012928469, 9006.954965225132, 9192.080791920822, 9429.528523573794, 9436.764080897963, 1622.399712106528, 1635.852773250413, 1651.4962936304423, 1667.5664327274874, 1683.9747403788954, 67106.0, 69097.0, 69597.0, 70640.29359706388, 71693.28306716918, 9740.805183896282, 9884.0, 9969.152622027064, 9981.0, 10042.297039207331, 13277.614208376803, 13296.601101966957, 13299.867001330056, 13313.068085233941, 13371.866281337258, 7165.547508039395, 7220.3140701633265, 7244.851054996181, 7389.445791565654, 7390.889136662954, 6793.558418702769, 6846.691898864563, 7008.964955175192, 7026.367626913602, 7032.964835175791, 4117.711760176759, 4158.584141585818, 4166.33338665812, 4180.372944058355, 4253.340732186516, 1757.8593712502968, 1794.6321004194108, 1816.827401396865, 1829.5334689654053, 1831.7343985122084, 766.8619648463218, 813.6419975210888, 824.4599787139433, 831.4512421801581, 835.807764214222, 15571.143587102819, 16069.196540172945, 16249.350025999063, 16416.0, 17032.914835425745, 792.9722459713882, 817.0717107625998, 823.3660081737148, 843.2874221283006, 855.3328403845011, 7979.760607181794, 9182.449053056838, 9374.343795934356, 9383.202427793578, 9570.856437153308, 351012.0, 353413.0, 361401.0, 361942.0, 362554.0, 76609.0, 77694.611526942, 78340.60829695815, 78838.81741773878, 79262.6036869812, 846.9576521173917, 867.947923124602, 868.5830801215326, 869.9173578510031, 870.2254993056185, 14367.784483232968, 14442.638934026734, 14517.346719397441, 14549.345279462661, 15243.390264389744, 36075.0, 36385.818070909474, 36460.635393646786, 36650.26699466049, 37548.62451375451, 49451.50548494469, 49548.75225623849, 50134.0, 51824.74087629538, 52855.73572132115, 7496.700131994659, 7524.247575242432, 7626.313631773167, 7749.457537972288, 7789.415793815373, 9684.56419461112, 11102.0, 11864.288142711464, 11937.46281417321, 12162.209456385306, 10036.94981525117, 10048.497575121068, 10057.647982320585, 10086.8486972694, 10523.05292523646, 9791.902080979098, 10008.58849142153, 10062.547185376528, 10341.689749307532, 10411.375317480975, 10108.292419530562, 10131.64539241123, 10463.529141188512, 10529.842052369373, 10718.464076795974, 7545.6981720730555, 7575.886361704469, 7585.734499292498, 7653.387728981556, 8040.517568945882, 7588.772336829904, 8886.644534218558, 9708.368956017835, 10259.076683098558, 10723.89276107229], "value": 7882.074061302286, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1246.4515613130216, 1359.4494229836916, 1397.3572156807868, 1451.5282533176714, 1669.666066786643, 6689.69896354664, 7459.142198647157, 7710.575918324483, 7750.4187185961, 7944.404169687267, 7774.0, 7821.960890195555, 7835.0, 7836.608169591526, 7851.960740196305, 2193.1775584155903, 2196.6265734825038, 2205.614017546931, 2208.1719355241785, 2213.457702862801, 2107.399391173516, 2161.729783777028, 2166.9891650541726, 2169.8915054247223, 2172.3374370816896, 2141.2077531313357, 2141.5609799991043, 2148.32327816738, 2148.881811500367, 2202.570498752744, 2118.904649290778, 2123.522207503307, 2127.6489379252403, 2129.158982202037, 2133.146741303491, 2087.185997460976, 2145.002573803189, 2145.3992881993067, 2148.0, 2153.6554151335868, 7536.4724469287175, 7821.335186509154, 7867.803304917423, 7876.73972164451, 7894.763157105296, 4396.0, 4543.840965566189, 4565.817367305303, 4567.817287308504, 4578.427696537933, 2726.61827344172, 2831.830090194595, 2868.8565571721538, 2871.1530098620956, 2871.3826527296524, 886.6586364249746, 888.8800011998427, 895.6104094718818, 900.6352427266968, 905.8414777413926, 10585.629502967358, 10611.628592999208, 10654.09440197584, 10666.14670826332, 10730.839037414367, 3790.2419516096893, 3958.5249770027203, 4063.0858056936954, 4088.9591104088577, 4193.7693426861815, 8327.167283271625, 8350.373721970876, 8369.0, 8377.413581049268, 8397.790055248546, 4459.576340247671, 4496.797644106023, 4505.594496495331, 4510.120526497301, 4512.729236245836, 3643.908902277464, 3754.6057663944894, 4037.0, 4194.727342722713, 4196.559361267023, 3301.752368572367, 3331.883384081594, 3438.2951494943477, 3453.568303962005, 3490.144914495914, 1032.390889375257, 1049.1030169205371, 1053.910417614496, 1064.4784055812752, 1070.973225669349, 750.0923882102608, 761.3186198352444, 776.5069181069948, 780.5706861226303, 793.2266040610359, 5006.574441172468, 5085.74571271435, 5215.7913683453, 5279.788808447696, 5651.858703532363, 764.2663043478323, 772.1005029140988, 780.5901901501644, 856.2507805670039, 856.5931182688298, 3105.5186446100893, 3167.55654208411, 3184.1402821238134, 3193.8722451101694, 3202.5516427699677, 9144.63421463134, 9696.127348538665, 9795.02049795029, 9797.559109840075, 9841.212702983745, 9736.9026309736, 9742.707718768448, 9757.170640495495, 9769.804603907882, 9780.706578802647, 6896.4827637926355, 7142.035825163641, 7161.570305781774, 7183.8563228736175, 7231.385332246818, 4850.6119510438375, 4869.123557759637, 4903.166461701448, 4913.43495498008, 4931.556159945622, 8656.43733157368, 8758.12418758119, 8786.560671966248, 8858.247049000907, 8897.243734282658, 8894.665800129773, 8930.01769805308, 9082.273418126666, 9083.18251357381, 9212.078792120734, 5314.3091398117995, 5471.50756431923, 5975.850603734942, 6109.69451527413, 6145.139680444652, 7010.404115650227, 7233.782986510413, 7252.963735181291, 7506.28690274423, 7525.247475252431, 6267.5299352549655, 6405.19935008124, 6463.353664633499, 6483.7730679425995, 6559.7376104955265, 6535.2811190768025, 6535.673216339259, 6628.602283862983, 6632.403083722488, 6649.135612370361, 5680.375158732619, 5776.480116789509, 5777.133429985368, 5779.219805326227, 5782.306123265235, 4274.294741367639, 4304.139172165516, 4339.544347843431, 4401.823927042882, 4426.336049592587, 4209.473815773028, 4347.3261644445165, 4379.627731642719, 4407.074514352022, 4440.378347031483], "value": 3988.61731155668, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.92749776304805, 298.48511317976494, 302.1223346179348, 302.3031911444121, 302.98333591652477, 4835.709857408554, 4865.270209468586, 4882.951170488294, 4887.413510378755, 4891.559759621633, 4546.840555658311, 4811.412233962793, 4830.710157390559, 4831.420229572447, 4913.606911447085, 3703.333399988001, 3725.105974566105, 3804.6956243500454, 3814.9618503815022, 3819.2934307153128, 3792.374258247386, 3794.392897136459, 3798.753081049737, 3799.3920972644382, 3801.1257410795533, 3555.7510974231814, 3764.5106136202257, 3774.3017541754725, 3775.490308808317, 3776.811159442017, 3691.2617476504674, 3710.83301251443, 3745.7190710696536, 3771.509703738524, 3777.660010599059, 3321.5848018997626, 3329.4839299908554, 3336.899893003214, 3337.1990722226733, 3345.1971526833627, 4651.279051746985, 4659.439087905555, 4661.603763680057, 4692.624590032823, 4698.600618947394, 4166.229247589175, 4248.553901840293, 4266.6586673066395, 4278.336857787048, 4284.121755040241, 4965.82619608312, 4995.875103122451, 5013.1227035268685, 5016.924746128811, 5017.613111149995, 3635.4546817977252, 3637.7089832813313, 3645.143391303042, 3645.453182022718, 3665.8350374233223, 5029.798808047673, 5234.371875374942, 5249.790008399659, 5283.313169288006, 5290.761915713802, 3737.7757334560015, 3742.962570374316, 3748.9062773430883, 3750.2124553843996, 3753.7184711146774, 3758.0, 3759.774413535197, 3783.5459744830246, 3787.867424640124, 3815.9236815264094, 4257.169851878916, 4269.5910349584565, 4276.422682937826, 4283.250431174532, 4293.763842988603, 4742.383490146259, 5042.268871013683, 5044.646874718808, 5080.669756465818, 5084.237364395371, 1283.4481173095471, 1287.575100216926, 1288.6198571421453, 1292.7737645911927, 1293.644247831835, 806.9031716194095, 810.2424233341844, 821.7919658102579, 827.4786884262996, 838.9580520973927, 4299.624120281543, 4335.479742430928, 4348.195583817004, 4438.312061630452, 4485.394471746337, 5234.555062819703, 5248.580113590903, 5252.868678283074, 5257.658252213594, 5264.473552644705, 4373.628241599499, 4498.910021799546, 4500.549945005473, 4504.481984571817, 4520.214515266452, 2729.2085295264546, 2738.835669859815, 2768.809411952839, 2772.6672799263815, 2777.6250206222307, 4886.975565122151, 4911.607071434277, 4918.606511479073, 4924.9507504925205, 5020.899582008413, 5076.238564215398, 5333.280007199056, 5341.305630268041, 5342.358916929993, 5359.490848369399, 4955.851324460272, 4959.256111583291, 4966.652334336562, 4970.17992031318, 4972.179590367621, 5228.947710522998, 5234.2933703949475, 5235.921461178009, 5271.65734227274, 5309.57523398135, 4802.615790736662, 5064.0756512525, 5099.898002039864, 5129.589632829439, 5150.278960945546, 4869.780859861386, 4872.829450969199, 4883.340748998839, 4888.828890988798, 4899.167141585867, 3657.3233951719017, 3665.193657395369, 3670.4861319415836, 3670.5778835434267, 3717.3308804415465, 4902.313676085279, 5158.509941555546, 5186.688798672092, 5191.091558977088, 5196.32447781786, 5044.495550444926, 5060.772265248146, 5072.0, 5091.389033316026, 5099.464556221692, 5075.416327122281, 5101.974490127525, 5107.157319042316, 5109.795608175631, 5209.557187638941, 4807.206810876166, 4883.462819089827, 4919.827806026772, 4949.109160351171, 4960.23116416956, 4911.410630724193, 4980.352554167935, 5061.595072394273, 5131.717755523482, 5139.460356662496, 4986.601071914166, 4999.15014447552, 5005.8748531285555, 5007.449180590205, 5015.523525265094], "value": 3810.1428580560964, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.3620409814371, 572.2360648534207, 593.525179856115, 631.819931319574, 638.3967151042267, 12620.36898155092, 13741.725165496684, 13752.724945501097, 13764.449422023119, 14105.57683269501, 14535.200563968978, 14605.707885842277, 14670.413183472674, 14705.926470367633, 14742.705145897076, 741.9183889772121, 771.6064806948468, 773.8800485924662, 777.4052849570083, 777.4130531448749, 604.2899592978255, 615.0712424239387, 744.4342299852098, 771.9035120609924, 778.3150827271993, 807.019471342319, 813.0284310249255, 813.5078277642031, 813.7436707437139, 813.8535063688533, 792.4611264340247, 800.8358286551243, 801.4550105927966, 801.7274126796888, 801.7634797734682, 467.8994016286481, 474.8717846181546, 570.3697414357158, 593.7624950020027, 593.9910901336483, 12362.0, 12973.0, 13074.738505229938, 13087.607371778862, 13138.671533211651, 11429.828552571718, 11555.94222028893, 11556.884431155664, 11559.53761849525, 11782.646520604396, 10005.949970250102, 10028.498575071217, 10176.135028522585, 10186.643467478676, 10238.89761102387, 3132.6867313268717, 3157.5737275467745, 3172.841357932094, 3211.6467188609236, 3243.2864769750618, 72065.2793472069, 72641.27358726451, 72989.0, 73082.26917730807, 73790.0, 8665.263452606472, 8686.913130868737, 8856.512891791013, 8983.0, 9461.24310055194, 16199.190040497928, 16795.0, 18884.43346699601, 18986.81013189878, 19051.333203337817, 6619.3380661933425, 6652.101966234496, 6695.698693558801, 6704.597724136567, 6708.295628958889, 3522.788632682047, 3551.8224088795455, 3580.3018411410044, 3596.6583174598372, 3704.0924973381693, 2861.7424431800823, 2953.3354995126356, 2971.881124755029, 2975.910722678323, 2976.1666733314705, 489.5471688687949, 496.18873142411695, 500.6770632941732, 506.45808984386355, 511.15404006369516, 410.17554715023016, 465.2114665641772, 476.1072988147224, 482.10088185533726, 492.29601669612083, 6594.901076483857, 6867.965660171667, 6945.444364450832, 7006.229314775371, 7214.206437291894, 468.29989166196754, 474.1134079271784, 486.3221884498494, 494.1845954175639, 500.5795132089063, 3330.1508115430893, 3358.9496157557655, 3367.3602015616952, 3425.880094196691, 3469.150058235698, 104730.0, 105579.0, 106116.0, 108116.35069194603, 111984.4400777991, 93098.0, 93642.0, 93707.0, 93945.0, 94962.52518737363, 79126.0, 80687.0, 82894.0, 84404.57797711095, 84525.57737211397, 6673.9666301668185, 7332.5967071811565, 7568.0, 7592.734254301073, 8038.678452862054, 37558.362608066716, 42843.357349639155, 43652.345214821165, 43934.62947872477, 45558.08883822371, 59830.70084649549, 59841.401585983585, 61408.385916140265, 62050.0, 62426.37573624206, 9557.569909353957, 9915.603375865174, 9949.850752238577, 10122.240831937781, 10258.640947566799, 10955.726106847393, 11157.553697851996, 11580.826287605523, 11777.234479758788, 12120.878791211975, 10333.689989300334, 10515.737106572396, 10745.677629671123, 10877.891221088004, 11280.0, 10235.078842904175, 10309.123724483203, 10431.269811113149, 10450.059494645518, 10490.632827851294, 10139.2395570334, 10300.845487317845, 10457.581696732046, 10782.353058816496, 11412.600558980395, 8732.0, 8734.257588105082, 8792.560371981503, 8937.508437036025, 9202.677906273248, 8436.409451338593, 8834.514101724468, 8916.420432671855, 8922.152395522415, 9374.281458376994], "value": 6237.158619470965, "unit": "score"}], "name": "dromaeo_css", "value": 6248.7336947878275, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 115.0, 113.0, 114.0, 115.0, 115.0, 114.0, 115.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 124.0, 123.0, 153.0, 124.0, 127.0, 129.0, 124.0, 164.0, 123.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 161.0, 160.0, 165.0, 161.0, 162.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 105.0, 77.0, 77.0, 77.0, 77.0, 99.0, 85.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 120.0, 83.0, 85.0, 83.0, 103.0, 83.0, 83.0, 112.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 148.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 63.0, 63.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 71.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 83.0, 83.0, 83.0, 83.0, 85.0, 83.0, 84.0, 84.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 140.0, 136.0, 136.0, 140.0, 134.0, 137.0, 134.0, 189.0, 137.0], "value": 142.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 173.0, 175.0, 171.0, 171.0, 171.0, 176.0, 173.0, 177.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1543.5000000000002, "alertThreshold": 2.0}]} 04:56:59 INFO - Return code: 0 04:56:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:56:59 INFO - # TBPL SUCCESS # 04:56:59 INFO - Running post-action listener: _resource_record_post_action 04:56:59 INFO - [mozharness: 2016-09-19 11:56:59.563521Z] Finished run-tests step (success) 04:56:59 INFO - Running post-run listener: _resource_record_post_run 04:56:59 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394199040; Read time: 12; Write time: 208756 04:56:59 INFO - TinderboxPrint: CPU usage
13.1% 04:56:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:56:59 INFO - TinderboxPrint: I/O write bytes / time
394,199,040 / 208,756 04:56:59 INFO - TinderboxPrint: CPU idle
8,343.9 (86.9%) 04:56:59 INFO - TinderboxPrint: CPU user
1,201.8 (12.5%) 04:56:59 INFO - TinderboxPrint: Swap in / out
0 / 0 04:56:59 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 101257216; Read time: 0; Write time: 67048 04:56:59 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 292941824; Read time: 0; Write time: 141708 04:57:00 INFO - Running post-run listener: _upload_blobber_files 04:57:00 INFO - Blob upload gear active. 04:57:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:57:00 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 04:57:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:57:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:57:00 INFO - (blobuploader) - INFO - Open directory for files ... 04:57:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:57:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:57:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:01 INFO - (blobuploader) - INFO - Done attempting. 04:57:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:57:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:57:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:02 INFO - (blobuploader) - INFO - Done attempting. 04:57:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:57:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:57:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:07 INFO - (blobuploader) - INFO - Done attempting. 04:57:07 INFO - (blobuploader) - INFO - Iteration through files over. 04:57:07 INFO - Return code: 0 04:57:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:57:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:57:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc9ebff276bac7dd3b65a9419b3f6ceead85749e01c681b1bf718ed3137610a6583b412408960d92d6fba8a28c25fef23757df27a689900fe1e269e424aefd1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7e290ef26ed44815908bf564d47498af39fd948c46fcc857fe47134e227f2cb91465eecbf5c890afe2e9dee30dbdd29c0c6bdbe38dda3ffd69f38e271298d033", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b70630f3fe8d18c150e0b0ffe826478116ecc3f0f5d50897aa80efaceaaaf028c174864c35ded8a2adb82d1cec96dfd4cb6aad60231fb3f02e3fb901bed6d2f2"} 04:57:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:57:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:57:07 INFO - Contents: 04:57:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc9ebff276bac7dd3b65a9419b3f6ceead85749e01c681b1bf718ed3137610a6583b412408960d92d6fba8a28c25fef23757df27a689900fe1e269e424aefd1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7e290ef26ed44815908bf564d47498af39fd948c46fcc857fe47134e227f2cb91465eecbf5c890afe2e9dee30dbdd29c0c6bdbe38dda3ffd69f38e271298d033", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b70630f3fe8d18c150e0b0ffe826478116ecc3f0f5d50897aa80efaceaaaf028c174864c35ded8a2adb82d1cec96dfd4cb6aad60231fb3f02e3fb901bed6d2f2"} 04:57:07 INFO - Running post-run listener: copy_logs_to_upload_dir 04:57:07 INFO - Copying logs to upload dir... 04:57:07 INFO - mkdir: /builds/slave/test/build/upload/logs 04:57:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.061701 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-19 04:57:07.100452) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-19 04:57:07.104223) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc9ebff276bac7dd3b65a9419b3f6ceead85749e01c681b1bf718ed3137610a6583b412408960d92d6fba8a28c25fef23757df27a689900fe1e269e424aefd1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7e290ef26ed44815908bf564d47498af39fd948c46fcc857fe47134e227f2cb91465eecbf5c890afe2e9dee30dbdd29c0c6bdbe38dda3ffd69f38e271298d033", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b70630f3fe8d18c150e0b0ffe826478116ecc3f0f5d50897aa80efaceaaaf028c174864c35ded8a2adb82d1cec96dfd4cb6aad60231fb3f02e3fb901bed6d2f2"} build_url:https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011277 build_url: 'https://queue.taskcluster.net/v1/task/LRUQQHkoTu6KPl6qIT0uFA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bc9ebff276bac7dd3b65a9419b3f6ceead85749e01c681b1bf718ed3137610a6583b412408960d92d6fba8a28c25fef23757df27a689900fe1e269e424aefd1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7e290ef26ed44815908bf564d47498af39fd948c46fcc857fe47134e227f2cb91465eecbf5c890afe2e9dee30dbdd29c0c6bdbe38dda3ffd69f38e271298d033", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b70630f3fe8d18c150e0b0ffe826478116ecc3f0f5d50897aa80efaceaaaf028c174864c35ded8a2adb82d1cec96dfd4cb6aad60231fb3f02e3fb901bed6d2f2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-19 04:57:07.129891) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 04:57:07.130218) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1474284977.952159-1895987580 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004366 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 04:57:07.212636) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-19 04:57:07.213048) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-19 04:57:07.213647) ========= ========= Total master_lag: 0.17 =========