builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1471965194.4 results: success (0) buildid: 20160823053002 builduid: 970d4e80ad184b738290bbe9033a4bc9 revision: 8cc027a0b80d20bfb271e906638e0cf140f3ba01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 08:13:14.401077) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 08:13:14.401472) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 08:13:14.401764) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 08:13:14.452393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:13:14.452672) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-23 08:13:14-- 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% 43.1M=0s 2016-08-23 08:13:14 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083793 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:13:14.549995) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:13:14.550279) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018162 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:13:14.601186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:13:14.601497) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8cc027a0b80d20bfb271e906638e0cf140f3ba01 --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 8cc027a0b80d20bfb271e906638e0cf140f3ba01 --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=9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-23 08:13:14,645 truncating revision to first 12 chars 2016-08-23 08:13:14,645 Setting DEBUG logging. 2016-08-23 08:13:14,645 attempt 1/10 2016-08-23 08:13:14,645 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8cc027a0b80d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 08:13:14,907 unpacking tar archive at: fx-team-8cc027a0b80d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.578480 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:13:15.193877) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 08:13:15.194293) ========= script_repo_revision: 8cc027a0b80d20bfb271e906638e0cf140f3ba01 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 08:13:15.194860) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 08:13:15.195136) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 08:13:15.207374) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-08-23 08:13:15.207660) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:13:15 INFO - MultiFileLogger online at 20160823 08:13:15 in /builds/slave/test 08:13:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:13:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:13:15 INFO - {'append_to_log': False, 08:13:15 INFO - 'base_work_dir': '/builds/slave/test', 08:13:15 INFO - 'blob_upload_branch': 'Fx-Team', 08:13:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:13:15 INFO - 'branch': 'Fx-Team', 08:13:15 INFO - 'buildbot_json_path': 'buildprops.json', 08:13:15 INFO - 'config_files': ('talos/linux_config.py',), 08:13:15 INFO - 'default_actions': ('clobber', 08:13:15 INFO - 'read-buildbot-config', 08:13:15 INFO - 'download-and-extract', 08:13:15 INFO - 'populate-webroot', 08:13:15 INFO - 'create-virtualenv', 08:13:15 INFO - 'install', 08:13:15 INFO - 'run-tests'), 08:13:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:13:15 INFO - 'download_minidump_stackwalk': True, 08:13:15 INFO - 'download_symbols': 'ondemand', 08:13:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:13:15 INFO - 'tooltool.py': '/tools/tooltool.py', 08:13:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:13:15 INFO - '/tools/misc-python/virtualenv.py')}, 08:13:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:13:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:13:15 INFO - 'installer_path': 'installer.exe', 08:13:15 INFO - 'log_level': 'info', 08:13:15 INFO - 'log_name': 'talos', 08:13:15 INFO - 'log_to_console': True, 08:13:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:13:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:13:15 INFO - 'opt_config_files': (), 08:13:15 INFO - 'pip_index': False, 08:13:15 INFO - 'sps_profile': False, 08:13:15 INFO - 'sps_profile_interval': 0, 08:13:15 INFO - 'suite': 'dromaeojs', 08:13:15 INFO - 'system_bits': '32', 08:13:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:13:15 INFO - 'title': 'talos-linux64-ix-022', 08:13:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:13:15 INFO - 'use_talos_json': True, 08:13:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:13:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:13:15 INFO - 'work_dir': 'build'} 08:13:15 INFO - [mozharness: 2016-08-23 15:13:15.348107Z] Running clobber step. 08:13:15 INFO - Running pre-action listener: _resource_record_pre_action 08:13:15 INFO - Running main action method: clobber 08:13:15 INFO - rmtree: /builds/slave/test/build 08:13:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:13:16 INFO - Running post-action listener: _resource_record_post_action 08:13:16 INFO - [mozharness: 2016-08-23 15:13:16.315470Z] Finished clobber step (success) 08:13:16 INFO - [mozharness: 2016-08-23 15:13:16.315569Z] Running read-buildbot-config step. 08:13:16 INFO - Running pre-action listener: _resource_record_pre_action 08:13:16 INFO - Running main action method: read_buildbot_config 08:13:16 INFO - Using buildbot properties: 08:13:16 INFO - { 08:13:16 INFO - "project": "", 08:13:16 INFO - "product": "firefox", 08:13:16 INFO - "script_repo_revision": "production", 08:13:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:13:16 INFO - "repository": "", 08:13:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:13:16 INFO - "buildid": "20160823053002", 08:13:16 INFO - "pgo_build": "True", 08:13:16 INFO - "basedir": "/builds/slave/test", 08:13:16 INFO - "buildnumber": 1488, 08:13:16 INFO - "slavename": "talos-linux64-ix-022", 08:13:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:13:16 INFO - "platform": "ubuntu64_hw", 08:13:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:13:16 INFO - "branch": "fx-team", 08:13:16 INFO - "repo_path": "integration/fx-team", 08:13:16 INFO - "revision": "8cc027a0b80d20bfb271e906638e0cf140f3ba01", 08:13:16 INFO - "stage_platform": "linux64-pgo", 08:13:16 INFO - "builduid": "970d4e80ad184b738290bbe9033a4bc9", 08:13:16 INFO - "slavebuilddir": "test" 08:13:16 INFO - } 08:13:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:13:16 INFO - Running post-action listener: _resource_record_post_action 08:13:16 INFO - [mozharness: 2016-08-23 15:13:16.318012Z] Finished read-buildbot-config step (success) 08:13:16 INFO - [mozharness: 2016-08-23 15:13:16.318101Z] Running download-and-extract step. 08:13:16 INFO - Running pre-action listener: _resource_record_pre_action 08:13:16 INFO - Running main action method: download_and_extract 08:13:16 INFO - mkdir: /builds/slave/test/build/tests 08:13:16 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')]} 08:13:16 INFO - trying https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:13:16 INFO - Downloading https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:13:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:13:16 INFO - Downloaded 1361 bytes. 08:13:16 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:13:16 INFO - Using the following test package requirements: 08:13:16 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:13:16 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:13:16 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:13:16 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:16 INFO - u'jsshell-linux-x86_64.zip'], 08:13:16 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:13:16 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:13:16 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:13:16 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:13:16 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:13:16 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:13:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:13:16 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:13:16 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')]} 08:13:16 INFO - trying https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:13:16 INFO - Downloading https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:13:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:13:17 INFO - Downloaded 21919722 bytes. 08:13:17 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:13:22 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:13:22 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')]} 08:13:22 INFO - trying https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:13:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:13:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:13:22 INFO - Downloaded 21919722 bytes. 08:13:22 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:13: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')]} 08:13:27 INFO - trying https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:13:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:13:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:13:28 INFO - Downloaded 14413981 bytes. 08:13:28 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 08:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:28 INFO - trying https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:13:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:13:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:13:29 INFO - Downloaded 59785248 bytes. 08:13:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:13:29 INFO - mkdir: /builds/slave/test/properties 08:13:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:13:29 INFO - Writing to file /builds/slave/test/properties/build_url 08:13:29 INFO - Contents: 08:13:29 INFO - build_url:https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:13:30 INFO - Running post-action listener: _resource_record_post_action 08:13:30 INFO - Running post-action listener: set_extra_try_arguments 08:13:30 INFO - [mozharness: 2016-08-23 15:13:30.438645Z] Finished download-and-extract step (success) 08:13:30 INFO - [mozharness: 2016-08-23 15:13:30.438873Z] Running populate-webroot step. 08:13:30 INFO - Running pre-action listener: _resource_record_pre_action 08:13:30 INFO - Running main action method: populate_webroot 08:13:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:13:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:13:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:13:30 INFO - '--tppagecycles', 08:13:30 INFO - '7'], 08:13:30 INFO - 'tests': ['tsvgm']}}, 08:13:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:13:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:13:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:13:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:13:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:13:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:13:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:30 INFO - 'talos_options': ['--disable-e10s'], 08:13:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:13:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:13:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:30 INFO - 'talos_options': ['--disable-e10s'], 08:13:30 INFO - 'tests': ['damp', 'tps']}, 08:13:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:30 INFO - 'tests': ['damp', 'tps']}, 08:13:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:13:30 INFO - 'tests': ['dromaeo_dom']}, 08:13:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:13:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:13:30 INFO - 'tests': ['basic_compositor_video']}, 08:13:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:13:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:13:30 INFO - 'tests': ['a11yr', 08:13:30 INFO - 'ts_paint', 08:13:30 INFO - 'tpaint', 08:13:30 INFO - 'sessionrestore', 08:13:30 INFO - 'sessionrestore_no_auto_restore', 08:13:30 INFO - 'tabpaint']}, 08:13:30 INFO - 'other-e10s': {'tests': ['a11yr', 08:13:30 INFO - 'ts_paint', 08:13:30 INFO - 'tpaint', 08:13:30 INFO - 'sessionrestore', 08:13:30 INFO - 'sessionrestore_no_auto_restore', 08:13:30 INFO - 'tabpaint']}, 08:13:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:13:30 INFO - 'ts_paint', 08:13:30 INFO - 'tpaint', 08:13:30 INFO - 'sessionrestore', 08:13:30 INFO - 'sessionrestore_no_auto_restore', 08:13:30 INFO - 'tabpaint']}, 08:13:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:13:30 INFO - 'ts_paint', 08:13:30 INFO - 'tpaint', 08:13:30 INFO - 'sessionrestore', 08:13:30 INFO - 'sessionrestore_no_auto_restore', 08:13:30 INFO - 'tabpaint']}, 08:13:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:13:30 INFO - 'tests': ['a11yr', 08:13:30 INFO - 'ts_paint', 08:13:30 INFO - 'tpaint', 08:13:30 INFO - 'sessionrestore', 08:13:30 INFO - 'sessionrestore_no_auto_restore', 08:13:30 INFO - 'tabpaint']}, 08:13:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:13:30 INFO - 'tests': ['a11yr', 08:13:30 INFO - 'ts_paint', 08:13:30 INFO - 'tpaint', 08:13:30 INFO - 'sessionrestore', 08:13:30 INFO - 'sessionrestore_no_auto_restore', 08:13:30 INFO - 'tabpaint']}, 08:13:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:13:30 INFO - 'tests': ['tsvgx', 08:13:30 INFO - 'tsvgr_opacity', 08:13:30 INFO - 'tart', 08:13:30 INFO - 'tscrollx', 08:13:30 INFO - 'cart']}, 08:13:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:13:30 INFO - 'tsvgr_opacity', 08:13:30 INFO - 'tart', 08:13:30 INFO - 'tscrollx', 08:13:30 INFO - 'cart']}, 08:13:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:30 INFO - 'talos_options': ['--disable-e10s'], 08:13:30 INFO - 'tests': ['tp5o']}, 08:13:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:30 INFO - 'tests': ['tp5o']}, 08:13:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:30 INFO - 'talos_options': ['--disable-e10s', 08:13:30 INFO - '--xperf_path', 08:13:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:13:30 INFO - 'tests': ['tp5n']}, 08:13:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:13:30 INFO - 'talos_options': ['--xperf_path', 08:13:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:13:30 INFO - 'tests': ['tp5n']}}, 08:13:30 INFO - 'talos.zip': {'path': '', 08:13:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:13:30 INFO - Running post-action listener: _resource_record_post_action 08:13:30 INFO - [mozharness: 2016-08-23 15:13:30.461506Z] Finished populate-webroot step (success) 08:13:30 INFO - [mozharness: 2016-08-23 15:13:30.461596Z] Running create-virtualenv step. 08:13:30 INFO - Running pre-action listener: _resource_record_pre_action 08:13:30 INFO - Running main action method: create_virtualenv 08:13:30 INFO - Creating virtualenv /builds/slave/test/build/venv 08:13:30 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 08:13:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:13:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:13:30 INFO - Using real prefix '/usr' 08:13:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:13:31 INFO - Installing distribute.............................................................................................................................................................................................done. 08:13:33 INFO - Installing pip.................done. 08:13:33 INFO - Return code: 0 08:13:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f034cf30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b9370>, '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 0x20bc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcd80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', '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 08:13:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:13:33 INFO - Using env: {'DISPLAY': ':0', 08:13:33 INFO - 'HOME': '/home/cltbld', 08:13:33 INFO - 'LANG': 'en_US.UTF-8', 08:13:33 INFO - 'LANGUAGE': 'en_US:en', 08:13:33 INFO - 'LOGNAME': 'cltbld', 08:13:33 INFO - 'MAIL': '/var/mail/cltbld', 08:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:33 INFO - 'MOZ_NO_REMOTE': '1', 08:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:33 INFO - 'NO_EM_RESTART': '1', 08:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:33 INFO - 'PWD': '/builds/slave/test', 08:13:33 INFO - 'SHELL': '/bin/bash', 08:13:33 INFO - 'SHLVL': '1', 08:13:33 INFO - 'TERM': 'linux', 08:13:33 INFO - 'TMOUT': '86400', 08:13:33 INFO - 'USER': 'cltbld', 08:13:33 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', 08:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:33 INFO - '_': '/tools/buildbot/bin/python'} 08:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:33 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 08:13:33 INFO - Cleaning up... 08:13:33 INFO - Return code: 0 08:13:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f034cf30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b9370>, '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 0x20bc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcd80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', '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 08:13:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:13:33 INFO - Using env: {'DISPLAY': ':0', 08:13:33 INFO - 'HOME': '/home/cltbld', 08:13:33 INFO - 'LANG': 'en_US.UTF-8', 08:13:33 INFO - 'LANGUAGE': 'en_US:en', 08:13:33 INFO - 'LOGNAME': 'cltbld', 08:13:33 INFO - 'MAIL': '/var/mail/cltbld', 08:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:33 INFO - 'MOZ_NO_REMOTE': '1', 08:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:33 INFO - 'NO_EM_RESTART': '1', 08:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:33 INFO - 'PWD': '/builds/slave/test', 08:13:33 INFO - 'SHELL': '/bin/bash', 08:13:33 INFO - 'SHLVL': '1', 08:13:33 INFO - 'TERM': 'linux', 08:13:33 INFO - 'TMOUT': '86400', 08:13:33 INFO - 'USER': 'cltbld', 08:13:33 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', 08:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:33 INFO - '_': '/tools/buildbot/bin/python'} 08:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:33 INFO - Downloading/unpacking psutil>=3.1.1 08:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:13:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:13:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:13:35 INFO - Installing collected packages: psutil 08:13:35 INFO - Running setup.py install for psutil 08:13:35 INFO - building 'psutil._psutil_linux' extension 08:13:35 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 08:13:35 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 08:13:35 INFO - building 'psutil._psutil_posix' extension 08:13:35 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 08:13:35 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 08:13:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:13:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:13:35 INFO - Successfully installed psutil 08:13:35 INFO - Cleaning up... 08:13:35 INFO - Return code: 0 08:13:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:13:35 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')]} 08:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:35 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')]} 08:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:35 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 0x7f034cf30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b9370>, '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 0x20bc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcd80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', '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 08:13:35 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 08:13:35 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 08:13:36 INFO - Using env: {'DISPLAY': ':0', 08:13:36 INFO - 'HOME': '/home/cltbld', 08:13:36 INFO - 'LANG': 'en_US.UTF-8', 08:13:36 INFO - 'LANGUAGE': 'en_US:en', 08:13:36 INFO - 'LOGNAME': 'cltbld', 08:13:36 INFO - 'MAIL': '/var/mail/cltbld', 08:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:36 INFO - 'MOZ_NO_REMOTE': '1', 08:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:36 INFO - 'NO_EM_RESTART': '1', 08:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:36 INFO - 'PWD': '/builds/slave/test', 08:13:36 INFO - 'SHELL': '/bin/bash', 08:13:36 INFO - 'SHLVL': '1', 08:13:36 INFO - 'TERM': 'linux', 08:13:36 INFO - 'TMOUT': '86400', 08:13:36 INFO - 'USER': 'cltbld', 08:13:36 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', 08:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:36 INFO - '_': '/tools/buildbot/bin/python'} 08:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:13:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:13:38 INFO - Installing collected packages: mozsystemmonitor 08:13:38 INFO - Running setup.py install for mozsystemmonitor 08:13:38 INFO - Successfully installed mozsystemmonitor 08:13:38 INFO - Cleaning up... 08:13:38 INFO - Return code: 0 08:13:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:13:38 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')]} 08:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:38 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')]} 08:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:38 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 0x7f034cf30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b9370>, '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 0x20bc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcd80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', '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 08:13:38 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 08:13:38 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 08:13:38 INFO - Using env: {'DISPLAY': ':0', 08:13:38 INFO - 'HOME': '/home/cltbld', 08:13:38 INFO - 'LANG': 'en_US.UTF-8', 08:13:38 INFO - 'LANGUAGE': 'en_US:en', 08:13:38 INFO - 'LOGNAME': 'cltbld', 08:13:38 INFO - 'MAIL': '/var/mail/cltbld', 08:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:38 INFO - 'MOZ_NO_REMOTE': '1', 08:13:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:38 INFO - 'NO_EM_RESTART': '1', 08:13:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:38 INFO - 'PWD': '/builds/slave/test', 08:13:38 INFO - 'SHELL': '/bin/bash', 08:13:38 INFO - 'SHLVL': '1', 08:13:38 INFO - 'TERM': 'linux', 08:13:38 INFO - 'TMOUT': '86400', 08:13:38 INFO - 'USER': 'cltbld', 08:13:38 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', 08:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:38 INFO - '_': '/tools/buildbot/bin/python'} 08:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:38 INFO - Downloading/unpacking jsonschema==2.5.1 08:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:13:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:40 INFO - Downloading functools32-3.2.3-2.tar.gz 08:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:13:40 INFO - warning: no files found matching '*.txt' 08:13:40 INFO - no previously-included directories found matching 'build' 08:13:40 INFO - no previously-included directories found matching 'dist' 08:13:40 INFO - no previously-included directories found matching '.git*' 08:13:40 INFO - Installing collected packages: jsonschema, functools32 08:13:40 INFO - Running setup.py install for functools32 08:13:40 INFO - warning: no files found matching '*.txt' 08:13:40 INFO - no previously-included directories found matching 'build' 08:13:40 INFO - no previously-included directories found matching 'dist' 08:13:40 INFO - no previously-included directories found matching '.git*' 08:13:40 INFO - Successfully installed jsonschema functools32 08:13:40 INFO - Cleaning up... 08:13:40 INFO - Return code: 0 08:13:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:13:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f034cf30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b9370>, '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 0x20bc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcd80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', '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 08:13:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:13:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:13:40 INFO - Using env: {'DISPLAY': ':0', 08:13:40 INFO - 'HOME': '/home/cltbld', 08:13:40 INFO - 'LANG': 'en_US.UTF-8', 08:13:40 INFO - 'LANGUAGE': 'en_US:en', 08:13:40 INFO - 'LOGNAME': 'cltbld', 08:13:40 INFO - 'MAIL': '/var/mail/cltbld', 08:13:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:40 INFO - 'MOZ_NO_REMOTE': '1', 08:13:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:40 INFO - 'NO_EM_RESTART': '1', 08:13:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:40 INFO - 'PWD': '/builds/slave/test', 08:13:40 INFO - 'SHELL': '/bin/bash', 08:13:40 INFO - 'SHLVL': '1', 08:13:40 INFO - 'TERM': 'linux', 08:13:40 INFO - 'TMOUT': '86400', 08:13:40 INFO - 'USER': 'cltbld', 08:13:40 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', 08:13:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:40 INFO - '_': '/tools/buildbot/bin/python'} 08:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:13:41 INFO - Cleaning up... 08:13:41 INFO - Return code: 0 08:13:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:13:41 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')]} 08:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:41 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')]} 08:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:41 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 0x7f034cf30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b9370>, '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 0x20bc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcd80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', '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 08:13:41 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 08:13:41 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 08:13:41 INFO - Using env: {'DISPLAY': ':0', 08:13:41 INFO - 'HOME': '/home/cltbld', 08:13:41 INFO - 'LANG': 'en_US.UTF-8', 08:13:41 INFO - 'LANGUAGE': 'en_US:en', 08:13:41 INFO - 'LOGNAME': 'cltbld', 08:13:41 INFO - 'MAIL': '/var/mail/cltbld', 08:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:41 INFO - 'MOZ_NO_REMOTE': '1', 08:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:41 INFO - 'NO_EM_RESTART': '1', 08:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:41 INFO - 'PWD': '/builds/slave/test', 08:13:41 INFO - 'SHELL': '/bin/bash', 08:13:41 INFO - 'SHLVL': '1', 08:13:41 INFO - 'TERM': 'linux', 08:13:41 INFO - 'TMOUT': '86400', 08:13:41 INFO - 'USER': 'cltbld', 08:13:41 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', 08:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:41 INFO - '_': '/tools/buildbot/bin/python'} 08:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:41 INFO - Downloading/unpacking blobuploader==1.2.4 08:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:43 INFO - Downloading blobuploader-1.2.4.tar.gz 08:13:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:13:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:13:43 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 08:13:43 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 08:13:43 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 08:13:43 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 08:13:43 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 08:13:43 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 08:13:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:13:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:13:43 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 08:13:43 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 08:13:43 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 08:13:43 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 08:13:43 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 08:13:43 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 08:13:43 INFO - Downloading docopt-0.6.1.tar.gz 08:13:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:13:43 INFO - Installing collected packages: blobuploader, requests, docopt 08:13:43 INFO - Running setup.py install for blobuploader 08:13:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:13:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:13:44 INFO - Running setup.py install for requests 08:13:44 INFO - Running setup.py install for docopt 08:13:44 INFO - Successfully installed blobuploader requests docopt 08:13:44 INFO - Cleaning up... 08:13:44 INFO - Return code: 0 08:13:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:44 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 0x7f034cf30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b9370>, '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 0x20bc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcd80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', '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 08:13:44 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 08:13:44 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 08:13:44 INFO - Using env: {'DISPLAY': ':0', 08:13:44 INFO - 'HOME': '/home/cltbld', 08:13:44 INFO - 'LANG': 'en_US.UTF-8', 08:13:44 INFO - 'LANGUAGE': 'en_US:en', 08:13:44 INFO - 'LOGNAME': 'cltbld', 08:13:44 INFO - 'MAIL': '/var/mail/cltbld', 08:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:44 INFO - 'MOZ_NO_REMOTE': '1', 08:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:44 INFO - 'NO_EM_RESTART': '1', 08:13:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:44 INFO - 'PWD': '/builds/slave/test', 08:13:44 INFO - 'SHELL': '/bin/bash', 08:13:44 INFO - 'SHLVL': '1', 08:13:44 INFO - 'TERM': 'linux', 08:13:44 INFO - 'TMOUT': '86400', 08:13:44 INFO - 'USER': 'cltbld', 08:13:44 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', 08:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:44 INFO - '_': '/tools/buildbot/bin/python'} 08:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:13:44 INFO - Running setup.py (path:/tmp/pip-_V6Ffr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:13:44 INFO - Running setup.py (path:/tmp/pip-5FIO_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:13:44 INFO - Running setup.py (path:/tmp/pip-SKxaTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:13:44 INFO - Running setup.py (path:/tmp/pip-VfborU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:13:45 INFO - Running setup.py (path:/tmp/pip-0kGxq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:13:45 INFO - Running setup.py (path:/tmp/pip-W1tjWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:13:45 INFO - Running setup.py (path:/tmp/pip-SL31zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:13:45 INFO - Running setup.py (path:/tmp/pip-YGRXd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:13:45 INFO - Running setup.py (path:/tmp/pip-X_ClDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:13:45 INFO - Running setup.py (path:/tmp/pip-rUyzYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:13:45 INFO - Running setup.py (path:/tmp/pip-v8SiUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:13:45 INFO - Running setup.py (path:/tmp/pip-wdikjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:13:45 INFO - Running setup.py (path:/tmp/pip-P_KCZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:13:45 INFO - Running setup.py (path:/tmp/pip-tBM9J2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:45 INFO - Running setup.py (path:/tmp/pip-9U7BN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:13:45 INFO - Running setup.py (path:/tmp/pip-W6l0mX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:13:45 INFO - Running setup.py (path:/tmp/pip-QnXO5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:13:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:13:45 INFO - Running setup.py install for manifestparser 08:13:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:13:46 INFO - Running setup.py install for mozcrash 08:13:46 INFO - Running setup.py install for mozdebug 08:13:46 INFO - Running setup.py install for mozdevice 08:13:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:13:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:13:46 INFO - Running setup.py install for mozfile 08:13:46 INFO - Running setup.py install for mozhttpd 08:13:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:13:46 INFO - Running setup.py install for mozinfo 08:13:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:13:46 INFO - Running setup.py install for mozInstall 08:13:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:13:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:13:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:13:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:13:46 INFO - Running setup.py install for mozleak 08:13:46 INFO - Running setup.py install for mozlog 08:13:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:13:46 INFO - Running setup.py install for moznetwork 08:13:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:13:47 INFO - Running setup.py install for mozprocess 08:13:47 INFO - Running setup.py install for mozprofile 08:13:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:13:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:13:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:13:47 INFO - Running setup.py install for mozrunner 08:13:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:13:47 INFO - Running setup.py install for mozscreenshot 08:13:47 INFO - Running setup.py install for moztest 08:13:47 INFO - Running setup.py install for mozversion 08:13:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:13:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:13:47 INFO - Cleaning up... 08:13:47 INFO - Return code: 0 08:13:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13: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')]} 08:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13: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')]} 08:13:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:47 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 0x7f034cf30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b9370>, '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 0x20bc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcd80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', '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 08:13:47 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 08:13:47 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 08:13:47 INFO - Using env: {'DISPLAY': ':0', 08:13:47 INFO - 'HOME': '/home/cltbld', 08:13:47 INFO - 'LANG': 'en_US.UTF-8', 08:13:47 INFO - 'LANGUAGE': 'en_US:en', 08:13:47 INFO - 'LOGNAME': 'cltbld', 08:13:47 INFO - 'MAIL': '/var/mail/cltbld', 08:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:47 INFO - 'MOZ_NO_REMOTE': '1', 08:13:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:47 INFO - 'NO_EM_RESTART': '1', 08:13:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:47 INFO - 'PWD': '/builds/slave/test', 08:13:47 INFO - 'SHELL': '/bin/bash', 08:13:47 INFO - 'SHLVL': '1', 08:13:47 INFO - 'TERM': 'linux', 08:13:47 INFO - 'TMOUT': '86400', 08:13:47 INFO - 'USER': 'cltbld', 08:13:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', 08:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:47 INFO - '_': '/tools/buildbot/bin/python'} 08:13:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:13:47 INFO - Running setup.py (path:/tmp/pip-HJm7JY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:13:48 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)) 08:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:13:48 INFO - Running setup.py (path:/tmp/pip-ysaKW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:13:48 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)) 08:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:13:48 INFO - Running setup.py (path:/tmp/pip-oscbdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:13:48 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)) 08:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:13:48 INFO - Running setup.py (path:/tmp/pip-QWakm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:13:48 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)) 08:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:13:48 INFO - Running setup.py (path:/tmp/pip-XTSXQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:13:48 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)) 08:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:13:48 INFO - Running setup.py (path:/tmp/pip-A7RXgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:13:48 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)) 08:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:13:48 INFO - Running setup.py (path:/tmp/pip-YX0fxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:13:48 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)) 08:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:13:48 INFO - Running setup.py (path:/tmp/pip-WL1U8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:13:48 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)) 08:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:13:48 INFO - Running setup.py (path:/tmp/pip-YDtsuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:13:48 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)) 08:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:13:48 INFO - Running setup.py (path:/tmp/pip-fsikp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:13:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 08:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:13:48 INFO - Running setup.py (path:/tmp/pip-gMDyjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:13:48 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)) 08:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:13:48 INFO - Running setup.py (path:/tmp/pip-59cS4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:13:48 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)) 08:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:13:48 INFO - Running setup.py (path:/tmp/pip-mT63OI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:13:48 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)) 08:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:13:48 INFO - Running setup.py (path:/tmp/pip-yub3EZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:13:48 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)) 08:13:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:48 INFO - Running setup.py (path:/tmp/pip-ZJqbAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:49 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)) 08:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:13:49 INFO - Running setup.py (path:/tmp/pip-RMatTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:13:49 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)) 08:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:13:49 INFO - Running setup.py (path:/tmp/pip-_bGzkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:13:49 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)) 08:13:49 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)) 08:13:49 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)) 08:13:49 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)) 08:13:49 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)) 08:13:49 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)) 08:13:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:13:49 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 08:13:49 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 08:13:49 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 08:13:49 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 08:13:49 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 08:13:49 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 08:13:51 INFO - Downloading blessings-1.6.tar.gz 08:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:13:51 INFO - Installing collected packages: blessings 08:13:51 INFO - Running setup.py install for blessings 08:13:51 INFO - Successfully installed blessings 08:13:51 INFO - Cleaning up... 08:13:51 INFO - Return code: 0 08:13:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:13:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:13:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:13:51 INFO - Reading from file tmpfile_stdout 08:13:51 INFO - Current package versions: 08:13:51 INFO - argparse == 1.2.1 08:13:51 INFO - blessings == 1.6 08:13:51 INFO - blobuploader == 1.2.4 08:13:51 INFO - docopt == 0.6.1 08:13:51 INFO - functools32 == 3.2.3-2 08:13:51 INFO - jsonschema == 2.5.1 08:13:51 INFO - manifestparser == 1.1 08:13:51 INFO - mozInstall == 1.12 08:13:51 INFO - mozcrash == 0.17 08:13:51 INFO - mozdebug == 0.1 08:13:51 INFO - mozdevice == 0.48 08:13:51 INFO - mozfile == 1.2 08:13:51 INFO - mozhttpd == 0.7 08:13:51 INFO - mozinfo == 0.9 08:13:51 INFO - mozleak == 0.1 08:13:51 INFO - mozlog == 3.3 08:13:51 INFO - moznetwork == 0.27 08:13:51 INFO - mozprocess == 0.23 08:13:51 INFO - mozprofile == 0.28 08:13:51 INFO - mozrunner == 6.12 08:13:51 INFO - mozscreenshot == 0.1 08:13:51 INFO - mozsystemmonitor == 0.3 08:13:51 INFO - moztest == 0.7 08:13:51 INFO - mozversion == 1.4 08:13:51 INFO - psutil == 3.1.1 08:13:51 INFO - requests == 1.2.3 08:13:51 INFO - wsgiref == 0.1.2 08:13:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:51 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')]} 08:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:51 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')]} 08:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:51 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 0x7f034cf30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b9370>, '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 0x20bc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcd80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', '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 08:13:51 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 08:13:51 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 08:13:51 INFO - Using env: {'DISPLAY': ':0', 08:13:51 INFO - 'HOME': '/home/cltbld', 08:13:51 INFO - 'LANG': 'en_US.UTF-8', 08:13:51 INFO - 'LANGUAGE': 'en_US:en', 08:13:51 INFO - 'LOGNAME': 'cltbld', 08:13:51 INFO - 'MAIL': '/var/mail/cltbld', 08:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:51 INFO - 'MOZ_NO_REMOTE': '1', 08:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:51 INFO - 'NO_EM_RESTART': '1', 08:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:51 INFO - 'PWD': '/builds/slave/test', 08:13:51 INFO - 'SHELL': '/bin/bash', 08:13:51 INFO - 'SHLVL': '1', 08:13:51 INFO - 'TERM': 'linux', 08:13:51 INFO - 'TMOUT': '86400', 08:13:51 INFO - 'USER': 'cltbld', 08:13:51 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', 08:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:51 INFO - '_': '/tools/buildbot/bin/python'} 08:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:51 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)) 08:13:51 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)) 08:13:51 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)) 08:13:51 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)) 08:13:51 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)) 08:13:51 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)) 08:13:51 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)) 08:13:51 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)) 08:13:51 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)) 08:13:51 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)) 08:13:51 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)) 08:13:51 INFO - Cleaning up... 08:13:51 INFO - Return code: 0 08:13:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:13:51 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')]} 08:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:51 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')]} 08:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:51 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 0x7f034cf30f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ff18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b9370>, '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 0x20bc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcd80>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', '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 08:13:51 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 08:13:51 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 08:13:51 INFO - Using env: {'DISPLAY': ':0', 08:13:51 INFO - 'HOME': '/home/cltbld', 08:13:51 INFO - 'LANG': 'en_US.UTF-8', 08:13:51 INFO - 'LANGUAGE': 'en_US:en', 08:13:51 INFO - 'LOGNAME': 'cltbld', 08:13:51 INFO - 'MAIL': '/var/mail/cltbld', 08:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:51 INFO - 'MOZ_NO_REMOTE': '1', 08:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:51 INFO - 'NO_EM_RESTART': '1', 08:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:51 INFO - 'PWD': '/builds/slave/test', 08:13:51 INFO - 'SHELL': '/bin/bash', 08:13:51 INFO - 'SHLVL': '1', 08:13:51 INFO - 'TERM': 'linux', 08:13:51 INFO - 'TMOUT': '86400', 08:13:51 INFO - 'USER': 'cltbld', 08:13:51 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', 08:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:51 INFO - '_': '/tools/buildbot/bin/python'} 08:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:13:51 INFO - Cleaning up... 08:13:51 INFO - Return code: 0 08:13:51 INFO - Running post-action listener: _resource_record_post_action 08:13:51 INFO - Running post-action listener: _start_resource_monitoring 08:13:52 INFO - Starting resource monitoring. 08:13:52 INFO - [mozharness: 2016-08-23 15:13:52.008764Z] Finished create-virtualenv step (success) 08:13:52 INFO - [mozharness: 2016-08-23 15:13:52.009264Z] Running install step. 08:13:52 INFO - Running pre-action listener: _resource_record_pre_action 08:13:52 INFO - Running main action method: install 08:13:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:13:52 INFO - Reading from file tmpfile_stdout 08:13:52 INFO - Detecting whether we're running mozinstall >=1.0... 08:13:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:13:52 INFO - Reading from file tmpfile_stdout 08:13:52 INFO - Output received: 08:13:52 INFO - Usage: mozinstall [options] installer 08:13:52 INFO - Options: 08:13:52 INFO - -h, --help show this help message and exit 08:13:52 INFO - -d DEST, --destination=DEST 08:13:52 INFO - Directory to install application into. [default: 08:13:52 INFO - "/builds/slave/test"] 08:13:52 INFO - --app=APP Application being installed. [default: firefox] 08:13:52 INFO - mkdir: /builds/slave/test/build/application 08:13:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:14:09 INFO - Reading from file tmpfile_stdout 08:14:09 INFO - Output received: 08:14:09 INFO - /builds/slave/test/build/application/firefox/firefox 08:14:09 INFO - Running post-action listener: _resource_record_post_action 08:14:09 INFO - [mozharness: 2016-08-23 15:14:09.303827Z] Finished install step (success) 08:14:09 INFO - [mozharness: 2016-08-23 15:14:09.304075Z] Running run-tests step. 08:14:09 INFO - Running pre-action listener: _resource_record_pre_action 08:14:09 INFO - Running main action method: run_tests 08:14:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:14:09 INFO - Python 2.7.3 08:14:09 INFO - Return code: 0 08:14:09 INFO - grabbing minidump binary from tooltool 08:14:09 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')]} 08:14:09 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 0x20b9370>, '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 0x20bc8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bcd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:14:09 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 08:14:09 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 08:14:09 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 08:14:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:14:09 INFO - Return code: 0 08:14:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:14:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:14:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:14:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:14:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:14:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:14:09 INFO - Using env: {'DISPLAY': ':0', 08:14:09 INFO - 'HOME': '/home/cltbld', 08:14:09 INFO - 'LANG': 'en_US.UTF-8', 08:14:09 INFO - 'LANGUAGE': 'en_US:en', 08:14:09 INFO - 'LOGNAME': 'cltbld', 08:14:09 INFO - 'MAIL': '/var/mail/cltbld', 08:14:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:14:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:09 INFO - 'MOZ_NO_REMOTE': '1', 08:14:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:09 INFO - 'NO_EM_RESTART': '1', 08:14:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:09 INFO - 'PWD': '/builds/slave/test', 08:14:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:14:09 INFO - 'SHELL': '/bin/bash', 08:14:09 INFO - 'SHLVL': '1', 08:14:09 INFO - 'TERM': 'linux', 08:14:09 INFO - 'TMOUT': '86400', 08:14:09 INFO - 'USER': 'cltbld', 08:14:09 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431', 08:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:09 INFO - '_': '/tools/buildbot/bin/python'} 08:14:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:14:09 INFO - mozversion application_buildid: 20160823053002 08:14:09 INFO - mozversion application_changeset: 8cc027a0b80d20bfb271e906638e0cf140f3ba01 08:14:09 INFO - mozversion application_display_name: Nightly 08:14:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:14:09 INFO - mozversion application_name: Firefox 08:14:09 INFO - mozversion application_remotingname: firefox 08:14:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:14:09 INFO - mozversion application_vendor: Mozilla 08:14:09 INFO - mozversion application_version: 51.0a1 08:14:09 INFO - mozversion platform_buildid: 20160823053002 08:14:09 INFO - mozversion platform_changeset: 8cc027a0b80d20bfb271e906638e0cf140f3ba01 08:14:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:14:09 INFO - mozversion platform_version: 51.0a1 08:14:09 INFO - using testdate: 1471965249 08:14:09 INFO - actual date: 1471965249 08:14:09 INFO - starting webserver on 'localhost:57903' 08:14:09 INFO - SUITE-START | Running 2 tests 08:14:09 INFO - TEST-START | dromaeo_css 08:14:09 INFO - operating with platform_type : linux_ 08:14:09 INFO - Initialising browser for dromaeo_css test... 08:14:09 INFO - TEST-INFO | started process 14298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN6Xh_V/profile http://localhost:57903/getInfo.html) 08:14:14 INFO - PROCESS | 14298 | __metrics Screen width/height:1600/1200 08:14:14 INFO - PROCESS | 14298 | colorDepth:24 08:14:14 INFO - PROCESS | 14298 | Browser inner width/height: 1024/697 08:14:14 INFO - PROCESS | 14298 | __metrics 08:14:14 INFO - PROCESS | 14298 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:14:14 INFO - PROCESS | 14298 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:14:15 INFO - PROCESS | 14298 | console.error: PushService: 08:14:15 INFO - PROCESS | 14298 | stateChangeProcessEnqueue: Error transitioning state 08:14:15 INFO - PROCESS | 14298 | UnknownError 08:14:15 INFO - TEST-INFO | 14298: exit 0 08:14:15 INFO - Browser initialized. 08:14:15 INFO - Running cycle 1/1 for dromaeo_css test... 08:14:15 INFO - TEST-INFO | started process 14380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN6Xh_V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:27 INFO - PROCESS | 14380 | RSS: Main: 179159040 08:14:27 INFO - PROCESS | 14380 | 08:15:19 INFO - PROCESS | 14380 | 1471965319348 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] 08:17:28 INFO - PROCESS | 14380 | Cycle 1(1): loaded http://localhost:57903/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57903/tests/dromaeo/cssquery-ext.html) 08:17:29 INFO - PROCESS | 14380 | RSS: Main: 275660800 08:17:29 INFO - PROCESS | 14380 | 08:20:32 INFO - PROCESS | 14380 | Cycle 1(1): loaded http://localhost:57903/tests/dromaeo/cssquery-ext.html (next: http://localhost:57903/tests/dromaeo/cssquery-jquery.html) 08:20:33 INFO - PROCESS | 14380 | RSS: Main: 271114240 08:20:33 INFO - PROCESS | 14380 | 08:23:35 INFO - PROCESS | 14380 | Cycle 1(1): loaded http://localhost:57903/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57903/tests/dromaeo/cssquery-mootools.html) 08:23:36 INFO - PROCESS | 14380 | RSS: Main: 215351296 08:23:36 INFO - PROCESS | 14380 | 08:26:38 INFO - PROCESS | 14380 | Cycle 1(1): loaded http://localhost:57903/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57903/tests/dromaeo/cssquery-prototype.html) 08:26:38 INFO - PROCESS | 14380 | RSS: Main: 249819136 08:26:38 INFO - PROCESS | 14380 | 08:29:41 INFO - PROCESS | 14380 | Cycle 1(1): loaded http://localhost:57903/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57903/tests/dromaeo/cssquery-yui.html) 08:29:42 INFO - PROCESS | 14380 | RSS: Main: 216547328 08:29:42 INFO - PROCESS | 14380 | 08:32:45 INFO - PROCESS | 14380 | Cycle 1(1): loaded http://localhost:57903/tests/dromaeo/cssquery-yui.html (next: http://localhost:57903/tests/dromaeo/cssquery-dojo.html) 08:32:45 INFO - PROCESS | 14380 | RSS: Main: 308019200 08:32:45 INFO - PROCESS | 14380 | 08:32:45 INFO - PROCESS | 14380 | __start_tp_report 08:32:45 INFO - PROCESS | 14380 | _x_x_mozilla_page_load 08:32:45 INFO - PROCESS | 14380 | _x_x_mozilla_page_load_details 08:32:45 INFO - PROCESS | 14380 | |i|pagename|runs| 08:32:45 INFO - PROCESS | 14380 | |0;dojo.html;2999.3401451680634;3014.9095527134195;3027.7123673251035;3033.9848300758495;3058.7552995760343;5119.872003199913;5268.31511903453;5298.23175639532;5330.706811125387;5346.331708536433;5355.3305836770405;5397.163439666848;5416.835380393215;5418.214358917964;5496.367917689457;4893.363862697862;4897.1674815281485;5001.074801161797;5045.571126454256;5061.974690126544;5016.548510634042;5082.161443361841;5087.66930149541;5090.720010399445;5092.872678183038;4756.952430475685;4822;4824.407945378017;4886.242632391985;4886.804527818883;4835.540623640749;4870.269459581055;4881.975590122062;4884.633652476078;4898.779554920037;4807.807687692488;4842.709437433765;4870.22076467767;4873.415190177201;4874.707517548958;5462.863428414282;5465.480779325958;5466.9179962300595;5466.988607107698;5475.178723191513;5572.4706152915405;5598.776048958037;5616.9157462638095;5632.831015069554;5815.79644712433;5685.40303268155;5709.543236541067;5724.427557244284;5729.856753581152;5732.369439361667;5353.652012619206;5363.007843548917;5366.704831234241;5369.5972802040005;5371.301730774974;5633.63381380209;5701.657900525982;5786.508146807569;5805.6806875621405;5892.027815410495;5641.153826925912;5648.322201335866;5667.858303542444;5676.744546495418;5680;5733.942660573341;5737.282839645044;5737.627054241461;5744.109663002241;5748.252727145445;5424.240606315119;5636.915446268309;5674.546036317085;5680.914786278209;5783.739731712083;5772.307323121168;5772.538196944234;5777.422257774273;5785.942140578624;5792.275965504312;4439.023414848728;4477.149341625146;4481.350204220435;4487.326900964881;4497.910041799146;3886.5530463997;3903.2388684206876;3929.4302326162547;3951.545572259227;4037.253108174997;5469.398366179717;5474.42518535556;5483.75323110461;5490.450954904478;5490.478404551562;5793.652380857162;5826.621269617462;5837.941620583825;5849.1226316052935;5853.385394533598;5247.527722504993;5325.041492531304;5364.168553874156;5370.489803468664;5425.159100339453;5008.12357837377;5029.622778291643;5033;5037.4458809530925;5039.244113383022;5945.286565612154;5962.612430192024;5963.135345374983;5969.104634304889;5978.133170690226;5527.088030474926;5645.181448689999;5656.2929633795775;5670.092785154356;5787.353967000762;5940.495057920125;5948.791792287249;5954.37479064692;5960.76156953717;5968.791092311748;5698.515626171822;5699.401562835843;5700.857478563069;5704.515116215168;5708.714564271853;5623.128415095667;5632.746526406239;5686.800961966312;5688.089905615082;5764.711764411846;5615.578831587729;5637.802676906453;5649.322081350264;5657.066584013756;5662.603617746883;5608.579356548356;5644.407337229532;5655.0103731847585;5663.122216056518;5663.122216056518;5363.839084827461;5485.725713714219;5512.035393806148;5515.862103447446;5636.718164091861;5649.830505084854;5667.206591077335;5672.886542269049;5706.600537962303;5724.8282551523525;5596.468335508121;5598.048331783688;5605.019121653613;5612.803551875665;5613.01772189857 08:32:45 INFO - PROCESS | 14380 | |1;ext.html;570.5207625594501;575.4850922858495;587.2219309415026;588.4615576747279;592.7806711516739;41121.383179252334;42085.78957105214;42204.57795422045;42272.99999999996;45586.0882782345;43780.78109609448;44350.55649443505;44384.3342349865;44392.11215775683;44419.77790111053;7957.6021198939825;8852.95573522133;8975.775605609879;9008.68469603564;10635.57457701691;10564.471776411187;10977.945110274437;10978.890211097907;10988;10988.120950323995;11030.172737044713;11078.612248571302;11088.944555277212;11089.27919685222;11099.112071034338;8134.837303253961;10420.843687344695;10696.732581685443;10980.341179529214;11019.614313499029;10680.198985076151;10737.463126843626;10750.892491075067;10759.30064545802;10763.892361076367;42009.57990420118;42236.57763422357;42364;42386;42396.57603423957;3511.8385507707067;3597.4963505109304;3696.149885526317;3855.267499175148;4236.364545318196;32872.50691239633;32967;33179.3364132716;33190.834045829855;34665.13337166566;4331.7617531035785;4348.695591308609;4365.650747940157;4508.932366014513;4642.628589712848;237713;238964;240485;240691;241050;55060;55220.72389638107;55295;55524.72237638786;55705.7214713932;36151.63848361535;36583.634163658025;36623.816880915954;38672;57867.710661447265;15622.140782257085;15646.608834779221;15740.291686874118;15753.68492630141;15770.68458630844;10641.467926603638;11781.882181178249;11916.523339066514;11931.88068119325;12457.937710311571;18705.34531291398;18806.905965470087;18838.811611883706;18867.811321886606;19009.524761881064;6835.213950395768;7068;7184.784456466315;7189.388901943289;7224.530405523624;849.3163003781891;961.403929563675;971.1502435369052;1010.8584798128268;1056.3028401255287;30174.84042342312;32138.517922231185;32296.35407291888;32553.837230813693;32775;1090.3294473898654;1133.065221192503;1191.9642410727693;1198.071494591681;1200.153891506486;17088.743668844978;17122.486325410257;17145.48563543071;17151.65696686059;17156;562329;567877;567983;568391;571495;55276;55754.44245557493;55806;55887.80841436909;55926.72036639791;1225.3811825028304;1318.406716977364;1325.887299579508;1347.737191247717;1358.4769863602585;31510.52734208943;32468.512972305907;33515;33541;34214;48516.5148348512;49173.26240106329;49179.508204917496;49223.507764921895;49244.507554925425;398871;399349;401277;401286;401954;27527;28235.71764282331;28691.28271793222;29900.10299691013;29931.85034074816;47649.52350476451;47655.76172119117;47911.76044119757;48145.518544814106;49310;39401.80299098486;40056.79971600123;40467.085564037;40930;42135.36796948109;39959.2008159841;39988.2002359957;40490;40490;41434.79282603568;40154.59845401509;40720.79639601783;40981.38527922024;40986.38520422136;41199;34156.65843341634;36120.63879361278;36225.45661815022;36904.63095369012;37088;27365.589516156877;27427.177184684493;27918.581221281293;27948.72051279461;27957.860210698815 08:32:45 INFO - PROCESS | 14380 | |2;jquery.html;370.63677595955943;385.41801879162455;395.3930716350402;399.6103798796173;413.82412474698265;13956.860431395682;16742.41401550946;19265.903670481628;19420.90289548554;19569.706454403196;19345.516362090955;19353;19496.22015119397;19578.314758983437;19744;5666.801661941833;5819.068948968166;5862.355140934494;5909.113632955048;5910.261217347832;5553.750081246354;5824.504917082053;5827.650340979555;5829.621074630136;5830.941690583082;5610.607257491977;5781;5798.797042103527;5805.158252053449;5855.824325270249;6003.279606447254;6010.549208809335;6044.607100538473;6045.304789949146;6062.63624182546;5857.20927674767;6745.898811517831;7063.399611033068;7108.395786358165;7111.111111111111;25057.248282551554;26552.60171097435;27366.589501157498;28077;28232.858835705894;2351.9412014699597;2432.768886955754;2441;2544.6819147606548;2978.2107741448535;15188.46840360582;15699.764503532457;15825.208739562975;16206.270717817608;16730.616302186878;2072.699458578513;2206.2719302630094;2216.2021672198;2336.462613598882;2351.659009443621;80216.59891700563;80699.5965020177;83422.58288708578;90716.5464172675;98176;17936.461906142835;17985.7302140468;18342.40556630214;18415.355462558746;18913.7162942556;32309.35381292361;32317.676823231937;32381;32419.35161296761;32689;10105;10347.689569312932;10398.376097434179;10440.73898152537;10721.552590400197;8707.782305442288;8752.518611476302;8773.736787896374;8987.146221108984;9013.324000699973;8670;9014.459132452073;9028.232600229054;9121.589528471235;9306.348555601178;3268.836558172082;3363.226457914693;3501.1772233525103;3529.5411596492804;3654.1778099927305;871.3116637856023;973.221422861722;1008.4150843750538;1011.8026984737905;1015.6242190389603;19811.900940495492;20175.59648807045;20493.38519844407;20623.175072997212;20728.689069663968;972.6790159247431;1000.9099181073739;1008.9445080520642;1027.773889744255;1042.9843552346722;10778.083862871586;11300.265482743594;11343.886561134448;11383.203175777782;11479.655610331703;491930;494310;496999;513345;515870;90519.54740226388;90827;90853.54573227091;91194;92085;988.9653862114648;995.4077323992213;1013.9493025348851;1024.3137098144261;1025.9538320775582;17371.82628173702;17781.19984600722;18173.363932262306;18343.81656183421;18488.445346639623;44295.557044429144;44712.55287447214;44809;45064.774676126406;45756.542434575225;59380;59608.70195648994;59889.401105988385;60016.69991650014;63352.68323658352;8376.53929033909;8451.915480845113;8478.448900821428;8560.57197140153;8907.331950103899;9328.067193280618;11939.76120477603;12742.171758835646;12924.935375323063;13132.671683207996;11118.777624447628;11348.148888833206;11429.428528573704;11513.13651476126;11669.416529173677;11173.944130279297;11362.886371136183;11573.942130289632;11684.824727628922;11806.881931180578;11409.144314176305;11451.942740286579;11941.76116477683;11975;12016.158868879094;8249.257566819015;8269.21442462965;8559.315254779478;8695.087015863497;8700.60847261862;10565.260431769702;11281.32312061279;11583.6524904253;11675.88324116748;11792.469338879599 08:32:45 INFO - PROCESS | 14380 | |3;mootools.html;1358.5856313824293;1490.128274959149;1509.5999560116568;1616.3857734061055;1755.4558086993025;8186.590670466475;8533.317334613224;8536.786580335487;8694.782630434242;8800.491859819953;8570.485770853738;8687.087855775148;8691.695790647329;8693.565321733904;8732.257758090554;2020.4948762809297;2309.861408315498;2339.4034521197073;2367.147826782357;2370.063824789207;2282.429392651837;2331.4404542909665;2332.8716920569364;2333.1017558240114;2337.848039877411;2339.4385347516645;2356.5169140326193;2369.123424332999;2371.158238825218;2387.450886296153;2200.273909609825;2271.2958982715327;2276.9658455123185;2280.5096904165603;2283.349245465051;2288.302067869299;2313.236631911482;2316.143027079991;2325.174563030134;2328.895199716017;9166.587503562356;9220.907790922072;9224.446533208029;9224.492652904088;9245.260379169651;5276.234945932818;5367.114426119686;5396.271503347037;5425.728713564306;5426.104692725696;3241.6110066792135;3278.278903575618;3427.246005878703;3445.242046749711;3462.8961131166106;1132.7677826045724;1144.6108323170163;1963.4404194804556;1973.891435971021;2032.9695054574192;12457.252564846138;12484.063695222894;12567.057470689735;12576.182548134342;12617.179883307648;4292.441982542249;4398.3402489626815;4535.886602834889;4544.136614043321;4604.58558729716;9675.274354423305;9678.70963871085;9693.273004524688;9757.024297570186;9765.658201962897;5220.947790522122;5227.555657769056;5244.868878278074;5257.290265814143;5285.233641122093;4198.433211516467;4624.375709279271;4783.689060211144;4924.4090709115135;4928.581070608967;3830.5020347354666;3877.0888841122314;4023.9195216095513;4027.9194416111513;4058.188362327546;1289.4777615065914;1305.3995162225483;1315.8026296055668;1319.8284223051135;1332.6268644779477;879.7668617816283;896.9416987895765;920.9079092090738;921.9861702074475;938.7653086728318;5441.727913604304;5581.023320918823;5782.132680098019;5979.103134529768;6086.482648974798;920.6823645842173;977.7897751983357;981.5190556627201;988.3427520698655;1022.3814592171777;3823.164880857204;4179.582041795796;4194.958050419517;4221.852235171754;4289.571042895748;10796.352218866894;11261.605843795427;11286.492107855167;11326.093912486982;11330.263532870336;11269.605563805228;11271.211015229019;11271.94364028191;11284.71788205285;11288.830667539993;8221.424500285042;8422.663093476192;8537;8537.146285371413;8567.74296771098;5886;5940.851478713067;5956.821295361146;6002.3097343804275;6128.877422451436;10150.187984961038;10248.23138264648;10337.328073675188;10399.740006499898;10498.107660848913;10557.472126393803;10733.463326833784;10737.677869663923;10754.83867742;10757.46212689378;6755.628440435823;6961.408280296231;7223.494355395072;7523.0972283326355;7625.847483050419;8367.330613551023;8798.252148567444;8803.383763136519;8822.426542274732;8824.558772061242;7357.0803649543805;7396.926030739839;7423.443241756781;7495.213002634863;7567.659455324413;7442.776716698508;7506.774796756106;7574.280443358092;7754.883676744967;7830.412719046209;7007.789766307019;7104.680289386886;7135.643217838983;7144.106986626672;7146.178189508273;4818.734969576707;5031.345925029723;5032.798688052437;5160.354955630546;5218.608604354765;5014.7994080236385;5130.461301563431;5132.7177005263575;5221.6344855859725;5263.157894736823 08:32:45 INFO - PROCESS | 14380 | |4;prototype.html;287.58874809023104;293.5655230259216;298.3972375800881;298.4880929206411;308.20329448375946;5059.810944428065;5160.6903585784785;5167.224916262562;5211.478852114787;5247.842564723064;5171.120909445394;5179.482051794818;5207.557357624597;5272.81545145919;5290.127129023716;4070.14526949341;4072.1855628874346;4074.0833312504674;4094.8566800162002;4124.773137477438;3897.8440862365474;4042.8989275268204;4116.650084742801;4117.07365842686;4128.318827393491;4024.1146947671464;4035.899102522446;4047.8380864765522;4049.1091959768805;4051.9594804051876;4001.25976694311;4018.397240413932;4022.7586344819406;4028.7913625912256;4049.6152865477734;3546.929061418783;3554.9822250888838;3557.7153827693724;3558.3417067842274;3572.4284114541547;4962.925556116661;5026.421961474441;5058.898822023539;5106.3107329398235;5108.6168537359845;4523.751193684346;4528.366028755977;4532.864014079583;4535.727856328631;4536.319552067183;5335.973320133413;5362.839114826562;5373.328333958255;5401.351837779492;5419.3225846769155;3639.3813051781262;3838.193979264358;3852.903677408059;3858.6334298241622;3861.420786881962;5560.860978475571;5604.215409842584;5615.382307946123;5619.831405057855;5647.971760141173;3868.2456920900154;3879.3405121129476;3883.8446462141196;3889.922201555953;3930;3870.651641352292;3925.156091440297;3946.565877753445;3968.7420317679257;3977.025628720982;4489.820407183742;4490.865274041784;4518.864434066983;4520.660950428731;4543.7955292011275;5386.488283613129;5393.4336894626285;5397.70312632809;5415.431379705153;5423.701696406735;1269.5429645327674;1350.5003148834799;1369.9726005479833;1385.3696568061507;1386.890487609908;848.804774901776;879.2614204068614;881.7002219245487;884.363258453925;892.8526793079199;4607.101615185007;4610.40064791575;4611.216093264153;4622.827271182538;4636.39726835516;4865.95134048662;4935.138888195125;4937.555619994146;4941.604671626261;4946.975265123651;4603.516630753789;4610.677252592353;4611.400517932647;4612.3542704021465;4626.247382807224;2721.700612932576;2927.6633187183747;2942.573326867635;2948.9410211795644;2949.218457108868;5665.858353541112;5674.432556744375;5687.658740475585;5715.77110921154;5743.655380677173;5511.173324001432;5676.403977582295;5685.175649530877;5693.68684722336;5694.174344720075;5690.857728556819;5711;5720.8283751487525;5756.33802112754;5773.191753154478;5574.637648552831;5581.386047534686;5592.524635406036;5608.999185435935;5609.411011843697;5327.254184414108;5480.588955828249;5515.310586176728;5535.557155427476;5568.554515638658;5687.3459552152035;5721.885562288814;5726.713664316851;5729.856753581027;5744.5117165039765;3775.2638235543805;3868.845246190121;3869.458275841441;3870.6903447724676;3875.2443273561385;5299.774094880237;5490.917636235539;5503.3395992481155;5507.512971497753;5525.872539072406;5282.260483532232;5418.837434876802;5439.5104440600535;5443.448617144095;5451.209574611738;5344.652597581145;5425.159100339453;5460.25271912984;5460.890782184255;5468.3711373191;5142.662907643965;5349.144136938071;5385.246065550904;5399.163129714901;5409.891802164014;5426.457354264542;5440.211169380338;5443.156310771837;5451.182322651634;5476.342838859362;5318.468153184651;5329.73351332424;5334.866628334323;5352.759125839269;5360.463953604608 08:32:45 INFO - PROCESS | 14380 | |5;yui.html;709.3792931185213;742.4172024960408;756.4704706705306;800.2917418084996;839.8530257204987;14850.1832399218;16133.515994520154;16136.11251381175;16138.596535086628;16161.191940402978;14610.853891461082;14655.780163297559;14773.335199916002;14803.111813291183;14816.407343706265;650.681166228547;760.672910648421;797.2227078598364;797.9361651067929;800.1718221640604;796.7649543384715;806.891069705588;807.725373373053;808.5310519898475;808.6563210635486;830.6179157587517;835.1523203947997;842.5323945210406;842.5576572299531;844.0588743550927;683.6786710246176;806.7902345390182;840.6763396092518;840.8822764812901;841.5834162089743;610.404855266112;613.6624856329001;613.7943788830703;614.216873486304;615.092738211135;13749.175049496962;13782.724345513034;13794.172349658953;13826.30868456573;13853.445862165501;14343.282835858165;14596.708065838624;14826.406943722239;14886.776698349533;15118.622034449118;13004.934975325063;13145.145565538209;13348.19910805345;13749.793753093612;14026.36881340332;4279.786010699484;4475.731456112611;4558.7264764113925;4579.67942244043;4579.931301030487;81788.18211817925;82009;82343.5882820588;83235.16764832335;83449;11396.94301528487;11798.08276177876;11818.290902545874;12174.81737773934;12411.317377544321;22494.32517024492;22530.662040069412;22539.88730056339;22564.435889102577;22633.2078377256;8817.823643527094;8943.508107054175;8946.284297256334;9147.65261020185;9224.49265290402;4698.201305777958;4756.809727610926;4873.512648735098;4958.826441074545;5006.4492905780335;3284.2282063715006;3360.6135294440965;3364.0580637421563;3368.2589830237307;3369.0061431877657;633.1515768869644;636.1221514310222;647.970841312142;657.3131078023381;658.6278752504819;602.6444397805228;672.8284287506655;736.845262494882;792.0732742691065;798.9560574168361;9357.344985851061;9541.666041688508;9702.51487425626;10145.695629131138;10301;567.0600460179586;633.5438484291303;669.2303850571881;740.9925900741032;770.5184259837602;4474.373587697725;4898.167311557044;4927.556519913153;4999.375078115236;5014.423341315723;124439;124574.37712811377;128946.35526822493;129964;131170;84989;88853;111509;112917;112978;83323.5833820827;83885;84216;84265.57867210625;87481.56259218663;9181.311401644769;9968.900310996798;10124.493775311057;10133.783945926536;10158.238132139972;49417.50582494129;50089.49910500849;50661.49338506715;51266;52486.737566311924;64856;67206;73980.63009684917;74011.6299418521;74134.62932685301;12374.071944604011;12786.168899021533;13467.326633668474;13494.595162145151;13729;13251.403686834308;13605.795913061114;13634.938721892415;13725.245111518563;13917.652058698613;14761.92619036898;14829.40682372693;14852.7772083421;15335.156566388956;15687.607809804846;13356.732865342834;13556.322183890568;13839.72320553563;13841.377138029015;13844.377003034686;13997.341709768487;14351.425942962165;14641;14642.780358294422;15126.773098403753;10765.730856728644;10912.345259284468;11265.324080555192;11294.94352528232;12041.217320874115;10891.891081089405;11008.834867476835;12129.45417456199;12316.815247771112;12355.69110772238 08:32:45 INFO - PROCESS | 14380 | __end_tp_report 08:32:45 INFO - PROCESS | 14380 | __start_cc_report 08:32:45 INFO - PROCESS | 14380 | _x_x_mozilla_cycle_collect,1056 08:32:45 INFO - PROCESS | 14380 | __end_cc_report 08:32:45 INFO - PROCESS | 14380 | __startTimestamp1471966365828__endTimestamp 08:32:45 INFO - PROCESS | 14380 | 08:32:45 INFO - PROCESS | 14380 | ------- Summary: start ------- 08:32:45 INFO - PROCESS | 14380 | Number of tests: 6 08:32:45 INFO - PROCESS | 14380 | 08:32:45 INFO - PROCESS | 14380 | [#0] dojo.html Cycles:165 Average:5341.37 Median:5596.47 stddev:602.34 (10.8%) stddev-sans-first:575.48 08:32:45 INFO - PROCESS | 14380 | Values: 2999.3 3014.9 3027.7 3034.0 3058.8 5119.9 5268.3 5298.2 5330.7 5346.3 5355.3 5397.2 5416.8 5418.2 5496.4 4893.4 4897.2 5001.1 5045.6 5062.0 5016.5 5082.2 5087.7 5090.7 5092.9 4757.0 4822.0 4824.4 4886.2 4886.8 4835.5 4870.3 4882.0 4884.6 4898.8 4807.8 4842.7 4870.2 4873.4 4874.7 5462.9 5465.5 5466.9 5467.0 5475.2 5572.5 5598.8 5616.9 5632.8 5815.8 5685.4 5709.5 5724.4 5729.9 5732.4 5353.7 5363.0 5366.7 5369.6 5371.3 5633.6 5701.7 5786.5 5805.7 5892.0 5641.2 5648.3 5667.9 5676.7 5680.0 5733.9 5737.3 5737.6 5744.1 5748.3 5424.2 5636.9 5674.5 5680.9 5783.7 5772.3 5772.5 5777.4 5785.9 5792.3 4439.0 4477.1 4481.4 4487.3 4497.9 3886.6 3903.2 3929.4 3951.5 4037.3 5469.4 5474.4 5483.8 5490.5 5490.5 5793.7 5826.6 5837.9 5849.1 5853.4 5247.5 5325.0 5364.2 5370.5 5425.2 5008.1 5029.6 5033.0 5037.4 5039.2 5945.3 5962.6 5963.1 5969.1 5978.1 5527.1 5645.2 5656.3 5670.1 5787.4 5940.5 5948.8 5954.4 5960.8 5968.8 5698.5 5699.4 5700.9 5704.5 5708.7 5623.1 5632.7 5686.8 5688.1 5764.7 5615.6 5637.8 5649.3 5657.1 5662.6 5608.6 5644.4 5655.0 5663.1 5663.1 5363.8 5485.7 5512.0 5515.9 5636.7 5649.8 5667.2 5672.9 5706.6 5724.8 5596.5 5598.0 5605.0 5612.8 5613.0 08:32:45 INFO - PROCESS | 14380 | 08:32:45 INFO - PROCESS | 14380 | [#1] ext.html Cycles:180 Average:56511.63 Median:20300.39 stddev:112879.26 (556.0%) stddev-sans-first:113117.78 08:32:45 INFO - PROCESS | 14380 | Values: 570.5 575.5 587.2 588.5 592.8 41121.4 42085.8 42204.6 42273.0 45586.1 43780.8 44350.6 44384.3 44392.1 44419.8 7957.6 8853.0 8975.8 9008.7 10635.6 10564.5 10977.9 10978.9 10988.0 10988.1 11030.2 11078.6 11088.9 11089.3 11099.1 8134.8 10420.8 10696.7 10980.3 11019.6 10680.2 10737.5 10750.9 10759.3 10763.9 42009.6 42236.6 42364.0 42386.0 42396.6 3511.8 3597.5 3696.1 3855.3 4236.4 32872.5 32967.0 33179.3 33190.8 34665.1 4331.8 4348.7 4365.7 4508.9 4642.6 237713.0 238964.0 240485.0 240691.0 241050.0 55060.0 55220.7 55295.0 55524.7 55705.7 36151.6 36583.6 36623.8 38672.0 57867.7 15622.1 15646.6 15740.3 15753.7 15770.7 10641.5 11781.9 11916.5 11931.9 12457.9 18705.3 18806.9 18838.8 18867.8 19009.5 6835.2 7068.0 7184.8 7189.4 7224.5 849.3 961.4 971.2 1010.9 1056.3 30174.8 32138.5 32296.4 32553.8 32775.0 1090.3 1133.1 1192.0 1198.1 1200.2 17088.7 17122.5 17145.5 17151.7 17156.0 562329.0 567877.0 567983.0 568391.0 571495.0 55276.0 55754.4 55806.0 55887.8 55926.7 1225.4 1318.4 1325.9 1347.7 1358.5 31510.5 32468.5 33515.0 33541.0 34214.0 48516.5 49173.3 49179.5 49223.5 49244.5 398871.0 399349.0 401277.0 401286.0 401954.0 27527.0 28235.7 28691.3 29900.1 29931.9 47649.5 47655.8 47911.8 48145.5 49310.0 39401.8 40056.8 40467.1 40930.0 42135.4 39959.2 39988.2 40490.0 40490.0 41434.8 40154.6 40720.8 40981.4 40986.4 41199.0 34156.7 36120.6 36225.5 36904.6 37088.0 27365.6 27427.2 27918.6 27948.7 27957.9 08:32:45 INFO - PROCESS | 14380 | 08:32:45 INFO - PROCESS | 14380 | [#2] jquery.html Cycles:180 Average:30875.88 Median:32349.34 stddev:82734.57 (255.8%) stddev-sans-first:82934.96 08:32:45 INFO - PROCESS | 14380 | Values: 370.6 385.4 395.4 399.6 413.8 13956.9 16742.4 19265.9 19420.9 19569.7 19345.5 19353.0 19496.2 19578.3 19744.0 5666.8 5819.1 5862.4 5909.1 5910.3 5553.8 5824.5 5827.7 5829.6 5830.9 5610.6 5781.0 5798.8 5805.2 5855.8 6003.3 6010.5 6044.6 6045.3 6062.6 5857.2 6745.9 7063.4 7108.4 7111.1 25057.2 26552.6 27366.6 28077.0 28232.9 2351.9 2432.8 2441.0 2544.7 2978.2 15188.5 15699.8 15825.2 16206.3 16730.6 2072.7 2206.3 2216.2 2336.5 2351.7 80216.6 80699.6 83422.6 90716.5 98176.0 17936.5 17985.7 18342.4 18415.4 18913.7 32309.4 32317.7 32381.0 32419.4 32689.0 10105.0 10347.7 10398.4 10440.7 10721.6 8707.8 8752.5 8773.7 8987.1 9013.3 8670.0 9014.5 9028.2 9121.6 9306.3 3268.8 3363.2 3501.2 3529.5 3654.2 871.3 973.2 1008.4 1011.8 1015.6 19811.9 20175.6 20493.4 20623.2 20728.7 972.7 1000.9 1008.9 1027.8 1043.0 10778.1 11300.3 11343.9 11383.2 11479.7 491930.0 494310.0 496999.0 513345.0 515870.0 90519.5 90827.0 90853.5 91194.0 92085.0 989.0 995.4 1013.9 1024.3 1026.0 17371.8 17781.2 18173.4 18343.8 18488.4 44295.6 44712.6 44809.0 45064.8 45756.5 59380.0 59608.7 59889.4 60016.7 63352.7 8376.5 8451.9 8478.4 8560.6 8907.3 9328.1 11939.8 12742.2 12924.9 13132.7 11118.8 11348.1 11429.4 11513.1 11669.4 11173.9 11362.9 11573.9 11684.8 11806.9 11409.1 11451.9 11941.8 11975.0 12016.2 8249.3 8269.2 8559.3 8695.1 8700.6 10565.3 11281.3 11583.7 11675.9 11792.5 08:32:45 INFO - PROCESS | 14380 | 08:32:45 INFO - PROCESS | 14380 | [#3] mootools.html Cycles:180 Average:5832.21 Median:4926.50 stddev:3334.66 (67.7%) stddev-sans-first:3327.07 08:32:45 INFO - PROCESS | 14380 | Values: 1358.6 1490.1 1509.6 1616.4 1755.5 8186.6 8533.3 8536.8 8694.8 8800.5 8570.5 8687.1 8691.7 8693.6 8732.3 2020.5 2309.9 2339.4 2367.1 2370.1 2282.4 2331.4 2332.9 2333.1 2337.8 2339.4 2356.5 2369.1 2371.2 2387.5 2200.3 2271.3 2277.0 2280.5 2283.3 2288.3 2313.2 2316.1 2325.2 2328.9 9166.6 9220.9 9224.4 9224.5 9245.3 5276.2 5367.1 5396.3 5425.7 5426.1 3241.6 3278.3 3427.2 3445.2 3462.9 1132.8 1144.6 1963.4 1973.9 2033.0 12457.3 12484.1 12567.1 12576.2 12617.2 4292.4 4398.3 4535.9 4544.1 4604.6 9675.3 9678.7 9693.3 9757.0 9765.7 5220.9 5227.6 5244.9 5257.3 5285.2 4198.4 4624.4 4783.7 4924.4 4928.6 3830.5 3877.1 4023.9 4027.9 4058.2 1289.5 1305.4 1315.8 1319.8 1332.6 879.8 896.9 920.9 922.0 938.8 5441.7 5581.0 5782.1 5979.1 6086.5 920.7 977.8 981.5 988.3 1022.4 3823.2 4179.6 4195.0 4221.9 4289.6 10796.4 11261.6 11286.5 11326.1 11330.3 11269.6 11271.2 11271.9 11284.7 11288.8 8221.4 8422.7 8537.0 8537.1 8567.7 5886.0 5940.9 5956.8 6002.3 6128.9 10150.2 10248.2 10337.3 10399.7 10498.1 10557.5 10733.5 10737.7 10754.8 10757.5 6755.6 6961.4 7223.5 7523.1 7625.8 8367.3 8798.3 8803.4 8822.4 8824.6 7357.1 7396.9 7423.4 7495.2 7567.7 7442.8 7506.8 7574.3 7754.9 7830.4 7007.8 7104.7 7135.6 7144.1 7146.2 4818.7 5031.3 5032.8 5160.4 5218.6 5014.8 5130.5 5132.7 5221.6 5263.2 08:32:45 INFO - PROCESS | 14380 | 08:32:45 INFO - PROCESS | 14380 | [#4] prototype.html Cycles:180 Average:4500.95 Median:5125.64 stddev:1334.73 (26.0%) stddev-sans-first:1300.47 08:32:45 INFO - PROCESS | 14380 | Values: 287.6 293.6 298.4 298.5 308.2 5059.8 5160.7 5167.2 5211.5 5247.8 5171.1 5179.5 5207.6 5272.8 5290.1 4070.1 4072.2 4074.1 4094.9 4124.8 3897.8 4042.9 4116.7 4117.1 4128.3 4024.1 4035.9 4047.8 4049.1 4052.0 4001.3 4018.4 4022.8 4028.8 4049.6 3546.9 3555.0 3557.7 3558.3 3572.4 4962.9 5026.4 5058.9 5106.3 5108.6 4523.8 4528.4 4532.9 4535.7 4536.3 5336.0 5362.8 5373.3 5401.4 5419.3 3639.4 3838.2 3852.9 3858.6 3861.4 5560.9 5604.2 5615.4 5619.8 5648.0 3868.2 3879.3 3883.8 3889.9 3930.0 3870.7 3925.2 3946.6 3968.7 3977.0 4489.8 4490.9 4518.9 4520.7 4543.8 5386.5 5393.4 5397.7 5415.4 5423.7 1269.5 1350.5 1370.0 1385.4 1386.9 848.8 879.3 881.7 884.4 892.9 4607.1 4610.4 4611.2 4622.8 4636.4 4866.0 4935.1 4937.6 4941.6 4947.0 4603.5 4610.7 4611.4 4612.4 4626.2 2721.7 2927.7 2942.6 2948.9 2949.2 5665.9 5674.4 5687.7 5715.8 5743.7 5511.2 5676.4 5685.2 5693.7 5694.2 5690.9 5711.0 5720.8 5756.3 5773.2 5574.6 5581.4 5592.5 5609.0 5609.4 5327.3 5480.6 5515.3 5535.6 5568.6 5687.3 5721.9 5726.7 5729.9 5744.5 3775.3 3868.8 3869.5 3870.7 3875.2 5299.8 5490.9 5503.3 5507.5 5525.9 5282.3 5418.8 5439.5 5443.4 5451.2 5344.7 5425.2 5460.3 5460.9 5468.4 5142.7 5349.1 5385.2 5399.2 5409.9 5426.5 5440.2 5443.2 5451.2 5476.3 5318.5 5329.7 5334.9 5352.8 5360.5 08:32:45 INFO - PROCESS | 14380 | 08:32:45 INFO - PROCESS | 14380 | [#5] yui.html Cycles:180 Average:21445.96 Median:4517.23 stddev:31409.79 (695.3%) stddev-sans-first:31459.31 08:32:45 INFO - PROCESS | 14380 | Values: 709.4 742.4 756.5 800.3 839.9 14850.2 16133.5 16136.1 16138.6 16161.2 14610.9 14655.8 14773.3 14803.1 14816.4 650.7 760.7 797.2 797.9 800.2 796.8 806.9 807.7 808.5 808.7 830.6 835.2 842.5 842.6 844.1 683.7 806.8 840.7 840.9 841.6 610.4 613.7 613.8 614.2 615.1 13749.2 13782.7 13794.2 13826.3 13853.4 14343.3 14596.7 14826.4 14886.8 15118.6 13004.9 13145.1 13348.2 13749.8 14026.4 4279.8 4475.7 4558.7 4579.7 4579.9 81788.2 82009.0 82343.6 83235.2 83449.0 11396.9 11798.1 11818.3 12174.8 12411.3 22494.3 22530.7 22539.9 22564.4 22633.2 8817.8 8943.5 8946.3 9147.7 9224.5 4698.2 4756.8 4873.5 4958.8 5006.4 3284.2 3360.6 3364.1 3368.3 3369.0 633.2 636.1 648.0 657.3 658.6 602.6 672.8 736.8 792.1 799.0 9357.3 9541.7 9702.5 10145.7 10301.0 567.1 633.5 669.2 741.0 770.5 4474.4 4898.2 4927.6 4999.4 5014.4 124439.0 124574.4 128946.4 129964.0 131170.0 84989.0 88853.0 111509.0 112917.0 112978.0 83323.6 83885.0 84216.0 84265.6 87481.6 9181.3 9968.9 10124.5 10133.8 10158.2 49417.5 50089.5 50661.5 51266.0 52486.7 64856.0 67206.0 73980.6 74011.6 74134.6 12374.1 12786.2 13467.3 13494.6 13729.0 13251.4 13605.8 13634.9 13725.2 13917.7 14761.9 14829.4 14852.8 15335.2 15687.6 13356.7 13556.3 13839.7 13841.4 13844.4 13997.3 14351.4 14641.0 14642.8 15126.8 10765.7 10912.3 11265.3 11294.9 12041.2 10891.9 11008.8 12129.5 12316.8 12355.7 08:32:45 INFO - PROCESS | 14380 | -------- Summary: end -------- 08:32:45 INFO - PROCESS | 14380 | 08:32:46 INFO - TEST-INFO | 14380: exit 0 08:32:46 INFO - TEST-OK | dromaeo_css | took 1117196ms 08:32:46 INFO - TEST-START | kraken 08:32:46 INFO - operating with platform_type : linux_ 08:32:46 INFO - Initialising browser for kraken test... 08:32:46 INFO - TEST-INFO | started process 14687 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXdEgML/profile http://localhost:57903/getInfo.html) 08:32:51 INFO - PROCESS | 14687 | __metrics Screen width/height:1600/1200 08:32:51 INFO - PROCESS | 14687 | colorDepth:24 08:32:51 INFO - PROCESS | 14687 | Browser inner width/height: 1024/697 08:32:51 INFO - PROCESS | 14687 | __metrics 08:32:51 INFO - PROCESS | 14687 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:32:51 INFO - PROCESS | 14687 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:32:52 INFO - PROCESS | 14687 | console.error: PushService: 08:32:52 INFO - PROCESS | 14687 | stateChangeProcessEnqueue: Error transitioning state 08:32:52 INFO - PROCESS | 14687 | UnknownError 08:32:52 INFO - TEST-INFO | 14687: exit 0 08:32:52 INFO - Browser initialized. 08:32:52 INFO - Running cycle 1/1 for kraken test... 08:32:52 INFO - TEST-INFO | started process 14768 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXdEgML/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:04 INFO - PROCESS | 14768 | RSS: Main: 174096384 08:33:04 INFO - PROCESS | 14768 | 08:33:07 INFO - PROCESS | 14768 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57903/tests/kraken/driver.html?testName=audio-beat-detection) 08:33:08 INFO - PROCESS | 14768 | RSS: Main: 243855360 08:33:08 INFO - PROCESS | 14768 | 08:33:10 INFO - PROCESS | 14768 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57903/tests/kraken/driver.html?testName=audio-dft) 08:33:11 INFO - PROCESS | 14768 | RSS: Main: 225886208 08:33:11 INFO - PROCESS | 14768 | 08:33:14 INFO - PROCESS | 14768 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57903/tests/kraken/driver.html?testName=audio-fft) 08:33:15 INFO - PROCESS | 14768 | RSS: Main: 303255552 08:33:15 INFO - PROCESS | 14768 | 08:33:17 INFO - PROCESS | 14768 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57903/tests/kraken/driver.html?testName=audio-oscillator) 08:33:18 INFO - PROCESS | 14768 | RSS: Main: 210247680 08:33:18 INFO - PROCESS | 14768 | 08:33:20 INFO - PROCESS | 14768 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57903/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:33:20 INFO - PROCESS | 14768 | RSS: Main: 213901312 08:33:20 INFO - PROCESS | 14768 | 08:33:23 INFO - PROCESS | 14768 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57903/tests/kraken/driver.html?testName=imaging-darkroom) 08:33:24 INFO - PROCESS | 14768 | RSS: Main: 250134528 08:33:24 INFO - PROCESS | 14768 | 08:33:27 INFO - PROCESS | 14768 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57903/tests/kraken/driver.html?testName=imaging-desaturate) 08:33:28 INFO - PROCESS | 14768 | RSS: Main: 248565760 08:33:28 INFO - PROCESS | 14768 | 08:33:31 INFO - PROCESS | 14768 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57903/tests/kraken/driver.html?testName=json-parse-financial) 08:33:32 INFO - PROCESS | 14768 | RSS: Main: 248193024 08:33:32 INFO - PROCESS | 14768 | 08:33:33 INFO - PROCESS | 14768 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57903/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:33:34 INFO - PROCESS | 14768 | RSS: Main: 211390464 08:33:34 INFO - PROCESS | 14768 | 08:33:36 INFO - PROCESS | 14768 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57903/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:33:36 INFO - PROCESS | 14768 | RSS: Main: 218951680 08:33:36 INFO - PROCESS | 14768 | 08:33:38 INFO - PROCESS | 14768 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57903/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:33:39 INFO - PROCESS | 14768 | RSS: Main: 223539200 08:33:39 INFO - PROCESS | 14768 | 08:33:42 INFO - PROCESS | 14768 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:33:42 INFO - PROCESS | 14768 | RSS: Main: 218775552 08:33:42 INFO - PROCESS | 14768 | 08:33:45 INFO - PROCESS | 14768 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:33:46 INFO - PROCESS | 14768 | RSS: Main: 221507584 08:33:46 INFO - PROCESS | 14768 | 08:33:47 INFO - PROCESS | 14768 | Cycle 1(1): loaded http://localhost:57903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57903/tests/kraken/driver.html?testName=ai-astar) 08:33:48 INFO - PROCESS | 14768 | RSS: Main: 272740352 08:33:48 INFO - PROCESS | 14768 | 08:33:48 INFO - PROCESS | 14768 | __start_tp_report 08:33:48 INFO - PROCESS | 14768 | _x_x_mozilla_page_load 08:33:48 INFO - PROCESS | 14768 | _x_x_mozilla_page_load_details 08:33:48 INFO - PROCESS | 14768 | |i|pagename|runs| 08:33:48 INFO - PROCESS | 14768 | |0;ai-astar;99;112;107;111;113;110;118;111;110;110 08:33:48 INFO - PROCESS | 14768 | |1;audio-beat-detection;151;118;146;182;122;154;147;118;193;122 08:33:48 INFO - PROCESS | 14768 | |2;audio-dft;160;162;160;160;160;162;163;161;161;161 08:33:48 INFO - PROCESS | 14768 | |3;audio-fft;74;74;75;165;77;76;75;74;171;77 08:33:48 INFO - PROCESS | 14768 | |4;audio-oscillator;85;85;147;87;86;84;138;89;86;155 08:33:48 INFO - PROCESS | 14768 | |5;imaging-gaussian-blur;117;116;116;116;116;117;118;118;117;118 08:33:48 INFO - PROCESS | 14768 | |6;imaging-darkroom;146;145;145;146;145;146;148;146;146;145 08:33:48 INFO - PROCESS | 14768 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;95 08:33:48 INFO - PROCESS | 14768 | |8;json-parse-financial;50;50;51;53;51;51;53;52;52;51 08:33:48 INFO - PROCESS | 14768 | |9;json-stringify-tinderbox;62;63;62;62;64;62;62;62;62;62 08:33:48 INFO - PROCESS | 14768 | |10;stanford-crypto-aes;88;79;79;79;81;78;78;84;82;79 08:33:48 INFO - PROCESS | 14768 | |11;stanford-crypto-ccm;135;125;130;124;134;127;125;135;158;128 08:33:48 INFO - PROCESS | 14768 | |12;stanford-crypto-pbkdf2;172;168;163;162;165;165;164;164;163;165 08:33:48 INFO - PROCESS | 14768 | |13;stanford-crypto-sha256-iterative;66;67;66;64;74;66;65;64;66;65 08:33:48 INFO - PROCESS | 14768 | __end_tp_report 08:33:48 INFO - PROCESS | 14768 | __start_cc_report 08:33:48 INFO - PROCESS | 14768 | _x_x_mozilla_cycle_collect,1726 08:33:48 INFO - PROCESS | 14768 | __end_cc_report 08:33:48 INFO - PROCESS | 14768 | __startTimestamp1471966428149__endTimestamp 08:33:48 INFO - PROCESS | 14768 | 08:33:48 INFO - PROCESS | 14768 | ------- Summary: start ------- 08:33:48 INFO - PROCESS | 14768 | Number of tests: 14 08:33:48 INFO - PROCESS | 14768 | 08:33:48 INFO - PROCESS | 14768 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.50 stddev:4.82 (4.3%) stddev-sans-first:3.00 08:33:48 INFO - PROCESS | 14768 | Values: 99.0 112.0 107.0 111.0 113.0 110.0 118.0 111.0 110.0 110.0 08:33:48 INFO - PROCESS | 14768 | 08:33:48 INFO - PROCESS | 14768 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:149.00 stddev:26.48 (17.8%) stddev-sans-first:28.00 08:33:48 INFO - PROCESS | 14768 | Values: 151.0 118.0 146.0 182.0 122.0 154.0 147.0 118.0 193.0 122.0 08:33:48 INFO - PROCESS | 14768 | 08:33:48 INFO - PROCESS | 14768 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 08:33:48 INFO - PROCESS | 14768 | Values: 160.0 162.0 160.0 160.0 160.0 162.0 163.0 161.0 161.0 161.0 08:33:48 INFO - PROCESS | 14768 | 08:33:48 INFO - PROCESS | 14768 | [#3] audio-fft Cycles:10 Average:93.80 Median:75.00 stddev:39.15 (52.2%) stddev-sans-first:40.86 08:33:48 INFO - PROCESS | 14768 | Values: 74.0 74.0 75.0 165.0 77.0 76.0 75.0 74.0 171.0 77.0 08:33:48 INFO - PROCESS | 14768 | 08:33:48 INFO - PROCESS | 14768 | [#4] audio-oscillator Cycles:10 Average:104.20 Median:85.50 stddev:29.61 (34.6%) stddev-sans-first:30.58 08:33:48 INFO - PROCESS | 14768 | Values: 85.0 85.0 147.0 87.0 86.0 84.0 138.0 89.0 86.0 155.0 08:33:48 INFO - PROCESS | 14768 | 08:33:48 INFO - PROCESS | 14768 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 08:33:48 INFO - PROCESS | 14768 | Values: 117.0 116.0 116.0 116.0 116.0 117.0 118.0 118.0 117.0 118.0 08:33:48 INFO - PROCESS | 14768 | 08:33:48 INFO - PROCESS | 14768 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 08:33:48 INFO - PROCESS | 14768 | Values: 146.0 145.0 145.0 146.0 145.0 146.0 148.0 146.0 146.0 145.0 08:33:48 INFO - PROCESS | 14768 | 08:33:48 INFO - PROCESS | 14768 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:33:48 INFO - PROCESS | 14768 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 08:33:48 INFO - PROCESS | 14768 | 08:33:48 INFO - PROCESS | 14768 | [#8] json-parse-financial Cycles:10 Average:51.40 Median:51.50 stddev:1.07 (2.1%) stddev-sans-first:1.01 08:33:48 INFO - PROCESS | 14768 | Values: 50.0 50.0 51.0 53.0 51.0 51.0 53.0 52.0 52.0 51.0 08:33:48 INFO - PROCESS | 14768 | 08:33:48 INFO - PROCESS | 14768 | [#9] json-stringify-tinderbox Cycles:10 Average:62.30 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 08:33:48 INFO - PROCESS | 14768 | Values: 62.0 63.0 62.0 62.0 64.0 62.0 62.0 62.0 62.0 62.0 08:33:48 INFO - PROCESS | 14768 | 08:33:48 INFO - PROCESS | 14768 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:3.20 (4.0%) stddev-sans-first:2.03 08:33:48 INFO - PROCESS | 14768 | Values: 88.0 79.0 79.0 79.0 81.0 78.0 78.0 84.0 82.0 79.0 08:33:48 INFO - PROCESS | 14768 | 08:33:48 INFO - PROCESS | 14768 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:132.00 stddev:10.03 (7.6%) stddev-sans-first:10.58 08:33:48 INFO - PROCESS | 14768 | Values: 135.0 125.0 130.0 124.0 134.0 127.0 125.0 135.0 158.0 128.0 08:33:48 INFO - PROCESS | 14768 | 08:33:48 INFO - PROCESS | 14768 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:165.00 stddev:2.92 (1.8%) stddev-sans-first:1.73 08:33:48 INFO - PROCESS | 14768 | Values: 172.0 168.0 163.0 162.0 165.0 165.0 164.0 164.0 163.0 165.0 08:33:48 INFO - PROCESS | 14768 | 08:33:48 INFO - PROCESS | 14768 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.00 stddev:2.87 (4.3%) stddev-sans-first:3.04 08:33:48 INFO - PROCESS | 14768 | Values: 66.0 67.0 66.0 64.0 74.0 66.0 65.0 64.0 66.0 65.0 08:33:48 INFO - PROCESS | 14768 | -------- Summary: end -------- 08:33:48 INFO - PROCESS | 14768 | 08:33:49 INFO - TEST-INFO | 14768: exit 0 08:33:49 INFO - TEST-OK | kraken | took 62553ms 08:33:49 INFO - SUITE-END | took 1179s 08:33:49 INFO - Completed test suite (00:19:40) 08:33:49 INFO - javascript benchmark 08:33:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2999.3401451680634, 3014.9095527134195, 3027.7123673251035, 3033.9848300758495, 3058.7552995760343, 5119.872003199913, 5268.31511903453, 5298.23175639532, 5330.706811125387, 5346.331708536433, 5355.3305836770405, 5397.163439666848, 5416.835380393215, 5418.214358917964, 5496.367917689457, 4893.363862697862, 4897.1674815281485, 5001.074801161797, 5045.571126454256, 5061.974690126544, 5016.548510634042, 5082.161443361841, 5087.66930149541, 5090.720010399445, 5092.872678183038, 4756.952430475685, 4822.0, 4824.407945378017, 4886.242632391985, 4886.804527818883, 4835.540623640749, 4870.269459581055, 4881.975590122062, 4884.633652476078, 4898.779554920037, 4807.807687692488, 4842.709437433765, 4870.22076467767, 4873.415190177201, 4874.707517548958, 5462.863428414282, 5465.480779325958, 5466.9179962300595, 5466.988607107698, 5475.178723191513, 5572.4706152915405, 5598.776048958037, 5616.9157462638095, 5632.831015069554, 5815.79644712433, 5685.40303268155, 5709.543236541067, 5724.427557244284, 5729.856753581152, 5732.369439361667, 5353.652012619206, 5363.007843548917, 5366.704831234241, 5369.5972802040005, 5371.301730774974, 5633.63381380209, 5701.657900525982, 5786.508146807569, 5805.6806875621405, 5892.027815410495, 5641.153826925912, 5648.322201335866, 5667.858303542444, 5676.744546495418, 5680.0, 5733.942660573341, 5737.282839645044, 5737.627054241461, 5744.109663002241, 5748.252727145445, 5424.240606315119, 5636.915446268309, 5674.546036317085, 5680.914786278209, 5783.739731712083, 5772.307323121168, 5772.538196944234, 5777.422257774273, 5785.942140578624, 5792.275965504312, 4439.023414848728, 4477.149341625146, 4481.350204220435, 4487.326900964881, 4497.910041799146, 3886.5530463997, 3903.2388684206876, 3929.4302326162547, 3951.545572259227, 4037.253108174997, 5469.398366179717, 5474.42518535556, 5483.75323110461, 5490.450954904478, 5490.478404551562, 5793.652380857162, 5826.621269617462, 5837.941620583825, 5849.1226316052935, 5853.385394533598, 5247.527722504993, 5325.041492531304, 5364.168553874156, 5370.489803468664, 5425.159100339453, 5008.12357837377, 5029.622778291643, 5033.0, 5037.4458809530925, 5039.244113383022, 5945.286565612154, 5962.612430192024, 5963.135345374983, 5969.104634304889, 5978.133170690226, 5527.088030474926, 5645.181448689999, 5656.2929633795775, 5670.092785154356, 5787.353967000762, 5940.495057920125, 5948.791792287249, 5954.37479064692, 5960.76156953717, 5968.791092311748, 5698.515626171822, 5699.401562835843, 5700.857478563069, 5704.515116215168, 5708.714564271853, 5623.128415095667, 5632.746526406239, 5686.800961966312, 5688.089905615082, 5764.711764411846, 5615.578831587729, 5637.802676906453, 5649.322081350264, 5657.066584013756, 5662.603617746883, 5608.579356548356, 5644.407337229532, 5655.0103731847585, 5663.122216056518, 5663.122216056518, 5363.839084827461, 5485.725713714219, 5512.035393806148, 5515.862103447446, 5636.718164091861, 5649.830505084854, 5667.206591077335, 5672.886542269049, 5706.600537962303, 5724.8282551523525, 5596.468335508121, 5598.048331783688, 5605.019121653613, 5612.803551875665, 5613.01772189857], "value": 5300.151633721978, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.5207625594501, 575.4850922858495, 587.2219309415026, 588.4615576747279, 592.7806711516739, 41121.383179252334, 42085.78957105214, 42204.57795422045, 42272.99999999996, 45586.0882782345, 43780.78109609448, 44350.55649443505, 44384.3342349865, 44392.11215775683, 44419.77790111053, 7957.6021198939825, 8852.95573522133, 8975.775605609879, 9008.68469603564, 10635.57457701691, 10564.471776411187, 10977.945110274437, 10978.890211097907, 10988.0, 10988.120950323995, 11030.172737044713, 11078.612248571302, 11088.944555277212, 11089.27919685222, 11099.112071034338, 8134.837303253961, 10420.843687344695, 10696.732581685443, 10980.341179529214, 11019.614313499029, 10680.198985076151, 10737.463126843626, 10750.892491075067, 10759.30064545802, 10763.892361076367, 42009.57990420118, 42236.57763422357, 42364.0, 42386.0, 42396.57603423957, 3511.8385507707067, 3597.4963505109304, 3696.149885526317, 3855.267499175148, 4236.364545318196, 32872.50691239633, 32967.0, 33179.3364132716, 33190.834045829855, 34665.13337166566, 4331.7617531035785, 4348.695591308609, 4365.650747940157, 4508.932366014513, 4642.628589712848, 237713.0, 238964.0, 240485.0, 240691.0, 241050.0, 55060.0, 55220.72389638107, 55295.0, 55524.72237638786, 55705.7214713932, 36151.63848361535, 36583.634163658025, 36623.816880915954, 38672.0, 57867.710661447265, 15622.140782257085, 15646.608834779221, 15740.291686874118, 15753.68492630141, 15770.68458630844, 10641.467926603638, 11781.882181178249, 11916.523339066514, 11931.88068119325, 12457.937710311571, 18705.34531291398, 18806.905965470087, 18838.811611883706, 18867.811321886606, 19009.524761881064, 6835.213950395768, 7068.0, 7184.784456466315, 7189.388901943289, 7224.530405523624, 849.3163003781891, 961.403929563675, 971.1502435369052, 1010.8584798128268, 1056.3028401255287, 30174.84042342312, 32138.517922231185, 32296.35407291888, 32553.837230813693, 32775.0, 1090.3294473898654, 1133.065221192503, 1191.9642410727693, 1198.071494591681, 1200.153891506486, 17088.743668844978, 17122.486325410257, 17145.48563543071, 17151.65696686059, 17156.0, 562329.0, 567877.0, 567983.0, 568391.0, 571495.0, 55276.0, 55754.44245557493, 55806.0, 55887.80841436909, 55926.72036639791, 1225.3811825028304, 1318.406716977364, 1325.887299579508, 1347.737191247717, 1358.4769863602585, 31510.52734208943, 32468.512972305907, 33515.0, 33541.0, 34214.0, 48516.5148348512, 49173.26240106329, 49179.508204917496, 49223.507764921895, 49244.507554925425, 398871.0, 399349.0, 401277.0, 401286.0, 401954.0, 27527.0, 28235.71764282331, 28691.28271793222, 29900.10299691013, 29931.85034074816, 47649.52350476451, 47655.76172119117, 47911.76044119757, 48145.518544814106, 49310.0, 39401.80299098486, 40056.79971600123, 40467.085564037, 40930.0, 42135.36796948109, 39959.2008159841, 39988.2002359957, 40490.0, 40490.0, 41434.79282603568, 40154.59845401509, 40720.79639601783, 40981.38527922024, 40986.38520422136, 41199.0, 34156.65843341634, 36120.63879361278, 36225.45661815022, 36904.63095369012, 37088.0, 27365.589516156877, 27427.177184684493, 27918.581221281293, 27948.72051279461, 27957.860210698815], "value": 19980.819450603693, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.63677595955943, 385.41801879162455, 395.3930716350402, 399.6103798796173, 413.82412474698265, 13956.860431395682, 16742.41401550946, 19265.903670481628, 19420.90289548554, 19569.706454403196, 19345.516362090955, 19353.0, 19496.22015119397, 19578.314758983437, 19744.0, 5666.801661941833, 5819.068948968166, 5862.355140934494, 5909.113632955048, 5910.261217347832, 5553.750081246354, 5824.504917082053, 5827.650340979555, 5829.621074630136, 5830.941690583082, 5610.607257491977, 5781.0, 5798.797042103527, 5805.158252053449, 5855.824325270249, 6003.279606447254, 6010.549208809335, 6044.607100538473, 6045.304789949146, 6062.63624182546, 5857.20927674767, 6745.898811517831, 7063.399611033068, 7108.395786358165, 7111.111111111111, 25057.248282551554, 26552.60171097435, 27366.589501157498, 28077.0, 28232.858835705894, 2351.9412014699597, 2432.768886955754, 2441.0, 2544.6819147606548, 2978.2107741448535, 15188.46840360582, 15699.764503532457, 15825.208739562975, 16206.270717817608, 16730.616302186878, 2072.699458578513, 2206.2719302630094, 2216.2021672198, 2336.462613598882, 2351.659009443621, 80216.59891700563, 80699.5965020177, 83422.58288708578, 90716.5464172675, 98176.0, 17936.461906142835, 17985.7302140468, 18342.40556630214, 18415.355462558746, 18913.7162942556, 32309.35381292361, 32317.676823231937, 32381.0, 32419.35161296761, 32689.0, 10105.0, 10347.689569312932, 10398.376097434179, 10440.73898152537, 10721.552590400197, 8707.782305442288, 8752.518611476302, 8773.736787896374, 8987.146221108984, 9013.324000699973, 8670.0, 9014.459132452073, 9028.232600229054, 9121.589528471235, 9306.348555601178, 3268.836558172082, 3363.226457914693, 3501.1772233525103, 3529.5411596492804, 3654.1778099927305, 871.3116637856023, 973.221422861722, 1008.4150843750538, 1011.8026984737905, 1015.6242190389603, 19811.900940495492, 20175.59648807045, 20493.38519844407, 20623.175072997212, 20728.689069663968, 972.6790159247431, 1000.9099181073739, 1008.9445080520642, 1027.773889744255, 1042.9843552346722, 10778.083862871586, 11300.265482743594, 11343.886561134448, 11383.203175777782, 11479.655610331703, 491930.0, 494310.0, 496999.0, 513345.0, 515870.0, 90519.54740226388, 90827.0, 90853.54573227091, 91194.0, 92085.0, 988.9653862114648, 995.4077323992213, 1013.9493025348851, 1024.3137098144261, 1025.9538320775582, 17371.82628173702, 17781.19984600722, 18173.363932262306, 18343.81656183421, 18488.445346639623, 44295.557044429144, 44712.55287447214, 44809.0, 45064.774676126406, 45756.542434575225, 59380.0, 59608.70195648994, 59889.401105988385, 60016.69991650014, 63352.68323658352, 8376.53929033909, 8451.915480845113, 8478.448900821428, 8560.57197140153, 8907.331950103899, 9328.067193280618, 11939.76120477603, 12742.171758835646, 12924.935375323063, 13132.671683207996, 11118.777624447628, 11348.148888833206, 11429.428528573704, 11513.13651476126, 11669.416529173677, 11173.944130279297, 11362.886371136183, 11573.942130289632, 11684.824727628922, 11806.881931180578, 11409.144314176305, 11451.942740286579, 11941.76116477683, 11975.0, 12016.158868879094, 8249.257566819015, 8269.21442462965, 8559.315254779478, 8695.087015863497, 8700.60847261862, 10565.260431769702, 11281.32312061279, 11583.6524904253, 11675.88324116748, 11792.469338879599], "value": 10321.066227631158, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.5856313824293, 1490.128274959149, 1509.5999560116568, 1616.3857734061055, 1755.4558086993025, 8186.590670466475, 8533.317334613224, 8536.786580335487, 8694.782630434242, 8800.491859819953, 8570.485770853738, 8687.087855775148, 8691.695790647329, 8693.565321733904, 8732.257758090554, 2020.4948762809297, 2309.861408315498, 2339.4034521197073, 2367.147826782357, 2370.063824789207, 2282.429392651837, 2331.4404542909665, 2332.8716920569364, 2333.1017558240114, 2337.848039877411, 2339.4385347516645, 2356.5169140326193, 2369.123424332999, 2371.158238825218, 2387.450886296153, 2200.273909609825, 2271.2958982715327, 2276.9658455123185, 2280.5096904165603, 2283.349245465051, 2288.302067869299, 2313.236631911482, 2316.143027079991, 2325.174563030134, 2328.895199716017, 9166.587503562356, 9220.907790922072, 9224.446533208029, 9224.492652904088, 9245.260379169651, 5276.234945932818, 5367.114426119686, 5396.271503347037, 5425.728713564306, 5426.104692725696, 3241.6110066792135, 3278.278903575618, 3427.246005878703, 3445.242046749711, 3462.8961131166106, 1132.7677826045724, 1144.6108323170163, 1963.4404194804556, 1973.891435971021, 2032.9695054574192, 12457.252564846138, 12484.063695222894, 12567.057470689735, 12576.182548134342, 12617.179883307648, 4292.441982542249, 4398.3402489626815, 4535.886602834889, 4544.136614043321, 4604.58558729716, 9675.274354423305, 9678.70963871085, 9693.273004524688, 9757.024297570186, 9765.658201962897, 5220.947790522122, 5227.555657769056, 5244.868878278074, 5257.290265814143, 5285.233641122093, 4198.433211516467, 4624.375709279271, 4783.689060211144, 4924.4090709115135, 4928.581070608967, 3830.5020347354666, 3877.0888841122314, 4023.9195216095513, 4027.9194416111513, 4058.188362327546, 1289.4777615065914, 1305.3995162225483, 1315.8026296055668, 1319.8284223051135, 1332.6268644779477, 879.7668617816283, 896.9416987895765, 920.9079092090738, 921.9861702074475, 938.7653086728318, 5441.727913604304, 5581.023320918823, 5782.132680098019, 5979.103134529768, 6086.482648974798, 920.6823645842173, 977.7897751983357, 981.5190556627201, 988.3427520698655, 1022.3814592171777, 3823.164880857204, 4179.582041795796, 4194.958050419517, 4221.852235171754, 4289.571042895748, 10796.352218866894, 11261.605843795427, 11286.492107855167, 11326.093912486982, 11330.263532870336, 11269.605563805228, 11271.211015229019, 11271.94364028191, 11284.71788205285, 11288.830667539993, 8221.424500285042, 8422.663093476192, 8537.0, 8537.146285371413, 8567.74296771098, 5886.0, 5940.851478713067, 5956.821295361146, 6002.3097343804275, 6128.877422451436, 10150.187984961038, 10248.23138264648, 10337.328073675188, 10399.740006499898, 10498.107660848913, 10557.472126393803, 10733.463326833784, 10737.677869663923, 10754.83867742, 10757.46212689378, 6755.628440435823, 6961.408280296231, 7223.494355395072, 7523.0972283326355, 7625.847483050419, 8367.330613551023, 8798.252148567444, 8803.383763136519, 8822.426542274732, 8824.558772061242, 7357.0803649543805, 7396.926030739839, 7423.443241756781, 7495.213002634863, 7567.659455324413, 7442.776716698508, 7506.774796756106, 7574.280443358092, 7754.883676744967, 7830.412719046209, 7007.789766307019, 7104.680289386886, 7135.643217838983, 7144.106986626672, 7146.178189508273, 4818.734969576707, 5031.345925029723, 5032.798688052437, 5160.354955630546, 5218.608604354765, 5014.7994080236385, 5130.461301563431, 5132.7177005263575, 5221.6344855859725, 5263.157894736823], "value": 4689.542776631341, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.58874809023104, 293.5655230259216, 298.3972375800881, 298.4880929206411, 308.20329448375946, 5059.810944428065, 5160.6903585784785, 5167.224916262562, 5211.478852114787, 5247.842564723064, 5171.120909445394, 5179.482051794818, 5207.557357624597, 5272.81545145919, 5290.127129023716, 4070.14526949341, 4072.1855628874346, 4074.0833312504674, 4094.8566800162002, 4124.773137477438, 3897.8440862365474, 4042.8989275268204, 4116.650084742801, 4117.07365842686, 4128.318827393491, 4024.1146947671464, 4035.899102522446, 4047.8380864765522, 4049.1091959768805, 4051.9594804051876, 4001.25976694311, 4018.397240413932, 4022.7586344819406, 4028.7913625912256, 4049.6152865477734, 3546.929061418783, 3554.9822250888838, 3557.7153827693724, 3558.3417067842274, 3572.4284114541547, 4962.925556116661, 5026.421961474441, 5058.898822023539, 5106.3107329398235, 5108.6168537359845, 4523.751193684346, 4528.366028755977, 4532.864014079583, 4535.727856328631, 4536.319552067183, 5335.973320133413, 5362.839114826562, 5373.328333958255, 5401.351837779492, 5419.3225846769155, 3639.3813051781262, 3838.193979264358, 3852.903677408059, 3858.6334298241622, 3861.420786881962, 5560.860978475571, 5604.215409842584, 5615.382307946123, 5619.831405057855, 5647.971760141173, 3868.2456920900154, 3879.3405121129476, 3883.8446462141196, 3889.922201555953, 3930.0, 3870.651641352292, 3925.156091440297, 3946.565877753445, 3968.7420317679257, 3977.025628720982, 4489.820407183742, 4490.865274041784, 4518.864434066983, 4520.660950428731, 4543.7955292011275, 5386.488283613129, 5393.4336894626285, 5397.70312632809, 5415.431379705153, 5423.701696406735, 1269.5429645327674, 1350.5003148834799, 1369.9726005479833, 1385.3696568061507, 1386.890487609908, 848.804774901776, 879.2614204068614, 881.7002219245487, 884.363258453925, 892.8526793079199, 4607.101615185007, 4610.40064791575, 4611.216093264153, 4622.827271182538, 4636.39726835516, 4865.95134048662, 4935.138888195125, 4937.555619994146, 4941.604671626261, 4946.975265123651, 4603.516630753789, 4610.677252592353, 4611.400517932647, 4612.3542704021465, 4626.247382807224, 2721.700612932576, 2927.6633187183747, 2942.573326867635, 2948.9410211795644, 2949.218457108868, 5665.858353541112, 5674.432556744375, 5687.658740475585, 5715.77110921154, 5743.655380677173, 5511.173324001432, 5676.403977582295, 5685.175649530877, 5693.68684722336, 5694.174344720075, 5690.857728556819, 5711.0, 5720.8283751487525, 5756.33802112754, 5773.191753154478, 5574.637648552831, 5581.386047534686, 5592.524635406036, 5608.999185435935, 5609.411011843697, 5327.254184414108, 5480.588955828249, 5515.310586176728, 5535.557155427476, 5568.554515638658, 5687.3459552152035, 5721.885562288814, 5726.713664316851, 5729.856753581027, 5744.5117165039765, 3775.2638235543805, 3868.845246190121, 3869.458275841441, 3870.6903447724676, 3875.2443273561385, 5299.774094880237, 5490.917636235539, 5503.3395992481155, 5507.512971497753, 5525.872539072406, 5282.260483532232, 5418.837434876802, 5439.5104440600535, 5443.448617144095, 5451.209574611738, 5344.652597581145, 5425.159100339453, 5460.25271912984, 5460.890782184255, 5468.3711373191, 5142.662907643965, 5349.144136938071, 5385.246065550904, 5399.163129714901, 5409.891802164014, 5426.457354264542, 5440.211169380338, 5443.156310771837, 5451.182322651634, 5476.342838859362, 5318.468153184651, 5329.73351332424, 5334.866628334323, 5352.759125839269, 5360.463953604608], "value": 4066.2877178071744, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.3792931185213, 742.4172024960408, 756.4704706705306, 800.2917418084996, 839.8530257204987, 14850.1832399218, 16133.515994520154, 16136.11251381175, 16138.596535086628, 16161.191940402978, 14610.853891461082, 14655.780163297559, 14773.335199916002, 14803.111813291183, 14816.407343706265, 650.681166228547, 760.672910648421, 797.2227078598364, 797.9361651067929, 800.1718221640604, 796.7649543384715, 806.891069705588, 807.725373373053, 808.5310519898475, 808.6563210635486, 830.6179157587517, 835.1523203947997, 842.5323945210406, 842.5576572299531, 844.0588743550927, 683.6786710246176, 806.7902345390182, 840.6763396092518, 840.8822764812901, 841.5834162089743, 610.404855266112, 613.6624856329001, 613.7943788830703, 614.216873486304, 615.092738211135, 13749.175049496962, 13782.724345513034, 13794.172349658953, 13826.30868456573, 13853.445862165501, 14343.282835858165, 14596.708065838624, 14826.406943722239, 14886.776698349533, 15118.622034449118, 13004.934975325063, 13145.145565538209, 13348.19910805345, 13749.793753093612, 14026.36881340332, 4279.786010699484, 4475.731456112611, 4558.7264764113925, 4579.67942244043, 4579.931301030487, 81788.18211817925, 82009.0, 82343.5882820588, 83235.16764832335, 83449.0, 11396.94301528487, 11798.08276177876, 11818.290902545874, 12174.81737773934, 12411.317377544321, 22494.32517024492, 22530.662040069412, 22539.88730056339, 22564.435889102577, 22633.2078377256, 8817.823643527094, 8943.508107054175, 8946.284297256334, 9147.65261020185, 9224.49265290402, 4698.201305777958, 4756.809727610926, 4873.512648735098, 4958.826441074545, 5006.4492905780335, 3284.2282063715006, 3360.6135294440965, 3364.0580637421563, 3368.2589830237307, 3369.0061431877657, 633.1515768869644, 636.1221514310222, 647.970841312142, 657.3131078023381, 658.6278752504819, 602.6444397805228, 672.8284287506655, 736.845262494882, 792.0732742691065, 798.9560574168361, 9357.344985851061, 9541.666041688508, 9702.51487425626, 10145.695629131138, 10301.0, 567.0600460179586, 633.5438484291303, 669.2303850571881, 740.9925900741032, 770.5184259837602, 4474.373587697725, 4898.167311557044, 4927.556519913153, 4999.375078115236, 5014.423341315723, 124439.0, 124574.37712811377, 128946.35526822493, 129964.0, 131170.0, 84989.0, 88853.0, 111509.0, 112917.0, 112978.0, 83323.5833820827, 83885.0, 84216.0, 84265.57867210625, 87481.56259218663, 9181.311401644769, 9968.900310996798, 10124.493775311057, 10133.783945926536, 10158.238132139972, 49417.50582494129, 50089.49910500849, 50661.49338506715, 51266.0, 52486.737566311924, 64856.0, 67206.0, 73980.63009684917, 74011.6299418521, 74134.62932685301, 12374.071944604011, 12786.168899021533, 13467.326633668474, 13494.595162145151, 13729.0, 13251.403686834308, 13605.795913061114, 13634.938721892415, 13725.245111518563, 13917.652058698613, 14761.92619036898, 14829.40682372693, 14852.7772083421, 15335.156566388956, 15687.607809804846, 13356.732865342834, 13556.322183890568, 13839.72320553563, 13841.377138029015, 13844.377003034686, 13997.341709768487, 14351.425942962165, 14641.0, 14642.780358294422, 15126.773098403753, 10765.730856728644, 10912.345259284468, 11265.324080555192, 11294.94352528232, 12041.217320874115, 10891.891081089405, 11008.834867476835, 12129.45417456199, 12316.815247771112, 12355.69110772238], "value": 7689.848237359065, "unit": "score"}], "name": "dromaeo_css", "value": 7370.327203867899, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 112.0, 107.0, 111.0, 113.0, 110.0, 118.0, 111.0, 110.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 118.0, 146.0, 182.0, 122.0, 154.0, 147.0, 118.0, 193.0, 122.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 160.0, 160.0, 162.0, 163.0, 161.0, 161.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 165.0, 77.0, 76.0, 75.0, 74.0, 171.0, 77.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 147.0, 87.0, 86.0, 84.0, 138.0, 89.0, 86.0, 155.0], "value": 104.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 145.0, 146.0, 145.0, 146.0, 148.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 51.0, 53.0, 51.0, 51.0, 53.0, 52.0, 52.0, 51.0], "value": 51.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 64.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 79.0, 79.0, 79.0, 81.0, 78.0, 78.0, 84.0, 82.0, 79.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 125.0, 130.0, 124.0, 134.0, 127.0, 125.0, 135.0, 158.0, 128.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 163.0, 162.0, 165.0, 165.0, 164.0, 164.0, 163.0, 165.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 64.0, 74.0, 66.0, 65.0, 64.0, 66.0, 65.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1530.0999999999997, "alertThreshold": 2.0}]} 08:33:49 INFO - Return code: 0 08:33:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:33:49 INFO - # TBPL SUCCESS # 08:33:49 INFO - Running post-action listener: _resource_record_post_action 08:33:49 INFO - [mozharness: 2016-08-23 15:33:49.946343Z] Finished run-tests step (success) 08:33:49 INFO - Running post-run listener: _resource_record_post_run 08:33:50 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 423763968; Read time: 12; Write time: 471024 08:33:50 INFO - TinderboxPrint: CPU usage
13.3% 08:33:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:33:50 INFO - TinderboxPrint: I/O write bytes / time
423,763,968 / 471,024 08:33:50 INFO - TinderboxPrint: CPU idle
8,277.5 (86.7%) 08:33:50 INFO - TinderboxPrint: CPU user
1,202.8 (12.6%) 08:33:50 INFO - TinderboxPrint: Swap in / out
0 / 0 08:33:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 134307840; Read time: 0; Write time: 142496 08:33:50 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288485376; Read time: 0; Write time: 328500 08:33:50 INFO - Running post-run listener: _upload_blobber_files 08:33:50 INFO - Blob upload gear active. 08:33:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:33:50 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 08:33:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:33:50 INFO - (blobuploader) - INFO - Open directory for files ... 08:33:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:33:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:33:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:51 INFO - (blobuploader) - INFO - Done attempting. 08:33:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:33:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:33:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:57 INFO - (blobuploader) - INFO - Done attempting. 08:33:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:33:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:33:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:57 INFO - (blobuploader) - INFO - Done attempting. 08:33:57 INFO - (blobuploader) - INFO - Iteration through files over. 08:33:57 INFO - Return code: 0 08:33:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:33:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:33:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df1324549b3003b9fb9d061a2c56b58f7149eee48dd6bc7201d89c1d93c43d9a861c09c47153ad347268ad0bcd0436e4702774a11bca41d554f3ad2a40be1f26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1107e771f88f3eeddcdc7de949336b71675f15eb28fe0af45db28845b524dc998962b664080208c203ca29d0e4dc1c2bd6fb676d8dc3d9b72307d664bf7dc907", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbed09f2d45b3d88f740cf50e5b7129c087ec2cea4e21188ee4c70035b864fdfd8feca603bb4ae7f32efce97e9e39b900ac35394d26df00b8a173fc316f52123"} 08:33:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:33:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:33:57 INFO - Contents: 08:33:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df1324549b3003b9fb9d061a2c56b58f7149eee48dd6bc7201d89c1d93c43d9a861c09c47153ad347268ad0bcd0436e4702774a11bca41d554f3ad2a40be1f26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1107e771f88f3eeddcdc7de949336b71675f15eb28fe0af45db28845b524dc998962b664080208c203ca29d0e4dc1c2bd6fb676d8dc3d9b72307d664bf7dc907", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbed09f2d45b3d88f740cf50e5b7129c087ec2cea4e21188ee4c70035b864fdfd8feca603bb4ae7f32efce97e9e39b900ac35394d26df00b8a173fc316f52123"} 08:33:57 INFO - Running post-run listener: copy_logs_to_upload_dir 08:33:57 INFO - Copying logs to upload dir... 08:33:57 INFO - mkdir: /builds/slave/test/build/upload/logs 08:33:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.811396 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-08-23 08:33:58.033697) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 08:33:58.038402) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df1324549b3003b9fb9d061a2c56b58f7149eee48dd6bc7201d89c1d93c43d9a861c09c47153ad347268ad0bcd0436e4702774a11bca41d554f3ad2a40be1f26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1107e771f88f3eeddcdc7de949336b71675f15eb28fe0af45db28845b524dc998962b664080208c203ca29d0e4dc1c2bd6fb676d8dc3d9b72307d664bf7dc907", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbed09f2d45b3d88f740cf50e5b7129c087ec2cea4e21188ee4c70035b864fdfd8feca603bb4ae7f32efce97e9e39b900ac35394d26df00b8a173fc316f52123"} build_url:https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011391 build_url: 'https://queue.taskcluster.net/v1/task/Z6GQlOfSQS20x2DWfitSqQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df1324549b3003b9fb9d061a2c56b58f7149eee48dd6bc7201d89c1d93c43d9a861c09c47153ad347268ad0bcd0436e4702774a11bca41d554f3ad2a40be1f26", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1107e771f88f3eeddcdc7de949336b71675f15eb28fe0af45db28845b524dc998962b664080208c203ca29d0e4dc1c2bd6fb676d8dc3d9b72307d664bf7dc907", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbed09f2d45b3d88f740cf50e5b7129c087ec2cea4e21188ee4c70035b864fdfd8feca603bb4ae7f32efce97e9e39b900ac35394d26df00b8a173fc316f52123"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 08:33:58.063494) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:33:58.063832) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1471964683.785696-679301431 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 08:33:58.148558) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 08:33:58.148879) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 08:33:58.149164) ========= ========= Total master_lag: 0.17 =========