builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1470717279.82 results: success (0) buildid: 20160808173001 builduid: 4d7a8406f94d4fd1b56b1fb59e7f712a revision: 5ff96be046af749644327f75b21ce9437d766886 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 21:34:39.824998) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 21:34:39.825429) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 21:34:39.825704) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 21:34:39.848551) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 21:34:39.848811) ========= 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=03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-08 21:34:39-- 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% 216M=0s 2016-08-08 21:34:40 (216 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119250 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 21:34:39.981239) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 21:34:39.981528) ========= 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=03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014874 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 21:34:40.030965) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 21:34:40.031288) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5ff96be046af749644327f75b21ce9437d766886 --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 5ff96be046af749644327f75b21ce9437d766886 --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=03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-08 21:34:40,219 truncating revision to first 12 chars 2016-08-08 21:34:40,219 Setting DEBUG logging. 2016-08-08 21:34:40,219 attempt 1/10 2016-08-08 21:34:40,219 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5ff96be046af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 21:34:40,849 unpacking tar archive at: fx-team-5ff96be046af/testing/mozharness/ program finished with exit code 0 elapsedTime=0.969199 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 21:34:41.014019) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 21:34:41.014394) ========= script_repo_revision: 5ff96be046af749644327f75b21ce9437d766886 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 21:34:41.014780) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 21:34:41.015048) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 21:34:41.024298) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-08 21:34:41.024591) ========= /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=03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:34:41 INFO - MultiFileLogger online at 20160808 21:34:41 in /builds/slave/test 21:34:41 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 21:34:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:34:41 INFO - {'append_to_log': False, 21:34:41 INFO - 'base_work_dir': '/builds/slave/test', 21:34:41 INFO - 'blob_upload_branch': 'Fx-Team', 21:34:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:34:41 INFO - 'branch': 'Fx-Team', 21:34:41 INFO - 'buildbot_json_path': 'buildprops.json', 21:34:41 INFO - 'config_files': ('talos/linux_config.py',), 21:34:41 INFO - 'default_actions': ('clobber', 21:34:41 INFO - 'read-buildbot-config', 21:34:41 INFO - 'download-and-extract', 21:34:41 INFO - 'populate-webroot', 21:34:41 INFO - 'create-virtualenv', 21:34:41 INFO - 'install', 21:34:41 INFO - 'run-tests'), 21:34:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:34:41 INFO - 'download_minidump_stackwalk': True, 21:34:41 INFO - 'download_symbols': 'ondemand', 21:34:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:34:41 INFO - 'tooltool.py': '/tools/tooltool.py', 21:34:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:34:41 INFO - '/tools/misc-python/virtualenv.py')}, 21:34:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:34:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:34:41 INFO - 'installer_path': 'installer.exe', 21:34:41 INFO - 'log_level': 'info', 21:34:41 INFO - 'log_name': 'talos', 21:34:41 INFO - 'log_to_console': True, 21:34:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:34:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:34:41 INFO - 'opt_config_files': (), 21:34:41 INFO - 'pip_index': False, 21:34:41 INFO - 'sps_profile': False, 21:34:41 INFO - 'sps_profile_interval': 0, 21:34:41 INFO - 'suite': 'dromaeojs', 21:34:41 INFO - 'system_bits': '32', 21:34:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:34:41 INFO - 'title': 'talos-linux64-ix-047', 21:34:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:34:41 INFO - 'use_talos_json': True, 21:34:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:34:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:34:41 INFO - 'work_dir': 'build'} 21:34:41 INFO - [mozharness: 2016-08-09 04:34:41.302245Z] Running clobber step. 21:34:41 INFO - Running pre-action listener: _resource_record_pre_action 21:34:41 INFO - Running main action method: clobber 21:34:41 INFO - rmtree: /builds/slave/test/build 21:34:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:34:41 INFO - Running post-action listener: _resource_record_post_action 21:34:41 INFO - [mozharness: 2016-08-09 04:34:41.764175Z] Finished clobber step (success) 21:34:41 INFO - [mozharness: 2016-08-09 04:34:41.764279Z] Running read-buildbot-config step. 21:34:41 INFO - Running pre-action listener: _resource_record_pre_action 21:34:41 INFO - Running main action method: read_buildbot_config 21:34:41 INFO - Using buildbot properties: 21:34:41 INFO - { 21:34:41 INFO - "project": "", 21:34:41 INFO - "product": "firefox", 21:34:41 INFO - "script_repo_revision": "production", 21:34:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:34:41 INFO - "repository": "", 21:34:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 21:34:41 INFO - "buildid": "20160808173001", 21:34:41 INFO - "pgo_build": "True", 21:34:41 INFO - "basedir": "/builds/slave/test", 21:34:41 INFO - "buildnumber": 966, 21:34:41 INFO - "slavename": "talos-linux64-ix-047", 21:34:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:34:41 INFO - "platform": "ubuntu64_hw", 21:34:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:34:41 INFO - "branch": "fx-team", 21:34:41 INFO - "repo_path": "integration/fx-team", 21:34:41 INFO - "revision": "5ff96be046af749644327f75b21ce9437d766886", 21:34:41 INFO - "stage_platform": "linux64-pgo", 21:34:41 INFO - "builduid": "4d7a8406f94d4fd1b56b1fb59e7f712a", 21:34:41 INFO - "slavebuilddir": "test" 21:34:41 INFO - } 21:34:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/COsqWIY4SraQxvpNLgsaRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 21:34:41 INFO - Running post-action listener: _resource_record_post_action 21:34:41 INFO - [mozharness: 2016-08-09 04:34:41.766751Z] Finished read-buildbot-config step (success) 21:34:41 INFO - [mozharness: 2016-08-09 04:34:41.766841Z] Running download-and-extract step. 21:34:41 INFO - Running pre-action listener: _resource_record_pre_action 21:34:41 INFO - Running main action method: download_and_extract 21:34:41 INFO - mkdir: /builds/slave/test/build/tests 21:34: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')]} 21:34:41 INFO - trying https://queue.taskcluster.net/v1/task/COsqWIY4SraQxvpNLgsaRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:34:41 INFO - Downloading https://queue.taskcluster.net/v1/task/COsqWIY4SraQxvpNLgsaRA/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 21:34:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/COsqWIY4SraQxvpNLgsaRA/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 21:34:42 INFO - Downloaded 1361 bytes. 21:34:42 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:34:42 INFO - Using the following test package requirements: 21:34:42 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 21:34:42 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:34:42 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:34:42 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:42 INFO - u'jsshell-linux-x86_64.zip'], 21:34:42 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:34:42 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 21:34:42 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:34:42 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:34:42 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:34:42 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:34:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:34:42 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:42 INFO - trying https://queue.taskcluster.net/v1/task/COsqWIY4SraQxvpNLgsaRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:34:42 INFO - Downloading https://queue.taskcluster.net/v1/task/COsqWIY4SraQxvpNLgsaRA/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 21:34:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/COsqWIY4SraQxvpNLgsaRA/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 21:34:43 INFO - Downloaded 21828404 bytes. 21:34:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:34:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:34:44 INFO - Return code: 0 21:34:44 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 21:34:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:44 INFO - trying https://queue.taskcluster.net/v1/task/COsqWIY4SraQxvpNLgsaRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:34:44 INFO - Downloading https://queue.taskcluster.net/v1/task/COsqWIY4SraQxvpNLgsaRA/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 21:34:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/COsqWIY4SraQxvpNLgsaRA/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 21:34:45 INFO - Downloaded 21828404 bytes. 21:34:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:34:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:34:46 INFO - Return code: 0 21:34:46 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')]} 21:34:46 INFO - trying https://queue.taskcluster.net/v1/task/COsqWIY4SraQxvpNLgsaRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 21:34:46 INFO - Downloading https://queue.taskcluster.net/v1/task/COsqWIY4SraQxvpNLgsaRA/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 21:34:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/COsqWIY4SraQxvpNLgsaRA/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 21:34:47 INFO - Downloaded 14413723 bytes. 21:34:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:34:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:34:47 INFO - Return code: 0 21:34:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:47 INFO - trying https://queue.taskcluster.net/v1/task/COsqWIY4SraQxvpNLgsaRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:34:47 INFO - Downloading https://queue.taskcluster.net/v1/task/COsqWIY4SraQxvpNLgsaRA/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 21:34:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/COsqWIY4SraQxvpNLgsaRA/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 21:34:49 INFO - Downloaded 59966260 bytes. 21:34:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/COsqWIY4SraQxvpNLgsaRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:34:49 INFO - mkdir: /builds/slave/test/properties 21:34:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:34:49 INFO - Writing to file /builds/slave/test/properties/build_url 21:34:49 INFO - Contents: 21:34:49 INFO - build_url:https://queue.taskcluster.net/v1/task/COsqWIY4SraQxvpNLgsaRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:34:49 INFO - Running post-action listener: _resource_record_post_action 21:34:49 INFO - Running post-action listener: set_extra_try_arguments 21:34:49 INFO - [mozharness: 2016-08-09 04:34:49.758635Z] Finished download-and-extract step (success) 21:34:49 INFO - [mozharness: 2016-08-09 04:34:49.758869Z] Running populate-webroot step. 21:34:49 INFO - Running pre-action listener: _resource_record_pre_action 21:34:49 INFO - Running main action method: populate_webroot 21:34:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:34:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:34:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:34:49 INFO - '--tppagecycles', 21:34:49 INFO - '7'], 21:34:49 INFO - 'tests': ['tsvgm']}}, 21:34:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:34:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:34:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:34:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:34:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:34:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:34:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:49 INFO - 'talos_options': ['--disable-e10s'], 21:34:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:34:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:34:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:49 INFO - 'talos_options': ['--disable-e10s'], 21:34:49 INFO - 'tests': ['damp', 'tps']}, 21:34:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:49 INFO - 'tests': ['damp', 'tps']}, 21:34:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:34:49 INFO - 'tests': ['dromaeo_dom']}, 21:34:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:34:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:34:49 INFO - 'tests': ['basic_compositor_video']}, 21:34:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:34:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:34:49 INFO - 'tests': ['a11yr', 21:34:49 INFO - 'ts_paint', 21:34:49 INFO - 'tpaint', 21:34:49 INFO - 'sessionrestore', 21:34:49 INFO - 'sessionrestore_no_auto_restore', 21:34:49 INFO - 'tabpaint']}, 21:34:49 INFO - 'other-e10s': {'tests': ['a11yr', 21:34:49 INFO - 'ts_paint', 21:34:49 INFO - 'tpaint', 21:34:49 INFO - 'sessionrestore', 21:34:49 INFO - 'sessionrestore_no_auto_restore', 21:34:49 INFO - 'tabpaint']}, 21:34:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:34:49 INFO - 'ts_paint', 21:34:49 INFO - 'tpaint', 21:34:49 INFO - 'sessionrestore', 21:34:49 INFO - 'sessionrestore_no_auto_restore', 21:34:49 INFO - 'tabpaint']}, 21:34:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:34:49 INFO - 'ts_paint', 21:34:49 INFO - 'tpaint', 21:34:49 INFO - 'sessionrestore', 21:34:49 INFO - 'sessionrestore_no_auto_restore', 21:34:49 INFO - 'tabpaint']}, 21:34:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:34:49 INFO - 'tests': ['a11yr', 21:34:49 INFO - 'ts_paint', 21:34:49 INFO - 'tpaint', 21:34:49 INFO - 'sessionrestore', 21:34:49 INFO - 'sessionrestore_no_auto_restore', 21:34:49 INFO - 'tabpaint']}, 21:34:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:34:49 INFO - 'tests': ['a11yr', 21:34:49 INFO - 'ts_paint', 21:34:49 INFO - 'tpaint', 21:34:49 INFO - 'sessionrestore', 21:34:49 INFO - 'sessionrestore_no_auto_restore', 21:34:49 INFO - 'tabpaint']}, 21:34:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:34:49 INFO - 'tests': ['tsvgx', 21:34:49 INFO - 'tsvgr_opacity', 21:34:49 INFO - 'tart', 21:34:49 INFO - 'tscrollx', 21:34:49 INFO - 'cart']}, 21:34:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:34:49 INFO - 'tsvgr_opacity', 21:34:49 INFO - 'tart', 21:34:49 INFO - 'tscrollx', 21:34:49 INFO - 'cart']}, 21:34:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:49 INFO - 'talos_options': ['--disable-e10s'], 21:34:49 INFO - 'tests': ['tp5o']}, 21:34:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:49 INFO - 'tests': ['tp5o']}, 21:34:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:49 INFO - 'talos_options': ['--disable-e10s', 21:34:49 INFO - '--xperf_path', 21:34:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:34:49 INFO - 'tests': ['tp5n']}, 21:34:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:34:49 INFO - 'talos_options': ['--xperf_path', 21:34:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:34:49 INFO - 'tests': ['tp5n']}}, 21:34:49 INFO - 'talos.zip': {'path': '', 21:34:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:34:49 INFO - Running post-action listener: _resource_record_post_action 21:34:49 INFO - [mozharness: 2016-08-09 04:34:49.781297Z] Finished populate-webroot step (success) 21:34:49 INFO - [mozharness: 2016-08-09 04:34:49.781387Z] Running create-virtualenv step. 21:34:49 INFO - Running pre-action listener: _resource_record_pre_action 21:34:49 INFO - Running main action method: create_virtualenv 21:34:49 INFO - Creating virtualenv /builds/slave/test/build/venv 21:34:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:34:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:34:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:34:49 INFO - Using real prefix '/usr' 21:34:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:34:50 INFO - Installing distribute.............................................................................................................................................................................................done. 21:34:52 INFO - Installing pip.................done. 21:34:52 INFO - Return code: 0 21:34:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d3b0>, '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 0x1d2e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e740>, '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': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', '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 21:34:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:34:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:34:52 INFO - Using env: {'DISPLAY': ':0', 21:34:52 INFO - 'HOME': '/home/cltbld', 21:34:52 INFO - 'LANG': 'en_US.UTF-8', 21:34:52 INFO - 'LANGUAGE': 'en_US:en', 21:34:52 INFO - 'LOGNAME': 'cltbld', 21:34:52 INFO - 'MAIL': '/var/mail/cltbld', 21:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:52 INFO - 'MOZ_NO_REMOTE': '1', 21:34:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:52 INFO - 'NO_EM_RESTART': '1', 21:34:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:52 INFO - 'PWD': '/builds/slave/test', 21:34:52 INFO - 'SHELL': '/bin/bash', 21:34:52 INFO - 'SHLVL': '1', 21:34:52 INFO - 'TERM': 'linux', 21:34:52 INFO - 'TMOUT': '86400', 21:34:52 INFO - 'USER': 'cltbld', 21:34:52 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', 21:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:52 INFO - '_': '/tools/buildbot/bin/python'} 21:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:34:52 INFO - Cleaning up... 21:34:52 INFO - Return code: 0 21:34:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d3b0>, '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 0x1d2e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e740>, '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': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', '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 21:34:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:34:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:34:52 INFO - Using env: {'DISPLAY': ':0', 21:34:52 INFO - 'HOME': '/home/cltbld', 21:34:52 INFO - 'LANG': 'en_US.UTF-8', 21:34:52 INFO - 'LANGUAGE': 'en_US:en', 21:34:52 INFO - 'LOGNAME': 'cltbld', 21:34:52 INFO - 'MAIL': '/var/mail/cltbld', 21:34:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:52 INFO - 'MOZ_NO_REMOTE': '1', 21:34:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:52 INFO - 'NO_EM_RESTART': '1', 21:34:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:52 INFO - 'PWD': '/builds/slave/test', 21:34:52 INFO - 'SHELL': '/bin/bash', 21:34:52 INFO - 'SHLVL': '1', 21:34:52 INFO - 'TERM': 'linux', 21:34:52 INFO - 'TMOUT': '86400', 21:34:52 INFO - 'USER': 'cltbld', 21:34:52 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', 21:34:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:52 INFO - '_': '/tools/buildbot/bin/python'} 21:34:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:52 INFO - Downloading/unpacking psutil>=3.1.1 21:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:34:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:34:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:34:54 INFO - Installing collected packages: psutil 21:34:54 INFO - Running setup.py install for psutil 21:34:54 INFO - building 'psutil._psutil_linux' extension 21:34:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:34:55 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 21:34:55 INFO - building 'psutil._psutil_posix' extension 21:34:55 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 21:34:55 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 21:34:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:34:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:34:55 INFO - Successfully installed psutil 21:34:55 INFO - Cleaning up... 21:34:55 INFO - Return code: 0 21:34:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d3b0>, '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 0x1d2e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e740>, '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': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', '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 21:34:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:34:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:34:55 INFO - Using env: {'DISPLAY': ':0', 21:34:55 INFO - 'HOME': '/home/cltbld', 21:34:55 INFO - 'LANG': 'en_US.UTF-8', 21:34:55 INFO - 'LANGUAGE': 'en_US:en', 21:34:55 INFO - 'LOGNAME': 'cltbld', 21:34:55 INFO - 'MAIL': '/var/mail/cltbld', 21:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:55 INFO - 'MOZ_NO_REMOTE': '1', 21:34:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:55 INFO - 'NO_EM_RESTART': '1', 21:34:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:55 INFO - 'PWD': '/builds/slave/test', 21:34:55 INFO - 'SHELL': '/bin/bash', 21:34:55 INFO - 'SHLVL': '1', 21:34:55 INFO - 'TERM': 'linux', 21:34:55 INFO - 'TMOUT': '86400', 21:34:55 INFO - 'USER': 'cltbld', 21:34:55 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', 21:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:55 INFO - '_': '/tools/buildbot/bin/python'} 21:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:34: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 21:34: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 21:34: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 21:34: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 21:34: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 21:34: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 21:34:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:34:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:34:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:34:57 INFO - Installing collected packages: mozsystemmonitor 21:34:57 INFO - Running setup.py install for mozsystemmonitor 21:34:57 INFO - Successfully installed mozsystemmonitor 21:34:57 INFO - Cleaning up... 21:34:57 INFO - Return code: 0 21:34:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:34: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')]} 21:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:34:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34: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')]} 21:34:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:34:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:34:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d3b0>, '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 0x1d2e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e740>, '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': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', '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 21:34:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:34:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:34:57 INFO - Using env: {'DISPLAY': ':0', 21:34:57 INFO - 'HOME': '/home/cltbld', 21:34:57 INFO - 'LANG': 'en_US.UTF-8', 21:34:57 INFO - 'LANGUAGE': 'en_US:en', 21:34:57 INFO - 'LOGNAME': 'cltbld', 21:34:57 INFO - 'MAIL': '/var/mail/cltbld', 21:34:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:34:57 INFO - 'MOZ_NO_REMOTE': '1', 21:34:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:34:57 INFO - 'NO_EM_RESTART': '1', 21:34:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:34:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:34:57 INFO - 'PWD': '/builds/slave/test', 21:34:57 INFO - 'SHELL': '/bin/bash', 21:34:57 INFO - 'SHLVL': '1', 21:34:57 INFO - 'TERM': 'linux', 21:34:57 INFO - 'TMOUT': '86400', 21:34:57 INFO - 'USER': 'cltbld', 21:34:57 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', 21:34:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:34:57 INFO - '_': '/tools/buildbot/bin/python'} 21:34:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:34:57 INFO - Downloading/unpacking jsonschema==2.5.1 21:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:34:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:34:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:34:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:34:59 INFO - Downloading functools32-3.2.3-2.tar.gz 21:34:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:35:00 INFO - warning: no files found matching '*.txt' 21:35:00 INFO - no previously-included directories found matching 'build' 21:35:00 INFO - no previously-included directories found matching 'dist' 21:35:00 INFO - no previously-included directories found matching '.git*' 21:35:00 INFO - Installing collected packages: jsonschema, functools32 21:35:00 INFO - Running setup.py install for functools32 21:35:00 INFO - warning: no files found matching '*.txt' 21:35:00 INFO - no previously-included directories found matching 'build' 21:35:00 INFO - no previously-included directories found matching 'dist' 21:35:00 INFO - no previously-included directories found matching '.git*' 21:35:00 INFO - Successfully installed jsonschema functools32 21:35:00 INFO - Cleaning up... 21:35:00 INFO - Return code: 0 21:35:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:35: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')]} 21:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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')]} 21:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a6e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d3b0>, '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 0x1d2e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e740>, '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': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', '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 21:35:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:35:00 INFO - Using env: {'DISPLAY': ':0', 21:35:00 INFO - 'HOME': '/home/cltbld', 21:35:00 INFO - 'LANG': 'en_US.UTF-8', 21:35:00 INFO - 'LANGUAGE': 'en_US:en', 21:35:00 INFO - 'LOGNAME': 'cltbld', 21:35:00 INFO - 'MAIL': '/var/mail/cltbld', 21:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:00 INFO - 'MOZ_NO_REMOTE': '1', 21:35:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:00 INFO - 'NO_EM_RESTART': '1', 21:35:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:00 INFO - 'PWD': '/builds/slave/test', 21:35:00 INFO - 'SHELL': '/bin/bash', 21:35:00 INFO - 'SHLVL': '1', 21:35:00 INFO - 'TERM': 'linux', 21:35:00 INFO - 'TMOUT': '86400', 21:35:00 INFO - 'USER': 'cltbld', 21:35:00 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', 21:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:00 INFO - '_': '/tools/buildbot/bin/python'} 21:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:35:00 INFO - Cleaning up... 21:35:00 INFO - Return code: 0 21:35:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:35: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')]} 21:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35: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')]} 21:35:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d3b0>, '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 0x1d2e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e740>, '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': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', '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 21:35:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:35:00 INFO - Using env: {'DISPLAY': ':0', 21:35:00 INFO - 'HOME': '/home/cltbld', 21:35:00 INFO - 'LANG': 'en_US.UTF-8', 21:35:00 INFO - 'LANGUAGE': 'en_US:en', 21:35:00 INFO - 'LOGNAME': 'cltbld', 21:35:00 INFO - 'MAIL': '/var/mail/cltbld', 21:35:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:00 INFO - 'MOZ_NO_REMOTE': '1', 21:35:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:00 INFO - 'NO_EM_RESTART': '1', 21:35:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:00 INFO - 'PWD': '/builds/slave/test', 21:35:00 INFO - 'SHELL': '/bin/bash', 21:35:00 INFO - 'SHLVL': '1', 21:35:00 INFO - 'TERM': 'linux', 21:35:00 INFO - 'TMOUT': '86400', 21:35:00 INFO - 'USER': 'cltbld', 21:35:00 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', 21:35:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:00 INFO - '_': '/tools/buildbot/bin/python'} 21:35:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:00 INFO - Downloading/unpacking blobuploader==1.2.4 21:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:02 INFO - Downloading blobuploader-1.2.4.tar.gz 21:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:35:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:35:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:03 INFO - Downloading docopt-0.6.1.tar.gz 21:35:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:35:03 INFO - Installing collected packages: blobuploader, requests, docopt 21:35:03 INFO - Running setup.py install for blobuploader 21:35:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:35:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:35:03 INFO - Running setup.py install for requests 21:35:03 INFO - Running setup.py install for docopt 21:35:03 INFO - Successfully installed blobuploader requests docopt 21:35:03 INFO - Cleaning up... 21:35:03 INFO - Return code: 0 21:35:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d3b0>, '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 0x1d2e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e740>, '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': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', '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 21:35:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:35:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:35:03 INFO - Using env: {'DISPLAY': ':0', 21:35:03 INFO - 'HOME': '/home/cltbld', 21:35:03 INFO - 'LANG': 'en_US.UTF-8', 21:35:03 INFO - 'LANGUAGE': 'en_US:en', 21:35:03 INFO - 'LOGNAME': 'cltbld', 21:35:03 INFO - 'MAIL': '/var/mail/cltbld', 21:35:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:03 INFO - 'MOZ_NO_REMOTE': '1', 21:35:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:03 INFO - 'NO_EM_RESTART': '1', 21:35:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:03 INFO - 'PWD': '/builds/slave/test', 21:35:03 INFO - 'SHELL': '/bin/bash', 21:35:03 INFO - 'SHLVL': '1', 21:35:03 INFO - 'TERM': 'linux', 21:35:03 INFO - 'TMOUT': '86400', 21:35:03 INFO - 'USER': 'cltbld', 21:35:03 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', 21:35:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:03 INFO - '_': '/tools/buildbot/bin/python'} 21:35:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:35:04 INFO - Running setup.py (path:/tmp/pip-9_ep5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:35:04 INFO - Running setup.py (path:/tmp/pip-HOM6Z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:35:04 INFO - Running setup.py (path:/tmp/pip-NZGI0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:35:04 INFO - Running setup.py (path:/tmp/pip-_C7v2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:35:04 INFO - Running setup.py (path:/tmp/pip-tHLzAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:35:04 INFO - Running setup.py (path:/tmp/pip-7bN9SO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:35:04 INFO - Running setup.py (path:/tmp/pip-dEJcTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:35:04 INFO - Running setup.py (path:/tmp/pip-o90EOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:35:04 INFO - Running setup.py (path:/tmp/pip-IVeghn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:35:04 INFO - Running setup.py (path:/tmp/pip-fV41Yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:35:04 INFO - Running setup.py (path:/tmp/pip-YOQ2NK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:35:04 INFO - Running setup.py (path:/tmp/pip-mBBNoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:35:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:35:04 INFO - Running setup.py (path:/tmp/pip-ZmR7zk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:35:05 INFO - Running setup.py (path:/tmp/pip-lyGSJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:05 INFO - Running setup.py (path:/tmp/pip-Wswums-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:35:05 INFO - Running setup.py (path:/tmp/pip-8Pmmga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:35:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:35:05 INFO - Running setup.py (path:/tmp/pip-1Jazfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:35:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:35:05 INFO - Running setup.py install for manifestparser 21:35:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:35:05 INFO - Running setup.py install for mozcrash 21:35:05 INFO - Running setup.py install for mozdebug 21:35:05 INFO - Running setup.py install for mozdevice 21:35:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:35:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:35:05 INFO - Running setup.py install for mozfile 21:35:05 INFO - Running setup.py install for mozhttpd 21:35:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:35:05 INFO - Running setup.py install for mozinfo 21:35:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:35:06 INFO - Running setup.py install for mozInstall 21:35:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:35:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:35:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:35:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:35:06 INFO - Running setup.py install for mozleak 21:35:06 INFO - Running setup.py install for mozlog 21:35:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:35:06 INFO - Running setup.py install for moznetwork 21:35:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:35:06 INFO - Running setup.py install for mozprocess 21:35:06 INFO - Running setup.py install for mozprofile 21:35:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:35:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:35:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:35:06 INFO - Running setup.py install for mozrunner 21:35:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:35:06 INFO - Running setup.py install for mozscreenshot 21:35:06 INFO - Running setup.py install for moztest 21:35:06 INFO - Running setup.py install for mozversion 21:35:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:35:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:35:07 INFO - Cleaning up... 21:35:07 INFO - Return code: 0 21:35:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:07 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')]} 21:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:07 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')]} 21:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:07 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 0x1a6e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d3b0>, '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 0x1d2e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e740>, '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': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', '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 21:35:07 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 21:35:07 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 21:35:07 INFO - Using env: {'DISPLAY': ':0', 21:35:07 INFO - 'HOME': '/home/cltbld', 21:35:07 INFO - 'LANG': 'en_US.UTF-8', 21:35:07 INFO - 'LANGUAGE': 'en_US:en', 21:35:07 INFO - 'LOGNAME': 'cltbld', 21:35:07 INFO - 'MAIL': '/var/mail/cltbld', 21:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:07 INFO - 'MOZ_NO_REMOTE': '1', 21:35:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:07 INFO - 'NO_EM_RESTART': '1', 21:35:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:07 INFO - 'PWD': '/builds/slave/test', 21:35:07 INFO - 'SHELL': '/bin/bash', 21:35:07 INFO - 'SHLVL': '1', 21:35:07 INFO - 'TERM': 'linux', 21:35:07 INFO - 'TMOUT': '86400', 21:35:07 INFO - 'USER': 'cltbld', 21:35:07 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', 21:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:07 INFO - '_': '/tools/buildbot/bin/python'} 21:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:35:07 INFO - Running setup.py (path:/tmp/pip-YPSQK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:35:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:35:07 INFO - Running setup.py (path:/tmp/pip-TpVtRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:35:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:35:07 INFO - Running setup.py (path:/tmp/pip-U9LKwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:35:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:35:07 INFO - Running setup.py (path:/tmp/pip-XERFOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:35:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:35:07 INFO - Running setup.py (path:/tmp/pip-kYnG4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:35:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:35:07 INFO - Running setup.py (path:/tmp/pip-4ZKPtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:35:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:35:07 INFO - Running setup.py (path:/tmp/pip-4vI5mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:35:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:35:07 INFO - Running setup.py (path:/tmp/pip-FA6Wqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:35:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:35:07 INFO - Running setup.py (path:/tmp/pip-hefU_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:35:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:35:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:35:07 INFO - Running setup.py (path:/tmp/pip-pFqtUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:35:08 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)) 21:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:35:08 INFO - Running setup.py (path:/tmp/pip-gPB1D6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:35:08 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)) 21:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:35:08 INFO - Running setup.py (path:/tmp/pip-0hNk3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:35:08 INFO - Running setup.py (path:/tmp/pip-tb_ZLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:35:08 INFO - Running setup.py (path:/tmp/pip-5K8wVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:08 INFO - Running setup.py (path:/tmp/pip-6P1b4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:35:08 INFO - Running setup.py (path:/tmp/pip-u9xd10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:35:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:35:08 INFO - Running setup.py (path:/tmp/pip-2tujmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:35:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:35:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:35:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:35:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:35:10 INFO - Downloading blessings-1.6.tar.gz 21:35:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:35:10 INFO - Installing collected packages: blessings 21:35:10 INFO - Running setup.py install for blessings 21:35:10 INFO - Successfully installed blessings 21:35:10 INFO - Cleaning up... 21:35:10 INFO - Return code: 0 21:35:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:35:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:35:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:35:10 INFO - Reading from file tmpfile_stdout 21:35:10 INFO - Current package versions: 21:35:10 INFO - argparse == 1.2.1 21:35:10 INFO - blessings == 1.6 21:35:10 INFO - blobuploader == 1.2.4 21:35:10 INFO - docopt == 0.6.1 21:35:10 INFO - functools32 == 3.2.3-2 21:35:10 INFO - jsonschema == 2.5.1 21:35:10 INFO - manifestparser == 1.1 21:35:10 INFO - mozInstall == 1.12 21:35:10 INFO - mozcrash == 0.17 21:35:10 INFO - mozdebug == 0.1 21:35:10 INFO - mozdevice == 0.48 21:35:10 INFO - mozfile == 1.2 21:35:10 INFO - mozhttpd == 0.7 21:35:10 INFO - mozinfo == 0.9 21:35:10 INFO - mozleak == 0.1 21:35:10 INFO - mozlog == 3.3 21:35:10 INFO - moznetwork == 0.27 21:35:10 INFO - mozprocess == 0.23 21:35:10 INFO - mozprofile == 0.28 21:35:10 INFO - mozrunner == 6.12 21:35:10 INFO - mozscreenshot == 0.1 21:35:10 INFO - mozsystemmonitor == 0.3 21:35:10 INFO - moztest == 0.7 21:35:10 INFO - mozversion == 1.4 21:35:10 INFO - psutil == 3.1.1 21:35:10 INFO - requests == 1.2.3 21:35:10 INFO - wsgiref == 0.1.2 21:35:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d3b0>, '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 0x1d2e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e740>, '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': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', '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 21:35:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:35:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:35:10 INFO - Using env: {'DISPLAY': ':0', 21:35:10 INFO - 'HOME': '/home/cltbld', 21:35:10 INFO - 'LANG': 'en_US.UTF-8', 21:35:10 INFO - 'LANGUAGE': 'en_US:en', 21:35:10 INFO - 'LOGNAME': 'cltbld', 21:35:10 INFO - 'MAIL': '/var/mail/cltbld', 21:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:10 INFO - 'MOZ_NO_REMOTE': '1', 21:35:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:10 INFO - 'NO_EM_RESTART': '1', 21:35:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:10 INFO - 'PWD': '/builds/slave/test', 21:35:10 INFO - 'SHELL': '/bin/bash', 21:35:10 INFO - 'SHLVL': '1', 21:35:10 INFO - 'TERM': 'linux', 21:35:10 INFO - 'TMOUT': '86400', 21:35:10 INFO - 'USER': 'cltbld', 21:35:10 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', 21:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:10 INFO - '_': '/tools/buildbot/bin/python'} 21:35:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:11 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)) 21:35:11 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)) 21:35:11 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)) 21:35:11 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)) 21:35:11 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)) 21:35:11 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)) 21:35:11 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)) 21:35:11 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)) 21:35:11 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)) 21:35:11 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)) 21:35:11 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)) 21:35:11 INFO - Cleaning up... 21:35:11 INFO - Return code: 0 21:35:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:35:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:35:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:35:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:35:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a6e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bd18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d2f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d2d3b0>, '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 0x1d2e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e740>, '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': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', '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 21:35:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:35:11 INFO - Using env: {'DISPLAY': ':0', 21:35:11 INFO - 'HOME': '/home/cltbld', 21:35:11 INFO - 'LANG': 'en_US.UTF-8', 21:35:11 INFO - 'LANGUAGE': 'en_US:en', 21:35:11 INFO - 'LOGNAME': 'cltbld', 21:35:11 INFO - 'MAIL': '/var/mail/cltbld', 21:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:11 INFO - 'MOZ_NO_REMOTE': '1', 21:35:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:11 INFO - 'NO_EM_RESTART': '1', 21:35:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:11 INFO - 'PWD': '/builds/slave/test', 21:35:11 INFO - 'SHELL': '/bin/bash', 21:35:11 INFO - 'SHLVL': '1', 21:35:11 INFO - 'TERM': 'linux', 21:35:11 INFO - 'TMOUT': '86400', 21:35:11 INFO - 'USER': 'cltbld', 21:35:11 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', 21:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:11 INFO - '_': '/tools/buildbot/bin/python'} 21:35:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:35:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:35:11 INFO - Cleaning up... 21:35:11 INFO - Return code: 0 21:35:11 INFO - Running post-action listener: _resource_record_post_action 21:35:11 INFO - Running post-action listener: _start_resource_monitoring 21:35:11 INFO - Starting resource monitoring. 21:35:11 INFO - [mozharness: 2016-08-09 04:35:11.387013Z] Finished create-virtualenv step (success) 21:35:11 INFO - [mozharness: 2016-08-09 04:35:11.387455Z] Running install step. 21:35:11 INFO - Running pre-action listener: _resource_record_pre_action 21:35:11 INFO - Running main action method: install 21:35:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:35:11 INFO - Reading from file tmpfile_stdout 21:35:11 INFO - Detecting whether we're running mozinstall >=1.0... 21:35:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:35:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:35:11 INFO - Reading from file tmpfile_stdout 21:35:11 INFO - Output received: 21:35:11 INFO - Usage: mozinstall [options] installer 21:35:11 INFO - Options: 21:35:11 INFO - -h, --help show this help message and exit 21:35:11 INFO - -d DEST, --destination=DEST 21:35:11 INFO - Directory to install application into. [default: 21:35:11 INFO - "/builds/slave/test"] 21:35:11 INFO - --app=APP Application being installed. [default: firefox] 21:35:11 INFO - mkdir: /builds/slave/test/build/application 21:35:11 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'] 21:35:11 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 21:35:29 INFO - Reading from file tmpfile_stdout 21:35:29 INFO - Output received: 21:35:29 INFO - /builds/slave/test/build/application/firefox/firefox 21:35:29 INFO - Running post-action listener: _resource_record_post_action 21:35:29 INFO - [mozharness: 2016-08-09 04:35:29.111479Z] Finished install step (success) 21:35:29 INFO - [mozharness: 2016-08-09 04:35:29.111729Z] Running run-tests step. 21:35:29 INFO - Running pre-action listener: _resource_record_pre_action 21:35:29 INFO - Running main action method: run_tests 21:35:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:35:29 INFO - Python 2.7.3 21:35:29 INFO - Return code: 0 21:35:29 INFO - grabbing minidump binary from tooltool 21:35: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')]} 21:35:29 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 0x1d2d3b0>, '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 0x1d2e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d2e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:35:29 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 21:35:29 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 21:35:29 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 21:35:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:35:29 INFO - Return code: 0 21:35:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:35:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:35:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:35:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:35:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:35:29 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/COsqWIY4SraQxvpNLgsaRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 21:35:29 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/COsqWIY4SraQxvpNLgsaRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 21:35:29 INFO - Using env: {'DISPLAY': ':0', 21:35:29 INFO - 'HOME': '/home/cltbld', 21:35:29 INFO - 'LANG': 'en_US.UTF-8', 21:35:29 INFO - 'LANGUAGE': 'en_US:en', 21:35:29 INFO - 'LOGNAME': 'cltbld', 21:35:29 INFO - 'MAIL': '/var/mail/cltbld', 21:35:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:35:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:35:29 INFO - 'MOZ_NO_REMOTE': '1', 21:35:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:35:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:35:29 INFO - 'NO_EM_RESTART': '1', 21:35:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:35:29 INFO - 'PWD': '/builds/slave/test', 21:35:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:35:29 INFO - 'SHELL': '/bin/bash', 21:35:29 INFO - 'SHLVL': '1', 21:35:29 INFO - 'TERM': 'linux', 21:35:29 INFO - 'TMOUT': '86400', 21:35:29 INFO - 'USER': 'cltbld', 21:35:29 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637', 21:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:35:29 INFO - '_': '/tools/buildbot/bin/python'} 21:35:29 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/COsqWIY4SraQxvpNLgsaRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 21:35:29 INFO - mozversion application_buildid: 20160808173001 21:35:29 INFO - mozversion application_changeset: 5ff96be046af749644327f75b21ce9437d766886 21:35:29 INFO - mozversion application_display_name: Nightly 21:35:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:35:29 INFO - mozversion application_name: Firefox 21:35:29 INFO - mozversion application_remotingname: firefox 21:35:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:35:29 INFO - mozversion application_vendor: Mozilla 21:35:29 INFO - mozversion application_version: 51.0a1 21:35:29 INFO - mozversion platform_buildid: 20160808173001 21:35:29 INFO - mozversion platform_changeset: 5ff96be046af749644327f75b21ce9437d766886 21:35:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:35:29 INFO - mozversion platform_version: 51.0a1 21:35:29 INFO - using testdate: 1470717329 21:35:29 INFO - actual date: 1470717329 21:35:29 INFO - starting webserver on 'localhost:45462' 21:35:29 INFO - SUITE-START | Running 2 tests 21:35:29 INFO - TEST-START | dromaeo_css 21:35:29 INFO - operating with platform_type : linux_ 21:35:29 INFO - Initialising browser for dromaeo_css test... 21:35:29 INFO - TEST-INFO | started process 28006 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpioDemF/profile http://localhost:45462/getInfo.html) 21:35:33 INFO - PROCESS | 28006 | __metrics Screen width/height:1600/1200 21:35:33 INFO - PROCESS | 28006 | colorDepth:24 21:35:33 INFO - PROCESS | 28006 | Browser inner width/height: 1024/697 21:35:33 INFO - PROCESS | 28006 | __metrics 21:35:34 INFO - PROCESS | 28006 | 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" 21:35:34 INFO - PROCESS | 28006 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:35:35 INFO - TEST-INFO | 28006: exit 0 21:35:35 INFO - Browser initialized. 21:35:35 INFO - Running cycle 1/1 for dromaeo_css test... 21:35:35 INFO - TEST-INFO | started process 28088 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpioDemF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:35:46 INFO - PROCESS | 28088 | RSS: Main: 156430336 21:35:46 INFO - PROCESS | 28088 | 21:36:38 INFO - PROCESS | 28088 | 1470717398367 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] 21:38:47 INFO - PROCESS | 28088 | Cycle 1(1): loaded http://localhost:45462/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45462/tests/dromaeo/cssquery-ext.html) 21:38:48 INFO - PROCESS | 28088 | RSS: Main: 267198464 21:38:48 INFO - PROCESS | 28088 | 21:41:50 INFO - PROCESS | 28088 | Cycle 1(1): loaded http://localhost:45462/tests/dromaeo/cssquery-ext.html (next: http://localhost:45462/tests/dromaeo/cssquery-jquery.html) 21:41:51 INFO - PROCESS | 28088 | RSS: Main: 248954880 21:41:51 INFO - PROCESS | 28088 | 21:44:53 INFO - PROCESS | 28088 | Cycle 1(1): loaded http://localhost:45462/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45462/tests/dromaeo/cssquery-mootools.html) 21:44:54 INFO - PROCESS | 28088 | RSS: Main: 186916864 21:44:54 INFO - PROCESS | 28088 | 21:47:56 INFO - PROCESS | 28088 | Cycle 1(1): loaded http://localhost:45462/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45462/tests/dromaeo/cssquery-prototype.html) 21:47:56 INFO - PROCESS | 28088 | RSS: Main: 183164928 21:47:56 INFO - PROCESS | 28088 | 21:50:59 INFO - PROCESS | 28088 | Cycle 1(1): loaded http://localhost:45462/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45462/tests/dromaeo/cssquery-yui.html) 21:50:59 INFO - PROCESS | 28088 | RSS: Main: 190296064 21:50:59 INFO - PROCESS | 28088 | 21:54:02 INFO - PROCESS | 28088 | Cycle 1(1): loaded http://localhost:45462/tests/dromaeo/cssquery-yui.html (next: http://localhost:45462/tests/dromaeo/cssquery-dojo.html) 21:54:02 INFO - PROCESS | 28088 | RSS: Main: 281190400 21:54:02 INFO - PROCESS | 28088 | 21:54:02 INFO - PROCESS | 28088 | __start_tp_report 21:54:02 INFO - PROCESS | 28088 | _x_x_mozilla_page_load 21:54:02 INFO - PROCESS | 28088 | _x_x_mozilla_page_load_details 21:54:02 INFO - PROCESS | 28088 | |i|pagename|runs| 21:54:02 INFO - PROCESS | 28088 | |0;dojo.html;2993.3115383461804;2998.445287621789;3012.8945486907937;3020.4563178627845;3055.373648402078;5012.598992080634;5074.264231686403;5121.257417674435;5133.1786914093755;5176.948230517698;5137.717425541594;5157.638965272433;5161.81933632322;5187.533122019017;5191.221316802482;4612.1698094343;4698.953010469886;4709.9764501177615;4719.787609557578;4813.49458306878;4740.19416699162;4779.928301075487;4781.115493633672;4799.544043315879;4803.159447096761;4604.079184163164;4620.237660785966;4651.279051746951;4652.464966528859;4716.599089077416;4624.514425985257;4637.744924029177;4644.581987621096;4694.131585656664;4735.73953432561;4665.5567721066445;4668.439787225555;4683;4688.882777930545;4728.314394412825;4962.1812400953795;5055.140626093573;5087.135187018216;5116.334876466036;5130.050940576006;5399.595030372699;5468.179773034037;5469.042917489423;5477.3427188737605;5479.287692599936;5495.0383682855345;5500.944990550083;5510.669359838423;5515.61390702651;5573.303337082864;4995.225740010304;5082.771275292621;5146.30524879144;5157.303763991813;5210.47895210476;5708.942910570924;5713.085906254979;5713.885722285531;5726.513246374022;5727;5471.480209380103;5473.397926228112;5479.397266300703;5482.17767334895;5488.533474654699;5343.572514198855;5417.214503896913;5462.934727728134;5475.397706252309;5560.944390556043;5470.316210473691;5487.478689524489;5490.423505531941;5491.28613280279;5499.945000549943;5492.917606235909;5501.944980550224;5515.4760297771645;5519.668819870821;5593.74828132735;4189.141226048653;4246.087091275329;4275.828966841354;4281.165172791276;4337.436133302714;3840.7695538267794;3843.2121415110396;3845.538535375773;3878.806059697004;3880.20455806559;5216.113260745682;5230.555402790729;5251.711155886386;5275.630705850554;5315.123004704181;5354.54486368663;5430.266913966564;5488.039593071197;5510.035743744828;5595.692236927008;5239.187925871496;5243.082460569462;5244.501772331622;5251.658642188246;5261.947380526222;4768.928466073012;4780.4741478437345;4783.545563171493;4784.091022705675;4835.468098509161;5607.52336051432;5643.971780141155;5647;5672.829815105636;5760.510356619734;5427.511523962862;5452.482014208644;5454.945450545602;5479.0411677957;5490.862728431821;5724.914126288026;5727.656340619576;5730.455606717355;5734;5759.424057594207;5303.893922121459;5311.760970756248;5341.572674186134;5345.4654534546235;5383.219433182245;5420.078586640359;5447.428020057995;5453.072977593898;5456.48163424474;5490.0941344677685;5364;5373.596980226421;5373.9731301343245;5380.946190538045;5429.049916264717;5226.8954620908125;5298.682079075268;5315.6279060465395;5347.545458636059;5349.973250133725;5334.706591137369;5340.49265319794;5341.75962081715;5343.919841202307;5368.7852485901685;5389.461053894579;5396.21754845553;5441.7279136043835;5444.50999410055;5447.073997420369;5176.456472070529;5265.131253343156;5280.709560974184;5293.12663410533;5308.124159513637 21:54:02 INFO - PROCESS | 28088 | |1;ext.html;578.199194116149;586.1354502109389;610.3713175429307;616.7563812294145;625.265313256923;44870;46361.53638463614;46580.76709616447;46622.999999999956;49451.258231126565;47876.28185577219;48175.27737083947;48331.51668483314;48402.27396589054;48454.75772621141;8981.82036359274;9118.680846170386;9126.680566180185;9127.26981841451;9127.26981841451;9036.412633178823;9130.360874738772;9130.863037054416;9131.041240669734;9136;9157.221636160933;9187.35688501805;9190.264778817678;9190.31072669549;9197.448153110834;9047.321450891177;9084.091590840862;9085;9085.818843550362;9091.908970923498;9000.549972501414;9054.366194366397;9062.728118156467;9072.228860546862;9072.639104134367;44397.55602443966;44783.77608111939;45056.774716126536;45063.09873802539;45172.77413612944;3692.298463291966;3728.4780130781714;3738.028112690693;3814.809259537012;4355.5208927018;32889.3422131556;34779.826100869584;34952.12619684503;36056.63943360585;36190.27619447596;4457.3091170868565;4469.508354081048;4528.411306530163;4623.214053610895;4721.929171062402;361093;362941.11176664743;364855;365327;366034.1698291518;62228.688856556335;62299.377006230265;62429;62570.37429625737;62720.372796271455;47785;64762;66327.33672663308;66981.66509167521;67031;16423.507294781175;16626.25181866819;16656.58358541022;16753.91623041877;16778.161091945352;11578.073754099652;11649;11656.358900260397;11661.300321980709;11662.94168529169;17286.13569321529;19345.51636209106;19715.605687886164;19908.402747917586;19924.402267931986;7207.171175314801;7253.782386528413;7278.672459739324;7440.20992127952;7483.4013278937555;997.8054279415444;1051.148569658579;1064.824303989833;1126.808442564766;1166.9183157178916;33141.66858331386;33716.831415843255;34092.829535852165;34117.78211456781;34435.483467748;1086.0714089453404;1097.2483848563759;1151.83874257604;1160.3560024186656;1212.587720175127;18273.63452730938;18693.719594206097;19042.143103560375;19573;19731.802681973284;567450;568911;569243;570325;570659;61653.691731541054;62123.37876621176;62236.377636223966;62295.6885215571;62322;1338.9129706569042;1384.3908680180689;1405.4308005257888;1413.5052731544083;1415.490423447558;33545.49681754824;34813.65186348104;34853.65146348504;34958.12604684903;35326.293474130885;54371.72814135904;55221.72389138029;55225.1716224265;55304;55336.44663553313;480410;480713;481695;482347;483692;26043.479130417665;28587.28531786722;29608;30143.698563014088;30501.23746906345;49782.75108624434;50426.74786626043;50483;51327;51487.48512514827;41387.379189311585;41491.37762933619;42727;42803.35794963016;44353.33469998017;41041;41321.79339103406;41325.586744132175;42825.357619635106;42860.78569607132;41830.372544412465;43551.78224108986;44591.55408446004;44765.77617111894;45892.77053614711;35487.467687984186;38429.80785096168;39214.80392598019;39243.60756392399;39691.80154099211;28985.56521652219;29224.707752922197;29642;29664.703352966193;29668.554971675872 21:54:02 INFO - PROCESS | 28088 | |2;jquery.html;374.33742276171193;382.10968443526576;385.8823058967015;398.07646260675244;406.5568530301972;18154.90922545387;19460.61078778427;20806.16775328987;20984.580308393863;21010.894945525288;12001.159918805666;12815.487380504768;12819.743605127915;13288.402021909013;20049;5267.683938963665;5453.15476101203;5459;5459.317585301837;5461.2354270402175;5383.246345511631;7168.784936451889;7514.3237108660205;7610.467267291292;7612.162662107164;7473.215312392202;7577.090749110114;7602.087749470072;7604.771856844303;7667.34827539657;7464.320527881183;7653.464257501977;7687.231276872324;7696.114946781108;7705.845883082335;7417.443691723142;7464.664090115958;7466.4773465857415;7474.364679002291;7481.551106933547;26707.599386009224;27524.724752752616;27873.024444144357;28357.149285521467;28560.428791424056;2476.2447453526665;2489.950200995988;2583.883725232369;2777.0141599732005;2947.7199666031693;15146.924265378713;15834.129122898235;15887.36450541977;16037.919810400874;16710.331586736516;2002.3692536850845;2127.4149608857533;2135.508832968426;2152.5156839711094;2218.4342992536963;101344.98655013429;101949.490252549;104154.1700597856;106851.46574267157;107257.46371268171;18037.909810451125;18410.539736506427;18747.625047498972;18754;18779;32732.345353092805;32770.67229327724;32978;32994.67005329964;33141.50287745686;9992;10194.949025254826;10269.640562580424;10409.479526023668;10430;8388.245057944814;8435.536045517432;8490.320774338039;8723.127687231226;8777.29781617469;9120.224780893566;9171.678991235274;9218.677346292981;9346.906530934739;9405.529723513797;3339.0513424023848;3457.3258214647904;3476.28736109097;3663.2673465307043;3679.2273622539565;903.3270213690711;965.4014511003223;974.9463779492054;1010.4644538394663;1043.2384359417667;19958.30145944885;20077.397678069683;20274.18903243854;20455;20514.589708205753;984.178211193647;996.9102780749768;1036.6268143468346;1045.5451878432907;1048.8793788714243;10420.895791041992;10993.670189894316;10994.395308258123;11123.555057797597;11145.944270278758;434179;435443;437385;439147;459597;92434;92657;92773.53613232025;93897.53051234837;94493;973.2019743810008;987.3138168972639;988.7330420786491;996.496769131584;1000.3247807729754;17103.48689539316;17764.91117544456;17973.640527189644;18025.909870450563;18167.545811354823;42850.57149428466;43590.346144808485;44158.55841441544;44163.55836441723;44225.11549769051;56885;57961;61565;65499.672501637186;67207.66396167988;6899.965500172467;8142.5343438179325;8646.308295336485;8830.690925817566;9204.493752843659;13004.674883127998;13511.256880871646;13618.659533511345;13791.10357826738;13836.723265534432;11127.666170014912;11292.346298619983;11372.896014237393;11555;12133.332666703416;11473.713157170803;11869;11929.940350298193;12025.63923082309;12405.317707526172;11672.76654466889;11855.17013809025;11878.584249551224;11906.583269585522;12005.939970300093;7580.05249343832;7853.960730196312;8021.197880211932;8333.874991875247;8628.82742345137;10897.782044359226;11574.826377604511;11632.127590430582;11651.30092194471;11926.642200733992 21:54:02 INFO - PROCESS | 28088 | |3;mootools.html;1307.9084464087518;1422.5732280315904;1484.9554513364599;1581.533447632948;1768.3191971091135;7697.114831794345;8110.188981101887;8129.796755081126;8319.417640765134;8361.790955226108;8195.385346099036;8317;8319.916800832005;8320.583970801466;8322.958385208065;2312.895919683614;2336.4742932840145;2337.181986304788;2337.345543247893;2337.8714170720605;2233.2741858895843;2248.8425810193294;2315.617923042696;2317.606006978809;2318.316096751454;2271.943201419961;2293.3807871874583;2302.3093072078395;2303.585354636165;2305.6772051912662;2238.3285014495586;2240.3838944290287;2254.6392577187653;2259.141526220034;2259.9887000564972;2237.955240895173;2238.418011317069;2240.8543444676043;2241.350008497534;2242.338510139513;7976.401769867225;8316.334693224588;8363.456375335583;8369.204925532125;8374.916250837474;4845.854624361275;5080.034793389281;5099.08216521026;5099.745012749385;5110.310108135392;3070.3073759375916;3261.608606967179;3303.5540202072652;3311.6688331166933;3319.1204330852343;1004.2819384140302;1004.8593196952432;1023.6468418395716;1050.8003479338977;1064.3613831700995;11121.443927803659;11167.329960202333;11246.212765106446;11252.774944501065;11263.831042534368;4153.252414565347;4243.172581346607;4351.129774045204;4387.736735795863;4404.713693609905;9006.279497640173;9043.140901614335;9049.095090490899;9050.049744776836;9055.59249833759;4904.2643603459055;4927.926081108714;4932.53140951609;4932.876678083005;4939.827106051271;4135;4435.467743870691;4558.49856515783;4591.517890621503;4628.3288923105965;3584.534010578608;3619.7647152934974;3709.3323201823932;3732.701383889282;3741.9064523386587;1103.906167975731;1107.402002918415;1116.079234631416;1121.870984836738;1122.4107343644653;980.2599037726471;985.0641890204334;1005.0452070533023;1006.094514936563;1009.3590569987964;5726.9713651431475;5823.068309070613;5831.825045248649;5855.765769369263;5859.853503662443;443.312865059157;445.6234481862821;448.0501337165231;458.1226950389966;459.4348950790546;4088.100617864065;4106.568810274938;4109.835606575763;4113.91772164555;4115.094679170577;9898.505074746234;10272.383656980604;10313.432761198055;10318.122959548522;10329.638462653922;10190.439525826003;10220.693379198636;10220.846687299696;10222.437765922798;10227.897721022844;7498.700051997968;7817.921820781833;7825.904373387731;7845.333146682596;7912.4856884302335;5990.748992994549;5997.790077347272;6028.668423236764;6087.939120608914;6131.325554189125;9498.667546635834;9526.618935242514;9538.523073846141;9546.474943878153;9625.133737963617;9234.769130771516;9640.662576810058;9681.467519286507;9736.269779766404;9741.025897410485;7544.47188696786;7575.431842611716;7600.087989441303;7651.234876512304;7668.309852113113;8120.715774947848;8179.222973817477;8183.754487365389;8186.508809471451;8188.7952801180445;7128.429725622042;7195.928040719526;7280.635968201463;7412.888806667796;7503.137139229058;7168.899143967492;7291.197968223597;7353.6690848912995;7572.583507907118;7592.4305677073335;6435.967820160869;6548.541602087808;6568;6571.704273307617;6574.211094668671;5002.499750024968;5141.53726164647;5187.351581052369;5206.6095042871175;5271.288376069335;5154.072266991828;5228.633995620422;5255;5264.184051472028;5339.546138578109 21:54:02 INFO - PROCESS | 28088 | |4;prototype.html;318.47292730530967;320.2969481987039;321.36049261968674;325.43212094894403;326.2089433124672;5194.298769666094;5232.110541207999;5242.711650859202;5250.737463126848;5256.658317209379;5167.199084141955;5182.896342073156;5184.274201611768;5199.792008319662;5200.479952004807;4026.879193624196;4158.625723684868;4162.438070860426;4164.646489890798;4170.728902621335;4122.6395289554375;4126;4126.793660316987;4145.419641250227;4151.418801367811;4082.2447847148223;4088.6729061674996;4091.3249313863175;4093.7953102344914;4093.856715014975;3896.844126234947;3908.863189788372;4097.7541347519245;4099.180163967204;4116.176764647053;3574.1779390740016;3579.731520136;3582.6417358264225;3590.9281814363826;3599.9740074079023;5050.116229659795;5053.444121146671;5062.569681577071;5077.517635824591;5114.360704911886;4401;4406.493253275882;4618.376519169903;4635.791389387486;4641.744704041276;5360.517553420172;5369.731513424353;5369.865753356158;5389.595780316492;5400.702961337164;3917.157811070605;3917.6865850731874;3923.117298607819;3929.9150167118673;3943.9014024649327;5481.451854814526;5548.167774833767;5581.6930068846195;5625.918410188216;5627.240322556443;4009.558948515661;4030.355143177136;4031.7580945143386;4035.152617950205;4041.4341992121126;4050.5341885683524;4053.2096241232675;4079.265732168179;4099.344104943254;4102.405151253051;4474.395956545824;4616.930746038812;4645.5354464553275;4646.4888862225125;4646.628269738413;5429.348478182565;5432.619716619878;5439.048166570834;5478.58910581708;5487.560995120461;1410.5909286307062;1427.5866891777066;1430.9125064950713;1432.7277817214697;1433.2117335465452;851.5912362066243;909.9363044586815;915.8900931888082;931.5202670624634;932.8087742012871;4683.765811709401;4708.223143181337;4716.268978308368;4717.292406139038;4720.0175926111115;4860.562549370574;4888.26675998596;4918.139325618003;4923.90152196954;4925.694690906913;4706.858794236178;4729.69256998294;4779.259214821708;4808.61531077513;5016.347874776256;2855.914322570326;2894.2040938742016;2940.617719696426;2973.3904549567287;3008.578798968146;5824.621399609012;5854.882902342015;5871.383504732027;5884.735186916599;5891.587588868823;5536.916946245809;5671.631343962712;5708.885822283531;5713.5714821388565;5731.083026715789;5799.2750906136735;5800.361960184377;5811.82564523065;5839.941600583939;5875.383084776123;5610.691411972381;5612.915806262991;5613.354464236501;5614.185943038318;5617.073182924772;5311.362636483646;5468.152436372368;5477.917831232615;5515.558755299647;5522.392536821027;5813.854653633523;5816.970915145397;5818.301803783404;5875.706214689163;5875.853103672443;3973.4039894016128;3978.8806335809973;3992.540857801274;3998.940015899822;4000.7199496035;5336.653117547347;5484.177373394023;5540.806071787468;5557.805476808292;5589.8261365113785;5374.570034397317;5427.864303392446;5431.293931788842;5432.864178395572;5445.264889239902;5281.471852814688;5369.946300537101;5428.83713488596;5434.483724046209;5459.262999495176;5329.54698850602;5331.946680533145;5341.519263266325;5346;5374.973125134349;5423.240746295601;5436.6194366393975;5459.362191342502;5469.179623056573;5475.917861232165;5090.109230884655;5301.5010093338215;5316.096263635114;5348.866278342917;5356.5982551308025 21:54:02 INFO - PROCESS | 28088 | |5;yui.html;742.6435311050695;749.951253168544;779.8713212319967;779.9924484807535;891.4205766251936;16031.51905442837;16919.49241522753;16921.3231470741;16961.236744346505;16961.745573816403;14883.18142502162;15508.612284692888;15570.53288401347;15577.065376077415;15584.298706558204;803.2730379006994;827.6399766101765;829.2329595124486;829.4152622401223;830.4353039932844;817.1501638296165;838.0446291228005;839.937004724645;841.5119230846094;849.0448245723561;891.2914233184601;892.2148509311796;892.5046599137476;892.8526793079134;892.9687460938868;888.8266787976347;889.1197714262897;889.1997202517721;889.5196593839319;889.884315039044;651.6546230497844;651.7979426377791;652.0349882174361;652.0642877470844;652.145689147214;14279.143251404845;14358.138511689333;14380.424783008772;14457.421703131862;14523.927380363137;15433;15454.459093931659;15515.612109697235;15548.844511554853;15564.37742490299;13035.608931732064;13255.403506842214;13268.535601254007;13445.731085378335;13535.864641353559;3854.998578319627;3920.7843568603716;3957.9010524736823;3979.6816254699556;4003.6396724294664;64476.35523644798;76930.23069769287;87672.56163719205;89433;92736.53631731866;10558.260921735558;10610.41642709643;10624.096951759033;10803.189760767973;11190.66428007161;21206.893965530384;21482;21757.67363489549;21780.564388712137;21860.45348866259;8509.531975741394;8660.696875609323;8722.651093956298;8740.475571465733;8807.295416366675;4876.926846097312;4895.094407534618;4936.605071594264;5053.36832895888;5091.032703786269;3551.1122219445137;3650.908727281839;3665.5051568038507;3670.33933891902;3671.2473942841652;588.8586739182565;591.8402031451484;597.6862147372577;616.2943429772974;618.4557589321369;692.9445644348541;695.3533214110926;785.5012067337168;788.2354116506979;796.3271035974592;10163;10511.864877188107;10592.364458132537;10619.734506637396;10643.893561064291;666.53009628212;721.2462976189894;746.6677328588726;774.825664225556;777.9183185765413;4816.686915350491;5019.598432125421;5077.466865979019;5083.847484575469;5230.764615592308;94739.52630236805;129549.35225324001;130441;131284;131806;71324;95999;96008;96897;98617.50691246642;52004.73997630063;73313;87261.56369218114;87353.56323218343;89823;10070.647527336509;10255.28213025111;10409;10446.477676116012;10533.36799792015;50956.23565646444;52849.47150528599;53609.46390536045;54172.45827541674;54807.177892332445;72966;73341;77308.61345693236;78626.2137378619;79178;12901.483940642269;13297.66755831112;13362;13749.931250344085;13832.792508112185;15429;15599.220038997777;15672.76490852661;15914.442994495137;16582.08798516093;14442.277886105863;14490.34793434277;14624;15009.549713508612;15538.300776464861;14467;14586.781198282246;14859.628509287355;15330.463433779763;15360.539183824503;14344.641383965485;14425.49510767118;14824.03643763152;15429.691406172038;15445.691086178438;11740.823887641864;11766.470508826953;11787.528498860293;12046.063734736563;12383.566575169825;10621.946890265499;10922.617708380169;11918.225315354473;12121.57574484924;12365.505379784709 21:54:02 INFO - PROCESS | 28088 | __end_tp_report 21:54:02 INFO - PROCESS | 28088 | __start_cc_report 21:54:02 INFO - PROCESS | 28088 | _x_x_mozilla_cycle_collect,1011 21:54:02 INFO - PROCESS | 28088 | __end_cc_report 21:54:02 INFO - PROCESS | 28088 | __startTimestamp1470718442762__endTimestamp 21:54:02 INFO - PROCESS | 28088 | 21:54:02 INFO - PROCESS | 28088 | ------- Summary: start ------- 21:54:02 INFO - PROCESS | 28088 | Number of tests: 6 21:54:02 INFO - PROCESS | 28088 | 21:54:02 INFO - PROCESS | 28088 | [#0] dojo.html Cycles:165 Average:5117.73 Median:5311.76 stddev:562.09 (10.6%) stddev-sans-first:538.54 21:54:02 INFO - PROCESS | 28088 | Values: 2993.3 2998.4 3012.9 3020.5 3055.4 5012.6 5074.3 5121.3 5133.2 5176.9 5137.7 5157.6 5161.8 5187.5 5191.2 4612.2 4699.0 4710.0 4719.8 4813.5 4740.2 4779.9 4781.1 4799.5 4803.2 4604.1 4620.2 4651.3 4652.5 4716.6 4624.5 4637.7 4644.6 4694.1 4735.7 4665.6 4668.4 4683.0 4688.9 4728.3 4962.2 5055.1 5087.1 5116.3 5130.1 5399.6 5468.2 5469.0 5477.3 5479.3 5495.0 5500.9 5510.7 5515.6 5573.3 4995.2 5082.8 5146.3 5157.3 5210.5 5708.9 5713.1 5713.9 5726.5 5727.0 5471.5 5473.4 5479.4 5482.2 5488.5 5343.6 5417.2 5462.9 5475.4 5560.9 5470.3 5487.5 5490.4 5491.3 5499.9 5492.9 5501.9 5515.5 5519.7 5593.7 4189.1 4246.1 4275.8 4281.2 4337.4 3840.8 3843.2 3845.5 3878.8 3880.2 5216.1 5230.6 5251.7 5275.6 5315.1 5354.5 5430.3 5488.0 5510.0 5595.7 5239.2 5243.1 5244.5 5251.7 5261.9 4768.9 4780.5 4783.5 4784.1 4835.5 5607.5 5644.0 5647.0 5672.8 5760.5 5427.5 5452.5 5454.9 5479.0 5490.9 5724.9 5727.7 5730.5 5734.0 5759.4 5303.9 5311.8 5341.6 5345.5 5383.2 5420.1 5447.4 5453.1 5456.5 5490.1 5364.0 5373.6 5374.0 5380.9 5429.0 5226.9 5298.7 5315.6 5347.5 5350.0 5334.7 5340.5 5341.8 5343.9 5368.8 5389.5 5396.2 5441.7 5444.5 5447.1 5176.5 5265.1 5280.7 5293.1 5308.1 21:54:02 INFO - PROCESS | 28088 | 21:54:02 INFO - PROCESS | 28088 | [#1] ext.html Cycles:180 Average:64140.29 Median:44774.78 stddev:127115.51 (283.9%) stddev-sans-first:127382.52 21:54:02 INFO - PROCESS | 28088 | Values: 578.2 586.1 610.4 616.8 625.3 44870.0 46361.5 46580.8 46623.0 49451.3 47876.3 48175.3 48331.5 48402.3 48454.8 8981.8 9118.7 9126.7 9127.3 9127.3 9036.4 9130.4 9130.9 9131.0 9136.0 9157.2 9187.4 9190.3 9190.3 9197.4 9047.3 9084.1 9085.0 9085.8 9091.9 9000.5 9054.4 9062.7 9072.2 9072.6 44397.6 44783.8 45056.8 45063.1 45172.8 3692.3 3728.5 3738.0 3814.8 4355.5 32889.3 34779.8 34952.1 36056.6 36190.3 4457.3 4469.5 4528.4 4623.2 4721.9 361093.0 362941.1 364855.0 365327.0 366034.2 62228.7 62299.4 62429.0 62570.4 62720.4 47785.0 64762.0 66327.3 66981.7 67031.0 16423.5 16626.3 16656.6 16753.9 16778.2 11578.1 11649.0 11656.4 11661.3 11662.9 17286.1 19345.5 19715.6 19908.4 19924.4 7207.2 7253.8 7278.7 7440.2 7483.4 997.8 1051.1 1064.8 1126.8 1166.9 33141.7 33716.8 34092.8 34117.8 34435.5 1086.1 1097.2 1151.8 1160.4 1212.6 18273.6 18693.7 19042.1 19573.0 19731.8 567450.0 568911.0 569243.0 570325.0 570659.0 61653.7 62123.4 62236.4 62295.7 62322.0 1338.9 1384.4 1405.4 1413.5 1415.5 33545.5 34813.7 34853.7 34958.1 35326.3 54371.7 55221.7 55225.2 55304.0 55336.4 480410.0 480713.0 481695.0 482347.0 483692.0 26043.5 28587.3 29608.0 30143.7 30501.2 49782.8 50426.7 50483.0 51327.0 51487.5 41387.4 41491.4 42727.0 42803.4 44353.3 41041.0 41321.8 41325.6 42825.4 42860.8 41830.4 43551.8 44591.6 44765.8 45892.8 35487.5 38429.8 39214.8 39243.6 39691.8 28985.6 29224.7 29642.0 29664.7 29668.6 21:54:02 INFO - PROCESS | 28088 | 21:54:02 INFO - PROCESS | 28088 | [#2] jquery.html Cycles:180 Average:29848.66 Median:32751.51 stddev:73480.23 (224.4%) stddev-sans-first:73653.04 21:54:02 INFO - PROCESS | 28088 | Values: 374.3 382.1 385.9 398.1 406.6 18154.9 19460.6 20806.2 20984.6 21010.9 12001.2 12815.5 12819.7 13288.4 20049.0 5267.7 5453.2 5459.0 5459.3 5461.2 5383.2 7168.8 7514.3 7610.5 7612.2 7473.2 7577.1 7602.1 7604.8 7667.3 7464.3 7653.5 7687.2 7696.1 7705.8 7417.4 7464.7 7466.5 7474.4 7481.6 26707.6 27524.7 27873.0 28357.1 28560.4 2476.2 2490.0 2583.9 2777.0 2947.7 15146.9 15834.1 15887.4 16037.9 16710.3 2002.4 2127.4 2135.5 2152.5 2218.4 101345.0 101949.5 104154.2 106851.5 107257.5 18037.9 18410.5 18747.6 18754.0 18779.0 32732.3 32770.7 32978.0 32994.7 33141.5 9992.0 10194.9 10269.6 10409.5 10430.0 8388.2 8435.5 8490.3 8723.1 8777.3 9120.2 9171.7 9218.7 9346.9 9405.5 3339.1 3457.3 3476.3 3663.3 3679.2 903.3 965.4 974.9 1010.5 1043.2 19958.3 20077.4 20274.2 20455.0 20514.6 984.2 996.9 1036.6 1045.5 1048.9 10420.9 10993.7 10994.4 11123.6 11145.9 434179.0 435443.0 437385.0 439147.0 459597.0 92434.0 92657.0 92773.5 93897.5 94493.0 973.2 987.3 988.7 996.5 1000.3 17103.5 17764.9 17973.6 18025.9 18167.5 42850.6 43590.3 44158.6 44163.6 44225.1 56885.0 57961.0 61565.0 65499.7 67207.7 6900.0 8142.5 8646.3 8830.7 9204.5 13004.7 13511.3 13618.7 13791.1 13836.7 11127.7 11292.3 11372.9 11555.0 12133.3 11473.7 11869.0 11929.9 12025.6 12405.3 11672.8 11855.2 11878.6 11906.6 12005.9 7580.1 7854.0 8021.2 8333.9 8628.8 10897.8 11574.8 11632.1 11651.3 11926.6 21:54:02 INFO - PROCESS | 28088 | 21:54:02 INFO - PROCESS | 28088 | [#3] mootools.html Cycles:180 Average:5497.87 Median:4932.70 stddev:3068.32 (62.2%) stddev-sans-first:3060.77 21:54:02 INFO - PROCESS | 28088 | Values: 1307.9 1422.6 1485.0 1581.5 1768.3 7697.1 8110.2 8129.8 8319.4 8361.8 8195.4 8317.0 8319.9 8320.6 8323.0 2312.9 2336.5 2337.2 2337.3 2337.9 2233.3 2248.8 2315.6 2317.6 2318.3 2271.9 2293.4 2302.3 2303.6 2305.7 2238.3 2240.4 2254.6 2259.1 2260.0 2238.0 2238.4 2240.9 2241.4 2242.3 7976.4 8316.3 8363.5 8369.2 8374.9 4845.9 5080.0 5099.1 5099.7 5110.3 3070.3 3261.6 3303.6 3311.7 3319.1 1004.3 1004.9 1023.6 1050.8 1064.4 11121.4 11167.3 11246.2 11252.8 11263.8 4153.3 4243.2 4351.1 4387.7 4404.7 9006.3 9043.1 9049.1 9050.0 9055.6 4904.3 4927.9 4932.5 4932.9 4939.8 4135.0 4435.5 4558.5 4591.5 4628.3 3584.5 3619.8 3709.3 3732.7 3741.9 1103.9 1107.4 1116.1 1121.9 1122.4 980.3 985.1 1005.0 1006.1 1009.4 5727.0 5823.1 5831.8 5855.8 5859.9 443.3 445.6 448.1 458.1 459.4 4088.1 4106.6 4109.8 4113.9 4115.1 9898.5 10272.4 10313.4 10318.1 10329.6 10190.4 10220.7 10220.8 10222.4 10227.9 7498.7 7817.9 7825.9 7845.3 7912.5 5990.7 5997.8 6028.7 6087.9 6131.3 9498.7 9526.6 9538.5 9546.5 9625.1 9234.8 9640.7 9681.5 9736.3 9741.0 7544.5 7575.4 7600.1 7651.2 7668.3 8120.7 8179.2 8183.8 8186.5 8188.8 7128.4 7195.9 7280.6 7412.9 7503.1 7168.9 7291.2 7353.7 7572.6 7592.4 6436.0 6548.5 6568.0 6571.7 6574.2 5002.5 5141.5 5187.4 5206.6 5271.3 5154.1 5228.6 5255.0 5264.2 5339.5 21:54:02 INFO - PROCESS | 28088 | 21:54:02 INFO - PROCESS | 28088 | [#4] prototype.html Cycles:180 Average:4547.93 Median:5140.78 stddev:1327.26 (25.8%) stddev-sans-first:1292.46 21:54:02 INFO - PROCESS | 28088 | Values: 318.5 320.3 321.4 325.4 326.2 5194.3 5232.1 5242.7 5250.7 5256.7 5167.2 5182.9 5184.3 5199.8 5200.5 4026.9 4158.6 4162.4 4164.6 4170.7 4122.6 4126.0 4126.8 4145.4 4151.4 4082.2 4088.7 4091.3 4093.8 4093.9 3896.8 3908.9 4097.8 4099.2 4116.2 3574.2 3579.7 3582.6 3590.9 3600.0 5050.1 5053.4 5062.6 5077.5 5114.4 4401.0 4406.5 4618.4 4635.8 4641.7 5360.5 5369.7 5369.9 5389.6 5400.7 3917.2 3917.7 3923.1 3929.9 3943.9 5481.5 5548.2 5581.7 5625.9 5627.2 4009.6 4030.4 4031.8 4035.2 4041.4 4050.5 4053.2 4079.3 4099.3 4102.4 4474.4 4616.9 4645.5 4646.5 4646.6 5429.3 5432.6 5439.0 5478.6 5487.6 1410.6 1427.6 1430.9 1432.7 1433.2 851.6 909.9 915.9 931.5 932.8 4683.8 4708.2 4716.3 4717.3 4720.0 4860.6 4888.3 4918.1 4923.9 4925.7 4706.9 4729.7 4779.3 4808.6 5016.3 2855.9 2894.2 2940.6 2973.4 3008.6 5824.6 5854.9 5871.4 5884.7 5891.6 5536.9 5671.6 5708.9 5713.6 5731.1 5799.3 5800.4 5811.8 5839.9 5875.4 5610.7 5612.9 5613.4 5614.2 5617.1 5311.4 5468.2 5477.9 5515.6 5522.4 5813.9 5817.0 5818.3 5875.7 5875.9 3973.4 3978.9 3992.5 3998.9 4000.7 5336.7 5484.2 5540.8 5557.8 5589.8 5374.6 5427.9 5431.3 5432.9 5445.3 5281.5 5369.9 5428.8 5434.5 5459.3 5329.5 5331.9 5341.5 5346.0 5375.0 5423.2 5436.6 5459.4 5469.2 5475.9 5090.1 5301.5 5316.1 5348.9 5356.6 21:54:02 INFO - PROCESS | 28088 | 21:54:02 INFO - PROCESS | 28088 | [#5] yui.html Cycles:180 Average:21233.88 Median:3939.34 stddev:30391.76 (771.5%) stddev-sans-first:30438.07 21:54:02 INFO - PROCESS | 28088 | Values: 742.6 750.0 779.9 780.0 891.4 16031.5 16919.5 16921.3 16961.2 16961.7 14883.2 15508.6 15570.5 15577.1 15584.3 803.3 827.6 829.2 829.4 830.4 817.2 838.0 839.9 841.5 849.0 891.3 892.2 892.5 892.9 893.0 888.8 889.1 889.2 889.5 889.9 651.7 651.8 652.0 652.1 652.1 14279.1 14358.1 14380.4 14457.4 14523.9 15433.0 15454.5 15515.6 15548.8 15564.4 13035.6 13255.4 13268.5 13445.7 13535.9 3855.0 3920.8 3957.9 3979.7 4003.6 64476.4 76930.2 87672.6 89433.0 92736.5 10558.3 10610.4 10624.1 10803.2 11190.7 21206.9 21482.0 21757.7 21780.6 21860.5 8509.5 8660.7 8722.7 8740.5 8807.3 4876.9 4895.1 4936.6 5053.4 5091.0 3551.1 3650.9 3665.5 3670.3 3671.2 588.9 591.8 597.7 616.3 618.5 692.9 695.4 785.5 788.2 796.3 10163.0 10511.9 10592.4 10619.7 10643.9 666.5 721.2 746.7 774.8 777.9 4816.7 5019.6 5077.5 5083.8 5230.8 94739.5 129549.4 130441.0 131284.0 131806.0 71324.0 95999.0 96008.0 96897.0 98617.5 52004.7 73313.0 87261.6 87353.6 89823.0 10070.6 10255.3 10409.0 10446.5 10533.4 50956.2 52849.5 53609.5 54172.5 54807.2 72966.0 73341.0 77308.6 78626.2 79178.0 12901.5 13297.7 13362.0 13749.9 13832.8 15429.0 15599.2 15672.8 15914.4 16582.1 14442.3 14490.3 14624.0 15009.5 15538.3 14467.0 14586.8 14859.6 15330.5 15360.5 14344.6 14425.5 14824.0 15429.7 15445.7 11740.8 11766.5 11787.5 12046.1 12383.6 10621.9 10922.6 11918.2 12121.6 12365.5 21:54:02 INFO - PROCESS | 28088 | -------- Summary: end -------- 21:54:02 INFO - PROCESS | 28088 | 21:54:03 INFO - TEST-INFO | 28088: exit 0 21:54:03 INFO - TEST-OK | dromaeo_css | took 1114214ms 21:54:03 INFO - TEST-START | kraken 21:54:03 INFO - operating with platform_type : linux_ 21:54:03 INFO - Initialising browser for kraken test... 21:54:03 INFO - TEST-INFO | started process 28275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpljkfXx/profile http://localhost:45462/getInfo.html) 21:54:07 INFO - PROCESS | 28275 | __metrics Screen width/height:1600/1200 21:54:07 INFO - PROCESS | 28275 | colorDepth:24 21:54:07 INFO - PROCESS | 28275 | Browser inner width/height: 1024/697 21:54:07 INFO - PROCESS | 28275 | __metrics 21:54:08 INFO - PROCESS | 28275 | 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" 21:54:08 INFO - PROCESS | 28275 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:54:09 INFO - TEST-INFO | 28275: exit 0 21:54:09 INFO - Browser initialized. 21:54:09 INFO - Running cycle 1/1 for kraken test... 21:54:09 INFO - TEST-INFO | started process 28355 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpljkfXx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:54:21 INFO - PROCESS | 28355 | RSS: Main: 156954624 21:54:21 INFO - PROCESS | 28355 | 21:54:23 INFO - PROCESS | 28355 | Cycle 1(1): loaded http://localhost:45462/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45462/tests/kraken/driver.html?testName=audio-beat-detection) 21:54:24 INFO - PROCESS | 28355 | RSS: Main: 213159936 21:54:24 INFO - PROCESS | 28355 | 21:54:27 INFO - PROCESS | 28355 | Cycle 1(1): loaded http://localhost:45462/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45462/tests/kraken/driver.html?testName=audio-dft) 21:54:27 INFO - PROCESS | 28355 | RSS: Main: 193171456 21:54:27 INFO - PROCESS | 28355 | 21:54:30 INFO - PROCESS | 28355 | Cycle 1(1): loaded http://localhost:45462/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45462/tests/kraken/driver.html?testName=audio-fft) 21:54:31 INFO - PROCESS | 28355 | RSS: Main: 269582336 21:54:31 INFO - PROCESS | 28355 | 21:54:33 INFO - PROCESS | 28355 | Cycle 1(1): loaded http://localhost:45462/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45462/tests/kraken/driver.html?testName=audio-oscillator) 21:54:34 INFO - PROCESS | 28355 | RSS: Main: 179961856 21:54:34 INFO - PROCESS | 28355 | 21:54:36 INFO - PROCESS | 28355 | Cycle 1(1): loaded http://localhost:45462/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45462/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:54:36 INFO - PROCESS | 28355 | RSS: Main: 184995840 21:54:36 INFO - PROCESS | 28355 | 21:54:39 INFO - PROCESS | 28355 | Cycle 1(1): loaded http://localhost:45462/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45462/tests/kraken/driver.html?testName=imaging-darkroom) 21:54:40 INFO - PROCESS | 28355 | RSS: Main: 219832320 21:54:40 INFO - PROCESS | 28355 | 21:54:43 INFO - PROCESS | 28355 | Cycle 1(1): loaded http://localhost:45462/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45462/tests/kraken/driver.html?testName=imaging-desaturate) 21:54:44 INFO - PROCESS | 28355 | RSS: Main: 220180480 21:54:44 INFO - PROCESS | 28355 | 21:54:47 INFO - PROCESS | 28355 | Cycle 1(1): loaded http://localhost:45462/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45462/tests/kraken/driver.html?testName=json-parse-financial) 21:54:47 INFO - PROCESS | 28355 | RSS: Main: 219754496 21:54:47 INFO - PROCESS | 28355 | 21:54:49 INFO - PROCESS | 28355 | Cycle 1(1): loaded http://localhost:45462/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45462/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:54:49 INFO - PROCESS | 28355 | RSS: Main: 184324096 21:54:49 INFO - PROCESS | 28355 | 21:54:51 INFO - PROCESS | 28355 | Cycle 1(1): loaded http://localhost:45462/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45462/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:54:52 INFO - PROCESS | 28355 | RSS: Main: 190291968 21:54:52 INFO - PROCESS | 28355 | 21:54:54 INFO - PROCESS | 28355 | Cycle 1(1): loaded http://localhost:45462/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45462/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:54:54 INFO - PROCESS | 28355 | RSS: Main: 194113536 21:54:54 INFO - PROCESS | 28355 | 21:54:57 INFO - PROCESS | 28355 | Cycle 1(1): loaded http://localhost:45462/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:54:58 INFO - PROCESS | 28355 | RSS: Main: 188846080 21:54:58 INFO - PROCESS | 28355 | 21:55:00 INFO - PROCESS | 28355 | Cycle 1(1): loaded http://localhost:45462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:55:01 INFO - PROCESS | 28355 | RSS: Main: 192827392 21:55:01 INFO - PROCESS | 28355 | 21:55:03 INFO - PROCESS | 28355 | Cycle 1(1): loaded http://localhost:45462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45462/tests/kraken/driver.html?testName=ai-astar) 21:55:03 INFO - PROCESS | 28355 | RSS: Main: 243728384 21:55:03 INFO - PROCESS | 28355 | 21:55:03 INFO - PROCESS | 28355 | __start_tp_report 21:55:03 INFO - PROCESS | 28355 | _x_x_mozilla_page_load 21:55:03 INFO - PROCESS | 28355 | _x_x_mozilla_page_load_details 21:55:03 INFO - PROCESS | 28355 | |i|pagename|runs| 21:55:03 INFO - PROCESS | 28355 | |0;ai-astar;105;110;111;111;111;112;110;111;111;110 21:55:03 INFO - PROCESS | 28355 | |1;audio-beat-detection;145;117;118;186;123;122;146;116;156;116 21:55:03 INFO - PROCESS | 28355 | |2;audio-dft;161;161;159;161;160;160;160;160;161;164 21:55:03 INFO - PROCESS | 28355 | |3;audio-fft;77;76;76;108;75;75;74;74;108;74 21:55:03 INFO - PROCESS | 28355 | |4;audio-oscillator;85;84;121;84;85;85;120;84;84;137 21:55:03 INFO - PROCESS | 28355 | |5;imaging-gaussian-blur;117;116;116;116;117;117;117;117;117;117 21:55:03 INFO - PROCESS | 28355 | |6;imaging-darkroom;146;146;145;146;146;146;146;146;145;147 21:55:03 INFO - PROCESS | 28355 | |7;imaging-desaturate;95;94;95;95;95;95;94;95;95;95 21:55:03 INFO - PROCESS | 28355 | |8;json-parse-financial;52;50;58;50;50;51;51;52;53;51 21:55:03 INFO - PROCESS | 28355 | |9;json-stringify-tinderbox;59;59;59;59;60;60;59;59;61;60 21:55:03 INFO - PROCESS | 28355 | |10;stanford-crypto-aes;84;80;75;75;75;75;75;75;75;79 21:55:03 INFO - PROCESS | 28355 | |11;stanford-crypto-ccm;122;131;123;123;124;119;135;123;144;142 21:55:03 INFO - PROCESS | 28355 | |12;stanford-crypto-pbkdf2;156;155;157;157;157;157;157;166;156;158 21:55:03 INFO - PROCESS | 28355 | |13;stanford-crypto-sha256-iterative;63;65;63;62;62;65;62;68;63;61 21:55:03 INFO - PROCESS | 28355 | __end_tp_report 21:55:03 INFO - PROCESS | 28355 | __start_cc_report 21:55:03 INFO - PROCESS | 28355 | _x_x_mozilla_cycle_collect,1710 21:55:03 INFO - PROCESS | 28355 | __end_cc_report 21:55:03 INFO - PROCESS | 28355 | __startTimestamp1470718503304__endTimestamp 21:55:03 INFO - PROCESS | 28355 | 21:55:03 INFO - PROCESS | 28355 | ------- Summary: start ------- 21:55:03 INFO - PROCESS | 28355 | Number of tests: 14 21:55:03 INFO - PROCESS | 28355 | 21:55:03 INFO - PROCESS | 28355 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:1.93 (1.7%) stddev-sans-first:0.67 21:55:03 INFO - PROCESS | 28355 | Values: 105.0 110.0 111.0 111.0 111.0 112.0 110.0 111.0 111.0 110.0 21:55:03 INFO - PROCESS | 28355 | 21:55:03 INFO - PROCESS | 28355 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:134.00 stddev:23.35 (17.4%) stddev-sans-first:24.46 21:55:03 INFO - PROCESS | 28355 | Values: 145.0 117.0 118.0 186.0 123.0 122.0 146.0 116.0 156.0 116.0 21:55:03 INFO - PROCESS | 28355 | 21:55:03 INFO - PROCESS | 28355 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.34 (0.8%) stddev-sans-first:1.41 21:55:03 INFO - PROCESS | 28355 | Values: 161.0 161.0 159.0 161.0 160.0 160.0 160.0 160.0 161.0 164.0 21:55:03 INFO - PROCESS | 28355 | 21:55:03 INFO - PROCESS | 28355 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.00 stddev:13.90 (18.5%) stddev-sans-first:14.64 21:55:03 INFO - PROCESS | 28355 | Values: 77.0 76.0 76.0 108.0 75.0 75.0 74.0 74.0 108.0 74.0 21:55:03 INFO - PROCESS | 28355 | 21:55:03 INFO - PROCESS | 28355 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:84.00 stddev:20.58 (24.5%) stddev-sans-first:21.38 21:55:03 INFO - PROCESS | 28355 | Values: 85.0 84.0 121.0 84.0 85.0 85.0 120.0 84.0 84.0 137.0 21:55:03 INFO - PROCESS | 28355 | 21:55:03 INFO - PROCESS | 28355 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 21:55:03 INFO - PROCESS | 28355 | Values: 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 21:55:03 INFO - PROCESS | 28355 | 21:55:03 INFO - PROCESS | 28355 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 21:55:03 INFO - PROCESS | 28355 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 147.0 21:55:03 INFO - PROCESS | 28355 | 21:55:03 INFO - PROCESS | 28355 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:55:03 INFO - PROCESS | 28355 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 21:55:03 INFO - PROCESS | 28355 | 21:55:03 INFO - PROCESS | 28355 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:51.50 stddev:2.39 (4.6%) stddev-sans-first:2.54 21:55:03 INFO - PROCESS | 28355 | Values: 52.0 50.0 58.0 50.0 50.0 51.0 51.0 52.0 53.0 51.0 21:55:03 INFO - PROCESS | 28355 | 21:55:03 INFO - PROCESS | 28355 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.50 stddev:0.71 (1.2%) stddev-sans-first:0.73 21:55:03 INFO - PROCESS | 28355 | Values: 59.0 59.0 59.0 59.0 60.0 60.0 59.0 59.0 61.0 60.0 21:55:03 INFO - PROCESS | 28355 | 21:55:03 INFO - PROCESS | 28355 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:75.00 stddev:3.16 (4.2%) stddev-sans-first:2.00 21:55:03 INFO - PROCESS | 28355 | Values: 84.0 80.0 75.0 75.0 75.0 75.0 75.0 75.0 75.0 79.0 21:55:03 INFO - PROCESS | 28355 | 21:55:03 INFO - PROCESS | 28355 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:127.50 stddev:8.91 (7.0%) stddev-sans-first:9.12 21:55:03 INFO - PROCESS | 28355 | Values: 122.0 131.0 123.0 123.0 124.0 119.0 135.0 123.0 144.0 142.0 21:55:03 INFO - PROCESS | 28355 | 21:55:03 INFO - PROCESS | 28355 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.60 Median:157.00 stddev:3.06 (2.0%) stddev-sans-first:3.19 21:55:03 INFO - PROCESS | 28355 | Values: 156.0 155.0 157.0 157.0 157.0 157.0 157.0 166.0 156.0 158.0 21:55:03 INFO - PROCESS | 28355 | 21:55:03 INFO - PROCESS | 28355 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:2.07 (3.3%) stddev-sans-first:2.19 21:55:03 INFO - PROCESS | 28355 | Values: 63.0 65.0 63.0 62.0 62.0 65.0 62.0 68.0 63.0 61.0 21:55:03 INFO - PROCESS | 28355 | -------- Summary: end -------- 21:55:03 INFO - PROCESS | 28355 | 21:55:04 INFO - TEST-INFO | 28355: exit 0 21:55:04 INFO - TEST-OK | kraken | took 60743ms 21:55:04 INFO - SUITE-END | took 1174s 21:55:04 INFO - Completed test suite (00:19:35) 21:55:04 INFO - javascript benchmark 21:55:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2993.3115383461804, 2998.445287621789, 3012.8945486907937, 3020.4563178627845, 3055.373648402078, 5012.598992080634, 5074.264231686403, 5121.257417674435, 5133.1786914093755, 5176.948230517698, 5137.717425541594, 5157.638965272433, 5161.81933632322, 5187.533122019017, 5191.221316802482, 4612.1698094343, 4698.953010469886, 4709.9764501177615, 4719.787609557578, 4813.49458306878, 4740.19416699162, 4779.928301075487, 4781.115493633672, 4799.544043315879, 4803.159447096761, 4604.079184163164, 4620.237660785966, 4651.279051746951, 4652.464966528859, 4716.599089077416, 4624.514425985257, 4637.744924029177, 4644.581987621096, 4694.131585656664, 4735.73953432561, 4665.5567721066445, 4668.439787225555, 4683.0, 4688.882777930545, 4728.314394412825, 4962.1812400953795, 5055.140626093573, 5087.135187018216, 5116.334876466036, 5130.050940576006, 5399.595030372699, 5468.179773034037, 5469.042917489423, 5477.3427188737605, 5479.287692599936, 5495.0383682855345, 5500.944990550083, 5510.669359838423, 5515.61390702651, 5573.303337082864, 4995.225740010304, 5082.771275292621, 5146.30524879144, 5157.303763991813, 5210.47895210476, 5708.942910570924, 5713.085906254979, 5713.885722285531, 5726.513246374022, 5727.0, 5471.480209380103, 5473.397926228112, 5479.397266300703, 5482.17767334895, 5488.533474654699, 5343.572514198855, 5417.214503896913, 5462.934727728134, 5475.397706252309, 5560.944390556043, 5470.316210473691, 5487.478689524489, 5490.423505531941, 5491.28613280279, 5499.945000549943, 5492.917606235909, 5501.944980550224, 5515.4760297771645, 5519.668819870821, 5593.74828132735, 4189.141226048653, 4246.087091275329, 4275.828966841354, 4281.165172791276, 4337.436133302714, 3840.7695538267794, 3843.2121415110396, 3845.538535375773, 3878.806059697004, 3880.20455806559, 5216.113260745682, 5230.555402790729, 5251.711155886386, 5275.630705850554, 5315.123004704181, 5354.54486368663, 5430.266913966564, 5488.039593071197, 5510.035743744828, 5595.692236927008, 5239.187925871496, 5243.082460569462, 5244.501772331622, 5251.658642188246, 5261.947380526222, 4768.928466073012, 4780.4741478437345, 4783.545563171493, 4784.091022705675, 4835.468098509161, 5607.52336051432, 5643.971780141155, 5647.0, 5672.829815105636, 5760.510356619734, 5427.511523962862, 5452.482014208644, 5454.945450545602, 5479.0411677957, 5490.862728431821, 5724.914126288026, 5727.656340619576, 5730.455606717355, 5734.0, 5759.424057594207, 5303.893922121459, 5311.760970756248, 5341.572674186134, 5345.4654534546235, 5383.219433182245, 5420.078586640359, 5447.428020057995, 5453.072977593898, 5456.48163424474, 5490.0941344677685, 5364.0, 5373.596980226421, 5373.9731301343245, 5380.946190538045, 5429.049916264717, 5226.8954620908125, 5298.682079075268, 5315.6279060465395, 5347.545458636059, 5349.973250133725, 5334.706591137369, 5340.49265319794, 5341.75962081715, 5343.919841202307, 5368.7852485901685, 5389.461053894579, 5396.21754845553, 5441.7279136043835, 5444.50999410055, 5447.073997420369, 5176.456472070529, 5265.131253343156, 5280.709560974184, 5293.12663410533, 5308.124159513637], "value": 5081.119772774895, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.199194116149, 586.1354502109389, 610.3713175429307, 616.7563812294145, 625.265313256923, 44870.0, 46361.53638463614, 46580.76709616447, 46622.999999999956, 49451.258231126565, 47876.28185577219, 48175.27737083947, 48331.51668483314, 48402.27396589054, 48454.75772621141, 8981.82036359274, 9118.680846170386, 9126.680566180185, 9127.26981841451, 9127.26981841451, 9036.412633178823, 9130.360874738772, 9130.863037054416, 9131.041240669734, 9136.0, 9157.221636160933, 9187.35688501805, 9190.264778817678, 9190.31072669549, 9197.448153110834, 9047.321450891177, 9084.091590840862, 9085.0, 9085.818843550362, 9091.908970923498, 9000.549972501414, 9054.366194366397, 9062.728118156467, 9072.228860546862, 9072.639104134367, 44397.55602443966, 44783.77608111939, 45056.774716126536, 45063.09873802539, 45172.77413612944, 3692.298463291966, 3728.4780130781714, 3738.028112690693, 3814.809259537012, 4355.5208927018, 32889.3422131556, 34779.826100869584, 34952.12619684503, 36056.63943360585, 36190.27619447596, 4457.3091170868565, 4469.508354081048, 4528.411306530163, 4623.214053610895, 4721.929171062402, 361093.0, 362941.11176664743, 364855.0, 365327.0, 366034.1698291518, 62228.688856556335, 62299.377006230265, 62429.0, 62570.37429625737, 62720.372796271455, 47785.0, 64762.0, 66327.33672663308, 66981.66509167521, 67031.0, 16423.507294781175, 16626.25181866819, 16656.58358541022, 16753.91623041877, 16778.161091945352, 11578.073754099652, 11649.0, 11656.358900260397, 11661.300321980709, 11662.94168529169, 17286.13569321529, 19345.51636209106, 19715.605687886164, 19908.402747917586, 19924.402267931986, 7207.171175314801, 7253.782386528413, 7278.672459739324, 7440.20992127952, 7483.4013278937555, 997.8054279415444, 1051.148569658579, 1064.824303989833, 1126.808442564766, 1166.9183157178916, 33141.66858331386, 33716.831415843255, 34092.829535852165, 34117.78211456781, 34435.483467748, 1086.0714089453404, 1097.2483848563759, 1151.83874257604, 1160.3560024186656, 1212.587720175127, 18273.63452730938, 18693.719594206097, 19042.143103560375, 19573.0, 19731.802681973284, 567450.0, 568911.0, 569243.0, 570325.0, 570659.0, 61653.691731541054, 62123.37876621176, 62236.377636223966, 62295.6885215571, 62322.0, 1338.9129706569042, 1384.3908680180689, 1405.4308005257888, 1413.5052731544083, 1415.490423447558, 33545.49681754824, 34813.65186348104, 34853.65146348504, 34958.12604684903, 35326.293474130885, 54371.72814135904, 55221.72389138029, 55225.1716224265, 55304.0, 55336.44663553313, 480410.0, 480713.0, 481695.0, 482347.0, 483692.0, 26043.479130417665, 28587.28531786722, 29608.0, 30143.698563014088, 30501.23746906345, 49782.75108624434, 50426.74786626043, 50483.0, 51327.0, 51487.48512514827, 41387.379189311585, 41491.37762933619, 42727.0, 42803.35794963016, 44353.33469998017, 41041.0, 41321.79339103406, 41325.586744132175, 42825.357619635106, 42860.78569607132, 41830.372544412465, 43551.78224108986, 44591.55408446004, 44765.77617111894, 45892.77053614711, 35487.467687984186, 38429.80785096168, 39214.80392598019, 39243.60756392399, 39691.80154099211, 28985.56521652219, 29224.707752922197, 29642.0, 29664.703352966193, 29668.554971675872], "value": 21052.152026087482, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.33742276171193, 382.10968443526576, 385.8823058967015, 398.07646260675244, 406.5568530301972, 18154.90922545387, 19460.61078778427, 20806.16775328987, 20984.580308393863, 21010.894945525288, 12001.159918805666, 12815.487380504768, 12819.743605127915, 13288.402021909013, 20049.0, 5267.683938963665, 5453.15476101203, 5459.0, 5459.317585301837, 5461.2354270402175, 5383.246345511631, 7168.784936451889, 7514.3237108660205, 7610.467267291292, 7612.162662107164, 7473.215312392202, 7577.090749110114, 7602.087749470072, 7604.771856844303, 7667.34827539657, 7464.320527881183, 7653.464257501977, 7687.231276872324, 7696.114946781108, 7705.845883082335, 7417.443691723142, 7464.664090115958, 7466.4773465857415, 7474.364679002291, 7481.551106933547, 26707.599386009224, 27524.724752752616, 27873.024444144357, 28357.149285521467, 28560.428791424056, 2476.2447453526665, 2489.950200995988, 2583.883725232369, 2777.0141599732005, 2947.7199666031693, 15146.924265378713, 15834.129122898235, 15887.36450541977, 16037.919810400874, 16710.331586736516, 2002.3692536850845, 2127.4149608857533, 2135.508832968426, 2152.5156839711094, 2218.4342992536963, 101344.98655013429, 101949.490252549, 104154.1700597856, 106851.46574267157, 107257.46371268171, 18037.909810451125, 18410.539736506427, 18747.625047498972, 18754.0, 18779.0, 32732.345353092805, 32770.67229327724, 32978.0, 32994.67005329964, 33141.50287745686, 9992.0, 10194.949025254826, 10269.640562580424, 10409.479526023668, 10430.0, 8388.245057944814, 8435.536045517432, 8490.320774338039, 8723.127687231226, 8777.29781617469, 9120.224780893566, 9171.678991235274, 9218.677346292981, 9346.906530934739, 9405.529723513797, 3339.0513424023848, 3457.3258214647904, 3476.28736109097, 3663.2673465307043, 3679.2273622539565, 903.3270213690711, 965.4014511003223, 974.9463779492054, 1010.4644538394663, 1043.2384359417667, 19958.30145944885, 20077.397678069683, 20274.18903243854, 20455.0, 20514.589708205753, 984.178211193647, 996.9102780749768, 1036.6268143468346, 1045.5451878432907, 1048.8793788714243, 10420.895791041992, 10993.670189894316, 10994.395308258123, 11123.555057797597, 11145.944270278758, 434179.0, 435443.0, 437385.0, 439147.0, 459597.0, 92434.0, 92657.0, 92773.53613232025, 93897.53051234837, 94493.0, 973.2019743810008, 987.3138168972639, 988.7330420786491, 996.496769131584, 1000.3247807729754, 17103.48689539316, 17764.91117544456, 17973.640527189644, 18025.909870450563, 18167.545811354823, 42850.57149428466, 43590.346144808485, 44158.55841441544, 44163.55836441723, 44225.11549769051, 56885.0, 57961.0, 61565.0, 65499.672501637186, 67207.66396167988, 6899.965500172467, 8142.5343438179325, 8646.308295336485, 8830.690925817566, 9204.493752843659, 13004.674883127998, 13511.256880871646, 13618.659533511345, 13791.10357826738, 13836.723265534432, 11127.666170014912, 11292.346298619983, 11372.896014237393, 11555.0, 12133.332666703416, 11473.713157170803, 11869.0, 11929.940350298193, 12025.63923082309, 12405.317707526172, 11672.76654466889, 11855.17013809025, 11878.584249551224, 11906.583269585522, 12005.939970300093, 7580.05249343832, 7853.960730196312, 8021.197880211932, 8333.874991875247, 8628.82742345137, 10897.782044359226, 11574.826377604511, 11632.127590430582, 11651.30092194471, 11926.642200733992], "value": 10524.367527745466, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1307.9084464087518, 1422.5732280315904, 1484.9554513364599, 1581.533447632948, 1768.3191971091135, 7697.114831794345, 8110.188981101887, 8129.796755081126, 8319.417640765134, 8361.790955226108, 8195.385346099036, 8317.0, 8319.916800832005, 8320.583970801466, 8322.958385208065, 2312.895919683614, 2336.4742932840145, 2337.181986304788, 2337.345543247893, 2337.8714170720605, 2233.2741858895843, 2248.8425810193294, 2315.617923042696, 2317.606006978809, 2318.316096751454, 2271.943201419961, 2293.3807871874583, 2302.3093072078395, 2303.585354636165, 2305.6772051912662, 2238.3285014495586, 2240.3838944290287, 2254.6392577187653, 2259.141526220034, 2259.9887000564972, 2237.955240895173, 2238.418011317069, 2240.8543444676043, 2241.350008497534, 2242.338510139513, 7976.401769867225, 8316.334693224588, 8363.456375335583, 8369.204925532125, 8374.916250837474, 4845.854624361275, 5080.034793389281, 5099.08216521026, 5099.745012749385, 5110.310108135392, 3070.3073759375916, 3261.608606967179, 3303.5540202072652, 3311.6688331166933, 3319.1204330852343, 1004.2819384140302, 1004.8593196952432, 1023.6468418395716, 1050.8003479338977, 1064.3613831700995, 11121.443927803659, 11167.329960202333, 11246.212765106446, 11252.774944501065, 11263.831042534368, 4153.252414565347, 4243.172581346607, 4351.129774045204, 4387.736735795863, 4404.713693609905, 9006.279497640173, 9043.140901614335, 9049.095090490899, 9050.049744776836, 9055.59249833759, 4904.2643603459055, 4927.926081108714, 4932.53140951609, 4932.876678083005, 4939.827106051271, 4135.0, 4435.467743870691, 4558.49856515783, 4591.517890621503, 4628.3288923105965, 3584.534010578608, 3619.7647152934974, 3709.3323201823932, 3732.701383889282, 3741.9064523386587, 1103.906167975731, 1107.402002918415, 1116.079234631416, 1121.870984836738, 1122.4107343644653, 980.2599037726471, 985.0641890204334, 1005.0452070533023, 1006.094514936563, 1009.3590569987964, 5726.9713651431475, 5823.068309070613, 5831.825045248649, 5855.765769369263, 5859.853503662443, 443.312865059157, 445.6234481862821, 448.0501337165231, 458.1226950389966, 459.4348950790546, 4088.100617864065, 4106.568810274938, 4109.835606575763, 4113.91772164555, 4115.094679170577, 9898.505074746234, 10272.383656980604, 10313.432761198055, 10318.122959548522, 10329.638462653922, 10190.439525826003, 10220.693379198636, 10220.846687299696, 10222.437765922798, 10227.897721022844, 7498.700051997968, 7817.921820781833, 7825.904373387731, 7845.333146682596, 7912.4856884302335, 5990.748992994549, 5997.790077347272, 6028.668423236764, 6087.939120608914, 6131.325554189125, 9498.667546635834, 9526.618935242514, 9538.523073846141, 9546.474943878153, 9625.133737963617, 9234.769130771516, 9640.662576810058, 9681.467519286507, 9736.269779766404, 9741.025897410485, 7544.47188696786, 7575.431842611716, 7600.087989441303, 7651.234876512304, 7668.309852113113, 8120.715774947848, 8179.222973817477, 8183.754487365389, 8186.508809471451, 8188.7952801180445, 7128.429725622042, 7195.928040719526, 7280.635968201463, 7412.888806667796, 7503.137139229058, 7168.899143967492, 7291.197968223597, 7353.6690848912995, 7572.583507907118, 7592.4305677073335, 6435.967820160869, 6548.541602087808, 6568.0, 6571.704273307617, 6574.211094668671, 5002.499750024968, 5141.53726164647, 5187.351581052369, 5206.6095042871175, 5271.288376069335, 5154.072266991828, 5228.633995620422, 5255.0, 5264.184051472028, 5339.546138578109], "value": 4354.547659453755, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.47292730530967, 320.2969481987039, 321.36049261968674, 325.43212094894403, 326.2089433124672, 5194.298769666094, 5232.110541207999, 5242.711650859202, 5250.737463126848, 5256.658317209379, 5167.199084141955, 5182.896342073156, 5184.274201611768, 5199.792008319662, 5200.479952004807, 4026.879193624196, 4158.625723684868, 4162.438070860426, 4164.646489890798, 4170.728902621335, 4122.6395289554375, 4126.0, 4126.793660316987, 4145.419641250227, 4151.418801367811, 4082.2447847148223, 4088.6729061674996, 4091.3249313863175, 4093.7953102344914, 4093.856715014975, 3896.844126234947, 3908.863189788372, 4097.7541347519245, 4099.180163967204, 4116.176764647053, 3574.1779390740016, 3579.731520136, 3582.6417358264225, 3590.9281814363826, 3599.9740074079023, 5050.116229659795, 5053.444121146671, 5062.569681577071, 5077.517635824591, 5114.360704911886, 4401.0, 4406.493253275882, 4618.376519169903, 4635.791389387486, 4641.744704041276, 5360.517553420172, 5369.731513424353, 5369.865753356158, 5389.595780316492, 5400.702961337164, 3917.157811070605, 3917.6865850731874, 3923.117298607819, 3929.9150167118673, 3943.9014024649327, 5481.451854814526, 5548.167774833767, 5581.6930068846195, 5625.918410188216, 5627.240322556443, 4009.558948515661, 4030.355143177136, 4031.7580945143386, 4035.152617950205, 4041.4341992121126, 4050.5341885683524, 4053.2096241232675, 4079.265732168179, 4099.344104943254, 4102.405151253051, 4474.395956545824, 4616.930746038812, 4645.5354464553275, 4646.4888862225125, 4646.628269738413, 5429.348478182565, 5432.619716619878, 5439.048166570834, 5478.58910581708, 5487.560995120461, 1410.5909286307062, 1427.5866891777066, 1430.9125064950713, 1432.7277817214697, 1433.2117335465452, 851.5912362066243, 909.9363044586815, 915.8900931888082, 931.5202670624634, 932.8087742012871, 4683.765811709401, 4708.223143181337, 4716.268978308368, 4717.292406139038, 4720.0175926111115, 4860.562549370574, 4888.26675998596, 4918.139325618003, 4923.90152196954, 4925.694690906913, 4706.858794236178, 4729.69256998294, 4779.259214821708, 4808.61531077513, 5016.347874776256, 2855.914322570326, 2894.2040938742016, 2940.617719696426, 2973.3904549567287, 3008.578798968146, 5824.621399609012, 5854.882902342015, 5871.383504732027, 5884.735186916599, 5891.587588868823, 5536.916946245809, 5671.631343962712, 5708.885822283531, 5713.5714821388565, 5731.083026715789, 5799.2750906136735, 5800.361960184377, 5811.82564523065, 5839.941600583939, 5875.383084776123, 5610.691411972381, 5612.915806262991, 5613.354464236501, 5614.185943038318, 5617.073182924772, 5311.362636483646, 5468.152436372368, 5477.917831232615, 5515.558755299647, 5522.392536821027, 5813.854653633523, 5816.970915145397, 5818.301803783404, 5875.706214689163, 5875.853103672443, 3973.4039894016128, 3978.8806335809973, 3992.540857801274, 3998.940015899822, 4000.7199496035, 5336.653117547347, 5484.177373394023, 5540.806071787468, 5557.805476808292, 5589.8261365113785, 5374.570034397317, 5427.864303392446, 5431.293931788842, 5432.864178395572, 5445.264889239902, 5281.471852814688, 5369.946300537101, 5428.83713488596, 5434.483724046209, 5459.262999495176, 5329.54698850602, 5331.946680533145, 5341.519263266325, 5346.0, 5374.973125134349, 5423.240746295601, 5436.6194366393975, 5459.362191342502, 5469.179623056573, 5475.917861232165, 5090.109230884655, 5301.5010093338215, 5316.096263635114, 5348.866278342917, 5356.5982551308025], "value": 4125.408334979764, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.6435311050695, 749.951253168544, 779.8713212319967, 779.9924484807535, 891.4205766251936, 16031.51905442837, 16919.49241522753, 16921.3231470741, 16961.236744346505, 16961.745573816403, 14883.18142502162, 15508.612284692888, 15570.53288401347, 15577.065376077415, 15584.298706558204, 803.2730379006994, 827.6399766101765, 829.2329595124486, 829.4152622401223, 830.4353039932844, 817.1501638296165, 838.0446291228005, 839.937004724645, 841.5119230846094, 849.0448245723561, 891.2914233184601, 892.2148509311796, 892.5046599137476, 892.8526793079134, 892.9687460938868, 888.8266787976347, 889.1197714262897, 889.1997202517721, 889.5196593839319, 889.884315039044, 651.6546230497844, 651.7979426377791, 652.0349882174361, 652.0642877470844, 652.145689147214, 14279.143251404845, 14358.138511689333, 14380.424783008772, 14457.421703131862, 14523.927380363137, 15433.0, 15454.459093931659, 15515.612109697235, 15548.844511554853, 15564.37742490299, 13035.608931732064, 13255.403506842214, 13268.535601254007, 13445.731085378335, 13535.864641353559, 3854.998578319627, 3920.7843568603716, 3957.9010524736823, 3979.6816254699556, 4003.6396724294664, 64476.35523644798, 76930.23069769287, 87672.56163719205, 89433.0, 92736.53631731866, 10558.260921735558, 10610.41642709643, 10624.096951759033, 10803.189760767973, 11190.66428007161, 21206.893965530384, 21482.0, 21757.67363489549, 21780.564388712137, 21860.45348866259, 8509.531975741394, 8660.696875609323, 8722.651093956298, 8740.475571465733, 8807.295416366675, 4876.926846097312, 4895.094407534618, 4936.605071594264, 5053.36832895888, 5091.032703786269, 3551.1122219445137, 3650.908727281839, 3665.5051568038507, 3670.33933891902, 3671.2473942841652, 588.8586739182565, 591.8402031451484, 597.6862147372577, 616.2943429772974, 618.4557589321369, 692.9445644348541, 695.3533214110926, 785.5012067337168, 788.2354116506979, 796.3271035974592, 10163.0, 10511.864877188107, 10592.364458132537, 10619.734506637396, 10643.893561064291, 666.53009628212, 721.2462976189894, 746.6677328588726, 774.825664225556, 777.9183185765413, 4816.686915350491, 5019.598432125421, 5077.466865979019, 5083.847484575469, 5230.764615592308, 94739.52630236805, 129549.35225324001, 130441.0, 131284.0, 131806.0, 71324.0, 95999.0, 96008.0, 96897.0, 98617.50691246642, 52004.73997630063, 73313.0, 87261.56369218114, 87353.56323218343, 89823.0, 10070.647527336509, 10255.28213025111, 10409.0, 10446.477676116012, 10533.36799792015, 50956.23565646444, 52849.47150528599, 53609.46390536045, 54172.45827541674, 54807.177892332445, 72966.0, 73341.0, 77308.61345693236, 78626.2137378619, 79178.0, 12901.483940642269, 13297.66755831112, 13362.0, 13749.931250344085, 13832.792508112185, 15429.0, 15599.220038997777, 15672.76490852661, 15914.442994495137, 16582.08798516093, 14442.277886105863, 14490.34793434277, 14624.0, 15009.549713508612, 15538.300776464861, 14467.0, 14586.781198282246, 14859.628509287355, 15330.463433779763, 15360.539183824503, 14344.641383965485, 14425.49510767118, 14824.03643763152, 15429.691406172038, 15445.691086178438, 11740.823887641864, 11766.470508826953, 11787.528498860293, 12046.063734736563, 12383.566575169825, 10621.946890265499, 10922.617708380169, 11918.225315354473, 12121.57574484924, 12365.505379784709], "value": 7851.389864506049, "unit": "score"}], "name": "dromaeo_css", "value": 7358.856607725975, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 110.0, 111.0, 111.0, 111.0, 112.0, 110.0, 111.0, 111.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 118.0, 186.0, 123.0, 122.0, 146.0, 116.0, 156.0, 116.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 161.0, 160.0, 160.0, 160.0, 160.0, 161.0, 164.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 108.0, 75.0, 75.0, 74.0, 74.0, 108.0, 74.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 121.0, 84.0, 85.0, 85.0, 120.0, 84.0, 84.0, 137.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 58.0, 50.0, 50.0, 51.0, 51.0, 52.0, 53.0, 51.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 59.0, 61.0, 60.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 75.0, 75.0, 75.0, 75.0, 75.0, 75.0, 75.0, 79.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 131.0, 123.0, 123.0, 124.0, 119.0, 135.0, 123.0, 144.0, 142.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 157.0, 157.0, 157.0, 157.0, 157.0, 166.0, 156.0, 158.0], "value": 157.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 63.0, 62.0, 62.0, 65.0, 62.0, 68.0, 63.0, 61.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1479.0999999999997, "alertThreshold": 2.0}]} 21:55:04 INFO - Return code: 0 21:55:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:55:04 INFO - # TBPL SUCCESS # 21:55:04 INFO - Running post-action listener: _resource_record_post_action 21:55:04 INFO - [mozharness: 2016-08-09 04:55:04.597065Z] Finished run-tests step (success) 21:55:04 INFO - Running post-run listener: _resource_record_post_run 21:55:04 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 554934272; Read time: 0; Write time: 561172 21:55:04 INFO - TinderboxPrint: CPU usage
13.0% 21:55:04 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 21:55:04 INFO - TinderboxPrint: I/O write bytes / time
554,934,272 / 561,172 21:55:04 INFO - TinderboxPrint: CPU idle
8,278.5 (86.9%) 21:55:04 INFO - TinderboxPrint: CPU user
1,196.4 (12.6%) 21:55:04 INFO - TinderboxPrint: Swap in / out
0 / 0 21:55:04 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 260726784; Read time: 0; Write time: 308920 21:55:04 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 294207488; Read time: 0; Write time: 252252 21:55:05 INFO - Running post-run listener: _upload_blobber_files 21:55:05 INFO - Blob upload gear active. 21:55:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:55:05 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 21:55:05 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'] 21:55:05 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 21:55:05 INFO - (blobuploader) - INFO - Open directory for files ... 21:55:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:55:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:55:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:09 INFO - (blobuploader) - INFO - Done attempting. 21:55:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:55:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:55:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:10 INFO - (blobuploader) - INFO - Done attempting. 21:55:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:55:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:55:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:55:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:55:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:55:10 INFO - (blobuploader) - INFO - Done attempting. 21:55:10 INFO - (blobuploader) - INFO - Iteration through files over. 21:55:10 INFO - Return code: 0 21:55:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:55:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:55:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff2f83da6e1b4af6bfaf4e867eb38365f8db45bcb4f30993dcf7e6bc92bb9d9030c68273633fffb7cdb28d3a7b8fc742c7890197785e716feffd83cf8c367bdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f9148cc87c23c3d8312fcfbd4844e12697ae230dba6979f89c70f77a2220ab0b06f319ebdafee63e2ff650ce9481e4648a454c40a7f43fddf7469ba3c53e6c43", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/076ac7e9651acad23a9de33156ee64fedc270306af202eb65f5b5772e402a1309c2b846412c7f2fdb98755de3bf51a9c296ffcf73c0d4960b193f3a9e8eddf7a"} 21:55:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:55:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:55:10 INFO - Contents: 21:55:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff2f83da6e1b4af6bfaf4e867eb38365f8db45bcb4f30993dcf7e6bc92bb9d9030c68273633fffb7cdb28d3a7b8fc742c7890197785e716feffd83cf8c367bdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f9148cc87c23c3d8312fcfbd4844e12697ae230dba6979f89c70f77a2220ab0b06f319ebdafee63e2ff650ce9481e4648a454c40a7f43fddf7469ba3c53e6c43", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/076ac7e9651acad23a9de33156ee64fedc270306af202eb65f5b5772e402a1309c2b846412c7f2fdb98755de3bf51a9c296ffcf73c0d4960b193f3a9e8eddf7a"} 21:55:10 INFO - Running post-run listener: copy_logs_to_upload_dir 21:55:10 INFO - Copying logs to upload dir... 21:55:10 INFO - mkdir: /builds/slave/test/build/upload/logs 21:55:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.665500 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-08-08 21:55:10.709102) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 21:55:10.712507) ========= 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=03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637 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/ff2f83da6e1b4af6bfaf4e867eb38365f8db45bcb4f30993dcf7e6bc92bb9d9030c68273633fffb7cdb28d3a7b8fc742c7890197785e716feffd83cf8c367bdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f9148cc87c23c3d8312fcfbd4844e12697ae230dba6979f89c70f77a2220ab0b06f319ebdafee63e2ff650ce9481e4648a454c40a7f43fddf7469ba3c53e6c43", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/076ac7e9651acad23a9de33156ee64fedc270306af202eb65f5b5772e402a1309c2b846412c7f2fdb98755de3bf51a9c296ffcf73c0d4960b193f3a9e8eddf7a"} build_url:https://queue.taskcluster.net/v1/task/COsqWIY4SraQxvpNLgsaRA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011124 build_url: 'https://queue.taskcluster.net/v1/task/COsqWIY4SraQxvpNLgsaRA/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/ff2f83da6e1b4af6bfaf4e867eb38365f8db45bcb4f30993dcf7e6bc92bb9d9030c68273633fffb7cdb28d3a7b8fc742c7890197785e716feffd83cf8c367bdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f9148cc87c23c3d8312fcfbd4844e12697ae230dba6979f89c70f77a2220ab0b06f319ebdafee63e2ff650ce9481e4648a454c40a7f43fddf7469ba3c53e6c43", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/076ac7e9651acad23a9de33156ee64fedc270306af202eb65f5b5772e402a1309c2b846412c7f2fdb98755de3bf51a9c296ffcf73c0d4960b193f3a9e8eddf7a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 21:55:10.736815) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 21:55:10.737110) ========= 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=03627c79f6bb3d1578c4a402000001ba-1470717023.58200-2019637637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 21:55:10.821811) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 21:55:10.822119) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 21:55:10.822403) ========= ========= Total master_lag: 0.17 =========