builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-029 starttime: 1474450029.43 results: success (0) buildid: 20160921003000 builduid: 045e51c603e54c44b45d969a13d6e250 revision: 6fb92ddf485702778367f7217caaa216d8639ac3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 02:27:09.433291) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 02:27:09.434509) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 02:27:09.434852) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 02:27:09.482674) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 02:27:09.483007) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-21 02:27:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-09-21 02:27:09 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084748 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 02:27:09.582626) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 02:27:09.582968) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016219 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 02:27:09.634061) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 02:27:09.634445) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6fb92ddf485702778367f7217caaa216d8639ac3 --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 6fb92ddf485702778367f7217caaa216d8639ac3 --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=9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-21 02:27:09,966 truncating revision to first 12 chars 2016-09-21 02:27:09,966 Setting DEBUG logging. 2016-09-21 02:27:09,966 attempt 1/10 2016-09-21 02:27:09,966 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6fb92ddf4857?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-21 02:27:10,286 unpacking tar archive at: fx-team-6fb92ddf4857/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643712 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 02:27:10.292780) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 02:27:10.293095) ========= script_repo_revision: 6fb92ddf485702778367f7217caaa216d8639ac3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 02:27:10.293509) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 02:27:10.293831) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 02:27:10.305153) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-09-21 02:27:10.305614) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:27:10 INFO - MultiFileLogger online at 20160921 02:27:10 in /builds/slave/test 02:27:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:27:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:27:10 INFO - {'append_to_log': False, 02:27:10 INFO - 'base_work_dir': '/builds/slave/test', 02:27:10 INFO - 'blob_upload_branch': 'Fx-Team', 02:27:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:27:10 INFO - 'branch': 'Fx-Team', 02:27:10 INFO - 'buildbot_json_path': 'buildprops.json', 02:27:10 INFO - 'config_files': ('talos/linux_config.py',), 02:27:10 INFO - 'default_actions': ('clobber', 02:27:10 INFO - 'read-buildbot-config', 02:27:10 INFO - 'download-and-extract', 02:27:10 INFO - 'populate-webroot', 02:27:10 INFO - 'create-virtualenv', 02:27:10 INFO - 'install', 02:27:10 INFO - 'run-tests'), 02:27:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:27:10 INFO - 'download_minidump_stackwalk': True, 02:27:10 INFO - 'download_symbols': 'ondemand', 02:27:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:27:10 INFO - 'tooltool.py': '/tools/tooltool.py', 02:27:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:27:10 INFO - '/tools/misc-python/virtualenv.py')}, 02:27:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:27:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:27:10 INFO - 'installer_path': 'installer.exe', 02:27:10 INFO - 'log_level': 'info', 02:27:10 INFO - 'log_name': 'talos', 02:27:10 INFO - 'log_to_console': True, 02:27:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:27:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:27:10 INFO - 'opt_config_files': (), 02:27:10 INFO - 'pip_index': False, 02:27:10 INFO - 'sps_profile': False, 02:27:10 INFO - 'sps_profile_interval': 0, 02:27:10 INFO - 'suite': 'dromaeojs-e10s', 02:27:10 INFO - 'system_bits': '32', 02:27:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:27:10 INFO - 'title': 'talos-linux64-ix-029', 02:27:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:27:10 INFO - 'use_talos_json': True, 02:27:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:27:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:27:10 INFO - 'work_dir': 'build'} 02:27:10 INFO - [mozharness: 2016-09-21 09:27:10.722307Z] Running clobber step. 02:27:10 INFO - Running pre-action listener: _resource_record_pre_action 02:27:10 INFO - Running main action method: clobber 02:27:10 INFO - rmtree: /builds/slave/test/build 02:27:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:27:11 INFO - Running post-action listener: _resource_record_post_action 02:27:11 INFO - [mozharness: 2016-09-21 09:27:11.687116Z] Finished clobber step (success) 02:27:11 INFO - [mozharness: 2016-09-21 09:27:11.687215Z] Running read-buildbot-config step. 02:27:11 INFO - Running pre-action listener: _resource_record_pre_action 02:27:11 INFO - Running main action method: read_buildbot_config 02:27:11 INFO - Using buildbot properties: 02:27:11 INFO - { 02:27:11 INFO - "project": "", 02:27:11 INFO - "product": "firefox", 02:27:11 INFO - "script_repo_revision": "production", 02:27:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:27:11 INFO - "repository": "", 02:27:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 02:27:11 INFO - "buildid": "20160921003000", 02:27:11 INFO - "pgo_build": "True", 02:27:11 INFO - "basedir": "/builds/slave/test", 02:27:11 INFO - "buildnumber": 1187, 02:27:11 INFO - "slavename": "talos-linux64-ix-029", 02:27:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:27:11 INFO - "platform": "ubuntu64_hw", 02:27:11 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:27:11 INFO - "branch": "fx-team", 02:27:11 INFO - "repo_path": "integration/fx-team", 02:27:11 INFO - "revision": "6fb92ddf485702778367f7217caaa216d8639ac3", 02:27:11 INFO - "stage_platform": "linux64-pgo", 02:27:11 INFO - "builduid": "045e51c603e54c44b45d969a13d6e250", 02:27:11 INFO - "slavebuilddir": "test" 02:27:11 INFO - } 02:27:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 02:27:11 INFO - Running post-action listener: _resource_record_post_action 02:27:11 INFO - [mozharness: 2016-09-21 09:27:11.689642Z] Finished read-buildbot-config step (success) 02:27:11 INFO - [mozharness: 2016-09-21 09:27:11.689732Z] Running download-and-extract step. 02:27:11 INFO - Running pre-action listener: _resource_record_pre_action 02:27:11 INFO - Running main action method: download_and_extract 02:27:11 INFO - mkdir: /builds/slave/test/build/tests 02:27:11 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')]} 02:27:11 INFO - trying https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:27:11 INFO - Downloading https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:27:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:27:12 INFO - Downloaded 1361 bytes. 02:27:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:27:12 INFO - Using the following test package requirements: 02:27:12 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 02:27:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:27:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:27:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:27:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:27:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:27:12 INFO - u'jsshell-linux-x86_64.zip'], 02:27:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:27:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:27:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 02:27:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:27:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:27:12 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:27:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:27:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:27:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:27:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:27:12 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:27:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:27:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 02:27:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:27:12 INFO - Fetch https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:27:12 INFO - Expected file size: 21940519 02:27:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:27:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 02:27:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:27:17 INFO - Fetch https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:27:17 INFO - Expected file size: 21940519 02:27:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 02:27:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:27:22 INFO - Fetch https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 02:27:22 INFO - Expected file size: 14414059 02:27:23 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')]} 02:27:23 INFO - trying https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:27:23 INFO - Downloading https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:27:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:27:25 INFO - Downloaded 59580909 bytes. 02:27:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:27:25 INFO - mkdir: /builds/slave/test/properties 02:27:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:27:25 INFO - Writing to file /builds/slave/test/properties/build_url 02:27:25 INFO - Contents: 02:27:25 INFO - build_url:https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:27:26 INFO - Running post-action listener: _resource_record_post_action 02:27:26 INFO - Running post-action listener: set_extra_try_arguments 02:27:26 INFO - [mozharness: 2016-09-21 09:27:26.421163Z] Finished download-and-extract step (success) 02:27:26 INFO - [mozharness: 2016-09-21 09:27:26.421389Z] Running populate-webroot step. 02:27:26 INFO - Running pre-action listener: _resource_record_pre_action 02:27:26 INFO - Running main action method: populate_webroot 02:27:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:27:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:27:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:27:26 INFO - '--tppagecycles', 02:27:26 INFO - '7'], 02:27:26 INFO - 'tests': ['tsvgm']}}, 02:27:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:27:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:27:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:27:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:27:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:27:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:27:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:26 INFO - 'talos_options': ['--disable-e10s'], 02:27:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:27:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:27:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:26 INFO - 'talos_options': ['--disable-e10s'], 02:27:26 INFO - 'tests': ['damp', 'tps']}, 02:27:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:26 INFO - 'tests': ['damp', 'tps']}, 02:27:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:27:26 INFO - 'tests': ['dromaeo_dom']}, 02:27:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:27:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:27:26 INFO - 'tests': ['basic_compositor_video']}, 02:27:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:27:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:27:26 INFO - 'tests': ['a11yr', 02:27:26 INFO - 'ts_paint', 02:27:26 INFO - 'tpaint', 02:27:26 INFO - 'sessionrestore', 02:27:26 INFO - 'sessionrestore_no_auto_restore', 02:27:26 INFO - 'tabpaint']}, 02:27:26 INFO - 'other-e10s': {'tests': ['a11yr', 02:27:26 INFO - 'ts_paint', 02:27:26 INFO - 'tpaint', 02:27:26 INFO - 'sessionrestore', 02:27:26 INFO - 'sessionrestore_no_auto_restore', 02:27:26 INFO - 'tabpaint']}, 02:27:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:27:26 INFO - 'ts_paint', 02:27:26 INFO - 'tpaint', 02:27:26 INFO - 'sessionrestore', 02:27:26 INFO - 'sessionrestore_no_auto_restore', 02:27:26 INFO - 'tabpaint']}, 02:27:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:27:26 INFO - 'ts_paint', 02:27:26 INFO - 'tpaint', 02:27:26 INFO - 'sessionrestore', 02:27:26 INFO - 'sessionrestore_no_auto_restore', 02:27:26 INFO - 'tabpaint']}, 02:27:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:27:26 INFO - 'tests': ['a11yr', 02:27:26 INFO - 'ts_paint', 02:27:26 INFO - 'tpaint', 02:27:26 INFO - 'sessionrestore', 02:27:26 INFO - 'sessionrestore_no_auto_restore', 02:27:26 INFO - 'tabpaint']}, 02:27:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:27:26 INFO - 'tests': ['a11yr', 02:27:26 INFO - 'ts_paint', 02:27:26 INFO - 'tpaint', 02:27:26 INFO - 'sessionrestore', 02:27:26 INFO - 'sessionrestore_no_auto_restore', 02:27:26 INFO - 'tabpaint']}, 02:27:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:27:26 INFO - 'tests': ['tsvgx', 02:27:26 INFO - 'tsvgr_opacity', 02:27:26 INFO - 'tart', 02:27:26 INFO - 'tscrollx', 02:27:26 INFO - 'cart']}, 02:27:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:27:26 INFO - 'tsvgr_opacity', 02:27:26 INFO - 'tart', 02:27:26 INFO - 'tscrollx', 02:27:26 INFO - 'cart']}, 02:27:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:26 INFO - 'talos_options': ['--disable-e10s'], 02:27:26 INFO - 'tests': ['tp5o']}, 02:27:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:26 INFO - 'tests': ['tp5o']}, 02:27:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:26 INFO - 'talos_options': ['--disable-e10s', 02:27:26 INFO - '--xperf_path', 02:27:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:27:26 INFO - 'tests': ['tp5n']}, 02:27:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:26 INFO - 'talos_options': ['--xperf_path', 02:27:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:27:26 INFO - 'tests': ['tp5n']}}, 02:27:26 INFO - 'talos.zip': {'path': '', 02:27:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:27:26 INFO - Running post-action listener: _resource_record_post_action 02:27:26 INFO - [mozharness: 2016-09-21 09:27:26.438555Z] Finished populate-webroot step (success) 02:27:26 INFO - [mozharness: 2016-09-21 09:27:26.438644Z] Running create-virtualenv step. 02:27:26 INFO - Running pre-action listener: _resource_record_pre_action 02:27:26 INFO - Running main action method: create_virtualenv 02:27:26 INFO - Creating virtualenv /builds/slave/test/build/venv 02:27:26 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 02:27:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:27:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:27:26 INFO - Using real prefix '/usr' 02:27:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:27:27 INFO - Installing distribute.............................................................................................................................................................................................done. 02:27:29 INFO - Installing pip.................done. 02:27:29 INFO - Return code: 0 02:27:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:27:29 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')]} 02:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:29 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')]} 02:27:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:29 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 0x7f02f31d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f4930>, '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 0x19f5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f5cc0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', '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 02:27:29 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 02:27:29 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 02:27:29 INFO - Using env: {'DISPLAY': ':0', 02:27:29 INFO - 'HOME': '/home/cltbld', 02:27:29 INFO - 'LANG': 'en_US.UTF-8', 02:27:29 INFO - 'LANGUAGE': 'en_US:en', 02:27:29 INFO - 'LOGNAME': 'cltbld', 02:27:29 INFO - 'MAIL': '/var/mail/cltbld', 02:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:29 INFO - 'MOZ_NO_REMOTE': '1', 02:27:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:29 INFO - 'NO_EM_RESTART': '1', 02:27:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:29 INFO - 'PWD': '/builds/slave/test', 02:27:29 INFO - 'SHELL': '/bin/bash', 02:27:29 INFO - 'SHLVL': '1', 02:27:29 INFO - 'TERM': 'linux', 02:27:29 INFO - 'TMOUT': '86400', 02:27:29 INFO - 'USER': 'cltbld', 02:27:29 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', 02:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:29 INFO - '_': '/tools/buildbot/bin/python'} 02:27:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:29 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 02:27:29 INFO - Cleaning up... 02:27:29 INFO - Return code: 0 02:27:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:27:29 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')]} 02:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:29 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')]} 02:27:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:29 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 0x7f02f31d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f4930>, '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 0x19f5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f5cc0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', '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 02:27:29 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 02:27:29 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 02:27:29 INFO - Using env: {'DISPLAY': ':0', 02:27:29 INFO - 'HOME': '/home/cltbld', 02:27:29 INFO - 'LANG': 'en_US.UTF-8', 02:27:29 INFO - 'LANGUAGE': 'en_US:en', 02:27:29 INFO - 'LOGNAME': 'cltbld', 02:27:29 INFO - 'MAIL': '/var/mail/cltbld', 02:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:29 INFO - 'MOZ_NO_REMOTE': '1', 02:27:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:29 INFO - 'NO_EM_RESTART': '1', 02:27:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:29 INFO - 'PWD': '/builds/slave/test', 02:27:29 INFO - 'SHELL': '/bin/bash', 02:27:29 INFO - 'SHLVL': '1', 02:27:29 INFO - 'TERM': 'linux', 02:27:29 INFO - 'TMOUT': '86400', 02:27:29 INFO - 'USER': 'cltbld', 02:27:29 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', 02:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:29 INFO - '_': '/tools/buildbot/bin/python'} 02:27:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:29 INFO - Downloading/unpacking psutil>=3.1.1 02:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:27:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:27:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:27:31 INFO - Installing collected packages: psutil 02:27:31 INFO - Running setup.py install for psutil 02:27:31 INFO - building 'psutil._psutil_linux' extension 02:27:31 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 02:27:31 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 02:27:31 INFO - building 'psutil._psutil_posix' extension 02:27:31 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 02:27:31 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 02:27:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:27:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:27:31 INFO - Successfully installed psutil 02:27:31 INFO - Cleaning up... 02:27:32 INFO - Return code: 0 02:27:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:27: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')]} 02:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27: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')]} 02:27:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:32 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 0x7f02f31d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f4930>, '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 0x19f5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f5cc0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', '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 02:27:32 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 02:27:32 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 02:27:32 INFO - Using env: {'DISPLAY': ':0', 02:27:32 INFO - 'HOME': '/home/cltbld', 02:27:32 INFO - 'LANG': 'en_US.UTF-8', 02:27:32 INFO - 'LANGUAGE': 'en_US:en', 02:27:32 INFO - 'LOGNAME': 'cltbld', 02:27:32 INFO - 'MAIL': '/var/mail/cltbld', 02:27:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:32 INFO - 'MOZ_NO_REMOTE': '1', 02:27:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:32 INFO - 'NO_EM_RESTART': '1', 02:27:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:32 INFO - 'PWD': '/builds/slave/test', 02:27:32 INFO - 'SHELL': '/bin/bash', 02:27:32 INFO - 'SHLVL': '1', 02:27:32 INFO - 'TERM': 'linux', 02:27:32 INFO - 'TMOUT': '86400', 02:27:32 INFO - 'USER': 'cltbld', 02:27:32 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', 02:27:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:32 INFO - '_': '/tools/buildbot/bin/python'} 02:27:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:27:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:27:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:27:34 INFO - Installing collected packages: mozsystemmonitor 02:27:34 INFO - Running setup.py install for mozsystemmonitor 02:27:34 INFO - Successfully installed mozsystemmonitor 02:27:34 INFO - Cleaning up... 02:27:34 INFO - Return code: 0 02:27:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f02f31d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f4930>, '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 0x19f5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f5cc0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', '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 02:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:27:34 INFO - Using env: {'DISPLAY': ':0', 02:27:34 INFO - 'HOME': '/home/cltbld', 02:27:34 INFO - 'LANG': 'en_US.UTF-8', 02:27:34 INFO - 'LANGUAGE': 'en_US:en', 02:27:34 INFO - 'LOGNAME': 'cltbld', 02:27:34 INFO - 'MAIL': '/var/mail/cltbld', 02:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:34 INFO - 'MOZ_NO_REMOTE': '1', 02:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:34 INFO - 'NO_EM_RESTART': '1', 02:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:34 INFO - 'PWD': '/builds/slave/test', 02:27:34 INFO - 'SHELL': '/bin/bash', 02:27:34 INFO - 'SHLVL': '1', 02:27:34 INFO - 'TERM': 'linux', 02:27:34 INFO - 'TMOUT': '86400', 02:27:34 INFO - 'USER': 'cltbld', 02:27:34 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', 02:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:34 INFO - '_': '/tools/buildbot/bin/python'} 02:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:34 INFO - Downloading/unpacking jsonschema==2.5.1 02:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:27:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:36 INFO - Downloading functools32-3.2.3-2.tar.gz 02:27:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:27:36 INFO - warning: no files found matching '*.txt' 02:27:36 INFO - no previously-included directories found matching 'build' 02:27:36 INFO - no previously-included directories found matching 'dist' 02:27:36 INFO - no previously-included directories found matching '.git*' 02:27:36 INFO - Installing collected packages: jsonschema, functools32 02:27:36 INFO - Running setup.py install for functools32 02:27:36 INFO - warning: no files found matching '*.txt' 02:27:36 INFO - no previously-included directories found matching 'build' 02:27:36 INFO - no previously-included directories found matching 'dist' 02:27:36 INFO - no previously-included directories found matching '.git*' 02:27:36 INFO - Successfully installed jsonschema functools32 02:27:36 INFO - Cleaning up... 02:27:37 INFO - Return code: 0 02:27:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:27: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')]} 02:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27: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')]} 02:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27: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', '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 0x7f02f31d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f4930>, '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 0x19f5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f5cc0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', '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 02:27: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:27: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 functools32==3.2.3-2 02:27:37 INFO - Using env: {'DISPLAY': ':0', 02:27:37 INFO - 'HOME': '/home/cltbld', 02:27:37 INFO - 'LANG': 'en_US.UTF-8', 02:27:37 INFO - 'LANGUAGE': 'en_US:en', 02:27:37 INFO - 'LOGNAME': 'cltbld', 02:27:37 INFO - 'MAIL': '/var/mail/cltbld', 02:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:37 INFO - 'MOZ_NO_REMOTE': '1', 02:27:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:37 INFO - 'NO_EM_RESTART': '1', 02:27:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:37 INFO - 'PWD': '/builds/slave/test', 02:27:37 INFO - 'SHELL': '/bin/bash', 02:27:37 INFO - 'SHLVL': '1', 02:27:37 INFO - 'TERM': 'linux', 02:27:37 INFO - 'TMOUT': '86400', 02:27:37 INFO - 'USER': 'cltbld', 02:27:37 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', 02:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:37 INFO - '_': '/tools/buildbot/bin/python'} 02:27:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:27:37 INFO - Cleaning up... 02:27:37 INFO - Return code: 0 02:27:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:27: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')]} 02:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27: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')]} 02:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27: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', '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 0x7f02f31d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f4930>, '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 0x19f5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f5cc0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', '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 02:27: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:27: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 blobuploader==1.2.4 02:27:37 INFO - Using env: {'DISPLAY': ':0', 02:27:37 INFO - 'HOME': '/home/cltbld', 02:27:37 INFO - 'LANG': 'en_US.UTF-8', 02:27:37 INFO - 'LANGUAGE': 'en_US:en', 02:27:37 INFO - 'LOGNAME': 'cltbld', 02:27:37 INFO - 'MAIL': '/var/mail/cltbld', 02:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:37 INFO - 'MOZ_NO_REMOTE': '1', 02:27:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:37 INFO - 'NO_EM_RESTART': '1', 02:27:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:37 INFO - 'PWD': '/builds/slave/test', 02:27:37 INFO - 'SHELL': '/bin/bash', 02:27:37 INFO - 'SHLVL': '1', 02:27:37 INFO - 'TERM': 'linux', 02:27:37 INFO - 'TMOUT': '86400', 02:27:37 INFO - 'USER': 'cltbld', 02:27:37 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', 02:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:37 INFO - '_': '/tools/buildbot/bin/python'} 02:27:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:37 INFO - Downloading/unpacking blobuploader==1.2.4 02:27: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 02:27: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 02:27: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 02:27: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 02:27: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 02:27: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 02:27:39 INFO - Downloading blobuploader-1.2.4.tar.gz 02:27:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:27:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:27:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:40 INFO - Downloading docopt-0.6.1.tar.gz 02:27:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:27:40 INFO - Installing collected packages: blobuploader, requests, docopt 02:27:40 INFO - Running setup.py install for blobuploader 02:27:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:27:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:27:40 INFO - Running setup.py install for requests 02:27:40 INFO - Running setup.py install for docopt 02:27:40 INFO - Successfully installed blobuploader requests docopt 02:27:40 INFO - Cleaning up... 02:27:40 INFO - Return code: 0 02:27:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27: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')]} 02:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27: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')]} 02:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:40 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 0x7f02f31d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f4930>, '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 0x19f5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f5cc0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', '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 02:27:40 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 02:27:40 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 02:27:40 INFO - Using env: {'DISPLAY': ':0', 02:27:40 INFO - 'HOME': '/home/cltbld', 02:27:40 INFO - 'LANG': 'en_US.UTF-8', 02:27:40 INFO - 'LANGUAGE': 'en_US:en', 02:27:40 INFO - 'LOGNAME': 'cltbld', 02:27:40 INFO - 'MAIL': '/var/mail/cltbld', 02:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:40 INFO - 'MOZ_NO_REMOTE': '1', 02:27:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:40 INFO - 'NO_EM_RESTART': '1', 02:27:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:40 INFO - 'PWD': '/builds/slave/test', 02:27:40 INFO - 'SHELL': '/bin/bash', 02:27:40 INFO - 'SHLVL': '1', 02:27:40 INFO - 'TERM': 'linux', 02:27:40 INFO - 'TMOUT': '86400', 02:27:40 INFO - 'USER': 'cltbld', 02:27:40 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', 02:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:40 INFO - '_': '/tools/buildbot/bin/python'} 02:27:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:27:40 INFO - Running setup.py (path:/tmp/pip-O7QUrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:27:41 INFO - Running setup.py (path:/tmp/pip-4fgdcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:27:41 INFO - Running setup.py (path:/tmp/pip-vWtXvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:27:41 INFO - Running setup.py (path:/tmp/pip-V3vNLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:27:41 INFO - Running setup.py (path:/tmp/pip-W78f3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:27:41 INFO - Running setup.py (path:/tmp/pip-qMcNrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:27:41 INFO - Running setup.py (path:/tmp/pip-uwfgqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:27:41 INFO - Running setup.py (path:/tmp/pip-DM3Giv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:27:41 INFO - Running setup.py (path:/tmp/pip-1mE87J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:27:41 INFO - Running setup.py (path:/tmp/pip-yt7uj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:27:41 INFO - Running setup.py (path:/tmp/pip-30lXkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:27:41 INFO - Running setup.py (path:/tmp/pip-EQMNSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:27:41 INFO - Running setup.py (path:/tmp/pip-16Dv2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:27:41 INFO - Running setup.py (path:/tmp/pip-UtaYq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:27:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:41 INFO - Running setup.py (path:/tmp/pip-yum6_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:27:42 INFO - Running setup.py (path:/tmp/pip-4FDnFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:27:42 INFO - Running setup.py (path:/tmp/pip-hFo5h1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:27:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:27:42 INFO - Running setup.py install for manifestparser 02:27:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:27:42 INFO - Running setup.py install for mozcrash 02:27:42 INFO - Running setup.py install for mozdebug 02:27:42 INFO - Running setup.py install for mozdevice 02:27:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:27:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:27:42 INFO - Running setup.py install for mozfile 02:27:42 INFO - Running setup.py install for mozhttpd 02:27:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:27:42 INFO - Running setup.py install for mozinfo 02:27:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:27:42 INFO - Running setup.py install for mozInstall 02:27:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:27:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:27:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:27:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:27:42 INFO - Running setup.py install for mozleak 02:27:43 INFO - Running setup.py install for mozlog 02:27:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:27:43 INFO - Running setup.py install for moznetwork 02:27:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:27:43 INFO - Running setup.py install for mozprocess 02:27:43 INFO - Running setup.py install for mozprofile 02:27:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:27:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:27:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:27:43 INFO - Running setup.py install for mozrunner 02:27:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:27:43 INFO - Running setup.py install for mozscreenshot 02:27:43 INFO - Running setup.py install for moztest 02:27:43 INFO - Running setup.py install for mozversion 02:27:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:27:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:27:43 INFO - Cleaning up... 02:27:43 INFO - Return code: 0 02:27:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:43 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 0x7f02f31d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f4930>, '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 0x19f5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f5cc0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', '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 02:27:43 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 02:27:43 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 02:27:43 INFO - Using env: {'DISPLAY': ':0', 02:27:43 INFO - 'HOME': '/home/cltbld', 02:27:43 INFO - 'LANG': 'en_US.UTF-8', 02:27:43 INFO - 'LANGUAGE': 'en_US:en', 02:27:43 INFO - 'LOGNAME': 'cltbld', 02:27:43 INFO - 'MAIL': '/var/mail/cltbld', 02:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:43 INFO - 'MOZ_NO_REMOTE': '1', 02:27:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:43 INFO - 'NO_EM_RESTART': '1', 02:27:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:43 INFO - 'PWD': '/builds/slave/test', 02:27:43 INFO - 'SHELL': '/bin/bash', 02:27:43 INFO - 'SHLVL': '1', 02:27:43 INFO - 'TERM': 'linux', 02:27:43 INFO - 'TMOUT': '86400', 02:27:43 INFO - 'USER': 'cltbld', 02:27:43 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', 02:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:43 INFO - '_': '/tools/buildbot/bin/python'} 02:27:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:27:44 INFO - Running setup.py (path:/tmp/pip-bB8oqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:27:44 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)) 02:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:27:44 INFO - Running setup.py (path:/tmp/pip-oe3Tu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:27:44 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)) 02:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:27:44 INFO - Running setup.py (path:/tmp/pip-tnMKsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:27:44 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)) 02:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:27:44 INFO - Running setup.py (path:/tmp/pip-iL2_2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:27:44 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)) 02:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:27:44 INFO - Running setup.py (path:/tmp/pip-sXqaJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:27:44 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)) 02:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:27:44 INFO - Running setup.py (path:/tmp/pip-WVgnxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:27:44 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)) 02:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:27:44 INFO - Running setup.py (path:/tmp/pip-CC2T3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:27:44 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)) 02:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:27:44 INFO - Running setup.py (path:/tmp/pip-ca1HL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:27:44 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)) 02:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:27:44 INFO - Running setup.py (path:/tmp/pip-5zDAQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:27:44 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)) 02:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:27:44 INFO - Running setup.py (path:/tmp/pip-6PoYii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:27:44 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)) 02:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:27:44 INFO - Running setup.py (path:/tmp/pip-C2P9D6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:27:44 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)) 02:27:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:27:44 INFO - Running setup.py (path:/tmp/pip-3ZwqBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:27:45 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)) 02:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:27:45 INFO - Running setup.py (path:/tmp/pip-8Qd7k4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:27:45 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)) 02:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:27:45 INFO - Running setup.py (path:/tmp/pip-O1GNDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:27:45 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)) 02:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:45 INFO - Running setup.py (path:/tmp/pip-aw7LXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:45 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)) 02:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:27:45 INFO - Running setup.py (path:/tmp/pip-o37_xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:27:45 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)) 02:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:27:45 INFO - Running setup.py (path:/tmp/pip-kOd5EN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:27:45 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)) 02:27:45 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)) 02:27:45 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)) 02:27:45 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)) 02:27:45 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)) 02:27:45 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)) 02:27:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:27: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 02:27: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 02:27: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 02:27: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 02:27: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 02:27: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 02:27:47 INFO - Downloading blessings-1.6.tar.gz 02:27:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:27:47 INFO - Installing collected packages: blessings 02:27:47 INFO - Running setup.py install for blessings 02:27:47 INFO - Successfully installed blessings 02:27:47 INFO - Cleaning up... 02:27:47 INFO - Return code: 0 02:27:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:27:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:27:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:27:47 INFO - Reading from file tmpfile_stdout 02:27:47 INFO - Current package versions: 02:27:47 INFO - argparse == 1.2.1 02:27:47 INFO - blessings == 1.6 02:27:47 INFO - blobuploader == 1.2.4 02:27:47 INFO - docopt == 0.6.1 02:27:47 INFO - functools32 == 3.2.3-2 02:27:47 INFO - jsonschema == 2.5.1 02:27:47 INFO - manifestparser == 1.1 02:27:47 INFO - mozInstall == 1.12 02:27:47 INFO - mozcrash == 0.17 02:27:47 INFO - mozdebug == 0.1 02:27:47 INFO - mozdevice == 0.48 02:27:47 INFO - mozfile == 1.2 02:27:47 INFO - mozhttpd == 0.7 02:27:47 INFO - mozinfo == 0.9 02:27:47 INFO - mozleak == 0.1 02:27:47 INFO - mozlog == 3.4 02:27:47 INFO - moznetwork == 0.27 02:27:47 INFO - mozprocess == 0.23 02:27:47 INFO - mozprofile == 0.28 02:27:47 INFO - mozrunner == 6.12 02:27:47 INFO - mozscreenshot == 0.1 02:27:47 INFO - mozsystemmonitor == 0.3 02:27:47 INFO - moztest == 0.7 02:27:47 INFO - mozversion == 1.4 02:27:47 INFO - psutil == 3.1.1 02:27:47 INFO - requests == 1.2.3 02:27:47 INFO - wsgiref == 0.1.2 02:27:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27:47 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')]} 02:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:47 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')]} 02:27:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:47 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 0x7f02f31d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f4930>, '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 0x19f5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f5cc0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', '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 02:27:47 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 02:27:47 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 02:27:47 INFO - Using env: {'DISPLAY': ':0', 02:27:47 INFO - 'HOME': '/home/cltbld', 02:27:47 INFO - 'LANG': 'en_US.UTF-8', 02:27:47 INFO - 'LANGUAGE': 'en_US:en', 02:27:47 INFO - 'LOGNAME': 'cltbld', 02:27:47 INFO - 'MAIL': '/var/mail/cltbld', 02:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:47 INFO - 'MOZ_NO_REMOTE': '1', 02:27:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:47 INFO - 'NO_EM_RESTART': '1', 02:27:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:47 INFO - 'PWD': '/builds/slave/test', 02:27:47 INFO - 'SHELL': '/bin/bash', 02:27:47 INFO - 'SHLVL': '1', 02:27:47 INFO - 'TERM': 'linux', 02:27:47 INFO - 'TMOUT': '86400', 02:27:47 INFO - 'USER': 'cltbld', 02:27:47 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', 02:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:47 INFO - '_': '/tools/buildbot/bin/python'} 02:27:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:47 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)) 02:27:47 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)) 02:27:47 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)) 02:27:47 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)) 02:27:47 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)) 02:27:47 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)) 02:27:47 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)) 02:27:47 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)) 02:27:47 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)) 02:27:47 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)) 02:27:47 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)) 02:27:47 INFO - Cleaning up... 02:27:47 INFO - Return code: 0 02:27:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:27:47 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')]} 02:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:47 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')]} 02:27:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:47 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 0x7f02f31d7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19f7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f4930>, '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 0x19f5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f5cc0>, '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': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', '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 02:27:47 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 02:27:47 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 02:27:47 INFO - Using env: {'DISPLAY': ':0', 02:27:47 INFO - 'HOME': '/home/cltbld', 02:27:47 INFO - 'LANG': 'en_US.UTF-8', 02:27:47 INFO - 'LANGUAGE': 'en_US:en', 02:27:47 INFO - 'LOGNAME': 'cltbld', 02:27:47 INFO - 'MAIL': '/var/mail/cltbld', 02:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:47 INFO - 'MOZ_NO_REMOTE': '1', 02:27:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:47 INFO - 'NO_EM_RESTART': '1', 02:27:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:47 INFO - 'PWD': '/builds/slave/test', 02:27:47 INFO - 'SHELL': '/bin/bash', 02:27:47 INFO - 'SHLVL': '1', 02:27:47 INFO - 'TERM': 'linux', 02:27:47 INFO - 'TMOUT': '86400', 02:27:47 INFO - 'USER': 'cltbld', 02:27:47 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', 02:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:47 INFO - '_': '/tools/buildbot/bin/python'} 02:27:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:27:48 INFO - Cleaning up... 02:27:48 INFO - Return code: 0 02:27:48 INFO - Running post-action listener: _resource_record_post_action 02:27:48 INFO - Running post-action listener: _start_resource_monitoring 02:27:48 INFO - Starting resource monitoring. 02:27:48 INFO - [mozharness: 2016-09-21 09:27:48.221599Z] Finished create-virtualenv step (success) 02:27:48 INFO - [mozharness: 2016-09-21 09:27:48.222056Z] Running install step. 02:27:48 INFO - Running pre-action listener: _resource_record_pre_action 02:27:48 INFO - Running main action method: install 02:27:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:27:48 INFO - Reading from file tmpfile_stdout 02:27:48 INFO - Detecting whether we're running mozinstall >=1.0... 02:27:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:27:48 INFO - Reading from file tmpfile_stdout 02:27:48 INFO - Output received: 02:27:48 INFO - Usage: mozinstall [options] installer 02:27:48 INFO - Options: 02:27:48 INFO - -h, --help show this help message and exit 02:27:48 INFO - -d DEST, --destination=DEST 02:27:48 INFO - Directory to install application into. [default: 02:27:48 INFO - "/builds/slave/test"] 02:27:48 INFO - --app=APP Application being installed. [default: firefox] 02:27:48 INFO - mkdir: /builds/slave/test/build/application 02:27:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:28:05 INFO - Reading from file tmpfile_stdout 02:28:05 INFO - Output received: 02:28:05 INFO - /builds/slave/test/build/application/firefox/firefox 02:28:05 INFO - Running post-action listener: _resource_record_post_action 02:28:05 INFO - [mozharness: 2016-09-21 09:28:05.472481Z] Finished install step (success) 02:28:05 INFO - [mozharness: 2016-09-21 09:28:05.472725Z] Running run-tests step. 02:28:05 INFO - Running pre-action listener: _resource_record_pre_action 02:28:05 INFO - Running main action method: run_tests 02:28:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:28:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:28:05 INFO - Python 2.7.3 02:28:05 INFO - Return code: 0 02:28:05 INFO - grabbing minidump binary from tooltool 02:28:05 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')]} 02:28:05 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 0x19f4930>, '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 0x19f5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19f5cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:28:05 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 02:28:05 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 02:28:05 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 02:28:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:28:05 INFO - Return code: 0 02:28:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:28:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:28:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:28:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:28:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:28:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:28:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:28:05 INFO - Using env: {'DISPLAY': ':0', 02:28:05 INFO - 'HOME': '/home/cltbld', 02:28:05 INFO - 'LANG': 'en_US.UTF-8', 02:28:05 INFO - 'LANGUAGE': 'en_US:en', 02:28:05 INFO - 'LOGNAME': 'cltbld', 02:28:05 INFO - 'MAIL': '/var/mail/cltbld', 02:28:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:28:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:05 INFO - 'MOZ_NO_REMOTE': '1', 02:28:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:28:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:05 INFO - 'NO_EM_RESTART': '1', 02:28:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:05 INFO - 'PWD': '/builds/slave/test', 02:28:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:28:05 INFO - 'SHELL': '/bin/bash', 02:28:05 INFO - 'SHLVL': '1', 02:28:05 INFO - 'TERM': 'linux', 02:28:05 INFO - 'TMOUT': '86400', 02:28:05 INFO - 'USER': 'cltbld', 02:28:05 INFO - 'XDG_SESSION_COOKIE': '9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433', 02:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:05 INFO - '_': '/tools/buildbot/bin/python'} 02:28:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:28:05 INFO - mozversion application_buildid: 20160921003000 02:28:05 INFO - mozversion application_changeset: 6fb92ddf485702778367f7217caaa216d8639ac3 02:28:05 INFO - mozversion application_display_name: Nightly 02:28:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:28:05 INFO - mozversion application_name: Firefox 02:28:05 INFO - mozversion application_remotingname: firefox 02:28:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:28:05 INFO - mozversion application_vendor: Mozilla 02:28:05 INFO - mozversion application_version: 52.0a1 02:28:05 INFO - mozversion platform_buildid: 20160921003000 02:28:05 INFO - mozversion platform_changeset: 6fb92ddf485702778367f7217caaa216d8639ac3 02:28:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:28:05 INFO - mozversion platform_version: 52.0a1 02:28:05 INFO - using testdate: 1474450085 02:28:05 INFO - actual date: 1474450085 02:28:05 INFO - starting webserver on 'localhost:36577' 02:28:05 INFO - SUITE-START | Running 2 tests 02:28:05 INFO - TEST-START | dromaeo_css 02:28:05 INFO - operating with platform_type : linux_ 02:28:05 INFO - Initialising browser for dromaeo_css test... 02:28:05 INFO - TEST-INFO | started process 8024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGrwSkw/profile http://localhost:36577/getInfo.html) 02:28:10 INFO - PROCESS | 8024 | __metrics Screen width/height:1600/1200 02:28:10 INFO - PROCESS | 8024 | colorDepth:24 02:28:10 INFO - PROCESS | 8024 | Browser inner width/height: 1024/697 02:28:10 INFO - PROCESS | 8024 | __metrics 02:28:10 ERROR - PROCESS | 8024 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 02:28:11 INFO - TEST-INFO | 8024: exit 0 02:28:11 INFO - Browser initialized. 02:28:11 INFO - Running cycle 1/1 for dromaeo_css test... 02:28:11 INFO - TEST-INFO | started process 8145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGrwSkw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:28:23 INFO - PROCESS | 8145 | RSS: Main: 185004032 02:28:23 INFO - PROCESS | 8145 | 02:29:13 INFO - PROCESS | 8145 | 1474450153586 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] 02:31:23 INFO - PROCESS | 8145 | Cycle 1(1): loaded http://localhost:36577/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36577/tests/dromaeo/cssquery-ext.html) 02:31:24 INFO - PROCESS | 8145 | RSS: Main: 199737344 02:31:24 INFO - PROCESS | 8145 | 02:34:26 INFO - PROCESS | 8145 | Cycle 1(1): loaded http://localhost:36577/tests/dromaeo/cssquery-ext.html (next: http://localhost:36577/tests/dromaeo/cssquery-jquery.html) 02:34:27 INFO - PROCESS | 8145 | RSS: Main: 195850240 02:34:27 INFO - PROCESS | 8145 | 02:37:29 INFO - PROCESS | 8145 | Cycle 1(1): loaded http://localhost:36577/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36577/tests/dromaeo/cssquery-mootools.html) 02:37:29 INFO - PROCESS | 8145 | RSS: Main: 197431296 02:37:29 INFO - PROCESS | 8145 | 02:40:31 INFO - PROCESS | 8145 | Cycle 1(1): loaded http://localhost:36577/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36577/tests/dromaeo/cssquery-prototype.html) 02:40:32 INFO - PROCESS | 8145 | RSS: Main: 194547712 02:40:32 INFO - PROCESS | 8145 | 02:43:34 INFO - PROCESS | 8145 | Cycle 1(1): loaded http://localhost:36577/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36577/tests/dromaeo/cssquery-yui.html) 02:43:35 INFO - PROCESS | 8145 | RSS: Main: 198041600 02:43:35 INFO - PROCESS | 8145 | 02:46:38 INFO - PROCESS | 8145 | Cycle 1(1): loaded http://localhost:36577/tests/dromaeo/cssquery-yui.html (next: http://localhost:36577/tests/dromaeo/cssquery-dojo.html) 02:46:38 INFO - PROCESS | 8145 | RSS: Main: 198270976 02:46:38 INFO - PROCESS | 8145 | 02:46:38 INFO - PROCESS | 8145 | __start_tp_report 02:46:38 INFO - PROCESS | 8145 | _x_x_mozilla_page_load 02:46:38 INFO - PROCESS | 8145 | _x_x_mozilla_page_load_details 02:46:38 INFO - PROCESS | 8145 | |i|pagename|runs| 02:46:38 INFO - PROCESS | 8145 | |0;dojo.html;3081.5377693345995;3096.4890793019154;3137.576427182331;3142.8585713642883;3147.9842600787006;5246.108161612526;5408.513233808956;5413.815802597191;5440.347158341;5442;5270.262163297141;5359.464053594638;5443.129099344106;5449.182622606611;5501.092319767244;4891.241857512083;4983.975080124595;4985.850424487271;4999.100161970844;5048.268001139851;4931.137051016076;4975.626827987898;4984.202527595586;4996.350474438336;5000.19996800512;4742.762861856911;4810.446798618169;4847.515248475124;4920.384951881015;4928.334674818925;4955.826546070906;4957.182064959277;4965.478624744386;4996;5006.924896126561;4819.0602832447685;4916.606671466274;4922.114019476493;4929.728864912428;4975.104481193383;5260.105782017028;5305.602079843989;5350.678959262456;5414.931751689993;5437.265969094161;5757.0788673811985;5789.768409263625;5800.564957628195;5822.505087067604;5850.210221620069;5802;5812.534997200214;5822.97088514559;5827.796027139072;5834.5040671542965;5279.340082489689;5329.760160792774;5411.053065713484;5411.783528658849;5425.864353391197;5864.354920958691;5885.382034886361;5921.496672782861;5948.821535353946;6007.969960150172;5639.041362968305;5686.687232202185;5688.800891968761;5694.60137790359;5706.857328566736;5596.300462442195;5631.915521267184;5740.368559458456;5785.913211301834;5803.187553742479;5589.80435684749;5597.720113994284;5667.291588551431;5686.5735069869925;5695.145728140729;5675.602707810413;5699.74351154199;5700.173474846124;5734.885302293931;5736.397678243808;4400.09797991411;4405.801738921757;4411.602955733999;4413.227685155085;4458.4426946631675;3928.9784655989647;3931.0958479549863;3940.2513522430645;3960.7227494075714;3978.264021156095;5376.193570964387;5410.1343784994215;5439.592030597721;5443.918341224885;5544.805931792368;5873.2658417697785;5878.941210587925;5885.058390657474;5885.176075349455;5890.322612899571;5479.479449452296;5518.089515229942;5520.282363292827;5527.751251193706;5528.44715528444;4670.929936050962;4738.715677059387;4836.081144582518;4844.685095468783;4857.028594281158;5965.582409231399;5977.103434484862;5985.042393217064;5986.042233242661;6054.666993315322;5779.075347944308;5804.564657650609;5805.912911306418;5805.94194058054;5812.912806307824;5793.855153621024;5835;5940.61386009908;5963.2844058713235;6001.309849367379;5709.942900570941;5748.971255143698;5751.367349591458;5805.419458054161;5813.593048486566;5798.59409841307;5857.824265272048;5867.325257595431;5870.324912634931;5875.853103672443;5544.7782088716;5585.664860108406;5605.691686957257;5727.770889164387;5736.1109028099045;5588;5635.6618602883955;5644.096944488862;5680.4319568042865;5697.259356283822;5541.113421852484;5554.638948468337;5561.138023606348;5566.666000040011;5585.525230355465;5513.807016754395;5563.443655634404;5612.887742245214;5654.293213348332;5680.375158732453;5604.019296622993;5606.215129881738;5609.887802244014;5653.265075540154;5671 02:46:38 INFO - PROCESS | 8145 | |1;ext.html;536.004280524552;585.3502612100565;588.7644942023193;591.3347484080409;602.9517638588912;41153.17693646129;42869.7856510717;42924.57075429245;46812.29781553271;46846.53153468464;43129.35305970413;43710.56289437105;43745;43787.78106109473;43896.3415548767;8856.468611883292;8948.284137269035;8986.326025548078;9003.95498022509;9032.548372581377;8878;8892.644294228256;8928.687495937644;8953.552322383888;8978.775530611721;8982.10178982103;8995.325350598698;9002.594883230271;9016.594253258587;9027.864582031274;8930;8951.776205594848;8984.23633991105;8995.640174393016;9006.774830629254;8805.119488051208;8861.73414797557;8903.06517815633;8938.4190027648;8949.865752013726;40460.19079618421;40824;40973.385399219034;41082.79458602688;41103;3440.55272814535;4056.553779084298;4138.544760076419;4174.666026717886;4185.455890734215;31337.216569585715;31424.528632070538;31546.842265788753;32022.35955280881;32098.518522222184;4255.5318914919335;4422.181896349153;4449.310356894686;4609.953900460986;4610.631149508032;346336;346371.9999999975;346397;347386;347952;35925.28149436996;36767.4484882727;36783.4482482763;55650.443495565334;55825;36561.63438365582;36944.63055369466;37043.814780925924;37065.258694825956;37211;15427.768583471257;15584.454544090902;15653.139077350626;15681.764773528406;15710.371585136696;13004.479820807252;13074.346282685829;13111.803322950163;13132;13167.47330106785;8456.196661317164;8507.447015944068;8585.227329540372;8595.097514760984;8614.741557753152;3335.6497567755523;3358.1101008232836;3403.863845446204;3418.3163367326633;3431.1079119428628;949.9477528735848;1004.2668851738126;1051.379685985257;1089.629525961177;1137.7951968645557;30560;30956.535651965238;31074.68925310718;31401.52897706536;31405.52891706626;1072.8819829818713;1109.5506319940437;1146.4497041420166;1178.4755783676183;1184.9585264515702;16208.59478513023;16307.347706091623;16513.422030228885;16536.75194872078;16543.83456165447;144081.27959360136;144448;144705.27647361695;145104;146210;54778;55285.170722439194;55362.446375536536;55501.16748248779;55664.44335556593;1296.9870301296867;1339.6048165791115;1348.157401623985;1367.09771550776;1383.1148065238256;28528.42943141084;30311.545326820557;30512.542311864894;30741.538876916416;30801.032047259392;47964.5203547974;48292.7585362071;48303.275450867564;48338.5166148334;48433.82047807787;405558;407610;407981;408410;408687;27246.782511154866;27293.72706272912;27649.723502764715;27668.584971225046;27920.581191282552;44543.777281113384;45199.32201016921;45843.77078114588;46222.306665399374;46460.07079858316;38601.42097868591;39515.604843951194;39837;40768.388474172316;40951.7952410236;38882.80558597302;39010.41484377794;39136.80431597824;39235.2152956945;39531;38640;39399;40261.19477610373;40410.1917961645;41927;31752.682473174973;34344;36105.63894361128;36739.63260367362;36878.18527031035;27104;27265.727342727114;27713.861430693523;27737;27781.58327625047 02:46:38 INFO - PROCESS | 8145 | |2;jquery.html;385.3352966133422;388.2661769256106;389.28760368525616;396.11863603482254;418.19914863037286;16048.197590120477;16736.2468688909;18113;19590.216391344347;19654.21383144674;12801.935990320035;12952.158109722885;16768.245428955695;18134.81865181348;19669.803301966975;5284.260203571494;5431.375391829931;5431.6740995540395;5437.945620543804;5487.780488780464;5747.109198074305;6002.279726432834;6032.366601506845;6109.35851735568;6136.938630613681;5991.281046274431;6021.337652858182;6125;6134.263888333407;6136.539759518032;6048.274207095154;6073.817785466443;6083.939160608404;6098.786542471036;6119.571629985903;5798.797042103548;5850.971267196694;5895.35151133375;5895.675737834417;5964.612300200516;14166.150030998173;14293.356798943969;14432.278386080654;14476.638084047878;14547.345369458293;2420.346506443268;2521.445282037949;2621.580547112472;2882.495563276418;2894.609227754247;9962.601495940226;10523.73690657732;10744.301620394728;10870.076043536308;10999.34003959765;1913.4068438783881;1964.7151163081417;1986.7913869043687;2007.9196832126697;2007.9598408031757;83889;86284.56857715671;88813.55593221993;89623.55188224082;91815.54092229562;11377.88622113785;11486;11576;11604.76790464186;11672.766544669059;15946.20268986546;15999.760003599955;16086.75869861953;16117.919410402874;16120.274587643584;7874.291313781672;8073.838523229502;8580.528070956158;8768.167024132697;8802.119788021148;8323.292520135736;8388.586902415174;8390.119037500974;8613.526256055977;8653.134686531297;4709.364235828188;4867.853964381075;4964.726940018334;4974.37820272466;4999.225120106389;2021.86857854239;2025.584755125196;2047.7337946066916;2049.272508259576;2112.3240563019995;901.5762591581946;940.3840484482674;959.2469911119738;979.1090108001827;1002.293383164867;17819.643607127786;19151.329703460313;19247.711284330748;19459.318923837596;19567.315143969892;919.5861862162054;962.1869520255373;972.9367591106555;973.2311473935512;1030.9639162629271;8926.776830579287;10479.738006549896;10871.347719136718;10900;10909.39998300101;450831;450937;469440;474209;476028;92945.5352723232;95086;96159.51920240354;96185;96382.51808740912;936.9109934556207;961.1589858873485;984.2322988069318;988.0662773678805;994.9801003980025;16430.342786288413;16442.83557164461;16819.24313405924;17174.742378864077;17225.913870430566;42725.35911961385;42831.3575296377;43431.13137737165;43646.34530481982;44272;57819.961914636406;58979.70510147422;60392;60416.395836041076;60743.69628151831;5718.742656580547;7889.487183333065;8273.958630206811;8352.248297653241;8578.270846978077;6934.514583979073;9216.769580760534;11509.021733152777;12341.3829308536;12357.814632780695;10683.145348372267;10921.453927303444;11080.944595276973;11180.55277788912;11440.885591143982;11030.283031603241;11061.723456913642;11088.057515110982;11153.832692509457;11210.327380356879;10839.67480975572;10926.289791163548;11091.445427728742;11187.049100826522;11344.829827552428;7577.772666820004;8089.716859909875;8256.545889976109;8348.916510835057;8399.538025408661;10281.845772313272;10415.510803880785;10683.626073087406;10802.189835762192;11446.198766086294 02:46:38 INFO - PROCESS | 8145 | |3;mootools.html;1455.9272036398181;1496.663250768577;1601.135386891079;1716.0475935855595;1756.3589289909187;7704.229577042293;7900.683972641087;8249.422540422172;8821.911780882197;8823.029466758659;8344.165583441669;8575.485470871752;8588.656453741844;8831.735047948572;8850.822983540342;2350.5063936573342;2374.7031621047367;2383.356493746687;2383.95232095358;2385.666006759055;2323.6863023491783;2340.8595484270913;2362.692849929507;2370.715514138306;2373.3947843299934;2342.672025916373;2346.401667574766;2350.2009316832273;2363.5745565798147;2371.1937941100023;2311.8034967027656;2334.9066037358484;2341.075275266269;2342.976570234293;2345.097137602027;2301.4476525633895;2305.4351683837567;2308.0536979838353;2319.2346525646667;2331.8717470539113;8700.390972631918;8742.606582703793;8742.650293988232;8797;8797.208251257354;4980.800767969277;5093.0577843099145;5100.9489905100845;5110.718910459923;5136.666116702402;3270.836458177105;3340.88306909257;3403.914902127442;3413.829308534588;3461.2039230977016;1067.908405167037;1111.4276147783899;1112.5660992213043;1123.7583919457275;1126.774645070989;11842.585509507126;11846.17076804624;11847.407629618485;11881.762364752743;11914.285142891367;4348.804303806336;4486.68593198473;4525.683202175882;4600.585947264695;4642.9535704643195;10182.439965801805;10186.388816671024;10186.541605627765;10190.184785217165;10213.591456341812;5156.2523434102595;5164.92252616211;5167.044096842096;5168.870778230575;5170.638055336166;4212.915741685149;4317.0934103838545;4537.274036154199;4612.423447069116;4700.858974230779;3629.7822130672243;3758.4362345648374;3793.260314238752;3802.6007269236884;3821.1593449441634;1233.3031837012059;1279.1685404486973;1283.18517741235;1297.7599144158362;1318.9274589897648;875.3303722652176;880.317753740856;890.0476490155601;915.0986278515657;926.1895841139003;5514.6691198528215;5571.359293681197;5713.314402271671;5746.569007324468;5798.59409841307;937.3813283233034;951.9762005949768;964.0937518732369;980.5048450532578;1027.3938376357985;3742;3976.4035394691027;4022.3966405039478;4032.294348489003;4124.8143833527565;10152.441615711059;10530.842037369446;10561.155107591374;10778.892211077946;10803.675889723321;10540.209484288556;10559.208059395576;10573.62992295266;10582.259241853151;10713.625023124154;7861.562915496214;8126.187381261827;8126.512409255463;8129.292848501763;8144.267015968591;5316.521513063843;5504.697241651747;5549.139883318092;5698.715064246854;5707.68607726579;9382.530873456437;9390.718278451657;9422.104900034486;9498.240140788583;9573;9388.906110938804;9552.474613896302;9569.61721531131;9582.66460673901;9670;6987.475939304471;7184.497085203986;7376.077990251219;7628.35159011468;7785.610719464117;8024.478408903403;8332.958335208528;8337.541435221121;8339.874901876356;8360.038595561587;7350.595717235603;7398.889016664647;7479.626018699152;7503.5497870127965;7642.273983971514;7119.110111236096;7206.171290301682;7242.203357630551;7274.636268186676;7456;6865.347791959756;6867.931320686729;6871.759488417882;6902.378785909092;6914.896276555755;4950.4059512858685;5024.522670346311;5033.446320904624;5063.063333283354;5110.105731497048;4710.364100846342;4772.141014617402;4903.387076615423;4918.336024636771;4989.151844186425 02:46:38 INFO - PROCESS | 8145 | |4;prototype.html;290.66573440543385;311.7101095980737;316.7481851927717;331.14894720568134;332.4381794766844;5217.582593392529;5468.699221542814;5505.10981734589;5573.944260557399;5609.3268807743025;5335.879465312289;5512.641678290918;5522.585806064541;5525.99999999999;5544;4323.243432399333;4334.4396017433855;4338.566143385668;4345.109252603209;4347.717398369104;4276.465441819772;4284.18600465912;4335.544767799383;4340.8697739067875;4355.324924636687;4234.767087810169;4259.424977628011;4260.723053001545;4266.189424009443;4293.699441039129;4255.574442555735;4267.4452321198205;4278.144371125787;4291.291936830419;4297.419848320468;3715.089802998256;3768.453574231721;3777.8866634001024;3778.3954567269107;3779.769935737928;5310.645785324756;5315.867103322448;5348.759305831208;5374.838754837361;5440.836774896759;4809.749465139054;4827.8551643450755;4833.782479788418;4842.515748425165;4874.585660218886;5612.575035091044;5706.400827913051;5716.1711551825165;5733.362653179543;5755.223044888929;3958.604139586047;4014.2573623879675;4026.2752704513177;4031.5363733170475;4062.329715596923;5797.710114494301;5966.224390829208;5994.13085102662;6017.458428741391;6052.6697221569575;4192.81132349045;4201.495820501559;4217.304144816071;4218.535961044283;4238.689913996817;4274.7435153890865;4284.228838809045;4288.678349123828;4307.0093878407515;4319.524852266248;4776.928346074812;4883.926741098886;4931.161702510582;4932.605391568666;4945.109880221595;5771.192033115367;5783.137347013171;5788.88422231553;5789.971050144806;5790.320806966017;1464.1727424005403;1478.3199728124969;1478.3811726159838;1479.423025020243;1480.8445113263167;910.0026183571612;940.304174910575;950.3680052764972;952.1858810716876;959.2421986630624;4866.562009419169;4899.191633380452;4905.460399356068;4912.287718280829;4918.712798548692;5211.166213405837;5229.980153870035;5231.71225582589;5243.898781255903;5279.868003299872;4546.52261512543;4842.346283251786;4867.904721437719;4889.877753056131;4930.731863342902;2758.0209025795953;2758.4207316463367;2761.3924936513936;2763.6407267055156;2789.3723912119613;5303.920441193385;5370.3287089113865;5374.570034397317;5376.73116344189;5381.031414345455;5349.438308977501;5362.70505122222;5607.607467477237;6106.206193194945;6143.56995010345;6175.722092505848;6177.351378105234;6187.721552530057;6214.564980451325;6237.500999919996;5669.6314739541795;5937.8218653438735;5947.791827286024;5987.550933680079;6018.729157188025;5872.911906321494;5877.119321816977;5890.587658864009;5929.0513517836935;5960.970195148997;5958.7616495341435;6163.674809915889;6170.660613666112;6221.502279817513;6230.25552845204;4106.7946602670345;4152.771597562163;4160.875173744793;4166.854160104382;4167.874963751093;5750.338711048283;6007.639541627342;6026.367231440811;6031.8539477499135;6051.515878729603;5765.4522820332;5768.596198266249;5769.711514424346;5774.3648198697265;5804.8970695567705;5850.561207909509;5860.208871802422;5861.560382971379;5879.5002424794375;5883.2057672213705;5428.511433970962;5711.343195532567;5752.194692743103;5755.482006619424;5761.48146666802;5838.94161058384;5843.181954526284;5895.852603684943;5900.173975643327;5919.200907877554;5514.944850551443;5735.340435849931;5784.884302313846;5804.738786754522;5813.302403711582 02:46:38 INFO - PROCESS | 8145 | |5;yui.html;693.9826504337394;703.2088899987517;707.9327463890929;751.7105914223023;805.5368163306099;15462.845371546282;16556.586085347873;16722.41471548496;16776.916115419423;16810.495685129452;14093.78859317111;14118.717625647481;14220.573382798506;15231.238438078108;15397.076175429482;784.2784638132931;796.2316364708056;806.0528878567688;807.8101646113158;808.6846130009271;792.13657113746;807;810.0522388805113;817.7914631768921;819.2094628683319;847.9703210387638;848.0417128644623;850.2985037344184;850.5322072859933;850.5959669157163;842.9747107586783;843.2284459719349;843.5697794125041;843.9324854011695;844.3962566764762;617.4967401567708;619.6313193649771;621.549376701892;622.4740094620039;622.7695752571532;15298.694026119527;15443.691126177526;15462.768058479132;15469.613259668486;15480.22598870052;14548.418063277457;14582.562523124323;14832.629184270372;15022.399104035825;15128.394864205418;11924.224925379822;12102.81845772314;12172.756544869142;12200.511979520898;12982.545610903668;3827.7129215308964;3853.5953724859046;3906.941395879064;4006.8797936061965;4014.598540145991;81950;84489.15510844874;84586;84965.15034849635;86049.97650164491;10441.425721585234;10488.213383996232;10837.18721095921;10930.508127134299;11427.48576314068;22123.778762212172;22197.1121155152;22214;22363.88818055932;22385.664215036788;8039.477433966774;8263.380246481538;8388.8741668875;8729.694460693845;8768.167024132697;4423.248047831877;4629.189891768927;4633.675642704979;4674.392328997209;4824.421069471686;3291.736661067109;3364.091695242271;3405.778624389456;3405.965940340565;3409.7272218222483;573.8565358660335;580.2282963658324;584.5995493087164;593.551868339401;599.2958274028;645.5674697952384;678.6369292428626;688.896665500169;767.1791183433672;795.0657976877146;8653.221210090996;9395.973154362411;9536;9758.853617195606;9857.852132218022;695.0408436357895;712.7398499547628;721.3634167119188;753.5441058159844;758.2796343473722;4102.2821006323775;4229.267126290196;4513.977430112828;4621.32990716351;4624.791884365211;121355;121450;121710;123878;128781;104041.87350960613;110723.44638276756;112620.43689781499;115207;117685.4115729416;93121.53439232761;94728.52635736915;96512;97251;99718.5014074925;8154.755357339052;8552.187542183483;8586.871196931927;8658;8665;39217.41173882337;47833.76083119562;50818.74590627023;51478.74260628673;52659.21011184912;73490.63254683692;81357.59321203356;82516;84902.57548712217;85544.57227713821;10641.361518308926;10743.08683761889;11240.606578769704;11500.194986351209;11555.364454955059;12448.62654120378;12575.308358040396;12956.870431295567;13028.739425211632;13231.735365292832;12344.506219751109;12524.93737531343;12587.93706031464;12750.936245318713;13195.538156164488;11246.381449020055;11397.577828961836;11737.530498779954;11814.173007889365;12220.633380998228;11719.238249513754;12277.447514862031;12443.253404795742;12524.499020039097;12824.067655621706;8803.119688031402;8994.235489983424;9144.451332920045;9173;9320.254379649476;10342.741431464274;10524.421156836448;10731.248812583044;10742.140628749525;10859.185561082792 02:46:38 INFO - PROCESS | 8145 | __end_tp_report 02:46:38 INFO - PROCESS | 8145 | __start_cc_report 02:46:38 INFO - PROCESS | 8145 | _x_x_mozilla_cycle_collect,305 02:46:38 INFO - PROCESS | 8145 | __end_cc_report 02:46:38 INFO - PROCESS | 8145 | __startTimestamp1474451198852__endTimestamp 02:46:38 INFO - PROCESS | 8145 | 02:46:38 INFO - PROCESS | 8145 | ------- Summary: start ------- 02:46:38 INFO - PROCESS | 8145 | Number of tests: 6 02:46:38 INFO - PROCESS | 8145 | 02:46:38 INFO - PROCESS | 8145 | [#0] dojo.html Cycles:165 Average:5364.92 Median:5585.53 stddev:612.36 (11.0%) stddev-sans-first:587.45 02:46:38 INFO - PROCESS | 8145 | Values: 3081.5 3096.5 3137.6 3142.9 3148.0 5246.1 5408.5 5413.8 5440.3 5442.0 5270.3 5359.5 5443.1 5449.2 5501.1 4891.2 4984.0 4985.9 4999.1 5048.3 4931.1 4975.6 4984.2 4996.4 5000.2 4742.8 4810.4 4847.5 4920.4 4928.3 4955.8 4957.2 4965.5 4996.0 5006.9 4819.1 4916.6 4922.1 4929.7 4975.1 5260.1 5305.6 5350.7 5414.9 5437.3 5757.1 5789.8 5800.6 5822.5 5850.2 5802.0 5812.5 5823.0 5827.8 5834.5 5279.3 5329.8 5411.1 5411.8 5425.9 5864.4 5885.4 5921.5 5948.8 6008.0 5639.0 5686.7 5688.8 5694.6 5706.9 5596.3 5631.9 5740.4 5785.9 5803.2 5589.8 5597.7 5667.3 5686.6 5695.1 5675.6 5699.7 5700.2 5734.9 5736.4 4400.1 4405.8 4411.6 4413.2 4458.4 3929.0 3931.1 3940.3 3960.7 3978.3 5376.2 5410.1 5439.6 5443.9 5544.8 5873.3 5878.9 5885.1 5885.2 5890.3 5479.5 5518.1 5520.3 5527.8 5528.4 4670.9 4738.7 4836.1 4844.7 4857.0 5965.6 5977.1 5985.0 5986.0 6054.7 5779.1 5804.6 5805.9 5805.9 5812.9 5793.9 5835.0 5940.6 5963.3 6001.3 5709.9 5749.0 5751.4 5805.4 5813.6 5798.6 5857.8 5867.3 5870.3 5875.9 5544.8 5585.7 5605.7 5727.8 5736.1 5588.0 5635.7 5644.1 5680.4 5697.3 5541.1 5554.6 5561.1 5566.7 5585.5 5513.8 5563.4 5612.9 5654.3 5680.4 5604.0 5606.2 5609.9 5653.3 5671.0 02:46:38 INFO - PROCESS | 8145 | 02:46:38 INFO - PROCESS | 8145 | [#1] ext.html Cycles:180 Average:46536.90 Median:39523.30 stddev:84818.03 (214.6%) stddev-sans-first:84985.64 02:46:38 INFO - PROCESS | 8145 | Values: 536.0 585.4 588.8 591.3 603.0 41153.2 42869.8 42924.6 46812.3 46846.5 43129.4 43710.6 43745.0 43787.8 43896.3 8856.5 8948.3 8986.3 9004.0 9032.5 8878.0 8892.6 8928.7 8953.6 8978.8 8982.1 8995.3 9002.6 9016.6 9027.9 8930.0 8951.8 8984.2 8995.6 9006.8 8805.1 8861.7 8903.1 8938.4 8949.9 40460.2 40824.0 40973.4 41082.8 41103.0 3440.6 4056.6 4138.5 4174.7 4185.5 31337.2 31424.5 31546.8 32022.4 32098.5 4255.5 4422.2 4449.3 4610.0 4610.6 346336.0 346372.0 346397.0 347386.0 347952.0 35925.3 36767.4 36783.4 55650.4 55825.0 36561.6 36944.6 37043.8 37065.3 37211.0 15427.8 15584.5 15653.1 15681.8 15710.4 13004.5 13074.3 13111.8 13132.0 13167.5 8456.2 8507.4 8585.2 8595.1 8614.7 3335.6 3358.1 3403.9 3418.3 3431.1 949.9 1004.3 1051.4 1089.6 1137.8 30560.0 30956.5 31074.7 31401.5 31405.5 1072.9 1109.6 1146.4 1178.5 1185.0 16208.6 16307.3 16513.4 16536.8 16543.8 144081.3 144448.0 144705.3 145104.0 146210.0 54778.0 55285.2 55362.4 55501.2 55664.4 1297.0 1339.6 1348.2 1367.1 1383.1 28528.4 30311.5 30512.5 30741.5 30801.0 47964.5 48292.8 48303.3 48338.5 48433.8 405558.0 407610.0 407981.0 408410.0 408687.0 27246.8 27293.7 27649.7 27668.6 27920.6 44543.8 45199.3 45843.8 46222.3 46460.1 38601.4 39515.6 39837.0 40768.4 40951.8 38882.8 39010.4 39136.8 39235.2 39531.0 38640.0 39399.0 40261.2 40410.2 41927.0 31752.7 34344.0 36105.6 36739.6 36878.2 27104.0 27265.7 27713.9 27737.0 27781.6 02:46:38 INFO - PROCESS | 8145 | 02:46:38 INFO - PROCESS | 8145 | [#2] jquery.html Cycles:180 Average:28204.36 Median:43538.74 stddev:77043.68 (177.0%) stddev-sans-first:77231.49 02:46:38 INFO - PROCESS | 8145 | Values: 385.3 388.3 389.3 396.1 418.2 16048.2 16736.2 18113.0 19590.2 19654.2 12801.9 12952.2 16768.2 18134.8 19669.8 5284.3 5431.4 5431.7 5437.9 5487.8 5747.1 6002.3 6032.4 6109.4 6136.9 5991.3 6021.3 6125.0 6134.3 6136.5 6048.3 6073.8 6083.9 6098.8 6119.6 5798.8 5851.0 5895.4 5895.7 5964.6 14166.2 14293.4 14432.3 14476.6 14547.3 2420.3 2521.4 2621.6 2882.5 2894.6 9962.6 10523.7 10744.3 10870.1 10999.3 1913.4 1964.7 1986.8 2007.9 2008.0 83889.0 86284.6 88813.6 89623.6 91815.5 11377.9 11486.0 11576.0 11604.8 11672.8 15946.2 15999.8 16086.8 16117.9 16120.3 7874.3 8073.8 8580.5 8768.2 8802.1 8323.3 8388.6 8390.1 8613.5 8653.1 4709.4 4867.9 4964.7 4974.4 4999.2 2021.9 2025.6 2047.7 2049.3 2112.3 901.6 940.4 959.2 979.1 1002.3 17819.6 19151.3 19247.7 19459.3 19567.3 919.6 962.2 972.9 973.2 1031.0 8926.8 10479.7 10871.3 10900.0 10909.4 450831.0 450937.0 469440.0 474209.0 476028.0 92945.5 95086.0 96159.5 96185.0 96382.5 936.9 961.2 984.2 988.1 995.0 16430.3 16442.8 16819.2 17174.7 17225.9 42725.4 42831.4 43431.1 43646.3 44272.0 57820.0 58979.7 60392.0 60416.4 60743.7 5718.7 7889.5 8274.0 8352.2 8578.3 6934.5 9216.8 11509.0 12341.4 12357.8 10683.1 10921.5 11080.9 11180.6 11440.9 11030.3 11061.7 11088.1 11153.8 11210.3 10839.7 10926.3 11091.4 11187.0 11344.8 7577.8 8089.7 8256.5 8348.9 8399.5 10281.8 10415.5 10683.6 10802.2 11446.2 02:46:38 INFO - PROCESS | 8145 | 02:46:38 INFO - PROCESS | 8145 | [#3] mootools.html Cycles:180 Average:5621.38 Median:4965.60 stddev:3161.61 (63.7%) stddev-sans-first:3154.99 02:46:38 INFO - PROCESS | 8145 | Values: 1455.9 1496.7 1601.1 1716.0 1756.4 7704.2 7900.7 8249.4 8821.9 8823.0 8344.2 8575.5 8588.7 8831.7 8850.8 2350.5 2374.7 2383.4 2384.0 2385.7 2323.7 2340.9 2362.7 2370.7 2373.4 2342.7 2346.4 2350.2 2363.6 2371.2 2311.8 2334.9 2341.1 2343.0 2345.1 2301.4 2305.4 2308.1 2319.2 2331.9 8700.4 8742.6 8742.7 8797.0 8797.2 4980.8 5093.1 5100.9 5110.7 5136.7 3270.8 3340.9 3403.9 3413.8 3461.2 1067.9 1111.4 1112.6 1123.8 1126.8 11842.6 11846.2 11847.4 11881.8 11914.3 4348.8 4486.7 4525.7 4600.6 4643.0 10182.4 10186.4 10186.5 10190.2 10213.6 5156.3 5164.9 5167.0 5168.9 5170.6 4212.9 4317.1 4537.3 4612.4 4700.9 3629.8 3758.4 3793.3 3802.6 3821.2 1233.3 1279.2 1283.2 1297.8 1318.9 875.3 880.3 890.0 915.1 926.2 5514.7 5571.4 5713.3 5746.6 5798.6 937.4 952.0 964.1 980.5 1027.4 3742.0 3976.4 4022.4 4032.3 4124.8 10152.4 10530.8 10561.2 10778.9 10803.7 10540.2 10559.2 10573.6 10582.3 10713.6 7861.6 8126.2 8126.5 8129.3 8144.3 5316.5 5504.7 5549.1 5698.7 5707.7 9382.5 9390.7 9422.1 9498.2 9573.0 9388.9 9552.5 9569.6 9582.7 9670.0 6987.5 7184.5 7376.1 7628.4 7785.6 8024.5 8333.0 8337.5 8339.9 8360.0 7350.6 7398.9 7479.6 7503.5 7642.3 7119.1 7206.2 7242.2 7274.6 7456.0 6865.3 6867.9 6871.8 6902.4 6914.9 4950.4 5024.5 5033.4 5063.1 5110.1 4710.4 4772.1 4903.4 4918.3 4989.2 02:46:38 INFO - PROCESS | 8145 | 02:46:38 INFO - PROCESS | 8145 | [#4] prototype.html Cycles:180 Average:4770.95 Median:5349.10 stddev:1421.81 (26.6%) stddev-sans-first:1385.46 02:46:38 INFO - PROCESS | 8145 | Values: 290.7 311.7 316.7 331.1 332.4 5217.6 5468.7 5505.1 5573.9 5609.3 5335.9 5512.6 5522.6 5526.0 5544.0 4323.2 4334.4 4338.6 4345.1 4347.7 4276.5 4284.2 4335.5 4340.9 4355.3 4234.8 4259.4 4260.7 4266.2 4293.7 4255.6 4267.4 4278.1 4291.3 4297.4 3715.1 3768.5 3777.9 3778.4 3779.8 5310.6 5315.9 5348.8 5374.8 5440.8 4809.7 4827.9 4833.8 4842.5 4874.6 5612.6 5706.4 5716.2 5733.4 5755.2 3958.6 4014.3 4026.3 4031.5 4062.3 5797.7 5966.2 5994.1 6017.5 6052.7 4192.8 4201.5 4217.3 4218.5 4238.7 4274.7 4284.2 4288.7 4307.0 4319.5 4776.9 4883.9 4931.2 4932.6 4945.1 5771.2 5783.1 5788.9 5790.0 5790.3 1464.2 1478.3 1478.4 1479.4 1480.8 910.0 940.3 950.4 952.2 959.2 4866.6 4899.2 4905.5 4912.3 4918.7 5211.2 5230.0 5231.7 5243.9 5279.9 4546.5 4842.3 4867.9 4889.9 4930.7 2758.0 2758.4 2761.4 2763.6 2789.4 5303.9 5370.3 5374.6 5376.7 5381.0 5349.4 5362.7 5607.6 6106.2 6143.6 6175.7 6177.4 6187.7 6214.6 6237.5 5669.6 5937.8 5947.8 5987.6 6018.7 5872.9 5877.1 5890.6 5929.1 5961.0 5958.8 6163.7 6170.7 6221.5 6230.3 4106.8 4152.8 4160.9 4166.9 4167.9 5750.3 6007.6 6026.4 6031.9 6051.5 5765.5 5768.6 5769.7 5774.4 5804.9 5850.6 5860.2 5861.6 5879.5 5883.2 5428.5 5711.3 5752.2 5755.5 5761.5 5838.9 5843.2 5895.9 5900.2 5919.2 5514.9 5735.3 5784.9 5804.7 5813.3 02:46:38 INFO - PROCESS | 8145 | 02:46:38 INFO - PROCESS | 8145 | [#5] yui.html Cycles:180 Average:21741.45 Median:4623.06 stddev:33086.07 (715.7%) stddev-sans-first:33141.14 02:46:38 INFO - PROCESS | 8145 | Values: 694.0 703.2 707.9 751.7 805.5 15462.8 16556.6 16722.4 16776.9 16810.5 14093.8 14118.7 14220.6 15231.2 15397.1 784.3 796.2 806.1 807.8 808.7 792.1 807.0 810.1 817.8 819.2 848.0 848.0 850.3 850.5 850.6 843.0 843.2 843.6 843.9 844.4 617.5 619.6 621.5 622.5 622.8 15298.7 15443.7 15462.8 15469.6 15480.2 14548.4 14582.6 14832.6 15022.4 15128.4 11924.2 12102.8 12172.8 12200.5 12982.5 3827.7 3853.6 3906.9 4006.9 4014.6 81950.0 84489.2 84586.0 84965.2 86050.0 10441.4 10488.2 10837.2 10930.5 11427.5 22123.8 22197.1 22214.0 22363.9 22385.7 8039.5 8263.4 8388.9 8729.7 8768.2 4423.2 4629.2 4633.7 4674.4 4824.4 3291.7 3364.1 3405.8 3406.0 3409.7 573.9 580.2 584.6 593.6 599.3 645.6 678.6 688.9 767.2 795.1 8653.2 9396.0 9536.0 9758.9 9857.9 695.0 712.7 721.4 753.5 758.3 4102.3 4229.3 4514.0 4621.3 4624.8 121355.0 121450.0 121710.0 123878.0 128781.0 104041.9 110723.4 112620.4 115207.0 117685.4 93121.5 94728.5 96512.0 97251.0 99718.5 8154.8 8552.2 8586.9 8658.0 8665.0 39217.4 47833.8 50818.7 51478.7 52659.2 73490.6 81357.6 82516.0 84902.6 85544.6 10641.4 10743.1 11240.6 11500.2 11555.4 12448.6 12575.3 12956.9 13028.7 13231.7 12344.5 12524.9 12587.9 12750.9 13195.5 11246.4 11397.6 11737.5 11814.2 12220.6 11719.2 12277.4 12443.3 12524.5 12824.1 8803.1 8994.2 9144.5 9173.0 9320.3 10342.7 10524.4 10731.2 10742.1 10859.2 02:46:38 INFO - PROCESS | 8145 | -------- Summary: end -------- 02:46:38 INFO - PROCESS | 8145 | 02:46:39 INFO - TEST-INFO | 8145: exit 0 02:46:39 INFO - TEST-OK | dromaeo_css | took 1114170ms 02:46:39 INFO - TEST-START | kraken 02:46:39 INFO - operating with platform_type : linux_ 02:46:39 INFO - Initialising browser for kraken test... 02:46:39 INFO - TEST-INFO | started process 8506 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnaehAV/profile http://localhost:36577/getInfo.html) 02:46:44 INFO - PROCESS | 8506 | __metrics Screen width/height:1600/1200 02:46:44 INFO - PROCESS | 8506 | colorDepth:24 02:46:44 INFO - PROCESS | 8506 | Browser inner width/height: 1024/697 02:46:44 INFO - PROCESS | 8506 | __metrics 02:46:45 ERROR - PROCESS | 8506 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 02:46:46 INFO - TEST-INFO | 8506: exit 0 02:46:46 INFO - Browser initialized. 02:46:46 INFO - Running cycle 1/1 for kraken test... 02:46:46 INFO - TEST-INFO | started process 8628 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnaehAV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:46:58 INFO - PROCESS | 8628 | RSS: Main: 184868864 02:46:58 INFO - PROCESS | 8628 | 02:47:01 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:36577/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36577/tests/kraken/driver.html?testName=audio-beat-detection) 02:47:02 INFO - PROCESS | 8628 | RSS: Main: 198705152 02:47:02 INFO - PROCESS | 8628 | 02:47:04 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:36577/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36577/tests/kraken/driver.html?testName=audio-dft) 02:47:05 INFO - PROCESS | 8628 | RSS: Main: 197210112 02:47:05 INFO - PROCESS | 8628 | 02:47:08 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:36577/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36577/tests/kraken/driver.html?testName=audio-fft) 02:47:08 INFO - PROCESS | 8628 | RSS: Main: 192499712 02:47:08 INFO - PROCESS | 8628 | 02:47:11 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:36577/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36577/tests/kraken/driver.html?testName=audio-oscillator) 02:47:11 INFO - PROCESS | 8628 | RSS: Main: 193122304 02:47:11 INFO - PROCESS | 8628 | 02:47:13 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:36577/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36577/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:47:14 INFO - PROCESS | 8628 | RSS: Main: 193114112 02:47:14 INFO - PROCESS | 8628 | 02:47:17 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:36577/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36577/tests/kraken/driver.html?testName=imaging-darkroom) 02:47:18 INFO - PROCESS | 8628 | RSS: Main: 193486848 02:47:18 INFO - PROCESS | 8628 | 02:47:21 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:36577/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36577/tests/kraken/driver.html?testName=imaging-desaturate) 02:47:22 INFO - PROCESS | 8628 | RSS: Main: 193650688 02:47:22 INFO - PROCESS | 8628 | 02:47:25 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:36577/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36577/tests/kraken/driver.html?testName=json-parse-financial) 02:47:25 INFO - PROCESS | 8628 | RSS: Main: 193892352 02:47:25 INFO - PROCESS | 8628 | 02:47:27 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:36577/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36577/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:47:27 INFO - PROCESS | 8628 | RSS: Main: 193720320 02:47:27 INFO - PROCESS | 8628 | 02:47:29 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:36577/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36577/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:47:30 INFO - PROCESS | 8628 | RSS: Main: 193396736 02:47:30 INFO - PROCESS | 8628 | 02:47:32 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:36577/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36577/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:47:33 INFO - PROCESS | 8628 | RSS: Main: 194670592 02:47:33 INFO - PROCESS | 8628 | 02:47:35 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:36577/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:47:36 INFO - PROCESS | 8628 | RSS: Main: 194011136 02:47:36 INFO - PROCESS | 8628 | 02:47:39 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:36577/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:47:39 INFO - PROCESS | 8628 | RSS: Main: 194199552 02:47:39 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | Cycle 1(1): loaded http://localhost:36577/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36577/tests/kraken/driver.html?testName=ai-astar) 02:47:41 INFO - PROCESS | 8628 | RSS: Main: 195874816 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | __start_tp_report 02:47:41 INFO - PROCESS | 8628 | _x_x_mozilla_page_load 02:47:41 INFO - PROCESS | 8628 | _x_x_mozilla_page_load_details 02:47:41 INFO - PROCESS | 8628 | |i|pagename|runs| 02:47:41 INFO - PROCESS | 8628 | |0;ai-astar;107;115;115;116;114;115;114;114;113;115 02:47:41 INFO - PROCESS | 8628 | |1;audio-beat-detection;158;121;121;168;128;127;127;124;159;121 02:47:41 INFO - PROCESS | 8628 | |2;audio-dft;163;166;166;167;166;163;163;162;163;163 02:47:41 INFO - PROCESS | 8628 | |3;audio-fft;77;77;77;112;77;77;77;75;116;76 02:47:41 INFO - PROCESS | 8628 | |4;audio-oscillator;84;84;109;85;85;84;107;84;83;109 02:47:41 INFO - PROCESS | 8628 | |5;imaging-gaussian-blur;118;117;117;117;118;118;118;118;119;118 02:47:41 INFO - PROCESS | 8628 | |6;imaging-darkroom;147;149;148;148;148;147;147;148;149;147 02:47:41 INFO - PROCESS | 8628 | |7;imaging-desaturate;96;95;95;96;96;95;95;96;96;96 02:47:41 INFO - PROCESS | 8628 | |8;json-parse-financial;53;52;54;53;52;52;55;53;52;53 02:47:41 INFO - PROCESS | 8628 | |9;json-stringify-tinderbox;61;61;62;61;63;61;63;61;62;62 02:47:41 INFO - PROCESS | 8628 | |10;stanford-crypto-aes;82;80;80;85;79;80;81;79;80;86 02:47:41 INFO - PROCESS | 8628 | |11;stanford-crypto-ccm;131;134;125;126;136;128;132;137;165;126 02:47:41 INFO - PROCESS | 8628 | |12;stanford-crypto-pbkdf2;167;170;165;170;167;169;165;165;165;169 02:47:41 INFO - PROCESS | 8628 | |13;stanford-crypto-sha256-iterative;71;66;65;67;66;65;65;68;64;66 02:47:41 INFO - PROCESS | 8628 | __end_tp_report 02:47:41 INFO - PROCESS | 8628 | __start_cc_report 02:47:41 INFO - PROCESS | 8628 | _x_x_mozilla_cycle_collect,810 02:47:41 INFO - PROCESS | 8628 | __end_cc_report 02:47:41 INFO - PROCESS | 8628 | __startTimestamp1474451261751__endTimestamp 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | ------- Summary: start ------- 02:47:41 INFO - PROCESS | 8628 | Number of tests: 14 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | [#0] ai-astar Cycles:10 Average:113.80 Median:115.00 stddev:2.53 (2.2%) stddev-sans-first:0.88 02:47:41 INFO - PROCESS | 8628 | Values: 107.0 115.0 115.0 116.0 114.0 115.0 114.0 114.0 113.0 115.0 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:127.50 stddev:18.49 (14.5%) stddev-sans-first:17.72 02:47:41 INFO - PROCESS | 8628 | Values: 158.0 121.0 121.0 168.0 128.0 127.0 127.0 124.0 159.0 121.0 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.50 stddev:1.81 (1.1%) stddev-sans-first:1.87 02:47:41 INFO - PROCESS | 8628 | Values: 163.0 166.0 166.0 167.0 166.0 163.0 163.0 162.0 163.0 163.0 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | [#3] audio-fft Cycles:10 Average:84.10 Median:77.00 stddev:15.80 (20.5%) stddev-sans-first:16.55 02:47:41 INFO - PROCESS | 8628 | Values: 77.0 77.0 77.0 112.0 77.0 77.0 77.0 75.0 116.0 76.0 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:84.00 stddev:11.71 (13.9%) stddev-sans-first:12.11 02:47:41 INFO - PROCESS | 8628 | Values: 84.0 84.0 109.0 85.0 85.0 84.0 107.0 84.0 83.0 109.0 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 02:47:41 INFO - PROCESS | 8628 | Values: 118.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 119.0 118.0 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 02:47:41 INFO - PROCESS | 8628 | Values: 147.0 149.0 148.0 148.0 148.0 147.0 147.0 148.0 149.0 147.0 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:47:41 INFO - PROCESS | 8628 | Values: 96.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.99 (1.9%) stddev-sans-first:1.05 02:47:41 INFO - PROCESS | 8628 | Values: 53.0 52.0 54.0 53.0 52.0 52.0 55.0 53.0 52.0 53.0 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 02:47:41 INFO - PROCESS | 8628 | Values: 61.0 61.0 62.0 61.0 63.0 61.0 63.0 61.0 62.0 62.0 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.50 stddev:2.44 (3.0%) stddev-sans-first:2.57 02:47:41 INFO - PROCESS | 8628 | Values: 82.0 80.0 80.0 85.0 79.0 80.0 81.0 79.0 80.0 86.0 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:133.00 stddev:11.70 (8.8%) stddev-sans-first:12.36 02:47:41 INFO - PROCESS | 8628 | Values: 131.0 134.0 125.0 126.0 136.0 128.0 132.0 137.0 165.0 126.0 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.20 Median:168.00 stddev:2.15 (1.3%) stddev-sans-first:2.28 02:47:41 INFO - PROCESS | 8628 | Values: 167.0 170.0 165.0 170.0 167.0 169.0 165.0 165.0 165.0 169.0 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:2.00 (3.0%) stddev-sans-first:1.20 02:47:41 INFO - PROCESS | 8628 | Values: 71.0 66.0 65.0 67.0 66.0 65.0 65.0 68.0 64.0 66.0 02:47:41 INFO - PROCESS | 8628 | -------- Summary: end -------- 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000C,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | 02:47:41 INFO - PROCESS | 8628 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 02:47:41 INFO - PROCESS | 8628 | 02:47:42 INFO - TEST-INFO | 8628: exit 0 02:47:42 INFO - TEST-OK | kraken | took 62913ms 02:47:42 INFO - SUITE-END | took 1177s 02:47:42 INFO - Completed test suite (00:19:37) 02:47:42 INFO - javascript benchmark 02:47:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7074.361050384586, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3081.5377693345995, 3096.4890793019154, 3137.576427182331, 3142.8585713642883, 3147.9842600787006, 5246.108161612526, 5408.513233808956, 5413.815802597191, 5440.347158341, 5442.0, 5270.262163297141, 5359.464053594638, 5443.129099344106, 5449.182622606611, 5501.092319767244, 4891.241857512083, 4983.975080124595, 4985.850424487271, 4999.100161970844, 5048.268001139851, 4931.137051016076, 4975.626827987898, 4984.202527595586, 4996.350474438336, 5000.19996800512, 4742.762861856911, 4810.446798618169, 4847.515248475124, 4920.384951881015, 4928.334674818925, 4955.826546070906, 4957.182064959277, 4965.478624744386, 4996.0, 5006.924896126561, 4819.0602832447685, 4916.606671466274, 4922.114019476493, 4929.728864912428, 4975.104481193383, 5260.105782017028, 5305.602079843989, 5350.678959262456, 5414.931751689993, 5437.265969094161, 5757.0788673811985, 5789.768409263625, 5800.564957628195, 5822.505087067604, 5850.210221620069, 5802.0, 5812.534997200214, 5822.97088514559, 5827.796027139072, 5834.5040671542965, 5279.340082489689, 5329.760160792774, 5411.053065713484, 5411.783528658849, 5425.864353391197, 5864.354920958691, 5885.382034886361, 5921.496672782861, 5948.821535353946, 6007.969960150172, 5639.041362968305, 5686.687232202185, 5688.800891968761, 5694.60137790359, 5706.857328566736, 5596.300462442195, 5631.915521267184, 5740.368559458456, 5785.913211301834, 5803.187553742479, 5589.80435684749, 5597.720113994284, 5667.291588551431, 5686.5735069869925, 5695.145728140729, 5675.602707810413, 5699.74351154199, 5700.173474846124, 5734.885302293931, 5736.397678243808, 4400.09797991411, 4405.801738921757, 4411.602955733999, 4413.227685155085, 4458.4426946631675, 3928.9784655989647, 3931.0958479549863, 3940.2513522430645, 3960.7227494075714, 3978.264021156095, 5376.193570964387, 5410.1343784994215, 5439.592030597721, 5443.918341224885, 5544.805931792368, 5873.2658417697785, 5878.941210587925, 5885.058390657474, 5885.176075349455, 5890.322612899571, 5479.479449452296, 5518.089515229942, 5520.282363292827, 5527.751251193706, 5528.44715528444, 4670.929936050962, 4738.715677059387, 4836.081144582518, 4844.685095468783, 4857.028594281158, 5965.582409231399, 5977.103434484862, 5985.042393217064, 5986.042233242661, 6054.666993315322, 5779.075347944308, 5804.564657650609, 5805.912911306418, 5805.94194058054, 5812.912806307824, 5793.855153621024, 5835.0, 5940.61386009908, 5963.2844058713235, 6001.309849367379, 5709.942900570941, 5748.971255143698, 5751.367349591458, 5805.419458054161, 5813.593048486566, 5798.59409841307, 5857.824265272048, 5867.325257595431, 5870.324912634931, 5875.853103672443, 5544.7782088716, 5585.664860108406, 5605.691686957257, 5727.770889164387, 5736.1109028099045, 5588.0, 5635.6618602883955, 5644.096944488862, 5680.4319568042865, 5697.259356283822, 5541.113421852484, 5554.638948468337, 5561.138023606348, 5566.666000040011, 5585.525230355465, 5513.807016754395, 5563.443655634404, 5612.887742245214, 5654.293213348332, 5680.375158732453, 5604.019296622993, 5606.215129881738, 5609.887802244014, 5653.265075540154, 5671.0], "value": 5323.364318982184, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.004280524552, 585.3502612100565, 588.7644942023193, 591.3347484080409, 602.9517638588912, 41153.17693646129, 42869.7856510717, 42924.57075429245, 46812.29781553271, 46846.53153468464, 43129.35305970413, 43710.56289437105, 43745.0, 43787.78106109473, 43896.3415548767, 8856.468611883292, 8948.284137269035, 8986.326025548078, 9003.95498022509, 9032.548372581377, 8878.0, 8892.644294228256, 8928.687495937644, 8953.552322383888, 8978.775530611721, 8982.10178982103, 8995.325350598698, 9002.594883230271, 9016.594253258587, 9027.864582031274, 8930.0, 8951.776205594848, 8984.23633991105, 8995.640174393016, 9006.774830629254, 8805.119488051208, 8861.73414797557, 8903.06517815633, 8938.4190027648, 8949.865752013726, 40460.19079618421, 40824.0, 40973.385399219034, 41082.79458602688, 41103.0, 3440.55272814535, 4056.553779084298, 4138.544760076419, 4174.666026717886, 4185.455890734215, 31337.216569585715, 31424.528632070538, 31546.842265788753, 32022.35955280881, 32098.518522222184, 4255.5318914919335, 4422.181896349153, 4449.310356894686, 4609.953900460986, 4610.631149508032, 346336.0, 346371.9999999975, 346397.0, 347386.0, 347952.0, 35925.28149436996, 36767.4484882727, 36783.4482482763, 55650.443495565334, 55825.0, 36561.63438365582, 36944.63055369466, 37043.814780925924, 37065.258694825956, 37211.0, 15427.768583471257, 15584.454544090902, 15653.139077350626, 15681.764773528406, 15710.371585136696, 13004.479820807252, 13074.346282685829, 13111.803322950163, 13132.0, 13167.47330106785, 8456.196661317164, 8507.447015944068, 8585.227329540372, 8595.097514760984, 8614.741557753152, 3335.6497567755523, 3358.1101008232836, 3403.863845446204, 3418.3163367326633, 3431.1079119428628, 949.9477528735848, 1004.2668851738126, 1051.379685985257, 1089.629525961177, 1137.7951968645557, 30560.0, 30956.535651965238, 31074.68925310718, 31401.52897706536, 31405.52891706626, 1072.8819829818713, 1109.5506319940437, 1146.4497041420166, 1178.4755783676183, 1184.9585264515702, 16208.59478513023, 16307.347706091623, 16513.422030228885, 16536.75194872078, 16543.83456165447, 144081.27959360136, 144448.0, 144705.27647361695, 145104.0, 146210.0, 54778.0, 55285.170722439194, 55362.446375536536, 55501.16748248779, 55664.44335556593, 1296.9870301296867, 1339.6048165791115, 1348.157401623985, 1367.09771550776, 1383.1148065238256, 28528.42943141084, 30311.545326820557, 30512.542311864894, 30741.538876916416, 30801.032047259392, 47964.5203547974, 48292.7585362071, 48303.275450867564, 48338.5166148334, 48433.82047807787, 405558.0, 407610.0, 407981.0, 408410.0, 408687.0, 27246.782511154866, 27293.72706272912, 27649.723502764715, 27668.584971225046, 27920.581191282552, 44543.777281113384, 45199.32201016921, 45843.77078114588, 46222.306665399374, 46460.07079858316, 38601.42097868591, 39515.604843951194, 39837.0, 40768.388474172316, 40951.7952410236, 38882.80558597302, 39010.41484377794, 39136.80431597824, 39235.2152956945, 39531.0, 38640.0, 39399.0, 40261.19477610373, 40410.1917961645, 41927.0, 31752.682473174973, 34344.0, 36105.63894361128, 36739.63260367362, 36878.18527031035, 27104.0, 27265.727342727114, 27713.861430693523, 27737.0, 27781.58327625047], "value": 17983.227288889288, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.3352966133422, 388.2661769256106, 389.28760368525616, 396.11863603482254, 418.19914863037286, 16048.197590120477, 16736.2468688909, 18113.0, 19590.216391344347, 19654.21383144674, 12801.935990320035, 12952.158109722885, 16768.245428955695, 18134.81865181348, 19669.803301966975, 5284.260203571494, 5431.375391829931, 5431.6740995540395, 5437.945620543804, 5487.780488780464, 5747.109198074305, 6002.279726432834, 6032.366601506845, 6109.35851735568, 6136.938630613681, 5991.281046274431, 6021.337652858182, 6125.0, 6134.263888333407, 6136.539759518032, 6048.274207095154, 6073.817785466443, 6083.939160608404, 6098.786542471036, 6119.571629985903, 5798.797042103548, 5850.971267196694, 5895.35151133375, 5895.675737834417, 5964.612300200516, 14166.150030998173, 14293.356798943969, 14432.278386080654, 14476.638084047878, 14547.345369458293, 2420.346506443268, 2521.445282037949, 2621.580547112472, 2882.495563276418, 2894.609227754247, 9962.601495940226, 10523.73690657732, 10744.301620394728, 10870.076043536308, 10999.34003959765, 1913.4068438783881, 1964.7151163081417, 1986.7913869043687, 2007.9196832126697, 2007.9598408031757, 83889.0, 86284.56857715671, 88813.55593221993, 89623.55188224082, 91815.54092229562, 11377.88622113785, 11486.0, 11576.0, 11604.76790464186, 11672.766544669059, 15946.20268986546, 15999.760003599955, 16086.75869861953, 16117.919410402874, 16120.274587643584, 7874.291313781672, 8073.838523229502, 8580.528070956158, 8768.167024132697, 8802.119788021148, 8323.292520135736, 8388.586902415174, 8390.119037500974, 8613.526256055977, 8653.134686531297, 4709.364235828188, 4867.853964381075, 4964.726940018334, 4974.37820272466, 4999.225120106389, 2021.86857854239, 2025.584755125196, 2047.7337946066916, 2049.272508259576, 2112.3240563019995, 901.5762591581946, 940.3840484482674, 959.2469911119738, 979.1090108001827, 1002.293383164867, 17819.643607127786, 19151.329703460313, 19247.711284330748, 19459.318923837596, 19567.315143969892, 919.5861862162054, 962.1869520255373, 972.9367591106555, 973.2311473935512, 1030.9639162629271, 8926.776830579287, 10479.738006549896, 10871.347719136718, 10900.0, 10909.39998300101, 450831.0, 450937.0, 469440.0, 474209.0, 476028.0, 92945.5352723232, 95086.0, 96159.51920240354, 96185.0, 96382.51808740912, 936.9109934556207, 961.1589858873485, 984.2322988069318, 988.0662773678805, 994.9801003980025, 16430.342786288413, 16442.83557164461, 16819.24313405924, 17174.742378864077, 17225.913870430566, 42725.35911961385, 42831.3575296377, 43431.13137737165, 43646.34530481982, 44272.0, 57819.961914636406, 58979.70510147422, 60392.0, 60416.395836041076, 60743.69628151831, 5718.742656580547, 7889.487183333065, 8273.958630206811, 8352.248297653241, 8578.270846978077, 6934.514583979073, 9216.769580760534, 11509.021733152777, 12341.3829308536, 12357.814632780695, 10683.145348372267, 10921.453927303444, 11080.944595276973, 11180.55277788912, 11440.885591143982, 11030.283031603241, 11061.723456913642, 11088.057515110982, 11153.832692509457, 11210.327380356879, 10839.67480975572, 10926.289791163548, 11091.445427728742, 11187.049100826522, 11344.829827552428, 7577.772666820004, 8089.716859909875, 8256.545889976109, 8348.916510835057, 8399.538025408661, 10281.845772313272, 10415.510803880785, 10683.626073087406, 10802.189835762192, 11446.198766086294], "value": 9032.86868339437, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1455.9272036398181, 1496.663250768577, 1601.135386891079, 1716.0475935855595, 1756.3589289909187, 7704.229577042293, 7900.683972641087, 8249.422540422172, 8821.911780882197, 8823.029466758659, 8344.165583441669, 8575.485470871752, 8588.656453741844, 8831.735047948572, 8850.822983540342, 2350.5063936573342, 2374.7031621047367, 2383.356493746687, 2383.95232095358, 2385.666006759055, 2323.6863023491783, 2340.8595484270913, 2362.692849929507, 2370.715514138306, 2373.3947843299934, 2342.672025916373, 2346.401667574766, 2350.2009316832273, 2363.5745565798147, 2371.1937941100023, 2311.8034967027656, 2334.9066037358484, 2341.075275266269, 2342.976570234293, 2345.097137602027, 2301.4476525633895, 2305.4351683837567, 2308.0536979838353, 2319.2346525646667, 2331.8717470539113, 8700.390972631918, 8742.606582703793, 8742.650293988232, 8797.0, 8797.208251257354, 4980.800767969277, 5093.0577843099145, 5100.9489905100845, 5110.718910459923, 5136.666116702402, 3270.836458177105, 3340.88306909257, 3403.914902127442, 3413.829308534588, 3461.2039230977016, 1067.908405167037, 1111.4276147783899, 1112.5660992213043, 1123.7583919457275, 1126.774645070989, 11842.585509507126, 11846.17076804624, 11847.407629618485, 11881.762364752743, 11914.285142891367, 4348.804303806336, 4486.68593198473, 4525.683202175882, 4600.585947264695, 4642.9535704643195, 10182.439965801805, 10186.388816671024, 10186.541605627765, 10190.184785217165, 10213.591456341812, 5156.2523434102595, 5164.92252616211, 5167.044096842096, 5168.870778230575, 5170.638055336166, 4212.915741685149, 4317.0934103838545, 4537.274036154199, 4612.423447069116, 4700.858974230779, 3629.7822130672243, 3758.4362345648374, 3793.260314238752, 3802.6007269236884, 3821.1593449441634, 1233.3031837012059, 1279.1685404486973, 1283.18517741235, 1297.7599144158362, 1318.9274589897648, 875.3303722652176, 880.317753740856, 890.0476490155601, 915.0986278515657, 926.1895841139003, 5514.6691198528215, 5571.359293681197, 5713.314402271671, 5746.569007324468, 5798.59409841307, 937.3813283233034, 951.9762005949768, 964.0937518732369, 980.5048450532578, 1027.3938376357985, 3742.0, 3976.4035394691027, 4022.3966405039478, 4032.294348489003, 4124.8143833527565, 10152.441615711059, 10530.842037369446, 10561.155107591374, 10778.892211077946, 10803.675889723321, 10540.209484288556, 10559.208059395576, 10573.62992295266, 10582.259241853151, 10713.625023124154, 7861.562915496214, 8126.187381261827, 8126.512409255463, 8129.292848501763, 8144.267015968591, 5316.521513063843, 5504.697241651747, 5549.139883318092, 5698.715064246854, 5707.68607726579, 9382.530873456437, 9390.718278451657, 9422.104900034486, 9498.240140788583, 9573.0, 9388.906110938804, 9552.474613896302, 9569.61721531131, 9582.66460673901, 9670.0, 6987.475939304471, 7184.497085203986, 7376.077990251219, 7628.35159011468, 7785.610719464117, 8024.478408903403, 8332.958335208528, 8337.541435221121, 8339.874901876356, 8360.038595561587, 7350.595717235603, 7398.889016664647, 7479.626018699152, 7503.5497870127965, 7642.273983971514, 7119.110111236096, 7206.171290301682, 7242.203357630551, 7274.636268186676, 7456.0, 6865.347791959756, 6867.931320686729, 6871.759488417882, 6902.378785909092, 6914.896276555755, 4950.4059512858685, 5024.522670346311, 5033.446320904624, 5063.063333283354, 5110.105731497048, 4710.364100846342, 4772.141014617402, 4903.387076615423, 4918.336024636771, 4989.151844186425], "value": 4530.140956611795, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.66573440543385, 311.7101095980737, 316.7481851927717, 331.14894720568134, 332.4381794766844, 5217.582593392529, 5468.699221542814, 5505.10981734589, 5573.944260557399, 5609.3268807743025, 5335.879465312289, 5512.641678290918, 5522.585806064541, 5525.99999999999, 5544.0, 4323.243432399333, 4334.4396017433855, 4338.566143385668, 4345.109252603209, 4347.717398369104, 4276.465441819772, 4284.18600465912, 4335.544767799383, 4340.8697739067875, 4355.324924636687, 4234.767087810169, 4259.424977628011, 4260.723053001545, 4266.189424009443, 4293.699441039129, 4255.574442555735, 4267.4452321198205, 4278.144371125787, 4291.291936830419, 4297.419848320468, 3715.089802998256, 3768.453574231721, 3777.8866634001024, 3778.3954567269107, 3779.769935737928, 5310.645785324756, 5315.867103322448, 5348.759305831208, 5374.838754837361, 5440.836774896759, 4809.749465139054, 4827.8551643450755, 4833.782479788418, 4842.515748425165, 4874.585660218886, 5612.575035091044, 5706.400827913051, 5716.1711551825165, 5733.362653179543, 5755.223044888929, 3958.604139586047, 4014.2573623879675, 4026.2752704513177, 4031.5363733170475, 4062.329715596923, 5797.710114494301, 5966.224390829208, 5994.13085102662, 6017.458428741391, 6052.6697221569575, 4192.81132349045, 4201.495820501559, 4217.304144816071, 4218.535961044283, 4238.689913996817, 4274.7435153890865, 4284.228838809045, 4288.678349123828, 4307.0093878407515, 4319.524852266248, 4776.928346074812, 4883.926741098886, 4931.161702510582, 4932.605391568666, 4945.109880221595, 5771.192033115367, 5783.137347013171, 5788.88422231553, 5789.971050144806, 5790.320806966017, 1464.1727424005403, 1478.3199728124969, 1478.3811726159838, 1479.423025020243, 1480.8445113263167, 910.0026183571612, 940.304174910575, 950.3680052764972, 952.1858810716876, 959.2421986630624, 4866.562009419169, 4899.191633380452, 4905.460399356068, 4912.287718280829, 4918.712798548692, 5211.166213405837, 5229.980153870035, 5231.71225582589, 5243.898781255903, 5279.868003299872, 4546.52261512543, 4842.346283251786, 4867.904721437719, 4889.877753056131, 4930.731863342902, 2758.0209025795953, 2758.4207316463367, 2761.3924936513936, 2763.6407267055156, 2789.3723912119613, 5303.920441193385, 5370.3287089113865, 5374.570034397317, 5376.73116344189, 5381.031414345455, 5349.438308977501, 5362.70505122222, 5607.607467477237, 6106.206193194945, 6143.56995010345, 6175.722092505848, 6177.351378105234, 6187.721552530057, 6214.564980451325, 6237.500999919996, 5669.6314739541795, 5937.8218653438735, 5947.791827286024, 5987.550933680079, 6018.729157188025, 5872.911906321494, 5877.119321816977, 5890.587658864009, 5929.0513517836935, 5960.970195148997, 5958.7616495341435, 6163.674809915889, 6170.660613666112, 6221.502279817513, 6230.25552845204, 4106.7946602670345, 4152.771597562163, 4160.875173744793, 4166.854160104382, 4167.874963751093, 5750.338711048283, 6007.639541627342, 6026.367231440811, 6031.8539477499135, 6051.515878729603, 5765.4522820332, 5768.596198266249, 5769.711514424346, 5774.3648198697265, 5804.8970695567705, 5850.561207909509, 5860.208871802422, 5861.560382971379, 5879.5002424794375, 5883.2057672213705, 5428.511433970962, 5711.343195532567, 5752.194692743103, 5755.482006619424, 5761.48146666802, 5838.94161058384, 5843.181954526284, 5895.852603684943, 5900.173975643327, 5919.200907877554, 5514.944850551443, 5735.340435849931, 5784.884302313846, 5804.738786754522, 5813.302403711582], "value": 4310.306532423074, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.9826504337394, 703.2088899987517, 707.9327463890929, 751.7105914223023, 805.5368163306099, 15462.845371546282, 16556.586085347873, 16722.41471548496, 16776.916115419423, 16810.495685129452, 14093.78859317111, 14118.717625647481, 14220.573382798506, 15231.238438078108, 15397.076175429482, 784.2784638132931, 796.2316364708056, 806.0528878567688, 807.8101646113158, 808.6846130009271, 792.13657113746, 807.0, 810.0522388805113, 817.7914631768921, 819.2094628683319, 847.9703210387638, 848.0417128644623, 850.2985037344184, 850.5322072859933, 850.5959669157163, 842.9747107586783, 843.2284459719349, 843.5697794125041, 843.9324854011695, 844.3962566764762, 617.4967401567708, 619.6313193649771, 621.549376701892, 622.4740094620039, 622.7695752571532, 15298.694026119527, 15443.691126177526, 15462.768058479132, 15469.613259668486, 15480.22598870052, 14548.418063277457, 14582.562523124323, 14832.629184270372, 15022.399104035825, 15128.394864205418, 11924.224925379822, 12102.81845772314, 12172.756544869142, 12200.511979520898, 12982.545610903668, 3827.7129215308964, 3853.5953724859046, 3906.941395879064, 4006.8797936061965, 4014.598540145991, 81950.0, 84489.15510844874, 84586.0, 84965.15034849635, 86049.97650164491, 10441.425721585234, 10488.213383996232, 10837.18721095921, 10930.508127134299, 11427.48576314068, 22123.778762212172, 22197.1121155152, 22214.0, 22363.88818055932, 22385.664215036788, 8039.477433966774, 8263.380246481538, 8388.8741668875, 8729.694460693845, 8768.167024132697, 4423.248047831877, 4629.189891768927, 4633.675642704979, 4674.392328997209, 4824.421069471686, 3291.736661067109, 3364.091695242271, 3405.778624389456, 3405.965940340565, 3409.7272218222483, 573.8565358660335, 580.2282963658324, 584.5995493087164, 593.551868339401, 599.2958274028, 645.5674697952384, 678.6369292428626, 688.896665500169, 767.1791183433672, 795.0657976877146, 8653.221210090996, 9395.973154362411, 9536.0, 9758.853617195606, 9857.852132218022, 695.0408436357895, 712.7398499547628, 721.3634167119188, 753.5441058159844, 758.2796343473722, 4102.2821006323775, 4229.267126290196, 4513.977430112828, 4621.32990716351, 4624.791884365211, 121355.0, 121450.0, 121710.0, 123878.0, 128781.0, 104041.87350960613, 110723.44638276756, 112620.43689781499, 115207.0, 117685.4115729416, 93121.53439232761, 94728.52635736915, 96512.0, 97251.0, 99718.5014074925, 8154.755357339052, 8552.187542183483, 8586.871196931927, 8658.0, 8665.0, 39217.41173882337, 47833.76083119562, 50818.74590627023, 51478.74260628673, 52659.21011184912, 73490.63254683692, 81357.59321203356, 82516.0, 84902.57548712217, 85544.57227713821, 10641.361518308926, 10743.08683761889, 11240.606578769704, 11500.194986351209, 11555.364454955059, 12448.62654120378, 12575.308358040396, 12956.870431295567, 13028.739425211632, 13231.735365292832, 12344.506219751109, 12524.93737531343, 12587.93706031464, 12750.936245318713, 13195.538156164488, 11246.381449020055, 11397.577828961836, 11737.530498779954, 11814.173007889365, 12220.633380998228, 11719.238249513754, 12277.447514862031, 12443.253404795742, 12524.499020039097, 12824.067655621706, 8803.119688031402, 8994.235489983424, 9144.451332920045, 9173.0, 9320.254379649476, 10342.741431464274, 10524.421156836448, 10731.248812583044, 10742.140628749525, 10859.185561082792], "value": 7423.066336697096, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1513.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 115.0, 116.0, 114.0, 115.0, 114.0, 114.0, 113.0, 115.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 121.0, 121.0, 168.0, 128.0, 127.0, 127.0, 124.0, 159.0, 121.0], "value": 135.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 166.0, 167.0, 166.0, 163.0, 163.0, 162.0, 163.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 112.0, 77.0, 77.0, 77.0, 75.0, 116.0, 76.0], "value": 84.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 109.0, 85.0, 85.0, 84.0, 107.0, 84.0, 83.0, 109.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 148.0, 148.0, 147.0, 147.0, 148.0, 149.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 54.0, 53.0, 52.0, 52.0, 55.0, 53.0, 52.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 61.0, 63.0, 61.0, 63.0, 61.0, 62.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 80.0, 85.0, 79.0, 80.0, 81.0, 79.0, 80.0, 86.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 134.0, 125.0, 126.0, 136.0, 128.0, 132.0, 137.0, 165.0, 126.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 170.0, 165.0, 170.0, 167.0, 169.0, 165.0, 165.0, 165.0, 169.0], "value": 167.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 66.0, 65.0, 67.0, 66.0, 65.0, 65.0, 68.0, 64.0, 66.0], "value": 66.3, "unit": "score"}]}]} 02:47:42 INFO - Return code: 0 02:47:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:47:43 ERROR - # TBPL SUCCESS # 02:47:43 INFO - Running post-action listener: _resource_record_post_action 02:47:43 INFO - [mozharness: 2016-09-21 09:47:43.062818Z] Finished run-tests step (success) 02:47:43 INFO - Running post-run listener: _resource_record_post_run 02:47:43 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 408555520; Read time: 8; Write time: 252204 02:47:43 INFO - TinderboxPrint: CPU usage
13.4% 02:47:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 02:47:43 INFO - TinderboxPrint: I/O write bytes / time
408,555,520 / 252,204 02:47:43 INFO - TinderboxPrint: CPU idle
8,245.2 (86.6%) 02:47:43 INFO - TinderboxPrint: CPU user
1,215.4 (12.8%) 02:47:43 INFO - TinderboxPrint: Swap in / out
0 / 0 02:47:43 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120528896; Read time: 0; Write time: 68760 02:47:43 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 287662080; Read time: 0; Write time: 183440 02:47:43 INFO - Running post-run listener: _upload_blobber_files 02:47:43 INFO - Blob upload gear active. 02:47:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:47:43 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 02:47:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:47:44 INFO - (blobuploader) - INFO - Open directory for files ... 02:47:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:47:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:47:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:44 INFO - (blobuploader) - INFO - Done attempting. 02:47:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:47:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:47:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:48 INFO - (blobuploader) - INFO - Done attempting. 02:47:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:47:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:47:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:49 INFO - (blobuploader) - INFO - Done attempting. 02:47:49 INFO - (blobuploader) - INFO - Iteration through files over. 02:47:49 INFO - Return code: 0 02:47:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:47:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:47:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04a36e6f4eaf2f50d8d7b880c153160c5cf0ff1150fbe6dbb69d87adfab70fa81cd623136309d51135b5f4bd6ea12b79a7f375d757d9ac9273daa2941de638e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9aee4c52084c3dac5c387539f4a94616affc82059ecc6c441f130f4bed97f36b1841e6f8948fcb941c9cf27a37fb9f49fadc2f86a913bee3ccc5a08ed4e0d56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/463df808e20a0633aafb8dd07cfd955729fe37602eb2a107af7f7aabfa433df4d95afb8448ac2855ec7bccce27def10e6832a58d8319aeb6d5811135a1f5e144"} 02:47:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:47:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:47:49 INFO - Contents: 02:47:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04a36e6f4eaf2f50d8d7b880c153160c5cf0ff1150fbe6dbb69d87adfab70fa81cd623136309d51135b5f4bd6ea12b79a7f375d757d9ac9273daa2941de638e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9aee4c52084c3dac5c387539f4a94616affc82059ecc6c441f130f4bed97f36b1841e6f8948fcb941c9cf27a37fb9f49fadc2f86a913bee3ccc5a08ed4e0d56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/463df808e20a0633aafb8dd07cfd955729fe37602eb2a107af7f7aabfa433df4d95afb8448ac2855ec7bccce27def10e6832a58d8319aeb6d5811135a1f5e144"} 02:47:49 INFO - Running post-run listener: copy_logs_to_upload_dir 02:47:49 INFO - Copying logs to upload dir... 02:47:49 INFO - mkdir: /builds/slave/test/build/upload/logs 02:47:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.893965 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-09-21 02:47:49.214308) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 02:47:49.218055) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04a36e6f4eaf2f50d8d7b880c153160c5cf0ff1150fbe6dbb69d87adfab70fa81cd623136309d51135b5f4bd6ea12b79a7f375d757d9ac9273daa2941de638e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9aee4c52084c3dac5c387539f4a94616affc82059ecc6c441f130f4bed97f36b1841e6f8948fcb941c9cf27a37fb9f49fadc2f86a913bee3ccc5a08ed4e0d56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/463df808e20a0633aafb8dd07cfd955729fe37602eb2a107af7f7aabfa433df4d95afb8448ac2855ec7bccce27def10e6832a58d8319aeb6d5811135a1f5e144"} build_url:https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011153 build_url: 'https://queue.taskcluster.net/v1/task/b3pKvd8YS1WWWmyB8ADQKQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04a36e6f4eaf2f50d8d7b880c153160c5cf0ff1150fbe6dbb69d87adfab70fa81cd623136309d51135b5f4bd6ea12b79a7f375d757d9ac9273daa2941de638e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e9aee4c52084c3dac5c387539f4a94616affc82059ecc6c441f130f4bed97f36b1841e6f8948fcb941c9cf27a37fb9f49fadc2f86a913bee3ccc5a08ed4e0d56", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/463df808e20a0633aafb8dd07cfd955729fe37602eb2a107af7f7aabfa433df4d95afb8448ac2855ec7bccce27def10e6832a58d8319aeb6d5811135a1f5e144"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 02:47:49.247670) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 02:47:49.248043) ========= 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=9ee515b9ec57ce2c386832a8000001b4-1474449668.387360-389966433 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004381 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 02:47:49.330520) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 02:47:49.330857) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 02:47:49.331151) ========= ========= Total master_lag: 0.18 =========