builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1472926344.41 results: success (0) buildid: 20160903083042 builduid: 24a697df10714e9e9e7ea7f3801f40f5 revision: bcab45259b4fe5787d0d6fea16067e763f2a11ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-03 11:12:24.411667) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-03 11:12:24.412133) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-03 11:12:24.412427) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-03 11:12:24.440657) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 11:12:24.441106) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-03 11:12:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.4M=0.001s 2016-09-03 11:12:26 (21.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112911 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 11:12:24.567916) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 11:12:24.568277) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021311 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 11:12:24.618536) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-03 11:12:24.618925) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bcab45259b4fe5787d0d6fea16067e763f2a11ea --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 bcab45259b4fe5787d0d6fea16067e763f2a11ea --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=82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-03 11:12:26,704 truncating revision to first 12 chars 2016-09-03 11:12:26,704 Setting DEBUG logging. 2016-09-03 11:12:26,704 attempt 1/10 2016-09-03 11:12:26,704 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bcab45259b4f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-03 11:12:27,609 unpacking tar archive at: fx-team-bcab45259b4f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.243012 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-03 11:12:25.875582) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-03 11:12:25.875912) ========= script_repo_revision: bcab45259b4fe5787d0d6fea16067e763f2a11ea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-03 11:12:25.876367) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-03 11:12:25.876652) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-03 11:12:25.885065) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-03 11:12:25.885403) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:12:28 INFO - MultiFileLogger online at 20160903 11:12:28 in /builds/slave/test 11:12:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:12:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:12:28 INFO - {'append_to_log': False, 11:12:28 INFO - 'base_work_dir': '/builds/slave/test', 11:12:28 INFO - 'blob_upload_branch': 'Fx-Team', 11:12:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:12:28 INFO - 'branch': 'Fx-Team', 11:12:28 INFO - 'buildbot_json_path': 'buildprops.json', 11:12:28 INFO - 'config_files': ('talos/linux_config.py',), 11:12:28 INFO - 'default_actions': ('clobber', 11:12:28 INFO - 'read-buildbot-config', 11:12:28 INFO - 'download-and-extract', 11:12:28 INFO - 'populate-webroot', 11:12:28 INFO - 'create-virtualenv', 11:12:28 INFO - 'install', 11:12:28 INFO - 'run-tests'), 11:12:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:12:28 INFO - 'download_minidump_stackwalk': True, 11:12:28 INFO - 'download_symbols': 'ondemand', 11:12:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:12:28 INFO - 'tooltool.py': '/tools/tooltool.py', 11:12:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:12:28 INFO - '/tools/misc-python/virtualenv.py')}, 11:12:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:12:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:12:28 INFO - 'installer_path': 'installer.exe', 11:12:28 INFO - 'log_level': 'info', 11:12:28 INFO - 'log_name': 'talos', 11:12:28 INFO - 'log_to_console': True, 11:12:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:12:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:12:28 INFO - 'opt_config_files': (), 11:12:28 INFO - 'pip_index': False, 11:12:28 INFO - 'sps_profile': False, 11:12:28 INFO - 'sps_profile_interval': 0, 11:12:28 INFO - 'suite': 'dromaeojs', 11:12:28 INFO - 'system_bits': '32', 11:12:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:12:28 INFO - 'title': 'talos-linux64-ix-066', 11:12:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:12:28 INFO - 'use_talos_json': True, 11:12:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:12:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:12:28 INFO - 'work_dir': 'build'} 11:12:28 INFO - [mozharness: 2016-09-03 18:12:28.064066Z] Running clobber step. 11:12:28 INFO - Running pre-action listener: _resource_record_pre_action 11:12:28 INFO - Running main action method: clobber 11:12:28 INFO - rmtree: /builds/slave/test/build 11:12:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:12:29 INFO - Running post-action listener: _resource_record_post_action 11:12:29 INFO - [mozharness: 2016-09-03 18:12:29.019379Z] Finished clobber step (success) 11:12:29 INFO - [mozharness: 2016-09-03 18:12:29.019482Z] Running read-buildbot-config step. 11:12:29 INFO - Running pre-action listener: _resource_record_pre_action 11:12:29 INFO - Running main action method: read_buildbot_config 11:12:29 INFO - Using buildbot properties: 11:12:29 INFO - { 11:12:29 INFO - "project": "", 11:12:29 INFO - "product": "firefox", 11:12:29 INFO - "script_repo_revision": "production", 11:12:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:12:29 INFO - "repository": "", 11:12:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 11:12:29 INFO - "buildid": "20160903083042", 11:12:29 INFO - "pgo_build": "True", 11:12:29 INFO - "basedir": "/builds/slave/test", 11:12:29 INFO - "buildnumber": 420, 11:12:29 INFO - "slavename": "talos-linux64-ix-066", 11:12:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:12:29 INFO - "platform": "ubuntu64_hw", 11:12:29 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:12:29 INFO - "branch": "fx-team", 11:12:29 INFO - "repo_path": "integration/fx-team", 11:12:29 INFO - "revision": "bcab45259b4fe5787d0d6fea16067e763f2a11ea", 11:12:29 INFO - "stage_platform": "linux64-pgo", 11:12:29 INFO - "builduid": "24a697df10714e9e9e7ea7f3801f40f5", 11:12:29 INFO - "slavebuilddir": "test" 11:12:29 INFO - } 11:12:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:12:29 INFO - Running post-action listener: _resource_record_post_action 11:12:29 INFO - [mozharness: 2016-09-03 18:12:29.022136Z] Finished read-buildbot-config step (success) 11:12:29 INFO - [mozharness: 2016-09-03 18:12:29.022227Z] Running download-and-extract step. 11:12:29 INFO - Running pre-action listener: _resource_record_pre_action 11:12:29 INFO - Running main action method: download_and_extract 11:12:29 INFO - mkdir: /builds/slave/test/build/tests 11:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:29 INFO - trying https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:12:29 INFO - Downloading https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/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 11:12:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/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 11:12:29 INFO - Downloaded 1361 bytes. 11:12:29 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:12:29 INFO - Using the following test package requirements: 11:12:29 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:12:29 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:12:29 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:12:29 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:29 INFO - u'jsshell-linux-x86_64.zip'], 11:12:29 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:12:29 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:12:29 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:12:29 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:12:29 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:12:29 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:12:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:12:29 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:29 INFO - trying https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:12:29 INFO - Downloading https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/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 11:12:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/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 11:12:30 INFO - Downloaded 21906553 bytes. 11:12:30 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:12:34 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 11:12:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:34 INFO - trying https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:12:34 INFO - Downloading https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/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 11:12:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/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 11:12:35 INFO - Downloaded 21906553 bytes. 11:12:35 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 11:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:40 INFO - trying https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:12:40 INFO - Downloading https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/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 11:12:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/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 11:12:41 INFO - Downloaded 14413998 bytes. 11:12:41 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 11:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:41 INFO - trying https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:12:41 INFO - Downloading https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/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 11:12:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/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 11:12:42 INFO - Downloaded 59698163 bytes. 11:12:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:12:42 INFO - mkdir: /builds/slave/test/properties 11:12:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:12:42 INFO - Writing to file /builds/slave/test/properties/build_url 11:12:42 INFO - Contents: 11:12:42 INFO - build_url:https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:12:43 INFO - Running post-action listener: _resource_record_post_action 11:12:43 INFO - Running post-action listener: set_extra_try_arguments 11:12:43 INFO - [mozharness: 2016-09-03 18:12:43.094790Z] Finished download-and-extract step (success) 11:12:43 INFO - [mozharness: 2016-09-03 18:12:43.095018Z] Running populate-webroot step. 11:12:43 INFO - Running pre-action listener: _resource_record_pre_action 11:12:43 INFO - Running main action method: populate_webroot 11:12:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:12:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:12:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:12:43 INFO - '--tppagecycles', 11:12:43 INFO - '7'], 11:12:43 INFO - 'tests': ['tsvgm']}}, 11:12:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:12:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:12:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:12:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:12:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:12:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:12:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:43 INFO - 'talos_options': ['--disable-e10s'], 11:12:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:12:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:43 INFO - 'talos_options': ['--disable-e10s'], 11:12:43 INFO - 'tests': ['damp', 'tps']}, 11:12:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:43 INFO - 'tests': ['damp', 'tps']}, 11:12:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:12:43 INFO - 'tests': ['dromaeo_dom']}, 11:12:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:12:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:12:43 INFO - 'tests': ['basic_compositor_video']}, 11:12:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:12:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:12:43 INFO - 'tests': ['a11yr', 11:12:43 INFO - 'ts_paint', 11:12:43 INFO - 'tpaint', 11:12:43 INFO - 'sessionrestore', 11:12:43 INFO - 'sessionrestore_no_auto_restore', 11:12:43 INFO - 'tabpaint']}, 11:12:43 INFO - 'other-e10s': {'tests': ['a11yr', 11:12:43 INFO - 'ts_paint', 11:12:43 INFO - 'tpaint', 11:12:43 INFO - 'sessionrestore', 11:12:43 INFO - 'sessionrestore_no_auto_restore', 11:12:43 INFO - 'tabpaint']}, 11:12:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:12:43 INFO - 'ts_paint', 11:12:43 INFO - 'tpaint', 11:12:43 INFO - 'sessionrestore', 11:12:43 INFO - 'sessionrestore_no_auto_restore', 11:12:43 INFO - 'tabpaint']}, 11:12:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:12:43 INFO - 'ts_paint', 11:12:43 INFO - 'tpaint', 11:12:43 INFO - 'sessionrestore', 11:12:43 INFO - 'sessionrestore_no_auto_restore', 11:12:43 INFO - 'tabpaint']}, 11:12:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:12:43 INFO - 'tests': ['a11yr', 11:12:43 INFO - 'ts_paint', 11:12:43 INFO - 'tpaint', 11:12:43 INFO - 'sessionrestore', 11:12:43 INFO - 'sessionrestore_no_auto_restore', 11:12:43 INFO - 'tabpaint']}, 11:12:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:12:43 INFO - 'tests': ['a11yr', 11:12:43 INFO - 'ts_paint', 11:12:43 INFO - 'tpaint', 11:12:43 INFO - 'sessionrestore', 11:12:43 INFO - 'sessionrestore_no_auto_restore', 11:12:43 INFO - 'tabpaint']}, 11:12:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:12:43 INFO - 'tests': ['tsvgx', 11:12:43 INFO - 'tsvgr_opacity', 11:12:43 INFO - 'tart', 11:12:43 INFO - 'tscrollx', 11:12:43 INFO - 'cart']}, 11:12:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:12:43 INFO - 'tsvgr_opacity', 11:12:43 INFO - 'tart', 11:12:43 INFO - 'tscrollx', 11:12:43 INFO - 'cart']}, 11:12:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:43 INFO - 'talos_options': ['--disable-e10s'], 11:12:43 INFO - 'tests': ['tp5o']}, 11:12:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:43 INFO - 'tests': ['tp5o']}, 11:12:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:43 INFO - 'talos_options': ['--disable-e10s', 11:12:43 INFO - '--xperf_path', 11:12:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:43 INFO - 'tests': ['tp5n']}, 11:12:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:12:43 INFO - 'talos_options': ['--xperf_path', 11:12:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:12:43 INFO - 'tests': ['tp5n']}}, 11:12:43 INFO - 'talos.zip': {'path': '', 11:12:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:12:43 INFO - Running post-action listener: _resource_record_post_action 11:12:43 INFO - [mozharness: 2016-09-03 18:12:43.110202Z] Finished populate-webroot step (success) 11:12:43 INFO - [mozharness: 2016-09-03 18:12:43.110292Z] Running create-virtualenv step. 11:12:43 INFO - Running pre-action listener: _resource_record_pre_action 11:12:43 INFO - Running main action method: create_virtualenv 11:12:43 INFO - Creating virtualenv /builds/slave/test/build/venv 11:12:43 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 11:12:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:12:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:12:43 INFO - Using real prefix '/usr' 11:12:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:12:43 INFO - Installing distribute.............................................................................................................................................................................................done. 11:12:45 INFO - Installing pip.................done. 11:12:45 INFO - Return code: 0 11:12:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15c6c3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ca850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c5370>, '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 0x19c88f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c8d80>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', '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 11:12:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:12:45 INFO - Using env: {'DISPLAY': ':0', 11:12:45 INFO - 'HOME': '/home/cltbld', 11:12:45 INFO - 'LANG': 'en_US.UTF-8', 11:12:45 INFO - 'LANGUAGE': 'en_US:en', 11:12:45 INFO - 'LOGNAME': 'cltbld', 11:12:45 INFO - 'MAIL': '/var/mail/cltbld', 11:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:45 INFO - 'MOZ_NO_REMOTE': '1', 11:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:45 INFO - 'NO_EM_RESTART': '1', 11:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:45 INFO - 'PWD': '/builds/slave/test', 11:12:45 INFO - 'SHELL': '/bin/bash', 11:12:45 INFO - 'SHLVL': '1', 11:12:45 INFO - 'TERM': 'linux', 11:12:45 INFO - 'TMOUT': '86400', 11:12:45 INFO - 'USER': 'cltbld', 11:12:45 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', 11:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:45 INFO - '_': '/tools/buildbot/bin/python'} 11:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:45 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 11:12:45 INFO - Cleaning up... 11:12:45 INFO - Return code: 0 11:12:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:12: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')]} 11:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12: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')]} 11:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f15c6c3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ca850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c5370>, '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 0x19c88f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c8d80>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', '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 11:12:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:12:45 INFO - Using env: {'DISPLAY': ':0', 11:12:45 INFO - 'HOME': '/home/cltbld', 11:12:45 INFO - 'LANG': 'en_US.UTF-8', 11:12:45 INFO - 'LANGUAGE': 'en_US:en', 11:12:45 INFO - 'LOGNAME': 'cltbld', 11:12:45 INFO - 'MAIL': '/var/mail/cltbld', 11:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:45 INFO - 'MOZ_NO_REMOTE': '1', 11:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:45 INFO - 'NO_EM_RESTART': '1', 11:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:45 INFO - 'PWD': '/builds/slave/test', 11:12:45 INFO - 'SHELL': '/bin/bash', 11:12:45 INFO - 'SHLVL': '1', 11:12:45 INFO - 'TERM': 'linux', 11:12:45 INFO - 'TMOUT': '86400', 11:12:45 INFO - 'USER': 'cltbld', 11:12:45 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', 11:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:45 INFO - '_': '/tools/buildbot/bin/python'} 11:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:46 INFO - Downloading/unpacking psutil>=3.1.1 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12: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 11:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:12:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:48 INFO - Installing collected packages: psutil 11:12:48 INFO - Running setup.py install for psutil 11:12:48 INFO - building 'psutil._psutil_linux' extension 11:12:48 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 11:12:48 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 11:12:48 INFO - building 'psutil._psutil_posix' extension 11:12:48 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 11:12:48 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 11:12:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:12:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:12:48 INFO - Successfully installed psutil 11:12:48 INFO - Cleaning up... 11:12:48 INFO - Return code: 0 11:12:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:48 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 0x7f15c6c3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ca850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c5370>, '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 0x19c88f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c8d80>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', '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 11:12:48 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 11:12:48 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 11:12:48 INFO - Using env: {'DISPLAY': ':0', 11:12:48 INFO - 'HOME': '/home/cltbld', 11:12:48 INFO - 'LANG': 'en_US.UTF-8', 11:12:48 INFO - 'LANGUAGE': 'en_US:en', 11:12:48 INFO - 'LOGNAME': 'cltbld', 11:12:48 INFO - 'MAIL': '/var/mail/cltbld', 11:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:48 INFO - 'MOZ_NO_REMOTE': '1', 11:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:48 INFO - 'NO_EM_RESTART': '1', 11:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:48 INFO - 'PWD': '/builds/slave/test', 11:12:48 INFO - 'SHELL': '/bin/bash', 11:12:48 INFO - 'SHLVL': '1', 11:12:48 INFO - 'TERM': 'linux', 11:12:48 INFO - 'TMOUT': '86400', 11:12:48 INFO - 'USER': 'cltbld', 11:12:48 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', 11:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:48 INFO - '_': '/tools/buildbot/bin/python'} 11:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:12:48 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 11:12:48 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 11:12:48 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 11:12:48 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 11:12:48 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 11:12:48 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 11:12:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:12:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:12:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:12:50 INFO - Installing collected packages: mozsystemmonitor 11:12:50 INFO - Running setup.py install for mozsystemmonitor 11:12:50 INFO - Successfully installed mozsystemmonitor 11:12:50 INFO - Cleaning up... 11:12:50 INFO - Return code: 0 11:12:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:12:50 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')]} 11:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:50 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')]} 11:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:50 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 0x7f15c6c3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ca850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c5370>, '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 0x19c88f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c8d80>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', '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 11:12:50 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 11:12:50 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 11:12:50 INFO - Using env: {'DISPLAY': ':0', 11:12:50 INFO - 'HOME': '/home/cltbld', 11:12:50 INFO - 'LANG': 'en_US.UTF-8', 11:12:50 INFO - 'LANGUAGE': 'en_US:en', 11:12:50 INFO - 'LOGNAME': 'cltbld', 11:12:50 INFO - 'MAIL': '/var/mail/cltbld', 11:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:50 INFO - 'MOZ_NO_REMOTE': '1', 11:12:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:50 INFO - 'NO_EM_RESTART': '1', 11:12:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:50 INFO - 'PWD': '/builds/slave/test', 11:12:50 INFO - 'SHELL': '/bin/bash', 11:12:50 INFO - 'SHLVL': '1', 11:12:50 INFO - 'TERM': 'linux', 11:12:50 INFO - 'TMOUT': '86400', 11:12:50 INFO - 'USER': 'cltbld', 11:12:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', 11:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:50 INFO - '_': '/tools/buildbot/bin/python'} 11:12:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:51 INFO - Downloading/unpacking jsonschema==2.5.1 11:12:51 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 11:12:51 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 11:12:51 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 11:12:51 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 11:12:51 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 11:12:51 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 11:12:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:12:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:53 INFO - Downloading functools32-3.2.3-2.tar.gz 11:12:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:12:53 INFO - warning: no files found matching '*.txt' 11:12:53 INFO - no previously-included directories found matching 'build' 11:12:53 INFO - no previously-included directories found matching 'dist' 11:12:53 INFO - no previously-included directories found matching '.git*' 11:12:53 INFO - Installing collected packages: jsonschema, functools32 11:12:53 INFO - Running setup.py install for functools32 11:12:53 INFO - warning: no files found matching '*.txt' 11:12:53 INFO - no previously-included directories found matching 'build' 11:12:53 INFO - no previously-included directories found matching 'dist' 11:12:53 INFO - no previously-included directories found matching '.git*' 11:12:53 INFO - Successfully installed jsonschema functools32 11:12:53 INFO - Cleaning up... 11:12:53 INFO - Return code: 0 11:12:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:12:53 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')]} 11:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:53 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')]} 11:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:53 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 0x7f15c6c3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ca850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c5370>, '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 0x19c88f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c8d80>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', '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 11:12:53 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 11:12:53 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 11:12:53 INFO - Using env: {'DISPLAY': ':0', 11:12:53 INFO - 'HOME': '/home/cltbld', 11:12:53 INFO - 'LANG': 'en_US.UTF-8', 11:12:53 INFO - 'LANGUAGE': 'en_US:en', 11:12:53 INFO - 'LOGNAME': 'cltbld', 11:12:53 INFO - 'MAIL': '/var/mail/cltbld', 11:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:53 INFO - 'MOZ_NO_REMOTE': '1', 11:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:53 INFO - 'NO_EM_RESTART': '1', 11:12:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:53 INFO - 'PWD': '/builds/slave/test', 11:12:53 INFO - 'SHELL': '/bin/bash', 11:12:53 INFO - 'SHLVL': '1', 11:12:53 INFO - 'TERM': 'linux', 11:12:53 INFO - 'TMOUT': '86400', 11:12:53 INFO - 'USER': 'cltbld', 11:12:53 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', 11:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:53 INFO - '_': '/tools/buildbot/bin/python'} 11:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:12:53 INFO - Cleaning up... 11:12:53 INFO - Return code: 0 11:12:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:12:53 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')]} 11:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:53 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')]} 11:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:53 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 0x7f15c6c3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ca850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c5370>, '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 0x19c88f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c8d80>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', '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 11:12:53 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 11:12:53 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 11:12:53 INFO - Using env: {'DISPLAY': ':0', 11:12:53 INFO - 'HOME': '/home/cltbld', 11:12:53 INFO - 'LANG': 'en_US.UTF-8', 11:12:53 INFO - 'LANGUAGE': 'en_US:en', 11:12:53 INFO - 'LOGNAME': 'cltbld', 11:12:53 INFO - 'MAIL': '/var/mail/cltbld', 11:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:53 INFO - 'MOZ_NO_REMOTE': '1', 11:12:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:53 INFO - 'NO_EM_RESTART': '1', 11:12:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:53 INFO - 'PWD': '/builds/slave/test', 11:12:53 INFO - 'SHELL': '/bin/bash', 11:12:53 INFO - 'SHLVL': '1', 11:12:53 INFO - 'TERM': 'linux', 11:12:53 INFO - 'TMOUT': '86400', 11:12:53 INFO - 'USER': 'cltbld', 11:12:53 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', 11:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:53 INFO - '_': '/tools/buildbot/bin/python'} 11:12:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:53 INFO - Downloading/unpacking blobuploader==1.2.4 11:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:55 INFO - Downloading blobuploader-1.2.4.tar.gz 11:12:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:12:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:12:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:12:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:12:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:12:56 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 11:12:56 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 11:12:56 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 11:12:56 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 11:12:56 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 11:12:56 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 11:12:56 INFO - Downloading docopt-0.6.1.tar.gz 11:12:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:12:56 INFO - Installing collected packages: blobuploader, requests, docopt 11:12:56 INFO - Running setup.py install for blobuploader 11:12:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:12:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:12:56 INFO - Running setup.py install for requests 11:12:57 INFO - Running setup.py install for docopt 11:12:57 INFO - Successfully installed blobuploader requests docopt 11:12:57 INFO - Cleaning up... 11:12:57 INFO - Return code: 0 11:12:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:12:57 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 0x7f15c6c3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ca850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c5370>, '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 0x19c88f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c8d80>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', '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 11:12:57 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 11:12:57 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 11:12:57 INFO - Using env: {'DISPLAY': ':0', 11:12:57 INFO - 'HOME': '/home/cltbld', 11:12:57 INFO - 'LANG': 'en_US.UTF-8', 11:12:57 INFO - 'LANGUAGE': 'en_US:en', 11:12:57 INFO - 'LOGNAME': 'cltbld', 11:12:57 INFO - 'MAIL': '/var/mail/cltbld', 11:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:12:57 INFO - 'MOZ_NO_REMOTE': '1', 11:12:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:12:57 INFO - 'NO_EM_RESTART': '1', 11:12:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:12:57 INFO - 'PWD': '/builds/slave/test', 11:12:57 INFO - 'SHELL': '/bin/bash', 11:12:57 INFO - 'SHLVL': '1', 11:12:57 INFO - 'TERM': 'linux', 11:12:57 INFO - 'TMOUT': '86400', 11:12:57 INFO - 'USER': 'cltbld', 11:12:57 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', 11:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:12:57 INFO - '_': '/tools/buildbot/bin/python'} 11:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:12:57 INFO - Running setup.py (path:/tmp/pip-kzU2hn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:12:57 INFO - Running setup.py (path:/tmp/pip-bZTnyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:12:57 INFO - Running setup.py (path:/tmp/pip-csh3sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:12:57 INFO - Running setup.py (path:/tmp/pip-o8fgYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:12:57 INFO - Running setup.py (path:/tmp/pip-oBRxe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:12:57 INFO - Running setup.py (path:/tmp/pip-WE0V6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:12:57 INFO - Running setup.py (path:/tmp/pip-x5X9Ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:12:57 INFO - Running setup.py (path:/tmp/pip-aFpnWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:12:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:12:57 INFO - Running setup.py (path:/tmp/pip-qx81AP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:12:58 INFO - Running setup.py (path:/tmp/pip-L5103H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:12:58 INFO - Running setup.py (path:/tmp/pip-ksChx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:12:58 INFO - Running setup.py (path:/tmp/pip-35qAyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:12:58 INFO - Running setup.py (path:/tmp/pip-MWn3fS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:12:58 INFO - Running setup.py (path:/tmp/pip-AWMvjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:58 INFO - Running setup.py (path:/tmp/pip-6aF7Jn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:12:58 INFO - Running setup.py (path:/tmp/pip-8ncXx3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:12:58 INFO - Running setup.py (path:/tmp/pip-k2RNXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:12:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:12:58 INFO - Running setup.py install for manifestparser 11:12:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:12:58 INFO - Running setup.py install for mozcrash 11:12:58 INFO - Running setup.py install for mozdebug 11:12:58 INFO - Running setup.py install for mozdevice 11:12:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:12:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:12:59 INFO - Running setup.py install for mozfile 11:12:59 INFO - Running setup.py install for mozhttpd 11:12:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:12:59 INFO - Running setup.py install for mozinfo 11:12:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:12:59 INFO - Running setup.py install for mozInstall 11:12:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:12:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:12:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:12:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:12:59 INFO - Running setup.py install for mozleak 11:12:59 INFO - Running setup.py install for mozlog 11:12:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:12:59 INFO - Running setup.py install for moznetwork 11:12:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:12:59 INFO - Running setup.py install for mozprocess 11:12:59 INFO - Running setup.py install for mozprofile 11:12:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:12:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:12:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:12:59 INFO - Running setup.py install for mozrunner 11:13:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:13:00 INFO - Running setup.py install for mozscreenshot 11:13:00 INFO - Running setup.py install for moztest 11:13:00 INFO - Running setup.py install for mozversion 11:13:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:13:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:13:00 INFO - Cleaning up... 11:13:00 INFO - Return code: 0 11:13:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:00 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 0x7f15c6c3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ca850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c5370>, '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 0x19c88f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c8d80>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', '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 11:13:00 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 11:13:00 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 11:13:00 INFO - Using env: {'DISPLAY': ':0', 11:13:00 INFO - 'HOME': '/home/cltbld', 11:13:00 INFO - 'LANG': 'en_US.UTF-8', 11:13:00 INFO - 'LANGUAGE': 'en_US:en', 11:13:00 INFO - 'LOGNAME': 'cltbld', 11:13:00 INFO - 'MAIL': '/var/mail/cltbld', 11:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:00 INFO - 'MOZ_NO_REMOTE': '1', 11:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:00 INFO - 'NO_EM_RESTART': '1', 11:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:00 INFO - 'PWD': '/builds/slave/test', 11:13:00 INFO - 'SHELL': '/bin/bash', 11:13:00 INFO - 'SHLVL': '1', 11:13:00 INFO - 'TERM': 'linux', 11:13:00 INFO - 'TMOUT': '86400', 11:13:00 INFO - 'USER': 'cltbld', 11:13:00 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', 11:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:00 INFO - '_': '/tools/buildbot/bin/python'} 11:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:00 INFO - Running setup.py (path:/tmp/pip-1002zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:00 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)) 11:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:00 INFO - Running setup.py (path:/tmp/pip-V00_dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:00 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)) 11:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:00 INFO - Running setup.py (path:/tmp/pip-lSKcFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:00 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)) 11:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:00 INFO - Running setup.py (path:/tmp/pip-_hgRbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:00 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)) 11:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:00 INFO - Running setup.py (path:/tmp/pip-C5REm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:01 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)) 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:01 INFO - Running setup.py (path:/tmp/pip-a3Sosb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:01 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)) 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:01 INFO - Running setup.py (path:/tmp/pip-7PAxYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:01 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)) 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:01 INFO - Running setup.py (path:/tmp/pip-gaevpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:01 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)) 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:01 INFO - Running setup.py (path:/tmp/pip-dWGIQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:01 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)) 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:01 INFO - Running setup.py (path:/tmp/pip-IEa0q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:01 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)) 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:01 INFO - Running setup.py (path:/tmp/pip-mhvkTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:01 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)) 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:01 INFO - Running setup.py (path:/tmp/pip-Eh0j0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:01 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)) 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:01 INFO - Running setup.py (path:/tmp/pip-88U0U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:01 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)) 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:01 INFO - Running setup.py (path:/tmp/pip-9j23DJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:01 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)) 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:01 INFO - Running setup.py (path:/tmp/pip-blZrEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:01 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)) 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:01 INFO - Running setup.py (path:/tmp/pip-_VLtxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:01 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)) 11:13:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:01 INFO - Running setup.py (path:/tmp/pip-QEfOBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:01 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)) 11:13:01 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)) 11:13:01 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)) 11:13:01 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)) 11:13:01 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)) 11:13:01 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)) 11:13:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:13:01 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 11:13:01 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 11:13:01 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 11:13:01 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 11:13:01 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 11:13:01 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 11:13:03 INFO - Downloading blessings-1.6.tar.gz 11:13:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:13:03 INFO - Installing collected packages: blessings 11:13:03 INFO - Running setup.py install for blessings 11:13:03 INFO - Successfully installed blessings 11:13:03 INFO - Cleaning up... 11:13:04 INFO - Return code: 0 11:13:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:13:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:04 INFO - Reading from file tmpfile_stdout 11:13:04 INFO - Current package versions: 11:13:04 INFO - argparse == 1.2.1 11:13:04 INFO - blessings == 1.6 11:13:04 INFO - blobuploader == 1.2.4 11:13:04 INFO - docopt == 0.6.1 11:13:04 INFO - functools32 == 3.2.3-2 11:13:04 INFO - jsonschema == 2.5.1 11:13:04 INFO - manifestparser == 1.1 11:13:04 INFO - mozInstall == 1.12 11:13:04 INFO - mozcrash == 0.17 11:13:04 INFO - mozdebug == 0.1 11:13:04 INFO - mozdevice == 0.48 11:13:04 INFO - mozfile == 1.2 11:13:04 INFO - mozhttpd == 0.7 11:13:04 INFO - mozinfo == 0.9 11:13:04 INFO - mozleak == 0.1 11:13:04 INFO - mozlog == 3.3 11:13:04 INFO - moznetwork == 0.27 11:13:04 INFO - mozprocess == 0.23 11:13:04 INFO - mozprofile == 0.28 11:13:04 INFO - mozrunner == 6.12 11:13:04 INFO - mozscreenshot == 0.1 11:13:04 INFO - mozsystemmonitor == 0.3 11:13:04 INFO - moztest == 0.7 11:13:04 INFO - mozversion == 1.4 11:13:04 INFO - psutil == 3.1.1 11:13:04 INFO - requests == 1.2.3 11:13:04 INFO - wsgiref == 0.1.2 11:13:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:04 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')]} 11:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:04 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')]} 11:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:04 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 0x7f15c6c3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ca850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c5370>, '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 0x19c88f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c8d80>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', '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 11:13:04 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 11:13:04 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 11:13:04 INFO - Using env: {'DISPLAY': ':0', 11:13:04 INFO - 'HOME': '/home/cltbld', 11:13:04 INFO - 'LANG': 'en_US.UTF-8', 11:13:04 INFO - 'LANGUAGE': 'en_US:en', 11:13:04 INFO - 'LOGNAME': 'cltbld', 11:13:04 INFO - 'MAIL': '/var/mail/cltbld', 11:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:04 INFO - 'MOZ_NO_REMOTE': '1', 11:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:04 INFO - 'NO_EM_RESTART': '1', 11:13:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:04 INFO - 'PWD': '/builds/slave/test', 11:13:04 INFO - 'SHELL': '/bin/bash', 11:13:04 INFO - 'SHLVL': '1', 11:13:04 INFO - 'TERM': 'linux', 11:13:04 INFO - 'TMOUT': '86400', 11:13:04 INFO - 'USER': 'cltbld', 11:13:04 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', 11:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:04 INFO - '_': '/tools/buildbot/bin/python'} 11:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:04 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)) 11:13:04 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)) 11:13:04 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)) 11:13:04 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)) 11:13:04 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)) 11:13:04 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)) 11:13:04 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)) 11:13:04 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)) 11:13:04 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)) 11:13:04 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)) 11:13:04 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)) 11:13:04 INFO - Cleaning up... 11:13:04 INFO - Return code: 0 11:13:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:13:04 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')]} 11:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:04 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')]} 11:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:13:04 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 0x7f15c6c3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ca850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c5370>, '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 0x19c88f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c8d80>, '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': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', '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 11:13:04 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 11:13:04 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 11:13:04 INFO - Using env: {'DISPLAY': ':0', 11:13:04 INFO - 'HOME': '/home/cltbld', 11:13:04 INFO - 'LANG': 'en_US.UTF-8', 11:13:04 INFO - 'LANGUAGE': 'en_US:en', 11:13:04 INFO - 'LOGNAME': 'cltbld', 11:13:04 INFO - 'MAIL': '/var/mail/cltbld', 11:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:04 INFO - 'MOZ_NO_REMOTE': '1', 11:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:04 INFO - 'NO_EM_RESTART': '1', 11:13:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:04 INFO - 'PWD': '/builds/slave/test', 11:13:04 INFO - 'SHELL': '/bin/bash', 11:13:04 INFO - 'SHLVL': '1', 11:13:04 INFO - 'TERM': 'linux', 11:13:04 INFO - 'TMOUT': '86400', 11:13:04 INFO - 'USER': 'cltbld', 11:13:04 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', 11:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:04 INFO - '_': '/tools/buildbot/bin/python'} 11:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:13:04 INFO - Cleaning up... 11:13:04 INFO - Return code: 0 11:13:04 INFO - Running post-action listener: _resource_record_post_action 11:13:04 INFO - Running post-action listener: _start_resource_monitoring 11:13:04 INFO - Starting resource monitoring. 11:13:04 INFO - [mozharness: 2016-09-03 18:13:04.706158Z] Finished create-virtualenv step (success) 11:13:04 INFO - [mozharness: 2016-09-03 18:13:04.706671Z] Running install step. 11:13:04 INFO - Running pre-action listener: _resource_record_pre_action 11:13:04 INFO - Running main action method: install 11:13:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:04 INFO - Reading from file tmpfile_stdout 11:13:04 INFO - Detecting whether we're running mozinstall >=1.0... 11:13:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:13:04 INFO - Reading from file tmpfile_stdout 11:13:04 INFO - Output received: 11:13:04 INFO - Usage: mozinstall [options] installer 11:13:05 INFO - Options: 11:13:05 INFO - -h, --help show this help message and exit 11:13:05 INFO - -d DEST, --destination=DEST 11:13:05 INFO - Directory to install application into. [default: 11:13:05 INFO - "/builds/slave/test"] 11:13:05 INFO - --app=APP Application being installed. [default: firefox] 11:13:05 INFO - mkdir: /builds/slave/test/build/application 11:13:05 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'] 11:13:05 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 11:13:22 INFO - Reading from file tmpfile_stdout 11:13:22 INFO - Output received: 11:13:22 INFO - /builds/slave/test/build/application/firefox/firefox 11:13:22 INFO - Running post-action listener: _resource_record_post_action 11:13:22 INFO - [mozharness: 2016-09-03 18:13:22.004959Z] Finished install step (success) 11:13:22 INFO - [mozharness: 2016-09-03 18:13:22.005241Z] Running run-tests step. 11:13:22 INFO - Running pre-action listener: _resource_record_pre_action 11:13:22 INFO - Running main action method: run_tests 11:13:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:13:22 INFO - Python 2.7.3 11:13:22 INFO - Return code: 0 11:13:22 INFO - grabbing minidump binary from tooltool 11:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:22 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 0x19c5370>, '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 0x19c88f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19c8d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:13:22 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 11:13:22 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 11:13:22 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 11:13:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:13:22 INFO - Return code: 0 11:13:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:13:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:13:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:13:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:13:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:13:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 11:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 11:13:22 INFO - Using env: {'DISPLAY': ':0', 11:13:22 INFO - 'HOME': '/home/cltbld', 11:13:22 INFO - 'LANG': 'en_US.UTF-8', 11:13:22 INFO - 'LANGUAGE': 'en_US:en', 11:13:22 INFO - 'LOGNAME': 'cltbld', 11:13:22 INFO - 'MAIL': '/var/mail/cltbld', 11:13:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:13:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:22 INFO - 'MOZ_NO_REMOTE': '1', 11:13:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:22 INFO - 'NO_EM_RESTART': '1', 11:13:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:22 INFO - 'PWD': '/builds/slave/test', 11:13:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:13:22 INFO - 'SHELL': '/bin/bash', 11:13:22 INFO - 'SHLVL': '1', 11:13:22 INFO - 'TERM': 'linux', 11:13:22 INFO - 'TMOUT': '86400', 11:13:22 INFO - 'USER': 'cltbld', 11:13:22 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575', 11:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:22 INFO - '_': '/tools/buildbot/bin/python'} 11:13:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 11:13:22 INFO - mozversion application_buildid: 20160903083042 11:13:22 INFO - mozversion application_changeset: bcab45259b4fe5787d0d6fea16067e763f2a11ea 11:13:22 INFO - mozversion application_display_name: Nightly 11:13:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:13:22 INFO - mozversion application_name: Firefox 11:13:22 INFO - mozversion application_remotingname: firefox 11:13:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:13:22 INFO - mozversion application_vendor: Mozilla 11:13:22 INFO - mozversion application_version: 51.0a1 11:13:22 INFO - mozversion platform_buildid: 20160903083042 11:13:22 INFO - mozversion platform_changeset: bcab45259b4fe5787d0d6fea16067e763f2a11ea 11:13:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:13:22 INFO - mozversion platform_version: 51.0a1 11:13:22 INFO - using testdate: 1472926402 11:13:22 INFO - actual date: 1472926402 11:13:22 INFO - starting webserver on 'localhost:50668' 11:13:22 INFO - SUITE-START | Running 2 tests 11:13:22 INFO - TEST-START | dromaeo_css 11:13:22 INFO - operating with platform_type : linux_ 11:13:22 INFO - Initialising browser for dromaeo_css test... 11:13:22 INFO - TEST-INFO | started process 19728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8FPJ5O/profile http://localhost:50668/getInfo.html) 11:13:27 INFO - PROCESS | 19728 | __metrics Screen width/height:1600/1200 11:13:27 INFO - PROCESS | 19728 | colorDepth:24 11:13:27 INFO - PROCESS | 19728 | Browser inner width/height: 1024/697 11:13:27 INFO - PROCESS | 19728 | __metrics 11:13:27 INFO - PROCESS | 19728 | 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:13:27 INFO - PROCESS | 19728 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:13:28 INFO - PROCESS | 19728 | console.error: PushService: 11:13:28 INFO - PROCESS | 19728 | stateChangeProcessEnqueue: Error transitioning state 11:13:28 INFO - PROCESS | 19728 | UnknownError 11:13:28 INFO - TEST-INFO | 19728: exit 0 11:13:28 INFO - Browser initialized. 11:13:28 INFO - Running cycle 1/1 for dromaeo_css test... 11:13:28 INFO - TEST-INFO | started process 19811 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8FPJ5O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:40 INFO - PROCESS | 19811 | RSS: Main: 179351552 11:13:40 INFO - PROCESS | 19811 | 11:14:32 INFO - PROCESS | 19811 | 1472926472504 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] 11:16:41 INFO - PROCESS | 19811 | Cycle 1(1): loaded http://localhost:50668/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50668/tests/dromaeo/cssquery-ext.html) 11:16:42 INFO - PROCESS | 19811 | RSS: Main: 291360768 11:16:42 INFO - PROCESS | 19811 | 11:19:45 INFO - PROCESS | 19811 | Cycle 1(1): loaded http://localhost:50668/tests/dromaeo/cssquery-ext.html (next: http://localhost:50668/tests/dromaeo/cssquery-jquery.html) 11:19:46 INFO - PROCESS | 19811 | RSS: Main: 271003648 11:19:46 INFO - PROCESS | 19811 | 11:22:48 INFO - PROCESS | 19811 | Cycle 1(1): loaded http://localhost:50668/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50668/tests/dromaeo/cssquery-mootools.html) 11:22:48 INFO - PROCESS | 19811 | RSS: Main: 251744256 11:22:48 INFO - PROCESS | 19811 | 11:25:50 INFO - PROCESS | 19811 | Cycle 1(1): loaded http://localhost:50668/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50668/tests/dromaeo/cssquery-prototype.html) 11:25:51 INFO - PROCESS | 19811 | RSS: Main: 224178176 11:25:51 INFO - PROCESS | 19811 | 11:28:54 INFO - PROCESS | 19811 | Cycle 1(1): loaded http://localhost:50668/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50668/tests/dromaeo/cssquery-yui.html) 11:28:54 INFO - PROCESS | 19811 | RSS: Main: 211886080 11:28:54 INFO - PROCESS | 19811 | 11:31:57 INFO - PROCESS | 19811 | Cycle 1(1): loaded http://localhost:50668/tests/dromaeo/cssquery-yui.html (next: http://localhost:50668/tests/dromaeo/cssquery-dojo.html) 11:31:57 INFO - PROCESS | 19811 | RSS: Main: 305991680 11:31:57 INFO - PROCESS | 19811 | 11:31:57 INFO - PROCESS | 19811 | __start_tp_report 11:31:57 INFO - PROCESS | 19811 | _x_x_mozilla_page_load 11:31:57 INFO - PROCESS | 19811 | _x_x_mozilla_page_load_details 11:31:57 INFO - PROCESS | 19811 | |i|pagename|runs| 11:31:57 INFO - PROCESS | 19811 | |0;dojo.html;2938.1919972007695;2938.206684195267;2959.896403625872;2982.716641919017;3004;5159;5209.140491818855;5251.081060814361;5296.417394086652;5300.178472336789;5272.077386457364;5275.683458992454;5293.8941221175555;5296.3379577552805;5332.493413125757;4729.692569982949;4732.313814496896;4872.317875497433;4918.803247870099;4932.654714170009;4861.805527778884;4902.411710594733;4910.337104490902;4930.852074437773;4949.505049495057;4694.624430045588;4716.127516409475;4825.975870120662;4836.758162091899;4906.901861962759;4733.644976626767;4776.044791041805;4875.268709693574;4877.317175595419;4884.877878053042;4690.413698287714;4733.5976442002475;4772.9761351193365;4781.3545171401765;4844.418669759616;5271.341082364705;5285.339332583427;5290.867728306823;5298.417174110883;5304.098303288451;5464.972675136639;5496.725163741797;5520.972395138038;5539.695316757577;5575.8884822303735;5546.500814926676;5575.8606034849045;5587.916181257285;5588.077967135418;5596;5178.275041494118;5204.089284375219;5218.347706536683;5223.216517522326;5226.320578324793;5666.320041595035;5724.542036637059;5726.3700992890745;5763.394843541368;5827.125931110282;5525.198846167284;5539.362973258047;5550.16747487872;5551.555875529948;5552.028395030934;5481.287432633732;5515.283013208337;5537.446255374511;5549.306336707911;5603.131514615241;5502.367227768857;5537.529310008614;5546.195801608744;5585;5652.689102099424;5582.8325150245555;5605.495505404533;5612.186232996192;5612.466815652589;5612.719364031782;4319.071399649028;4371.606555410029;4382.123575284956;4389.385486031958;4392.275274579659;3846.653801157853;3861.362875125629;3888.261230366278;3912.4131380293184;3974.82113304902;5335.679859208382;5340.19897015443;5341.332333458317;5341.946580534145;5407.242985981887;5527.723613819293;5587.413321601254;5631.155326701028;5632.464915833071;5639.295088113986;5286.3392075990505;5293.894122117536;5307.9734601326745;5359.758810853521;5374.435684253175;4797.328374027639;4802.927956080662;4835.854924352275;4851.102546028926;4856.781444834991;5645.068563686946;5811.389804070596;5817.650940943557;5819.941800582024;5823.417658234142;5485.917711234414;5534;5549.889002219852;5566.970110529565;5638.097904335286;5804.419558044162;5812.447817457335;5829.883402331845;5831.94168058314;5832.3292821326095;5344.919826202532;5494.587905907153;5502.944970550243;5504.4495550444635;5510.256115424367;5500.1749737539685;5539.833804985857;5560.499555040065;5572.526335261548;5647.926893890148;5431.076716958048;5459.2629994950175;5462.91805622908;5464.426235245401;5466.91799623014;5323.547498462519;5392.460753924576;5452.209429632601;5453.754581043783;5515.724213789214;5398.973005134949;5417.5665946723375;5453.454654534674;5479.342478902558;5543.77824887;5499.312585926759;5508.256385388082;5510.724463776715;5517.200005999188;5520.06158952971;5302.416734159162;5393.27190829233;5407.972960135174;5413.675179489243;5464.890702186013 11:31:57 INFO - PROCESS | 19811 | |1;ext.html;558.6675332794181;588.5379976718277;589.2810770859552;593.9940600593993;613.5153228949131;32324.009836655532;43449.78275108624;44592.3311150333;44595.33107003389;44705;45834.770826145905;46414;46431.535684643146;46469.30296045562;46491.53508464914;8090.555019473926;8951.149640784148;9063.139001794852;9120.407173533698;10631.149508039338;10326.483675816216;10750.623728169516;10762.461876906124;10764.677059688222;10766.40784756838;10785.676429707122;10813.567457301699;10826.18803589734;10830.350178989247;10835.404052777094;10691.893081069167;10718.73203169927;10746.785064298749;10752.086072683831;10762.354258744423;10596.62911798091;10680.412577308245;10681.41252231127;10685.091767199798;10692.091172250368;41952.79023604893;42621.36067958983;42681.35977960333;42776.78611606922;42788.35817462741;3533.6819686228364;3633.618470060632;3747.4191500317493;3956.5647778744315;4205.074883525619;32120.196995075075;32385.352292954245;32890.671093289;32945.176370590685;33004.50493242603;4333.739975601474;4401.889952751175;4404.647628189769;4503.797329120198;4615.653825963066;342284;347123;347895;347902;348471;57763.13355299674;58124.4187558119;58179.4182058174;58194.4180558189;58629.41370586325;62444;63252;63324.68337658282;63330;63377.68311158415;15690.68618627621;15855.920720396323;15924.363025479082;15930.840691593168;15947.122908240159;10725.51735171919;12590.43343049565;12746.617601471971;13158.934205329104;13265.734685306434;17057.402990895258;17211.91394043022;17267.65464690699;17288.308467661154;17302.134893255286;6166.845828854225;6389.520785941073;6411.2306523216575;6442;6507.674616269168;733.512214377433;871.7384784564732;879.5162660536679;892.2950868813695;919.8068405634891;29689.406211876074;30604.23489412738;30754.69245307563;31113;31245.375092498478;963.5375019990444;1082.680609220282;1100.4208960142062;1129.170060005895;1146.879577644352;15476.922615386851;16258.593535161715;16318.592035198977;16453.753193702105;16653.41713040038;524359.7820108979;534800;535483;536044;841908;58287;58928.41071589229;58966;58989.410105898394;59050.40949590449;1220.3288191494642;1286.6204469681466;1343.543195313598;1349.6355983884296;1395.3511617097895;28064.579031314137;32695.50956735603;33064.83467582647;33092.1726956828;33788.83105584457;50797;51357.48642513527;51396;51401.7429912848;51427.228591570405;395076;395791;395926;396528;397772;25042.62436063424;27222.72777272202;27963.72036279611;28150.71849281481;28453.857730712043;45196;45930.4069593038;45967;46170.307445387676;47159.29261061018;38506.61493385142;38554;38746.80626596849;40738.38892416676;41061.38407923943;37943.810280949525;38875.416868746426;39094.80452597719;39822.60177398189;40673.38989915094;39070.218595628496;39943.80028099841;40016.7999160014;40347.59652403439;40557.797211013756;32757.181070472474;34897.65102348944;35418.65742952753;35792.64207357997;35991.46012809758;27224;27279.86360068187;27392.45215095727;27414;27449.31376715598 11:31:57 INFO - PROCESS | 19811 | |2;jquery.html;377.68463333116847;396.4924896132949;408.2019651581159;409.32665764816875;425.42142685947124;15695.372185112596;19196.98431664676;19235.615287694236;19409.708854367178;20214.89892550539;18968.905155474204;19262.13320400582;19432;19574.11916463759;19737.309194178208;5237.162054071349;5737.971310143444;5932.792352267671;5953.047512397996;5986.97006514969;4282.7858607069675;5862.120681897707;6321.209848768904;6520.576162549419;6556.246031706343;6362.5546211765195;6636.834079148011;6638.269790323061;6648.368405001541;6648.867022659544;6532.902006469907;6560.671966401661;6569.901451478232;6584.374484423972;6599;5657.8019769308285;5720.599558030939;5784.595078344518;5851.912221316684;5859.970700146515;21565.24521641751;22198.667019994715;22438.214662486735;23284.534309313887;23312;2454.7913427358694;2552.642630031797;2603.856787876666;2709.376843326026;2816.802823802335;9737.123658870665;9974.251931105124;10268.794624107475;10358.585656573729;10803.83794243087;1868.234024050133;1868.7383766272733;1880.576870204207;1914.2438736698925;1930.691089425685;78185.60907195427;86130.56934715349;87061.99999999936;88240;88496.557517212;10544.156467482582;10666.36001839892;11063;11213.327200368005;11311.60409385684;15221.31504082319;15246.313915873812;15265;15290.847091528942;15299.923500382427;7987.640556174986;8124.106348301682;8152.307053900485;8317.500949943023;8388.245057944814;8138.593070346577;8180.263776260165;8206.8358632827;8382.538960357238;8487.830243395098;4616.76916154191;4705.7647117644665;4750.7387093709485;4760.523947605281;4879.194932836113;1829.6889528779873;1869.9065046747608;1962.8037196280543;2004.298495526554;2026.9189232430538;1005.7636455432968;1006.9899301007042;1016.8576399304103;1057.6721216422934;1060.6128763001602;17801.554961125817;19235.90382048109;19396.612067758848;19514.70727939082;19753.802461975483;989.8119357322086;989.9604015839429;991.5587563534302;1054.298891237334;1083.0847933496184;10203.38779673222;10803.891961080446;10832.24174307791;10878.728031799268;10910.836337454944;459669;462909;469903;472842;475170;92429.53785231031;93628.53185734028;94141.57973919297;95689.52155239179;96519.51740241394;962.9614815407306;964.0841200859212;964.971050868461;974.0600320690568;974.9415035097917;15868.285927133076;15972.760408594113;16265.674686505967;16287.18564071768;17435;38385.23229535449;40320;40403.797981009906;43248.783756081015;45040.27077156983;55919.73043504318;56760.716196418754;56946.145807812085;57645;58888;6468.997305417668;7511.549307041595;7949.7217597383815;8367.121452247426;8482.787930301793;12067.75864482688;12969.54606588765;13017.153884997444;13028.804567931298;13208.603741887759;11010.50452729645;11167;11844.585439509576;11954.402279886144;12015.339156346485;11084.390358530036;11237.269577477438;11436.256643318158;11629.302241865515;11711.531538738354;11367.658970230907;11515.481803319039;11704;11829.881701183222;12167.695807604881;7611.3530349920875;7749.380049596131;7798.688052477837;7997;8082.87875681877;10664.786704266027;10932.726681833017;11398.430078495876;11752.412379381169;11954.820677689668 11:31:57 INFO - PROCESS | 19811 | |3;mootools.html;1463.5024091808782;1480.267267702487;1638.7378019516873;1732.3243934865413;1792.8027916929127;7554.962225188873;8056.274935255826;8058.315043221319;8058.355331573474;8069.5561744104125;7287.453440991933;7892.56590887501;7971.282584567388;8093.919060809405;8205.097439281673;2371.1819422299363;2403.146882856587;2403.2790162951133;2404.218628945591;2407.9157229496973;2323.744388117306;2332.825038122148;2382.845115067515;2386.570417324881;2390.3307074019303;2341.7424083350816;2346.296111166652;2350.6239001759723;2363.0075368345338;2369.2655276864143;2262.9207977720866;2279.3731723775927;2281.2243837095384;2287.5081857400573;2313.5372925414817;2292.79364857162;2293.8853057347233;2318.1654604342593;2318.3392733070996;2323.2913961241816;8325.626271665167;8463;8470.152984701543;8517.446365986252;8518.70184543538;4996.4503904570465;5042.949570504321;5167.819126330561;5176.094183517869;5186.273921650972;3127.749780017593;3191.266008817962;3259.38071766366;3270.1661076425357;3285.720713739335;1136.4261048170704;1156.6587856582328;1948.1038722187811;2004.7995200479836;2031.3702752146883;11274;11309.604163854226;11366.318020918772;11386.430678466044;11388.886111138783;4275.828966841292;4308.202982448257;4465.665075119314;4505.45934487857;4508.07584445188;9071.183593476619;9082.818343633222;9091.227245684191;9095.454272743656;9098.772530686785;4980.277859710394;5009.824656137018;5010.098182327216;5018.974905125451;5020.2720605511995;4229.788510574459;4618.976905115453;4673.929891051637;4674.368960190331;4693.55411235932;3599.190182208982;3617.5297211362354;3693.2059607184046;3716.572594151653;3739.457778622085;1120.0535547462382;1138.282881784487;1138.6185627814775;1143.3711458697683;1147.2198904744687;914.1726737302752;931.3108299858056;940.2759874896292;947.9810403792023;954.5255270814241;5498.202760599691;5590.8043218487155;5613.242212301368;5730.656160630376;5868;919.6435257994405;959.3236768078627;966.0725703324746;975.770693886936;991.9355241909253;3465.792052476809;3754.3805272129794;3796.9430458543143;3851.094992676719;3945.8027098645525;9998.850017249748;10117.140043096271;10128;10206.336588121749;10210.795784084425;10097.646582369729;10115.241356898116;10121.59513619447;10123.1901447884;10134.797304053878;7444.330010299099;7778.222177782177;7861.371090312761;7863.6409077276585;7892.329152022027;5299.6290259681455;5318.680879147263;5417;5620.606557541097;5674.574406919415;9235.953820230856;9254.861177082485;9483.573239204114;9530.428174309563;9599.568019439283;9260.166585007382;9408.341416100808;9440.575174117044;9585.72935113531;9695.515224238901;6755.898661520179;7190.820229494305;7253.492255542273;7315;7478.439117066133;8103.716369927024;8162.265396114378;8172.305354044735;8173.918260817316;8181.6318265677;7153.60655163971;7372.852542949218;7390.778276651709;7438.6652600632015;7478.738244161428;6841.350071743176;6937.75717849893;6985.825354366181;7027.15674119109;7205.207427182901;6308.27454842699;6473.611583305017;6534.869302613826;6574.145361103026;6656.933430665825;4855.927161092657;4887.926681099715;4914.7542622867995;4966.925496117633;5024.522670346311;4893.825481884393;4958.528939750718;4964.404271487445;5029.371328583927;5129.256257842518 11:31:57 INFO - PROCESS | 19811 | |4;prototype.html;300.2433866656028;313.84778382484507;316.0565711351616;319.4744645058878;323.08405669925764;5115.2071428928575;5188.650950752813;5286.7356632168385;5330;5370.999999999995;5217;5218.660787048839;5250.579953603712;5251.55361794247;5256.185291279849;4135.793210339486;4136.751794892309;4143.606357396043;4148.398482220076;4148.6266236038755;3923.2938071147323;4057.2291264659766;4143.544210136883;4150.066235097109;4155.771432571208;4047;4048.4413500802257;4049.7975101244965;4060.1473690525027;4072.450219220397;4023.939640905389;4041.3735870939904;4042.676585873138;4044.170944956277;4076.9592304076878;3539.929201415983;3614.493970844084;3636.254567813592;3636.5454318210222;3642.9799656096334;5088.491150884919;5105.412877519058;5117.769700363456;5117.820876269313;5151.639385243035;4710.717356958594;4712.434507859079;4712.929306060412;4724.858254252378;4753.928691069636;5328.307320048408;5464.617476776627;5504.541296556416;5510.6418082824885;5522.806701765459;3996.360582306817;3998.520177578709;4007.9599204007877;4013.779242141681;4018.8794336169963;5729.742161602738;5763.2507773989955;5781.913271300934;5798.710064496759;5807.448292412214;4038.919221615551;4111.588841115924;4118.135191609736;4126.649234815014;4141.529756936245;4159.563245859202;4160.958390416057;4182.912442764903;4186.769727664947;4191.811368488365;4716.811327546929;4743.407074115736;4764;4780.737059461693;4786.617070634341;5315.893682126336;5431;5525.889482210333;5532.30846144232;5533.833984980457;1371.3349025722516;1411.5553600615774;1447.8117844680335;1456.83974762776;1458.8030615866935;965.4931161140317;978.3298440568092;1005.3615953869199;1008.2639673038723;1024.8667673202585;5326.307580014573;5342.866428339323;5355;5381.730913454312;5384.1385378340065;5612.494875461228;5614.427960171159;5621.0444224481935;5629.31280011593;5671.51792097668;5224.164133738584;5305.885763989605;5395.406505284415;5440.863978400572;5445.346558413015;2641.550936340827;2657.2161212442375;2657.6677915260593;2665;2678.825876318033;5195.376554813371;5200.843974680765;5210.270562121306;5259.21111833228;5277.472252774769;4745.525447455227;4984.461032666847;5036.345275114285;5055.823046193365;5094.898102038012;5111.361079865017;5143.305653736773;5163.66436181647;5163.690178589221;5180.922286165635;4914.238293064581;5004;5026.271190677258;5044.218146187347;5073.604758691389;4608.331791890224;4922.852314430573;4923.409190897115;4931.950680493293;4948.727819969792;5154.768035438489;5189.584833213409;5204.724842413481;5205.557527610044;5218.765155568084;3788.1666033472593;3805.6384643459933;3809.9045524961716;3814.5422549294262;3822.7515211512277;4650.441946966385;5017.67385119966;5049.030877957673;5092.821751238689;5424.430434804446;5416.322959630046;5467.316585426822;5469.577909743575;5478.780848766005;5610.102383618601;5527.4246839650505;5547.306586676666;5621.35354434229;5625.324961004706;5641.210230567642;5254.579633629224;5515.724213789214;5537.8061767837935;5611.691356975405;5647.802326918538;5572.498475137257;5589.972050139886;5607.271054762855;5612.7193640317;5616.719164041863;5484.107982745946;5485.6434331768305;5500.3949565548555;5501.697406642673;5508.190822680542 11:31:57 INFO - PROCESS | 19811 | |5;yui.html;800.6077022259093;821.1952286758973;823.3948048184587;840.93692973027;854.5940678177865;15385.538433846988;16100.516984490454;16200.51398458048;16271.918640406797;16277;13393.492995483035;13723.382447789849;14403.351849166786;14426.134431934091;14540.909431792632;797.2983774278626;802.9036515618105;803.2850762821093;803.5500119932856;803.5540275147291;664.3489380407204;791.4301702773994;802.2859654907137;804.8350088231898;809.7894547417684;854.7393045121236;860.0453496618749;860.0668274921718;860.1785295043219;860.1914200651399;856.5545916123612;858.3991206155716;858.6908712863365;859.1236938322876;859.1279850951289;508.22241969786285;517.9922301165485;519.13823053731;630.7918386932301;631.0093153748617;12666.87333126666;13100.737985240337;13158.934205329007;13336.19982801035;13342.199468031851;14334.211618360985;15538.378464861393;15564.844351556452;15657.843421565753;15910.680362873389;11301.152413569016;11359.602413915472;11387;11425.873465533488;11786.587469438615;3778.8299526521096;3843.6925045996254;3860.691144708445;3862.633049860259;3898.4347269646028;77917;77975;78494;78872;79877.60061199714;11755.823662644896;11876.584319548774;11953.940230298793;12025.398730063462;12027.879721202851;22348.441288967904;22365.888170559043;22415;22418.103275869107;22425.32724018282;8149.877751833727;8172.754817355489;8218.178182181735;8349.624266907882;8523.105073967268;4576.519465456146;4577.771111444481;4584.541545845389;4630.143423466669;4834.854954351375;3241.7082462578483;3310.7915610802365;3312.503124531291;3316.4527852904002;3321.8837340693444;603.2911329188187;610.5451438678214;612.5834432585884;612.6569121292091;615.0804547201961;563.2846285217751;649.7206201333378;679.3851564334285;683.9214133716;722.1767185408638;9623.807523849484;9740.220782337396;9793.755156121011;9987.500624968723;10376.688699339033;651.4560342114388;687.4363022321749;693.7675878580732;700.7932659865352;721.7077083781077;4286.485621725351;4628.675992680547;4640.257558790578;4761.428628564595;4832.589229915427;122361;124048.37975810064;124110;131319.34340328237;131739;69010;109848;112165.43917280524;115759;116618;57645.13532296935;68862.65568672125;88705;88719.55640221758;93115.53442232746;8634.084275129007;8839.69061082859;8879.422837515542;9001.729948101567;9214.308926830648;51082.489175107774;51811.74094129656;52677.7366113167;54163.45836541742;54163.72918135384;73213;79557.20442795497;80079.59960200162;84280.15719842969;84930.57534712287;10672.413017284123;11387.882672708985;11476.540938362372;11752.529898803952;11864.881351186377;12931.418086185957;13065.216087034809;13633.659158520719;13957.58127256184;14393.496227631982;12317.384130793604;12497.312647804458;12622.684432889251;12704.682382940131;12779.297138657463;12185.329806860707;12216;13263.469461221828;13534.526291579747;13769.242691652054;11963.042956563628;12133.575324863587;12388.56640017595;12964.546240881524;13184.80222796678;10129.392236465836;10346.844797328196;10390.740231494274;10454.895451045697;10704.785904282027;9496.620135194791;9785.266105042008;10195.7451063724;10360.637377691744;11047.779044419227 11:31:57 INFO - PROCESS | 19811 | __end_tp_report 11:31:57 INFO - PROCESS | 19811 | __start_cc_report 11:31:57 INFO - PROCESS | 19811 | _x_x_mozilla_cycle_collect,933 11:31:57 INFO - PROCESS | 19811 | __end_cc_report 11:31:57 INFO - PROCESS | 19811 | __startTimestamp1472927517462__endTimestamp 11:31:57 INFO - PROCESS | 19811 | 11:31:57 INFO - PROCESS | 19811 | ------- Summary: start ------- 11:31:57 INFO - PROCESS | 19811 | Number of tests: 6 11:31:57 INFO - PROCESS | 19811 | 11:31:57 INFO - PROCESS | 19811 | [#0] dojo.html Cycles:165 Average:5213.81 Median:5413.68 stddev:577.91 (10.7%) stddev-sans-first:551.42 11:31:57 INFO - PROCESS | 19811 | Values: 2938.2 2938.2 2959.9 2982.7 3004.0 5159.0 5209.1 5251.1 5296.4 5300.2 5272.1 5275.7 5293.9 5296.3 5332.5 4729.7 4732.3 4872.3 4918.8 4932.7 4861.8 4902.4 4910.3 4930.9 4949.5 4694.6 4716.1 4826.0 4836.8 4906.9 4733.6 4776.0 4875.3 4877.3 4884.9 4690.4 4733.6 4773.0 4781.4 4844.4 5271.3 5285.3 5290.9 5298.4 5304.1 5465.0 5496.7 5521.0 5539.7 5575.9 5546.5 5575.9 5587.9 5588.1 5596.0 5178.3 5204.1 5218.3 5223.2 5226.3 5666.3 5724.5 5726.4 5763.4 5827.1 5525.2 5539.4 5550.2 5551.6 5552.0 5481.3 5515.3 5537.4 5549.3 5603.1 5502.4 5537.5 5546.2 5585.0 5652.7 5582.8 5605.5 5612.2 5612.5 5612.7 4319.1 4371.6 4382.1 4389.4 4392.3 3846.7 3861.4 3888.3 3912.4 3974.8 5335.7 5340.2 5341.3 5341.9 5407.2 5527.7 5587.4 5631.2 5632.5 5639.3 5286.3 5293.9 5308.0 5359.8 5374.4 4797.3 4802.9 4835.9 4851.1 4856.8 5645.1 5811.4 5817.7 5819.9 5823.4 5485.9 5534.0 5549.9 5567.0 5638.1 5804.4 5812.4 5829.9 5831.9 5832.3 5344.9 5494.6 5502.9 5504.4 5510.3 5500.2 5539.8 5560.5 5572.5 5647.9 5431.1 5459.3 5462.9 5464.4 5466.9 5323.5 5392.5 5452.2 5453.8 5515.7 5399.0 5417.6 5453.5 5479.3 5543.8 5499.3 5508.3 5510.7 5517.2 5520.1 5302.4 5393.3 5408.0 5413.7 5464.9 11:31:57 INFO - PROCESS | 19811 | 11:31:57 INFO - PROCESS | 19811 | [#1] ext.html Cycles:180 Average:60616.44 Median:38530.31 stddev:123622.31 (320.8%) stddev-sans-first:123886.86 11:31:57 INFO - PROCESS | 19811 | Values: 558.7 588.5 589.3 594.0 613.5 32324.0 43449.8 44592.3 44595.3 44705.0 45834.8 46414.0 46431.5 46469.3 46491.5 8090.6 8951.1 9063.1 9120.4 10631.1 10326.5 10750.6 10762.5 10764.7 10766.4 10785.7 10813.6 10826.2 10830.4 10835.4 10691.9 10718.7 10746.8 10752.1 10762.4 10596.6 10680.4 10681.4 10685.1 10692.1 41952.8 42621.4 42681.4 42776.8 42788.4 3533.7 3633.6 3747.4 3956.6 4205.1 32120.2 32385.4 32890.7 32945.2 33004.5 4333.7 4401.9 4404.6 4503.8 4615.7 342284.0 347123.0 347895.0 347902.0 348471.0 57763.1 58124.4 58179.4 58194.4 58629.4 62444.0 63252.0 63324.7 63330.0 63377.7 15690.7 15855.9 15924.4 15930.8 15947.1 10725.5 12590.4 12746.6 13158.9 13265.7 17057.4 17211.9 17267.7 17288.3 17302.1 6166.8 6389.5 6411.2 6442.0 6507.7 733.5 871.7 879.5 892.3 919.8 29689.4 30604.2 30754.7 31113.0 31245.4 963.5 1082.7 1100.4 1129.2 1146.9 15476.9 16258.6 16318.6 16453.8 16653.4 524359.8 534800.0 535483.0 536044.0 841908.0 58287.0 58928.4 58966.0 58989.4 59050.4 1220.3 1286.6 1343.5 1349.6 1395.4 28064.6 32695.5 33064.8 33092.2 33788.8 50797.0 51357.5 51396.0 51401.7 51427.2 395076.0 395791.0 395926.0 396528.0 397772.0 25042.6 27222.7 27963.7 28150.7 28453.9 45196.0 45930.4 45967.0 46170.3 47159.3 38506.6 38554.0 38746.8 40738.4 41061.4 37943.8 38875.4 39094.8 39822.6 40673.4 39070.2 39943.8 40016.8 40347.6 40557.8 32757.2 34897.7 35418.7 35792.6 35991.5 27224.0 27279.9 27392.5 27414.0 27449.3 11:31:57 INFO - PROCESS | 19811 | 11:31:57 INFO - PROCESS | 19811 | [#2] jquery.html Cycles:180 Average:28515.27 Median:19381.46 stddev:77457.43 (399.6%) stddev-sans-first:77645.91 11:31:57 INFO - PROCESS | 19811 | Values: 377.7 396.5 408.2 409.3 425.4 15695.4 19197.0 19235.6 19409.7 20214.9 18968.9 19262.1 19432.0 19574.1 19737.3 5237.2 5738.0 5932.8 5953.0 5987.0 4282.8 5862.1 6321.2 6520.6 6556.2 6362.6 6636.8 6638.3 6648.4 6648.9 6532.9 6560.7 6569.9 6584.4 6599.0 5657.8 5720.6 5784.6 5851.9 5860.0 21565.2 22198.7 22438.2 23284.5 23312.0 2454.8 2552.6 2603.9 2709.4 2816.8 9737.1 9974.3 10268.8 10358.6 10803.8 1868.2 1868.7 1880.6 1914.2 1930.7 78185.6 86130.6 87062.0 88240.0 88496.6 10544.2 10666.4 11063.0 11213.3 11311.6 15221.3 15246.3 15265.0 15290.8 15299.9 7987.6 8124.1 8152.3 8317.5 8388.2 8138.6 8180.3 8206.8 8382.5 8487.8 4616.8 4705.8 4750.7 4760.5 4879.2 1829.7 1869.9 1962.8 2004.3 2026.9 1005.8 1007.0 1016.9 1057.7 1060.6 17801.6 19235.9 19396.6 19514.7 19753.8 989.8 990.0 991.6 1054.3 1083.1 10203.4 10803.9 10832.2 10878.7 10910.8 459669.0 462909.0 469903.0 472842.0 475170.0 92429.5 93628.5 94141.6 95689.5 96519.5 963.0 964.1 965.0 974.1 974.9 15868.3 15972.8 16265.7 16287.2 17435.0 38385.2 40320.0 40403.8 43248.8 45040.3 55919.7 56760.7 56946.1 57645.0 58888.0 6469.0 7511.5 7949.7 8367.1 8482.8 12067.8 12969.5 13017.2 13028.8 13208.6 11010.5 11167.0 11844.6 11954.4 12015.3 11084.4 11237.3 11436.3 11629.3 11711.5 11367.7 11515.5 11704.0 11829.9 12167.7 7611.4 7749.4 7798.7 7997.0 8082.9 10664.8 10932.7 11398.4 11752.4 11954.8 11:31:57 INFO - PROCESS | 19811 | 11:31:57 INFO - PROCESS | 19811 | [#3] mootools.html Cycles:180 Average:5465.10 Median:5019.62 stddev:2983.59 (59.4%) stddev-sans-first:2976.81 11:31:57 INFO - PROCESS | 19811 | Values: 1463.5 1480.3 1638.7 1732.3 1792.8 7555.0 8056.3 8058.3 8058.4 8069.6 7287.5 7892.6 7971.3 8093.9 8205.1 2371.2 2403.1 2403.3 2404.2 2407.9 2323.7 2332.8 2382.8 2386.6 2390.3 2341.7 2346.3 2350.6 2363.0 2369.3 2262.9 2279.4 2281.2 2287.5 2313.5 2292.8 2293.9 2318.2 2318.3 2323.3 8325.6 8463.0 8470.2 8517.4 8518.7 4996.5 5042.9 5167.8 5176.1 5186.3 3127.7 3191.3 3259.4 3270.2 3285.7 1136.4 1156.7 1948.1 2004.8 2031.4 11274.0 11309.6 11366.3 11386.4 11388.9 4275.8 4308.2 4465.7 4505.5 4508.1 9071.2 9082.8 9091.2 9095.5 9098.8 4980.3 5009.8 5010.1 5019.0 5020.3 4229.8 4619.0 4673.9 4674.4 4693.6 3599.2 3617.5 3693.2 3716.6 3739.5 1120.1 1138.3 1138.6 1143.4 1147.2 914.2 931.3 940.3 948.0 954.5 5498.2 5590.8 5613.2 5730.7 5868.0 919.6 959.3 966.1 975.8 991.9 3465.8 3754.4 3796.9 3851.1 3945.8 9998.9 10117.1 10128.0 10206.3 10210.8 10097.6 10115.2 10121.6 10123.2 10134.8 7444.3 7778.2 7861.4 7863.6 7892.3 5299.6 5318.7 5417.0 5620.6 5674.6 9236.0 9254.9 9483.6 9530.4 9599.6 9260.2 9408.3 9440.6 9585.7 9695.5 6755.9 7190.8 7253.5 7315.0 7478.4 8103.7 8162.3 8172.3 8173.9 8181.6 7153.6 7372.9 7390.8 7438.7 7478.7 6841.4 6937.8 6985.8 7027.2 7205.2 6308.3 6473.6 6534.9 6574.1 6656.9 4855.9 4887.9 4914.8 4966.9 5024.5 4893.8 4958.5 4964.4 5029.4 5129.3 11:31:57 INFO - PROCESS | 19811 | 11:31:57 INFO - PROCESS | 19811 | [#4] prototype.html Cycles:180 Average:4521.51 Median:5090.66 stddev:1303.94 (25.6%) stddev-sans-first:1268.52 11:31:57 INFO - PROCESS | 19811 | Values: 300.2 313.8 316.1 319.5 323.1 5115.2 5188.7 5286.7 5330.0 5371.0 5217.0 5218.7 5250.6 5251.6 5256.2 4135.8 4136.8 4143.6 4148.4 4148.6 3923.3 4057.2 4143.5 4150.1 4155.8 4047.0 4048.4 4049.8 4060.1 4072.5 4023.9 4041.4 4042.7 4044.2 4077.0 3539.9 3614.5 3636.3 3636.5 3643.0 5088.5 5105.4 5117.8 5117.8 5151.6 4710.7 4712.4 4712.9 4724.9 4753.9 5328.3 5464.6 5504.5 5510.6 5522.8 3996.4 3998.5 4008.0 4013.8 4018.9 5729.7 5763.3 5781.9 5798.7 5807.4 4038.9 4111.6 4118.1 4126.6 4141.5 4159.6 4161.0 4182.9 4186.8 4191.8 4716.8 4743.4 4764.0 4780.7 4786.6 5315.9 5431.0 5525.9 5532.3 5533.8 1371.3 1411.6 1447.8 1456.8 1458.8 965.5 978.3 1005.4 1008.3 1024.9 5326.3 5342.9 5355.0 5381.7 5384.1 5612.5 5614.4 5621.0 5629.3 5671.5 5224.2 5305.9 5395.4 5440.9 5445.3 2641.6 2657.2 2657.7 2665.0 2678.8 5195.4 5200.8 5210.3 5259.2 5277.5 4745.5 4984.5 5036.3 5055.8 5094.9 5111.4 5143.3 5163.7 5163.7 5180.9 4914.2 5004.0 5026.3 5044.2 5073.6 4608.3 4922.9 4923.4 4932.0 4948.7 5154.8 5189.6 5204.7 5205.6 5218.8 3788.2 3805.6 3809.9 3814.5 3822.8 4650.4 5017.7 5049.0 5092.8 5424.4 5416.3 5467.3 5469.6 5478.8 5610.1 5527.4 5547.3 5621.4 5625.3 5641.2 5254.6 5515.7 5537.8 5611.7 5647.8 5572.5 5590.0 5607.3 5612.7 5616.7 5484.1 5485.6 5500.4 5501.7 5508.2 11:31:57 INFO - PROCESS | 19811 | 11:31:57 INFO - PROCESS | 19811 | [#5] yui.html Cycles:180 Average:21137.40 Median:4581.16 stddev:31795.99 (694.1%) stddev-sans-first:31848.52 11:31:57 INFO - PROCESS | 19811 | Values: 800.6 821.2 823.4 840.9 854.6 15385.5 16100.5 16200.5 16271.9 16277.0 13393.5 13723.4 14403.4 14426.1 14540.9 797.3 802.9 803.3 803.6 803.6 664.3 791.4 802.3 804.8 809.8 854.7 860.0 860.1 860.2 860.2 856.6 858.4 858.7 859.1 859.1 508.2 518.0 519.1 630.8 631.0 12666.9 13100.7 13158.9 13336.2 13342.2 14334.2 15538.4 15564.8 15657.8 15910.7 11301.2 11359.6 11387.0 11425.9 11786.6 3778.8 3843.7 3860.7 3862.6 3898.4 77917.0 77975.0 78494.0 78872.0 79877.6 11755.8 11876.6 11953.9 12025.4 12027.9 22348.4 22365.9 22415.0 22418.1 22425.3 8149.9 8172.8 8218.2 8349.6 8523.1 4576.5 4577.8 4584.5 4630.1 4834.9 3241.7 3310.8 3312.5 3316.5 3321.9 603.3 610.5 612.6 612.7 615.1 563.3 649.7 679.4 683.9 722.2 9623.8 9740.2 9793.8 9987.5 10376.7 651.5 687.4 693.8 700.8 721.7 4286.5 4628.7 4640.3 4761.4 4832.6 122361.0 124048.4 124110.0 131319.3 131739.0 69010.0 109848.0 112165.4 115759.0 116618.0 57645.1 68862.7 88705.0 88719.6 93115.5 8634.1 8839.7 8879.4 9001.7 9214.3 51082.5 51811.7 52677.7 54163.5 54163.7 73213.0 79557.2 80079.6 84280.2 84930.6 10672.4 11387.9 11476.5 11752.5 11864.9 12931.4 13065.2 13633.7 13957.6 14393.5 12317.4 12497.3 12622.7 12704.7 12779.3 12185.3 12216.0 13263.5 13534.5 13769.2 11963.0 12133.6 12388.6 12964.5 13184.8 10129.4 10346.8 10390.7 10454.9 10704.8 9496.6 9785.3 10195.7 10360.6 11047.8 11:31:57 INFO - PROCESS | 19811 | -------- Summary: end -------- 11:31:57 INFO - PROCESS | 19811 | 11:31:58 INFO - TEST-INFO | 19811: exit 0 11:31:58 INFO - TEST-OK | dromaeo_css | took 1116149ms 11:31:58 INFO - TEST-START | kraken 11:31:58 INFO - operating with platform_type : linux_ 11:31:58 INFO - Initialising browser for kraken test... 11:31:58 INFO - TEST-INFO | started process 20123 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Bcd14/profile http://localhost:50668/getInfo.html) 11:32:03 INFO - PROCESS | 20123 | __metrics Screen width/height:1600/1200 11:32:03 INFO - PROCESS | 20123 | colorDepth:24 11:32:03 INFO - PROCESS | 20123 | Browser inner width/height: 1024/697 11:32:03 INFO - PROCESS | 20123 | __metrics 11:32:03 INFO - PROCESS | 20123 | 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:32:03 INFO - PROCESS | 20123 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:32:04 INFO - PROCESS | 20123 | console.error: PushService: 11:32:04 INFO - PROCESS | 20123 | stateChangeProcessEnqueue: Error transitioning state 11:32:04 INFO - PROCESS | 20123 | UnknownError 11:32:04 INFO - TEST-INFO | 20123: exit 0 11:32:04 INFO - Browser initialized. 11:32:04 INFO - Running cycle 1/1 for kraken test... 11:32:04 INFO - TEST-INFO | started process 20203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9Bcd14/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:16 INFO - PROCESS | 20203 | RSS: Main: 179408896 11:32:16 INFO - PROCESS | 20203 | 11:32:19 INFO - PROCESS | 20203 | Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50668/tests/kraken/driver.html?testName=audio-beat-detection) 11:32:20 INFO - PROCESS | 20203 | RSS: Main: 234336256 11:32:20 INFO - PROCESS | 20203 | 11:32:22 INFO - PROCESS | 20203 | Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50668/tests/kraken/driver.html?testName=audio-dft) 11:32:23 INFO - PROCESS | 20203 | RSS: Main: 224575488 11:32:23 INFO - PROCESS | 20203 | 11:32:26 INFO - PROCESS | 20203 | Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50668/tests/kraken/driver.html?testName=audio-fft) 11:32:27 INFO - PROCESS | 20203 | RSS: Main: 300187648 11:32:27 INFO - PROCESS | 20203 | 11:32:29 INFO - PROCESS | 20203 | Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50668/tests/kraken/driver.html?testName=audio-oscillator) 11:32:29 INFO - PROCESS | 20203 | RSS: Main: 211918848 11:32:29 INFO - PROCESS | 20203 | 11:32:32 INFO - PROCESS | 20203 | Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50668/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:32:32 INFO - PROCESS | 20203 | RSS: Main: 214396928 11:32:32 INFO - PROCESS | 20203 | 11:32:35 INFO - PROCESS | 20203 | Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50668/tests/kraken/driver.html?testName=imaging-darkroom) 11:32:36 INFO - PROCESS | 20203 | RSS: Main: 252719104 11:32:36 INFO - PROCESS | 20203 | 11:32:39 INFO - PROCESS | 20203 | Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50668/tests/kraken/driver.html?testName=imaging-desaturate) 11:32:40 INFO - PROCESS | 20203 | RSS: Main: 252403712 11:32:40 INFO - PROCESS | 20203 | 11:32:43 INFO - PROCESS | 20203 | Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50668/tests/kraken/driver.html?testName=json-parse-financial) 11:32:43 INFO - PROCESS | 20203 | RSS: Main: 251756544 11:32:43 INFO - PROCESS | 20203 | 11:32:45 INFO - PROCESS | 20203 | Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50668/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:32:45 INFO - PROCESS | 20203 | RSS: Main: 213987328 11:32:45 INFO - PROCESS | 20203 | 11:32:47 INFO - PROCESS | 20203 | Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50668/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:32:48 INFO - PROCESS | 20203 | RSS: Main: 220557312 11:32:48 INFO - PROCESS | 20203 | 11:32:50 INFO - PROCESS | 20203 | Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50668/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:32:50 INFO - PROCESS | 20203 | RSS: Main: 222543872 11:32:50 INFO - PROCESS | 20203 | 11:32:53 INFO - PROCESS | 20203 | Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50668/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:32:54 INFO - PROCESS | 20203 | RSS: Main: 216657920 11:32:54 INFO - PROCESS | 20203 | 11:32:56 INFO - PROCESS | 20203 | Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50668/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:32:57 INFO - PROCESS | 20203 | RSS: Main: 220573696 11:32:57 INFO - PROCESS | 20203 | 11:32:59 INFO - PROCESS | 20203 | Cycle 1(1): loaded http://localhost:50668/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50668/tests/kraken/driver.html?testName=ai-astar) 11:32:59 INFO - PROCESS | 20203 | RSS: Main: 271872000 11:32:59 INFO - PROCESS | 20203 | 11:32:59 INFO - PROCESS | 20203 | __start_tp_report 11:32:59 INFO - PROCESS | 20203 | _x_x_mozilla_page_load 11:32:59 INFO - PROCESS | 20203 | _x_x_mozilla_page_load_details 11:32:59 INFO - PROCESS | 20203 | |i|pagename|runs| 11:32:59 INFO - PROCESS | 20203 | |0;ai-astar;111;113;119;112;112;113;113;112;111;129 11:32:59 INFO - PROCESS | 20203 | |1;audio-beat-detection;147;116;145;190;118;151;146;125;182;116 11:32:59 INFO - PROCESS | 20203 | |2;audio-dft;161;163;164;163;161;164;160;161;159;159 11:32:59 INFO - PROCESS | 20203 | |3;audio-fft;76;74;75;167;78;77;76;75;162;76 11:32:59 INFO - PROCESS | 20203 | |4;audio-oscillator;83;82;142;83;83;82;151;82;82;148 11:32:59 INFO - PROCESS | 20203 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;117;117;117 11:32:59 INFO - PROCESS | 20203 | |6;imaging-darkroom;146;146;146;146;147;146;146;146;148;146 11:32:59 INFO - PROCESS | 20203 | |7;imaging-desaturate;95;94;95;95;95;96;95;96;96;95 11:32:59 INFO - PROCESS | 20203 | |8;json-parse-financial;50;49;60;51;52;51;51;52;51;51 11:32:59 INFO - PROCESS | 20203 | |9;json-stringify-tinderbox;62;62;62;63;62;62;62;62;62;62 11:32:59 INFO - PROCESS | 20203 | |10;stanford-crypto-aes;84;80;78;79;78;79;79;83;79;79 11:32:59 INFO - PROCESS | 20203 | |11;stanford-crypto-ccm;128;126;124;125;127;130;128;123;213;133 11:32:59 INFO - PROCESS | 20203 | |12;stanford-crypto-pbkdf2;166;161;162;166;166;164;165;165;164;163 11:32:59 INFO - PROCESS | 20203 | |13;stanford-crypto-sha256-iterative;67;68;66;65;65;64;65;68;67;66 11:32:59 INFO - PROCESS | 20203 | __end_tp_report 11:32:59 INFO - PROCESS | 20203 | __start_cc_report 11:32:59 INFO - PROCESS | 20203 | _x_x_mozilla_cycle_collect,1674 11:32:59 INFO - PROCESS | 20203 | __end_cc_report 11:32:59 INFO - PROCESS | 20203 | __startTimestamp1472927579486__endTimestamp 11:32:59 INFO - PROCESS | 20203 | 11:32:59 INFO - PROCESS | 20203 | ------- Summary: start ------- 11:32:59 INFO - PROCESS | 20203 | Number of tests: 14 11:32:59 INFO - PROCESS | 20203 | 11:32:59 INFO - PROCESS | 20203 | [#0] ai-astar Cycles:10 Average:114.50 Median:113.00 stddev:5.58 (4.9%) stddev-sans-first:5.78 11:32:59 INFO - PROCESS | 20203 | Values: 111.0 113.0 119.0 112.0 112.0 113.0 113.0 112.0 111.0 129.0 11:32:59 INFO - PROCESS | 20203 | 11:32:59 INFO - PROCESS | 20203 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:146.50 stddev:26.30 (18.0%) stddev-sans-first:27.87 11:32:59 INFO - PROCESS | 20203 | Values: 147.0 116.0 145.0 190.0 118.0 151.0 146.0 125.0 182.0 116.0 11:32:59 INFO - PROCESS | 20203 | 11:32:59 INFO - PROCESS | 20203 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.90 (1.2%) stddev-sans-first:2.01 11:32:59 INFO - PROCESS | 20203 | Values: 161.0 163.0 164.0 163.0 161.0 164.0 160.0 161.0 159.0 159.0 11:32:59 INFO - PROCESS | 20203 | 11:32:59 INFO - PROCESS | 20203 | [#3] audio-fft Cycles:10 Average:93.60 Median:76.00 stddev:37.40 (49.2%) stddev-sans-first:39.13 11:32:59 INFO - PROCESS | 20203 | Values: 76.0 74.0 75.0 167.0 78.0 77.0 76.0 75.0 162.0 76.0 11:32:59 INFO - PROCESS | 20203 | 11:32:59 INFO - PROCESS | 20203 | [#4] audio-oscillator Cycles:10 Average:101.80 Median:82.00 stddev:31.27 (38.1%) stddev-sans-first:32.42 11:32:59 INFO - PROCESS | 20203 | Values: 83.0 82.0 142.0 83.0 83.0 82.0 151.0 82.0 82.0 148.0 11:32:59 INFO - PROCESS | 20203 | 11:32:59 INFO - PROCESS | 20203 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:32:59 INFO - PROCESS | 20203 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 11:32:59 INFO - PROCESS | 20203 | 11:32:59 INFO - PROCESS | 20203 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 11:32:59 INFO - PROCESS | 20203 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 148.0 146.0 11:32:59 INFO - PROCESS | 20203 | 11:32:59 INFO - PROCESS | 20203 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 11:32:59 INFO - PROCESS | 20203 | Values: 95.0 94.0 95.0 95.0 95.0 96.0 95.0 96.0 96.0 95.0 11:32:59 INFO - PROCESS | 20203 | 11:32:59 INFO - PROCESS | 20203 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:51.00 stddev:3.01 (5.9%) stddev-sans-first:3.12 11:32:59 INFO - PROCESS | 20203 | Values: 50.0 49.0 60.0 51.0 52.0 51.0 51.0 52.0 51.0 51.0 11:32:59 INFO - PROCESS | 20203 | 11:32:59 INFO - PROCESS | 20203 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 11:32:59 INFO - PROCESS | 20203 | Values: 62.0 62.0 62.0 63.0 62.0 62.0 62.0 62.0 62.0 62.0 11:32:59 INFO - PROCESS | 20203 | 11:32:59 INFO - PROCESS | 20203 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.00 stddev:2.04 (2.6%) stddev-sans-first:1.50 11:32:59 INFO - PROCESS | 20203 | Values: 84.0 80.0 78.0 79.0 78.0 79.0 79.0 83.0 79.0 79.0 11:32:59 INFO - PROCESS | 20203 | 11:32:59 INFO - PROCESS | 20203 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:128.00 stddev:27.32 (21.3%) stddev-sans-first:28.83 11:32:59 INFO - PROCESS | 20203 | Values: 128.0 126.0 124.0 125.0 127.0 130.0 128.0 123.0 213.0 133.0 11:32:59 INFO - PROCESS | 20203 | 11:32:59 INFO - PROCESS | 20203 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:165.00 stddev:1.75 (1.1%) stddev-sans-first:1.73 11:32:59 INFO - PROCESS | 20203 | Values: 166.0 161.0 162.0 166.0 166.0 164.0 165.0 165.0 164.0 163.0 11:32:59 INFO - PROCESS | 20203 | 11:32:59 INFO - PROCESS | 20203 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:1.37 (2.1%) stddev-sans-first:1.41 11:32:59 INFO - PROCESS | 20203 | Values: 67.0 68.0 66.0 65.0 65.0 64.0 65.0 68.0 67.0 66.0 11:32:59 INFO - PROCESS | 20203 | -------- Summary: end -------- 11:32:59 INFO - PROCESS | 20203 | 11:33:00 INFO - TEST-INFO | 20203: exit 0 11:33:00 INFO - TEST-OK | kraken | took 62288ms 11:33:00 INFO - SUITE-END | took 1178s 11:33:01 INFO - Completed test suite (00:19:38) 11:33:01 INFO - javascript benchmark 11:33:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2938.1919972007695, 2938.206684195267, 2959.896403625872, 2982.716641919017, 3004.0, 5159.0, 5209.140491818855, 5251.081060814361, 5296.417394086652, 5300.178472336789, 5272.077386457364, 5275.683458992454, 5293.8941221175555, 5296.3379577552805, 5332.493413125757, 4729.692569982949, 4732.313814496896, 4872.317875497433, 4918.803247870099, 4932.654714170009, 4861.805527778884, 4902.411710594733, 4910.337104490902, 4930.852074437773, 4949.505049495057, 4694.624430045588, 4716.127516409475, 4825.975870120662, 4836.758162091899, 4906.901861962759, 4733.644976626767, 4776.044791041805, 4875.268709693574, 4877.317175595419, 4884.877878053042, 4690.413698287714, 4733.5976442002475, 4772.9761351193365, 4781.3545171401765, 4844.418669759616, 5271.341082364705, 5285.339332583427, 5290.867728306823, 5298.417174110883, 5304.098303288451, 5464.972675136639, 5496.725163741797, 5520.972395138038, 5539.695316757577, 5575.8884822303735, 5546.500814926676, 5575.8606034849045, 5587.916181257285, 5588.077967135418, 5596.0, 5178.275041494118, 5204.089284375219, 5218.347706536683, 5223.216517522326, 5226.320578324793, 5666.320041595035, 5724.542036637059, 5726.3700992890745, 5763.394843541368, 5827.125931110282, 5525.198846167284, 5539.362973258047, 5550.16747487872, 5551.555875529948, 5552.028395030934, 5481.287432633732, 5515.283013208337, 5537.446255374511, 5549.306336707911, 5603.131514615241, 5502.367227768857, 5537.529310008614, 5546.195801608744, 5585.0, 5652.689102099424, 5582.8325150245555, 5605.495505404533, 5612.186232996192, 5612.466815652589, 5612.719364031782, 4319.071399649028, 4371.606555410029, 4382.123575284956, 4389.385486031958, 4392.275274579659, 3846.653801157853, 3861.362875125629, 3888.261230366278, 3912.4131380293184, 3974.82113304902, 5335.679859208382, 5340.19897015443, 5341.332333458317, 5341.946580534145, 5407.242985981887, 5527.723613819293, 5587.413321601254, 5631.155326701028, 5632.464915833071, 5639.295088113986, 5286.3392075990505, 5293.894122117536, 5307.9734601326745, 5359.758810853521, 5374.435684253175, 4797.328374027639, 4802.927956080662, 4835.854924352275, 4851.102546028926, 4856.781444834991, 5645.068563686946, 5811.389804070596, 5817.650940943557, 5819.941800582024, 5823.417658234142, 5485.917711234414, 5534.0, 5549.889002219852, 5566.970110529565, 5638.097904335286, 5804.419558044162, 5812.447817457335, 5829.883402331845, 5831.94168058314, 5832.3292821326095, 5344.919826202532, 5494.587905907153, 5502.944970550243, 5504.4495550444635, 5510.256115424367, 5500.1749737539685, 5539.833804985857, 5560.499555040065, 5572.526335261548, 5647.926893890148, 5431.076716958048, 5459.2629994950175, 5462.91805622908, 5464.426235245401, 5466.91799623014, 5323.547498462519, 5392.460753924576, 5452.209429632601, 5453.754581043783, 5515.724213789214, 5398.973005134949, 5417.5665946723375, 5453.454654534674, 5479.342478902558, 5543.77824887, 5499.312585926759, 5508.256385388082, 5510.724463776715, 5517.200005999188, 5520.06158952971, 5302.416734159162, 5393.27190829233, 5407.972960135174, 5413.675179489243, 5464.890702186013], "value": 5174.901357754101, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.6675332794181, 588.5379976718277, 589.2810770859552, 593.9940600593993, 613.5153228949131, 32324.009836655532, 43449.78275108624, 44592.3311150333, 44595.33107003389, 44705.0, 45834.770826145905, 46414.0, 46431.535684643146, 46469.30296045562, 46491.53508464914, 8090.555019473926, 8951.149640784148, 9063.139001794852, 9120.407173533698, 10631.149508039338, 10326.483675816216, 10750.623728169516, 10762.461876906124, 10764.677059688222, 10766.40784756838, 10785.676429707122, 10813.567457301699, 10826.18803589734, 10830.350178989247, 10835.404052777094, 10691.893081069167, 10718.73203169927, 10746.785064298749, 10752.086072683831, 10762.354258744423, 10596.62911798091, 10680.412577308245, 10681.41252231127, 10685.091767199798, 10692.091172250368, 41952.79023604893, 42621.36067958983, 42681.35977960333, 42776.78611606922, 42788.35817462741, 3533.6819686228364, 3633.618470060632, 3747.4191500317493, 3956.5647778744315, 4205.074883525619, 32120.196995075075, 32385.352292954245, 32890.671093289, 32945.176370590685, 33004.50493242603, 4333.739975601474, 4401.889952751175, 4404.647628189769, 4503.797329120198, 4615.653825963066, 342284.0, 347123.0, 347895.0, 347902.0, 348471.0, 57763.13355299674, 58124.4187558119, 58179.4182058174, 58194.4180558189, 58629.41370586325, 62444.0, 63252.0, 63324.68337658282, 63330.0, 63377.68311158415, 15690.68618627621, 15855.920720396323, 15924.363025479082, 15930.840691593168, 15947.122908240159, 10725.51735171919, 12590.43343049565, 12746.617601471971, 13158.934205329104, 13265.734685306434, 17057.402990895258, 17211.91394043022, 17267.65464690699, 17288.308467661154, 17302.134893255286, 6166.845828854225, 6389.520785941073, 6411.2306523216575, 6442.0, 6507.674616269168, 733.512214377433, 871.7384784564732, 879.5162660536679, 892.2950868813695, 919.8068405634891, 29689.406211876074, 30604.23489412738, 30754.69245307563, 31113.0, 31245.375092498478, 963.5375019990444, 1082.680609220282, 1100.4208960142062, 1129.170060005895, 1146.879577644352, 15476.922615386851, 16258.593535161715, 16318.592035198977, 16453.753193702105, 16653.41713040038, 524359.7820108979, 534800.0, 535483.0, 536044.0, 841908.0, 58287.0, 58928.41071589229, 58966.0, 58989.410105898394, 59050.40949590449, 1220.3288191494642, 1286.6204469681466, 1343.543195313598, 1349.6355983884296, 1395.3511617097895, 28064.579031314137, 32695.50956735603, 33064.83467582647, 33092.1726956828, 33788.83105584457, 50797.0, 51357.48642513527, 51396.0, 51401.7429912848, 51427.228591570405, 395076.0, 395791.0, 395926.0, 396528.0, 397772.0, 25042.62436063424, 27222.72777272202, 27963.72036279611, 28150.71849281481, 28453.857730712043, 45196.0, 45930.4069593038, 45967.0, 46170.307445387676, 47159.29261061018, 38506.61493385142, 38554.0, 38746.80626596849, 40738.38892416676, 41061.38407923943, 37943.810280949525, 38875.416868746426, 39094.80452597719, 39822.60177398189, 40673.38989915094, 39070.218595628496, 39943.80028099841, 40016.7999160014, 40347.59652403439, 40557.797211013756, 32757.181070472474, 34897.65102348944, 35418.65742952753, 35792.64207357997, 35991.46012809758, 27224.0, 27279.86360068187, 27392.45215095727, 27414.0, 27449.31376715598], "value": 20185.27537350104, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.68463333116847, 396.4924896132949, 408.2019651581159, 409.32665764816875, 425.42142685947124, 15695.372185112596, 19196.98431664676, 19235.615287694236, 19409.708854367178, 20214.89892550539, 18968.905155474204, 19262.13320400582, 19432.0, 19574.11916463759, 19737.309194178208, 5237.162054071349, 5737.971310143444, 5932.792352267671, 5953.047512397996, 5986.97006514969, 4282.7858607069675, 5862.120681897707, 6321.209848768904, 6520.576162549419, 6556.246031706343, 6362.5546211765195, 6636.834079148011, 6638.269790323061, 6648.368405001541, 6648.867022659544, 6532.902006469907, 6560.671966401661, 6569.901451478232, 6584.374484423972, 6599.0, 5657.8019769308285, 5720.599558030939, 5784.595078344518, 5851.912221316684, 5859.970700146515, 21565.24521641751, 22198.667019994715, 22438.214662486735, 23284.534309313887, 23312.0, 2454.7913427358694, 2552.642630031797, 2603.856787876666, 2709.376843326026, 2816.802823802335, 9737.123658870665, 9974.251931105124, 10268.794624107475, 10358.585656573729, 10803.83794243087, 1868.234024050133, 1868.7383766272733, 1880.576870204207, 1914.2438736698925, 1930.691089425685, 78185.60907195427, 86130.56934715349, 87061.99999999936, 88240.0, 88496.557517212, 10544.156467482582, 10666.36001839892, 11063.0, 11213.327200368005, 11311.60409385684, 15221.31504082319, 15246.313915873812, 15265.0, 15290.847091528942, 15299.923500382427, 7987.640556174986, 8124.106348301682, 8152.307053900485, 8317.500949943023, 8388.245057944814, 8138.593070346577, 8180.263776260165, 8206.8358632827, 8382.538960357238, 8487.830243395098, 4616.76916154191, 4705.7647117644665, 4750.7387093709485, 4760.523947605281, 4879.194932836113, 1829.6889528779873, 1869.9065046747608, 1962.8037196280543, 2004.298495526554, 2026.9189232430538, 1005.7636455432968, 1006.9899301007042, 1016.8576399304103, 1057.6721216422934, 1060.6128763001602, 17801.554961125817, 19235.90382048109, 19396.612067758848, 19514.70727939082, 19753.802461975483, 989.8119357322086, 989.9604015839429, 991.5587563534302, 1054.298891237334, 1083.0847933496184, 10203.38779673222, 10803.891961080446, 10832.24174307791, 10878.728031799268, 10910.836337454944, 459669.0, 462909.0, 469903.0, 472842.0, 475170.0, 92429.53785231031, 93628.53185734028, 94141.57973919297, 95689.52155239179, 96519.51740241394, 962.9614815407306, 964.0841200859212, 964.971050868461, 974.0600320690568, 974.9415035097917, 15868.285927133076, 15972.760408594113, 16265.674686505967, 16287.18564071768, 17435.0, 38385.23229535449, 40320.0, 40403.797981009906, 43248.783756081015, 45040.27077156983, 55919.73043504318, 56760.716196418754, 56946.145807812085, 57645.0, 58888.0, 6468.997305417668, 7511.549307041595, 7949.7217597383815, 8367.121452247426, 8482.787930301793, 12067.75864482688, 12969.54606588765, 13017.153884997444, 13028.804567931298, 13208.603741887759, 11010.50452729645, 11167.0, 11844.585439509576, 11954.402279886144, 12015.339156346485, 11084.390358530036, 11237.269577477438, 11436.256643318158, 11629.302241865515, 11711.531538738354, 11367.658970230907, 11515.481803319039, 11704.0, 11829.881701183222, 12167.695807604881, 7611.3530349920875, 7749.380049596131, 7798.688052477837, 7997.0, 8082.87875681877, 10664.786704266027, 10932.726681833017, 11398.430078495876, 11752.412379381169, 11954.820677689668], "value": 9263.936433831595, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.5024091808782, 1480.267267702487, 1638.7378019516873, 1732.3243934865413, 1792.8027916929127, 7554.962225188873, 8056.274935255826, 8058.315043221319, 8058.355331573474, 8069.5561744104125, 7287.453440991933, 7892.56590887501, 7971.282584567388, 8093.919060809405, 8205.097439281673, 2371.1819422299363, 2403.146882856587, 2403.2790162951133, 2404.218628945591, 2407.9157229496973, 2323.744388117306, 2332.825038122148, 2382.845115067515, 2386.570417324881, 2390.3307074019303, 2341.7424083350816, 2346.296111166652, 2350.6239001759723, 2363.0075368345338, 2369.2655276864143, 2262.9207977720866, 2279.3731723775927, 2281.2243837095384, 2287.5081857400573, 2313.5372925414817, 2292.79364857162, 2293.8853057347233, 2318.1654604342593, 2318.3392733070996, 2323.2913961241816, 8325.626271665167, 8463.0, 8470.152984701543, 8517.446365986252, 8518.70184543538, 4996.4503904570465, 5042.949570504321, 5167.819126330561, 5176.094183517869, 5186.273921650972, 3127.749780017593, 3191.266008817962, 3259.38071766366, 3270.1661076425357, 3285.720713739335, 1136.4261048170704, 1156.6587856582328, 1948.1038722187811, 2004.7995200479836, 2031.3702752146883, 11274.0, 11309.604163854226, 11366.318020918772, 11386.430678466044, 11388.886111138783, 4275.828966841292, 4308.202982448257, 4465.665075119314, 4505.45934487857, 4508.07584445188, 9071.183593476619, 9082.818343633222, 9091.227245684191, 9095.454272743656, 9098.772530686785, 4980.277859710394, 5009.824656137018, 5010.098182327216, 5018.974905125451, 5020.2720605511995, 4229.788510574459, 4618.976905115453, 4673.929891051637, 4674.368960190331, 4693.55411235932, 3599.190182208982, 3617.5297211362354, 3693.2059607184046, 3716.572594151653, 3739.457778622085, 1120.0535547462382, 1138.282881784487, 1138.6185627814775, 1143.3711458697683, 1147.2198904744687, 914.1726737302752, 931.3108299858056, 940.2759874896292, 947.9810403792023, 954.5255270814241, 5498.202760599691, 5590.8043218487155, 5613.242212301368, 5730.656160630376, 5868.0, 919.6435257994405, 959.3236768078627, 966.0725703324746, 975.770693886936, 991.9355241909253, 3465.792052476809, 3754.3805272129794, 3796.9430458543143, 3851.094992676719, 3945.8027098645525, 9998.850017249748, 10117.140043096271, 10128.0, 10206.336588121749, 10210.795784084425, 10097.646582369729, 10115.241356898116, 10121.59513619447, 10123.1901447884, 10134.797304053878, 7444.330010299099, 7778.222177782177, 7861.371090312761, 7863.6409077276585, 7892.329152022027, 5299.6290259681455, 5318.680879147263, 5417.0, 5620.606557541097, 5674.574406919415, 9235.953820230856, 9254.861177082485, 9483.573239204114, 9530.428174309563, 9599.568019439283, 9260.166585007382, 9408.341416100808, 9440.575174117044, 9585.72935113531, 9695.515224238901, 6755.898661520179, 7190.820229494305, 7253.492255542273, 7315.0, 7478.439117066133, 8103.716369927024, 8162.265396114378, 8172.305354044735, 8173.918260817316, 8181.6318265677, 7153.60655163971, 7372.852542949218, 7390.778276651709, 7438.6652600632015, 7478.738244161428, 6841.350071743176, 6937.75717849893, 6985.825354366181, 7027.15674119109, 7205.207427182901, 6308.27454842699, 6473.611583305017, 6534.869302613826, 6574.145361103026, 6656.933430665825, 4855.927161092657, 4887.926681099715, 4914.7542622867995, 4966.925496117633, 5024.522670346311, 4893.825481884393, 4958.528939750718, 4964.404271487445, 5029.371328583927, 5129.256257842518], "value": 4472.329321325131, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.2433866656028, 313.84778382484507, 316.0565711351616, 319.4744645058878, 323.08405669925764, 5115.2071428928575, 5188.650950752813, 5286.7356632168385, 5330.0, 5370.999999999995, 5217.0, 5218.660787048839, 5250.579953603712, 5251.55361794247, 5256.185291279849, 4135.793210339486, 4136.751794892309, 4143.606357396043, 4148.398482220076, 4148.6266236038755, 3923.2938071147323, 4057.2291264659766, 4143.544210136883, 4150.066235097109, 4155.771432571208, 4047.0, 4048.4413500802257, 4049.7975101244965, 4060.1473690525027, 4072.450219220397, 4023.939640905389, 4041.3735870939904, 4042.676585873138, 4044.170944956277, 4076.9592304076878, 3539.929201415983, 3614.493970844084, 3636.254567813592, 3636.5454318210222, 3642.9799656096334, 5088.491150884919, 5105.412877519058, 5117.769700363456, 5117.820876269313, 5151.639385243035, 4710.717356958594, 4712.434507859079, 4712.929306060412, 4724.858254252378, 4753.928691069636, 5328.307320048408, 5464.617476776627, 5504.541296556416, 5510.6418082824885, 5522.806701765459, 3996.360582306817, 3998.520177578709, 4007.9599204007877, 4013.779242141681, 4018.8794336169963, 5729.742161602738, 5763.2507773989955, 5781.913271300934, 5798.710064496759, 5807.448292412214, 4038.919221615551, 4111.588841115924, 4118.135191609736, 4126.649234815014, 4141.529756936245, 4159.563245859202, 4160.958390416057, 4182.912442764903, 4186.769727664947, 4191.811368488365, 4716.811327546929, 4743.407074115736, 4764.0, 4780.737059461693, 4786.617070634341, 5315.893682126336, 5431.0, 5525.889482210333, 5532.30846144232, 5533.833984980457, 1371.3349025722516, 1411.5553600615774, 1447.8117844680335, 1456.83974762776, 1458.8030615866935, 965.4931161140317, 978.3298440568092, 1005.3615953869199, 1008.2639673038723, 1024.8667673202585, 5326.307580014573, 5342.866428339323, 5355.0, 5381.730913454312, 5384.1385378340065, 5612.494875461228, 5614.427960171159, 5621.0444224481935, 5629.31280011593, 5671.51792097668, 5224.164133738584, 5305.885763989605, 5395.406505284415, 5440.863978400572, 5445.346558413015, 2641.550936340827, 2657.2161212442375, 2657.6677915260593, 2665.0, 2678.825876318033, 5195.376554813371, 5200.843974680765, 5210.270562121306, 5259.21111833228, 5277.472252774769, 4745.525447455227, 4984.461032666847, 5036.345275114285, 5055.823046193365, 5094.898102038012, 5111.361079865017, 5143.305653736773, 5163.66436181647, 5163.690178589221, 5180.922286165635, 4914.238293064581, 5004.0, 5026.271190677258, 5044.218146187347, 5073.604758691389, 4608.331791890224, 4922.852314430573, 4923.409190897115, 4931.950680493293, 4948.727819969792, 5154.768035438489, 5189.584833213409, 5204.724842413481, 5205.557527610044, 5218.765155568084, 3788.1666033472593, 3805.6384643459933, 3809.9045524961716, 3814.5422549294262, 3822.7515211512277, 4650.441946966385, 5017.67385119966, 5049.030877957673, 5092.821751238689, 5424.430434804446, 5416.322959630046, 5467.316585426822, 5469.577909743575, 5478.780848766005, 5610.102383618601, 5527.4246839650505, 5547.306586676666, 5621.35354434229, 5625.324961004706, 5641.210230567642, 5254.579633629224, 5515.724213789214, 5537.8061767837935, 5611.691356975405, 5647.802326918538, 5572.498475137257, 5589.972050139886, 5607.271054762855, 5612.7193640317, 5616.719164041863, 5484.107982745946, 5485.6434331768305, 5500.3949565548555, 5501.697406642673, 5508.190822680542], "value": 4108.938165081409, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.6077022259093, 821.1952286758973, 823.3948048184587, 840.93692973027, 854.5940678177865, 15385.538433846988, 16100.516984490454, 16200.51398458048, 16271.918640406797, 16277.0, 13393.492995483035, 13723.382447789849, 14403.351849166786, 14426.134431934091, 14540.909431792632, 797.2983774278626, 802.9036515618105, 803.2850762821093, 803.5500119932856, 803.5540275147291, 664.3489380407204, 791.4301702773994, 802.2859654907137, 804.8350088231898, 809.7894547417684, 854.7393045121236, 860.0453496618749, 860.0668274921718, 860.1785295043219, 860.1914200651399, 856.5545916123612, 858.3991206155716, 858.6908712863365, 859.1236938322876, 859.1279850951289, 508.22241969786285, 517.9922301165485, 519.13823053731, 630.7918386932301, 631.0093153748617, 12666.87333126666, 13100.737985240337, 13158.934205329007, 13336.19982801035, 13342.199468031851, 14334.211618360985, 15538.378464861393, 15564.844351556452, 15657.843421565753, 15910.680362873389, 11301.152413569016, 11359.602413915472, 11387.0, 11425.873465533488, 11786.587469438615, 3778.8299526521096, 3843.6925045996254, 3860.691144708445, 3862.633049860259, 3898.4347269646028, 77917.0, 77975.0, 78494.0, 78872.0, 79877.60061199714, 11755.823662644896, 11876.584319548774, 11953.940230298793, 12025.398730063462, 12027.879721202851, 22348.441288967904, 22365.888170559043, 22415.0, 22418.103275869107, 22425.32724018282, 8149.877751833727, 8172.754817355489, 8218.178182181735, 8349.624266907882, 8523.105073967268, 4576.519465456146, 4577.771111444481, 4584.541545845389, 4630.143423466669, 4834.854954351375, 3241.7082462578483, 3310.7915610802365, 3312.503124531291, 3316.4527852904002, 3321.8837340693444, 603.2911329188187, 610.5451438678214, 612.5834432585884, 612.6569121292091, 615.0804547201961, 563.2846285217751, 649.7206201333378, 679.3851564334285, 683.9214133716, 722.1767185408638, 9623.807523849484, 9740.220782337396, 9793.755156121011, 9987.500624968723, 10376.688699339033, 651.4560342114388, 687.4363022321749, 693.7675878580732, 700.7932659865352, 721.7077083781077, 4286.485621725351, 4628.675992680547, 4640.257558790578, 4761.428628564595, 4832.589229915427, 122361.0, 124048.37975810064, 124110.0, 131319.34340328237, 131739.0, 69010.0, 109848.0, 112165.43917280524, 115759.0, 116618.0, 57645.13532296935, 68862.65568672125, 88705.0, 88719.55640221758, 93115.53442232746, 8634.084275129007, 8839.69061082859, 8879.422837515542, 9001.729948101567, 9214.308926830648, 51082.489175107774, 51811.74094129656, 52677.7366113167, 54163.45836541742, 54163.72918135384, 73213.0, 79557.20442795497, 80079.59960200162, 84280.15719842969, 84930.57534712287, 10672.413017284123, 11387.882672708985, 11476.540938362372, 11752.529898803952, 11864.881351186377, 12931.418086185957, 13065.216087034809, 13633.659158520719, 13957.58127256184, 14393.496227631982, 12317.384130793604, 12497.312647804458, 12622.684432889251, 12704.682382940131, 12779.297138657463, 12185.329806860707, 12216.0, 13263.469461221828, 13534.526291579747, 13769.242691652054, 11963.042956563628, 12133.575324863587, 12388.56640017595, 12964.546240881524, 13184.80222796678, 10129.392236465836, 10346.844797328196, 10390.740231494274, 10454.895451045697, 10704.785904282027, 9496.620135194791, 9785.266105042008, 10195.7451063724, 10360.637377691744, 11047.779044419227], "value": 7402.224083374527, "unit": "score"}], "name": "dromaeo_css", "value": 7132.37869703494, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 119.0, 112.0, 112.0, 113.0, 113.0, 112.0, 111.0, 129.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 145.0, 190.0, 118.0, 151.0, 146.0, 125.0, 182.0, 116.0], "value": 143.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 164.0, 163.0, 161.0, 164.0, 160.0, 161.0, 159.0, 159.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 167.0, 78.0, 77.0, 76.0, 75.0, 162.0, 76.0], "value": 93.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 142.0, 83.0, 83.0, 82.0, 151.0, 82.0, 82.0, 148.0], "value": 101.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.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, 96.0, 95.0, 96.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 60.0, 51.0, 52.0, 51.0, 51.0, 52.0, 51.0, 51.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 78.0, 79.0, 78.0, 79.0, 79.0, 83.0, 79.0, 79.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 124.0, 125.0, 127.0, 130.0, 128.0, 123.0, 213.0, 133.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 161.0, 162.0, 166.0, 166.0, 164.0, 165.0, 165.0, 164.0, 163.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 65.0, 65.0, 64.0, 65.0, 68.0, 67.0, 66.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1532.9999999999998, "alertThreshold": 2.0}]} 11:33:01 INFO - Return code: 0 11:33:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:33:01 INFO - # TBPL SUCCESS # 11:33:01 INFO - Running post-action listener: _resource_record_post_action 11:33:01 INFO - [mozharness: 2016-09-03 18:33:01.308391Z] Finished run-tests step (success) 11:33:01 INFO - Running post-run listener: _resource_record_post_run 11:33:01 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 423358464; Read time: 124; Write time: 351340 11:33:01 INFO - TinderboxPrint: CPU usage
13.1% 11:33:01 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 124 11:33:01 INFO - TinderboxPrint: I/O write bytes / time
423,358,464 / 351,340 11:33:01 INFO - TinderboxPrint: CPU idle
8,288.5 (86.8%) 11:33:01 INFO - TinderboxPrint: CPU user
1,202.2 (12.6%) 11:33:01 INFO - TinderboxPrint: Swap in / out
0 / 0 11:33:01 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 134578176; Read time: 0; Write time: 115224 11:33:01 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288165888; Read time: 116; Write time: 236116 11:33:01 INFO - Running post-run listener: _upload_blobber_files 11:33:01 INFO - Blob upload gear active. 11:33:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:33:01 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:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:33:02 INFO - (blobuploader) - INFO - Open directory for files ... 11:33:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:33:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:33:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:06 INFO - (blobuploader) - INFO - Done attempting. 11:33:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:33:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:33:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:06 INFO - (blobuploader) - INFO - Done attempting. 11:33:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:33:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:33:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:07 INFO - (blobuploader) - INFO - Done attempting. 11:33:07 INFO - (blobuploader) - INFO - Iteration through files over. 11:33:07 INFO - Return code: 0 11:33:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:33:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:33:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad0efdfae28edba88feb9dceed2c5bdd95b3b469b2142213838be9cb0230f142bf45b972afaf6160ba3faa861e9c8e6b0a92cd9f17b43f3ab01b09bac97c958a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7eccf2c7e5f0050213772c12f799952a4b7906a052cc6d6842e333fa8da9172ae71b16429a97e94d4afdc54b385d3fc8798ea0c099964d8136fd59a10a8234a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcbcc644c785eefe3e112b492a34b33e6a77a361c253cd3ba19e253edf289b9b785dd0eaa03da6ca33fc011454926967c9a0aa332dc0496f28c960d7d39f9ce5"} 11:33:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:33:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:33:07 INFO - Contents: 11:33:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad0efdfae28edba88feb9dceed2c5bdd95b3b469b2142213838be9cb0230f142bf45b972afaf6160ba3faa861e9c8e6b0a92cd9f17b43f3ab01b09bac97c958a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7eccf2c7e5f0050213772c12f799952a4b7906a052cc6d6842e333fa8da9172ae71b16429a97e94d4afdc54b385d3fc8798ea0c099964d8136fd59a10a8234a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcbcc644c785eefe3e112b492a34b33e6a77a361c253cd3ba19e253edf289b9b785dd0eaa03da6ca33fc011454926967c9a0aa332dc0496f28c960d7d39f9ce5"} 11:33:07 INFO - Running post-run listener: copy_logs_to_upload_dir 11:33:07 INFO - Copying logs to upload dir... 11:33:07 INFO - mkdir: /builds/slave/test/build/upload/logs 11:33:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.661283 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-03 11:33:05.559031) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-03 11:33:05.562899) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad0efdfae28edba88feb9dceed2c5bdd95b3b469b2142213838be9cb0230f142bf45b972afaf6160ba3faa861e9c8e6b0a92cd9f17b43f3ab01b09bac97c958a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7eccf2c7e5f0050213772c12f799952a4b7906a052cc6d6842e333fa8da9172ae71b16429a97e94d4afdc54b385d3fc8798ea0c099964d8136fd59a10a8234a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcbcc644c785eefe3e112b492a34b33e6a77a361c253cd3ba19e253edf289b9b785dd0eaa03da6ca33fc011454926967c9a0aa332dc0496f28c960d7d39f9ce5"} build_url:https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011309 build_url: 'https://queue.taskcluster.net/v1/task/EdshgrwaSVWpd6SMMbLbIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ad0efdfae28edba88feb9dceed2c5bdd95b3b469b2142213838be9cb0230f142bf45b972afaf6160ba3faa861e9c8e6b0a92cd9f17b43f3ab01b09bac97c958a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7eccf2c7e5f0050213772c12f799952a4b7906a052cc6d6842e333fa8da9172ae71b16429a97e94d4afdc54b385d3fc8798ea0c099964d8136fd59a10a8234a6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dcbcc644c785eefe3e112b492a34b33e6a77a361c253cd3ba19e253edf289b9b785dd0eaa03da6ca33fc011454926967c9a0aa332dc0496f28c960d7d39f9ce5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-03 11:33:05.595325) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 11:33:05.595876) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1472923866.91346-1501104575 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-03 11:33:05.679094) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-03 11:33:05.679642) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-03 11:33:05.680251) ========= ========= Total master_lag: 0.17 =========