builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1470333014.63 results: success (0) buildid: 20160804103422 builduid: d0f18a69a0694807900ea67b70a4096a revision: a0a49732aeb4ca43fa98c37cecc0c9fec5303e01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:14.626384) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:14.626985) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:14.627352) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:14.643478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:14.644011) ========= 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=41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 10:50: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.8M=0s 2016-08-04 10:50:14 (50.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104310 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:14.762615) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:14.762946) ========= 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=41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020309 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:14.813018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:14.813381) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a0a49732aeb4ca43fa98c37cecc0c9fec5303e01 --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 a0a49732aeb4ca43fa98c37cecc0c9fec5303e01 --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=41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 10:50:15,010 truncating revision to first 12 chars 2016-08-04 10:50:15,010 Setting DEBUG logging. 2016-08-04 10:50:15,010 attempt 1/10 2016-08-04 10:50:15,010 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a0a49732aeb4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 10:50:15,397 unpacking tar archive at: fx-team-a0a49732aeb4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.745892 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:15.573258) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:15.573591) ========= script_repo_revision: a0a49732aeb4ca43fa98c37cecc0c9fec5303e01 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:15.574064) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:15.574402) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 10:50:15.586109) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2016-08-04 10:50:15.586522) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:50:15 INFO - MultiFileLogger online at 20160804 10:50:15 in /builds/slave/test 10:50:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:50:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:50:15 INFO - {'append_to_log': False, 10:50:15 INFO - 'base_work_dir': '/builds/slave/test', 10:50:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:50:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:50:15 INFO - 'branch': 'Fx-Team-Non-PGO', 10:50:15 INFO - 'buildbot_json_path': 'buildprops.json', 10:50:15 INFO - 'config_files': ('talos/linux_config.py',), 10:50:15 INFO - 'default_actions': ('clobber', 10:50:15 INFO - 'read-buildbot-config', 10:50:15 INFO - 'download-and-extract', 10:50:15 INFO - 'populate-webroot', 10:50:15 INFO - 'create-virtualenv', 10:50:15 INFO - 'install', 10:50:15 INFO - 'run-tests'), 10:50:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:50:15 INFO - 'download_minidump_stackwalk': True, 10:50:15 INFO - 'download_symbols': 'ondemand', 10:50:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:50:15 INFO - 'tooltool.py': '/tools/tooltool.py', 10:50:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:50:15 INFO - '/tools/misc-python/virtualenv.py')}, 10:50:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:50:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:50:15 INFO - 'installer_path': 'installer.exe', 10:50:15 INFO - 'log_level': 'info', 10:50:15 INFO - 'log_name': 'talos', 10:50:15 INFO - 'log_to_console': True, 10:50:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:50:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:50:15 INFO - 'opt_config_files': (), 10:50:15 INFO - 'pip_index': False, 10:50:15 INFO - 'sps_profile': False, 10:50:15 INFO - 'sps_profile_interval': 0, 10:50:15 INFO - 'suite': 'dromaeojs', 10:50:15 INFO - 'system_bits': '32', 10:50:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:50:15 INFO - 'title': 'talos-linux64-ix-026', 10:50:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:50:15 INFO - 'use_talos_json': True, 10:50:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:50:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:50:15 INFO - 'work_dir': 'build'} 10:50:15 INFO - [mozharness: 2016-08-04 17:50:15.876641Z] Running clobber step. 10:50:15 INFO - Running pre-action listener: _resource_record_pre_action 10:50:15 INFO - Running main action method: clobber 10:50:15 INFO - rmtree: /builds/slave/test/build 10:50:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:50:16 INFO - Running post-action listener: _resource_record_post_action 10:50:16 INFO - [mozharness: 2016-08-04 17:50:16.328945Z] Finished clobber step (success) 10:50:16 INFO - [mozharness: 2016-08-04 17:50:16.329045Z] Running read-buildbot-config step. 10:50:16 INFO - Running pre-action listener: _resource_record_pre_action 10:50:16 INFO - Running main action method: read_buildbot_config 10:50:16 INFO - Using buildbot properties: 10:50:16 INFO - { 10:50:16 INFO - "project": "", 10:50:16 INFO - "product": "firefox", 10:50:16 INFO - "script_repo_revision": "production", 10:50:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:50:16 INFO - "repository": "", 10:50:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:50:16 INFO - "buildid": "20160804103422", 10:50:16 INFO - "pgo_build": "False", 10:50:16 INFO - "basedir": "/builds/slave/test", 10:50:16 INFO - "buildnumber": 1851, 10:50:16 INFO - "slavename": "talos-linux64-ix-026", 10:50:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:50:16 INFO - "platform": "ubuntu64_hw", 10:50:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:50:16 INFO - "branch": "fx-team", 10:50:16 INFO - "repo_path": "integration/fx-team", 10:50:16 INFO - "revision": "a0a49732aeb4ca43fa98c37cecc0c9fec5303e01", 10:50:16 INFO - "stage_platform": "linux64", 10:50:16 INFO - "builduid": "d0f18a69a0694807900ea67b70a4096a", 10:50:16 INFO - "slavebuilddir": "test" 10:50:16 INFO - } 10:50:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:50:16 INFO - Running post-action listener: _resource_record_post_action 10:50:16 INFO - [mozharness: 2016-08-04 17:50:16.331523Z] Finished read-buildbot-config step (success) 10:50:16 INFO - [mozharness: 2016-08-04 17:50:16.331615Z] Running download-and-extract step. 10:50:16 INFO - Running pre-action listener: _resource_record_pre_action 10:50:16 INFO - Running main action method: download_and_extract 10:50:16 INFO - mkdir: /builds/slave/test/build/tests 10:50: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')]} 10:50:16 INFO - trying https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:50:16 INFO - Downloading https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/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 10:50:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/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 10:50:16 INFO - Downloaded 1361 bytes. 10:50:16 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:50:16 INFO - Using the following test package requirements: 10:50:16 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:50:16 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:50:16 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:50:16 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:16 INFO - u'jsshell-linux-x86_64.zip'], 10:50:16 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:50:16 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:50:16 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:50:16 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:50:16 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:50:16 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:50:16 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:50:16 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:50: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')]} 10:50:16 INFO - trying https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:50:16 INFO - Downloading https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/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 10:50:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/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 10:50:19 INFO - Downloaded 20249623 bytes. 10:50:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:50:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:50:20 INFO - Return code: 0 10:50:20 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 10:50:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:20 INFO - trying https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:50:20 INFO - Downloading https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/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 10:50:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/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 10:50:52 WARNING - Socket error when accessing https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip: The read operation timed out 10:50:52 INFO - retry: attempt #1 caught exception: The read operation timed out 10:50:52 INFO - retry: Failed, sleeping 30 seconds before retrying 10:51:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/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 #2 10:51:23 INFO - Downloaded 20249623 bytes. 10:51:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:51:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:51:24 INFO - Return code: 0 10:51:24 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')]} 10:51:24 INFO - trying https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:51:24 INFO - Downloading https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/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 10:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/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 10:51:25 INFO - Downloaded 14413723 bytes. 10:51:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:51:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:51:26 INFO - Return code: 0 10:51:26 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')]} 10:51:26 INFO - trying https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:51:26 INFO - Downloading https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/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 10:51:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/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 10:51:27 INFO - Downloaded 55519316 bytes. 10:51:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:51:27 INFO - mkdir: /builds/slave/test/properties 10:51:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:51:27 INFO - Writing to file /builds/slave/test/properties/build_url 10:51:27 INFO - Contents: 10:51:27 INFO - build_url:https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:51:27 INFO - Running post-action listener: _resource_record_post_action 10:51:27 INFO - Running post-action listener: set_extra_try_arguments 10:51:27 INFO - [mozharness: 2016-08-04 17:51:27.869437Z] Finished download-and-extract step (success) 10:51:27 INFO - [mozharness: 2016-08-04 17:51:27.869756Z] Running populate-webroot step. 10:51:27 INFO - Running pre-action listener: _resource_record_pre_action 10:51:27 INFO - Running main action method: populate_webroot 10:51:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:51:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:51:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:51:27 INFO - '--tppagecycles', 10:51:27 INFO - '7'], 10:51:27 INFO - 'tests': ['tsvgm']}}, 10:51:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:51:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:51:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:51:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:51:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:51:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:51:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:27 INFO - 'talos_options': ['--disable-e10s'], 10:51:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:27 INFO - 'talos_options': ['--disable-e10s'], 10:51:27 INFO - 'tests': ['damp', 'tps']}, 10:51:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:27 INFO - 'tests': ['damp', 'tps']}, 10:51:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:51:27 INFO - 'tests': ['dromaeo_dom']}, 10:51:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:51:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:51:27 INFO - 'tests': ['basic_compositor_video']}, 10:51:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:51:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:51:27 INFO - 'tests': ['a11yr', 10:51:27 INFO - 'ts_paint', 10:51:27 INFO - 'tpaint', 10:51:27 INFO - 'sessionrestore', 10:51:27 INFO - 'sessionrestore_no_auto_restore', 10:51:27 INFO - 'tabpaint']}, 10:51:27 INFO - 'other-e10s': {'tests': ['a11yr', 10:51:27 INFO - 'ts_paint', 10:51:27 INFO - 'tpaint', 10:51:27 INFO - 'sessionrestore', 10:51:27 INFO - 'sessionrestore_no_auto_restore', 10:51:27 INFO - 'tabpaint']}, 10:51:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:51:27 INFO - 'ts_paint', 10:51:27 INFO - 'tpaint', 10:51:27 INFO - 'sessionrestore', 10:51:27 INFO - 'sessionrestore_no_auto_restore', 10:51:27 INFO - 'tabpaint']}, 10:51:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:51:27 INFO - 'ts_paint', 10:51:27 INFO - 'tpaint', 10:51:27 INFO - 'sessionrestore', 10:51:27 INFO - 'sessionrestore_no_auto_restore', 10:51:27 INFO - 'tabpaint']}, 10:51:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:51:27 INFO - 'tests': ['a11yr', 10:51:27 INFO - 'ts_paint', 10:51:27 INFO - 'tpaint', 10:51:27 INFO - 'sessionrestore', 10:51:27 INFO - 'sessionrestore_no_auto_restore', 10:51:27 INFO - 'tabpaint']}, 10:51:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:51:27 INFO - 'tests': ['a11yr', 10:51:27 INFO - 'ts_paint', 10:51:27 INFO - 'tpaint', 10:51:27 INFO - 'sessionrestore', 10:51:27 INFO - 'sessionrestore_no_auto_restore', 10:51:27 INFO - 'tabpaint']}, 10:51:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:51:27 INFO - 'tests': ['tsvgx', 10:51:27 INFO - 'tsvgr_opacity', 10:51:27 INFO - 'tart', 10:51:27 INFO - 'tscrollx', 10:51:27 INFO - 'cart']}, 10:51:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:51:27 INFO - 'tsvgr_opacity', 10:51:27 INFO - 'tart', 10:51:27 INFO - 'tscrollx', 10:51:27 INFO - 'cart']}, 10:51:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:27 INFO - 'talos_options': ['--disable-e10s'], 10:51:27 INFO - 'tests': ['tp5o']}, 10:51:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:27 INFO - 'tests': ['tp5o']}, 10:51:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:27 INFO - 'talos_options': ['--disable-e10s', 10:51:27 INFO - '--xperf_path', 10:51:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:27 INFO - 'tests': ['tp5n']}, 10:51:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:27 INFO - 'talos_options': ['--xperf_path', 10:51:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:27 INFO - 'tests': ['tp5n']}}, 10:51:27 INFO - 'talos.zip': {'path': '', 10:51:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:51:27 INFO - Running post-action listener: _resource_record_post_action 10:51:27 INFO - [mozharness: 2016-08-04 17:51:27.887988Z] Finished populate-webroot step (success) 10:51:27 INFO - [mozharness: 2016-08-04 17:51:27.888078Z] Running create-virtualenv step. 10:51:27 INFO - Running pre-action listener: _resource_record_pre_action 10:51:27 INFO - Running main action method: create_virtualenv 10:51:27 INFO - Creating virtualenv /builds/slave/test/build/venv 10:51:27 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 10:51:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:51:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:51:28 INFO - Using real prefix '/usr' 10:51:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:51:28 INFO - Installing distribute.............................................................................................................................................................................................done. 10:51:30 INFO - Installing pip.................done. 10:51:30 INFO - Return code: 0 10:51:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:51:30 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')]} 10:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:30 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')]} 10:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:30 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 0x10d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1397180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13953b0>, '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 0x13962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396740>, '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': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', '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 10:51:30 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 10:51:30 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 10:51:30 INFO - Using env: {'DISPLAY': ':0', 10:51:30 INFO - 'HOME': '/home/cltbld', 10:51:30 INFO - 'LANG': 'en_US.UTF-8', 10:51:30 INFO - 'LANGUAGE': 'en_US:en', 10:51:30 INFO - 'LOGNAME': 'cltbld', 10:51:30 INFO - 'MAIL': '/var/mail/cltbld', 10:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:30 INFO - 'MOZ_NO_REMOTE': '1', 10:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:30 INFO - 'NO_EM_RESTART': '1', 10:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:30 INFO - 'PWD': '/builds/slave/test', 10:51:30 INFO - 'SHELL': '/bin/bash', 10:51:30 INFO - 'SHLVL': '1', 10:51:30 INFO - 'TERM': 'linux', 10:51:30 INFO - 'TMOUT': '86400', 10:51:30 INFO - 'USER': 'cltbld', 10:51:30 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', 10:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:30 INFO - '_': '/tools/buildbot/bin/python'} 10:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:30 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 10:51:30 INFO - Cleaning up... 10:51:30 INFO - Return code: 0 10:51:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:51:30 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')]} 10:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:30 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')]} 10:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:30 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 0x10d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1397180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13953b0>, '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 0x13962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396740>, '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': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', '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 10:51:30 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 10:51:30 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 10:51:30 INFO - Using env: {'DISPLAY': ':0', 10:51:30 INFO - 'HOME': '/home/cltbld', 10:51:30 INFO - 'LANG': 'en_US.UTF-8', 10:51:30 INFO - 'LANGUAGE': 'en_US:en', 10:51:30 INFO - 'LOGNAME': 'cltbld', 10:51:30 INFO - 'MAIL': '/var/mail/cltbld', 10:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:30 INFO - 'MOZ_NO_REMOTE': '1', 10:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:30 INFO - 'NO_EM_RESTART': '1', 10:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:30 INFO - 'PWD': '/builds/slave/test', 10:51:30 INFO - 'SHELL': '/bin/bash', 10:51:30 INFO - 'SHLVL': '1', 10:51:30 INFO - 'TERM': 'linux', 10:51:30 INFO - 'TMOUT': '86400', 10:51:30 INFO - 'USER': 'cltbld', 10:51:30 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', 10:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:30 INFO - '_': '/tools/buildbot/bin/python'} 10:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:30 INFO - Downloading/unpacking psutil>=3.1.1 10:51:30 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 10:51:30 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 10:51:30 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 10:51:30 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 10:51:30 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 10:51:30 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 10:51:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:51:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:32 INFO - Installing collected packages: psutil 10:51:32 INFO - Running setup.py install for psutil 10:51:32 INFO - building 'psutil._psutil_linux' extension 10:51:32 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 10:51:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:51:33 INFO - building 'psutil._psutil_posix' extension 10:51:33 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 10:51:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:51:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:33 INFO - Successfully installed psutil 10:51:33 INFO - Cleaning up... 10:51:33 INFO - Return code: 0 10:51:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:51: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')]} 10:51:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1397180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13953b0>, '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 0x13962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396740>, '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': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', '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 10:51: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:51: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 mozsystemmonitor==0.3 10:51:33 INFO - Using env: {'DISPLAY': ':0', 10:51:33 INFO - 'HOME': '/home/cltbld', 10:51:33 INFO - 'LANG': 'en_US.UTF-8', 10:51:33 INFO - 'LANGUAGE': 'en_US:en', 10:51:33 INFO - 'LOGNAME': 'cltbld', 10:51:33 INFO - 'MAIL': '/var/mail/cltbld', 10:51:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:33 INFO - 'MOZ_NO_REMOTE': '1', 10:51:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:33 INFO - 'NO_EM_RESTART': '1', 10:51:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:33 INFO - 'PWD': '/builds/slave/test', 10:51:33 INFO - 'SHELL': '/bin/bash', 10:51:33 INFO - 'SHLVL': '1', 10:51:33 INFO - 'TERM': 'linux', 10:51:33 INFO - 'TMOUT': '86400', 10:51:33 INFO - 'USER': 'cltbld', 10:51:33 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', 10:51:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:33 INFO - '_': '/tools/buildbot/bin/python'} 10:51:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:51:35 INFO - Installing collected packages: mozsystemmonitor 10:51:35 INFO - Running setup.py install for mozsystemmonitor 10:51:35 INFO - Successfully installed mozsystemmonitor 10:51:35 INFO - Cleaning up... 10:51:35 INFO - Return code: 0 10:51:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:51: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')]} 10:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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', '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 0x10d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1397180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13953b0>, '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 0x13962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396740>, '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': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', '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 10:51: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:51: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 jsonschema==2.5.1 10:51:35 INFO - Using env: {'DISPLAY': ':0', 10:51:35 INFO - 'HOME': '/home/cltbld', 10:51:35 INFO - 'LANG': 'en_US.UTF-8', 10:51:35 INFO - 'LANGUAGE': 'en_US:en', 10:51:35 INFO - 'LOGNAME': 'cltbld', 10:51:35 INFO - 'MAIL': '/var/mail/cltbld', 10:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:35 INFO - 'MOZ_NO_REMOTE': '1', 10:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:35 INFO - 'NO_EM_RESTART': '1', 10:51:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:35 INFO - 'PWD': '/builds/slave/test', 10:51:35 INFO - 'SHELL': '/bin/bash', 10:51:35 INFO - 'SHLVL': '1', 10:51:35 INFO - 'TERM': 'linux', 10:51:35 INFO - 'TMOUT': '86400', 10:51:35 INFO - 'USER': 'cltbld', 10:51:35 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', 10:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:35 INFO - '_': '/tools/buildbot/bin/python'} 10:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:35 INFO - Downloading/unpacking jsonschema==2.5.1 10:51:35 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 10:51:35 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 10:51:35 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 10:51:35 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 10:51:35 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 10:51:35 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 10:51:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:51:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:38 INFO - Downloading functools32-3.2.3-2.tar.gz 10:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:51:38 INFO - warning: no files found matching '*.txt' 10:51:38 INFO - no previously-included directories found matching 'build' 10:51:38 INFO - no previously-included directories found matching 'dist' 10:51:38 INFO - no previously-included directories found matching '.git*' 10:51:38 INFO - Installing collected packages: jsonschema, functools32 10:51:38 INFO - Running setup.py install for functools32 10:51:38 INFO - warning: no files found matching '*.txt' 10:51:38 INFO - no previously-included directories found matching 'build' 10:51:38 INFO - no previously-included directories found matching 'dist' 10:51:38 INFO - no previously-included directories found matching '.git*' 10:51:38 INFO - Successfully installed jsonschema functools32 10:51:38 INFO - Cleaning up... 10:51:38 INFO - Return code: 0 10:51:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:51: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')]} 10:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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', '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 0x10d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1397180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13953b0>, '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 0x13962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396740>, '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': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', '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 10:51: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:51: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 functools32==3.2.3-2 10:51:38 INFO - Using env: {'DISPLAY': ':0', 10:51:38 INFO - 'HOME': '/home/cltbld', 10:51:38 INFO - 'LANG': 'en_US.UTF-8', 10:51:38 INFO - 'LANGUAGE': 'en_US:en', 10:51:38 INFO - 'LOGNAME': 'cltbld', 10:51:38 INFO - 'MAIL': '/var/mail/cltbld', 10:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:38 INFO - 'MOZ_NO_REMOTE': '1', 10:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:38 INFO - 'NO_EM_RESTART': '1', 10:51:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:38 INFO - 'PWD': '/builds/slave/test', 10:51:38 INFO - 'SHELL': '/bin/bash', 10:51:38 INFO - 'SHLVL': '1', 10:51:38 INFO - 'TERM': 'linux', 10:51:38 INFO - 'TMOUT': '86400', 10:51:38 INFO - 'USER': 'cltbld', 10:51:38 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', 10:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:38 INFO - '_': '/tools/buildbot/bin/python'} 10:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:51:38 INFO - Cleaning up... 10:51:38 INFO - Return code: 0 10:51:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:51: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')]} 10:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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', '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 0x10d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1397180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13953b0>, '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 0x13962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396740>, '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': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', '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 10:51: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:51: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 blobuploader==1.2.4 10:51:38 INFO - Using env: {'DISPLAY': ':0', 10:51:38 INFO - 'HOME': '/home/cltbld', 10:51:38 INFO - 'LANG': 'en_US.UTF-8', 10:51:38 INFO - 'LANGUAGE': 'en_US:en', 10:51:38 INFO - 'LOGNAME': 'cltbld', 10:51:38 INFO - 'MAIL': '/var/mail/cltbld', 10:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:38 INFO - 'MOZ_NO_REMOTE': '1', 10:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:38 INFO - 'NO_EM_RESTART': '1', 10:51:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:38 INFO - 'PWD': '/builds/slave/test', 10:51:38 INFO - 'SHELL': '/bin/bash', 10:51:38 INFO - 'SHLVL': '1', 10:51:38 INFO - 'TERM': 'linux', 10:51:38 INFO - 'TMOUT': '86400', 10:51:38 INFO - 'USER': 'cltbld', 10:51:38 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', 10:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:38 INFO - '_': '/tools/buildbot/bin/python'} 10:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:38 INFO - Downloading/unpacking blobuploader==1.2.4 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51:40 INFO - Downloading blobuploader-1.2.4.tar.gz 10:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:51:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:51:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51:41 INFO - Downloading docopt-0.6.1.tar.gz 10:51:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:51:41 INFO - Installing collected packages: blobuploader, requests, docopt 10:51:41 INFO - Running setup.py install for blobuploader 10:51:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:51:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:51:41 INFO - Running setup.py install for requests 10:51:41 INFO - Running setup.py install for docopt 10:51:41 INFO - Successfully installed blobuploader requests docopt 10:51:41 INFO - Cleaning up... 10:51:42 INFO - Return code: 0 10:51:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:42 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 0x10d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1397180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13953b0>, '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 0x13962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396740>, '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': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', '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 10:51:42 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 10:51:42 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 10:51:42 INFO - Using env: {'DISPLAY': ':0', 10:51:42 INFO - 'HOME': '/home/cltbld', 10:51:42 INFO - 'LANG': 'en_US.UTF-8', 10:51:42 INFO - 'LANGUAGE': 'en_US:en', 10:51:42 INFO - 'LOGNAME': 'cltbld', 10:51:42 INFO - 'MAIL': '/var/mail/cltbld', 10:51:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:42 INFO - 'MOZ_NO_REMOTE': '1', 10:51:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:42 INFO - 'NO_EM_RESTART': '1', 10:51:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:42 INFO - 'PWD': '/builds/slave/test', 10:51:42 INFO - 'SHELL': '/bin/bash', 10:51:42 INFO - 'SHLVL': '1', 10:51:42 INFO - 'TERM': 'linux', 10:51:42 INFO - 'TMOUT': '86400', 10:51:42 INFO - 'USER': 'cltbld', 10:51:42 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', 10:51:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:42 INFO - '_': '/tools/buildbot/bin/python'} 10:51:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:51:42 INFO - Running setup.py (path:/tmp/pip-4PV3uC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:51:42 INFO - Running setup.py (path:/tmp/pip-2d48Yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:51:42 INFO - Running setup.py (path:/tmp/pip-YlHcRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:51:42 INFO - Running setup.py (path:/tmp/pip-tBwNaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:51:42 INFO - Running setup.py (path:/tmp/pip-WhwKpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:51:42 INFO - Running setup.py (path:/tmp/pip-XFqRTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:51:42 INFO - Running setup.py (path:/tmp/pip-0kRsE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:51:42 INFO - Running setup.py (path:/tmp/pip-be10GQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:51:42 INFO - Running setup.py (path:/tmp/pip-S19ejC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:51:42 INFO - Running setup.py (path:/tmp/pip-220nOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:51:42 INFO - Running setup.py (path:/tmp/pip-HVOK0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:51:43 INFO - Running setup.py (path:/tmp/pip-ONQB_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:51:43 INFO - Running setup.py (path:/tmp/pip-oErO9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:51:43 INFO - Running setup.py (path:/tmp/pip-qpVdd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:43 INFO - Running setup.py (path:/tmp/pip-jxsB4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:51:43 INFO - Running setup.py (path:/tmp/pip-17QvyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:51:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:51:43 INFO - Running setup.py (path:/tmp/pip-gFy3Ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:51:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:51:43 INFO - Running setup.py install for manifestparser 10:51:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:51:43 INFO - Running setup.py install for mozcrash 10:51:43 INFO - Running setup.py install for mozdebug 10:51:43 INFO - Running setup.py install for mozdevice 10:51:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:51:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:51:43 INFO - Running setup.py install for mozfile 10:51:43 INFO - Running setup.py install for mozhttpd 10:51:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Running setup.py install for mozinfo 10:51:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Running setup.py install for mozInstall 10:51:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Running setup.py install for mozleak 10:51:44 INFO - Running setup.py install for mozlog 10:51:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Running setup.py install for moznetwork 10:51:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Running setup.py install for mozprocess 10:51:44 INFO - Running setup.py install for mozprofile 10:51:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Running setup.py install for mozrunner 10:51:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:51:44 INFO - Running setup.py install for mozscreenshot 10:51:45 INFO - Running setup.py install for moztest 10:51:45 INFO - Running setup.py install for mozversion 10:51:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:51:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:51:45 INFO - Cleaning up... 10:51:45 INFO - Return code: 0 10:51:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:45 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 0x10d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1397180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13953b0>, '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 0x13962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396740>, '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': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', '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 10:51:45 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 10:51:45 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 10:51:45 INFO - Using env: {'DISPLAY': ':0', 10:51:45 INFO - 'HOME': '/home/cltbld', 10:51:45 INFO - 'LANG': 'en_US.UTF-8', 10:51:45 INFO - 'LANGUAGE': 'en_US:en', 10:51:45 INFO - 'LOGNAME': 'cltbld', 10:51:45 INFO - 'MAIL': '/var/mail/cltbld', 10:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:45 INFO - 'MOZ_NO_REMOTE': '1', 10:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:45 INFO - 'NO_EM_RESTART': '1', 10:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:45 INFO - 'PWD': '/builds/slave/test', 10:51:45 INFO - 'SHELL': '/bin/bash', 10:51:45 INFO - 'SHLVL': '1', 10:51:45 INFO - 'TERM': 'linux', 10:51:45 INFO - 'TMOUT': '86400', 10:51:45 INFO - 'USER': 'cltbld', 10:51:45 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', 10:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:45 INFO - '_': '/tools/buildbot/bin/python'} 10:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:51:45 INFO - Running setup.py (path:/tmp/pip-sGXdfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:51:45 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)) 10:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:51:45 INFO - Running setup.py (path:/tmp/pip-60ppo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:51:45 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)) 10:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:51:45 INFO - Running setup.py (path:/tmp/pip-CoHPuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:51:45 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)) 10:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:51:45 INFO - Running setup.py (path:/tmp/pip-B6Z5dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:51:45 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)) 10:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:51:45 INFO - Running setup.py (path:/tmp/pip-ytchir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:51:45 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)) 10:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:51:45 INFO - Running setup.py (path:/tmp/pip-jHdac6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:51:45 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)) 10:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:51:45 INFO - Running setup.py (path:/tmp/pip-ZhHzl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:51:45 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)) 10:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:51:45 INFO - Running setup.py (path:/tmp/pip-RLjcCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:51:46 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)) 10:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:51:46 INFO - Running setup.py (path:/tmp/pip-Jqe7CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:51:46 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)) 10:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:51:46 INFO - Running setup.py (path:/tmp/pip-fB_l_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:51:46 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)) 10:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:51:46 INFO - Running setup.py (path:/tmp/pip-LyQDAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:51:46 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)) 10:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:51:46 INFO - Running setup.py (path:/tmp/pip-G2f7bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:51:46 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)) 10:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:51:46 INFO - Running setup.py (path:/tmp/pip-C6ruek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:51:46 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)) 10:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:51:46 INFO - Running setup.py (path:/tmp/pip-y80Rjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:51:46 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)) 10:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:46 INFO - Running setup.py (path:/tmp/pip-hF4GbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:46 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)) 10:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:51:46 INFO - Running setup.py (path:/tmp/pip-QteAiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:51:46 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)) 10:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:51:46 INFO - Running setup.py (path:/tmp/pip-c0UVyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:51:46 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)) 10:51:46 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)) 10:51:46 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)) 10:51:46 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)) 10:51:46 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)) 10:51:46 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)) 10:51:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:51:46 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 10:51:46 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 10:51:46 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 10:51:46 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 10:51:46 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 10:51:46 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 10:51:48 INFO - Downloading blessings-1.6.tar.gz 10:51:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:51:48 INFO - Installing collected packages: blessings 10:51:48 INFO - Running setup.py install for blessings 10:51:48 INFO - Successfully installed blessings 10:51:48 INFO - Cleaning up... 10:51:48 INFO - Return code: 0 10:51:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:51:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:51:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:51:49 INFO - Reading from file tmpfile_stdout 10:51:49 INFO - Current package versions: 10:51:49 INFO - argparse == 1.2.1 10:51:49 INFO - blessings == 1.6 10:51:49 INFO - blobuploader == 1.2.4 10:51:49 INFO - docopt == 0.6.1 10:51:49 INFO - functools32 == 3.2.3-2 10:51:49 INFO - jsonschema == 2.5.1 10:51:49 INFO - manifestparser == 1.1 10:51:49 INFO - mozInstall == 1.12 10:51:49 INFO - mozcrash == 0.17 10:51:49 INFO - mozdebug == 0.1 10:51:49 INFO - mozdevice == 0.48 10:51:49 INFO - mozfile == 1.2 10:51:49 INFO - mozhttpd == 0.7 10:51:49 INFO - mozinfo == 0.9 10:51:49 INFO - mozleak == 0.1 10:51:49 INFO - mozlog == 3.3 10:51:49 INFO - moznetwork == 0.27 10:51:49 INFO - mozprocess == 0.23 10:51:49 INFO - mozprofile == 0.28 10:51:49 INFO - mozrunner == 6.12 10:51:49 INFO - mozscreenshot == 0.1 10:51:49 INFO - mozsystemmonitor == 0.3 10:51:49 INFO - moztest == 0.7 10:51:49 INFO - mozversion == 1.4 10:51:49 INFO - psutil == 3.1.1 10:51:49 INFO - requests == 1.2.3 10:51:49 INFO - wsgiref == 0.1.2 10:51:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:49 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')]} 10:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:49 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')]} 10:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:49 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 0x10d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1397180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13953b0>, '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 0x13962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396740>, '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': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', '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 10:51:49 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 10:51:49 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 10:51:49 INFO - Using env: {'DISPLAY': ':0', 10:51:49 INFO - 'HOME': '/home/cltbld', 10:51:49 INFO - 'LANG': 'en_US.UTF-8', 10:51:49 INFO - 'LANGUAGE': 'en_US:en', 10:51:49 INFO - 'LOGNAME': 'cltbld', 10:51:49 INFO - 'MAIL': '/var/mail/cltbld', 10:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:49 INFO - 'MOZ_NO_REMOTE': '1', 10:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:49 INFO - 'NO_EM_RESTART': '1', 10:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:49 INFO - 'PWD': '/builds/slave/test', 10:51:49 INFO - 'SHELL': '/bin/bash', 10:51:49 INFO - 'SHLVL': '1', 10:51:49 INFO - 'TERM': 'linux', 10:51:49 INFO - 'TMOUT': '86400', 10:51:49 INFO - 'USER': 'cltbld', 10:51:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', 10:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:49 INFO - '_': '/tools/buildbot/bin/python'} 10:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:49 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)) 10:51:49 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)) 10:51:49 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)) 10:51:49 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)) 10:51:49 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)) 10:51:49 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)) 10:51:49 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)) 10:51:49 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)) 10:51:49 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)) 10:51:49 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)) 10:51:49 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)) 10:51:49 INFO - Cleaning up... 10:51:49 INFO - Return code: 0 10:51:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:51:49 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')]} 10:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:49 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')]} 10:51:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:49 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 0x10d6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1397180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13953b0>, '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 0x13962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396740>, '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': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', '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 10:51:49 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 10:51:49 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 10:51:49 INFO - Using env: {'DISPLAY': ':0', 10:51:49 INFO - 'HOME': '/home/cltbld', 10:51:49 INFO - 'LANG': 'en_US.UTF-8', 10:51:49 INFO - 'LANGUAGE': 'en_US:en', 10:51:49 INFO - 'LOGNAME': 'cltbld', 10:51:49 INFO - 'MAIL': '/var/mail/cltbld', 10:51:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:49 INFO - 'MOZ_NO_REMOTE': '1', 10:51:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:49 INFO - 'NO_EM_RESTART': '1', 10:51:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:49 INFO - 'PWD': '/builds/slave/test', 10:51:49 INFO - 'SHELL': '/bin/bash', 10:51:49 INFO - 'SHLVL': '1', 10:51:49 INFO - 'TERM': 'linux', 10:51:49 INFO - 'TMOUT': '86400', 10:51:49 INFO - 'USER': 'cltbld', 10:51:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', 10:51:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:49 INFO - '_': '/tools/buildbot/bin/python'} 10:51:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:51:49 INFO - Cleaning up... 10:51:49 INFO - Return code: 0 10:51:49 INFO - Running post-action listener: _resource_record_post_action 10:51:49 INFO - Running post-action listener: _start_resource_monitoring 10:51:49 INFO - Starting resource monitoring. 10:51:49 INFO - [mozharness: 2016-08-04 17:51:49.552026Z] Finished create-virtualenv step (success) 10:51:49 INFO - [mozharness: 2016-08-04 17:51:49.552513Z] Running install step. 10:51:49 INFO - Running pre-action listener: _resource_record_pre_action 10:51:49 INFO - Running main action method: install 10:51:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:51:49 INFO - Reading from file tmpfile_stdout 10:51:49 INFO - Detecting whether we're running mozinstall >=1.0... 10:51:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:51:49 INFO - Reading from file tmpfile_stdout 10:51:49 INFO - Output received: 10:51:49 INFO - Usage: mozinstall [options] installer 10:51:49 INFO - Options: 10:51:49 INFO - -h, --help show this help message and exit 10:51:49 INFO - -d DEST, --destination=DEST 10:51:49 INFO - Directory to install application into. [default: 10:51:49 INFO - "/builds/slave/test"] 10:51:49 INFO - --app=APP Application being installed. [default: firefox] 10:51:49 INFO - mkdir: /builds/slave/test/build/application 10:51:49 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'] 10:51:49 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 10:52:05 INFO - Reading from file tmpfile_stdout 10:52:05 INFO - Output received: 10:52:05 INFO - /builds/slave/test/build/application/firefox/firefox 10:52:05 INFO - Running post-action listener: _resource_record_post_action 10:52:05 INFO - [mozharness: 2016-08-04 17:52:05.837894Z] Finished install step (success) 10:52:05 INFO - [mozharness: 2016-08-04 17:52:05.838229Z] Running run-tests step. 10:52:05 INFO - Running pre-action listener: _resource_record_pre_action 10:52:05 INFO - Running main action method: run_tests 10:52:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:52:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:52:05 INFO - Python 2.7.3 10:52:05 INFO - Return code: 0 10:52:05 INFO - grabbing minidump binary from tooltool 10:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:05 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13953b0>, '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 0x13962b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1396740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:52:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:52:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:52:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:52:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:52:05 INFO - Return code: 0 10:52:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:52:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:52:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:52:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:52:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:52:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 10:52:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 10:52:05 INFO - Using env: {'DISPLAY': ':0', 10:52:05 INFO - 'HOME': '/home/cltbld', 10:52:05 INFO - 'LANG': 'en_US.UTF-8', 10:52:05 INFO - 'LANGUAGE': 'en_US:en', 10:52:05 INFO - 'LOGNAME': 'cltbld', 10:52:05 INFO - 'MAIL': '/var/mail/cltbld', 10:52:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:52:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:05 INFO - 'MOZ_NO_REMOTE': '1', 10:52:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:05 INFO - 'NO_EM_RESTART': '1', 10:52:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:05 INFO - 'PWD': '/builds/slave/test', 10:52:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:52:05 INFO - 'SHELL': '/bin/bash', 10:52:05 INFO - 'SHLVL': '1', 10:52:05 INFO - 'TERM': 'linux', 10:52:05 INFO - 'TMOUT': '86400', 10:52:05 INFO - 'USER': 'cltbld', 10:52:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541', 10:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:05 INFO - '_': '/tools/buildbot/bin/python'} 10:52:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 10:52:06 INFO - mozversion application_buildid: 20160804103422 10:52:06 INFO - mozversion application_changeset: a0a49732aeb4ca43fa98c37cecc0c9fec5303e01 10:52:06 INFO - mozversion application_display_name: Nightly 10:52:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:52:06 INFO - mozversion application_name: Firefox 10:52:06 INFO - mozversion application_remotingname: firefox 10:52:06 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:52:06 INFO - mozversion application_vendor: Mozilla 10:52:06 INFO - mozversion application_version: 51.0a1 10:52:06 INFO - mozversion platform_buildid: 20160804103422 10:52:06 INFO - mozversion platform_changeset: a0a49732aeb4ca43fa98c37cecc0c9fec5303e01 10:52:06 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:52:06 INFO - mozversion platform_version: 51.0a1 10:52:06 INFO - using testdate: 1470333126 10:52:06 INFO - actual date: 1470333126 10:52:06 INFO - starting webserver on 'localhost:35431' 10:52:06 INFO - SUITE-START | Running 2 tests 10:52:06 INFO - TEST-START | dromaeo_css 10:52:06 INFO - operating with platform_type : linux_ 10:52:06 INFO - Initialising browser for dromaeo_css test... 10:52:06 INFO - TEST-INFO | started process 17589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpihCvOa/profile http://localhost:35431/getInfo.html) 10:52:10 INFO - PROCESS | 17589 | __metrics Screen width/height:1600/1200 10:52:10 INFO - PROCESS | 17589 | colorDepth:24 10:52:10 INFO - PROCESS | 17589 | Browser inner width/height: 1024/697 10:52:10 INFO - PROCESS | 17589 | __metrics 10:52:11 INFO - PROCESS | 17589 | 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" 10:52:11 INFO - PROCESS | 17589 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:52:12 INFO - TEST-INFO | 17589: exit 0 10:52:12 INFO - Browser initialized. 10:52:12 INFO - Running cycle 1/1 for dromaeo_css test... 10:52:12 INFO - TEST-INFO | started process 17670 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpihCvOa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:52:23 INFO - PROCESS | 17670 | RSS: Main: 156221440 10:52:23 INFO - PROCESS | 17670 | 10:53:15 INFO - PROCESS | 17670 | 1470333195124 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] 10:55:27 INFO - PROCESS | 17670 | Cycle 1(1): loaded http://localhost:35431/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35431/tests/dromaeo/cssquery-ext.html) 10:55:29 INFO - PROCESS | 17670 | RSS: Main: 254353408 10:55:29 INFO - PROCESS | 17670 | 10:58:31 INFO - PROCESS | 17670 | Cycle 1(1): loaded http://localhost:35431/tests/dromaeo/cssquery-ext.html (next: http://localhost:35431/tests/dromaeo/cssquery-jquery.html) 10:58:32 INFO - PROCESS | 17670 | RSS: Main: 246153216 10:58:32 INFO - PROCESS | 17670 | 11:01:34 INFO - PROCESS | 17670 | Cycle 1(1): loaded http://localhost:35431/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35431/tests/dromaeo/cssquery-mootools.html) 11:01:35 INFO - PROCESS | 17670 | RSS: Main: 188747776 11:01:35 INFO - PROCESS | 17670 | 11:04:37 INFO - PROCESS | 17670 | Cycle 1(1): loaded http://localhost:35431/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35431/tests/dromaeo/cssquery-prototype.html) 11:04:38 INFO - PROCESS | 17670 | RSS: Main: 213164032 11:04:38 INFO - PROCESS | 17670 | 11:07:41 INFO - PROCESS | 17670 | Cycle 1(1): loaded http://localhost:35431/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35431/tests/dromaeo/cssquery-yui.html) 11:07:41 INFO - PROCESS | 17670 | RSS: Main: 189071360 11:07:41 INFO - PROCESS | 17670 | 11:10:44 INFO - PROCESS | 17670 | Cycle 1(1): loaded http://localhost:35431/tests/dromaeo/cssquery-yui.html (next: http://localhost:35431/tests/dromaeo/cssquery-dojo.html) 11:10:45 INFO - PROCESS | 17670 | RSS: Main: 275832832 11:10:45 INFO - PROCESS | 17670 | 11:10:45 INFO - PROCESS | 17670 | __start_tp_report 11:10:45 INFO - PROCESS | 17670 | _x_x_mozilla_page_load 11:10:45 INFO - PROCESS | 17670 | _x_x_mozilla_page_load_details 11:10:45 INFO - PROCESS | 17670 | |i|pagename|runs| 11:10:45 INFO - PROCESS | 17670 | |0;dojo.html;2637.683477982642;2639.9208023759284;2662.9600555991656;2673.1445937300045;2677.9196624101273;4596.49438561758;4692.41344831896;4748.786304616292;4843.3219349291085;4860.222364421693;4744.430668319797;4798.992211635561;4801.663883528155;4802.759862006903;4846.151923413407;4346.239408103585;4351.891202719934;4419.513853476131;4469.396631454744;4573.153966516188;4463.263561512363;4526.818927242906;4540.40974673292;4549.272116461367;4557.521460246676;4327.350897365421;4350.216960947028;4384.232759267147;4384.6492280617795;4418.64650827933;4347.30443129101;4369.912601747979;4390.692651514395;4403.537628548988;4419.668524860648;4384.254676704968;4414.53647367025;4417.58032986869;4424.535423780489;4454.37638730578;4642.930356044662;4732.006278681481;4773.546513081252;4778.569928706398;4824.951750482485;5146.922796158061;5197.714125723083;5256.211568264753;5258.789648414059;5259.3951695555115;5217.139172036609;5247.16045432729;5254.054270231357;5265.236540701577;5273.077211488013;4723.551262630044;4761.095391875532;4786.712797232177;4862.805487780449;4917.901641967141;5259.447757985433;5279.604029697788;5317.096093664087;5323.467653234646;5338.386085600206;5054.595632349403;5055.140626093573;5061.974690126526;5107;5116.590672746246;5018.723970181675;5064.82273120439;5107.438181799999;5142.537171654494;5191.766370513336;5090.949090509122;5092.821751238689;5094.898102037939;5129.102407078746;5142.871428214325;5054.191329387354;5057.494250574987;5061.8734531637;5063.670861393997;5112.923306150411;4330.480342358874;4373.803178856895;4385.605295523418;4420.535843736361;4460.687751857404;3851.1527463957887;3865.111024464333;3894.6300101490315;3940.625640564142;3962.881113566598;4421.535738747385;4421.646268298528;4426.380306757057;4429.601335879786;4471.038726673781;5015.774290156952;5079.593632509391;5207.869803254873;5219.347581552306;5264.578833693296;4355.172517221781;4362.149380870763;4367.650587952956;4417.690761646718;4418.536053714313;4652.697574657636;4654.348391225231;4655.86032419028;4702.7883745230865;4705.200115980291;4706.10583989041;4747.477777444409;4770.904581908412;4814.301926220678;4818.10864989978;5100.030994111107;5149.9227511586605;5174.534291913746;5220.686758794484;5222.947770522246;4827.493113223061;4827.841318083705;4832.95167048339;4838.709677419366;4881.68269062524;4907.33750943618;5042.243663450512;5063.822766203165;5081.568066714222;5116.769745361542;5145.562627176732;5196.142636464941;5210.6613070150315;5234.18870075139;5253.527182553588;5022.796845895244;5026.698398095979;5030.647854650139;5033.169527028;5084.466131056334;4882.316475693477;4973.776180071833;5042.520960508746;5055.317532133115;5058.241263810458;4923.483034281349;5033.043721692867;5037.672551284155;5038.496150385079;5046.016026874724;5058.949410505995;5086.313347698161;5088.465711100281;5090.796368145381;5145.099607568585;4743.715377077387;4800.183968725255;4980.252962055721;4988.501149884983;4989.451160372429 11:10:45 INFO - PROCESS | 17670 | |1;ext.html;567.909134538474;574.6465923457075;579.8202557207265;585.2421114656521;587.5182350472614;28952;38529.61470385299;39929;40042;43494.56505434945;39170.41244381329;39438.40842387366;39484.605153948454;39500.40749388754;39528.60471395285;7395.371393431538;7697.2302769723;7843.843123137533;7848.68605255789;7853.921460785376;9677.419354838732;9967.95016024919;9969.252306077036;10280.897191028107;10299.227557933147;9994.45030523321;10098.89901100987;10100.343477673965;10100.797984040315;10117.14004309631;9720.90279097207;9751.804963900719;9801.656942006995;9803.607855685765;9813.852792208123;9515.666951656658;9581.760455988586;9583.616655333848;9585.712428627083;9589.328746987714;37851.43222851659;38171.42742858859;38210.808945955374;38252;38279.42580861289;2993.5060714982;3027.9394412111633;3450.741194410404;3485.7559970802054;3546.538949936492;28684.282892927637;29242.561361579592;29437.55843662347;29477.115686529225;29599.40801183964;3548.520949671787;3637.2543628556346;3680.595134535199;3688.8340024698955;3758.229562939618;249828;252199;252201;252272;253424.7328763363;30410.239744006136;52092;52447.73776131095;52507.73746131245;52513;31630.683693163235;31694.207644809063;31772.364552708816;31838.681613184035;31895.202619934687;13248.668783280302;13368;13373.59879203606;13405.530806421728;13416.932915335361;10376.325538839952;10842.891571084347;11087.113030957504;11157.27477713946;11164.330140191614;7774.339181169551;7812.726554570563;7814.006464214496;7883.802904927308;7885.1326354101;2781.3324802047364;2831.957520637192;2855.928601784972;2957.852107394665;3023.9092827214777;696.6512457444587;774.9612519374009;778.9221077892165;881.7090360181124;979.6326377608397;26963.460730785275;28319;28380.290492737848;28610.284742881176;28680;940.3981451870808;944.4852555357347;971.3103696375512;979.2851218610455;1065.8507808906759;14478.493252736103;15076.924615377073;15255.71077402714;15271.312790924436;15503.224838758017;128115;129520;129971;130617;130639.34680326538;47976.28035579469;48099.27851082237;48553.757231214324;48699.26951095736;48719.75640121777;1061.2730279758237;1159.2522822779429;1165.294996527106;1191.2792760380191;1201.2252097397304;27740.58389124205;28685.856570717013;29123.563146552395;29273.414531709674;29432.705672942997;40414.39378409385;41096.38355424611;41148;41237;41309;298694;301622;302106;302395;409988;33298.667013329556;35981.28037439289;36050.09874753152;36233.81883090568;36408.27183456369;39050.804745976086;39404.2119157621;39651;39752;39783.60216397799;33995;34251.486227706104;34338.82830585831;34695.82652086723;34816.129596760285;34313.48529772006;34539.654603453644;34661.65338346685;34674.47988280228;34910.301793964485;34443.483347750305;34575.65424345825;34704.826475867456;36006.09984750298;36853.44719829151;31348.686513134577;32388.83805580957;33122.5031624521;33229.33541329111;33236.335273294884;23097.538049239258;23124.768752312262;23262.185823496096;23291.3012609622;23300.3009909703 11:10:45 INFO - PROCESS | 17670 | |2;jquery.html;330.0724962854378;353.9380608393532;357.1482015393287;358.25840510144;381.27177091754737;12892.517360503545;15904;16781;17522.299108035662;17666.205020774065;15383.538493845175;15831.287592058356;15926.04443733374;16863.747043794323;16984.065876376793;4872.439669438016;5016.372953380827;5067.974660126694;5214.270002199695;5252.238425428311;3292.407366673998;3475.6350583188782;5304.416514183436;5338;5341.332333458317;3487.1805125795418;3490.6683865032783;3804.524434445694;4917.2869933859565;5994.790182343619;5922.940770592303;5943.70281485924;5945.346011938684;5949.286085669704;5952.851178720523;5037.4458809530925;5183.688978661293;5209.583233341324;5221.530062294374;5256.553192978601;11950.282983021047;11968.880311196863;12008.519659213622;12208.633740987785;12250.019998400196;1805.0613680885997;1877.0239475472815;1902.9238830446766;2270.500489892221;2277.0664027748708;8584;8947.32895032875;9250.583723732449;9340.159385655255;9435.90564094357;1682.537302241881;1734.3149455964824;1739.4346837277935;1775.8046614872353;1776.5718303443264;63581;65981.34018659848;67994;68042.65978670075;68645.65677171582;9285.767855803659;9435;9448.291378146529;9480.573374198178;9513.904860951301;12436.502539898303;12530.122891397697;12535;12535.498580056877;12540.372981351078;7054.294570542905;7096.396806271525;7175.067241258603;7182.676779544933;7323.890141647879;6993.160820701549;7046.1192350956135;7052;7172.175199852084;7252.673629686677;3973.642372186517;4111.527174374925;4128.236276288896;4151.335786274181;4234.6823988201;1661.9750703739453;1684.8230935751815;1703.8040625328247;1706.5648259693698;1730.454906704384;744.8137965508623;758.8178837079062;766.6779952419886;784.5606460382204;847.5677404523738;15021.173835439156;15235.314410851539;15500.689986200212;15623.609409764847;15848.841511584737;716.6595866963255;723.106962900817;743.3012967810349;764.1365257259262;785.7681983814788;8322.209390108052;8348.206920342558;8694;8911;9021.097890211058;388628;397539;398426;399211;404157;76018.61990690122;76406;77203.61398193086;77784;78643;885.4112015509614;885.7387070813996;893.2496702769705;902.4991129922956;917.6788124156492;13712.17726936387;13851.653708657364;13986.790198146833;14030.438782448588;14321.785173222203;34517;36259.818700906326;36822.631773682995;37335;39327.016824579616;44462.77768611136;46205.30692039689;47313;52643.473565263856;53376.73311633417;6800.183977922681;7029.929700702927;7120.928790712233;7206.927930720625;7565.394768418403;10718.732031698957;11575.305481671126;11765;11897.583584574499;12118.394080295773;9843.950780246052;9927.40435573868;10692.732681683021;10741.67774966721;11016.944915275373;9895.851562226717;9917.206623470249;9917.900820991987;10072.446015469219;10456.16350691958;9493.857592135986;10257.846132307872;10456;10814.405207713336;10842.186835987175;7303;7338.6697598607125;7415.887616857514;7458.664360103917;7475.43934204926;8710.520921349387;9545.570449329936;9631.71104866855;9645.807083858143;9816.2147028239 11:10:45 INFO - PROCESS | 17670 | |3;mootools.html;1186.9584564540244;1212.2060050666814;1262.4950019992002;1318.386950068218;1597.1535086404203;6120.510359171267;6915.896261556074;7182.712691492347;7196.856062878745;7414.851702965938;7286;7293.817654558638;7325.047743793312;7325.157606875211;7332.633368331575;2047.6383205168545;2074.7406574178226;2075.30477290108;2076.4186027912133;2076.4497408186844;2142.2073832681854;2142.4215461825297;2153.203314773536;2187.9343619691354;2190.8247340212824;2050.364387040015;2091.362134548962;2092.811646951774;2099.128861522474;2166.5775173841107;2099.202303124818;2104.7263855698816;2105.7157283766724;2106.73665791776;2107.6100921329526;2035.2266138867283;2103.3795030465894;2103.5897999890026;2103.852730308879;2108.8207502362316;7005.474589405764;7254.165770936357;7269;7324.414046876291;7349.889751653729;4263.765492897889;4412.161689279027;4417.646588272931;4424.845130420452;4435.800388982471;2781.4993301205773;2887.9133625991044;2934.7212014858555;2935.6477222733197;2937.1922721251613;913.6710784117712;919.1084647891535;920.1764420843308;929.1637526226383;949.3164921256684;9139.131782480654;9223.907760922371;9226.630934762601;9240.214581760558;9244.676436324764;3608.530890984208;3656.4880916671686;3673.540807399075;3828.9617103829164;3831.616838316146;7501.699932002768;7514.323710866049;7527.962360188164;7534;7534.849303013909;4212.852550160791;4218.0720241546815;4229.978850105791;4237.470316210473;4242.384854196124;3391.270876761508;3856.325143099946;3933.213357328546;3946.703997200164;4021.7586944783407;3275.6069271687074;3288.621808492006;3385.6783605557434;3397.7451691123265;3400.812955287483;980.9411435313904;989.475577943691;991.3853410885297;992.9056739609725;997.8503224516236;671.375620672779;722.4762047515615;724.008108890823;736.517580984456;760.5208718507305;4845.418549773979;4906.558409743069;5053.772580233898;5102.183650615883;5143.588512919032;353.29165024126974;356.8501229483623;360.53851070629634;372.7223218702084;386.6693976649924;3344.5484859544135;3382.2051817822794;3396.507506411606;3431.5367425397753;3495.475678648172;8608.827823443497;8877.289816814638;8910.86633700495;8939.061398553189;8973.730788076367;8863.867041994376;8866.024737278894;8875.068117847663;8936.374453788303;8941;6882.483813713991;6942.236354001056;6946.2011868634745;6958.373746362851;6963;4812.855614331575;4849.2726091086615;4862.343583616166;4869.245266983623;5013.674111182761;8294;8302.377321701017;8307.916920830714;8350.206730360605;8375.036870759941;8221.630026648696;8436.156384361515;8444.493330400195;8514.148585141436;8628.827423451621;5272.2882410874045;6075.1191077294425;6174.394657389022;6181.721822517908;6182.752689892533;6814.2163651180745;6971.26801685836;7084.2915708428745;7190.280971902768;7200.855982880418;6193.071039344134;6352.650604216812;6421.229452465734;6473.643949582818;6484.902726459201;6320;6329.050642403677;6355.110284560073;6368.840778980562;6378.425941665087;5849.8537536560225;5988.970055149696;5991.191189189403;5999.520038397005;6008.8798224036145;4177.310743727251;4247.129338485542;4307.0955099429475;4322.416473776126;4401.317795741666;4238.3430568261965;4241.278982572909;4329.393884856059;4347.760873152007;4387.802548885244 11:10:45 INFO - PROCESS | 17670 | |4;prototype.html;275.88267516557937;283.5538752362948;288.256298749227;288.9595456636071;298.86102962122607;4793.352897358855;4838.661293709441;4884.487128851472;4884.804607815692;4888.242322440018;4541.455025396949;4607.976960115195;4715.599174070199;4727.598154156893;4830.251311046784;3782.773033617978;3784.6972242220695;3792.9810350948273;3794.867179648713;3804.980975095121;3792.6586607205345;3794.924101517968;3797.3987818344385;3806.2197249563774;3821.159344944108;3540.9114772130774;3600.711943044563;3721.702263818888;3758.1168425420005;3773.924521509568;3729.2914346274392;3732.3841566141555;3741.457488664142;3743.644353786386;3750.8124593770203;3304;3305.0910999475095;3312.3540909522653;3330.8501117449773;3348.4262396673525;4427.712198707074;4671.43942726875;4672.299155126758;4677.391939047936;4696.718196908162;4191.8532851350365;4204.66362690984;4212.178625168062;4217.451731274915;4225.309876049574;5024.522670346311;5028.899422011576;5033.295338652591;5045.823396181153;5061.139606266944;3516.40221162403;3521.4329623317635;3525.5416795816636;3526.664966828147;3528.8059156746367;4951.603871690292;5224;5233.293505376763;5260.1583746600745;5293.6294459387855;3610.7833529988284;3625.329314076904;3627.4196128619296;3628.63713628635;3629.891103266906;3683.318586061587;3684.244729830432;3693.9261214776093;3712.5173727415263;3720.232889377578;4136.903720514066;4156.750594964251;4267.658587313008;4274.380214868826;4276.401303817468;4976.681179487438;4995.25071239317;5024.648274620815;5028.120078986163;5031.169856973558;1200.0279773383588;1254.1471799176647;1275.4260582737804;1278.7506436245028;1279.9872001280055;876.6931573949195;894.6913314906346;897.5063714956748;912.5163663258484;915.5762788863382;4369.60673539383;4424.13729322779;4433.645308375322;4445.4220951276775;4467.24056910326;5174.741262936914;5183.3261675981885;5184.585233181337;5188.377394712658;5194.909069095456;4318.201132790444;4383.3863259143745;4402.207602631493;4444.644428445717;4451.910961780746;2711.8101732878904;2728.7544121028805;2729.56326987681;2730.470936275692;2730.604062410939;4802.711837289774;4829.879253018703;4829.975850120727;4834.903301933941;4846.29728689338;5011.84964451067;5162.870928226749;5174.43081261061;5199.6880187188135;5260.684358938476;4747.83382581608;4749.216379297377;4769.642276829251;4774.976125119421;4789.377380940456;5053.31780209667;5067.341245638044;5098.796048158032;5106.846794596168;5112.769925353294;4715;4985.152524070844;5085.364329458817;5094.337736094284;5097.235414687826;4836.153673107263;4869.683470574401;4871.975640121776;4887.97149183085;4890.779914903909;3619.8371073301237;3643.817809109587;3672.4674922136674;3680.6871415929945;3682.1715114099115;5092.083424983539;5166.147585648326;5220.504052115043;5221.608379371638;5246.344206974129;5031.949680503295;5033.6476446648385;5037.186612819455;5042.722650254272;5060.49395060491;5057.974710126426;5074.543291103819;5082.186850103965;5091.694498330112;5093.668911520739;4729.787159577896;4738.715677059387;4925.704457732548;4950.331705219749;4996.475370086234;4924.729139897197;5057.8251351919025;5086.949130508648;5102.1326374515675;5115.4884511550035;4962;4985.3020577118505;5005.824796132118;5012.799488020584;5016.949830501649 11:10:45 INFO - PROCESS | 17670 | |5;yui.html;636.6943866943867;650.6063831382011;652.5595223224328;693.6497068980165;696.8327601375671;13505.729885402287;14694.191819449927;14724.926375368135;14756;14773.630659233524;13414.19514829111;13549.525766598172;13595.116317439384;13608.659783505418;13610.727785444285;621.5338496127904;749.2058418076856;769.8037000564848;791.3471386106456;791.6754130806371;789.2305002622454;789.5933594198992;792.469045739356;792.9801754956114;793.8134538383475;838.5220424358118;839.3620848155385;839.8152406470567;839.9832003359929;840.0255703384075;659.9307072757364;783.0525064671754;826.2068414322258;827.4001349021971;840.2563731097991;603.5292471871946;603.6287683074921;603.6891001134419;605.2374008749008;605.4671888737927;13100.672483187902;13110.410031548603;13119.86880131196;13136.211827290297;13138.4087716053;12094.879051209464;12444.315562644051;12718.872811271862;12911.999999999905;13080.345982700826;11577.94211028948;11923.344216068113;11983.221090629082;12095.758084838253;12409.193402428904;3187.2031992002;3339.782914110575;4061.756294622332;4085.2442298174933;4134;64746;65172;65179.674101629666;66020.3397966019;66144.66927665331;10319.380837149794;10395.740106497247;10412.843807342895;10604.469776511143;10860.782784344268;17215.82784172167;17899.910500447415;17984.460466186036;18047.278108875496;18098.728519072225;7023.473239507058;7034.824129396806;7281.417486601059;7304.817379565553;7334.853302934018;3750.3249415104997;3815.7901315427916;3896.0649444133205;3910.8435662573747;3946.881593552198;2844.260492271983;2989.671136175019;3007.1279328994783;3015.6833532479213;3019.562163486326;508.1919747601258;521.3977855576815;524.0880867290887;526.2632314759292;526.2842534153548;539.7274376439873;543.1716632136024;572.1189368372659;572.7507394727361;586.1764221269124;7782.679869040991;7933.920660793434;8006.3995200360205;8056.637451314705;8162.1837816219095;489.2148102295835;553.8670719027485;559.499248172883;559.9524040456607;587.5681374189967;3773.660370566607;3793.24135172961;3867.284552357823;3875.593062728373;4027.3556231003486;53616.927661446556;68091.65954170197;102793;112296;112476;93879.53060234792;94302.52848735849;94462;95020.52489737507;95771;50023;75970;77732.22267777476;80049.59975200203;83247.5837620808;6834.282400348091;6908.48186386013;6910.20532638753;7229.674664639999;7363.374113200438;48460.757696211294;48928.51071489239;48997.2650410237;49255.522334330024;51334.22998655098;64206.35793642004;69192;69744.30255697582;69899.30100698928;73897;9927.751806204902;10321.122704570196;11439.828402573801;11769.588064417705;11845.289282643069;12416.317102559085;12740.112289457267;12895.226286422845;12972.675683107998;13064.412101455267;10825.296355736851;10993.61522346714;11063.446827658745;11782.234154779911;11818.113641477095;10920.235583509078;11374.658760237206;11748.823767643664;11855.940720296343;11870.228435151688;11433.59982400612;11471;11777.175597708077;11782.116341274268;11798.292102473879;9814.803703926023;9859.654912078044;10107.49462526856;10299.845502317321;10311.793764124826;9062.682806101755;9909.950450247703;10200.795984080425;10207.642732504326;10227.795444091225 11:10:45 INFO - PROCESS | 17670 | __end_tp_report 11:10:45 INFO - PROCESS | 17670 | __start_cc_report 11:10:45 INFO - PROCESS | 17670 | _x_x_mozilla_cycle_collect,1053 11:10:45 INFO - PROCESS | 17670 | __end_cc_report 11:10:45 INFO - PROCESS | 17670 | __startTimestamp1470334245157__endTimestamp 11:10:45 INFO - PROCESS | 17670 | 11:10:45 INFO - PROCESS | 17670 | ------- Summary: start ------- 11:10:45 INFO - PROCESS | 17670 | Number of tests: 6 11:10:45 INFO - PROCESS | 17670 | 11:10:45 INFO - PROCESS | 17670 | [#0] dojo.html Cycles:165 Average:4760.10 Median:4846.15 stddev:504.14 (10.4%) stddev-sans-first:477.40 11:10:45 INFO - PROCESS | 17670 | Values: 2637.7 2639.9 2663.0 2673.1 2677.9 4596.5 4692.4 4748.8 4843.3 4860.2 4744.4 4799.0 4801.7 4802.8 4846.2 4346.2 4351.9 4419.5 4469.4 4573.2 4463.3 4526.8 4540.4 4549.3 4557.5 4327.4 4350.2 4384.2 4384.6 4418.6 4347.3 4369.9 4390.7 4403.5 4419.7 4384.3 4414.5 4417.6 4424.5 4454.4 4642.9 4732.0 4773.5 4778.6 4825.0 5146.9 5197.7 5256.2 5258.8 5259.4 5217.1 5247.2 5254.1 5265.2 5273.1 4723.6 4761.1 4786.7 4862.8 4917.9 5259.4 5279.6 5317.1 5323.5 5338.4 5054.6 5055.1 5062.0 5107.0 5116.6 5018.7 5064.8 5107.4 5142.5 5191.8 5090.9 5092.8 5094.9 5129.1 5142.9 5054.2 5057.5 5061.9 5063.7 5112.9 4330.5 4373.8 4385.6 4420.5 4460.7 3851.2 3865.1 3894.6 3940.6 3962.9 4421.5 4421.6 4426.4 4429.6 4471.0 5015.8 5079.6 5207.9 5219.3 5264.6 4355.2 4362.1 4367.7 4417.7 4418.5 4652.7 4654.3 4655.9 4702.8 4705.2 4706.1 4747.5 4770.9 4814.3 4818.1 5100.0 5149.9 5174.5 5220.7 5222.9 4827.5 4827.8 4833.0 4838.7 4881.7 4907.3 5042.2 5063.8 5081.6 5116.8 5145.6 5196.1 5210.7 5234.2 5253.5 5022.8 5026.7 5030.6 5033.2 5084.5 4882.3 4973.8 5042.5 5055.3 5058.2 4923.5 5033.0 5037.7 5038.5 5046.0 5058.9 5086.3 5088.5 5090.8 5145.1 4743.7 4800.2 4980.3 4988.5 4989.5 11:10:45 INFO - PROCESS | 17670 | 11:10:45 INFO - PROCESS | 17670 | [#1] ext.html Cycles:180 Average:39422.63 Median:34685.15 stddev:65614.40 (189.2%) stddev-sans-first:65733.61 11:10:45 INFO - PROCESS | 17670 | Values: 567.9 574.6 579.8 585.2 587.5 28952.0 38529.6 39929.0 40042.0 43494.6 39170.4 39438.4 39484.6 39500.4 39528.6 7395.4 7697.2 7843.8 7848.7 7853.9 9677.4 9968.0 9969.3 10280.9 10299.2 9994.5 10098.9 10100.3 10100.8 10117.1 9720.9 9751.8 9801.7 9803.6 9813.9 9515.7 9581.8 9583.6 9585.7 9589.3 37851.4 38171.4 38210.8 38252.0 38279.4 2993.5 3027.9 3450.7 3485.8 3546.5 28684.3 29242.6 29437.6 29477.1 29599.4 3548.5 3637.3 3680.6 3688.8 3758.2 249828.0 252199.0 252201.0 252272.0 253424.7 30410.2 52092.0 52447.7 52507.7 52513.0 31630.7 31694.2 31772.4 31838.7 31895.2 13248.7 13368.0 13373.6 13405.5 13416.9 10376.3 10842.9 11087.1 11157.3 11164.3 7774.3 7812.7 7814.0 7883.8 7885.1 2781.3 2832.0 2855.9 2957.9 3023.9 696.7 775.0 778.9 881.7 979.6 26963.5 28319.0 28380.3 28610.3 28680.0 940.4 944.5 971.3 979.3 1065.9 14478.5 15076.9 15255.7 15271.3 15503.2 128115.0 129520.0 129971.0 130617.0 130639.3 47976.3 48099.3 48553.8 48699.3 48719.8 1061.3 1159.3 1165.3 1191.3 1201.2 27740.6 28685.9 29123.6 29273.4 29432.7 40414.4 41096.4 41148.0 41237.0 41309.0 298694.0 301622.0 302106.0 302395.0 409988.0 33298.7 35981.3 36050.1 36233.8 36408.3 39050.8 39404.2 39651.0 39752.0 39783.6 33995.0 34251.5 34338.8 34695.8 34816.1 34313.5 34539.7 34661.7 34674.5 34910.3 34443.5 34575.7 34704.8 36006.1 36853.4 31348.7 32388.8 33122.5 33229.3 33236.3 23097.5 23124.8 23262.2 23291.3 23300.3 11:10:45 INFO - PROCESS | 17670 | 11:10:45 INFO - PROCESS | 17670 | [#2] jquery.html Cycles:180 Average:23864.16 Median:5052.71 stddev:65632.38 (1299.0%) stddev-sans-first:65792.71 11:10:45 INFO - PROCESS | 17670 | Values: 330.1 353.9 357.1 358.3 381.3 12892.5 15904.0 16781.0 17522.3 17666.2 15383.5 15831.3 15926.0 16863.7 16984.1 4872.4 5016.4 5068.0 5214.3 5252.2 3292.4 3475.6 5304.4 5338.0 5341.3 3487.2 3490.7 3804.5 4917.3 5994.8 5922.9 5943.7 5945.3 5949.3 5952.9 5037.4 5183.7 5209.6 5221.5 5256.6 11950.3 11968.9 12008.5 12208.6 12250.0 1805.1 1877.0 1902.9 2270.5 2277.1 8584.0 8947.3 9250.6 9340.2 9435.9 1682.5 1734.3 1739.4 1775.8 1776.6 63581.0 65981.3 67994.0 68042.7 68645.7 9285.8 9435.0 9448.3 9480.6 9513.9 12436.5 12530.1 12535.0 12535.5 12540.4 7054.3 7096.4 7175.1 7182.7 7323.9 6993.2 7046.1 7052.0 7172.2 7252.7 3973.6 4111.5 4128.2 4151.3 4234.7 1662.0 1684.8 1703.8 1706.6 1730.5 744.8 758.8 766.7 784.6 847.6 15021.2 15235.3 15500.7 15623.6 15848.8 716.7 723.1 743.3 764.1 785.8 8322.2 8348.2 8694.0 8911.0 9021.1 388628.0 397539.0 398426.0 399211.0 404157.0 76018.6 76406.0 77203.6 77784.0 78643.0 885.4 885.7 893.2 902.5 917.7 13712.2 13851.7 13986.8 14030.4 14321.8 34517.0 36259.8 36822.6 37335.0 39327.0 44462.8 46205.3 47313.0 52643.5 53376.7 6800.2 7029.9 7120.9 7206.9 7565.4 10718.7 11575.3 11765.0 11897.6 12118.4 9844.0 9927.4 10692.7 10741.7 11016.9 9895.9 9917.2 9917.9 10072.4 10456.2 9493.9 10257.8 10456.0 10814.4 10842.2 7303.0 7338.7 7415.9 7458.7 7475.4 8710.5 9545.6 9631.7 9645.8 9816.2 11:10:45 INFO - PROCESS | 17670 | 11:10:45 INFO - PROCESS | 17670 | [#3] mootools.html Cycles:180 Average:4739.64 Median:5561.07 stddev:2619.63 (47.1%) stddev-sans-first:2613.37 11:10:45 INFO - PROCESS | 17670 | Values: 1187.0 1212.2 1262.5 1318.4 1597.2 6120.5 6915.9 7182.7 7196.9 7414.9 7286.0 7293.8 7325.0 7325.2 7332.6 2047.6 2074.7 2075.3 2076.4 2076.4 2142.2 2142.4 2153.2 2187.9 2190.8 2050.4 2091.4 2092.8 2099.1 2166.6 2099.2 2104.7 2105.7 2106.7 2107.6 2035.2 2103.4 2103.6 2103.9 2108.8 7005.5 7254.2 7269.0 7324.4 7349.9 4263.8 4412.2 4417.6 4424.8 4435.8 2781.5 2887.9 2934.7 2935.6 2937.2 913.7 919.1 920.2 929.2 949.3 9139.1 9223.9 9226.6 9240.2 9244.7 3608.5 3656.5 3673.5 3829.0 3831.6 7501.7 7514.3 7528.0 7534.0 7534.8 4212.9 4218.1 4230.0 4237.5 4242.4 3391.3 3856.3 3933.2 3946.7 4021.8 3275.6 3288.6 3385.7 3397.7 3400.8 980.9 989.5 991.4 992.9 997.9 671.4 722.5 724.0 736.5 760.5 4845.4 4906.6 5053.8 5102.2 5143.6 353.3 356.9 360.5 372.7 386.7 3344.5 3382.2 3396.5 3431.5 3495.5 8608.8 8877.3 8910.9 8939.1 8973.7 8863.9 8866.0 8875.1 8936.4 8941.0 6882.5 6942.2 6946.2 6958.4 6963.0 4812.9 4849.3 4862.3 4869.2 5013.7 8294.0 8302.4 8307.9 8350.2 8375.0 8221.6 8436.2 8444.5 8514.1 8628.8 5272.3 6075.1 6174.4 6181.7 6182.8 6814.2 6971.3 7084.3 7190.3 7200.9 6193.1 6352.7 6421.2 6473.6 6484.9 6320.0 6329.1 6355.1 6368.8 6378.4 5849.9 5989.0 5991.2 5999.5 6008.9 4177.3 4247.1 4307.1 4322.4 4401.3 4238.3 4241.3 4329.4 4347.8 4387.8 11:10:45 INFO - PROCESS | 17670 | 11:10:45 INFO - PROCESS | 17670 | [#4] prototype.html Cycles:180 Average:4161.52 Median:4734.25 stddev:1205.81 (25.5%) stddev-sans-first:1173.39 11:10:45 INFO - PROCESS | 17670 | Values: 275.9 283.6 288.3 289.0 298.9 4793.4 4838.7 4884.5 4884.8 4888.2 4541.5 4608.0 4715.6 4727.6 4830.3 3782.8 3784.7 3793.0 3794.9 3805.0 3792.7 3794.9 3797.4 3806.2 3821.2 3540.9 3600.7 3721.7 3758.1 3773.9 3729.3 3732.4 3741.5 3743.6 3750.8 3304.0 3305.1 3312.4 3330.9 3348.4 4427.7 4671.4 4672.3 4677.4 4696.7 4191.9 4204.7 4212.2 4217.5 4225.3 5024.5 5028.9 5033.3 5045.8 5061.1 3516.4 3521.4 3525.5 3526.7 3528.8 4951.6 5224.0 5233.3 5260.2 5293.6 3610.8 3625.3 3627.4 3628.6 3629.9 3683.3 3684.2 3693.9 3712.5 3720.2 4136.9 4156.8 4267.7 4274.4 4276.4 4976.7 4995.3 5024.6 5028.1 5031.2 1200.0 1254.1 1275.4 1278.8 1280.0 876.7 894.7 897.5 912.5 915.6 4369.6 4424.1 4433.6 4445.4 4467.2 5174.7 5183.3 5184.6 5188.4 5194.9 4318.2 4383.4 4402.2 4444.6 4451.9 2711.8 2728.8 2729.6 2730.5 2730.6 4802.7 4829.9 4830.0 4834.9 4846.3 5011.8 5162.9 5174.4 5199.7 5260.7 4747.8 4749.2 4769.6 4775.0 4789.4 5053.3 5067.3 5098.8 5106.8 5112.8 4715.0 4985.2 5085.4 5094.3 5097.2 4836.2 4869.7 4872.0 4888.0 4890.8 3619.8 3643.8 3672.5 3680.7 3682.2 5092.1 5166.1 5220.5 5221.6 5246.3 5031.9 5033.6 5037.2 5042.7 5060.5 5058.0 5074.5 5082.2 5091.7 5093.7 4729.8 4738.7 4925.7 4950.3 4996.5 4924.7 5057.8 5086.9 5102.1 5115.5 4962.0 4985.3 5005.8 5012.8 5016.9 11:10:45 INFO - PROCESS | 17670 | 11:10:45 INFO - PROCESS | 17670 | [#5] yui.html Cycles:180 Average:18264.35 Median:48962.89 stddev:26485.01 (54.1%) stddev-sans-first:26526.24 11:10:45 INFO - PROCESS | 17670 | Values: 636.7 650.6 652.6 693.6 696.8 13505.7 14694.2 14724.9 14756.0 14773.6 13414.2 13549.5 13595.1 13608.7 13610.7 621.5 749.2 769.8 791.3 791.7 789.2 789.6 792.5 793.0 793.8 838.5 839.4 839.8 840.0 840.0 659.9 783.1 826.2 827.4 840.3 603.5 603.6 603.7 605.2 605.5 13100.7 13110.4 13119.9 13136.2 13138.4 12094.9 12444.3 12718.9 12912.0 13080.3 11577.9 11923.3 11983.2 12095.8 12409.2 3187.2 3339.8 4061.8 4085.2 4134.0 64746.0 65172.0 65179.7 66020.3 66144.7 10319.4 10395.7 10412.8 10604.5 10860.8 17215.8 17899.9 17984.5 18047.3 18098.7 7023.5 7034.8 7281.4 7304.8 7334.9 3750.3 3815.8 3896.1 3910.8 3946.9 2844.3 2989.7 3007.1 3015.7 3019.6 508.2 521.4 524.1 526.3 526.3 539.7 543.2 572.1 572.8 586.2 7782.7 7933.9 8006.4 8056.6 8162.2 489.2 553.9 559.5 560.0 587.6 3773.7 3793.2 3867.3 3875.6 4027.4 53616.9 68091.7 102793.0 112296.0 112476.0 93879.5 94302.5 94462.0 95020.5 95771.0 50023.0 75970.0 77732.2 80049.6 83247.6 6834.3 6908.5 6910.2 7229.7 7363.4 48460.8 48928.5 48997.3 49255.5 51334.2 64206.4 69192.0 69744.3 69899.3 73897.0 9927.8 10321.1 11439.8 11769.6 11845.3 12416.3 12740.1 12895.2 12972.7 13064.4 10825.3 10993.6 11063.4 11782.2 11818.1 10920.2 11374.7 11748.8 11855.9 11870.2 11433.6 11471.0 11777.2 11782.1 11798.3 9814.8 9859.7 10107.5 10299.8 10311.8 9062.7 9910.0 10200.8 10207.6 10227.8 11:10:45 INFO - PROCESS | 17670 | -------- Summary: end -------- 11:10:45 INFO - PROCESS | 17670 | 11:10:45 INFO - TEST-INFO | 17670: exit 0 11:10:45 INFO - TEST-OK | dromaeo_css | took 1119829ms 11:10:45 INFO - TEST-START | kraken 11:10:45 INFO - operating with platform_type : linux_ 11:10:45 INFO - Initialising browser for kraken test... 11:10:45 INFO - TEST-INFO | started process 17861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLuAb03/profile http://localhost:35431/getInfo.html) 11:10:50 INFO - PROCESS | 17861 | __metrics Screen width/height:1600/1200 11:10:50 INFO - PROCESS | 17861 | colorDepth:24 11:10:50 INFO - PROCESS | 17861 | Browser inner width/height: 1024/697 11:10:50 INFO - PROCESS | 17861 | __metrics 11:10:50 INFO - PROCESS | 17861 | 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" 11:10:50 INFO - PROCESS | 17861 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:10:51 INFO - TEST-INFO | 17861: exit 0 11:10:51 INFO - Browser initialized. 11:10:51 INFO - Running cycle 1/1 for kraken test... 11:10:51 INFO - TEST-INFO | started process 17940 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLuAb03/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:03 INFO - PROCESS | 17940 | RSS: Main: 156733440 11:11:03 INFO - PROCESS | 17940 | 11:11:06 INFO - PROCESS | 17940 | Cycle 1(1): loaded http://localhost:35431/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35431/tests/kraken/driver.html?testName=audio-beat-detection) 11:11:07 INFO - PROCESS | 17940 | RSS: Main: 212795392 11:11:07 INFO - PROCESS | 17940 | 11:11:10 INFO - PROCESS | 17940 | Cycle 1(1): loaded http://localhost:35431/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35431/tests/kraken/driver.html?testName=audio-dft) 11:11:10 INFO - PROCESS | 17940 | RSS: Main: 190287872 11:11:10 INFO - PROCESS | 17940 | 11:11:13 INFO - PROCESS | 17940 | Cycle 1(1): loaded http://localhost:35431/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35431/tests/kraken/driver.html?testName=audio-fft) 11:11:14 INFO - PROCESS | 17940 | RSS: Main: 270483456 11:11:14 INFO - PROCESS | 17940 | 11:11:16 INFO - PROCESS | 17940 | Cycle 1(1): loaded http://localhost:35431/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35431/tests/kraken/driver.html?testName=audio-oscillator) 11:11:17 INFO - PROCESS | 17940 | RSS: Main: 179093504 11:11:17 INFO - PROCESS | 17940 | 11:11:19 INFO - PROCESS | 17940 | Cycle 1(1): loaded http://localhost:35431/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35431/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:11:20 INFO - PROCESS | 17940 | RSS: Main: 183754752 11:11:20 INFO - PROCESS | 17940 | 11:11:23 INFO - PROCESS | 17940 | Cycle 1(1): loaded http://localhost:35431/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35431/tests/kraken/driver.html?testName=imaging-darkroom) 11:11:23 INFO - PROCESS | 17940 | RSS: Main: 219951104 11:11:23 INFO - PROCESS | 17940 | 11:11:27 INFO - PROCESS | 17940 | Cycle 1(1): loaded http://localhost:35431/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35431/tests/kraken/driver.html?testName=imaging-desaturate) 11:11:28 INFO - PROCESS | 17940 | RSS: Main: 219037696 11:11:28 INFO - PROCESS | 17940 | 11:11:30 INFO - PROCESS | 17940 | Cycle 1(1): loaded http://localhost:35431/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35431/tests/kraken/driver.html?testName=json-parse-financial) 11:11:31 INFO - PROCESS | 17940 | RSS: Main: 219795456 11:11:31 INFO - PROCESS | 17940 | 11:11:33 INFO - PROCESS | 17940 | Cycle 1(1): loaded http://localhost:35431/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35431/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:11:33 INFO - PROCESS | 17940 | RSS: Main: 182915072 11:11:33 INFO - PROCESS | 17940 | 11:11:35 INFO - PROCESS | 17940 | Cycle 1(1): loaded http://localhost:35431/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35431/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:11:36 INFO - PROCESS | 17940 | RSS: Main: 189276160 11:11:36 INFO - PROCESS | 17940 | 11:11:38 INFO - PROCESS | 17940 | Cycle 1(1): loaded http://localhost:35431/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35431/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:11:39 INFO - PROCESS | 17940 | RSS: Main: 193806336 11:11:39 INFO - PROCESS | 17940 | 11:11:41 INFO - PROCESS | 17940 | Cycle 1(1): loaded http://localhost:35431/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35431/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:11:42 INFO - PROCESS | 17940 | RSS: Main: 195006464 11:11:42 INFO - PROCESS | 17940 | 11:11:45 INFO - PROCESS | 17940 | Cycle 1(1): loaded http://localhost:35431/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35431/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:11:46 INFO - PROCESS | 17940 | RSS: Main: 194736128 11:11:46 INFO - PROCESS | 17940 | 11:11:47 INFO - PROCESS | 17940 | Cycle 1(1): loaded http://localhost:35431/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35431/tests/kraken/driver.html?testName=ai-astar) 11:11:48 INFO - PROCESS | 17940 | RSS: Main: 242073600 11:11:48 INFO - PROCESS | 17940 | 11:11:48 INFO - PROCESS | 17940 | __start_tp_report 11:11:48 INFO - PROCESS | 17940 | _x_x_mozilla_page_load 11:11:48 INFO - PROCESS | 17940 | _x_x_mozilla_page_load_details 11:11:48 INFO - PROCESS | 17940 | |i|pagename|runs| 11:11:48 INFO - PROCESS | 17940 | |0;ai-astar;105;113;113;113;113;113;112;113;112;113 11:11:48 INFO - PROCESS | 17940 | |1;audio-beat-detection;152;122;129;185;123;126;155;124;184;125 11:11:48 INFO - PROCESS | 17940 | |2;audio-dft;162;162;161;162;162;162;163;162;162;161 11:11:48 INFO - PROCESS | 17940 | |3;audio-fft;75;75;76;126;76;76;76;76;106;76 11:11:48 INFO - PROCESS | 17940 | |4;audio-oscillator;85;86;110;86;86;85;108;84;87;131 11:11:48 INFO - PROCESS | 17940 | |5;imaging-gaussian-blur;117;117;118;117;117;117;116;116;116;117 11:11:48 INFO - PROCESS | 17940 | |6;imaging-darkroom;147;147;147;145;146;146;145;146;146;148 11:11:48 INFO - PROCESS | 17940 | |7;imaging-desaturate;95;94;95;95;95;95;95;97;95;95 11:11:48 INFO - PROCESS | 17940 | |8;json-parse-financial;64;64;63;63;63;62;64;62;64;64 11:11:48 INFO - PROCESS | 17940 | |9;json-stringify-tinderbox;65;65;65;65;65;65;65;65;66;65 11:11:48 INFO - PROCESS | 17940 | |10;stanford-crypto-aes;81;84;78;79;78;77;78;80;79;88 11:11:48 INFO - PROCESS | 17940 | |11;stanford-crypto-ccm;139;129;127;129;130;137;127;139;133;134 11:11:48 INFO - PROCESS | 17940 | |12;stanford-crypto-pbkdf2;171;171;167;165;166;171;164;164;168;167 11:11:48 INFO - PROCESS | 17940 | |13;stanford-crypto-sha256-iterative;70;66;69;69;70;70;67;67;67;66 11:11:48 INFO - PROCESS | 17940 | __end_tp_report 11:11:48 INFO - PROCESS | 17940 | __start_cc_report 11:11:48 INFO - PROCESS | 17940 | _x_x_mozilla_cycle_collect,1931 11:11:48 INFO - PROCESS | 17940 | __end_cc_report 11:11:48 INFO - PROCESS | 17940 | __startTimestamp1470334308053__endTimestamp 11:11:48 INFO - PROCESS | 17940 | 11:11:48 INFO - PROCESS | 17940 | ------- Summary: start ------- 11:11:48 INFO - PROCESS | 17940 | Number of tests: 14 11:11:48 INFO - PROCESS | 17940 | 11:11:48 INFO - PROCESS | 17940 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.49 (2.2%) stddev-sans-first:0.44 11:11:48 INFO - PROCESS | 17940 | Values: 105.0 113.0 113.0 113.0 113.0 113.0 112.0 113.0 112.0 113.0 11:11:48 INFO - PROCESS | 17940 | 11:11:48 INFO - PROCESS | 17940 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:140.50 stddev:25.12 (17.9%) stddev-sans-first:26.41 11:11:48 INFO - PROCESS | 17940 | Values: 152.0 122.0 129.0 185.0 123.0 126.0 155.0 124.0 184.0 125.0 11:11:48 INFO - PROCESS | 17940 | 11:11:48 INFO - PROCESS | 17940 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 11:11:48 INFO - PROCESS | 17940 | Values: 162.0 162.0 161.0 162.0 162.0 162.0 163.0 162.0 162.0 161.0 11:11:48 INFO - PROCESS | 17940 | 11:11:48 INFO - PROCESS | 17940 | [#3] audio-fft Cycles:10 Average:83.80 Median:76.00 stddev:17.62 (23.2%) stddev-sans-first:18.40 11:11:48 INFO - PROCESS | 17940 | Values: 75.0 75.0 76.0 126.0 76.0 76.0 76.0 76.0 106.0 76.0 11:11:48 INFO - PROCESS | 17940 | 11:11:48 INFO - PROCESS | 17940 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:85.50 stddev:16.05 (18.8%) stddev-sans-first:16.62 11:11:48 INFO - PROCESS | 17940 | Values: 85.0 86.0 110.0 86.0 86.0 85.0 108.0 84.0 87.0 131.0 11:11:48 INFO - PROCESS | 17940 | 11:11:48 INFO - PROCESS | 17940 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 11:11:48 INFO - PROCESS | 17940 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 116.0 116.0 116.0 117.0 11:11:48 INFO - PROCESS | 17940 | 11:11:48 INFO - PROCESS | 17940 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 11:11:48 INFO - PROCESS | 17940 | Values: 147.0 147.0 147.0 145.0 146.0 146.0 145.0 146.0 146.0 148.0 11:11:48 INFO - PROCESS | 17940 | 11:11:48 INFO - PROCESS | 17940 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 11:11:48 INFO - PROCESS | 17940 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 97.0 95.0 95.0 11:11:48 INFO - PROCESS | 17940 | 11:11:48 INFO - PROCESS | 17940 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 11:11:48 INFO - PROCESS | 17940 | Values: 64.0 64.0 63.0 63.0 63.0 62.0 64.0 62.0 64.0 64.0 11:11:48 INFO - PROCESS | 17940 | 11:11:48 INFO - PROCESS | 17940 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 11:11:48 INFO - PROCESS | 17940 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 66.0 65.0 11:11:48 INFO - PROCESS | 17940 | 11:11:48 INFO - PROCESS | 17940 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:79.50 stddev:3.39 (4.3%) stddev-sans-first:3.59 11:11:48 INFO - PROCESS | 17940 | Values: 81.0 84.0 78.0 79.0 78.0 77.0 78.0 80.0 79.0 88.0 11:11:48 INFO - PROCESS | 17940 | 11:11:48 INFO - PROCESS | 17940 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:133.50 stddev:4.70 (3.5%) stddev-sans-first:4.33 11:11:48 INFO - PROCESS | 17940 | Values: 139.0 129.0 127.0 129.0 130.0 137.0 127.0 139.0 133.0 134.0 11:11:48 INFO - PROCESS | 17940 | 11:11:48 INFO - PROCESS | 17940 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.40 Median:167.50 stddev:2.80 (1.7%) stddev-sans-first:2.65 11:11:48 INFO - PROCESS | 17940 | Values: 171.0 171.0 167.0 165.0 166.0 171.0 164.0 164.0 168.0 167.0 11:11:48 INFO - PROCESS | 17940 | 11:11:48 INFO - PROCESS | 17940 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:69.00 stddev:1.66 (2.4%) stddev-sans-first:1.62 11:11:48 INFO - PROCESS | 17940 | Values: 70.0 66.0 69.0 69.0 70.0 70.0 67.0 67.0 67.0 66.0 11:11:48 INFO - PROCESS | 17940 | -------- Summary: end -------- 11:11:48 INFO - PROCESS | 17940 | 11:11:49 INFO - TEST-INFO | 17940: exit 0 11:11:49 INFO - TEST-OK | kraken | took 63239ms 11:11:49 INFO - SUITE-END | took 1183s 11:11:49 INFO - Completed test suite (00:19:43) 11:11:49 INFO - javascript benchmark 11:11:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2637.683477982642, 2639.9208023759284, 2662.9600555991656, 2673.1445937300045, 2677.9196624101273, 4596.49438561758, 4692.41344831896, 4748.786304616292, 4843.3219349291085, 4860.222364421693, 4744.430668319797, 4798.992211635561, 4801.663883528155, 4802.759862006903, 4846.151923413407, 4346.239408103585, 4351.891202719934, 4419.513853476131, 4469.396631454744, 4573.153966516188, 4463.263561512363, 4526.818927242906, 4540.40974673292, 4549.272116461367, 4557.521460246676, 4327.350897365421, 4350.216960947028, 4384.232759267147, 4384.6492280617795, 4418.64650827933, 4347.30443129101, 4369.912601747979, 4390.692651514395, 4403.537628548988, 4419.668524860648, 4384.254676704968, 4414.53647367025, 4417.58032986869, 4424.535423780489, 4454.37638730578, 4642.930356044662, 4732.006278681481, 4773.546513081252, 4778.569928706398, 4824.951750482485, 5146.922796158061, 5197.714125723083, 5256.211568264753, 5258.789648414059, 5259.3951695555115, 5217.139172036609, 5247.16045432729, 5254.054270231357, 5265.236540701577, 5273.077211488013, 4723.551262630044, 4761.095391875532, 4786.712797232177, 4862.805487780449, 4917.901641967141, 5259.447757985433, 5279.604029697788, 5317.096093664087, 5323.467653234646, 5338.386085600206, 5054.595632349403, 5055.140626093573, 5061.974690126526, 5107.0, 5116.590672746246, 5018.723970181675, 5064.82273120439, 5107.438181799999, 5142.537171654494, 5191.766370513336, 5090.949090509122, 5092.821751238689, 5094.898102037939, 5129.102407078746, 5142.871428214325, 5054.191329387354, 5057.494250574987, 5061.8734531637, 5063.670861393997, 5112.923306150411, 4330.480342358874, 4373.803178856895, 4385.605295523418, 4420.535843736361, 4460.687751857404, 3851.1527463957887, 3865.111024464333, 3894.6300101490315, 3940.625640564142, 3962.881113566598, 4421.535738747385, 4421.646268298528, 4426.380306757057, 4429.601335879786, 4471.038726673781, 5015.774290156952, 5079.593632509391, 5207.869803254873, 5219.347581552306, 5264.578833693296, 4355.172517221781, 4362.149380870763, 4367.650587952956, 4417.690761646718, 4418.536053714313, 4652.697574657636, 4654.348391225231, 4655.86032419028, 4702.7883745230865, 4705.200115980291, 4706.10583989041, 4747.477777444409, 4770.904581908412, 4814.301926220678, 4818.10864989978, 5100.030994111107, 5149.9227511586605, 5174.534291913746, 5220.686758794484, 5222.947770522246, 4827.493113223061, 4827.841318083705, 4832.95167048339, 4838.709677419366, 4881.68269062524, 4907.33750943618, 5042.243663450512, 5063.822766203165, 5081.568066714222, 5116.769745361542, 5145.562627176732, 5196.142636464941, 5210.6613070150315, 5234.18870075139, 5253.527182553588, 5022.796845895244, 5026.698398095979, 5030.647854650139, 5033.169527028, 5084.466131056334, 4882.316475693477, 4973.776180071833, 5042.520960508746, 5055.317532133115, 5058.241263810458, 4923.483034281349, 5033.043721692867, 5037.672551284155, 5038.496150385079, 5046.016026874724, 5058.949410505995, 5086.313347698161, 5088.465711100281, 5090.796368145381, 5145.099607568585, 4743.715377077387, 4800.183968725255, 4980.252962055721, 4988.501149884983, 4989.451160372429], "value": 4727.54174863464, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.909134538474, 574.6465923457075, 579.8202557207265, 585.2421114656521, 587.5182350472614, 28952.0, 38529.61470385299, 39929.0, 40042.0, 43494.56505434945, 39170.41244381329, 39438.40842387366, 39484.605153948454, 39500.40749388754, 39528.60471395285, 7395.371393431538, 7697.2302769723, 7843.843123137533, 7848.68605255789, 7853.921460785376, 9677.419354838732, 9967.95016024919, 9969.252306077036, 10280.897191028107, 10299.227557933147, 9994.45030523321, 10098.89901100987, 10100.343477673965, 10100.797984040315, 10117.14004309631, 9720.90279097207, 9751.804963900719, 9801.656942006995, 9803.607855685765, 9813.852792208123, 9515.666951656658, 9581.760455988586, 9583.616655333848, 9585.712428627083, 9589.328746987714, 37851.43222851659, 38171.42742858859, 38210.808945955374, 38252.0, 38279.42580861289, 2993.5060714982, 3027.9394412111633, 3450.741194410404, 3485.7559970802054, 3546.538949936492, 28684.282892927637, 29242.561361579592, 29437.55843662347, 29477.115686529225, 29599.40801183964, 3548.520949671787, 3637.2543628556346, 3680.595134535199, 3688.8340024698955, 3758.229562939618, 249828.0, 252199.0, 252201.0, 252272.0, 253424.7328763363, 30410.239744006136, 52092.0, 52447.73776131095, 52507.73746131245, 52513.0, 31630.683693163235, 31694.207644809063, 31772.364552708816, 31838.681613184035, 31895.202619934687, 13248.668783280302, 13368.0, 13373.59879203606, 13405.530806421728, 13416.932915335361, 10376.325538839952, 10842.891571084347, 11087.113030957504, 11157.27477713946, 11164.330140191614, 7774.339181169551, 7812.726554570563, 7814.006464214496, 7883.802904927308, 7885.1326354101, 2781.3324802047364, 2831.957520637192, 2855.928601784972, 2957.852107394665, 3023.9092827214777, 696.6512457444587, 774.9612519374009, 778.9221077892165, 881.7090360181124, 979.6326377608397, 26963.460730785275, 28319.0, 28380.290492737848, 28610.284742881176, 28680.0, 940.3981451870808, 944.4852555357347, 971.3103696375512, 979.2851218610455, 1065.8507808906759, 14478.493252736103, 15076.924615377073, 15255.71077402714, 15271.312790924436, 15503.224838758017, 128115.0, 129520.0, 129971.0, 130617.0, 130639.34680326538, 47976.28035579469, 48099.27851082237, 48553.757231214324, 48699.26951095736, 48719.75640121777, 1061.2730279758237, 1159.2522822779429, 1165.294996527106, 1191.2792760380191, 1201.2252097397304, 27740.58389124205, 28685.856570717013, 29123.563146552395, 29273.414531709674, 29432.705672942997, 40414.39378409385, 41096.38355424611, 41148.0, 41237.0, 41309.0, 298694.0, 301622.0, 302106.0, 302395.0, 409988.0, 33298.667013329556, 35981.28037439289, 36050.09874753152, 36233.81883090568, 36408.27183456369, 39050.804745976086, 39404.2119157621, 39651.0, 39752.0, 39783.60216397799, 33995.0, 34251.486227706104, 34338.82830585831, 34695.82652086723, 34816.129596760285, 34313.48529772006, 34539.654603453644, 34661.65338346685, 34674.47988280228, 34910.301793964485, 34443.483347750305, 34575.65424345825, 34704.826475867456, 36006.09984750298, 36853.44719829151, 31348.686513134577, 32388.83805580957, 33122.5031624521, 33229.33541329111, 33236.335273294884, 23097.538049239258, 23124.768752312262, 23262.185823496096, 23291.3012609622, 23300.3009909703], "value": 16335.999674376377, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.0724962854378, 353.9380608393532, 357.1482015393287, 358.25840510144, 381.27177091754737, 12892.517360503545, 15904.0, 16781.0, 17522.299108035662, 17666.205020774065, 15383.538493845175, 15831.287592058356, 15926.04443733374, 16863.747043794323, 16984.065876376793, 4872.439669438016, 5016.372953380827, 5067.974660126694, 5214.270002199695, 5252.238425428311, 3292.407366673998, 3475.6350583188782, 5304.416514183436, 5338.0, 5341.332333458317, 3487.1805125795418, 3490.6683865032783, 3804.524434445694, 4917.2869933859565, 5994.790182343619, 5922.940770592303, 5943.70281485924, 5945.346011938684, 5949.286085669704, 5952.851178720523, 5037.4458809530925, 5183.688978661293, 5209.583233341324, 5221.530062294374, 5256.553192978601, 11950.282983021047, 11968.880311196863, 12008.519659213622, 12208.633740987785, 12250.019998400196, 1805.0613680885997, 1877.0239475472815, 1902.9238830446766, 2270.500489892221, 2277.0664027748708, 8584.0, 8947.32895032875, 9250.583723732449, 9340.159385655255, 9435.90564094357, 1682.537302241881, 1734.3149455964824, 1739.4346837277935, 1775.8046614872353, 1776.5718303443264, 63581.0, 65981.34018659848, 67994.0, 68042.65978670075, 68645.65677171582, 9285.767855803659, 9435.0, 9448.291378146529, 9480.573374198178, 9513.904860951301, 12436.502539898303, 12530.122891397697, 12535.0, 12535.498580056877, 12540.372981351078, 7054.294570542905, 7096.396806271525, 7175.067241258603, 7182.676779544933, 7323.890141647879, 6993.160820701549, 7046.1192350956135, 7052.0, 7172.175199852084, 7252.673629686677, 3973.642372186517, 4111.527174374925, 4128.236276288896, 4151.335786274181, 4234.6823988201, 1661.9750703739453, 1684.8230935751815, 1703.8040625328247, 1706.5648259693698, 1730.454906704384, 744.8137965508623, 758.8178837079062, 766.6779952419886, 784.5606460382204, 847.5677404523738, 15021.173835439156, 15235.314410851539, 15500.689986200212, 15623.609409764847, 15848.841511584737, 716.6595866963255, 723.106962900817, 743.3012967810349, 764.1365257259262, 785.7681983814788, 8322.209390108052, 8348.206920342558, 8694.0, 8911.0, 9021.097890211058, 388628.0, 397539.0, 398426.0, 399211.0, 404157.0, 76018.61990690122, 76406.0, 77203.61398193086, 77784.0, 78643.0, 885.4112015509614, 885.7387070813996, 893.2496702769705, 902.4991129922956, 917.6788124156492, 13712.17726936387, 13851.653708657364, 13986.790198146833, 14030.438782448588, 14321.785173222203, 34517.0, 36259.818700906326, 36822.631773682995, 37335.0, 39327.016824579616, 44462.77768611136, 46205.30692039689, 47313.0, 52643.473565263856, 53376.73311633417, 6800.183977922681, 7029.929700702927, 7120.928790712233, 7206.927930720625, 7565.394768418403, 10718.732031698957, 11575.305481671126, 11765.0, 11897.583584574499, 12118.394080295773, 9843.950780246052, 9927.40435573868, 10692.732681683021, 10741.67774966721, 11016.944915275373, 9895.851562226717, 9917.206623470249, 9917.900820991987, 10072.446015469219, 10456.16350691958, 9493.857592135986, 10257.846132307872, 10456.0, 10814.405207713336, 10842.186835987175, 7303.0, 7338.6697598607125, 7415.887616857514, 7458.664360103917, 7475.43934204926, 8710.520921349387, 9545.570449329936, 9631.71104866855, 9645.807083858143, 9816.2147028239], "value": 7759.428432057064, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1186.9584564540244, 1212.2060050666814, 1262.4950019992002, 1318.386950068218, 1597.1535086404203, 6120.510359171267, 6915.896261556074, 7182.712691492347, 7196.856062878745, 7414.851702965938, 7286.0, 7293.817654558638, 7325.047743793312, 7325.157606875211, 7332.633368331575, 2047.6383205168545, 2074.7406574178226, 2075.30477290108, 2076.4186027912133, 2076.4497408186844, 2142.2073832681854, 2142.4215461825297, 2153.203314773536, 2187.9343619691354, 2190.8247340212824, 2050.364387040015, 2091.362134548962, 2092.811646951774, 2099.128861522474, 2166.5775173841107, 2099.202303124818, 2104.7263855698816, 2105.7157283766724, 2106.73665791776, 2107.6100921329526, 2035.2266138867283, 2103.3795030465894, 2103.5897999890026, 2103.852730308879, 2108.8207502362316, 7005.474589405764, 7254.165770936357, 7269.0, 7324.414046876291, 7349.889751653729, 4263.765492897889, 4412.161689279027, 4417.646588272931, 4424.845130420452, 4435.800388982471, 2781.4993301205773, 2887.9133625991044, 2934.7212014858555, 2935.6477222733197, 2937.1922721251613, 913.6710784117712, 919.1084647891535, 920.1764420843308, 929.1637526226383, 949.3164921256684, 9139.131782480654, 9223.907760922371, 9226.630934762601, 9240.214581760558, 9244.676436324764, 3608.530890984208, 3656.4880916671686, 3673.540807399075, 3828.9617103829164, 3831.616838316146, 7501.699932002768, 7514.323710866049, 7527.962360188164, 7534.0, 7534.849303013909, 4212.852550160791, 4218.0720241546815, 4229.978850105791, 4237.470316210473, 4242.384854196124, 3391.270876761508, 3856.325143099946, 3933.213357328546, 3946.703997200164, 4021.7586944783407, 3275.6069271687074, 3288.621808492006, 3385.6783605557434, 3397.7451691123265, 3400.812955287483, 980.9411435313904, 989.475577943691, 991.3853410885297, 992.9056739609725, 997.8503224516236, 671.375620672779, 722.4762047515615, 724.008108890823, 736.517580984456, 760.5208718507305, 4845.418549773979, 4906.558409743069, 5053.772580233898, 5102.183650615883, 5143.588512919032, 353.29165024126974, 356.8501229483623, 360.53851070629634, 372.7223218702084, 386.6693976649924, 3344.5484859544135, 3382.2051817822794, 3396.507506411606, 3431.5367425397753, 3495.475678648172, 8608.827823443497, 8877.289816814638, 8910.86633700495, 8939.061398553189, 8973.730788076367, 8863.867041994376, 8866.024737278894, 8875.068117847663, 8936.374453788303, 8941.0, 6882.483813713991, 6942.236354001056, 6946.2011868634745, 6958.373746362851, 6963.0, 4812.855614331575, 4849.2726091086615, 4862.343583616166, 4869.245266983623, 5013.674111182761, 8294.0, 8302.377321701017, 8307.916920830714, 8350.206730360605, 8375.036870759941, 8221.630026648696, 8436.156384361515, 8444.493330400195, 8514.148585141436, 8628.827423451621, 5272.2882410874045, 6075.1191077294425, 6174.394657389022, 6181.721822517908, 6182.752689892533, 6814.2163651180745, 6971.26801685836, 7084.2915708428745, 7190.280971902768, 7200.855982880418, 6193.071039344134, 6352.650604216812, 6421.229452465734, 6473.643949582818, 6484.902726459201, 6320.0, 6329.050642403677, 6355.110284560073, 6368.840778980562, 6378.425941665087, 5849.8537536560225, 5988.970055149696, 5991.191189189403, 5999.520038397005, 6008.8798224036145, 4177.310743727251, 4247.129338485542, 4307.0955099429475, 4322.416473776126, 4401.317795741666, 4238.3430568261965, 4241.278982572909, 4329.393884856059, 4347.760873152007, 4387.802548885244], "value": 3763.6596729348607, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.88267516557937, 283.5538752362948, 288.256298749227, 288.9595456636071, 298.86102962122607, 4793.352897358855, 4838.661293709441, 4884.487128851472, 4884.804607815692, 4888.242322440018, 4541.455025396949, 4607.976960115195, 4715.599174070199, 4727.598154156893, 4830.251311046784, 3782.773033617978, 3784.6972242220695, 3792.9810350948273, 3794.867179648713, 3804.980975095121, 3792.6586607205345, 3794.924101517968, 3797.3987818344385, 3806.2197249563774, 3821.159344944108, 3540.9114772130774, 3600.711943044563, 3721.702263818888, 3758.1168425420005, 3773.924521509568, 3729.2914346274392, 3732.3841566141555, 3741.457488664142, 3743.644353786386, 3750.8124593770203, 3304.0, 3305.0910999475095, 3312.3540909522653, 3330.8501117449773, 3348.4262396673525, 4427.712198707074, 4671.43942726875, 4672.299155126758, 4677.391939047936, 4696.718196908162, 4191.8532851350365, 4204.66362690984, 4212.178625168062, 4217.451731274915, 4225.309876049574, 5024.522670346311, 5028.899422011576, 5033.295338652591, 5045.823396181153, 5061.139606266944, 3516.40221162403, 3521.4329623317635, 3525.5416795816636, 3526.664966828147, 3528.8059156746367, 4951.603871690292, 5224.0, 5233.293505376763, 5260.1583746600745, 5293.6294459387855, 3610.7833529988284, 3625.329314076904, 3627.4196128619296, 3628.63713628635, 3629.891103266906, 3683.318586061587, 3684.244729830432, 3693.9261214776093, 3712.5173727415263, 3720.232889377578, 4136.903720514066, 4156.750594964251, 4267.658587313008, 4274.380214868826, 4276.401303817468, 4976.681179487438, 4995.25071239317, 5024.648274620815, 5028.120078986163, 5031.169856973558, 1200.0279773383588, 1254.1471799176647, 1275.4260582737804, 1278.7506436245028, 1279.9872001280055, 876.6931573949195, 894.6913314906346, 897.5063714956748, 912.5163663258484, 915.5762788863382, 4369.60673539383, 4424.13729322779, 4433.645308375322, 4445.4220951276775, 4467.24056910326, 5174.741262936914, 5183.3261675981885, 5184.585233181337, 5188.377394712658, 5194.909069095456, 4318.201132790444, 4383.3863259143745, 4402.207602631493, 4444.644428445717, 4451.910961780746, 2711.8101732878904, 2728.7544121028805, 2729.56326987681, 2730.470936275692, 2730.604062410939, 4802.711837289774, 4829.879253018703, 4829.975850120727, 4834.903301933941, 4846.29728689338, 5011.84964451067, 5162.870928226749, 5174.43081261061, 5199.6880187188135, 5260.684358938476, 4747.83382581608, 4749.216379297377, 4769.642276829251, 4774.976125119421, 4789.377380940456, 5053.31780209667, 5067.341245638044, 5098.796048158032, 5106.846794596168, 5112.769925353294, 4715.0, 4985.152524070844, 5085.364329458817, 5094.337736094284, 5097.235414687826, 4836.153673107263, 4869.683470574401, 4871.975640121776, 4887.97149183085, 4890.779914903909, 3619.8371073301237, 3643.817809109587, 3672.4674922136674, 3680.6871415929945, 3682.1715114099115, 5092.083424983539, 5166.147585648326, 5220.504052115043, 5221.608379371638, 5246.344206974129, 5031.949680503295, 5033.6476446648385, 5037.186612819455, 5042.722650254272, 5060.49395060491, 5057.974710126426, 5074.543291103819, 5082.186850103965, 5091.694498330112, 5093.668911520739, 4729.787159577896, 4738.715677059387, 4925.704457732548, 4950.331705219749, 4996.475370086234, 4924.729139897197, 5057.8251351919025, 5086.949130508648, 5102.1326374515675, 5115.4884511550035, 4962.0, 4985.3020577118505, 5005.824796132118, 5012.799488020584, 5016.949830501649], "value": 3777.810671909377, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.6943866943867, 650.6063831382011, 652.5595223224328, 693.6497068980165, 696.8327601375671, 13505.729885402287, 14694.191819449927, 14724.926375368135, 14756.0, 14773.630659233524, 13414.19514829111, 13549.525766598172, 13595.116317439384, 13608.659783505418, 13610.727785444285, 621.5338496127904, 749.2058418076856, 769.8037000564848, 791.3471386106456, 791.6754130806371, 789.2305002622454, 789.5933594198992, 792.469045739356, 792.9801754956114, 793.8134538383475, 838.5220424358118, 839.3620848155385, 839.8152406470567, 839.9832003359929, 840.0255703384075, 659.9307072757364, 783.0525064671754, 826.2068414322258, 827.4001349021971, 840.2563731097991, 603.5292471871946, 603.6287683074921, 603.6891001134419, 605.2374008749008, 605.4671888737927, 13100.672483187902, 13110.410031548603, 13119.86880131196, 13136.211827290297, 13138.4087716053, 12094.879051209464, 12444.315562644051, 12718.872811271862, 12911.999999999905, 13080.345982700826, 11577.94211028948, 11923.344216068113, 11983.221090629082, 12095.758084838253, 12409.193402428904, 3187.2031992002, 3339.782914110575, 4061.756294622332, 4085.2442298174933, 4134.0, 64746.0, 65172.0, 65179.674101629666, 66020.3397966019, 66144.66927665331, 10319.380837149794, 10395.740106497247, 10412.843807342895, 10604.469776511143, 10860.782784344268, 17215.82784172167, 17899.910500447415, 17984.460466186036, 18047.278108875496, 18098.728519072225, 7023.473239507058, 7034.824129396806, 7281.417486601059, 7304.817379565553, 7334.853302934018, 3750.3249415104997, 3815.7901315427916, 3896.0649444133205, 3910.8435662573747, 3946.881593552198, 2844.260492271983, 2989.671136175019, 3007.1279328994783, 3015.6833532479213, 3019.562163486326, 508.1919747601258, 521.3977855576815, 524.0880867290887, 526.2632314759292, 526.2842534153548, 539.7274376439873, 543.1716632136024, 572.1189368372659, 572.7507394727361, 586.1764221269124, 7782.679869040991, 7933.920660793434, 8006.3995200360205, 8056.637451314705, 8162.1837816219095, 489.2148102295835, 553.8670719027485, 559.499248172883, 559.9524040456607, 587.5681374189967, 3773.660370566607, 3793.24135172961, 3867.284552357823, 3875.593062728373, 4027.3556231003486, 53616.927661446556, 68091.65954170197, 102793.0, 112296.0, 112476.0, 93879.53060234792, 94302.52848735849, 94462.0, 95020.52489737507, 95771.0, 50023.0, 75970.0, 77732.22267777476, 80049.59975200203, 83247.5837620808, 6834.282400348091, 6908.48186386013, 6910.20532638753, 7229.674664639999, 7363.374113200438, 48460.757696211294, 48928.51071489239, 48997.2650410237, 49255.522334330024, 51334.22998655098, 64206.35793642004, 69192.0, 69744.30255697582, 69899.30100698928, 73897.0, 9927.751806204902, 10321.122704570196, 11439.828402573801, 11769.588064417705, 11845.289282643069, 12416.317102559085, 12740.112289457267, 12895.226286422845, 12972.675683107998, 13064.412101455267, 10825.296355736851, 10993.61522346714, 11063.446827658745, 11782.234154779911, 11818.113641477095, 10920.235583509078, 11374.658760237206, 11748.823767643664, 11855.940720296343, 11870.228435151688, 11433.59982400612, 11471.0, 11777.175597708077, 11782.116341274268, 11798.292102473879, 9814.803703926023, 9859.654912078044, 10107.49462526856, 10299.845502317321, 10311.793764124826, 9062.682806101755, 9909.950450247703, 10200.795984080425, 10207.642732504326, 10227.795444091225], "value": 6634.549438984676, "unit": "score"}], "name": "dromaeo_css", "value": 6195.177187291421, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 112.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 122.0, 129.0, 185.0, 123.0, 126.0, 155.0, 124.0, 184.0, 125.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 162.0, 162.0, 163.0, 162.0, 162.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 126.0, 76.0, 76.0, 76.0, 76.0, 106.0, 76.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 110.0, 86.0, 86.0, 85.0, 108.0, 84.0, 87.0, 131.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 116.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 148.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 97.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 63.0, 63.0, 62.0, 64.0, 62.0, 64.0, 64.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 78.0, 79.0, 78.0, 77.0, 78.0, 80.0, 79.0, 88.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 129.0, 127.0, 129.0, 130.0, 137.0, 127.0, 139.0, 133.0, 134.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 167.0, 165.0, 166.0, 171.0, 164.0, 164.0, 168.0, 167.0], "value": 167.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 69.0, 69.0, 70.0, 70.0, 67.0, 67.0, 67.0, 66.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1529.7, "alertThreshold": 2.0}]} 11:11:49 INFO - Return code: 0 11:11:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:11:49 INFO - # TBPL SUCCESS # 11:11:49 INFO - Running post-action listener: _resource_record_post_action 11:11:49 INFO - [mozharness: 2016-08-04 18:11:49.367947Z] Finished run-tests step (success) 11:11:49 INFO - Running post-run listener: _resource_record_post_run 11:11:49 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 527282176; Read time: 16; Write time: 448344 11:11:49 INFO - TinderboxPrint: CPU usage
13.0% 11:11:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:11:49 INFO - TinderboxPrint: I/O write bytes / time
527,282,176 / 448,344 11:11:49 INFO - TinderboxPrint: CPU idle
8,328.3 (87.0%) 11:11:49 INFO - TinderboxPrint: CPU user
1,199.1 (12.5%) 11:11:49 INFO - TinderboxPrint: Swap in / out
0 / 0 11:11:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 247291904; Read time: 0; Write time: 232824 11:11:49 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 279699456; Read time: 0; Write time: 215496 11:11:50 INFO - Running post-run listener: _upload_blobber_files 11:11:50 INFO - Blob upload gear active. 11:11:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:11: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 11:11: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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:11: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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:11:50 INFO - (blobuploader) - INFO - Open directory for files ... 11:11:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:11:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:11:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:51 INFO - (blobuploader) - INFO - Done attempting. 11:11:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:11:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:11:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:51 INFO - (blobuploader) - INFO - Done attempting. 11:11:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:11:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:11:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:56 INFO - (blobuploader) - INFO - Done attempting. 11:11:56 INFO - (blobuploader) - INFO - Iteration through files over. 11:11:56 INFO - Return code: 0 11:11:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:11:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:11:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1799ecba9e5ee5f3308e48abb781d28637ade0b5d76a338a20e0656cbe94e90554689ff760deb805627c37f26da4bf2b2f29e24e2019b2237dd5cf665551ea0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5224cda1d5937edc1c57fbda3b25ae3ff0fc277d50c9064283321789395be024ad98d2dea288ca5753210d3367d6ef9bd59b69357df2ac4da520f658a810da5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73729fac0b093e577bb5079c319f66f7fa6c8c7eff7c7d074c03a8ab01052f2d2d0d1a33a9fb12a0a5df30441aa3f2d423b1c9588087f822f6edaac58737624c"} 11:11:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:11:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:11:56 INFO - Contents: 11:11:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1799ecba9e5ee5f3308e48abb781d28637ade0b5d76a338a20e0656cbe94e90554689ff760deb805627c37f26da4bf2b2f29e24e2019b2237dd5cf665551ea0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5224cda1d5937edc1c57fbda3b25ae3ff0fc277d50c9064283321789395be024ad98d2dea288ca5753210d3367d6ef9bd59b69357df2ac4da520f658a810da5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73729fac0b093e577bb5079c319f66f7fa6c8c7eff7c7d074c03a8ab01052f2d2d0d1a33a9fb12a0a5df30441aa3f2d423b1c9588087f822f6edaac58737624c"} 11:11:56 INFO - Running post-run listener: copy_logs_to_upload_dir 11:11:56 INFO - Copying logs to upload dir... 11:11:56 INFO - mkdir: /builds/slave/test/build/upload/logs 11:11:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1300.729321 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 40 secs) (at 2016-08-04 11:11:56.336165) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 11:11:56.339696) ========= 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=41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1799ecba9e5ee5f3308e48abb781d28637ade0b5d76a338a20e0656cbe94e90554689ff760deb805627c37f26da4bf2b2f29e24e2019b2237dd5cf665551ea0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5224cda1d5937edc1c57fbda3b25ae3ff0fc277d50c9064283321789395be024ad98d2dea288ca5753210d3367d6ef9bd59b69357df2ac4da520f658a810da5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73729fac0b093e577bb5079c319f66f7fa6c8c7eff7c7d074c03a8ab01052f2d2d0d1a33a9fb12a0a5df30441aa3f2d423b1c9588087f822f6edaac58737624c"} build_url:https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/NyJECErlT7WXe-ujVOgnjw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1799ecba9e5ee5f3308e48abb781d28637ade0b5d76a338a20e0656cbe94e90554689ff760deb805627c37f26da4bf2b2f29e24e2019b2237dd5cf665551ea0e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f5224cda1d5937edc1c57fbda3b25ae3ff0fc277d50c9064283321789395be024ad98d2dea288ca5753210d3367d6ef9bd59b69357df2ac4da520f658a810da5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/73729fac0b093e577bb5079c319f66f7fa6c8c7eff7c7d074c03a8ab01052f2d2d0d1a33a9fb12a0a5df30441aa3f2d423b1c9588087f822f6edaac58737624c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 11:11:56.366283) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 11:11:56.366654) ========= 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=41bf3e9aed84707956354da8000001c5-1470329658.923630-998989541 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004385 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 11:11:56.452120) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 11:11:56.452496) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 11:11:56.452874) ========= ========= Total master_lag: 0.17 =========