builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-004 starttime: 1474445074.12 results: success (0) buildid: 20160920234106 builduid: efd18a9b8a2f44e5ad136e1ed077d9f5 revision: 6fb92ddf485702778367f7217caaa216d8639ac3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 01:04:34.124249) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 01:04:34.124635) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 01:04:34.124911) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 01:04:34.202625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 01:04:34.202887) ========= 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=c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-21 01:04:34-- 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% 46.2M=0s 2016-09-21 01:04:34 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118775 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 01:04:34.335969) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 01:04:34.336271) ========= 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=c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014273 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 01:04:34.386598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 01:04:34.386905) ========= 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=c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-21 01:04:34,820 truncating revision to first 12 chars 2016-09-21 01:04:34,820 Setting DEBUG logging. 2016-09-21 01:04:34,820 attempt 1/10 2016-09-21 01:04:34,820 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 01:04:35,154 unpacking tar archive at: fx-team-6fb92ddf4857/testing/mozharness/ program finished with exit code 0 elapsedTime=0.757253 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 01:04:35.158373) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 01:04:35.158664) ========= script_repo_revision: 6fb92ddf485702778367f7217caaa216d8639ac3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 01:04:35.159021) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 01:04:35.159295) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 01:04:35.168886) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-21 01:04:35.169159) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:04:35 INFO - MultiFileLogger online at 20160921 01:04:35 in /builds/slave/test 01:04:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:04:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:04:35 INFO - {'append_to_log': False, 01:04:35 INFO - 'base_work_dir': '/builds/slave/test', 01:04:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:04:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:04:35 INFO - 'branch': 'Fx-Team-Non-PGO', 01:04:35 INFO - 'buildbot_json_path': 'buildprops.json', 01:04:35 INFO - 'config_files': ('talos/linux_config.py',), 01:04:35 INFO - 'default_actions': ('clobber', 01:04:35 INFO - 'read-buildbot-config', 01:04:35 INFO - 'download-and-extract', 01:04:35 INFO - 'populate-webroot', 01:04:35 INFO - 'create-virtualenv', 01:04:35 INFO - 'install', 01:04:35 INFO - 'run-tests'), 01:04:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:04:35 INFO - 'download_minidump_stackwalk': True, 01:04:35 INFO - 'download_symbols': 'ondemand', 01:04:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:04:35 INFO - 'tooltool.py': '/tools/tooltool.py', 01:04:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:04:35 INFO - '/tools/misc-python/virtualenv.py')}, 01:04:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:04:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:04:35 INFO - 'installer_path': 'installer.exe', 01:04:35 INFO - 'log_level': 'info', 01:04:35 INFO - 'log_name': 'talos', 01:04:35 INFO - 'log_to_console': True, 01:04:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:04:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:04:35 INFO - 'opt_config_files': (), 01:04:35 INFO - 'pip_index': False, 01:04:35 INFO - 'sps_profile': False, 01:04:35 INFO - 'sps_profile_interval': 0, 01:04:35 INFO - 'suite': 'dromaeojs-e10s', 01:04:35 INFO - 'system_bits': '32', 01:04:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:04:35 INFO - 'title': 'talos-linux64-ix-004', 01:04:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:04:35 INFO - 'use_talos_json': True, 01:04:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:04:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:04:35 INFO - 'work_dir': 'build'} 01:04:35 INFO - [mozharness: 2016-09-21 08:04:35.699583Z] Running clobber step. 01:04:35 INFO - Running pre-action listener: _resource_record_pre_action 01:04:35 INFO - Running main action method: clobber 01:04:35 INFO - rmtree: /builds/slave/test/build 01:04:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:04:36 INFO - Running post-action listener: _resource_record_post_action 01:04:36 INFO - [mozharness: 2016-09-21 08:04:36.162328Z] Finished clobber step (success) 01:04:36 INFO - [mozharness: 2016-09-21 08:04:36.162428Z] Running read-buildbot-config step. 01:04:36 INFO - Running pre-action listener: _resource_record_pre_action 01:04:36 INFO - Running main action method: read_buildbot_config 01:04:36 INFO - Using buildbot properties: 01:04:36 INFO - { 01:04:36 INFO - "project": "", 01:04:36 INFO - "product": "firefox", 01:04:36 INFO - "script_repo_revision": "production", 01:04:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:04:36 INFO - "repository": "", 01:04:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 01:04:36 INFO - "buildid": "20160920234106", 01:04:36 INFO - "pgo_build": "False", 01:04:36 INFO - "basedir": "/builds/slave/test", 01:04:36 INFO - "buildnumber": 1598, 01:04:36 INFO - "slavename": "talos-linux64-ix-004", 01:04:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:04:36 INFO - "platform": "ubuntu64_hw", 01:04:36 INFO - "scheduler": "tests-fx-team-linux64-talos-8-3600", 01:04:36 INFO - "branch": "fx-team", 01:04:36 INFO - "repo_path": "integration/fx-team", 01:04:36 INFO - "revision": "6fb92ddf485702778367f7217caaa216d8639ac3", 01:04:36 INFO - "stage_platform": "linux64", 01:04:36 INFO - "builduid": "efd18a9b8a2f44e5ad136e1ed077d9f5", 01:04:36 INFO - "slavebuilddir": "test" 01:04:36 INFO - } 01:04:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 01:04:36 INFO - Running post-action listener: _resource_record_post_action 01:04:36 INFO - [mozharness: 2016-09-21 08:04:36.164876Z] Finished read-buildbot-config step (success) 01:04:36 INFO - [mozharness: 2016-09-21 08:04:36.164964Z] Running download-and-extract step. 01:04:36 INFO - Running pre-action listener: _resource_record_pre_action 01:04:36 INFO - Running main action method: download_and_extract 01:04:36 INFO - mkdir: /builds/slave/test/build/tests 01:04:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:04:36 INFO - trying https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:04:36 INFO - Downloading https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/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 01:04:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/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 01:04:36 INFO - Downloaded 1361 bytes. 01:04:36 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:04:36 INFO - Using the following test package requirements: 01:04:36 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:04:36 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:04:36 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:04:36 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:36 INFO - u'jsshell-linux-x86_64.zip'], 01:04:36 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:04:36 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:04:36 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:04:36 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:04:36 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:04:36 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:04:36 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:04:36 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:04:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:04:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:04:36 INFO - Fetch https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:04:37 INFO - Expected file size: 20369760 01:04:41 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 01:04:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:04:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:04:41 INFO - Fetch https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:04:42 INFO - Expected file size: 20369760 01:04:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 01:04:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:04:46 INFO - Fetch https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 01:04:47 INFO - Expected file size: 14414059 01:04: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')]} 01:04:47 INFO - trying https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:04:47 INFO - Downloading https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/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 01:04:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/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 01:04:48 INFO - Downloaded 55602168 bytes. 01:04:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:04:48 INFO - mkdir: /builds/slave/test/properties 01:04:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:04:48 INFO - Writing to file /builds/slave/test/properties/build_url 01:04:48 INFO - Contents: 01:04:48 INFO - build_url:https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:04:49 INFO - Running post-action listener: _resource_record_post_action 01:04:49 INFO - Running post-action listener: set_extra_try_arguments 01:04:49 INFO - [mozharness: 2016-09-21 08:04:49.517889Z] Finished download-and-extract step (success) 01:04:49 INFO - [mozharness: 2016-09-21 08:04:49.518194Z] Running populate-webroot step. 01:04:49 INFO - Running pre-action listener: _resource_record_pre_action 01:04:49 INFO - Running main action method: populate_webroot 01:04:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:04:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:04:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:04:49 INFO - '--tppagecycles', 01:04:49 INFO - '7'], 01:04:49 INFO - 'tests': ['tsvgm']}}, 01:04:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:04:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:04:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:04:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:04:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:04:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:04:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:04:49 INFO - 'talos_options': ['--disable-e10s'], 01:04:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:04:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:04:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:04:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:04:49 INFO - 'talos_options': ['--disable-e10s'], 01:04:49 INFO - 'tests': ['damp', 'tps']}, 01:04:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:04:49 INFO - 'tests': ['damp', 'tps']}, 01:04:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:04:49 INFO - 'tests': ['dromaeo_dom']}, 01:04:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:04:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:04:49 INFO - 'tests': ['basic_compositor_video']}, 01:04:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:04:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:04:49 INFO - 'tests': ['a11yr', 01:04:49 INFO - 'ts_paint', 01:04:49 INFO - 'tpaint', 01:04:49 INFO - 'sessionrestore', 01:04:49 INFO - 'sessionrestore_no_auto_restore', 01:04:49 INFO - 'tabpaint']}, 01:04:49 INFO - 'other-e10s': {'tests': ['a11yr', 01:04:49 INFO - 'ts_paint', 01:04:49 INFO - 'tpaint', 01:04:49 INFO - 'sessionrestore', 01:04:49 INFO - 'sessionrestore_no_auto_restore', 01:04:49 INFO - 'tabpaint']}, 01:04:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:04:49 INFO - 'ts_paint', 01:04:49 INFO - 'tpaint', 01:04:49 INFO - 'sessionrestore', 01:04:49 INFO - 'sessionrestore_no_auto_restore', 01:04:49 INFO - 'tabpaint']}, 01:04:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:04:49 INFO - 'ts_paint', 01:04:49 INFO - 'tpaint', 01:04:49 INFO - 'sessionrestore', 01:04:49 INFO - 'sessionrestore_no_auto_restore', 01:04:49 INFO - 'tabpaint']}, 01:04:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:04:49 INFO - 'tests': ['a11yr', 01:04:49 INFO - 'ts_paint', 01:04:49 INFO - 'tpaint', 01:04:49 INFO - 'sessionrestore', 01:04:49 INFO - 'sessionrestore_no_auto_restore', 01:04:49 INFO - 'tabpaint']}, 01:04:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:04:49 INFO - 'tests': ['a11yr', 01:04:49 INFO - 'ts_paint', 01:04:49 INFO - 'tpaint', 01:04:49 INFO - 'sessionrestore', 01:04:49 INFO - 'sessionrestore_no_auto_restore', 01:04:49 INFO - 'tabpaint']}, 01:04:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:04:49 INFO - 'tests': ['tsvgx', 01:04:49 INFO - 'tsvgr_opacity', 01:04:49 INFO - 'tart', 01:04:49 INFO - 'tscrollx', 01:04:49 INFO - 'cart']}, 01:04:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:04:49 INFO - 'tsvgr_opacity', 01:04:49 INFO - 'tart', 01:04:49 INFO - 'tscrollx', 01:04:49 INFO - 'cart']}, 01:04:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:04:49 INFO - 'talos_options': ['--disable-e10s'], 01:04:49 INFO - 'tests': ['tp5o']}, 01:04:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:04:49 INFO - 'tests': ['tp5o']}, 01:04:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:04:49 INFO - 'talos_options': ['--disable-e10s', 01:04:49 INFO - '--xperf_path', 01:04:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:04:49 INFO - 'tests': ['tp5n']}, 01:04:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:04:49 INFO - 'talos_options': ['--xperf_path', 01:04:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:04:49 INFO - 'tests': ['tp5n']}}, 01:04:49 INFO - 'talos.zip': {'path': '', 01:04:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:04:49 INFO - Running post-action listener: _resource_record_post_action 01:04:49 INFO - [mozharness: 2016-09-21 08:04:49.535486Z] Finished populate-webroot step (success) 01:04:49 INFO - [mozharness: 2016-09-21 08:04:49.535579Z] Running create-virtualenv step. 01:04:49 INFO - Running pre-action listener: _resource_record_pre_action 01:04:49 INFO - Running main action method: create_virtualenv 01:04:49 INFO - Creating virtualenv /builds/slave/test/build/venv 01:04:49 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 01:04:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:04:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:04:49 INFO - Using real prefix '/usr' 01:04:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:04:50 INFO - Installing distribute.............................................................................................................................................................................................done. 01:04:52 INFO - Installing pip.................done. 01:04:52 INFO - Return code: 0 01:04:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:52 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 0x7fe422e76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9df60>, '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 0x2c9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', '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 01:04:52 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 01:04:52 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 01:04:52 INFO - Using env: {'DISPLAY': ':0', 01:04:52 INFO - 'HOME': '/home/cltbld', 01:04:52 INFO - 'LANG': 'en_US.UTF-8', 01:04:52 INFO - 'LANGUAGE': 'en_US:en', 01:04:52 INFO - 'LOGNAME': 'cltbld', 01:04:52 INFO - 'MAIL': '/var/mail/cltbld', 01:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:52 INFO - 'MOZ_NO_REMOTE': '1', 01:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:52 INFO - 'NO_EM_RESTART': '1', 01:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:52 INFO - 'PWD': '/builds/slave/test', 01:04:52 INFO - 'SHELL': '/bin/bash', 01:04:52 INFO - 'SHLVL': '1', 01:04:52 INFO - 'TERM': 'linux', 01:04:52 INFO - 'TMOUT': '86400', 01:04:52 INFO - 'USER': 'cltbld', 01:04:52 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', 01:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:52 INFO - '_': '/tools/buildbot/bin/python'} 01:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:52 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 01:04:52 INFO - Cleaning up... 01:04:52 INFO - Return code: 0 01:04:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:04:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:04:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:52 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 0x7fe422e76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9df60>, '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 0x2c9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', '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 01:04:52 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 01:04:52 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 01:04:52 INFO - Using env: {'DISPLAY': ':0', 01:04:52 INFO - 'HOME': '/home/cltbld', 01:04:52 INFO - 'LANG': 'en_US.UTF-8', 01:04:52 INFO - 'LANGUAGE': 'en_US:en', 01:04:52 INFO - 'LOGNAME': 'cltbld', 01:04:52 INFO - 'MAIL': '/var/mail/cltbld', 01:04:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:52 INFO - 'MOZ_NO_REMOTE': '1', 01:04:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:52 INFO - 'NO_EM_RESTART': '1', 01:04:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:52 INFO - 'PWD': '/builds/slave/test', 01:04:52 INFO - 'SHELL': '/bin/bash', 01:04:52 INFO - 'SHLVL': '1', 01:04:52 INFO - 'TERM': 'linux', 01:04:52 INFO - 'TMOUT': '86400', 01:04:52 INFO - 'USER': 'cltbld', 01:04:52 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', 01:04:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:52 INFO - '_': '/tools/buildbot/bin/python'} 01:04:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:52 INFO - Downloading/unpacking psutil>=3.1.1 01:04:52 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 01:04:52 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 01:04:52 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 01:04:52 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 01:04:52 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 01:04:52 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 01:04:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:04:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:04:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:04:54 INFO - Installing collected packages: psutil 01:04:54 INFO - Running setup.py install for psutil 01:04:54 INFO - building 'psutil._psutil_linux' extension 01:04:54 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 01:04:54 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 01:04:54 INFO - building 'psutil._psutil_posix' extension 01:04:54 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 01:04:54 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 01:04:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:04:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:04:55 INFO - Successfully installed psutil 01:04:55 INFO - Cleaning up... 01:04:55 INFO - Return code: 0 01:04:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:04:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:04:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:55 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 0x7fe422e76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9df60>, '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 0x2c9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', '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 01:04:55 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 01:04:55 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 01:04:55 INFO - Using env: {'DISPLAY': ':0', 01:04:55 INFO - 'HOME': '/home/cltbld', 01:04:55 INFO - 'LANG': 'en_US.UTF-8', 01:04:55 INFO - 'LANGUAGE': 'en_US:en', 01:04:55 INFO - 'LOGNAME': 'cltbld', 01:04:55 INFO - 'MAIL': '/var/mail/cltbld', 01:04:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:55 INFO - 'MOZ_NO_REMOTE': '1', 01:04:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:55 INFO - 'NO_EM_RESTART': '1', 01:04:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:55 INFO - 'PWD': '/builds/slave/test', 01:04:55 INFO - 'SHELL': '/bin/bash', 01:04:55 INFO - 'SHLVL': '1', 01:04:55 INFO - 'TERM': 'linux', 01:04:55 INFO - 'TMOUT': '86400', 01:04:55 INFO - 'USER': 'cltbld', 01:04:55 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', 01:04:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:55 INFO - '_': '/tools/buildbot/bin/python'} 01:04:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:04:55 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 01:04:55 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 01:04:55 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 01:04:55 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 01:04:55 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 01:04:55 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 01:04:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:04:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:04:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:04:57 INFO - Installing collected packages: mozsystemmonitor 01:04:57 INFO - Running setup.py install for mozsystemmonitor 01:04:57 INFO - Successfully installed mozsystemmonitor 01:04:57 INFO - Cleaning up... 01:04:57 INFO - Return code: 0 01:04:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe422e76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9df60>, '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 0x2c9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', '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 01:04:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:04:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:04:57 INFO - Using env: {'DISPLAY': ':0', 01:04:57 INFO - 'HOME': '/home/cltbld', 01:04:57 INFO - 'LANG': 'en_US.UTF-8', 01:04:57 INFO - 'LANGUAGE': 'en_US:en', 01:04:57 INFO - 'LOGNAME': 'cltbld', 01:04:57 INFO - 'MAIL': '/var/mail/cltbld', 01:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:57 INFO - 'MOZ_NO_REMOTE': '1', 01:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:57 INFO - 'NO_EM_RESTART': '1', 01:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:57 INFO - 'PWD': '/builds/slave/test', 01:04:57 INFO - 'SHELL': '/bin/bash', 01:04:57 INFO - 'SHLVL': '1', 01:04:57 INFO - 'TERM': 'linux', 01:04:57 INFO - 'TMOUT': '86400', 01:04:57 INFO - 'USER': 'cltbld', 01:04:57 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', 01:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:57 INFO - '_': '/tools/buildbot/bin/python'} 01:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:04:57 INFO - Downloading/unpacking jsonschema==2.5.1 01:04:57 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 01:04:57 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 01:04:57 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 01:04:57 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 01:04:57 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 01:04:57 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 01:04:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:04:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:04:59 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 01:04:59 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 01:04:59 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 01:04:59 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 01:04:59 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 01:04:59 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 01:04:59 INFO - Downloading functools32-3.2.3-2.tar.gz 01:04:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:04:59 INFO - warning: no files found matching '*.txt' 01:04:59 INFO - no previously-included directories found matching 'build' 01:04:59 INFO - no previously-included directories found matching 'dist' 01:04:59 INFO - no previously-included directories found matching '.git*' 01:04:59 INFO - Installing collected packages: jsonschema, functools32 01:04:59 INFO - Running setup.py install for functools32 01:04:59 INFO - warning: no files found matching '*.txt' 01:04:59 INFO - no previously-included directories found matching 'build' 01:04:59 INFO - no previously-included directories found matching 'dist' 01:04:59 INFO - no previously-included directories found matching '.git*' 01:04:59 INFO - Successfully installed jsonschema functools32 01:04:59 INFO - Cleaning up... 01:04:59 INFO - Return code: 0 01:04:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:04:59 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')]} 01:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:59 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')]} 01:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:04:59 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 0x7fe422e76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9df60>, '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 0x2c9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', '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 01:04:59 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 01:04:59 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 01:04:59 INFO - Using env: {'DISPLAY': ':0', 01:04:59 INFO - 'HOME': '/home/cltbld', 01:04:59 INFO - 'LANG': 'en_US.UTF-8', 01:04:59 INFO - 'LANGUAGE': 'en_US:en', 01:04:59 INFO - 'LOGNAME': 'cltbld', 01:04:59 INFO - 'MAIL': '/var/mail/cltbld', 01:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:04:59 INFO - 'MOZ_NO_REMOTE': '1', 01:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:04:59 INFO - 'NO_EM_RESTART': '1', 01:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:04:59 INFO - 'PWD': '/builds/slave/test', 01:04:59 INFO - 'SHELL': '/bin/bash', 01:04:59 INFO - 'SHLVL': '1', 01:04:59 INFO - 'TERM': 'linux', 01:04:59 INFO - 'TMOUT': '86400', 01:04:59 INFO - 'USER': 'cltbld', 01:04:59 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', 01:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:04:59 INFO - '_': '/tools/buildbot/bin/python'} 01:05:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:05:00 INFO - Cleaning up... 01:05:00 INFO - Return code: 0 01:05:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:05:00 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')]} 01:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:00 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')]} 01:05:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:00 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 0x7fe422e76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9df60>, '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 0x2c9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', '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 01:05:00 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 01:05:00 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 01:05:00 INFO - Using env: {'DISPLAY': ':0', 01:05:00 INFO - 'HOME': '/home/cltbld', 01:05:00 INFO - 'LANG': 'en_US.UTF-8', 01:05:00 INFO - 'LANGUAGE': 'en_US:en', 01:05:00 INFO - 'LOGNAME': 'cltbld', 01:05:00 INFO - 'MAIL': '/var/mail/cltbld', 01:05:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:00 INFO - 'MOZ_NO_REMOTE': '1', 01:05:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:00 INFO - 'NO_EM_RESTART': '1', 01:05:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:00 INFO - 'PWD': '/builds/slave/test', 01:05:00 INFO - 'SHELL': '/bin/bash', 01:05:00 INFO - 'SHLVL': '1', 01:05:00 INFO - 'TERM': 'linux', 01:05:00 INFO - 'TMOUT': '86400', 01:05:00 INFO - 'USER': 'cltbld', 01:05:00 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', 01:05:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:00 INFO - '_': '/tools/buildbot/bin/python'} 01:05:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:00 INFO - Downloading/unpacking blobuploader==1.2.4 01:05:00 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 01:05:00 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 01:05:00 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 01:05:00 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 01:05:00 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 01:05:00 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 01:05:02 INFO - Downloading blobuploader-1.2.4.tar.gz 01:05:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:05:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:05:02 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 01:05:02 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 01:05:02 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 01:05:02 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 01:05:02 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 01:05:02 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 01:05:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:05:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:05:02 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 01:05:02 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 01:05:02 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 01:05:02 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 01:05:02 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 01:05:02 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 01:05:03 INFO - Downloading docopt-0.6.1.tar.gz 01:05:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:05:03 INFO - Installing collected packages: blobuploader, requests, docopt 01:05:03 INFO - Running setup.py install for blobuploader 01:05:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:05:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:05:03 INFO - Running setup.py install for requests 01:05:03 INFO - Running setup.py install for docopt 01:05:03 INFO - Successfully installed blobuploader requests docopt 01:05:03 INFO - Cleaning up... 01:05:03 INFO - Return code: 0 01:05:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:05:03 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')]} 01:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:03 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')]} 01:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:03 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 0x7fe422e76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9df60>, '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 0x2c9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', '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 01:05:03 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 01:05:03 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 01:05:03 INFO - Using env: {'DISPLAY': ':0', 01:05:03 INFO - 'HOME': '/home/cltbld', 01:05:03 INFO - 'LANG': 'en_US.UTF-8', 01:05:03 INFO - 'LANGUAGE': 'en_US:en', 01:05:03 INFO - 'LOGNAME': 'cltbld', 01:05:03 INFO - 'MAIL': '/var/mail/cltbld', 01:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:03 INFO - 'MOZ_NO_REMOTE': '1', 01:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:03 INFO - 'NO_EM_RESTART': '1', 01:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:03 INFO - 'PWD': '/builds/slave/test', 01:05:03 INFO - 'SHELL': '/bin/bash', 01:05:03 INFO - 'SHLVL': '1', 01:05:03 INFO - 'TERM': 'linux', 01:05:03 INFO - 'TMOUT': '86400', 01:05:03 INFO - 'USER': 'cltbld', 01:05:03 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', 01:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:03 INFO - '_': '/tools/buildbot/bin/python'} 01:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:05:03 INFO - Running setup.py (path:/tmp/pip-pIVrrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:05:03 INFO - Running setup.py (path:/tmp/pip-EMCpj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:05:04 INFO - Running setup.py (path:/tmp/pip-eIWu1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:05:04 INFO - Running setup.py (path:/tmp/pip-MTNOxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:05:04 INFO - Running setup.py (path:/tmp/pip-A01TXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:05:04 INFO - Running setup.py (path:/tmp/pip-HfICui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:05:04 INFO - Running setup.py (path:/tmp/pip-ASVSxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:05:04 INFO - Running setup.py (path:/tmp/pip-Htnafe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:05:04 INFO - Running setup.py (path:/tmp/pip-eJYTAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:05:04 INFO - Running setup.py (path:/tmp/pip-vhc9zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:05:04 INFO - Running setup.py (path:/tmp/pip-5CKKN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:05:04 INFO - Running setup.py (path:/tmp/pip-8CxlrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:05:04 INFO - Running setup.py (path:/tmp/pip-h3l7RT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:05:04 INFO - Running setup.py (path:/tmp/pip-EcdpnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:05:04 INFO - Running setup.py (path:/tmp/pip-LECdL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:05:05 INFO - Running setup.py (path:/tmp/pip-MY79sO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:05:05 INFO - Running setup.py (path:/tmp/pip-MuwZNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:05:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:05:05 INFO - Running setup.py install for manifestparser 01:05:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:05:05 INFO - Running setup.py install for mozcrash 01:05:05 INFO - Running setup.py install for mozdebug 01:05:05 INFO - Running setup.py install for mozdevice 01:05:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:05:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:05:05 INFO - Running setup.py install for mozfile 01:05:05 INFO - Running setup.py install for mozhttpd 01:05:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:05:05 INFO - Running setup.py install for mozinfo 01:05:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:05:05 INFO - Running setup.py install for mozInstall 01:05:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:05:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:05:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:05:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:05:05 INFO - Running setup.py install for mozleak 01:05:06 INFO - Running setup.py install for mozlog 01:05:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:05:06 INFO - Running setup.py install for moznetwork 01:05:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:05:06 INFO - Running setup.py install for mozprocess 01:05:06 INFO - Running setup.py install for mozprofile 01:05:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:05:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:05:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:05:06 INFO - Running setup.py install for mozrunner 01:05:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:05:06 INFO - Running setup.py install for mozscreenshot 01:05:06 INFO - Running setup.py install for moztest 01:05:06 INFO - Running setup.py install for mozversion 01:05:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:05:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:05:06 INFO - Cleaning up... 01:05:06 INFO - Return code: 0 01:05:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:05:06 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')]} 01:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:06 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')]} 01:05:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:06 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 0x7fe422e76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9df60>, '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 0x2c9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', '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 01:05:06 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 01:05:06 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 01:05:06 INFO - Using env: {'DISPLAY': ':0', 01:05:06 INFO - 'HOME': '/home/cltbld', 01:05:06 INFO - 'LANG': 'en_US.UTF-8', 01:05:06 INFO - 'LANGUAGE': 'en_US:en', 01:05:06 INFO - 'LOGNAME': 'cltbld', 01:05:06 INFO - 'MAIL': '/var/mail/cltbld', 01:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:06 INFO - 'MOZ_NO_REMOTE': '1', 01:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:06 INFO - 'NO_EM_RESTART': '1', 01:05:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:06 INFO - 'PWD': '/builds/slave/test', 01:05:06 INFO - 'SHELL': '/bin/bash', 01:05:06 INFO - 'SHLVL': '1', 01:05:06 INFO - 'TERM': 'linux', 01:05:06 INFO - 'TMOUT': '86400', 01:05:06 INFO - 'USER': 'cltbld', 01:05:06 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', 01:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:06 INFO - '_': '/tools/buildbot/bin/python'} 01:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:05:07 INFO - Running setup.py (path:/tmp/pip-VoE7Ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:05:07 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)) 01:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:05:07 INFO - Running setup.py (path:/tmp/pip-xrVxRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:05:07 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)) 01:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:05:07 INFO - Running setup.py (path:/tmp/pip-0hueJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:05:07 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)) 01:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:05:07 INFO - Running setup.py (path:/tmp/pip-Y296wP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:05:07 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)) 01:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:05:07 INFO - Running setup.py (path:/tmp/pip-KZZfTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:05:07 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)) 01:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:05:07 INFO - Running setup.py (path:/tmp/pip-KXfJbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:05:07 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)) 01:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:05:07 INFO - Running setup.py (path:/tmp/pip-3uSsRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:05:07 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)) 01:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:05:07 INFO - Running setup.py (path:/tmp/pip-9C0OUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:05:07 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)) 01:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:05:07 INFO - Running setup.py (path:/tmp/pip-BBooSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:05:07 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)) 01:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:05:07 INFO - Running setup.py (path:/tmp/pip-uFW5EW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:05:07 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)) 01:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:05:07 INFO - Running setup.py (path:/tmp/pip-pNfo3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:05:07 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)) 01:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:05:07 INFO - Running setup.py (path:/tmp/pip-Mc2854-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:05:08 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)) 01:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:05:08 INFO - Running setup.py (path:/tmp/pip-w5DtWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:05:08 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)) 01:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:05:08 INFO - Running setup.py (path:/tmp/pip-il2h4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:05:08 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)) 01:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:05:08 INFO - Running setup.py (path:/tmp/pip-LbSN6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:05:08 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)) 01:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:05:08 INFO - Running setup.py (path:/tmp/pip-tiFiMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:05:08 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)) 01:05:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:05:08 INFO - Running setup.py (path:/tmp/pip-fOgQpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:05:08 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)) 01:05:08 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)) 01:05:08 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)) 01:05:08 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)) 01:05:08 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)) 01:05:08 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)) 01:05:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:05:08 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 01:05:08 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 01:05:08 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 01:05:08 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 01:05:08 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 01:05:08 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 01:05:10 INFO - Downloading blessings-1.6.tar.gz 01:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:05:10 INFO - Installing collected packages: blessings 01:05:10 INFO - Running setup.py install for blessings 01:05:10 INFO - Successfully installed blessings 01:05:10 INFO - Cleaning up... 01:05:10 INFO - Return code: 0 01:05:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:05:10 INFO - Reading from file tmpfile_stdout 01:05:10 INFO - Current package versions: 01:05:10 INFO - argparse == 1.2.1 01:05:10 INFO - blessings == 1.6 01:05:10 INFO - blobuploader == 1.2.4 01:05:10 INFO - docopt == 0.6.1 01:05:10 INFO - functools32 == 3.2.3-2 01:05:10 INFO - jsonschema == 2.5.1 01:05:10 INFO - manifestparser == 1.1 01:05:10 INFO - mozInstall == 1.12 01:05:10 INFO - mozcrash == 0.17 01:05:10 INFO - mozdebug == 0.1 01:05:10 INFO - mozdevice == 0.48 01:05:10 INFO - mozfile == 1.2 01:05:10 INFO - mozhttpd == 0.7 01:05:10 INFO - mozinfo == 0.9 01:05:10 INFO - mozleak == 0.1 01:05:10 INFO - mozlog == 3.4 01:05:10 INFO - moznetwork == 0.27 01:05:10 INFO - mozprocess == 0.23 01:05:10 INFO - mozprofile == 0.28 01:05:10 INFO - mozrunner == 6.12 01:05:10 INFO - mozscreenshot == 0.1 01:05:10 INFO - mozsystemmonitor == 0.3 01:05:10 INFO - moztest == 0.7 01:05:10 INFO - mozversion == 1.4 01:05:10 INFO - psutil == 3.1.1 01:05:10 INFO - requests == 1.2.3 01:05:10 INFO - wsgiref == 0.1.2 01:05:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:05:10 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')]} 01:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:10 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')]} 01:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:10 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 0x7fe422e76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9df60>, '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 0x2c9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', '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 01:05:10 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 01:05:10 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 01:05:10 INFO - Using env: {'DISPLAY': ':0', 01:05:10 INFO - 'HOME': '/home/cltbld', 01:05:10 INFO - 'LANG': 'en_US.UTF-8', 01:05:10 INFO - 'LANGUAGE': 'en_US:en', 01:05:10 INFO - 'LOGNAME': 'cltbld', 01:05:10 INFO - 'MAIL': '/var/mail/cltbld', 01:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:10 INFO - 'MOZ_NO_REMOTE': '1', 01:05:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:10 INFO - 'NO_EM_RESTART': '1', 01:05:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:10 INFO - 'PWD': '/builds/slave/test', 01:05:10 INFO - 'SHELL': '/bin/bash', 01:05:10 INFO - 'SHLVL': '1', 01:05:10 INFO - 'TERM': 'linux', 01:05:10 INFO - 'TMOUT': '86400', 01:05:10 INFO - 'USER': 'cltbld', 01:05:10 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', 01:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:10 INFO - '_': '/tools/buildbot/bin/python'} 01:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:10 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)) 01:05:10 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)) 01:05:10 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)) 01:05:10 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)) 01:05:10 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)) 01:05:10 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)) 01:05:10 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)) 01:05:10 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)) 01:05:10 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)) 01:05:10 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)) 01:05:10 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)) 01:05:10 INFO - Cleaning up... 01:05:10 INFO - Return code: 0 01:05:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:05:10 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')]} 01:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:10 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')]} 01:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:05:11 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 0x7fe422e76f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ca0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9df60>, '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 0x2c9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', '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 01:05:11 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 01:05:11 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 01:05:11 INFO - Using env: {'DISPLAY': ':0', 01:05:11 INFO - 'HOME': '/home/cltbld', 01:05:11 INFO - 'LANG': 'en_US.UTF-8', 01:05:11 INFO - 'LANGUAGE': 'en_US:en', 01:05:11 INFO - 'LOGNAME': 'cltbld', 01:05:11 INFO - 'MAIL': '/var/mail/cltbld', 01:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:11 INFO - 'MOZ_NO_REMOTE': '1', 01:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:11 INFO - 'NO_EM_RESTART': '1', 01:05:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:11 INFO - 'PWD': '/builds/slave/test', 01:05:11 INFO - 'SHELL': '/bin/bash', 01:05:11 INFO - 'SHLVL': '1', 01:05:11 INFO - 'TERM': 'linux', 01:05:11 INFO - 'TMOUT': '86400', 01:05:11 INFO - 'USER': 'cltbld', 01:05:11 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', 01:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:11 INFO - '_': '/tools/buildbot/bin/python'} 01:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:05:11 INFO - Cleaning up... 01:05:11 INFO - Return code: 0 01:05:11 INFO - Running post-action listener: _resource_record_post_action 01:05:11 INFO - Running post-action listener: _start_resource_monitoring 01:05:11 INFO - Starting resource monitoring. 01:05:11 INFO - [mozharness: 2016-09-21 08:05:11.256728Z] Finished create-virtualenv step (success) 01:05:11 INFO - [mozharness: 2016-09-21 08:05:11.257184Z] Running install step. 01:05:11 INFO - Running pre-action listener: _resource_record_pre_action 01:05:11 INFO - Running main action method: install 01:05:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:05:11 INFO - Reading from file tmpfile_stdout 01:05:11 INFO - Detecting whether we're running mozinstall >=1.0... 01:05:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:05:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:05:11 INFO - Reading from file tmpfile_stdout 01:05:11 INFO - Output received: 01:05:11 INFO - Usage: mozinstall [options] installer 01:05:11 INFO - Options: 01:05:11 INFO - -h, --help show this help message and exit 01:05:11 INFO - -d DEST, --destination=DEST 01:05:11 INFO - Directory to install application into. [default: 01:05:11 INFO - "/builds/slave/test"] 01:05:11 INFO - --app=APP Application being installed. [default: firefox] 01:05:11 INFO - mkdir: /builds/slave/test/build/application 01:05:11 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'] 01:05:11 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 01:05:27 INFO - Reading from file tmpfile_stdout 01:05:27 INFO - Output received: 01:05:27 INFO - /builds/slave/test/build/application/firefox/firefox 01:05:27 INFO - Running post-action listener: _resource_record_post_action 01:05:27 INFO - [mozharness: 2016-09-21 08:05:27.637095Z] Finished install step (success) 01:05:27 INFO - [mozharness: 2016-09-21 08:05:27.637340Z] Running run-tests step. 01:05:27 INFO - Running pre-action listener: _resource_record_pre_action 01:05:27 INFO - Running main action method: run_tests 01:05:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:05:27 INFO - Python 2.7.3 01:05:27 INFO - Return code: 0 01:05:27 INFO - grabbing minidump binary from tooltool 01:05:27 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')]} 01:05:27 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 0x2c9df60>, '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 0x2c9ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:05:27 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 01:05:27 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 01:05:27 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 01:05:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:05:27 INFO - Return code: 0 01:05:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:05:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:05:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:05:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:05:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:05:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 01:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 01:05:27 INFO - Using env: {'DISPLAY': ':0', 01:05:27 INFO - 'HOME': '/home/cltbld', 01:05:27 INFO - 'LANG': 'en_US.UTF-8', 01:05:27 INFO - 'LANGUAGE': 'en_US:en', 01:05:27 INFO - 'LOGNAME': 'cltbld', 01:05:27 INFO - 'MAIL': '/var/mail/cltbld', 01:05:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:05:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:05:27 INFO - 'MOZ_NO_REMOTE': '1', 01:05:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:05:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:05:27 INFO - 'NO_EM_RESTART': '1', 01:05:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:05:27 INFO - 'PWD': '/builds/slave/test', 01:05:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:05:27 INFO - 'SHELL': '/bin/bash', 01:05:27 INFO - 'SHLVL': '1', 01:05:27 INFO - 'TERM': 'linux', 01:05:27 INFO - 'TMOUT': '86400', 01:05:27 INFO - 'USER': 'cltbld', 01:05:27 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755', 01:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:05:27 INFO - '_': '/tools/buildbot/bin/python'} 01:05:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 01:05:27 INFO - mozversion application_buildid: 20160920234106 01:05:27 INFO - mozversion application_changeset: 6fb92ddf485702778367f7217caaa216d8639ac3 01:05:27 INFO - mozversion application_display_name: Nightly 01:05:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:05:27 INFO - mozversion application_name: Firefox 01:05:27 INFO - mozversion application_remotingname: firefox 01:05:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:05:27 INFO - mozversion application_vendor: Mozilla 01:05:27 INFO - mozversion application_version: 52.0a1 01:05:27 INFO - mozversion platform_buildid: 20160920234106 01:05:27 INFO - mozversion platform_changeset: 6fb92ddf485702778367f7217caaa216d8639ac3 01:05:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:05:27 INFO - mozversion platform_version: 52.0a1 01:05:27 INFO - using testdate: 1474445127 01:05:27 INFO - actual date: 1474445127 01:05:27 INFO - starting webserver on 'localhost:48727' 01:05:27 INFO - SUITE-START | Running 2 tests 01:05:27 INFO - TEST-START | dromaeo_css 01:05:27 INFO - operating with platform_type : linux_ 01:05:27 INFO - Initialising browser for dromaeo_css test... 01:05:27 INFO - TEST-INFO | started process 8761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuELIUu/profile http://localhost:48727/getInfo.html) 01:05:33 INFO - PROCESS | 8761 | __metrics Screen width/height:1600/1200 01:05:33 INFO - PROCESS | 8761 | colorDepth:24 01:05:33 INFO - PROCESS | 8761 | Browser inner width/height: 1024/697 01:05:33 INFO - PROCESS | 8761 | __metrics 01:05:33 ERROR - PROCESS | 8761 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 01:05:34 INFO - TEST-INFO | 8761: exit 0 01:05:34 INFO - Browser initialized. 01:05:34 INFO - Running cycle 1/1 for dromaeo_css test... 01:05:34 INFO - TEST-INFO | started process 8884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuELIUu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:05:46 INFO - PROCESS | 8884 | RSS: Main: 186216448 01:05:46 INFO - PROCESS | 8884 | 01:06:36 INFO - PROCESS | 8884 | 1474445196524 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] 01:08:49 INFO - PROCESS | 8884 | Cycle 1(1): loaded http://localhost:48727/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48727/tests/dromaeo/cssquery-ext.html) 01:08:50 INFO - PROCESS | 8884 | RSS: Main: 200613888 01:08:50 INFO - PROCESS | 8884 | 01:11:52 INFO - PROCESS | 8884 | Cycle 1(1): loaded http://localhost:48727/tests/dromaeo/cssquery-ext.html (next: http://localhost:48727/tests/dromaeo/cssquery-jquery.html) 01:11:53 INFO - PROCESS | 8884 | RSS: Main: 196247552 01:11:53 INFO - PROCESS | 8884 | 01:14:55 INFO - PROCESS | 8884 | Cycle 1(1): loaded http://localhost:48727/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48727/tests/dromaeo/cssquery-mootools.html) 01:14:56 INFO - PROCESS | 8884 | RSS: Main: 198791168 01:14:56 INFO - PROCESS | 8884 | 01:17:57 INFO - PROCESS | 8884 | Cycle 1(1): loaded http://localhost:48727/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48727/tests/dromaeo/cssquery-prototype.html) 01:17:58 INFO - PROCESS | 8884 | RSS: Main: 195076096 01:17:58 INFO - PROCESS | 8884 | 01:21:01 INFO - PROCESS | 8884 | Cycle 1(1): loaded http://localhost:48727/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48727/tests/dromaeo/cssquery-yui.html) 01:21:02 INFO - PROCESS | 8884 | RSS: Main: 198066176 01:21:02 INFO - PROCESS | 8884 | 01:24:04 INFO - PROCESS | 8884 | Cycle 1(1): loaded http://localhost:48727/tests/dromaeo/cssquery-yui.html (next: http://localhost:48727/tests/dromaeo/cssquery-dojo.html) 01:24:04 INFO - PROCESS | 8884 | RSS: Main: 199741440 01:24:04 INFO - PROCESS | 8884 | 01:24:04 INFO - PROCESS | 8884 | __start_tp_report 01:24:04 INFO - PROCESS | 8884 | _x_x_mozilla_page_load 01:24:04 INFO - PROCESS | 8884 | _x_x_mozilla_page_load_details 01:24:04 INFO - PROCESS | 8884 | |i|pagename|runs| 01:24:05 INFO - PROCESS | 8884 | |0;dojo.html;2620.253227830068;2623.317937336292;2628.4874449482345;2648.059938721754;2663.493936152132;4640.651951103672;4777.641676874236;4798;4811.23020316749;4867.513248675131;4630.699004564701;4733.313669517926;4793.1611967905565;4810.68730532516;4823.71057736536;4352.738835669854;4375.299952007679;4434.379186913835;4464.843730469434;4509.368688383629;4412.889677758066;4437.400950871639;4438.4451943507065;4489.730616163024;4530.841420550281;4318.589733975299;4319.611234988866;4377.584129507692;4426.22541055314;4523.321501774727;4324.308110702273;4345.9130817383475;4363.563643635643;4393.0994146199955;4429.889252768674;4301.032267739764;4311.676624253162;4323.437953066082;4386.210482113218;4387.561243875619;4722.3152642866935;4750.45369782476;4767.380240568738;4782.33047373368;4820.903581928342;5024;5055.039542486916;5075.949240507584;5087.79648814047;5089.109405853961;5055.6713813602;5075.898482030376;5101.872453188663;5130.410002849682;5188.247704082924;4638.512956139557;4686.74222917736;4750.762461876892;4753.881152971168;4799.9760001199775;5124.385073791169;5141.845744627667;5157.7679004444135;5162.303089082926;5240.030594340059;4938.975305123451;4949.356583644103;4988.102141614544;4988.152014157602;5079.111155547838;4971.304017437562;5014.674046186986;5056.696598204046;5076.086304465158;5082.745862706924;5044.369453818273;5089.338386009795;5090.490950904954;5103.795848166032;5182.326297581366;5088.236764485357;5095.181439619319;5097.08252514551;5116.309298244763;5151.278820965068;4233.941514621345;4392.714473559208;4393.912121757547;4396.692231543825;4440.467143942683;3728.3102626014274;3736.103335199587;3792.4500947362476;3800.562935262425;3802.961970380316;4428.800703968329;4442.644588432918;4453.287474004209;4476.171908196994;4490.955090449053;5086.821961231339;5131.307273518102;5133.1273683473155;5142.997115562504;5202.76587553561;4321.567843215653;4363.018320877841;4384.649228061748;4427.158839820424;4496.820127194941;4563.269876819693;4569.474510431276;4602.907941841145;4610.861674149781;4670.322803193518;4804.183288840905;4806.807727690853;4810.39870016248;4815.662903596784;4867.586255168279;5017.774200160929;5125.103106956342;5149.510796474329;5150.536451719363;5198.4801519847715;4730.550597693214;4769.594584460221;4773.594244489118;4777.689450185727;4837.322774811459;4938.604911607134;4940.184869496493;4951.5048495150195;4965.950340496549;5042.218456139304;5062.772175252197;5082.974585127051;5084.034033533617;5100.158473851773;5141.974290128525;4843.539863712942;4881.707097574157;4901.362822833009;4912.852614421573;4925.433575138905;4953.083679519301;4959.156943319572;4959.181735013683;4977.751112444291;5016.874578135576;4759.857204283877;4835.395575553056;4845.0067736114715;4847.491013443538;4927.039227350632;4986.7257300848805;5023.924641130313;5025.3718285214345;5038.47096054909;5100.928804951001;4910.705357678551;4929.728864912464;4932;4934.802607895644;5014.247862820606 01:24:05 INFO - PROCESS | 8884 | |1;ext.html;544.6269305525715;550.9118541033434;552.1359073050678;556.4824713016895;565.9971700141498;37111.70109046181;39564.60435395645;39720.00699982498;42874.571254287446;43051;38717.806410967976;39332.41001384982;39405.847532197426;39425.21149577007;39489;7476.850462990737;7682.731104411347;7685.11621163565;7686.3466605338335;7693.576853273068;7513.286237807427;7648;7656;7696.961515192416;7710.344620707247;7707.152213256537;7777.611119444005;7779.338756205701;7786.493877897947;7786.961065194694;7655.50239234448;7688.346490548282;7696.230376962315;7734.110577283572;7734.419918506134;7598.08822941245;7614.8096297593;7627;7663.271989161077;7704.191059938682;37064;37591;37781.433278500845;37806.81096594527;37870.81064594687;2743.7530622244094;2942.8969986050383;2988.9850550747324;2993.6407631084408;3160.5259211118287;27903.860480697465;28299.434011319863;28385.57421638677;28415.857920710263;28959;3388.4747864081105;3412.181076541637;3449.379111759882;3456.0495863637448;3484.372812893678;235391;235780.13758899248;236604;237040.81479592665;237616.99999999828;45168.3224751629;45579.544204558195;45654.77172614182;45661.77169114133;45710.314345284845;32028.519572206435;32961.83519082389;33014;34626.65373346234;52558.474415256125;13368.131071480517;13430.127041742255;13506.459741610226;13512.054156208971;13516.594502164951;11048.944755276332;11262.155338349492;11290.604828830952;11305.830412543819;11314.943425282821;17437.825621743876;17505;17536.64926701459;17559.122043897754;17688.55778605545;6676.632785196861;6684.498662600325;6745.9662701686175;6771.52599318043;6820.93179068203;733.3912852332551;802.1897883138073;915.1534830282095;921.7373048681094;972.924917965652;26202.606960895602;27121.321966950985;27391.178264651695;27691;27850.303742406195;882.289756745813;923.4920793563513;986.3095832916987;991.6777047459605;1013.7313611892854;13337.266450345323;14015.929920350536;14222.786658200135;14254;14330.49843255481;368501;370448;370997;371223;372551;47372;47488.5251147491;47551;47571.28643070357;47979.760101199274;1117.3072694929197;1156.4795841871191;1166.7258194324327;1166.78414493319;1167.9474423650956;24604.293527712296;25481.617775733008;26430;26464.8676756615;26595.33511662224;39185.608143918194;39664.80167599144;39699.40450893181;39751.80124099477;39794.403083953184;313571;313852;314066;314486;314666;24287.87856060779;24376;24815.255542333758;24844.751552484242;24887.751122489266;39942;40156.3976540358;40165;40934.79532602318;41005.17989640131;33966.32067358688;34373;34552;34758.47862282118;34768.82615586906;34522.82738586291;34542;34575;34779.478307824895;35153.64846351606;34855;35047.824760877054;35238.647613523535;35883;36102.27795444129;30689;31477.527837082922;32819.015429537154;32944.83527582443;33159.33681326408;24389.63415548804;24653.137140200008;24759.87620061888;24810.50378992446;25431 01:24:05 INFO - PROCESS | 8884 | |2;jquery.html;360.51510718084177;365.8061227549398;371.817809273456;375.1858467126339;383.342567496743;15530.534083977485;16686;17433.738493922603;17498.387556435526;17549.034803085826;15746;16217.432389866328;16778.161091945414;16810.83189168108;16894.408695695653;4919.975400123003;5171.922421163686;5181.222816577506;5182.870428239286;5188.221766734982;3708.3139619170406;3888.591697871725;5172.663776854492;5676.744546495397;5974.462298393144;6051.243594550681;6064.241969753781;6067.332593414721;6068.605540639866;6070.0591408331775;5791.10237913122;5973.910391344133;6002.819915402545;6011.5190784737115;6017.7592896284095;5127;5298.178782288713;5299.311089558371;5300.257963885059;5300.840974770763;20677.793222067736;20918.267860624805;20958.371248862557;21027.369178924655;21051.8947405262;1845.7600511933497;1886.1323791056132;1926.1813729165049;1949.5028767664296;2065.0810389376734;12744.490220391173;13358.933205333911;13581.456741730319;13644.795328070088;14014.649633759136;1733.4886208568375;1740.1386313774763;1751.3082332478727;1755.8244175582468;1819.7725284339458;68645.31354686439;68809.65595171992;70746.64626676885;71122.64438677825;71155;9520;9625.32622716417;9678.467684277432;9746.317757757031;9974.197868862162;13519.594412167455;13597.932010340082;13603.455861765617;13604.93197534006;13609.31953402326;7490.101187857492;7655.617219139021;7710.96144519285;7855.607219638995;7868.488548244346;7442.516236444614;7468.178500364956;7488.625568721543;7660.119086305146;7706.922930770621;6027.427394397525;6125.632462052202;6214.937850621526;6224.097505861715;6384.201974753156;1597.3850067723777;1695.7625932369479;1697.8471937525683;1715.4596302164778;1796.97304540432;825.2531459029587;828.763802316337;830.4062595244429;838.6896848166095;881.7883707910183;16368.345266189457;16859.83140168607;17256.913715431343;17461.912690436468;17690;853.6329378367361;871.5250188647202;881.4094556647062;891.892972843263;951.990480095204;9764.462954537568;9766.804663906823;9918.652847150315;9964.501774911225;10163.7459063524;343727;345098;347360;348988;349238;65180;65481;66335.33664663388;66739.33260667331;67481.66259168673;878.4246318661287;897.6140259688266;913.6893456224783;918.8346097702344;932.2215949681956;15257.694846103237;15314.923425383247;15465.149416782186;15993.440229591908;16009.35962561531;34406.65593344034;34442.13894652654;34534.82732586321;34554.13614659654;35205.64794352126;53646.195307071204;54465.18302225391;54631;54829;55217.44782552284;4632.957584543451;4758.881027974328;4998.975005124951;5722.771089156554;7610.581418022062;7948.523088614702;8517.48895066298;10657.14742820588;11788.823167652321;11895.940520297343;8247.95876020616;9256.629734810533;9682.661106861226;9723.416595004323;10152.441615711206;9751.756206094904;9796.706098817047;9903.45530995802;10002.199824013916;10317.771870108514;10069.244806639384;10225.59097636116;10432.791344172922;10451.738706532093;10747.89252107469;6663.633500157538;6864.347886950732;6907;7215.134183897966;7419.703211871465;8081.313088387553;9851.65519206853;9895.505224738878;10386.740331491774;10473 01:24:05 INFO - PROCESS | 8884 | |3;mootools.html;1335.4324412124845;1367.111377604557;1426.586289975907;1628.210317995771;1647.192875491009;6855.897161542581;7099.609521476316;7448.441366897484;8172.7548173554815;8213.342932565389;7545.962270188655;7865.174156713534;7889.4871833330935;8117.431779775418;8123.5125892446495;2174.217281778562;2197.3957161780477;2202.0861342542826;2206.4483879030245;2209.149477451185;2157.7950094740972;2188.0700702201502;2205.4596623827183;2206.6579680149603;2210.4694873230387;2175.8476906616543;2184.2355175688463;2188.2122435923056;2193.846430749848;2195.9121635134575;2144.9571008579896;2151.38685474639;2151.7633060363346;2154.3321570313174;2155.8814265215406;2098.685197220414;2104.989475052615;2145.2706079932896;2153.870767753924;2156.105216335219;8032.277095061472;8064.274215320649;8068.47554908929;8088.636011379502;8142.185781421869;4525.2533332000185;4554.134714404253;4557.817687292504;4562.794674239634;4581.083783243364;2745.643066401375;2814.3104939290006;2856.557233628791;2896.8117072390437;2946.7789915756402;885.3890815337396;920.8848893888264;935.3686261773344;940.2524992630875;942.9151376376091;10722;10829.187810914213;10864.728381790439;10928.453577321103;10954.835677464844;3956.4263181839046;4093.9590604094174;4244.575542445792;4279.529251782302;4294.463192100988;9209.125133112344;9243.722688319362;9244.537773111317;9246.214071803972;9251.953740231256;4564.041551274269;4570.65720070996;4572.7942242599165;4586.72479651222;4593.816247350069;3754.436834474796;3890.8054597270025;4003.819828107684;4170.374443833449;4176.204232180131;3541.911452213664;3581.659742324475;3698.260347930425;3733.253349330145;3744.681702055356;1151.424287856072;1173.3077484284313;1183.591660876996;1227.766724322376;1232.827404163418;664.2394458345265;756.53095081049;781.1602527283193;781.4842204145236;792.9167437419103;4854.660173787872;4947.6289278304275;4973.42805577356;5048.192289233705;5240.528352448298;412.94218809366714;414.44464417679853;424.8258214132191;428.39168380899196;431.89418592445054;3312.93374132516;3374.308266805299;3411.573553305837;3455.2571197192724;3499.8600055997476;9451.480168590793;9711.611535538499;9713.417194968324;9804.019598040139;9822.803543929082;9485.478298693639;9708.077732615391;9727.124558789743;9732.318737688294;9734.172595329335;7299.963500182465;7335.963320183365;7394.26057394267;7417.962910185414;7453.515521491194;4854.75726213695;4951.5048495150195;5016.673916195582;5298.788048478018;5316.149416093406;9034.503102329434;9079.228265597498;9145.908540914506;9215.262778977532;9263.76840578991;9008.594613242289;9148.588313525774;9179.541022948959;9335.393199442015;9384.296177786557;6806.65966701653;6896.724131034703;6952.617606031717;6972.965135174291;7065.505414621133;7533.849323013618;7597.734079307198;7599.1261004982925;7603.2776886195725;7616.23837616234;6621.470282377302;6699.9665001674675;6729.394354508117;6880.8967865483055;6910.2398736137975;6664.566803157779;6769.932300677127;6845.315468453314;6899.068625735462;6904.896426553505;5959.940400595939;6056.788012419544;6061.545384096122;6063.848403789941;6066.787662431793;4511.548845115462;4549.567791059844;4612.515685852937;4625.07498500308;4665.32352808834;4578.954210457853;4605.7927393268055;4617.6536759742485;4696.342512048248;4835.516448355136 01:24:05 INFO - PROCESS | 8884 | |4;prototype.html;282.7285805626597;285.38499533505296;292.3145224448667;294.58610652033894;294.7700793381163;4845.1763200255955;4951.876203094916;5084.262781896623;5116.155834287343;5161.225816127583;4778.450478195009;4902;4928.926066109002;4993.350864387634;5015.699058056519;3903.10228647412;3919.6864250859862;3928.37146056631;3953.5651078381356;3954.5452272988687;3680.429533422324;3951.3480275754464;3963.8810835674976;3964.702647301464;3964.8215830287563;3819.1597848473293;3822.178231680188;3832.367659336206;3833.616638336158;3835.8082095895093;3810.580836108026;3819.2170605025904;3828;3830.80845957701;3838.42423636454;3198.2409674679066;3321.2527181383994;3338.3490219407227;3342.1143396999814;3342.732581393507;4900.701314151753;4927.926081108786;4930.260460930853;4971.254311853215;4972.8508144755715;4424.491183513905;4426.667999900021;4434.534373890728;4439.867833702418;4462.44219472566;5032.295478632995;5287.07476191665;5332.253484512172;5336.466353364672;5362.51737343641;3655.9268814623824;3657.122290650251;3676.852925882988;3687.2441149564274;3694.949303136758;5498.532624726903;5529.391766905637;5574.916376254359;5581.441855814386;5597.580181486404;3690.4279836625365;3784.448376165814;3789.5263092113487;3790.488284081669;3803.0682482791894;3769.4545236452923;3777.2823163598828;3811.676007539335;3823.885283441501;3840.6763907835357;4385.824567017347;4407.515173330931;4409.581089796464;4414.271645178574;4437.5784300491405;5307.054584705448;5310.6813591184655;5322.414534401213;5341.278927344759;5365.38298095724;1281.423359488234;1313.967150821218;1319.9340032998311;1327.502186679995;1328.774108401574;776.1927595300824;817.1868990354635;831.2518733140101;834.8539005673982;836.8117173635883;4098.180363927227;4100.323446631272;4122.196171746481;4144.466547377489;4161.479815023122;4726.26742854858;4745.003549254626;4769.904601907942;4788.497207793202;4792.028942055878;4150.900011496956;4161.375793630919;4161.459010328698;4169.874903752892;4182.435371224846;2571.29289445404;2681.5575430053823;2907.2877145099587;2911.7233862783;2915.766738660902;5120.667156634807;5123.820666276737;5138.537531622097;5144.30551875492;5147.639665223398;5352.223927530486;5574.042429874753;5579.7489112990015;5581.274434323594;5604.775808967595;5057.721825299644;5061.8734531637;5070.873228169252;5094.796208151706;5115.7442127893455;5412.242286079873;5424.83725488236;5432.185172224198;5441.5102640762525;5446.836594902159;5110.97444512775;5344.625876188629;5360.70516121617;5368.731563421891;5373.328333958255;5087.796488140433;5088.771005304696;5093.796248150181;5150.8969820604125;5162.561182299547;3521.454174602941;3642.817859107087;3673.8714145004797;3675.7978311192073;3692.1539230384806;5325.360956685223;5431.456854314537;5480.260164877691;5484.588655850747;5490;5312.495312945264;5315.229291752751;5317.8404647860625;5319.973400132974;5363.812266570651;5067.949320506896;5280.339957505312;5328.200769884548;5339.359276886643;5343.492368225168;5222.451642577626;5236.481420388045;5251.977988474388;5257.237700533477;5263.131583288715;5342.813001544927;5357.276767636475;5374.3013408256675;5378.946210537844;5393;5107.182850743863;5213.869653258547;5237.764300606405;5259.263703081495;5264.894702106013 01:24:05 INFO - PROCESS | 8884 | |5;yui.html;553.8615346163458;558.5894367639784;559.1947595462531;563.8477611045018;617.0589850478021;12357;12701;12783.808242876352;12900.935495322521;12912.160709553873;12129.272243665364;12506.937465312683;12547.749045019116;12742.80885786714;12781.61655150347;720.899074129621;749.3630414147958;751.8233215194425;752.586077657289;753.4499815134927;737.2111840330848;762.3824701991405;766.6166916541729;769.730594291999;773.8568364852492;806.1938061938062;814.6008455856618;816.2286639125998;816.677412422093;818.8485130250892;796.2555011064674;805.0299389235986;806.6047636658025;807.5437377881508;807.7617102954642;593.8841925824466;594.6342999055593;594.9137375080633;595.642614431342;598.5540772124751;11514.366709830956;11516.654500365003;11600.303981761037;11658.358790266531;11691.181617286793;11597.362145082017;12038.4582693779;12196.39018049094;12602.117851750381;13290.73418531624;10908.50911708967;11302.208845380826;11338;11504.079673626089;11654.300741955425;3836.175222327185;3864.285107255139;3953.1105501262273;3954.2486927483687;3964.8215830287704;68990;69334.65332673304;69650;69678;70406.295937041;9018.09819018093;9090.318226132935;9231.399959002643;9302.86045709315;9462.101100395452;16845.91577042107;16907.40824071176;17150.228239729244;17175.96944183353;17301.307947682202;6195.81412557624;6242.157308763259;6274.121622972787;6401.9039714404325;6476.190476190476;3664.706823454117;3725.4784330193793;3728.2729867675544;3768.246350729865;3898.7075969302414;2614.8954041838115;2716.7147449517515;2732.0437846753475;2733.1253998720617;2735.3435175557725;513.4916432731569;517.8524120625603;518.5877227604063;529.1242992846844;532.0449792622175;485.5605676862445;493.60758197233287;498.5388515623034;523.1629392971215;523.9895202095937;7291.489595728354;7352.522086064496;7463.589502577411;7566.205548417337;7667.731629392944;409.3246143862591;481.0979413599501;535.5314100162358;542.2029616463792;547.7699366266178;3565.2691198304287;3579.0136474256515;3592.5329707137903;3648.2338708871434;3832.1952389997855;92900.53549732208;93369;94121.5293923526;95332.52333738425;97272;81789.59105204436;82909.58545207235;83820;87343.56328218318;87504;69467.3053269471;71323.64338178276;71552.56894862177;71610.64194679097;72516;7533.8116547086765;8207.425480216567;8246.422750407413;8565.48607083577;8648.56757162152;40910.59089409068;41725.79137104295;45232.095358091996;46694.299585506924;47550.76224618855;63155.36844631495;64278.67860660667;64729;65274.673626631564;66775;10123.59505619767;10425.322354046963;10437.739056523647;10452.634157804441;10800.783984320113;10445.059944605022;10869.402182880018;10993.670189894316;11211.327320360804;11491.655250342503;10462.21533384984;10617.681469555926;10656.147508199481;10660.84008739885;10800.459977001276;10128.088472037552;10297.691069267934;10585.682429527127;11071.225014248925;11503;10439.348159888928;10688.358698478116;10729.141668666643;11018.39398833072;11246.718832029264;9402.670906518239;9704.120729532398;9707;9921.362975109027;9988.400695958266;8436.831263374821;9038.322125840457;9406.200472959876;9438.905610943802;9592 01:24:05 INFO - PROCESS | 8884 | __end_tp_report 01:24:05 INFO - PROCESS | 8884 | __start_cc_report 01:24:05 INFO - PROCESS | 8884 | _x_x_mozilla_cycle_collect,350 01:24:05 INFO - PROCESS | 8884 | __end_cc_report 01:24:05 INFO - PROCESS | 8884 | __startTimestamp1474446244997__endTimestamp 01:24:05 INFO - PROCESS | 8884 | 01:24:05 INFO - PROCESS | 8884 | ------- Summary: start ------- 01:24:05 INFO - PROCESS | 8884 | Number of tests: 6 01:24:05 INFO - PROCESS | 8884 | 01:24:05 INFO - PROCESS | 8884 | [#0] dojo.html Cycles:165 Average:4711.15 Median:4823.71 stddev:490.79 (10.2%) stddev-sans-first:464.08 01:24:05 INFO - PROCESS | 8884 | Values: 2620.3 2623.3 2628.5 2648.1 2663.5 4640.7 4777.6 4798.0 4811.2 4867.5 4630.7 4733.3 4793.2 4810.7 4823.7 4352.7 4375.3 4434.4 4464.8 4509.4 4412.9 4437.4 4438.4 4489.7 4530.8 4318.6 4319.6 4377.6 4426.2 4523.3 4324.3 4345.9 4363.6 4393.1 4429.9 4301.0 4311.7 4323.4 4386.2 4387.6 4722.3 4750.5 4767.4 4782.3 4820.9 5024.0 5055.0 5075.9 5087.8 5089.1 5055.7 5075.9 5101.9 5130.4 5188.2 4638.5 4686.7 4750.8 4753.9 4800.0 5124.4 5141.8 5157.8 5162.3 5240.0 4939.0 4949.4 4988.1 4988.2 5079.1 4971.3 5014.7 5056.7 5076.1 5082.7 5044.4 5089.3 5090.5 5103.8 5182.3 5088.2 5095.2 5097.1 5116.3 5151.3 4233.9 4392.7 4393.9 4396.7 4440.5 3728.3 3736.1 3792.5 3800.6 3803.0 4428.8 4442.6 4453.3 4476.2 4491.0 5086.8 5131.3 5133.1 5143.0 5202.8 4321.6 4363.0 4384.6 4427.2 4496.8 4563.3 4569.5 4602.9 4610.9 4670.3 4804.2 4806.8 4810.4 4815.7 4867.6 5017.8 5125.1 5149.5 5150.5 5198.5 4730.6 4769.6 4773.6 4777.7 4837.3 4938.6 4940.2 4951.5 4966.0 5042.2 5062.8 5083.0 5084.0 5100.2 5142.0 4843.5 4881.7 4901.4 4912.9 4925.4 4953.1 4959.2 4959.2 4977.8 5016.9 4759.9 4835.4 4845.0 4847.5 4927.0 4986.7 5023.9 5025.4 5038.5 5100.9 4910.7 4929.7 4932.0 4934.8 5014.2 01:24:05 INFO - PROCESS | 8884 | 01:24:05 INFO - PROCESS | 8884 | [#1] ext.html Cycles:180 Average:45227.45 Median:35100.74 stddev:82099.90 (233.9%) stddev-sans-first:82261.67 01:24:05 INFO - PROCESS | 8884 | Values: 544.6 550.9 552.1 556.5 566.0 37111.7 39564.6 39720.0 42874.6 43051.0 38717.8 39332.4 39405.8 39425.2 39489.0 7476.9 7682.7 7685.1 7686.3 7693.6 7513.3 7648.0 7656.0 7697.0 7710.3 7707.2 7777.6 7779.3 7786.5 7787.0 7655.5 7688.3 7696.2 7734.1 7734.4 7598.1 7614.8 7627.0 7663.3 7704.2 37064.0 37591.0 37781.4 37806.8 37870.8 2743.8 2942.9 2989.0 2993.6 3160.5 27903.9 28299.4 28385.6 28415.9 28959.0 3388.5 3412.2 3449.4 3456.0 3484.4 235391.0 235780.1 236604.0 237040.8 237617.0 45168.3 45579.5 45654.8 45661.8 45710.3 32028.5 32961.8 33014.0 34626.7 52558.5 13368.1 13430.1 13506.5 13512.1 13516.6 11048.9 11262.2 11290.6 11305.8 11314.9 17437.8 17505.0 17536.6 17559.1 17688.6 6676.6 6684.5 6746.0 6771.5 6820.9 733.4 802.2 915.2 921.7 972.9 26202.6 27121.3 27391.2 27691.0 27850.3 882.3 923.5 986.3 991.7 1013.7 13337.3 14015.9 14222.8 14254.0 14330.5 368501.0 370448.0 370997.0 371223.0 372551.0 47372.0 47488.5 47551.0 47571.3 47979.8 1117.3 1156.5 1166.7 1166.8 1167.9 24604.3 25481.6 26430.0 26464.9 26595.3 39185.6 39664.8 39699.4 39751.8 39794.4 313571.0 313852.0 314066.0 314486.0 314666.0 24287.9 24376.0 24815.3 24844.8 24887.8 39942.0 40156.4 40165.0 40934.8 41005.2 33966.3 34373.0 34552.0 34758.5 34768.8 34522.8 34542.0 34575.0 34779.5 35153.6 34855.0 35047.8 35238.6 35883.0 36102.3 30689.0 31477.5 32819.0 32944.8 33159.3 24389.6 24653.1 24759.9 24810.5 25431.0 01:24:05 INFO - PROCESS | 8884 | 01:24:05 INFO - PROCESS | 8884 | [#2] jquery.html Cycles:180 Average:22932.29 Median:5243.20 stddev:57380.02 (1094.4%) stddev-sans-first:57515.96 01:24:05 INFO - PROCESS | 8884 | Values: 360.5 365.8 371.8 375.2 383.3 15530.5 16686.0 17433.7 17498.4 17549.0 15746.0 16217.4 16778.2 16810.8 16894.4 4920.0 5171.9 5181.2 5182.9 5188.2 3708.3 3888.6 5172.7 5676.7 5974.5 6051.2 6064.2 6067.3 6068.6 6070.1 5791.1 5973.9 6002.8 6011.5 6017.8 5127.0 5298.2 5299.3 5300.3 5300.8 20677.8 20918.3 20958.4 21027.4 21051.9 1845.8 1886.1 1926.2 1949.5 2065.1 12744.5 13358.9 13581.5 13644.8 14014.6 1733.5 1740.1 1751.3 1755.8 1819.8 68645.3 68809.7 70746.6 71122.6 71155.0 9520.0 9625.3 9678.5 9746.3 9974.2 13519.6 13597.9 13603.5 13604.9 13609.3 7490.1 7655.6 7711.0 7855.6 7868.5 7442.5 7468.2 7488.6 7660.1 7706.9 6027.4 6125.6 6214.9 6224.1 6384.2 1597.4 1695.8 1697.8 1715.5 1797.0 825.3 828.8 830.4 838.7 881.8 16368.3 16859.8 17256.9 17461.9 17690.0 853.6 871.5 881.4 891.9 952.0 9764.5 9766.8 9918.7 9964.5 10163.7 343727.0 345098.0 347360.0 348988.0 349238.0 65180.0 65481.0 66335.3 66739.3 67481.7 878.4 897.6 913.7 918.8 932.2 15257.7 15314.9 15465.1 15993.4 16009.4 34406.7 34442.1 34534.8 34554.1 35205.6 53646.2 54465.2 54631.0 54829.0 55217.4 4633.0 4758.9 4999.0 5722.8 7610.6 7948.5 8517.5 10657.1 11788.8 11895.9 8248.0 9256.6 9682.7 9723.4 10152.4 9751.8 9796.7 9903.5 10002.2 10317.8 10069.2 10225.6 10432.8 10451.7 10747.9 6663.6 6864.3 6907.0 7215.1 7419.7 8081.3 9851.7 9895.5 10386.7 10473.0 01:24:05 INFO - PROCESS | 8884 | 01:24:05 INFO - PROCESS | 8884 | [#3] mootools.html Cycles:180 Average:5142.98 Median:4854.71 stddev:2956.42 (60.9%) stddev-sans-first:2950.87 01:24:05 INFO - PROCESS | 8884 | Values: 1335.4 1367.1 1426.6 1628.2 1647.2 6855.9 7099.6 7448.4 8172.8 8213.3 7546.0 7865.2 7889.5 8117.4 8123.5 2174.2 2197.4 2202.1 2206.4 2209.1 2157.8 2188.1 2205.5 2206.7 2210.5 2175.8 2184.2 2188.2 2193.8 2195.9 2145.0 2151.4 2151.8 2154.3 2155.9 2098.7 2105.0 2145.3 2153.9 2156.1 8032.3 8064.3 8068.5 8088.6 8142.2 4525.3 4554.1 4557.8 4562.8 4581.1 2745.6 2814.3 2856.6 2896.8 2946.8 885.4 920.9 935.4 940.3 942.9 10722.0 10829.2 10864.7 10928.5 10954.8 3956.4 4094.0 4244.6 4279.5 4294.5 9209.1 9243.7 9244.5 9246.2 9252.0 4564.0 4570.7 4572.8 4586.7 4593.8 3754.4 3890.8 4003.8 4170.4 4176.2 3541.9 3581.7 3698.3 3733.3 3744.7 1151.4 1173.3 1183.6 1227.8 1232.8 664.2 756.5 781.2 781.5 792.9 4854.7 4947.6 4973.4 5048.2 5240.5 412.9 414.4 424.8 428.4 431.9 3312.9 3374.3 3411.6 3455.3 3499.9 9451.5 9711.6 9713.4 9804.0 9822.8 9485.5 9708.1 9727.1 9732.3 9734.2 7300.0 7336.0 7394.3 7418.0 7453.5 4854.8 4951.5 5016.7 5298.8 5316.1 9034.5 9079.2 9145.9 9215.3 9263.8 9008.6 9148.6 9179.5 9335.4 9384.3 6806.7 6896.7 6952.6 6973.0 7065.5 7533.8 7597.7 7599.1 7603.3 7616.2 6621.5 6700.0 6729.4 6880.9 6910.2 6664.6 6769.9 6845.3 6899.1 6904.9 5959.9 6056.8 6061.5 6063.8 6066.8 4511.5 4549.6 4612.5 4625.1 4665.3 4579.0 4605.8 4617.7 4696.3 4835.5 01:24:05 INFO - PROCESS | 8884 | 01:24:05 INFO - PROCESS | 8884 | [#4] prototype.html Cycles:180 Average:4315.37 Median:4929.59 stddev:1291.96 (26.2%) stddev-sans-first:1259.63 01:24:05 INFO - PROCESS | 8884 | Values: 282.7 285.4 292.3 294.6 294.8 4845.2 4951.9 5084.3 5116.2 5161.2 4778.5 4902.0 4928.9 4993.4 5015.7 3903.1 3919.7 3928.4 3953.6 3954.5 3680.4 3951.3 3963.9 3964.7 3964.8 3819.2 3822.2 3832.4 3833.6 3835.8 3810.6 3819.2 3828.0 3830.8 3838.4 3198.2 3321.3 3338.3 3342.1 3342.7 4900.7 4927.9 4930.3 4971.3 4972.9 4424.5 4426.7 4434.5 4439.9 4462.4 5032.3 5287.1 5332.3 5336.5 5362.5 3655.9 3657.1 3676.9 3687.2 3694.9 5498.5 5529.4 5574.9 5581.4 5597.6 3690.4 3784.4 3789.5 3790.5 3803.1 3769.5 3777.3 3811.7 3823.9 3840.7 4385.8 4407.5 4409.6 4414.3 4437.6 5307.1 5310.7 5322.4 5341.3 5365.4 1281.4 1314.0 1319.9 1327.5 1328.8 776.2 817.2 831.3 834.9 836.8 4098.2 4100.3 4122.2 4144.5 4161.5 4726.3 4745.0 4769.9 4788.5 4792.0 4150.9 4161.4 4161.5 4169.9 4182.4 2571.3 2681.6 2907.3 2911.7 2915.8 5120.7 5123.8 5138.5 5144.3 5147.6 5352.2 5574.0 5579.7 5581.3 5604.8 5057.7 5061.9 5070.9 5094.8 5115.7 5412.2 5424.8 5432.2 5441.5 5446.8 5111.0 5344.6 5360.7 5368.7 5373.3 5087.8 5088.8 5093.8 5150.9 5162.6 3521.5 3642.8 3673.9 3675.8 3692.2 5325.4 5431.5 5480.3 5484.6 5490.0 5312.5 5315.2 5317.8 5320.0 5363.8 5067.9 5280.3 5328.2 5339.4 5343.5 5222.5 5236.5 5252.0 5257.2 5263.1 5342.8 5357.3 5374.3 5378.9 5393.0 5107.2 5213.9 5237.8 5259.3 5264.9 01:24:05 INFO - PROCESS | 8884 | 01:24:05 INFO - PROCESS | 8884 | [#5] yui.html Cycles:180 Average:17520.16 Median:530.58 stddev:25499.24 (4805.9%) stddev-sans-first:25538.95 01:24:05 INFO - PROCESS | 8884 | Values: 553.9 558.6 559.2 563.8 617.1 12357.0 12701.0 12783.8 12900.9 12912.2 12129.3 12506.9 12547.7 12742.8 12781.6 720.9 749.4 751.8 752.6 753.4 737.2 762.4 766.6 769.7 773.9 806.2 814.6 816.2 816.7 818.8 796.3 805.0 806.6 807.5 807.8 593.9 594.6 594.9 595.6 598.6 11514.4 11516.7 11600.3 11658.4 11691.2 11597.4 12038.5 12196.4 12602.1 13290.7 10908.5 11302.2 11338.0 11504.1 11654.3 3836.2 3864.3 3953.1 3954.2 3964.8 68990.0 69334.7 69650.0 69678.0 70406.3 9018.1 9090.3 9231.4 9302.9 9462.1 16845.9 16907.4 17150.2 17176.0 17301.3 6195.8 6242.2 6274.1 6401.9 6476.2 3664.7 3725.5 3728.3 3768.2 3898.7 2614.9 2716.7 2732.0 2733.1 2735.3 513.5 517.9 518.6 529.1 532.0 485.6 493.6 498.5 523.2 524.0 7291.5 7352.5 7463.6 7566.2 7667.7 409.3 481.1 535.5 542.2 547.8 3565.3 3579.0 3592.5 3648.2 3832.2 92900.5 93369.0 94121.5 95332.5 97272.0 81789.6 82909.6 83820.0 87343.6 87504.0 69467.3 71323.6 71552.6 71610.6 72516.0 7533.8 8207.4 8246.4 8565.5 8648.6 40910.6 41725.8 45232.1 46694.3 47550.8 63155.4 64278.7 64729.0 65274.7 66775.0 10123.6 10425.3 10437.7 10452.6 10800.8 10445.1 10869.4 10993.7 11211.3 11491.7 10462.2 10617.7 10656.1 10660.8 10800.5 10128.1 10297.7 10585.7 11071.2 11503.0 10439.3 10688.4 10729.1 11018.4 11246.7 9402.7 9704.1 9707.0 9921.4 9988.4 8436.8 9038.3 9406.2 9438.9 9592.0 01:24:05 INFO - PROCESS | 8884 | -------- Summary: end -------- 01:24:05 INFO - PROCESS | 8884 | 01:24:06 INFO - TEST-INFO | 8884: exit 0 01:24:06 INFO - TEST-OK | dromaeo_css | took 1118258ms 01:24:06 INFO - TEST-START | kraken 01:24:06 INFO - operating with platform_type : linux_ 01:24:06 INFO - Initialising browser for kraken test... 01:24:06 INFO - TEST-INFO | started process 9242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQDGphz/profile http://localhost:48727/getInfo.html) 01:24:11 INFO - PROCESS | 9242 | __metrics Screen width/height:1600/1200 01:24:11 INFO - PROCESS | 9242 | colorDepth:24 01:24:11 INFO - PROCESS | 9242 | Browser inner width/height: 1024/697 01:24:11 INFO - PROCESS | 9242 | __metrics 01:24:11 ERROR - PROCESS | 9242 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 01:24:12 INFO - TEST-INFO | 9242: exit 0 01:24:12 INFO - Browser initialized. 01:24:12 INFO - Running cycle 1/1 for kraken test... 01:24:12 INFO - TEST-INFO | started process 9362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQDGphz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:24:24 INFO - PROCESS | 9362 | RSS: Main: 186576896 01:24:24 INFO - PROCESS | 9362 | 01:24:27 INFO - PROCESS | 9362 | Cycle 1(1): loaded http://localhost:48727/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48727/tests/kraken/driver.html?testName=audio-beat-detection) 01:24:28 INFO - PROCESS | 9362 | RSS: Main: 199667712 01:24:28 INFO - PROCESS | 9362 | 01:24:31 INFO - PROCESS | 9362 | Cycle 1(1): loaded http://localhost:48727/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48727/tests/kraken/driver.html?testName=audio-dft) 01:24:32 INFO - PROCESS | 9362 | RSS: Main: 198635520 01:24:32 INFO - PROCESS | 9362 | 01:24:35 INFO - PROCESS | 9362 | Cycle 1(1): loaded http://localhost:48727/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48727/tests/kraken/driver.html?testName=audio-fft) 01:24:35 INFO - PROCESS | 9362 | RSS: Main: 193847296 01:24:35 INFO - PROCESS | 9362 | 01:24:38 INFO - PROCESS | 9362 | Cycle 1(1): loaded http://localhost:48727/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48727/tests/kraken/driver.html?testName=audio-oscillator) 01:24:38 INFO - PROCESS | 9362 | RSS: Main: 193961984 01:24:38 INFO - PROCESS | 9362 | 01:24:40 INFO - PROCESS | 9362 | Cycle 1(1): loaded http://localhost:48727/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48727/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:24:41 INFO - PROCESS | 9362 | RSS: Main: 194314240 01:24:41 INFO - PROCESS | 9362 | 01:24:44 INFO - PROCESS | 9362 | Cycle 1(1): loaded http://localhost:48727/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48727/tests/kraken/driver.html?testName=imaging-darkroom) 01:24:45 INFO - PROCESS | 9362 | RSS: Main: 194232320 01:24:45 INFO - PROCESS | 9362 | 01:24:48 INFO - PROCESS | 9362 | Cycle 1(1): loaded http://localhost:48727/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48727/tests/kraken/driver.html?testName=imaging-desaturate) 01:24:49 INFO - PROCESS | 9362 | RSS: Main: 192344064 01:24:49 INFO - PROCESS | 9362 | 01:24:52 INFO - PROCESS | 9362 | Cycle 1(1): loaded http://localhost:48727/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48727/tests/kraken/driver.html?testName=json-parse-financial) 01:24:53 INFO - PROCESS | 9362 | RSS: Main: 193638400 01:24:53 INFO - PROCESS | 9362 | 01:24:54 INFO - PROCESS | 9362 | Cycle 1(1): loaded http://localhost:48727/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48727/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:24:55 INFO - PROCESS | 9362 | RSS: Main: 194416640 01:24:55 INFO - PROCESS | 9362 | 01:24:57 INFO - PROCESS | 9362 | Cycle 1(1): loaded http://localhost:48727/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48727/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:24:57 INFO - PROCESS | 9362 | RSS: Main: 194420736 01:24:57 INFO - PROCESS | 9362 | 01:25:00 INFO - PROCESS | 9362 | Cycle 1(1): loaded http://localhost:48727/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48727/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:25:00 INFO - PROCESS | 9362 | RSS: Main: 194711552 01:25:00 INFO - PROCESS | 9362 | 01:25:03 INFO - PROCESS | 9362 | Cycle 1(1): loaded http://localhost:48727/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:25:04 INFO - PROCESS | 9362 | RSS: Main: 195125248 01:25:04 INFO - PROCESS | 9362 | 01:25:07 INFO - PROCESS | 9362 | Cycle 1(1): loaded http://localhost:48727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:25:07 INFO - PROCESS | 9362 | RSS: Main: 194936832 01:25:07 INFO - PROCESS | 9362 | 01:25:09 INFO - PROCESS | 9362 | Cycle 1(1): loaded http://localhost:48727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48727/tests/kraken/driver.html?testName=ai-astar) 01:25:09 INFO - PROCESS | 9362 | RSS: Main: 197427200 01:25:09 INFO - PROCESS | 9362 | 01:25:09 INFO - PROCESS | 9362 | __start_tp_report 01:25:09 INFO - PROCESS | 9362 | _x_x_mozilla_page_load 01:25:09 INFO - PROCESS | 9362 | _x_x_mozilla_page_load_details 01:25:09 INFO - PROCESS | 9362 | |i|pagename|runs| 01:25:09 INFO - PROCESS | 9362 | |0;ai-astar;109;116;117;116;116;122;116;114;115;114 01:25:09 INFO - PROCESS | 9362 | |1;audio-beat-detection;148;131;126;167;130;125;127;128;157;134 01:25:09 INFO - PROCESS | 9362 | |2;audio-dft;170;175;163;165;164;167;163;163;165;164 01:25:09 INFO - PROCESS | 9362 | |3;audio-fft;78;78;76;110;78;78;77;77;108;77 01:25:09 INFO - PROCESS | 9362 | |4;audio-oscillator;84;83;114;84;84;84;104;85;84;112 01:25:09 INFO - PROCESS | 9362 | |5;imaging-gaussian-blur;118;118;118;118;118;120;119;117;119;120 01:25:09 INFO - PROCESS | 9362 | |6;imaging-darkroom;148;148;148;148;147;150;150;151;148;150 01:25:09 INFO - PROCESS | 9362 | |7;imaging-desaturate;95;95;96;95;95;95;95;96;96;96 01:25:09 INFO - PROCESS | 9362 | |8;json-parse-financial;65;62;63;64;65;65;66;65;65;68 01:25:09 INFO - PROCESS | 9362 | |9;json-stringify-tinderbox;66;66;66;68;68;66;66;67;66;66 01:25:09 INFO - PROCESS | 9362 | |10;stanford-crypto-aes;86;84;83;84;82;83;83;84;83;83 01:25:09 INFO - PROCESS | 9362 | |11;stanford-crypto-ccm;137;145;148;137;154;146;136;137;172;149 01:25:09 INFO - PROCESS | 9362 | |12;stanford-crypto-pbkdf2;171;181;172;177;172;175;172;171;169;173 01:25:09 INFO - PROCESS | 9362 | |13;stanford-crypto-sha256-iterative;74;69;69;71;71;69;73;70;71;71 01:25:09 INFO - PROCESS | 9362 | __end_tp_report 01:25:09 INFO - PROCESS | 9362 | __start_cc_report 01:25:09 INFO - PROCESS | 9362 | _x_x_mozilla_cycle_collect,870 01:25:09 INFO - PROCESS | 9362 | __end_cc_report 01:25:09 INFO - PROCESS | 9362 | __startTimestamp1474446309995__endTimestamp 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | ------- Summary: start ------- 01:25:10 INFO - PROCESS | 9362 | Number of tests: 14 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.00 stddev:3.21 (2.8%) stddev-sans-first:2.39 01:25:10 INFO - PROCESS | 9362 | Values: 109.0 116.0 117.0 116.0 116.0 122.0 116.0 114.0 115.0 114.0 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:132.50 stddev:14.76 (11.1%) stddev-sans-first:15.14 01:25:10 INFO - PROCESS | 9362 | Values: 148.0 131.0 126.0 167.0 130.0 125.0 127.0 128.0 157.0 134.0 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | [#2] audio-dft Cycles:10 Average:165.90 Median:165.00 stddev:3.87 (2.3%) stddev-sans-first:3.81 01:25:10 INFO - PROCESS | 9362 | Values: 170.0 175.0 163.0 165.0 164.0 167.0 163.0 163.0 165.0 164.0 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | [#3] audio-fft Cycles:10 Average:83.70 Median:77.50 stddev:13.36 (17.2%) stddev-sans-first:14.01 01:25:10 INFO - PROCESS | 9362 | Values: 78.0 78.0 76.0 110.0 78.0 78.0 77.0 77.0 108.0 77.0 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:84.00 stddev:12.81 (15.3%) stddev-sans-first:13.28 01:25:10 INFO - PROCESS | 9362 | Values: 84.0 83.0 114.0 84.0 84.0 84.0 104.0 85.0 84.0 112.0 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.50 stddev:0.97 (0.8%) stddev-sans-first:1.01 01:25:10 INFO - PROCESS | 9362 | Values: 118.0 118.0 118.0 118.0 118.0 120.0 119.0 117.0 119.0 120.0 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:1.32 (0.9%) stddev-sans-first:1.36 01:25:10 INFO - PROCESS | 9362 | Values: 148.0 148.0 148.0 148.0 147.0 150.0 150.0 151.0 148.0 150.0 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 01:25:10 INFO - PROCESS | 9362 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:1.62 (2.5%) stddev-sans-first:1.72 01:25:10 INFO - PROCESS | 9362 | Values: 65.0 62.0 63.0 64.0 65.0 65.0 66.0 65.0 65.0 68.0 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 01:25:10 INFO - PROCESS | 9362 | Values: 66.0 66.0 66.0 68.0 68.0 66.0 66.0 67.0 66.0 66.0 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:83.50 stddev:1.08 (1.3%) stddev-sans-first:0.67 01:25:10 INFO - PROCESS | 9362 | Values: 86.0 84.0 83.0 84.0 82.0 83.0 83.0 84.0 83.0 83.0 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | [#11] stanford-crypto-ccm Cycles:10 Average:146.10 Median:147.00 stddev:11.04 (7.5%) stddev-sans-first:11.21 01:25:10 INFO - PROCESS | 9362 | Values: 137.0 145.0 148.0 137.0 154.0 146.0 136.0 137.0 172.0 149.0 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.30 Median:172.50 stddev:3.50 (2.0%) stddev-sans-first:3.61 01:25:10 INFO - PROCESS | 9362 | Values: 171.0 181.0 172.0 177.0 172.0 175.0 172.0 171.0 169.0 173.0 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.69 (2.4%) stddev-sans-first:1.33 01:25:10 INFO - PROCESS | 9362 | Values: 74.0 69.0 69.0 71.0 71.0 69.0 73.0 70.0 71.0 71.0 01:25:10 INFO - PROCESS | 9362 | -------- Summary: end -------- 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000C,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | 01:25:10 INFO - PROCESS | 9362 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 01:25:10 INFO - PROCESS | 9362 | 01:25:11 INFO - TEST-INFO | 9362: exit 0 01:25:11 INFO - TEST-OK | kraken | took 65079ms 01:25:11 INFO - SUITE-END | took 1183s 01:25:11 INFO - Completed test suite (00:19:43) 01:25:11 INFO - javascript benchmark 01:25:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6324.096530425061, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2620.253227830068, 2623.317937336292, 2628.4874449482345, 2648.059938721754, 2663.493936152132, 4640.651951103672, 4777.641676874236, 4798.0, 4811.23020316749, 4867.513248675131, 4630.699004564701, 4733.313669517926, 4793.1611967905565, 4810.68730532516, 4823.71057736536, 4352.738835669854, 4375.299952007679, 4434.379186913835, 4464.843730469434, 4509.368688383629, 4412.889677758066, 4437.400950871639, 4438.4451943507065, 4489.730616163024, 4530.841420550281, 4318.589733975299, 4319.611234988866, 4377.584129507692, 4426.22541055314, 4523.321501774727, 4324.308110702273, 4345.9130817383475, 4363.563643635643, 4393.0994146199955, 4429.889252768674, 4301.032267739764, 4311.676624253162, 4323.437953066082, 4386.210482113218, 4387.561243875619, 4722.3152642866935, 4750.45369782476, 4767.380240568738, 4782.33047373368, 4820.903581928342, 5024.0, 5055.039542486916, 5075.949240507584, 5087.79648814047, 5089.109405853961, 5055.6713813602, 5075.898482030376, 5101.872453188663, 5130.410002849682, 5188.247704082924, 4638.512956139557, 4686.74222917736, 4750.762461876892, 4753.881152971168, 4799.9760001199775, 5124.385073791169, 5141.845744627667, 5157.7679004444135, 5162.303089082926, 5240.030594340059, 4938.975305123451, 4949.356583644103, 4988.102141614544, 4988.152014157602, 5079.111155547838, 4971.304017437562, 5014.674046186986, 5056.696598204046, 5076.086304465158, 5082.745862706924, 5044.369453818273, 5089.338386009795, 5090.490950904954, 5103.795848166032, 5182.326297581366, 5088.236764485357, 5095.181439619319, 5097.08252514551, 5116.309298244763, 5151.278820965068, 4233.941514621345, 4392.714473559208, 4393.912121757547, 4396.692231543825, 4440.467143942683, 3728.3102626014274, 3736.103335199587, 3792.4500947362476, 3800.562935262425, 3802.961970380316, 4428.800703968329, 4442.644588432918, 4453.287474004209, 4476.171908196994, 4490.955090449053, 5086.821961231339, 5131.307273518102, 5133.1273683473155, 5142.997115562504, 5202.76587553561, 4321.567843215653, 4363.018320877841, 4384.649228061748, 4427.158839820424, 4496.820127194941, 4563.269876819693, 4569.474510431276, 4602.907941841145, 4610.861674149781, 4670.322803193518, 4804.183288840905, 4806.807727690853, 4810.39870016248, 4815.662903596784, 4867.586255168279, 5017.774200160929, 5125.103106956342, 5149.510796474329, 5150.536451719363, 5198.4801519847715, 4730.550597693214, 4769.594584460221, 4773.594244489118, 4777.689450185727, 4837.322774811459, 4938.604911607134, 4940.184869496493, 4951.5048495150195, 4965.950340496549, 5042.218456139304, 5062.772175252197, 5082.974585127051, 5084.034033533617, 5100.158473851773, 5141.974290128525, 4843.539863712942, 4881.707097574157, 4901.362822833009, 4912.852614421573, 4925.433575138905, 4953.083679519301, 4959.156943319572, 4959.181735013683, 4977.751112444291, 5016.874578135576, 4759.857204283877, 4835.395575553056, 4845.0067736114715, 4847.491013443538, 4927.039227350632, 4986.7257300848805, 5023.924641130313, 5025.3718285214345, 5038.47096054909, 5100.928804951001, 4910.705357678551, 4929.728864912464, 4932.0, 4934.802607895644, 5014.247862820606], "value": 4679.647236194025, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.6269305525715, 550.9118541033434, 552.1359073050678, 556.4824713016895, 565.9971700141498, 37111.70109046181, 39564.60435395645, 39720.00699982498, 42874.571254287446, 43051.0, 38717.806410967976, 39332.41001384982, 39405.847532197426, 39425.21149577007, 39489.0, 7476.850462990737, 7682.731104411347, 7685.11621163565, 7686.3466605338335, 7693.576853273068, 7513.286237807427, 7648.0, 7656.0, 7696.961515192416, 7710.344620707247, 7707.152213256537, 7777.611119444005, 7779.338756205701, 7786.493877897947, 7786.961065194694, 7655.50239234448, 7688.346490548282, 7696.230376962315, 7734.110577283572, 7734.419918506134, 7598.08822941245, 7614.8096297593, 7627.0, 7663.271989161077, 7704.191059938682, 37064.0, 37591.0, 37781.433278500845, 37806.81096594527, 37870.81064594687, 2743.7530622244094, 2942.8969986050383, 2988.9850550747324, 2993.6407631084408, 3160.5259211118287, 27903.860480697465, 28299.434011319863, 28385.57421638677, 28415.857920710263, 28959.0, 3388.4747864081105, 3412.181076541637, 3449.379111759882, 3456.0495863637448, 3484.372812893678, 235391.0, 235780.13758899248, 236604.0, 237040.81479592665, 237616.99999999828, 45168.3224751629, 45579.544204558195, 45654.77172614182, 45661.77169114133, 45710.314345284845, 32028.519572206435, 32961.83519082389, 33014.0, 34626.65373346234, 52558.474415256125, 13368.131071480517, 13430.127041742255, 13506.459741610226, 13512.054156208971, 13516.594502164951, 11048.944755276332, 11262.155338349492, 11290.604828830952, 11305.830412543819, 11314.943425282821, 17437.825621743876, 17505.0, 17536.64926701459, 17559.122043897754, 17688.55778605545, 6676.632785196861, 6684.498662600325, 6745.9662701686175, 6771.52599318043, 6820.93179068203, 733.3912852332551, 802.1897883138073, 915.1534830282095, 921.7373048681094, 972.924917965652, 26202.606960895602, 27121.321966950985, 27391.178264651695, 27691.0, 27850.303742406195, 882.289756745813, 923.4920793563513, 986.3095832916987, 991.6777047459605, 1013.7313611892854, 13337.266450345323, 14015.929920350536, 14222.786658200135, 14254.0, 14330.49843255481, 368501.0, 370448.0, 370997.0, 371223.0, 372551.0, 47372.0, 47488.5251147491, 47551.0, 47571.28643070357, 47979.760101199274, 1117.3072694929197, 1156.4795841871191, 1166.7258194324327, 1166.78414493319, 1167.9474423650956, 24604.293527712296, 25481.617775733008, 26430.0, 26464.8676756615, 26595.33511662224, 39185.608143918194, 39664.80167599144, 39699.40450893181, 39751.80124099477, 39794.403083953184, 313571.0, 313852.0, 314066.0, 314486.0, 314666.0, 24287.87856060779, 24376.0, 24815.255542333758, 24844.751552484242, 24887.751122489266, 39942.0, 40156.3976540358, 40165.0, 40934.79532602318, 41005.17989640131, 33966.32067358688, 34373.0, 34552.0, 34758.47862282118, 34768.82615586906, 34522.82738586291, 34542.0, 34575.0, 34779.478307824895, 35153.64846351606, 34855.0, 35047.824760877054, 35238.647613523535, 35883.0, 36102.27795444129, 30689.0, 31477.527837082922, 32819.015429537154, 32944.83527582443, 33159.33681326408, 24389.63415548804, 24653.137140200008, 24759.87620061888, 24810.50378992446, 25431.0], "value": 16803.98642992436, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.51510718084177, 365.8061227549398, 371.817809273456, 375.1858467126339, 383.342567496743, 15530.534083977485, 16686.0, 17433.738493922603, 17498.387556435526, 17549.034803085826, 15746.0, 16217.432389866328, 16778.161091945414, 16810.83189168108, 16894.408695695653, 4919.975400123003, 5171.922421163686, 5181.222816577506, 5182.870428239286, 5188.221766734982, 3708.3139619170406, 3888.591697871725, 5172.663776854492, 5676.744546495397, 5974.462298393144, 6051.243594550681, 6064.241969753781, 6067.332593414721, 6068.605540639866, 6070.0591408331775, 5791.10237913122, 5973.910391344133, 6002.819915402545, 6011.5190784737115, 6017.7592896284095, 5127.0, 5298.178782288713, 5299.311089558371, 5300.257963885059, 5300.840974770763, 20677.793222067736, 20918.267860624805, 20958.371248862557, 21027.369178924655, 21051.8947405262, 1845.7600511933497, 1886.1323791056132, 1926.1813729165049, 1949.5028767664296, 2065.0810389376734, 12744.490220391173, 13358.933205333911, 13581.456741730319, 13644.795328070088, 14014.649633759136, 1733.4886208568375, 1740.1386313774763, 1751.3082332478727, 1755.8244175582468, 1819.7725284339458, 68645.31354686439, 68809.65595171992, 70746.64626676885, 71122.64438677825, 71155.0, 9520.0, 9625.32622716417, 9678.467684277432, 9746.317757757031, 9974.197868862162, 13519.594412167455, 13597.932010340082, 13603.455861765617, 13604.93197534006, 13609.31953402326, 7490.101187857492, 7655.617219139021, 7710.96144519285, 7855.607219638995, 7868.488548244346, 7442.516236444614, 7468.178500364956, 7488.625568721543, 7660.119086305146, 7706.922930770621, 6027.427394397525, 6125.632462052202, 6214.937850621526, 6224.097505861715, 6384.201974753156, 1597.3850067723777, 1695.7625932369479, 1697.8471937525683, 1715.4596302164778, 1796.97304540432, 825.2531459029587, 828.763802316337, 830.4062595244429, 838.6896848166095, 881.7883707910183, 16368.345266189457, 16859.83140168607, 17256.913715431343, 17461.912690436468, 17690.0, 853.6329378367361, 871.5250188647202, 881.4094556647062, 891.892972843263, 951.990480095204, 9764.462954537568, 9766.804663906823, 9918.652847150315, 9964.501774911225, 10163.7459063524, 343727.0, 345098.0, 347360.0, 348988.0, 349238.0, 65180.0, 65481.0, 66335.33664663388, 66739.33260667331, 67481.66259168673, 878.4246318661287, 897.6140259688266, 913.6893456224783, 918.8346097702344, 932.2215949681956, 15257.694846103237, 15314.923425383247, 15465.149416782186, 15993.440229591908, 16009.35962561531, 34406.65593344034, 34442.13894652654, 34534.82732586321, 34554.13614659654, 35205.64794352126, 53646.195307071204, 54465.18302225391, 54631.0, 54829.0, 55217.44782552284, 4632.957584543451, 4758.881027974328, 4998.975005124951, 5722.771089156554, 7610.581418022062, 7948.523088614702, 8517.48895066298, 10657.14742820588, 11788.823167652321, 11895.940520297343, 8247.95876020616, 9256.629734810533, 9682.661106861226, 9723.416595004323, 10152.441615711206, 9751.756206094904, 9796.706098817047, 9903.45530995802, 10002.199824013916, 10317.771870108514, 10069.244806639384, 10225.59097636116, 10432.791344172922, 10451.738706532093, 10747.89252107469, 6663.633500157538, 6864.347886950732, 6907.0, 7215.134183897966, 7419.703211871465, 8081.313088387553, 9851.65519206853, 9895.505224738878, 10386.740331491774, 10473.0], "value": 8201.379333095461, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.4324412124845, 1367.111377604557, 1426.586289975907, 1628.210317995771, 1647.192875491009, 6855.897161542581, 7099.609521476316, 7448.441366897484, 8172.7548173554815, 8213.342932565389, 7545.962270188655, 7865.174156713534, 7889.4871833330935, 8117.431779775418, 8123.5125892446495, 2174.217281778562, 2197.3957161780477, 2202.0861342542826, 2206.4483879030245, 2209.149477451185, 2157.7950094740972, 2188.0700702201502, 2205.4596623827183, 2206.6579680149603, 2210.4694873230387, 2175.8476906616543, 2184.2355175688463, 2188.2122435923056, 2193.846430749848, 2195.9121635134575, 2144.9571008579896, 2151.38685474639, 2151.7633060363346, 2154.3321570313174, 2155.8814265215406, 2098.685197220414, 2104.989475052615, 2145.2706079932896, 2153.870767753924, 2156.105216335219, 8032.277095061472, 8064.274215320649, 8068.47554908929, 8088.636011379502, 8142.185781421869, 4525.2533332000185, 4554.134714404253, 4557.817687292504, 4562.794674239634, 4581.083783243364, 2745.643066401375, 2814.3104939290006, 2856.557233628791, 2896.8117072390437, 2946.7789915756402, 885.3890815337396, 920.8848893888264, 935.3686261773344, 940.2524992630875, 942.9151376376091, 10722.0, 10829.187810914213, 10864.728381790439, 10928.453577321103, 10954.835677464844, 3956.4263181839046, 4093.9590604094174, 4244.575542445792, 4279.529251782302, 4294.463192100988, 9209.125133112344, 9243.722688319362, 9244.537773111317, 9246.214071803972, 9251.953740231256, 4564.041551274269, 4570.65720070996, 4572.7942242599165, 4586.72479651222, 4593.816247350069, 3754.436834474796, 3890.8054597270025, 4003.819828107684, 4170.374443833449, 4176.204232180131, 3541.911452213664, 3581.659742324475, 3698.260347930425, 3733.253349330145, 3744.681702055356, 1151.424287856072, 1173.3077484284313, 1183.591660876996, 1227.766724322376, 1232.827404163418, 664.2394458345265, 756.53095081049, 781.1602527283193, 781.4842204145236, 792.9167437419103, 4854.660173787872, 4947.6289278304275, 4973.42805577356, 5048.192289233705, 5240.528352448298, 412.94218809366714, 414.44464417679853, 424.8258214132191, 428.39168380899196, 431.89418592445054, 3312.93374132516, 3374.308266805299, 3411.573553305837, 3455.2571197192724, 3499.8600055997476, 9451.480168590793, 9711.611535538499, 9713.417194968324, 9804.019598040139, 9822.803543929082, 9485.478298693639, 9708.077732615391, 9727.124558789743, 9732.318737688294, 9734.172595329335, 7299.963500182465, 7335.963320183365, 7394.26057394267, 7417.962910185414, 7453.515521491194, 4854.75726213695, 4951.5048495150195, 5016.673916195582, 5298.788048478018, 5316.149416093406, 9034.503102329434, 9079.228265597498, 9145.908540914506, 9215.262778977532, 9263.76840578991, 9008.594613242289, 9148.588313525774, 9179.541022948959, 9335.393199442015, 9384.296177786557, 6806.65966701653, 6896.724131034703, 6952.617606031717, 6972.965135174291, 7065.505414621133, 7533.849323013618, 7597.734079307198, 7599.1261004982925, 7603.2776886195725, 7616.23837616234, 6621.470282377302, 6699.9665001674675, 6729.394354508117, 6880.8967865483055, 6910.2398736137975, 6664.566803157779, 6769.932300677127, 6845.315468453314, 6899.068625735462, 6904.896426553505, 5959.940400595939, 6056.788012419544, 6061.545384096122, 6063.848403789941, 6066.787662431793, 4511.548845115462, 4549.567791059844, 4612.515685852937, 4625.07498500308, 4665.32352808834, 4578.954210457853, 4605.7927393268055, 4617.6536759742485, 4696.342512048248, 4835.516448355136], "value": 4046.0888343132992, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.7285805626597, 285.38499533505296, 292.3145224448667, 294.58610652033894, 294.7700793381163, 4845.1763200255955, 4951.876203094916, 5084.262781896623, 5116.155834287343, 5161.225816127583, 4778.450478195009, 4902.0, 4928.926066109002, 4993.350864387634, 5015.699058056519, 3903.10228647412, 3919.6864250859862, 3928.37146056631, 3953.5651078381356, 3954.5452272988687, 3680.429533422324, 3951.3480275754464, 3963.8810835674976, 3964.702647301464, 3964.8215830287563, 3819.1597848473293, 3822.178231680188, 3832.367659336206, 3833.616638336158, 3835.8082095895093, 3810.580836108026, 3819.2170605025904, 3828.0, 3830.80845957701, 3838.42423636454, 3198.2409674679066, 3321.2527181383994, 3338.3490219407227, 3342.1143396999814, 3342.732581393507, 4900.701314151753, 4927.926081108786, 4930.260460930853, 4971.254311853215, 4972.8508144755715, 4424.491183513905, 4426.667999900021, 4434.534373890728, 4439.867833702418, 4462.44219472566, 5032.295478632995, 5287.07476191665, 5332.253484512172, 5336.466353364672, 5362.51737343641, 3655.9268814623824, 3657.122290650251, 3676.852925882988, 3687.2441149564274, 3694.949303136758, 5498.532624726903, 5529.391766905637, 5574.916376254359, 5581.441855814386, 5597.580181486404, 3690.4279836625365, 3784.448376165814, 3789.5263092113487, 3790.488284081669, 3803.0682482791894, 3769.4545236452923, 3777.2823163598828, 3811.676007539335, 3823.885283441501, 3840.6763907835357, 4385.824567017347, 4407.515173330931, 4409.581089796464, 4414.271645178574, 4437.5784300491405, 5307.054584705448, 5310.6813591184655, 5322.414534401213, 5341.278927344759, 5365.38298095724, 1281.423359488234, 1313.967150821218, 1319.9340032998311, 1327.502186679995, 1328.774108401574, 776.1927595300824, 817.1868990354635, 831.2518733140101, 834.8539005673982, 836.8117173635883, 4098.180363927227, 4100.323446631272, 4122.196171746481, 4144.466547377489, 4161.479815023122, 4726.26742854858, 4745.003549254626, 4769.904601907942, 4788.497207793202, 4792.028942055878, 4150.900011496956, 4161.375793630919, 4161.459010328698, 4169.874903752892, 4182.435371224846, 2571.29289445404, 2681.5575430053823, 2907.2877145099587, 2911.7233862783, 2915.766738660902, 5120.667156634807, 5123.820666276737, 5138.537531622097, 5144.30551875492, 5147.639665223398, 5352.223927530486, 5574.042429874753, 5579.7489112990015, 5581.274434323594, 5604.775808967595, 5057.721825299644, 5061.8734531637, 5070.873228169252, 5094.796208151706, 5115.7442127893455, 5412.242286079873, 5424.83725488236, 5432.185172224198, 5441.5102640762525, 5446.836594902159, 5110.97444512775, 5344.625876188629, 5360.70516121617, 5368.731563421891, 5373.328333958255, 5087.796488140433, 5088.771005304696, 5093.796248150181, 5150.8969820604125, 5162.561182299547, 3521.454174602941, 3642.817859107087, 3673.8714145004797, 3675.7978311192073, 3692.1539230384806, 5325.360956685223, 5431.456854314537, 5480.260164877691, 5484.588655850747, 5490.0, 5312.495312945264, 5315.229291752751, 5317.8404647860625, 5319.973400132974, 5363.812266570651, 5067.949320506896, 5280.339957505312, 5328.200769884548, 5339.359276886643, 5343.492368225168, 5222.451642577626, 5236.481420388045, 5251.977988474388, 5257.237700533477, 5263.131583288715, 5342.813001544927, 5357.276767636475, 5374.3013408256675, 5378.946210537844, 5393.0, 5107.182850743863, 5213.869653258547, 5237.764300606405, 5259.263703081495, 5264.894702106013], "value": 3896.3559423056136, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.8615346163458, 558.5894367639784, 559.1947595462531, 563.8477611045018, 617.0589850478021, 12357.0, 12701.0, 12783.808242876352, 12900.935495322521, 12912.160709553873, 12129.272243665364, 12506.937465312683, 12547.749045019116, 12742.80885786714, 12781.61655150347, 720.899074129621, 749.3630414147958, 751.8233215194425, 752.586077657289, 753.4499815134927, 737.2111840330848, 762.3824701991405, 766.6166916541729, 769.730594291999, 773.8568364852492, 806.1938061938062, 814.6008455856618, 816.2286639125998, 816.677412422093, 818.8485130250892, 796.2555011064674, 805.0299389235986, 806.6047636658025, 807.5437377881508, 807.7617102954642, 593.8841925824466, 594.6342999055593, 594.9137375080633, 595.642614431342, 598.5540772124751, 11514.366709830956, 11516.654500365003, 11600.303981761037, 11658.358790266531, 11691.181617286793, 11597.362145082017, 12038.4582693779, 12196.39018049094, 12602.117851750381, 13290.73418531624, 10908.50911708967, 11302.208845380826, 11338.0, 11504.079673626089, 11654.300741955425, 3836.175222327185, 3864.285107255139, 3953.1105501262273, 3954.2486927483687, 3964.8215830287704, 68990.0, 69334.65332673304, 69650.0, 69678.0, 70406.295937041, 9018.09819018093, 9090.318226132935, 9231.399959002643, 9302.86045709315, 9462.101100395452, 16845.91577042107, 16907.40824071176, 17150.228239729244, 17175.96944183353, 17301.307947682202, 6195.81412557624, 6242.157308763259, 6274.121622972787, 6401.9039714404325, 6476.190476190476, 3664.706823454117, 3725.4784330193793, 3728.2729867675544, 3768.246350729865, 3898.7075969302414, 2614.8954041838115, 2716.7147449517515, 2732.0437846753475, 2733.1253998720617, 2735.3435175557725, 513.4916432731569, 517.8524120625603, 518.5877227604063, 529.1242992846844, 532.0449792622175, 485.5605676862445, 493.60758197233287, 498.5388515623034, 523.1629392971215, 523.9895202095937, 7291.489595728354, 7352.522086064496, 7463.589502577411, 7566.205548417337, 7667.731629392944, 409.3246143862591, 481.0979413599501, 535.5314100162358, 542.2029616463792, 547.7699366266178, 3565.2691198304287, 3579.0136474256515, 3592.5329707137903, 3648.2338708871434, 3832.1952389997855, 92900.53549732208, 93369.0, 94121.5293923526, 95332.52333738425, 97272.0, 81789.59105204436, 82909.58545207235, 83820.0, 87343.56328218318, 87504.0, 69467.3053269471, 71323.64338178276, 71552.56894862177, 71610.64194679097, 72516.0, 7533.8116547086765, 8207.425480216567, 8246.422750407413, 8565.48607083577, 8648.56757162152, 40910.59089409068, 41725.79137104295, 45232.095358091996, 46694.299585506924, 47550.76224618855, 63155.36844631495, 64278.67860660667, 64729.0, 65274.673626631564, 66775.0, 10123.59505619767, 10425.322354046963, 10437.739056523647, 10452.634157804441, 10800.783984320113, 10445.059944605022, 10869.402182880018, 10993.670189894316, 11211.327320360804, 11491.655250342503, 10462.21533384984, 10617.681469555926, 10656.147508199481, 10660.84008739885, 10800.459977001276, 10128.088472037552, 10297.691069267934, 10585.682429527127, 11071.225014248925, 11503.0, 10439.348159888928, 10688.358698478116, 10729.141668666643, 11018.39398833072, 11246.718832029264, 9402.670906518239, 9704.120729532398, 9707.0, 9921.362975109027, 9988.400695958266, 8436.831263374821, 9038.322125840457, 9406.200472959876, 9438.905610943802, 9592.0], "value": 6291.253503550761, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1561.8999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 116.0, 117.0, 116.0, 116.0, 122.0, 116.0, 114.0, 115.0, 114.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 131.0, 126.0, 167.0, 130.0, 125.0, 127.0, 128.0, 157.0, 134.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 175.0, 163.0, 165.0, 164.0, 167.0, 163.0, 163.0, 165.0, 164.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 76.0, 110.0, 78.0, 78.0, 77.0, 77.0, 108.0, 77.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 114.0, 84.0, 84.0, 84.0, 104.0, 85.0, 84.0, 112.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 120.0, 119.0, 117.0, 119.0, 120.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 147.0, 150.0, 150.0, 151.0, 148.0, 150.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 63.0, 64.0, 65.0, 65.0, 66.0, 65.0, 65.0, 68.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 68.0, 68.0, 66.0, 66.0, 67.0, 66.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 83.0, 84.0, 82.0, 83.0, 83.0, 84.0, 83.0, 83.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 145.0, 148.0, 137.0, 154.0, 146.0, 136.0, 137.0, 172.0, 149.0], "value": 146.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 181.0, 172.0, 177.0, 172.0, 175.0, 172.0, 171.0, 169.0, 173.0], "value": 173.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 69.0, 69.0, 71.0, 71.0, 69.0, 73.0, 70.0, 71.0, 71.0], "value": 70.8, "unit": "score"}]}]} 01:25:11 INFO - Return code: 0 01:25:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:25:11 ERROR - # TBPL SUCCESS # 01:25:11 INFO - Running post-action listener: _resource_record_post_action 01:25:11 INFO - [mozharness: 2016-09-21 08:25:11.789829Z] Finished run-tests step (success) 01:25:11 INFO - Running post-run listener: _resource_record_post_run 01:25:11 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401051648; Read time: 12; Write time: 256496 01:25:11 INFO - TinderboxPrint: CPU usage
13.4% 01:25:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 01:25:11 INFO - TinderboxPrint: I/O write bytes / time
401,051,648 / 256,496 01:25:11 INFO - TinderboxPrint: CPU idle
8,285.4 (86.6%) 01:25:11 INFO - TinderboxPrint: CPU user
1,224.2 (12.8%) 01:25:11 INFO - TinderboxPrint: Swap in / out
0 / 0 01:25:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110432256; Read time: 0; Write time: 65904 01:25:11 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 290619392; Read time: 0; Write time: 190592 01:25:12 INFO - Running post-run listener: _upload_blobber_files 01:25:12 INFO - Blob upload gear active. 01:25:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:25:12 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 01:25:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:25:12 INFO - (blobuploader) - INFO - Open directory for files ... 01:25:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:25:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:25:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:25:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:25:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:25:13 INFO - (blobuploader) - INFO - Done attempting. 01:25:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:25:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:25:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:25:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:25:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:25:14 INFO - (blobuploader) - INFO - Done attempting. 01:25:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:25:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:25:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:25:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:25:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:25:24 INFO - (blobuploader) - INFO - Done attempting. 01:25:24 INFO - (blobuploader) - INFO - Iteration through files over. 01:25:24 INFO - Return code: 0 01:25:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:25:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:25:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/52cbf32b143baf174282be57f2ac2ab24d437db7b1a9364dae50e241b776a385ff8eda96d51619fd646e14f2eeeae2d5d1c4df596b33fce6ab2e5406f7c2e258", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/efcc73f10c41b37c17b204f53437afadc0453ac5e7d1d702b24a38fcab16042d452fd9143e6ff85bcbf6c2e853c829d8d031cafdf381acbe10737bdca094a0f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9f76ad46165787d211fd30fd117310e88caca291134a5cb5db4de46678832b9ea8ca340dffa064ee6c9cb92480296027310ba54907896422a6314ac369280a61"} 01:25:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:25:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:25:24 INFO - Contents: 01:25:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/52cbf32b143baf174282be57f2ac2ab24d437db7b1a9364dae50e241b776a385ff8eda96d51619fd646e14f2eeeae2d5d1c4df596b33fce6ab2e5406f7c2e258", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/efcc73f10c41b37c17b204f53437afadc0453ac5e7d1d702b24a38fcab16042d452fd9143e6ff85bcbf6c2e853c829d8d031cafdf381acbe10737bdca094a0f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9f76ad46165787d211fd30fd117310e88caca291134a5cb5db4de46678832b9ea8ca340dffa064ee6c9cb92480296027310ba54907896422a6314ac369280a61"} 01:25:24 INFO - Running post-run listener: copy_logs_to_upload_dir 01:25:24 INFO - Copying logs to upload dir... 01:25:24 INFO - mkdir: /builds/slave/test/build/upload/logs 01:25:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.584308 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-09-21 01:25:23.767373) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 01:25:23.770573) ========= 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=c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755 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-Non-PGO/sha512/52cbf32b143baf174282be57f2ac2ab24d437db7b1a9364dae50e241b776a385ff8eda96d51619fd646e14f2eeeae2d5d1c4df596b33fce6ab2e5406f7c2e258", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/efcc73f10c41b37c17b204f53437afadc0453ac5e7d1d702b24a38fcab16042d452fd9143e6ff85bcbf6c2e853c829d8d031cafdf381acbe10737bdca094a0f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9f76ad46165787d211fd30fd117310e88caca291134a5cb5db4de46678832b9ea8ca340dffa064ee6c9cb92480296027310ba54907896422a6314ac369280a61"} build_url:https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011306 build_url: 'https://queue.taskcluster.net/v1/task/C00lAkfGSlyWtoShu_xlAA/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-Non-PGO/sha512/52cbf32b143baf174282be57f2ac2ab24d437db7b1a9364dae50e241b776a385ff8eda96d51619fd646e14f2eeeae2d5d1c4df596b33fce6ab2e5406f7c2e258", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/efcc73f10c41b37c17b204f53437afadc0453ac5e7d1d702b24a38fcab16042d452fd9143e6ff85bcbf6c2e853c829d8d031cafdf381acbe10737bdca094a0f5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9f76ad46165787d211fd30fd117310e88caca291134a5cb5db4de46678832b9ea8ca340dffa064ee6c9cb92480296027310ba54907896422a6314ac369280a61"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 01:25:23.795841) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 01:25:23.796180) ========= 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=c6927cf182745ad25b1d38b9000001fe-1474443660.780306-868788755 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 01:25:23.878944) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 01:25:23.879283) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 01:25:23.879581) ========= ========= Total master_lag: 0.17 =========