builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1470776064.96 results: success (0) buildid: 20160809123615 builduid: b2c9e900e6ac4c65a88b6033e38a9eac revision: e61b48ca0d637b83d2b81cbb9b2f8713338a92fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 13:54:24.957565) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 13:54:24.958143) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 13:54:24.958454) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 13:54:24.976051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 13:54:24.976426) ========= 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=af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-09 13:54:25-- 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% 28.6M=0s 2016-08-09 13:54:25 (28.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.192410 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 13:54:25.185941) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 13:54:25.186291) ========= 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=af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020508 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 13:54:25.237413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 13:54:25.237782) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e61b48ca0d637b83d2b81cbb9b2f8713338a92fb --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 e61b48ca0d637b83d2b81cbb9b2f8713338a92fb --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=af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-09 13:54:25,696 truncating revision to first 12 chars 2016-08-09 13:54:25,697 Setting DEBUG logging. 2016-08-09 13:54:25,697 attempt 1/10 2016-08-09 13:54:25,697 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e61b48ca0d63?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 13:54:27,044 unpacking tar archive at: fx-team-e61b48ca0d63/testing/mozharness/ program finished with exit code 0 elapsedTime=1.692251 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 13:54:26.955379) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 13:54:26.955712) ========= script_repo_revision: e61b48ca0d637b83d2b81cbb9b2f8713338a92fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 13:54:26.956281) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 13:54:26.956565) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 13:54:26.970443) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-09 13:54:26.970921) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:54:27 INFO - MultiFileLogger online at 20160809 13:54:27 in /builds/slave/test 13:54:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 13:54:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:54:27 INFO - {'append_to_log': False, 13:54:27 INFO - 'base_work_dir': '/builds/slave/test', 13:54:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:54:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:54:27 INFO - 'branch': 'Fx-Team-Non-PGO', 13:54:27 INFO - 'buildbot_json_path': 'buildprops.json', 13:54:27 INFO - 'config_files': ('talos/linux_config.py',), 13:54:27 INFO - 'default_actions': ('clobber', 13:54:27 INFO - 'read-buildbot-config', 13:54:27 INFO - 'download-and-extract', 13:54:27 INFO - 'populate-webroot', 13:54:27 INFO - 'create-virtualenv', 13:54:27 INFO - 'install', 13:54:27 INFO - 'run-tests'), 13:54:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:54:27 INFO - 'download_minidump_stackwalk': True, 13:54:27 INFO - 'download_symbols': 'ondemand', 13:54:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:54:27 INFO - 'tooltool.py': '/tools/tooltool.py', 13:54:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:54:27 INFO - '/tools/misc-python/virtualenv.py')}, 13:54:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:54:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:54:27 INFO - 'installer_path': 'installer.exe', 13:54:27 INFO - 'log_level': 'info', 13:54:27 INFO - 'log_name': 'talos', 13:54:27 INFO - 'log_to_console': True, 13:54:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:54:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:54:27 INFO - 'opt_config_files': (), 13:54:27 INFO - 'pip_index': False, 13:54:27 INFO - 'sps_profile': False, 13:54:27 INFO - 'sps_profile_interval': 0, 13:54:27 INFO - 'suite': 'dromaeojs', 13:54:27 INFO - 'system_bits': '32', 13:54:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:54:27 INFO - 'title': 'talos-linux64-ix-020', 13:54:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:54:27 INFO - 'use_talos_json': True, 13:54:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:54:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:54:27 INFO - 'work_dir': 'build'} 13:54:27 INFO - [mozharness: 2016-08-09 20:54:27.510474Z] Running clobber step. 13:54:27 INFO - Running pre-action listener: _resource_record_pre_action 13:54:27 INFO - Running main action method: clobber 13:54:27 INFO - rmtree: /builds/slave/test/build 13:54:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:54:28 INFO - Running post-action listener: _resource_record_post_action 13:54:28 INFO - [mozharness: 2016-08-09 20:54:28.490744Z] Finished clobber step (success) 13:54:28 INFO - [mozharness: 2016-08-09 20:54:28.490845Z] Running read-buildbot-config step. 13:54:28 INFO - Running pre-action listener: _resource_record_pre_action 13:54:28 INFO - Running main action method: read_buildbot_config 13:54:28 INFO - Using buildbot properties: 13:54:28 INFO - { 13:54:28 INFO - "project": "", 13:54:28 INFO - "product": "firefox", 13:54:28 INFO - "script_repo_revision": "production", 13:54:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 13:54:28 INFO - "repository": "", 13:54:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 13:54:28 INFO - "buildid": "20160809123615", 13:54:28 INFO - "pgo_build": "False", 13:54:28 INFO - "basedir": "/builds/slave/test", 13:54:28 INFO - "buildnumber": 2086, 13:54:28 INFO - "slavename": "talos-linux64-ix-020", 13:54:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:54:28 INFO - "platform": "ubuntu64_hw", 13:54:28 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 13:54:28 INFO - "branch": "fx-team", 13:54:28 INFO - "repo_path": "integration/fx-team", 13:54:28 INFO - "revision": "e61b48ca0d637b83d2b81cbb9b2f8713338a92fb", 13:54:28 INFO - "stage_platform": "linux64", 13:54:28 INFO - "builduid": "b2c9e900e6ac4c65a88b6033e38a9eac", 13:54:28 INFO - "slavebuilddir": "test" 13:54:28 INFO - } 13:54:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 13:54:28 INFO - Running post-action listener: _resource_record_post_action 13:54:28 INFO - [mozharness: 2016-08-09 20:54:28.493293Z] Finished read-buildbot-config step (success) 13:54:28 INFO - [mozharness: 2016-08-09 20:54:28.493382Z] Running download-and-extract step. 13:54:28 INFO - Running pre-action listener: _resource_record_pre_action 13:54:28 INFO - Running main action method: download_and_extract 13:54:28 INFO - mkdir: /builds/slave/test/build/tests 13:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:28 INFO - trying https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:54:28 INFO - Downloading https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/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 13:54:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/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 13:54:29 INFO - Downloaded 1361 bytes. 13:54:29 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:54:29 INFO - Using the following test package requirements: 13:54:29 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:54:29 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:54:29 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:54:29 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:29 INFO - u'jsshell-linux-x86_64.zip'], 13:54:29 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:54:29 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:54:29 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:54:29 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:54:29 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:54:29 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:54:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:54:29 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:54: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')]} 13:54:29 INFO - trying https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:54:29 INFO - Downloading https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/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 13:54:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/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 13:54:29 INFO - Downloaded 20259579 bytes. 13:54:29 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'] 13:54:29 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 13:54:31 INFO - Return code: 0 13:54:31 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 13:54:31 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')]} 13:54:31 INFO - trying https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:54:31 INFO - Downloading https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/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 13:54:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/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 13:54:31 INFO - Downloaded 20259579 bytes. 13:54:31 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'] 13:54:31 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 13:54:33 INFO - Return code: 0 13:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:33 INFO - trying https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 13:54:33 INFO - Downloading https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/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 13:54:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/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 13:54:34 INFO - Downloaded 14413723 bytes. 13:54:34 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'] 13:54:34 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 13:54:34 INFO - Return code: 0 13:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:34 INFO - trying https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:54:34 INFO - Downloading https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/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 13:54:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/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 13:54:36 INFO - Downloaded 55612289 bytes. 13:54:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:54:36 INFO - mkdir: /builds/slave/test/properties 13:54:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:54:36 INFO - Writing to file /builds/slave/test/properties/build_url 13:54:36 INFO - Contents: 13:54:36 INFO - build_url:https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:54:36 INFO - Running post-action listener: _resource_record_post_action 13:54:36 INFO - Running post-action listener: set_extra_try_arguments 13:54:36 INFO - [mozharness: 2016-08-09 20:54:36.806253Z] Finished download-and-extract step (success) 13:54:36 INFO - [mozharness: 2016-08-09 20:54:36.806484Z] Running populate-webroot step. 13:54:36 INFO - Running pre-action listener: _resource_record_pre_action 13:54:36 INFO - Running main action method: populate_webroot 13:54:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:54:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:54:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:54:36 INFO - '--tppagecycles', 13:54:36 INFO - '7'], 13:54:36 INFO - 'tests': ['tsvgm']}}, 13:54:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:54:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:54:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:54:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:54:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:54:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:54:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:54:36 INFO - 'talos_options': ['--disable-e10s'], 13:54:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:54:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:54:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:54:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:54:36 INFO - 'talos_options': ['--disable-e10s'], 13:54:36 INFO - 'tests': ['damp', 'tps']}, 13:54:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:54:36 INFO - 'tests': ['damp', 'tps']}, 13:54:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:54:36 INFO - 'tests': ['dromaeo_dom']}, 13:54:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:54:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:54:36 INFO - 'tests': ['basic_compositor_video']}, 13:54:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:54:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:54:36 INFO - 'tests': ['a11yr', 13:54:36 INFO - 'ts_paint', 13:54:36 INFO - 'tpaint', 13:54:36 INFO - 'sessionrestore', 13:54:36 INFO - 'sessionrestore_no_auto_restore', 13:54:36 INFO - 'tabpaint']}, 13:54:36 INFO - 'other-e10s': {'tests': ['a11yr', 13:54:36 INFO - 'ts_paint', 13:54:36 INFO - 'tpaint', 13:54:36 INFO - 'sessionrestore', 13:54:36 INFO - 'sessionrestore_no_auto_restore', 13:54:36 INFO - 'tabpaint']}, 13:54:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:54:36 INFO - 'ts_paint', 13:54:36 INFO - 'tpaint', 13:54:36 INFO - 'sessionrestore', 13:54:36 INFO - 'sessionrestore_no_auto_restore', 13:54:36 INFO - 'tabpaint']}, 13:54:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:54:36 INFO - 'ts_paint', 13:54:36 INFO - 'tpaint', 13:54:36 INFO - 'sessionrestore', 13:54:36 INFO - 'sessionrestore_no_auto_restore', 13:54:36 INFO - 'tabpaint']}, 13:54:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:54:36 INFO - 'tests': ['a11yr', 13:54:36 INFO - 'ts_paint', 13:54:36 INFO - 'tpaint', 13:54:36 INFO - 'sessionrestore', 13:54:36 INFO - 'sessionrestore_no_auto_restore', 13:54:36 INFO - 'tabpaint']}, 13:54:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:54:36 INFO - 'tests': ['a11yr', 13:54:36 INFO - 'ts_paint', 13:54:36 INFO - 'tpaint', 13:54:36 INFO - 'sessionrestore', 13:54:36 INFO - 'sessionrestore_no_auto_restore', 13:54:36 INFO - 'tabpaint']}, 13:54:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:54:36 INFO - 'tests': ['tsvgx', 13:54:36 INFO - 'tsvgr_opacity', 13:54:36 INFO - 'tart', 13:54:36 INFO - 'tscrollx', 13:54:36 INFO - 'cart']}, 13:54:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:54:36 INFO - 'tsvgr_opacity', 13:54:36 INFO - 'tart', 13:54:36 INFO - 'tscrollx', 13:54:36 INFO - 'cart']}, 13:54:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:54:36 INFO - 'talos_options': ['--disable-e10s'], 13:54:36 INFO - 'tests': ['tp5o']}, 13:54:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:54:36 INFO - 'tests': ['tp5o']}, 13:54:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:54:36 INFO - 'talos_options': ['--disable-e10s', 13:54:36 INFO - '--xperf_path', 13:54:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:54:36 INFO - 'tests': ['tp5n']}, 13:54:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:54:36 INFO - 'talos_options': ['--xperf_path', 13:54:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:54:36 INFO - 'tests': ['tp5n']}}, 13:54:36 INFO - 'talos.zip': {'path': '', 13:54:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:54:36 INFO - Running post-action listener: _resource_record_post_action 13:54:36 INFO - [mozharness: 2016-08-09 20:54:36.821677Z] Finished populate-webroot step (success) 13:54:36 INFO - [mozharness: 2016-08-09 20:54:36.821766Z] Running create-virtualenv step. 13:54:36 INFO - Running pre-action listener: _resource_record_pre_action 13:54:36 INFO - Running main action method: create_virtualenv 13:54:36 INFO - Creating virtualenv /builds/slave/test/build/venv 13:54:36 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 13:54:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:54:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:54:36 INFO - Using real prefix '/usr' 13:54:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:54:37 INFO - Installing distribute.............................................................................................................................................................................................done. 13:54:39 INFO - Installing pip.................done. 13:54:39 INFO - Return code: 0 13:54:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:54:39 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')]} 13:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:39 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')]} 13:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:39 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 0xe0e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3b0>, '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 0x10ce2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', '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 13:54:39 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 13:54:39 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 13:54:39 INFO - Using env: {'DISPLAY': ':0', 13:54:39 INFO - 'HOME': '/home/cltbld', 13:54:39 INFO - 'LANG': 'en_US.UTF-8', 13:54:39 INFO - 'LANGUAGE': 'en_US:en', 13:54:39 INFO - 'LOGNAME': 'cltbld', 13:54:39 INFO - 'MAIL': '/var/mail/cltbld', 13:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:39 INFO - 'MOZ_NO_REMOTE': '1', 13:54:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:39 INFO - 'NO_EM_RESTART': '1', 13:54:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:54:39 INFO - 'PWD': '/builds/slave/test', 13:54:39 INFO - 'SHELL': '/bin/bash', 13:54:39 INFO - 'SHLVL': '1', 13:54:39 INFO - 'TERM': 'linux', 13:54:39 INFO - 'TMOUT': '86400', 13:54:39 INFO - 'USER': 'cltbld', 13:54:39 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', 13:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:39 INFO - '_': '/tools/buildbot/bin/python'} 13:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:39 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 13:54:39 INFO - Cleaning up... 13:54:39 INFO - Return code: 0 13:54:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:54:39 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')]} 13:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:39 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')]} 13:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:39 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 0xe0e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3b0>, '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 0x10ce2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', '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 13:54:39 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 13:54:39 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 13:54:39 INFO - Using env: {'DISPLAY': ':0', 13:54:39 INFO - 'HOME': '/home/cltbld', 13:54:39 INFO - 'LANG': 'en_US.UTF-8', 13:54:39 INFO - 'LANGUAGE': 'en_US:en', 13:54:39 INFO - 'LOGNAME': 'cltbld', 13:54:39 INFO - 'MAIL': '/var/mail/cltbld', 13:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:39 INFO - 'MOZ_NO_REMOTE': '1', 13:54:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:39 INFO - 'NO_EM_RESTART': '1', 13:54:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:54:39 INFO - 'PWD': '/builds/slave/test', 13:54:39 INFO - 'SHELL': '/bin/bash', 13:54:39 INFO - 'SHLVL': '1', 13:54:39 INFO - 'TERM': 'linux', 13:54:39 INFO - 'TMOUT': '86400', 13:54:39 INFO - 'USER': 'cltbld', 13:54:39 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', 13:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:39 INFO - '_': '/tools/buildbot/bin/python'} 13:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:39 INFO - Downloading/unpacking psutil>=3.1.1 13:54:39 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 13:54:39 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 13:54:39 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 13:54:39 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 13:54:39 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 13:54:39 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 13:54:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:54:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:54:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:54:41 INFO - Installing collected packages: psutil 13:54:41 INFO - Running setup.py install for psutil 13:54:41 INFO - building 'psutil._psutil_linux' extension 13:54:41 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 13:54:42 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 13:54:42 INFO - building 'psutil._psutil_posix' extension 13:54:42 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 13:54:42 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 13:54:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:54:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:54:42 INFO - Successfully installed psutil 13:54:42 INFO - Cleaning up... 13:54:42 INFO - Return code: 0 13:54:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:54: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')]} 13:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54: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')]} 13:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:42 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 0xe0e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3b0>, '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 0x10ce2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', '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 13:54:42 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 13:54:42 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 13:54:42 INFO - Using env: {'DISPLAY': ':0', 13:54:42 INFO - 'HOME': '/home/cltbld', 13:54:42 INFO - 'LANG': 'en_US.UTF-8', 13:54:42 INFO - 'LANGUAGE': 'en_US:en', 13:54:42 INFO - 'LOGNAME': 'cltbld', 13:54:42 INFO - 'MAIL': '/var/mail/cltbld', 13:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:42 INFO - 'MOZ_NO_REMOTE': '1', 13:54:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:42 INFO - 'NO_EM_RESTART': '1', 13:54:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:54:42 INFO - 'PWD': '/builds/slave/test', 13:54:42 INFO - 'SHELL': '/bin/bash', 13:54:42 INFO - 'SHLVL': '1', 13:54:42 INFO - 'TERM': 'linux', 13:54:42 INFO - 'TMOUT': '86400', 13:54:42 INFO - 'USER': 'cltbld', 13:54:42 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', 13:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:42 INFO - '_': '/tools/buildbot/bin/python'} 13:54:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:54:42 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 13:54:42 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 13:54:42 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 13:54:42 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 13:54:42 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 13:54:42 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 13:54:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:54:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:54:44 INFO - Installing collected packages: mozsystemmonitor 13:54:44 INFO - Running setup.py install for mozsystemmonitor 13:54:44 INFO - Successfully installed mozsystemmonitor 13:54:44 INFO - Cleaning up... 13:54:44 INFO - Return code: 0 13:54:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:54: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')]} 13:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54: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')]} 13:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:44 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 0xe0e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3b0>, '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 0x10ce2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', '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 13:54:44 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 13:54:44 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 13:54:44 INFO - Using env: {'DISPLAY': ':0', 13:54:44 INFO - 'HOME': '/home/cltbld', 13:54:44 INFO - 'LANG': 'en_US.UTF-8', 13:54:44 INFO - 'LANGUAGE': 'en_US:en', 13:54:44 INFO - 'LOGNAME': 'cltbld', 13:54:44 INFO - 'MAIL': '/var/mail/cltbld', 13:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:44 INFO - 'MOZ_NO_REMOTE': '1', 13:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:44 INFO - 'NO_EM_RESTART': '1', 13:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:54:44 INFO - 'PWD': '/builds/slave/test', 13:54:44 INFO - 'SHELL': '/bin/bash', 13:54:44 INFO - 'SHLVL': '1', 13:54:44 INFO - 'TERM': 'linux', 13:54:44 INFO - 'TMOUT': '86400', 13:54:44 INFO - 'USER': 'cltbld', 13:54:44 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', 13:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:44 INFO - '_': '/tools/buildbot/bin/python'} 13:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:44 INFO - Downloading/unpacking jsonschema==2.5.1 13:54:44 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 13:54:44 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 13:54:44 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 13:54:44 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 13:54:44 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 13:54:44 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 13:54:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:54:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:54:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:54:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:54:46 INFO - Downloading functools32-3.2.3-2.tar.gz 13:54:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:54:46 INFO - warning: no files found matching '*.txt' 13:54:46 INFO - no previously-included directories found matching 'build' 13:54:46 INFO - no previously-included directories found matching 'dist' 13:54:46 INFO - no previously-included directories found matching '.git*' 13:54:46 INFO - Installing collected packages: jsonschema, functools32 13:54:47 INFO - Running setup.py install for functools32 13:54:47 INFO - warning: no files found matching '*.txt' 13:54:47 INFO - no previously-included directories found matching 'build' 13:54:47 INFO - no previously-included directories found matching 'dist' 13:54:47 INFO - no previously-included directories found matching '.git*' 13:54:47 INFO - Successfully installed jsonschema functools32 13:54:47 INFO - Cleaning up... 13:54:47 INFO - Return code: 0 13:54:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:54: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')]} 13:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54: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')]} 13:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:47 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 0xe0e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3b0>, '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 0x10ce2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', '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 13:54:47 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 13:54:47 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 13:54:47 INFO - Using env: {'DISPLAY': ':0', 13:54:47 INFO - 'HOME': '/home/cltbld', 13:54:47 INFO - 'LANG': 'en_US.UTF-8', 13:54:47 INFO - 'LANGUAGE': 'en_US:en', 13:54:47 INFO - 'LOGNAME': 'cltbld', 13:54:47 INFO - 'MAIL': '/var/mail/cltbld', 13:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:47 INFO - 'MOZ_NO_REMOTE': '1', 13:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:47 INFO - 'NO_EM_RESTART': '1', 13:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:54:47 INFO - 'PWD': '/builds/slave/test', 13:54:47 INFO - 'SHELL': '/bin/bash', 13:54:47 INFO - 'SHLVL': '1', 13:54:47 INFO - 'TERM': 'linux', 13:54:47 INFO - 'TMOUT': '86400', 13:54:47 INFO - 'USER': 'cltbld', 13:54:47 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', 13:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:47 INFO - '_': '/tools/buildbot/bin/python'} 13:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:54:47 INFO - Cleaning up... 13:54:47 INFO - Return code: 0 13:54:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:54: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')]} 13:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54: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')]} 13:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:47 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 0xe0e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3b0>, '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 0x10ce2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', '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 13:54:47 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 13:54:47 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 13:54:47 INFO - Using env: {'DISPLAY': ':0', 13:54:47 INFO - 'HOME': '/home/cltbld', 13:54:47 INFO - 'LANG': 'en_US.UTF-8', 13:54:47 INFO - 'LANGUAGE': 'en_US:en', 13:54:47 INFO - 'LOGNAME': 'cltbld', 13:54:47 INFO - 'MAIL': '/var/mail/cltbld', 13:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:47 INFO - 'MOZ_NO_REMOTE': '1', 13:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:47 INFO - 'NO_EM_RESTART': '1', 13:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:54:47 INFO - 'PWD': '/builds/slave/test', 13:54:47 INFO - 'SHELL': '/bin/bash', 13:54:47 INFO - 'SHLVL': '1', 13:54:47 INFO - 'TERM': 'linux', 13:54:47 INFO - 'TMOUT': '86400', 13:54:47 INFO - 'USER': 'cltbld', 13:54:47 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', 13:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:47 INFO - '_': '/tools/buildbot/bin/python'} 13:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:47 INFO - Downloading/unpacking blobuploader==1.2.4 13:54:47 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 13:54:47 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 13:54:47 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 13:54:47 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 13:54:47 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 13:54:47 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 13:54:49 INFO - Downloading blobuploader-1.2.4.tar.gz 13:54:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:54:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:54:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:54:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:54:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:54:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:54:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:54:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:54:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:54:50 INFO - Downloading docopt-0.6.1.tar.gz 13:54:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:54:50 INFO - Installing collected packages: blobuploader, requests, docopt 13:54:50 INFO - Running setup.py install for blobuploader 13:54:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:54:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:54:50 INFO - Running setup.py install for requests 13:54:50 INFO - Running setup.py install for docopt 13:54:50 INFO - Successfully installed blobuploader requests docopt 13:54:50 INFO - Cleaning up... 13:54:50 INFO - Return code: 0 13:54:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:50 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 0xe0e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3b0>, '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 0x10ce2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', '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 13:54:50 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 13:54:50 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 13:54:50 INFO - Using env: {'DISPLAY': ':0', 13:54:50 INFO - 'HOME': '/home/cltbld', 13:54:50 INFO - 'LANG': 'en_US.UTF-8', 13:54:50 INFO - 'LANGUAGE': 'en_US:en', 13:54:50 INFO - 'LOGNAME': 'cltbld', 13:54:50 INFO - 'MAIL': '/var/mail/cltbld', 13:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:50 INFO - 'MOZ_NO_REMOTE': '1', 13:54:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:50 INFO - 'NO_EM_RESTART': '1', 13:54:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:54:50 INFO - 'PWD': '/builds/slave/test', 13:54:50 INFO - 'SHELL': '/bin/bash', 13:54:50 INFO - 'SHLVL': '1', 13:54:50 INFO - 'TERM': 'linux', 13:54:50 INFO - 'TMOUT': '86400', 13:54:50 INFO - 'USER': 'cltbld', 13:54:50 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', 13:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:50 INFO - '_': '/tools/buildbot/bin/python'} 13:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:54:51 INFO - Running setup.py (path:/tmp/pip-lN4xVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:54:51 INFO - Running setup.py (path:/tmp/pip-jw2UPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:54:51 INFO - Running setup.py (path:/tmp/pip-n0t4u0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:54:51 INFO - Running setup.py (path:/tmp/pip-kcRrA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:54:51 INFO - Running setup.py (path:/tmp/pip-WK98_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:54:51 INFO - Running setup.py (path:/tmp/pip-xST3RG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:54:51 INFO - Running setup.py (path:/tmp/pip-Nn5gX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:54:51 INFO - Running setup.py (path:/tmp/pip-SUfdUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:54:51 INFO - Running setup.py (path:/tmp/pip-b00h_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:54:51 INFO - Running setup.py (path:/tmp/pip-bLME_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:54:51 INFO - Running setup.py (path:/tmp/pip-ZLzQGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:54:51 INFO - Running setup.py (path:/tmp/pip-Nz2EJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:54:51 INFO - Running setup.py (path:/tmp/pip-gZRLl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:54:52 INFO - Running setup.py (path:/tmp/pip-hLUX5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:54:52 INFO - Running setup.py (path:/tmp/pip-cmBwdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:54:52 INFO - Running setup.py (path:/tmp/pip-94xZaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:54:52 INFO - Running setup.py (path:/tmp/pip-3GK4vU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:54:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:54:52 INFO - Running setup.py install for manifestparser 13:54:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:54:52 INFO - Running setup.py install for mozcrash 13:54:52 INFO - Running setup.py install for mozdebug 13:54:52 INFO - Running setup.py install for mozdevice 13:54:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:54:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:54:52 INFO - Running setup.py install for mozfile 13:54:52 INFO - Running setup.py install for mozhttpd 13:54:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:54:52 INFO - Running setup.py install for mozinfo 13:54:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:54:53 INFO - Running setup.py install for mozInstall 13:54:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:54:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:54:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:54:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:54:53 INFO - Running setup.py install for mozleak 13:54:53 INFO - Running setup.py install for mozlog 13:54:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:54:53 INFO - Running setup.py install for moznetwork 13:54:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:54:53 INFO - Running setup.py install for mozprocess 13:54:53 INFO - Running setup.py install for mozprofile 13:54:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:54:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:54:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:54:53 INFO - Running setup.py install for mozrunner 13:54:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:54:53 INFO - Running setup.py install for mozscreenshot 13:54:53 INFO - Running setup.py install for moztest 13:54:53 INFO - Running setup.py install for mozversion 13:54:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:54:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:54:54 INFO - Cleaning up... 13:54:54 INFO - Return code: 0 13:54:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:54:54 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')]} 13:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:54 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')]} 13:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:54 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 0xe0e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3b0>, '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 0x10ce2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', '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 13:54:54 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 13:54:54 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 13:54:54 INFO - Using env: {'DISPLAY': ':0', 13:54:54 INFO - 'HOME': '/home/cltbld', 13:54:54 INFO - 'LANG': 'en_US.UTF-8', 13:54:54 INFO - 'LANGUAGE': 'en_US:en', 13:54:54 INFO - 'LOGNAME': 'cltbld', 13:54:54 INFO - 'MAIL': '/var/mail/cltbld', 13:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:54 INFO - 'MOZ_NO_REMOTE': '1', 13:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:54 INFO - 'NO_EM_RESTART': '1', 13:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:54:54 INFO - 'PWD': '/builds/slave/test', 13:54:54 INFO - 'SHELL': '/bin/bash', 13:54:54 INFO - 'SHLVL': '1', 13:54:54 INFO - 'TERM': 'linux', 13:54:54 INFO - 'TMOUT': '86400', 13:54:54 INFO - 'USER': 'cltbld', 13:54:54 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', 13:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:54 INFO - '_': '/tools/buildbot/bin/python'} 13:54:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:54:54 INFO - Running setup.py (path:/tmp/pip-5CrIcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:54:54 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)) 13:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:54:54 INFO - Running setup.py (path:/tmp/pip-ZMDOOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:54:54 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)) 13:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:54:54 INFO - Running setup.py (path:/tmp/pip-p9VdCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:54:54 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)) 13:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:54:54 INFO - Running setup.py (path:/tmp/pip-XE3IUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:54:54 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)) 13:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:54:54 INFO - Running setup.py (path:/tmp/pip-Wvs2LM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:54:54 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)) 13:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:54:54 INFO - Running setup.py (path:/tmp/pip-uY7uM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:54:54 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)) 13:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:54:54 INFO - Running setup.py (path:/tmp/pip-yQjZ9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:54:54 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)) 13:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:54:54 INFO - Running setup.py (path:/tmp/pip-dfbLFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:54:54 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)) 13:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:54:54 INFO - Running setup.py (path:/tmp/pip-GVGTxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:54:54 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)) 13:54:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:54:54 INFO - Running setup.py (path:/tmp/pip-Cr4IOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:54:55 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)) 13:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:54:55 INFO - Running setup.py (path:/tmp/pip-q6JnzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:54:55 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)) 13:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:54:55 INFO - Running setup.py (path:/tmp/pip-WX4xjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:54:55 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)) 13:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:54:55 INFO - Running setup.py (path:/tmp/pip-1HXTSI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:54:55 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)) 13:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:54:55 INFO - Running setup.py (path:/tmp/pip-8Ta_cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:54:55 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)) 13:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:54:55 INFO - Running setup.py (path:/tmp/pip-uA_twH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:54:55 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)) 13:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:54:55 INFO - Running setup.py (path:/tmp/pip-paD5ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:54:55 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)) 13:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:54:55 INFO - Running setup.py (path:/tmp/pip-RwOHhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:54:55 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)) 13:54:55 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)) 13:54:55 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)) 13:54:55 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)) 13:54:55 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)) 13:54:55 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)) 13:54:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:54: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 13:54: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 13:54: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 13:54: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 13:54: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 13:54: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 13:54:57 INFO - Downloading blessings-1.6.tar.gz 13:54:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:54:57 INFO - Installing collected packages: blessings 13:54:57 INFO - Running setup.py install for blessings 13:54:57 INFO - Successfully installed blessings 13:54:57 INFO - Cleaning up... 13:54:57 INFO - Return code: 0 13:54:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:54:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:54:58 INFO - Reading from file tmpfile_stdout 13:54:58 INFO - Current package versions: 13:54:58 INFO - argparse == 1.2.1 13:54:58 INFO - blessings == 1.6 13:54:58 INFO - blobuploader == 1.2.4 13:54:58 INFO - docopt == 0.6.1 13:54:58 INFO - functools32 == 3.2.3-2 13:54:58 INFO - jsonschema == 2.5.1 13:54:58 INFO - manifestparser == 1.1 13:54:58 INFO - mozInstall == 1.12 13:54:58 INFO - mozcrash == 0.17 13:54:58 INFO - mozdebug == 0.1 13:54:58 INFO - mozdevice == 0.48 13:54:58 INFO - mozfile == 1.2 13:54:58 INFO - mozhttpd == 0.7 13:54:58 INFO - mozinfo == 0.9 13:54:58 INFO - mozleak == 0.1 13:54:58 INFO - mozlog == 3.3 13:54:58 INFO - moznetwork == 0.27 13:54:58 INFO - mozprocess == 0.23 13:54:58 INFO - mozprofile == 0.28 13:54:58 INFO - mozrunner == 6.12 13:54:58 INFO - mozscreenshot == 0.1 13:54:58 INFO - mozsystemmonitor == 0.3 13:54:58 INFO - moztest == 0.7 13:54:58 INFO - mozversion == 1.4 13:54:58 INFO - psutil == 3.1.1 13:54:58 INFO - requests == 1.2.3 13:54:58 INFO - wsgiref == 0.1.2 13:54:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:54:58 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')]} 13:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:58 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')]} 13:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:58 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 0xe0e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3b0>, '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 0x10ce2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', '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 13:54:58 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 13:54:58 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 13:54:58 INFO - Using env: {'DISPLAY': ':0', 13:54:58 INFO - 'HOME': '/home/cltbld', 13:54:58 INFO - 'LANG': 'en_US.UTF-8', 13:54:58 INFO - 'LANGUAGE': 'en_US:en', 13:54:58 INFO - 'LOGNAME': 'cltbld', 13:54:58 INFO - 'MAIL': '/var/mail/cltbld', 13:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:58 INFO - 'MOZ_NO_REMOTE': '1', 13:54:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:58 INFO - 'NO_EM_RESTART': '1', 13:54:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:54:58 INFO - 'PWD': '/builds/slave/test', 13:54:58 INFO - 'SHELL': '/bin/bash', 13:54:58 INFO - 'SHLVL': '1', 13:54:58 INFO - 'TERM': 'linux', 13:54:58 INFO - 'TMOUT': '86400', 13:54:58 INFO - 'USER': 'cltbld', 13:54:58 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', 13:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:58 INFO - '_': '/tools/buildbot/bin/python'} 13:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:58 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)) 13:54:58 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)) 13:54:58 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)) 13:54:58 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)) 13:54:58 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)) 13:54:58 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)) 13:54:58 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)) 13:54:58 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)) 13:54:58 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)) 13:54:58 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)) 13:54:58 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)) 13:54:58 INFO - Cleaning up... 13:54:58 INFO - Return code: 0 13:54:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:54:58 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')]} 13:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:54:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:58 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')]} 13:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:54:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:54:58 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 0xe0e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3b0>, '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 0x10ce2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce740>, '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': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', '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 13:54:58 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 13:54:58 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 13:54:58 INFO - Using env: {'DISPLAY': ':0', 13:54:58 INFO - 'HOME': '/home/cltbld', 13:54:58 INFO - 'LANG': 'en_US.UTF-8', 13:54:58 INFO - 'LANGUAGE': 'en_US:en', 13:54:58 INFO - 'LOGNAME': 'cltbld', 13:54:58 INFO - 'MAIL': '/var/mail/cltbld', 13:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:54:58 INFO - 'MOZ_NO_REMOTE': '1', 13:54:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:54:58 INFO - 'NO_EM_RESTART': '1', 13:54:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:54:58 INFO - 'PWD': '/builds/slave/test', 13:54:58 INFO - 'SHELL': '/bin/bash', 13:54:58 INFO - 'SHLVL': '1', 13:54:58 INFO - 'TERM': 'linux', 13:54:58 INFO - 'TMOUT': '86400', 13:54:58 INFO - 'USER': 'cltbld', 13:54:58 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', 13:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:54:58 INFO - '_': '/tools/buildbot/bin/python'} 13:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:54:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:54:58 INFO - Cleaning up... 13:54:58 INFO - Return code: 0 13:54:58 INFO - Running post-action listener: _resource_record_post_action 13:54:58 INFO - Running post-action listener: _start_resource_monitoring 13:54:58 INFO - Starting resource monitoring. 13:54:58 INFO - [mozharness: 2016-08-09 20:54:58.486773Z] Finished create-virtualenv step (success) 13:54:58 INFO - [mozharness: 2016-08-09 20:54:58.487211Z] Running install step. 13:54:58 INFO - Running pre-action listener: _resource_record_pre_action 13:54:58 INFO - Running main action method: install 13:54:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:54:58 INFO - Reading from file tmpfile_stdout 13:54:58 INFO - Detecting whether we're running mozinstall >=1.0... 13:54:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:54:58 INFO - Reading from file tmpfile_stdout 13:54:58 INFO - Output received: 13:54:58 INFO - Usage: mozinstall [options] installer 13:54:58 INFO - Options: 13:54:58 INFO - -h, --help show this help message and exit 13:54:58 INFO - -d DEST, --destination=DEST 13:54:58 INFO - Directory to install application into. [default: 13:54:58 INFO - "/builds/slave/test"] 13:54:58 INFO - --app=APP Application being installed. [default: firefox] 13:54:58 INFO - mkdir: /builds/slave/test/build/application 13:54:58 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'] 13:54:58 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 13:55:14 INFO - Reading from file tmpfile_stdout 13:55:14 INFO - Output received: 13:55:14 INFO - /builds/slave/test/build/application/firefox/firefox 13:55:14 INFO - Running post-action listener: _resource_record_post_action 13:55:14 INFO - [mozharness: 2016-08-09 20:55:14.902865Z] Finished install step (success) 13:55:14 INFO - [mozharness: 2016-08-09 20:55:14.903114Z] Running run-tests step. 13:55:14 INFO - Running pre-action listener: _resource_record_pre_action 13:55:14 INFO - Running main action method: run_tests 13:55:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:55:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:55:14 INFO - Python 2.7.3 13:55:14 INFO - Return code: 0 13:55:14 INFO - grabbing minidump binary from tooltool 13:55:14 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')]} 13:55:14 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 0x10cd3b0>, '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 0x10ce2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ce740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:55:14 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 13:55:14 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 13:55:14 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 13:55:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:55:14 INFO - Return code: 0 13:55:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:55:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:55:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:55:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:55:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:55:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 13:55:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 13:55:14 INFO - Using env: {'DISPLAY': ':0', 13:55:14 INFO - 'HOME': '/home/cltbld', 13:55:14 INFO - 'LANG': 'en_US.UTF-8', 13:55:14 INFO - 'LANGUAGE': 'en_US:en', 13:55:14 INFO - 'LOGNAME': 'cltbld', 13:55:14 INFO - 'MAIL': '/var/mail/cltbld', 13:55:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:55:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:55:14 INFO - 'MOZ_NO_REMOTE': '1', 13:55:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:55:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:55:14 INFO - 'NO_EM_RESTART': '1', 13:55:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:55:14 INFO - 'PWD': '/builds/slave/test', 13:55:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:55:14 INFO - 'SHELL': '/bin/bash', 13:55:14 INFO - 'SHLVL': '1', 13:55:14 INFO - 'TERM': 'linux', 13:55:14 INFO - 'TMOUT': '86400', 13:55:14 INFO - 'USER': 'cltbld', 13:55:14 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938', 13:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:55:14 INFO - '_': '/tools/buildbot/bin/python'} 13:55:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 13:55:15 INFO - mozversion application_buildid: 20160809123615 13:55:15 INFO - mozversion application_changeset: e61b48ca0d637b83d2b81cbb9b2f8713338a92fb 13:55:15 INFO - mozversion application_display_name: Nightly 13:55:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:55:15 INFO - mozversion application_name: Firefox 13:55:15 INFO - mozversion application_remotingname: firefox 13:55:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:55:15 INFO - mozversion application_vendor: Mozilla 13:55:15 INFO - mozversion application_version: 51.0a1 13:55:15 INFO - mozversion platform_buildid: 20160809123615 13:55:15 INFO - mozversion platform_changeset: e61b48ca0d637b83d2b81cbb9b2f8713338a92fb 13:55:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:55:15 INFO - mozversion platform_version: 51.0a1 13:55:15 INFO - using testdate: 1470776115 13:55:15 INFO - actual date: 1470776115 13:55:15 INFO - starting webserver on 'localhost:43634' 13:55:15 INFO - SUITE-START | Running 2 tests 13:55:15 INFO - TEST-START | dromaeo_css 13:55:15 INFO - operating with platform_type : linux_ 13:55:15 INFO - Initialising browser for dromaeo_css test... 13:55:15 INFO - TEST-INFO | started process 16062 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEambD_/profile http://localhost:43634/getInfo.html) 13:55:19 INFO - PROCESS | 16062 | __metrics Screen width/height:1600/1200 13:55:19 INFO - PROCESS | 16062 | colorDepth:24 13:55:19 INFO - PROCESS | 16062 | Browser inner width/height: 1024/697 13:55:19 INFO - PROCESS | 16062 | __metrics 13:55:20 INFO - PROCESS | 16062 | 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" 13:55:20 INFO - PROCESS | 16062 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:55:21 INFO - TEST-INFO | 16062: exit 0 13:55:21 INFO - Browser initialized. 13:55:21 INFO - Running cycle 1/1 for dromaeo_css test... 13:55:21 INFO - TEST-INFO | started process 16140 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEambD_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:55:33 INFO - PROCESS | 16140 | RSS: Main: 157298688 13:55:33 INFO - PROCESS | 16140 | 13:56:24 INFO - PROCESS | 16140 | 1470776184584 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] 13:58:37 INFO - PROCESS | 16140 | Cycle 1(1): loaded http://localhost:43634/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43634/tests/dromaeo/cssquery-ext.html) 13:58:38 INFO - PROCESS | 16140 | RSS: Main: 247164928 13:58:38 INFO - PROCESS | 16140 | 14:01:41 INFO - PROCESS | 16140 | Cycle 1(1): loaded http://localhost:43634/tests/dromaeo/cssquery-ext.html (next: http://localhost:43634/tests/dromaeo/cssquery-jquery.html) 14:01:41 INFO - PROCESS | 16140 | RSS: Main: 243871744 14:01:41 INFO - PROCESS | 16140 | 14:04:44 INFO - PROCESS | 16140 | Cycle 1(1): loaded http://localhost:43634/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43634/tests/dromaeo/cssquery-mootools.html) 14:04:44 INFO - PROCESS | 16140 | RSS: Main: 189394944 14:04:44 INFO - PROCESS | 16140 | 14:07:46 INFO - PROCESS | 16140 | Cycle 1(1): loaded http://localhost:43634/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43634/tests/dromaeo/cssquery-prototype.html) 14:07:47 INFO - PROCESS | 16140 | RSS: Main: 189050880 14:07:47 INFO - PROCESS | 16140 | 14:10:50 INFO - PROCESS | 16140 | Cycle 1(1): loaded http://localhost:43634/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43634/tests/dromaeo/cssquery-yui.html) 14:10:51 INFO - PROCESS | 16140 | RSS: Main: 188788736 14:10:51 INFO - PROCESS | 16140 | 14:13:54 INFO - PROCESS | 16140 | Cycle 1(1): loaded http://localhost:43634/tests/dromaeo/cssquery-yui.html (next: http://localhost:43634/tests/dromaeo/cssquery-dojo.html) 14:13:54 INFO - PROCESS | 16140 | RSS: Main: 266182656 14:13:54 INFO - PROCESS | 16140 | 14:13:54 INFO - PROCESS | 16140 | __start_tp_report 14:13:54 INFO - PROCESS | 16140 | _x_x_mozilla_page_load 14:13:54 INFO - PROCESS | 16140 | _x_x_mozilla_page_load_details 14:13:54 INFO - PROCESS | 16140 | |i|pagename|runs| 14:13:54 INFO - PROCESS | 16140 | |0;dojo.html;2616.4767046590687;2623.1737002844106;2652.7479889410506;2671.265402014446;2675.0770984010524;4448.243798554246;4524.34397012433;4685.625149988001;4746;4747.501512341206;4690.319903613982;4748.881277968044;4758.857234282977;4764.595009424194;4806.1589221886115;4315.093830295642;4335.761533115678;4410.051838854645;4460.776961151945;4531.841385551506;4450.287953927388;4473.7986790594505;4487.169873573399;4499.077689073749;4509.301058335963;4218.641415479688;4257.808398622069;4258.659307255443;4313.503947046099;4376.037271800199;4346.217680817452;4354.564543545652;4368.388425620416;4379.540148284416;4427;4397.340398940185;4398;4401.009772801126;4431.534688857688;4437.733735975852;4551.795169217393;4560.247559152735;4788.928166077511;4799.640026997954;4847.030593881238;4919.926201106986;4971.651984361096;4978.6514943953935;4984.501549845023;4988.426330971948;4952.083864485082;4987.077390682735;5000.549950504435;5005.824796132118;5022.096022715909;4629.907401851944;4648.116857797041;4666.510016448292;4692.061587682477;4749.026449577828;5198.090334191501;5237.371515418098;5269.077911365495;5279.736013199325;5285.022270879899;5027.748612569357;5058.241263810458;5060.645754797129;5067.087924173684;5074.720890350993;4854.393200849894;5046.1169295373165;5072.391313042459;5097.46476619957;5154.664946778447;5099;5117.155669314521;5118.564921981673;5123.513266239701;5144.948550514447;5056.974715126475;5057.645964782503;5067.391912970467;5074;5126.5898728101665;4121.443605113332;4286.6999310047995;4289.721168124124;4293.141371725667;4346.782660866944;3667.0832291927018;3688.446732990073;3731.6641502264924;3775.2260786538695;3818.446325282874;4389.736615803062;4391.429114215131;4394.98915249488;4399.032212913218;4441.644668426518;5058.165402708585;5093.796248150106;5101.795928162906;5108.131617625013;5128.076946149654;4212.410262563244;4351.456067991501;4427.712198707138;4428.3800267962515;4496.460424749051;4528.47922488918;4529.547045295444;4540.88647783808;4544.954550454453;4583.633309335245;4817.542333478384;4819.879503012453;4826.58973987215;4826.762962185997;4871;4891.437484689306;5073.11220536412;5147.996140752667;5148.227765835155;5208.088584497622;4875.146849301429;4902.7058376497525;4905;4905.950940490549;4946.258061290835;5078.085944529872;5078.695278283315;5087.771050302671;5088.313077734459;5137.897242055213;4876.536729010738;4938.481459446706;4969.3291405659775;5010.023045506091;5061.367329083864;4894.95105048945;4896.36347274852;4904.92642610354;4912.6561140719805;4950.6039516837845;4900;4906.803727850846;4914.705117692807;4916.287138364845;4980.103581355391;4652.674312798072;4812.542808433193;4848.757562121809;4859.878503037452;4897.314375987436;4954.752262386794;4961.677490963076;4993.325901003318;4997.150484417585;5037.471065538212;4853.781579828987;4870.0746858096845;4876.829310974241;4880.219164933594;4924.507549245047 14:13:54 INFO - PROCESS | 16140 | |1;ext.html;561.7696744334824;567.7870798450581;571.0178492992053;572.490483469712;585.882823435313;29084.272893177655;31702.68297317026;31843;31897.68102318976;39261;36572.81713591428;39915;39956;40013.19973600526;40036.199276014464;7622.390208783298;7754.573498457583;7755.185705500926;7759.1852855450215;7780.649870755829;7414.962925185394;7622.047244094489;7704.306612404883;9709.563069661846;10003.949980250089;10056.547455364525;10123.08892199702;10137.239707022003;10140.695779126638;10143.036411540928;9917.851232231485;9950.502474876228;9962.750931226705;9966.800663986753;9966.850497242547;9743.464109473976;9830.4101753895;9839.45882976436;9842.753931151707;9844.064813842746;37968;38026.23947521034;38211.42682859759;38392.23215535674;38515.61484385149;2978.612780338564;3034.5296479045564;3187.714328313693;3562.4834399012257;3659.4876717259604;28689.713102868915;29453;29918.70081299181;29945.850270748506;30686.386272274653;3276.5576647152566;3296.8351582421024;3300.3234336960863;3328.234506063619;3335.52055993002;245999;263660;266487;266941;268248;31713.207169820478;53755.19367209495;53990.46009539854;53998;54024;32102.19744506406;34078.65921340804;34310;34355.48466773;34367.484487732705;13249;13393.330333483287;13394.062415631008;13394.933025335005;13398.062135650605;10874.184436167161;10894.782104357868;10958.28771129874;10963.177761667906;10988.450577471094;7385.926140738631;7457.813554661177;7465.70137194517;7685.462017658822;7741.651625676858;3049.237690577356;3097.1351499862535;3106.9533956990663;3141.7015383538983;3159.447096758104;856.8971723393232;862;896.394933419939;964.7395203295212;988.683621241196;28016.579751303747;28483.57274640882;28693.28266793347;28729.281767955967;29121.85439072791;906.0803284666069;908.6183802802839;952.8323065026981;1033.0341131042499;1072.8122578548723;14995.925020374829;15185.6203594911;15258.847411525965;15397.615059623598;15414.152221627917;414252;415941;419253;420572;420768;43398.56601434008;48362.5163748358;48918.755406223456;49406.25890611644;49440.752796235785;1169.3977601535387;1187.928724276546;1190.7558950415143;1194.42070595761;1198.80219763738;26399.34001649974;27165.59251611267;27630.5855412173;28242.576361355008;28407.857960710066;42950.35574466448;46263.768681156376;47728.761356193;47828;53378;367670.90961812495;367842;372033;407676;420679;37474;37770.43344349782;37793.81103094467;37795.62204378031;38243;39182.2163556733;39207.41188882112;39240.6075939237;39581;40212.1957560853;36228.456573151954;36320;36593.634063659025;36956;36959.07602309964;35378.46932296069;36417.453738194476;36864.44703329399;37101.628983709816;39067.609323907534;35491.29017419689;35916;36203.456948146326;36379.27241455103;36941.815290923376;30726.385472290876;32863.507047394785;32982.835085825376;33021.17447063843;33146;24900.252992410256;25269.494610108064;25293.241202763948;25877.353066173495;25878.482430351665 14:13:54 INFO - PROCESS | 16140 | |2;jquery.html;342.4776866826955;365.1218818740927;371.233403022758;371.4391269183532;392.64269514741574;12779.616611501659;15878.444254451097;16339.999999999985;16801.32794688211;17880.46358609244;16359.754603680925;16652.83347166531;17242.913785431087;17388.913055434707;17501.299948002095;4910.8035678573;4955.355803745508;5133.794648214067;5142.07442660321;5161.329027226455;3612.349777040132;4999.175136102539;5052.772625231855;5687.573431992617;6006.189164462807;6050.909236361458;6054.485368743662;6059.636421814683;6059.636421814683;6061.45446909778;5871.29544454666;5992.898415377769;5997.700114994276;6009.308929473123;6020.909686354708;5124.743762811844;5311.654742441768;5314.601404894648;5319.20211968204;5323.574114070865;20605.690914636292;20606.381808545768;20776.896115519325;21198.470038249012;21200.893995529925;1976.6540855350256;2021.6259991901545;2155.461134716321;2221.2447767758877;2429.1983645397154;6309.558330916838;6698.698558564876;12957.546485873043;13308.467661293536;13526.526571570046;1637.7297745871917;1748.2395158106265;1756.8418842304254;1764.3119183518438;1793.6681713882974;69617.65191174063;70868;72498;73500.6324968377;74088.25911740867;9710.854337184948;9919.206463482904;9961.203103751683;10211.591536338612;10288.537015834305;13676.863231367757;13744.862551374557;13746;13751.174929504261;13759.38082786277;7314.817129571697;7400.518966267283;7516.060492438445;7637.274458926393;7637.923620763721;7098.36114749675;7149.463790215755;7219.0976127984;7336.33972942427;7336.889946650805;5991.340952495222;6033.276006879202;6056.545759068087;6114.847128821815;6285.371462853678;1730.5068055604092;1752.2377765671974;1767.293082766878;1773.4059090204669;1794.4437224460198;848.3637272045966;855.1243051495793;879.5953861223909;898.1602201941206;998.201438848918;16224.513264602081;16952.321907123576;17350.652986940444;17746.29014839392;19117.426477205707;820.2569539728078;831.650706703174;862.2455351567379;875.4572165257581;889.6930558957149;9377.906220937703;9469.448584202682;9646.710598682052;9814.46020468881;9892.60429582823;409058;418032;422028;422919;424323;77927;79423;82608.58695706484;82707.58646206731;83461;947.725159703692;955.7658373698488;963.8506031565119;965.6764983730529;968.1915600473683;15274.618134546725;15282.694346113238;15577.610559736097;15760.211989400714;16154.757678634594;38835.834924952294;39037.609623903394;39234.411483828335;39766;40089.39865902072;54438.45561544334;54861.45138548723;55003;55070;56512.71743641255;6603.20761508622;6665.800025999228;6855.4172895304455;7059.082319298664;7664.271894170045;9326.766830829283;11250.943745281222;11322.94338528302;11665.650030499099;11723.824142637697;8910.465372077697;9158.862617060882;9320.72037838866;9456.716298511055;9489.620415183315;4632.328312394617;7028.121484814398;9490.667826626035;9880.20958323318;10297.897021029994;4994.6503744738975;5056.089903817348;8864.069272726529;9548.61805527799;9586.856197156909;6637.668116594247;6688.230853451915;6690.297518760654;6799.6600169990315;6944.687489062903;7430;8902.109789021046;9271.953640231755;9314.022027687266;9495.43027418357 14:13:54 INFO - PROCESS | 16140 | |3;mootools.html;1248.968775780606;1349.2376807103985;1417.0930604413174;1476.8795061777641;1679.4877562343488;6127.234095738033;7025.437964962804;7238.7828365149;7239.67421466034;7376.668049937753;7229.09636295463;7274.345308922196;7284.7814565562985;7298.562086274814;7300.452466065053;2166.6533354663256;2189.3760278320683;2191.605511008018;2196.4618668426256;2196.8352373571965;2144.142343062772;2171.7176767020264;2174.8042676159143;2178.891055447229;2178.9564208715815;2116.693079503471;2142.06820033286;2142.3358758784825;2145.281330754199;2149.7312835895514;2092.3722883135074;2101.0440249686358;2101.495641046153;2101.7162683037745;2102.211670623516;2061.391889392618;2107.947301317464;2108.8207502362316;2110.356341315898;2113.144176608476;7204.423646108299;7204.639768011579;7268.200497945275;7278.126624805004;7388.9261107388775;4140.503139623264;4287.91424171518;4291.871243862689;4306.5262821089655;4314.697971142022;2662.3743420296214;2743.2867454461784;2797.5663772115354;2799.776017918582;2807.410443806803;868.2619773192736;875.3587024329382;878.3544095090103;918.8300164469528;927.2535608834885;9600.711978640651;9706.466144362057;9719.416834989923;9732.41605503665;9735.367201131903;3662.2675464906592;3837.5394952605866;3999.34010888206;4005.4192142139227;4042.211768705133;7842.647080881374;7842.725504607425;7845.607719613997;7848.607569621496;7850.175731548219;4301.462317210348;4308.224519586442;4311.935320970188;4313.115811258747;4322.135572885435;3372.9831350843087;3824.808759562011;3969.2458432897656;3973.980130099331;3996.2806694795217;3197.4811964316764;3203.727683146912;3307.7188438982957;3318.983405082959;3346.1969127409247;1060.9045185933303;1064.5369264370024;1065.7495488560182;1069.3476979042778;1071.1698433713777;707.6037419045248;755.2749360613763;762.9580373079534;796.2952786783623;815.8409110223569;4502.414686090788;4810.687305325143;4868.805247790048;5183.429822719498;5284.04887120322;858.6050416808213;916.2349438219162;916.8716379706847;919.4161707315902;924.2328867040341;3252.349530093991;3395.7962522248745;3403;3518.2611651552947;3610.9638903611153;8700.34747393948;9015.27877769777;9035.096490351043;9046.14061664154;9049.004609492951;9068.22920051803;9075.2286055686;9080.909190908007;9081.45511269326;9087.454752714859;6567.704453299613;6847.554908930804;6853.211880633691;7017.61403122823;7142.535735177197;5241.633085683966;5321.255024296524;5336.119540275966;5362.249285100167;5373.194020896896;8327.37544684139;8339;8370.53962032094;8410.411271210956;8460.450070745383;8317.168283171635;8468.322534197372;8528.91471085306;8531.658733650584;8577.442466239923;5668.404817494104;6316.431521163117;6408.743650254124;6410;6417.775377861939;5791.681457519877;6875.48433867452;6880;7012.474064445085;7015;6241.500679945502;6292.559520833498;6343.9682801585695;6352.491800655844;6363.268224154282;6130.141780150871;6183.412575805291;6192.195014648247;6372.776952806629;6484.481241500763;5726.4273572642405;5799.710014499174;5842.415758424124;5847.356790753099;5854.824355269348;4416.867493975186;4436.112777444459;4455.532169122325;4533.931991020071;4545.863624091283;4402.6697997650945;4482.977585112054;4489.73061616304;4489.91020179588;4591.862244132682 14:13:54 INFO - PROCESS | 16140 | |4;prototype.html;300.64974304934753;301.95523488729;308.3416904908022;309.14983794564955;311.4098782806583;4830.42034955805;4832.251001094832;4843.304843304846;4858.927116093257;4866.858582223828;4785.162596545608;4787.186178349681;4795.23276275796;4799.928001079987;4804.207305794548;3654.835532401048;3711.4061750119986;3750.5124333836698;3777.5655799583124;3849.191669749342;3829.272438236726;3835.2137811748526;3839.4816699745456;3851.1719980204252;3857.4406711026886;3812.332841752696;3818.9045273868096;3819.178876541543;3820.465134881119;3836.405357169643;3606.981965090184;3708.221273532548;3801.1827457096856;3809.7046055162364;3812.4090765931323;3390.627031026585;3392.3384939936723;3403.2172600301824;3404.5233667286598;3406.3357645259184;4704.247320428715;4719.646026547988;4719.787609557578;4722.362481065046;4726.71639701619;4176.770277634729;4317.589828966243;4341.719192838121;4359;4364.498082720496;4981.750912454363;5005.449400565934;5009.2486127080865;5013.222950442687;5033.6224783141415;3680.1167719747336;3712.814359282025;3718.2749363874054;3728.067983004249;3730.2539492101687;5096.261042148868;5210.947890521084;5263.578913686934;5271.630985830993;5307.177387504943;3695;3704.5737391104617;3706.3513885070006;3714.53568303962;3716.1452865841006;3759.3609086455367;3764.8117594120185;3766.472693822867;3766.9058273542832;3774.50931378919;4152.584741525884;4272.316429371348;4280.357946308079;4283.271843786501;4285.250081235771;4957.3307603473795;4977.228529577921;4992.650514464025;5023.422306434733;5041.294218809369;1282.6916545123922;1299.226959958823;1300.8178854960313;1304.6086174147908;1305.575687901436;834.6619619054293;836.7949852286229;849.6176720475687;850.6980022092192;862.7239283429242;4421.668374871898;4443.00032492693;4462.821487140543;4481.2381895077915;4486.282194848808;5147.742612869416;5153.7165455900285;5153.742312884341;5153.984918822456;5158.613104017214;4252.576031661984;4476.574725401082;4481.887952801206;4483.125790470892;4489.349044388546;2693.811433199657;2704.756571908538;2735.712750161244;2738.657667791526;2741.629879966219;4877.853744352474;4890.364252647133;4893.681910675795;4895.412550493964;4898.387701537308;5012.573931215888;5222.683595916545;5242.76407561653;5272.6309158358545;5273.868153296122;4863.9513604864915;4872.512748725099;4880.682755620945;4884.1941079722155;4895.038501706487;5083.186690129562;5111.744412779421;5127.384873764752;5129.743512824419;5137.460566640449;4826.903461930671;5034.766482211881;5039.001793932604;5051.722155281494;5107.157319042316;4960.131976903956;4968.447559994621;4979.477154898828;4995.175795993766;4995.8001679932395;3649.689776368932;3651.689606383487;3670.4127339625534;3672.320620685182;3673.4673472346894;5102.158143906214;5213.843584692465;5238.4237733850005;5239.056969745482;5250.89498210026;5058.671186372874;5067.797288108434;5074.31496747949;5077.517635824738;5084.771185296597;5008.048470790538;5065.56942659878;5072.137736584716;5089.745512724275;5091.287219789307;4891.217405215149;4967.652264341606;5006.899862002812;5019.544332143783;5029.295898574275;4847.418309802846;4940.209566469348;5063.367079115111;5089.9745501272255;5090.694558326512;4957.3059771632725;4982.576480999156;4983.775730092227;4985.5762260208285;5009.824656137018 14:13:54 INFO - PROCESS | 16140 | |5;yui.html;659.6503852957933;702.8559145375199;715.7530651925084;719.4532155561772;740.167311774254;13901.165930044192;14521.854781452183;14536.41854325827;14538.636534086652;14558.126512409262;13813.171209727423;13945.163290202596;13967.371468283925;14005.159690418557;14014.859851401483;632.2665707778978;751.3163021650299;766.4366690482491;788.3929374381722;793.5000949401898;785.8271180340316;788.538704857659;788.7594283743456;788.8895554622358;790.3203245209115;833.1543483364389;833.2750507058868;833.7707130539089;834.4784509681449;834.5993922917004;655.2431941108005;675.2976904019813;678.372505432478;678.5521555773215;829.3738227638155;590.3948452835834;608.3399511529996;612.2499937576478;612.8008397270905;612.9938700612981;12731.490740370375;12738.74522509554;12745.17156384832;12751.171173873669;12772.105952583323;12104.757904841854;12406.875931240753;12465.813012804816;12848.293343866084;13000.674983125404;11342.659720208407;11474.139439541985;11623.88376116245;11703.648890533297;11947.820782688266;4076.1032572834224;4107.404426358191;4159.9376009359585;4278.893027674302;4279.957200428018;66184.00723989143;66253;69503;70019.64990175067;71547;9940.155086817702;10409.42748148859;10531.947340263403;10568.418736969386;10809.67570972872;17218.05300708448;17711.645767084585;17740;17750.91124544369;17784.555386115193;6761.763338283235;7352.411807055422;7414.814629634302;7457.32884040439;7484.850302994018;3688.9262214755554;3746.119661879456;3806.4861243731743;3921.2941670499586;3954.4859168308512;2683.8389696618265;2747.5741260104714;2757.0763794129193;2759.8344099354103;2759.931001724973;478.8324086569673;479.56599277653777;487.50761730652295;490.7399078488335;494.8169177404383;465.4554171619214;501.7140230068899;513.8339920948616;524.685188886665;543.8286939614009;7144.821379465451;7451.180370159278;7650.770476885591;7676.731314404081;7713.614319284014;427.1201325269954;440.7641911577291;451.58454222115734;500.49450055444265;507.27206458731837;3507.877224297137;3638.3632864248652;3807.162424266657;4498.280275155959;4734.692245004064;59515;101502;103754.96245037604;105698.47150764197;110546;91146.54426727824;94208;94491.44068474506;94699;95504;81391;81658.05906497895;82674.58662706648;83666.74499882506;85963.14036859552;8368.958155209428;9017.724631090885;9017.909820901707;9023.142801433853;9120.589573469077;30241.395172096876;31374.52938205883;33219.66780332166;38947;40431.3935290965;39449.21101577895;47440.7627961858;50801;56975.715121424124;63381.683091584244;11550.826737598774;11747.177697561088;11805.468753906267;11979.640610781691;12283.140180187658;12900.09699321076;12929.870701292866;12939.223646581235;13233.206007639572;13957;11400.828987565028;11440.82838757436;11699.824502632297;12234.204776689487;12239.143259972072;11354.659360219206;12399.442025108712;12548.623541293775;13380.93309533485;13445.394957226752;11531;12068.517259309529;12185.51257949672;12787.017608564343;12856.421461034462;10777.245592808427;10863.185261105291;10973;11017.504212310625;11125.17559927146;9963.352382095141;10068.77304893862;10085.142762865238;10151.543180556744;10170.148675047252 14:13:54 INFO - PROCESS | 16140 | __end_tp_report 14:13:54 INFO - PROCESS | 16140 | __start_cc_report 14:13:54 INFO - PROCESS | 16140 | _x_x_mozilla_cycle_collect,1007 14:13:54 INFO - PROCESS | 16140 | __end_cc_report 14:13:54 INFO - PROCESS | 16140 | __startTimestamp1470777234970__endTimestamp 14:13:54 INFO - PROCESS | 16140 | 14:13:54 INFO - PROCESS | 16140 | ------- Summary: start ------- 14:13:54 INFO - PROCESS | 16140 | Number of tests: 6 14:13:54 INFO - PROCESS | 16140 | 14:13:54 INFO - PROCESS | 16140 | [#0] dojo.html Cycles:165 Average:4689.52 Median:4853.78 stddev:493.84 (10.2%) stddev-sans-first:467.81 14:13:54 INFO - PROCESS | 16140 | Values: 2616.5 2623.2 2652.7 2671.3 2675.1 4448.2 4524.3 4685.6 4746.0 4747.5 4690.3 4748.9 4758.9 4764.6 4806.2 4315.1 4335.8 4410.1 4460.8 4531.8 4450.3 4473.8 4487.2 4499.1 4509.3 4218.6 4257.8 4258.7 4313.5 4376.0 4346.2 4354.6 4368.4 4379.5 4427.0 4397.3 4398.0 4401.0 4431.5 4437.7 4551.8 4560.2 4788.9 4799.6 4847.0 4919.9 4971.7 4978.7 4984.5 4988.4 4952.1 4987.1 5000.5 5005.8 5022.1 4629.9 4648.1 4666.5 4692.1 4749.0 5198.1 5237.4 5269.1 5279.7 5285.0 5027.7 5058.2 5060.6 5067.1 5074.7 4854.4 5046.1 5072.4 5097.5 5154.7 5099.0 5117.2 5118.6 5123.5 5144.9 5057.0 5057.6 5067.4 5074.0 5126.6 4121.4 4286.7 4289.7 4293.1 4346.8 3667.1 3688.4 3731.7 3775.2 3818.4 4389.7 4391.4 4395.0 4399.0 4441.6 5058.2 5093.8 5101.8 5108.1 5128.1 4212.4 4351.5 4427.7 4428.4 4496.5 4528.5 4529.5 4540.9 4545.0 4583.6 4817.5 4819.9 4826.6 4826.8 4871.0 4891.4 5073.1 5148.0 5148.2 5208.1 4875.1 4902.7 4905.0 4906.0 4946.3 5078.1 5078.7 5087.8 5088.3 5137.9 4876.5 4938.5 4969.3 5010.0 5061.4 4895.0 4896.4 4904.9 4912.7 4950.6 4900.0 4906.8 4914.7 4916.3 4980.1 4652.7 4812.5 4848.8 4859.9 4897.3 4954.8 4961.7 4993.3 4997.2 5037.5 4853.8 4870.1 4876.8 4880.2 4924.5 14:13:54 INFO - PROCESS | 16140 | 14:13:54 INFO - PROCESS | 16140 | [#1] ext.html Cycles:180 Average:49841.64 Median:20116.15 stddev:95904.66 (476.8%) stddev-sans-first:96102.33 14:13:54 INFO - PROCESS | 16140 | Values: 561.8 567.8 571.0 572.5 585.9 29084.3 31702.7 31843.0 31897.7 39261.0 36572.8 39915.0 39956.0 40013.2 40036.2 7622.4 7754.6 7755.2 7759.2 7780.6 7415.0 7622.0 7704.3 9709.6 10003.9 10056.5 10123.1 10137.2 10140.7 10143.0 9917.9 9950.5 9962.8 9966.8 9966.9 9743.5 9830.4 9839.5 9842.8 9844.1 37968.0 38026.2 38211.4 38392.2 38515.6 2978.6 3034.5 3187.7 3562.5 3659.5 28689.7 29453.0 29918.7 29945.9 30686.4 3276.6 3296.8 3300.3 3328.2 3335.5 245999.0 263660.0 266487.0 266941.0 268248.0 31713.2 53755.2 53990.5 53998.0 54024.0 32102.2 34078.7 34310.0 34355.5 34367.5 13249.0 13393.3 13394.1 13394.9 13398.1 10874.2 10894.8 10958.3 10963.2 10988.5 7385.9 7457.8 7465.7 7685.5 7741.7 3049.2 3097.1 3107.0 3141.7 3159.4 856.9 862.0 896.4 964.7 988.7 28016.6 28483.6 28693.3 28729.3 29121.9 906.1 908.6 952.8 1033.0 1072.8 14995.9 15185.6 15258.8 15397.6 15414.2 414252.0 415941.0 419253.0 420572.0 420768.0 43398.6 48362.5 48918.8 49406.3 49440.8 1169.4 1187.9 1190.8 1194.4 1198.8 26399.3 27165.6 27630.6 28242.6 28407.9 42950.4 46263.8 47728.8 47828.0 53378.0 367670.9 367842.0 372033.0 407676.0 420679.0 37474.0 37770.4 37793.8 37795.6 38243.0 39182.2 39207.4 39240.6 39581.0 40212.2 36228.5 36320.0 36593.6 36956.0 36959.1 35378.5 36417.5 36864.4 37101.6 39067.6 35491.3 35916.0 36203.5 36379.3 36941.8 30726.4 32863.5 32982.8 33021.2 33146.0 24900.3 25269.5 25293.2 25877.4 25878.5 14:13:54 INFO - PROCESS | 16140 | 14:13:54 INFO - PROCESS | 16140 | [#2] jquery.html Cycles:180 Average:25385.84 Median:31100.15 stddev:69292.01 (222.8%) stddev-sans-first:69460.88 14:13:54 INFO - PROCESS | 16140 | Values: 342.5 365.1 371.2 371.4 392.6 12779.6 15878.4 16340.0 16801.3 17880.5 16359.8 16652.8 17242.9 17388.9 17501.3 4910.8 4955.4 5133.8 5142.1 5161.3 3612.3 4999.2 5052.8 5687.6 6006.2 6050.9 6054.5 6059.6 6059.6 6061.5 5871.3 5992.9 5997.7 6009.3 6020.9 5124.7 5311.7 5314.6 5319.2 5323.6 20605.7 20606.4 20776.9 21198.5 21200.9 1976.7 2021.6 2155.5 2221.2 2429.2 6309.6 6698.7 12957.5 13308.5 13526.5 1637.7 1748.2 1756.8 1764.3 1793.7 69617.7 70868.0 72498.0 73500.6 74088.3 9710.9 9919.2 9961.2 10211.6 10288.5 13676.9 13744.9 13746.0 13751.2 13759.4 7314.8 7400.5 7516.1 7637.3 7637.9 7098.4 7149.5 7219.1 7336.3 7336.9 5991.3 6033.3 6056.5 6114.8 6285.4 1730.5 1752.2 1767.3 1773.4 1794.4 848.4 855.1 879.6 898.2 998.2 16224.5 16952.3 17350.7 17746.3 19117.4 820.3 831.7 862.2 875.5 889.7 9377.9 9469.4 9646.7 9814.5 9892.6 409058.0 418032.0 422028.0 422919.0 424323.0 77927.0 79423.0 82608.6 82707.6 83461.0 947.7 955.8 963.9 965.7 968.2 15274.6 15282.7 15577.6 15760.2 16154.8 38835.8 39037.6 39234.4 39766.0 40089.4 54438.5 54861.5 55003.0 55070.0 56512.7 6603.2 6665.8 6855.4 7059.1 7664.3 9326.8 11250.9 11322.9 11665.7 11723.8 8910.5 9158.9 9320.7 9456.7 9489.6 4632.3 7028.1 9490.7 9880.2 10297.9 4994.7 5056.1 8864.1 9548.6 9586.9 6637.7 6688.2 6690.3 6799.7 6944.7 7430.0 8902.1 9272.0 9314.0 9495.4 14:13:54 INFO - PROCESS | 16140 | 14:13:54 INFO - PROCESS | 16140 | [#3] mootools.html Cycles:180 Average:4806.63 Median:5697.42 stddev:2628.30 (46.1%) stddev-sans-first:2622.07 14:13:54 INFO - PROCESS | 16140 | Values: 1249.0 1349.2 1417.1 1476.9 1679.5 6127.2 7025.4 7238.8 7239.7 7376.7 7229.1 7274.3 7284.8 7298.6 7300.5 2166.7 2189.4 2191.6 2196.5 2196.8 2144.1 2171.7 2174.8 2178.9 2179.0 2116.7 2142.1 2142.3 2145.3 2149.7 2092.4 2101.0 2101.5 2101.7 2102.2 2061.4 2107.9 2108.8 2110.4 2113.1 7204.4 7204.6 7268.2 7278.1 7388.9 4140.5 4287.9 4291.9 4306.5 4314.7 2662.4 2743.3 2797.6 2799.8 2807.4 868.3 875.4 878.4 918.8 927.3 9600.7 9706.5 9719.4 9732.4 9735.4 3662.3 3837.5 3999.3 4005.4 4042.2 7842.6 7842.7 7845.6 7848.6 7850.2 4301.5 4308.2 4311.9 4313.1 4322.1 3373.0 3824.8 3969.2 3974.0 3996.3 3197.5 3203.7 3307.7 3319.0 3346.2 1060.9 1064.5 1065.7 1069.3 1071.2 707.6 755.3 763.0 796.3 815.8 4502.4 4810.7 4868.8 5183.4 5284.0 858.6 916.2 916.9 919.4 924.2 3252.3 3395.8 3403.0 3518.3 3611.0 8700.3 9015.3 9035.1 9046.1 9049.0 9068.2 9075.2 9080.9 9081.5 9087.5 6567.7 6847.6 6853.2 7017.6 7142.5 5241.6 5321.3 5336.1 5362.2 5373.2 8327.4 8339.0 8370.5 8410.4 8460.5 8317.2 8468.3 8528.9 8531.7 8577.4 5668.4 6316.4 6408.7 6410.0 6417.8 5791.7 6875.5 6880.0 7012.5 7015.0 6241.5 6292.6 6344.0 6352.5 6363.3 6130.1 6183.4 6192.2 6372.8 6484.5 5726.4 5799.7 5842.4 5847.4 5854.8 4416.9 4436.1 4455.5 4533.9 4545.9 4402.7 4483.0 4489.7 4489.9 4591.9 14:13:54 INFO - PROCESS | 16140 | 14:13:54 INFO - PROCESS | 16140 | [#4] prototype.html Cycles:180 Average:4200.07 Median:4828.66 stddev:1208.15 (25.0%) stddev-sans-first:1175.56 14:13:54 INFO - PROCESS | 16140 | Values: 300.6 302.0 308.3 309.1 311.4 4830.4 4832.3 4843.3 4858.9 4866.9 4785.2 4787.2 4795.2 4799.9 4804.2 3654.8 3711.4 3750.5 3777.6 3849.2 3829.3 3835.2 3839.5 3851.2 3857.4 3812.3 3818.9 3819.2 3820.5 3836.4 3607.0 3708.2 3801.2 3809.7 3812.4 3390.6 3392.3 3403.2 3404.5 3406.3 4704.2 4719.6 4719.8 4722.4 4726.7 4176.8 4317.6 4341.7 4359.0 4364.5 4981.8 5005.4 5009.2 5013.2 5033.6 3680.1 3712.8 3718.3 3728.1 3730.3 5096.3 5210.9 5263.6 5271.6 5307.2 3695.0 3704.6 3706.4 3714.5 3716.1 3759.4 3764.8 3766.5 3766.9 3774.5 4152.6 4272.3 4280.4 4283.3 4285.3 4957.3 4977.2 4992.7 5023.4 5041.3 1282.7 1299.2 1300.8 1304.6 1305.6 834.7 836.8 849.6 850.7 862.7 4421.7 4443.0 4462.8 4481.2 4486.3 5147.7 5153.7 5153.7 5154.0 5158.6 4252.6 4476.6 4481.9 4483.1 4489.3 2693.8 2704.8 2735.7 2738.7 2741.6 4877.9 4890.4 4893.7 4895.4 4898.4 5012.6 5222.7 5242.8 5272.6 5273.9 4864.0 4872.5 4880.7 4884.2 4895.0 5083.2 5111.7 5127.4 5129.7 5137.5 4826.9 5034.8 5039.0 5051.7 5107.2 4960.1 4968.4 4979.5 4995.2 4995.8 3649.7 3651.7 3670.4 3672.3 3673.5 5102.2 5213.8 5238.4 5239.1 5250.9 5058.7 5067.8 5074.3 5077.5 5084.8 5008.0 5065.6 5072.1 5089.7 5091.3 4891.2 4967.7 5006.9 5019.5 5029.3 4847.4 4940.2 5063.4 5090.0 5090.7 4957.3 4982.6 4983.8 4985.6 5009.8 14:13:54 INFO - PROCESS | 16140 | 14:13:54 INFO - PROCESS | 16140 | [#5] yui.html Cycles:180 Average:18027.88 Median:22253.75 stddev:26343.71 (118.4%) stddev-sans-first:26385.33 14:13:54 INFO - PROCESS | 16140 | Values: 659.7 702.9 715.8 719.5 740.2 13901.2 14521.9 14536.4 14538.6 14558.1 13813.2 13945.2 13967.4 14005.2 14014.9 632.3 751.3 766.4 788.4 793.5 785.8 788.5 788.8 788.9 790.3 833.2 833.3 833.8 834.5 834.6 655.2 675.3 678.4 678.6 829.4 590.4 608.3 612.2 612.8 613.0 12731.5 12738.7 12745.2 12751.2 12772.1 12104.8 12406.9 12465.8 12848.3 13000.7 11342.7 11474.1 11623.9 11703.6 11947.8 4076.1 4107.4 4159.9 4278.9 4280.0 66184.0 66253.0 69503.0 70019.6 71547.0 9940.2 10409.4 10531.9 10568.4 10809.7 17218.1 17711.6 17740.0 17750.9 17784.6 6761.8 7352.4 7414.8 7457.3 7484.9 3688.9 3746.1 3806.5 3921.3 3954.5 2683.8 2747.6 2757.1 2759.8 2759.9 478.8 479.6 487.5 490.7 494.8 465.5 501.7 513.8 524.7 543.8 7144.8 7451.2 7650.8 7676.7 7713.6 427.1 440.8 451.6 500.5 507.3 3507.9 3638.4 3807.2 4498.3 4734.7 59515.0 101502.0 103755.0 105698.5 110546.0 91146.5 94208.0 94491.4 94699.0 95504.0 81391.0 81658.1 82674.6 83666.7 85963.1 8369.0 9017.7 9017.9 9023.1 9120.6 30241.4 31374.5 33219.7 38947.0 40431.4 39449.2 47440.8 50801.0 56975.7 63381.7 11550.8 11747.2 11805.5 11979.6 12283.1 12900.1 12929.9 12939.2 13233.2 13957.0 11400.8 11440.8 11699.8 12234.2 12239.1 11354.7 12399.4 12548.6 13380.9 13445.4 11531.0 12068.5 12185.5 12787.0 12856.4 10777.2 10863.2 10973.0 11017.5 11125.2 9963.4 10068.8 10085.1 10151.5 10170.1 14:13:54 INFO - PROCESS | 16140 | -------- Summary: end -------- 14:13:54 INFO - PROCESS | 16140 | 14:13:55 INFO - TEST-INFO | 16140: exit 0 14:13:55 INFO - TEST-OK | dromaeo_css | took 1120644ms 14:13:55 INFO - TEST-START | kraken 14:13:55 INFO - operating with platform_type : linux_ 14:13:55 INFO - Initialising browser for kraken test... 14:13:55 INFO - TEST-INFO | started process 16329 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXQIqTl/profile http://localhost:43634/getInfo.html) 14:14:00 INFO - PROCESS | 16329 | __metrics Screen width/height:1600/1200 14:14:00 INFO - PROCESS | 16329 | colorDepth:24 14:14:00 INFO - PROCESS | 16329 | Browser inner width/height: 1024/697 14:14:00 INFO - PROCESS | 16329 | __metrics 14:14:01 INFO - PROCESS | 16329 | 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" 14:14:01 INFO - PROCESS | 16329 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:14:01 INFO - PROCESS | 16329 | console.error: PushService: 14:14:01 INFO - PROCESS | 16329 | stateChangeProcessEnqueue: Error transitioning state 14:14:01 INFO - PROCESS | 16329 | UnknownError 14:14:02 INFO - TEST-INFO | 16329: exit 0 14:14:02 INFO - Browser initialized. 14:14:02 INFO - Running cycle 1/1 for kraken test... 14:14:02 INFO - TEST-INFO | started process 16411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXQIqTl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:14:14 INFO - PROCESS | 16411 | RSS: Main: 157421568 14:14:14 INFO - PROCESS | 16411 | 14:14:17 INFO - PROCESS | 16411 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43634/tests/kraken/driver.html?testName=audio-beat-detection) 14:14:18 INFO - PROCESS | 16411 | RSS: Main: 212725760 14:14:18 INFO - PROCESS | 16411 | 14:14:20 INFO - PROCESS | 16411 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43634/tests/kraken/driver.html?testName=audio-dft) 14:14:21 INFO - PROCESS | 16411 | RSS: Main: 192204800 14:14:21 INFO - PROCESS | 16411 | 14:14:24 INFO - PROCESS | 16411 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43634/tests/kraken/driver.html?testName=audio-fft) 14:14:25 INFO - PROCESS | 16411 | RSS: Main: 271953920 14:14:25 INFO - PROCESS | 16411 | 14:14:27 INFO - PROCESS | 16411 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43634/tests/kraken/driver.html?testName=audio-oscillator) 14:14:28 INFO - PROCESS | 16411 | RSS: Main: 180248576 14:14:28 INFO - PROCESS | 16411 | 14:14:30 INFO - PROCESS | 16411 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43634/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:14:30 INFO - PROCESS | 16411 | RSS: Main: 184619008 14:14:30 INFO - PROCESS | 16411 | 14:14:34 INFO - PROCESS | 16411 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43634/tests/kraken/driver.html?testName=imaging-darkroom) 14:14:34 INFO - PROCESS | 16411 | RSS: Main: 220745728 14:14:34 INFO - PROCESS | 16411 | 14:14:38 INFO - PROCESS | 16411 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43634/tests/kraken/driver.html?testName=imaging-desaturate) 14:14:38 INFO - PROCESS | 16411 | RSS: Main: 214982656 14:14:38 INFO - PROCESS | 16411 | 14:14:41 INFO - PROCESS | 16411 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43634/tests/kraken/driver.html?testName=json-parse-financial) 14:14:42 INFO - PROCESS | 16411 | RSS: Main: 217444352 14:14:42 INFO - PROCESS | 16411 | 14:14:44 INFO - PROCESS | 16411 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43634/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:14:44 INFO - PROCESS | 16411 | RSS: Main: 183439360 14:14:44 INFO - PROCESS | 16411 | 14:14:46 INFO - PROCESS | 16411 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43634/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:14:47 INFO - PROCESS | 16411 | RSS: Main: 189288448 14:14:47 INFO - PROCESS | 16411 | 14:14:49 INFO - PROCESS | 16411 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43634/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:14:50 INFO - PROCESS | 16411 | RSS: Main: 193355776 14:14:50 INFO - PROCESS | 16411 | 14:14:52 INFO - PROCESS | 16411 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43634/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:14:53 INFO - PROCESS | 16411 | RSS: Main: 187781120 14:14:53 INFO - PROCESS | 16411 | 14:14:56 INFO - PROCESS | 16411 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43634/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:14:56 INFO - PROCESS | 16411 | RSS: Main: 191254528 14:14:56 INFO - PROCESS | 16411 | 14:14:58 INFO - PROCESS | 16411 | Cycle 1(1): loaded http://localhost:43634/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43634/tests/kraken/driver.html?testName=ai-astar) 14:14:59 INFO - PROCESS | 16411 | RSS: Main: 242778112 14:14:59 INFO - PROCESS | 16411 | 14:14:59 INFO - PROCESS | 16411 | __start_tp_report 14:14:59 INFO - PROCESS | 16411 | _x_x_mozilla_page_load 14:14:59 INFO - PROCESS | 16411 | _x_x_mozilla_page_load_details 14:14:59 INFO - PROCESS | 16411 | |i|pagename|runs| 14:14:59 INFO - PROCESS | 16411 | |0;ai-astar;105;116;117;114;115;116;114;114;116;115 14:14:59 INFO - PROCESS | 16411 | |1;audio-beat-detection;150;123;123;185;124;126;142;122;157;128 14:14:59 INFO - PROCESS | 16411 | |2;audio-dft;163;160;162;161;160;160;161;162;161;162 14:14:59 INFO - PROCESS | 16411 | |3;audio-fft;76;77;77;104;76;76;75;76;98;75 14:14:59 INFO - PROCESS | 16411 | |4;audio-oscillator;85;86;126;86;86;87;124;84;85;128 14:14:59 INFO - PROCESS | 16411 | |5;imaging-gaussian-blur;117;117;118;119;117;117;117;116;117;118 14:14:59 INFO - PROCESS | 16411 | |6;imaging-darkroom;147;148;146;147;147;147;147;147;148;147 14:14:59 INFO - PROCESS | 16411 | |7;imaging-desaturate;95;94;94;95;95;95;95;95;96;95 14:14:59 INFO - PROCESS | 16411 | |8;json-parse-financial;64;62;63;62;63;64;63;61;62;62 14:14:59 INFO - PROCESS | 16411 | |9;json-stringify-tinderbox;65;65;64;66;65;65;66;66;66;65 14:14:59 INFO - PROCESS | 16411 | |10;stanford-crypto-aes;89;81;85;82;85;83;79;78;79;81 14:14:59 INFO - PROCESS | 16411 | |11;stanford-crypto-ccm;134;132;130;129;128;128;129;129;151;141 14:14:59 INFO - PROCESS | 16411 | |12;stanford-crypto-pbkdf2;171;174;170;168;167;172;170;168;177;172 14:14:59 INFO - PROCESS | 16411 | |13;stanford-crypto-sha256-iterative;68;69;68;71;66;66;70;66;65;67 14:14:59 INFO - PROCESS | 16411 | __end_tp_report 14:14:59 INFO - PROCESS | 16411 | __start_cc_report 14:14:59 INFO - PROCESS | 16411 | _x_x_mozilla_cycle_collect,1919 14:14:59 INFO - PROCESS | 16411 | __end_cc_report 14:14:59 INFO - PROCESS | 16411 | __startTimestamp1470777299009__endTimestamp 14:14:59 INFO - PROCESS | 16411 | 14:14:59 INFO - PROCESS | 16411 | ------- Summary: start ------- 14:14:59 INFO - PROCESS | 16411 | Number of tests: 14 14:14:59 INFO - PROCESS | 16411 | 14:14:59 INFO - PROCESS | 16411 | [#0] ai-astar Cycles:10 Average:114.20 Median:115.50 stddev:3.39 (2.9%) stddev-sans-first:1.09 14:14:59 INFO - PROCESS | 16411 | Values: 105.0 116.0 117.0 114.0 115.0 116.0 114.0 114.0 116.0 115.0 14:14:59 INFO - PROCESS | 16411 | 14:14:59 INFO - PROCESS | 16411 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:135.00 stddev:20.75 (15.4%) stddev-sans-first:21.55 14:14:59 INFO - PROCESS | 16411 | Values: 150.0 123.0 123.0 185.0 124.0 126.0 142.0 122.0 157.0 128.0 14:14:59 INFO - PROCESS | 16411 | 14:14:59 INFO - PROCESS | 16411 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:0.87 14:14:59 INFO - PROCESS | 16411 | Values: 163.0 160.0 162.0 161.0 160.0 160.0 161.0 162.0 161.0 162.0 14:14:59 INFO - PROCESS | 16411 | 14:14:59 INFO - PROCESS | 16411 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.00 stddev:10.66 (14.0%) stddev-sans-first:11.15 14:14:59 INFO - PROCESS | 16411 | Values: 76.0 77.0 77.0 104.0 76.0 76.0 75.0 76.0 98.0 75.0 14:14:59 INFO - PROCESS | 16411 | 14:14:59 INFO - PROCESS | 16411 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:85.50 stddev:19.57 (22.9%) stddev-sans-first:20.21 14:14:59 INFO - PROCESS | 16411 | Values: 85.0 86.0 126.0 86.0 86.0 87.0 124.0 84.0 85.0 128.0 14:14:59 INFO - PROCESS | 16411 | 14:14:59 INFO - PROCESS | 16411 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 14:14:59 INFO - PROCESS | 16411 | Values: 117.0 117.0 118.0 119.0 117.0 117.0 117.0 116.0 117.0 118.0 14:14:59 INFO - PROCESS | 16411 | 14:14:59 INFO - PROCESS | 16411 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 14:14:59 INFO - PROCESS | 16411 | Values: 147.0 148.0 146.0 147.0 147.0 147.0 147.0 147.0 148.0 147.0 14:14:59 INFO - PROCESS | 16411 | 14:14:59 INFO - PROCESS | 16411 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 14:14:59 INFO - PROCESS | 16411 | Values: 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 14:14:59 INFO - PROCESS | 16411 | 14:14:59 INFO - PROCESS | 16411 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:63.00 stddev:0.97 (1.5%) stddev-sans-first:0.88 14:14:59 INFO - PROCESS | 16411 | Values: 64.0 62.0 63.0 62.0 63.0 64.0 63.0 61.0 62.0 62.0 14:14:59 INFO - PROCESS | 16411 | 14:14:59 INFO - PROCESS | 16411 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 14:14:59 INFO - PROCESS | 16411 | Values: 65.0 65.0 64.0 66.0 65.0 65.0 66.0 66.0 66.0 65.0 14:14:59 INFO - PROCESS | 16411 | 14:14:59 INFO - PROCESS | 16411 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.50 stddev:3.39 (4.1%) stddev-sans-first:2.55 14:14:59 INFO - PROCESS | 16411 | Values: 89.0 81.0 85.0 82.0 85.0 83.0 79.0 78.0 79.0 81.0 14:14:59 INFO - PROCESS | 16411 | 14:14:59 INFO - PROCESS | 16411 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:131.00 stddev:7.43 (5.7%) stddev-sans-first:7.87 14:14:59 INFO - PROCESS | 16411 | Values: 134.0 132.0 130.0 129.0 128.0 128.0 129.0 129.0 151.0 141.0 14:14:59 INFO - PROCESS | 16411 | 14:14:59 INFO - PROCESS | 16411 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:171.50 stddev:3.03 (1.8%) stddev-sans-first:3.22 14:14:59 INFO - PROCESS | 16411 | Values: 171.0 174.0 170.0 168.0 167.0 172.0 170.0 168.0 177.0 172.0 14:14:59 INFO - PROCESS | 16411 | 14:14:59 INFO - PROCESS | 16411 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.96 (2.9%) stddev-sans-first:2.07 14:14:59 INFO - PROCESS | 16411 | Values: 68.0 69.0 68.0 71.0 66.0 66.0 70.0 66.0 65.0 67.0 14:14:59 INFO - PROCESS | 16411 | -------- Summary: end -------- 14:14:59 INFO - PROCESS | 16411 | 14:15:00 INFO - TEST-INFO | 16411: exit 0 14:15:00 INFO - TEST-OK | kraken | took 64357ms 14:15:00 INFO - SUITE-END | took 1185s 14:15:00 INFO - Completed test suite (00:19:45) 14:15:00 INFO - javascript benchmark 14:15:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2616.4767046590687, 2623.1737002844106, 2652.7479889410506, 2671.265402014446, 2675.0770984010524, 4448.243798554246, 4524.34397012433, 4685.625149988001, 4746.0, 4747.501512341206, 4690.319903613982, 4748.881277968044, 4758.857234282977, 4764.595009424194, 4806.1589221886115, 4315.093830295642, 4335.761533115678, 4410.051838854645, 4460.776961151945, 4531.841385551506, 4450.287953927388, 4473.7986790594505, 4487.169873573399, 4499.077689073749, 4509.301058335963, 4218.641415479688, 4257.808398622069, 4258.659307255443, 4313.503947046099, 4376.037271800199, 4346.217680817452, 4354.564543545652, 4368.388425620416, 4379.540148284416, 4427.0, 4397.340398940185, 4398.0, 4401.009772801126, 4431.534688857688, 4437.733735975852, 4551.795169217393, 4560.247559152735, 4788.928166077511, 4799.640026997954, 4847.030593881238, 4919.926201106986, 4971.651984361096, 4978.6514943953935, 4984.501549845023, 4988.426330971948, 4952.083864485082, 4987.077390682735, 5000.549950504435, 5005.824796132118, 5022.096022715909, 4629.907401851944, 4648.116857797041, 4666.510016448292, 4692.061587682477, 4749.026449577828, 5198.090334191501, 5237.371515418098, 5269.077911365495, 5279.736013199325, 5285.022270879899, 5027.748612569357, 5058.241263810458, 5060.645754797129, 5067.087924173684, 5074.720890350993, 4854.393200849894, 5046.1169295373165, 5072.391313042459, 5097.46476619957, 5154.664946778447, 5099.0, 5117.155669314521, 5118.564921981673, 5123.513266239701, 5144.948550514447, 5056.974715126475, 5057.645964782503, 5067.391912970467, 5074.0, 5126.5898728101665, 4121.443605113332, 4286.6999310047995, 4289.721168124124, 4293.141371725667, 4346.782660866944, 3667.0832291927018, 3688.446732990073, 3731.6641502264924, 3775.2260786538695, 3818.446325282874, 4389.736615803062, 4391.429114215131, 4394.98915249488, 4399.032212913218, 4441.644668426518, 5058.165402708585, 5093.796248150106, 5101.795928162906, 5108.131617625013, 5128.076946149654, 4212.410262563244, 4351.456067991501, 4427.712198707138, 4428.3800267962515, 4496.460424749051, 4528.47922488918, 4529.547045295444, 4540.88647783808, 4544.954550454453, 4583.633309335245, 4817.542333478384, 4819.879503012453, 4826.58973987215, 4826.762962185997, 4871.0, 4891.437484689306, 5073.11220536412, 5147.996140752667, 5148.227765835155, 5208.088584497622, 4875.146849301429, 4902.7058376497525, 4905.0, 4905.950940490549, 4946.258061290835, 5078.085944529872, 5078.695278283315, 5087.771050302671, 5088.313077734459, 5137.897242055213, 4876.536729010738, 4938.481459446706, 4969.3291405659775, 5010.023045506091, 5061.367329083864, 4894.95105048945, 4896.36347274852, 4904.92642610354, 4912.6561140719805, 4950.6039516837845, 4900.0, 4906.803727850846, 4914.705117692807, 4916.287138364845, 4980.103581355391, 4652.674312798072, 4812.542808433193, 4848.757562121809, 4859.878503037452, 4897.314375987436, 4954.752262386794, 4961.677490963076, 4993.325901003318, 4997.150484417585, 5037.471065538212, 4853.781579828987, 4870.0746858096845, 4876.829310974241, 4880.219164933594, 4924.507549245047], "value": 4657.965801899542, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.7696744334824, 567.7870798450581, 571.0178492992053, 572.490483469712, 585.882823435313, 29084.272893177655, 31702.68297317026, 31843.0, 31897.68102318976, 39261.0, 36572.81713591428, 39915.0, 39956.0, 40013.19973600526, 40036.199276014464, 7622.390208783298, 7754.573498457583, 7755.185705500926, 7759.1852855450215, 7780.649870755829, 7414.962925185394, 7622.047244094489, 7704.306612404883, 9709.563069661846, 10003.949980250089, 10056.547455364525, 10123.08892199702, 10137.239707022003, 10140.695779126638, 10143.036411540928, 9917.851232231485, 9950.502474876228, 9962.750931226705, 9966.800663986753, 9966.850497242547, 9743.464109473976, 9830.4101753895, 9839.45882976436, 9842.753931151707, 9844.064813842746, 37968.0, 38026.23947521034, 38211.42682859759, 38392.23215535674, 38515.61484385149, 2978.612780338564, 3034.5296479045564, 3187.714328313693, 3562.4834399012257, 3659.4876717259604, 28689.713102868915, 29453.0, 29918.70081299181, 29945.850270748506, 30686.386272274653, 3276.5576647152566, 3296.8351582421024, 3300.3234336960863, 3328.234506063619, 3335.52055993002, 245999.0, 263660.0, 266487.0, 266941.0, 268248.0, 31713.207169820478, 53755.19367209495, 53990.46009539854, 53998.0, 54024.0, 32102.19744506406, 34078.65921340804, 34310.0, 34355.48466773, 34367.484487732705, 13249.0, 13393.330333483287, 13394.062415631008, 13394.933025335005, 13398.062135650605, 10874.184436167161, 10894.782104357868, 10958.28771129874, 10963.177761667906, 10988.450577471094, 7385.926140738631, 7457.813554661177, 7465.70137194517, 7685.462017658822, 7741.651625676858, 3049.237690577356, 3097.1351499862535, 3106.9533956990663, 3141.7015383538983, 3159.447096758104, 856.8971723393232, 862.0, 896.394933419939, 964.7395203295212, 988.683621241196, 28016.579751303747, 28483.57274640882, 28693.28266793347, 28729.281767955967, 29121.85439072791, 906.0803284666069, 908.6183802802839, 952.8323065026981, 1033.0341131042499, 1072.8122578548723, 14995.925020374829, 15185.6203594911, 15258.847411525965, 15397.615059623598, 15414.152221627917, 414252.0, 415941.0, 419253.0, 420572.0, 420768.0, 43398.56601434008, 48362.5163748358, 48918.755406223456, 49406.25890611644, 49440.752796235785, 1169.3977601535387, 1187.928724276546, 1190.7558950415143, 1194.42070595761, 1198.80219763738, 26399.34001649974, 27165.59251611267, 27630.5855412173, 28242.576361355008, 28407.857960710066, 42950.35574466448, 46263.768681156376, 47728.761356193, 47828.0, 53378.0, 367670.90961812495, 367842.0, 372033.0, 407676.0, 420679.0, 37474.0, 37770.43344349782, 37793.81103094467, 37795.62204378031, 38243.0, 39182.2163556733, 39207.41188882112, 39240.6075939237, 39581.0, 40212.1957560853, 36228.456573151954, 36320.0, 36593.634063659025, 36956.0, 36959.07602309964, 35378.46932296069, 36417.453738194476, 36864.44703329399, 37101.628983709816, 39067.609323907534, 35491.29017419689, 35916.0, 36203.456948146326, 36379.27241455103, 36941.815290923376, 30726.385472290876, 32863.507047394785, 32982.835085825376, 33021.17447063843, 33146.0, 24900.252992410256, 25269.494610108064, 25293.241202763948, 25877.353066173495, 25878.482430351665], "value": 17119.979857124166, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.4776866826955, 365.1218818740927, 371.233403022758, 371.4391269183532, 392.64269514741574, 12779.616611501659, 15878.444254451097, 16339.999999999985, 16801.32794688211, 17880.46358609244, 16359.754603680925, 16652.83347166531, 17242.913785431087, 17388.913055434707, 17501.299948002095, 4910.8035678573, 4955.355803745508, 5133.794648214067, 5142.07442660321, 5161.329027226455, 3612.349777040132, 4999.175136102539, 5052.772625231855, 5687.573431992617, 6006.189164462807, 6050.909236361458, 6054.485368743662, 6059.636421814683, 6059.636421814683, 6061.45446909778, 5871.29544454666, 5992.898415377769, 5997.700114994276, 6009.308929473123, 6020.909686354708, 5124.743762811844, 5311.654742441768, 5314.601404894648, 5319.20211968204, 5323.574114070865, 20605.690914636292, 20606.381808545768, 20776.896115519325, 21198.470038249012, 21200.893995529925, 1976.6540855350256, 2021.6259991901545, 2155.461134716321, 2221.2447767758877, 2429.1983645397154, 6309.558330916838, 6698.698558564876, 12957.546485873043, 13308.467661293536, 13526.526571570046, 1637.7297745871917, 1748.2395158106265, 1756.8418842304254, 1764.3119183518438, 1793.6681713882974, 69617.65191174063, 70868.0, 72498.0, 73500.6324968377, 74088.25911740867, 9710.854337184948, 9919.206463482904, 9961.203103751683, 10211.591536338612, 10288.537015834305, 13676.863231367757, 13744.862551374557, 13746.0, 13751.174929504261, 13759.38082786277, 7314.817129571697, 7400.518966267283, 7516.060492438445, 7637.274458926393, 7637.923620763721, 7098.36114749675, 7149.463790215755, 7219.0976127984, 7336.33972942427, 7336.889946650805, 5991.340952495222, 6033.276006879202, 6056.545759068087, 6114.847128821815, 6285.371462853678, 1730.5068055604092, 1752.2377765671974, 1767.293082766878, 1773.4059090204669, 1794.4437224460198, 848.3637272045966, 855.1243051495793, 879.5953861223909, 898.1602201941206, 998.201438848918, 16224.513264602081, 16952.321907123576, 17350.652986940444, 17746.29014839392, 19117.426477205707, 820.2569539728078, 831.650706703174, 862.2455351567379, 875.4572165257581, 889.6930558957149, 9377.906220937703, 9469.448584202682, 9646.710598682052, 9814.46020468881, 9892.60429582823, 409058.0, 418032.0, 422028.0, 422919.0, 424323.0, 77927.0, 79423.0, 82608.58695706484, 82707.58646206731, 83461.0, 947.725159703692, 955.7658373698488, 963.8506031565119, 965.6764983730529, 968.1915600473683, 15274.618134546725, 15282.694346113238, 15577.610559736097, 15760.211989400714, 16154.757678634594, 38835.834924952294, 39037.609623903394, 39234.411483828335, 39766.0, 40089.39865902072, 54438.45561544334, 54861.45138548723, 55003.0, 55070.0, 56512.71743641255, 6603.20761508622, 6665.800025999228, 6855.4172895304455, 7059.082319298664, 7664.271894170045, 9326.766830829283, 11250.943745281222, 11322.94338528302, 11665.650030499099, 11723.824142637697, 8910.465372077697, 9158.862617060882, 9320.72037838866, 9456.716298511055, 9489.620415183315, 4632.328312394617, 7028.121484814398, 9490.667826626035, 9880.20958323318, 10297.897021029994, 4994.6503744738975, 5056.089903817348, 8864.069272726529, 9548.61805527799, 9586.856197156909, 6637.668116594247, 6688.230853451915, 6690.297518760654, 6799.6600169990315, 6944.687489062903, 7430.0, 8902.109789021046, 9271.953640231755, 9314.022027687266, 9495.43027418357], "value": 8233.622869181618, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1248.968775780606, 1349.2376807103985, 1417.0930604413174, 1476.8795061777641, 1679.4877562343488, 6127.234095738033, 7025.437964962804, 7238.7828365149, 7239.67421466034, 7376.668049937753, 7229.09636295463, 7274.345308922196, 7284.7814565562985, 7298.562086274814, 7300.452466065053, 2166.6533354663256, 2189.3760278320683, 2191.605511008018, 2196.4618668426256, 2196.8352373571965, 2144.142343062772, 2171.7176767020264, 2174.8042676159143, 2178.891055447229, 2178.9564208715815, 2116.693079503471, 2142.06820033286, 2142.3358758784825, 2145.281330754199, 2149.7312835895514, 2092.3722883135074, 2101.0440249686358, 2101.495641046153, 2101.7162683037745, 2102.211670623516, 2061.391889392618, 2107.947301317464, 2108.8207502362316, 2110.356341315898, 2113.144176608476, 7204.423646108299, 7204.639768011579, 7268.200497945275, 7278.126624805004, 7388.9261107388775, 4140.503139623264, 4287.91424171518, 4291.871243862689, 4306.5262821089655, 4314.697971142022, 2662.3743420296214, 2743.2867454461784, 2797.5663772115354, 2799.776017918582, 2807.410443806803, 868.2619773192736, 875.3587024329382, 878.3544095090103, 918.8300164469528, 927.2535608834885, 9600.711978640651, 9706.466144362057, 9719.416834989923, 9732.41605503665, 9735.367201131903, 3662.2675464906592, 3837.5394952605866, 3999.34010888206, 4005.4192142139227, 4042.211768705133, 7842.647080881374, 7842.725504607425, 7845.607719613997, 7848.607569621496, 7850.175731548219, 4301.462317210348, 4308.224519586442, 4311.935320970188, 4313.115811258747, 4322.135572885435, 3372.9831350843087, 3824.808759562011, 3969.2458432897656, 3973.980130099331, 3996.2806694795217, 3197.4811964316764, 3203.727683146912, 3307.7188438982957, 3318.983405082959, 3346.1969127409247, 1060.9045185933303, 1064.5369264370024, 1065.7495488560182, 1069.3476979042778, 1071.1698433713777, 707.6037419045248, 755.2749360613763, 762.9580373079534, 796.2952786783623, 815.8409110223569, 4502.414686090788, 4810.687305325143, 4868.805247790048, 5183.429822719498, 5284.04887120322, 858.6050416808213, 916.2349438219162, 916.8716379706847, 919.4161707315902, 924.2328867040341, 3252.349530093991, 3395.7962522248745, 3403.0, 3518.2611651552947, 3610.9638903611153, 8700.34747393948, 9015.27877769777, 9035.096490351043, 9046.14061664154, 9049.004609492951, 9068.22920051803, 9075.2286055686, 9080.909190908007, 9081.45511269326, 9087.454752714859, 6567.704453299613, 6847.554908930804, 6853.211880633691, 7017.61403122823, 7142.535735177197, 5241.633085683966, 5321.255024296524, 5336.119540275966, 5362.249285100167, 5373.194020896896, 8327.37544684139, 8339.0, 8370.53962032094, 8410.411271210956, 8460.450070745383, 8317.168283171635, 8468.322534197372, 8528.91471085306, 8531.658733650584, 8577.442466239923, 5668.404817494104, 6316.431521163117, 6408.743650254124, 6410.0, 6417.775377861939, 5791.681457519877, 6875.48433867452, 6880.0, 7012.474064445085, 7015.0, 6241.500679945502, 6292.559520833498, 6343.9682801585695, 6352.491800655844, 6363.268224154282, 6130.141780150871, 6183.412575805291, 6192.195014648247, 6372.776952806629, 6484.481241500763, 5726.4273572642405, 5799.710014499174, 5842.415758424124, 5847.356790753099, 5854.824355269348, 4416.867493975186, 4436.112777444459, 4455.532169122325, 4533.931991020071, 4545.863624091283, 4402.6697997650945, 4482.977585112054, 4489.73061616304, 4489.91020179588, 4591.862244132682], "value": 3910.8903958836013, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.64974304934753, 301.95523488729, 308.3416904908022, 309.14983794564955, 311.4098782806583, 4830.42034955805, 4832.251001094832, 4843.304843304846, 4858.927116093257, 4866.858582223828, 4785.162596545608, 4787.186178349681, 4795.23276275796, 4799.928001079987, 4804.207305794548, 3654.835532401048, 3711.4061750119986, 3750.5124333836698, 3777.5655799583124, 3849.191669749342, 3829.272438236726, 3835.2137811748526, 3839.4816699745456, 3851.1719980204252, 3857.4406711026886, 3812.332841752696, 3818.9045273868096, 3819.178876541543, 3820.465134881119, 3836.405357169643, 3606.981965090184, 3708.221273532548, 3801.1827457096856, 3809.7046055162364, 3812.4090765931323, 3390.627031026585, 3392.3384939936723, 3403.2172600301824, 3404.5233667286598, 3406.3357645259184, 4704.247320428715, 4719.646026547988, 4719.787609557578, 4722.362481065046, 4726.71639701619, 4176.770277634729, 4317.589828966243, 4341.719192838121, 4359.0, 4364.498082720496, 4981.750912454363, 5005.449400565934, 5009.2486127080865, 5013.222950442687, 5033.6224783141415, 3680.1167719747336, 3712.814359282025, 3718.2749363874054, 3728.067983004249, 3730.2539492101687, 5096.261042148868, 5210.947890521084, 5263.578913686934, 5271.630985830993, 5307.177387504943, 3695.0, 3704.5737391104617, 3706.3513885070006, 3714.53568303962, 3716.1452865841006, 3759.3609086455367, 3764.8117594120185, 3766.472693822867, 3766.9058273542832, 3774.50931378919, 4152.584741525884, 4272.316429371348, 4280.357946308079, 4283.271843786501, 4285.250081235771, 4957.3307603473795, 4977.228529577921, 4992.650514464025, 5023.422306434733, 5041.294218809369, 1282.6916545123922, 1299.226959958823, 1300.8178854960313, 1304.6086174147908, 1305.575687901436, 834.6619619054293, 836.7949852286229, 849.6176720475687, 850.6980022092192, 862.7239283429242, 4421.668374871898, 4443.00032492693, 4462.821487140543, 4481.2381895077915, 4486.282194848808, 5147.742612869416, 5153.7165455900285, 5153.742312884341, 5153.984918822456, 5158.613104017214, 4252.576031661984, 4476.574725401082, 4481.887952801206, 4483.125790470892, 4489.349044388546, 2693.811433199657, 2704.756571908538, 2735.712750161244, 2738.657667791526, 2741.629879966219, 4877.853744352474, 4890.364252647133, 4893.681910675795, 4895.412550493964, 4898.387701537308, 5012.573931215888, 5222.683595916545, 5242.76407561653, 5272.6309158358545, 5273.868153296122, 4863.9513604864915, 4872.512748725099, 4880.682755620945, 4884.1941079722155, 4895.038501706487, 5083.186690129562, 5111.744412779421, 5127.384873764752, 5129.743512824419, 5137.460566640449, 4826.903461930671, 5034.766482211881, 5039.001793932604, 5051.722155281494, 5107.157319042316, 4960.131976903956, 4968.447559994621, 4979.477154898828, 4995.175795993766, 4995.8001679932395, 3649.689776368932, 3651.689606383487, 3670.4127339625534, 3672.320620685182, 3673.4673472346894, 5102.158143906214, 5213.843584692465, 5238.4237733850005, 5239.056969745482, 5250.89498210026, 5058.671186372874, 5067.797288108434, 5074.31496747949, 5077.517635824738, 5084.771185296597, 5008.048470790538, 5065.56942659878, 5072.137736584716, 5089.745512724275, 5091.287219789307, 4891.217405215149, 4967.652264341606, 5006.899862002812, 5019.544332143783, 5029.295898574275, 4847.418309802846, 4940.209566469348, 5063.367079115111, 5089.9745501272255, 5090.694558326512, 4957.3059771632725, 4982.576480999156, 4983.775730092227, 4985.5762260208285, 5009.824656137018], "value": 3816.2946690941662, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.6503852957933, 702.8559145375199, 715.7530651925084, 719.4532155561772, 740.167311774254, 13901.165930044192, 14521.854781452183, 14536.41854325827, 14538.636534086652, 14558.126512409262, 13813.171209727423, 13945.163290202596, 13967.371468283925, 14005.159690418557, 14014.859851401483, 632.2665707778978, 751.3163021650299, 766.4366690482491, 788.3929374381722, 793.5000949401898, 785.8271180340316, 788.538704857659, 788.7594283743456, 788.8895554622358, 790.3203245209115, 833.1543483364389, 833.2750507058868, 833.7707130539089, 834.4784509681449, 834.5993922917004, 655.2431941108005, 675.2976904019813, 678.372505432478, 678.5521555773215, 829.3738227638155, 590.3948452835834, 608.3399511529996, 612.2499937576478, 612.8008397270905, 612.9938700612981, 12731.490740370375, 12738.74522509554, 12745.17156384832, 12751.171173873669, 12772.105952583323, 12104.757904841854, 12406.875931240753, 12465.813012804816, 12848.293343866084, 13000.674983125404, 11342.659720208407, 11474.139439541985, 11623.88376116245, 11703.648890533297, 11947.820782688266, 4076.1032572834224, 4107.404426358191, 4159.9376009359585, 4278.893027674302, 4279.957200428018, 66184.00723989143, 66253.0, 69503.0, 70019.64990175067, 71547.0, 9940.155086817702, 10409.42748148859, 10531.947340263403, 10568.418736969386, 10809.67570972872, 17218.05300708448, 17711.645767084585, 17740.0, 17750.91124544369, 17784.555386115193, 6761.763338283235, 7352.411807055422, 7414.814629634302, 7457.32884040439, 7484.850302994018, 3688.9262214755554, 3746.119661879456, 3806.4861243731743, 3921.2941670499586, 3954.4859168308512, 2683.8389696618265, 2747.5741260104714, 2757.0763794129193, 2759.8344099354103, 2759.931001724973, 478.8324086569673, 479.56599277653777, 487.50761730652295, 490.7399078488335, 494.8169177404383, 465.4554171619214, 501.7140230068899, 513.8339920948616, 524.685188886665, 543.8286939614009, 7144.821379465451, 7451.180370159278, 7650.770476885591, 7676.731314404081, 7713.614319284014, 427.1201325269954, 440.7641911577291, 451.58454222115734, 500.49450055444265, 507.27206458731837, 3507.877224297137, 3638.3632864248652, 3807.162424266657, 4498.280275155959, 4734.692245004064, 59515.0, 101502.0, 103754.96245037604, 105698.47150764197, 110546.0, 91146.54426727824, 94208.0, 94491.44068474506, 94699.0, 95504.0, 81391.0, 81658.05906497895, 82674.58662706648, 83666.74499882506, 85963.14036859552, 8368.958155209428, 9017.724631090885, 9017.909820901707, 9023.142801433853, 9120.589573469077, 30241.395172096876, 31374.52938205883, 33219.66780332166, 38947.0, 40431.3935290965, 39449.21101577895, 47440.7627961858, 50801.0, 56975.715121424124, 63381.683091584244, 11550.826737598774, 11747.177697561088, 11805.468753906267, 11979.640610781691, 12283.140180187658, 12900.09699321076, 12929.870701292866, 12939.223646581235, 13233.206007639572, 13957.0, 11400.828987565028, 11440.82838757436, 11699.824502632297, 12234.204776689487, 12239.143259972072, 11354.659360219206, 12399.442025108712, 12548.623541293775, 13380.93309533485, 13445.394957226752, 11531.0, 12068.517259309529, 12185.51257949672, 12787.017608564343, 12856.421461034462, 10777.245592808427, 10863.185261105291, 10973.0, 11017.504212310625, 11125.17559927146, 9963.352382095141, 10068.77304893862, 10085.142762865238, 10151.543180556744, 10170.148675047252], "value": 6591.30488325638, "unit": "score"}], "name": "dromaeo_css", "value": 6334.393338077645, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 117.0, 114.0, 115.0, 116.0, 114.0, 114.0, 116.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 123.0, 185.0, 124.0, 126.0, 142.0, 122.0, 157.0, 128.0], "value": 138.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 162.0, 161.0, 160.0, 160.0, 161.0, 162.0, 161.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 104.0, 76.0, 76.0, 75.0, 76.0, 98.0, 75.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 126.0, 86.0, 86.0, 87.0, 124.0, 84.0, 85.0, 128.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 119.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 62.0, 63.0, 64.0, 63.0, 61.0, 62.0, 62.0], "value": 62.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 81.0, 85.0, 82.0, 85.0, 83.0, 79.0, 78.0, 79.0, 81.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 130.0, 129.0, 128.0, 128.0, 129.0, 129.0, 151.0, 141.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 170.0, 168.0, 167.0, 172.0, 170.0, 168.0, 177.0, 172.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 71.0, 66.0, 66.0, 70.0, 66.0, 65.0, 67.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1533.1, "alertThreshold": 2.0}]} 14:15:00 INFO - Return code: 0 14:15:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:15:00 INFO - # TBPL SUCCESS # 14:15:00 INFO - Running post-action listener: _resource_record_post_action 14:15:00 INFO - [mozharness: 2016-08-09 21:15:00.789075Z] Finished run-tests step (success) 14:15:00 INFO - Running post-run listener: _resource_record_post_run 14:15:00 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 547913728; Read time: 0; Write time: 832244 14:15:00 INFO - TinderboxPrint: CPU usage
13.0% 14:15:00 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:15:00 INFO - TinderboxPrint: I/O write bytes / time
547,913,728 / 832,244 14:15:00 INFO - TinderboxPrint: CPU idle
8,344.2 (87.0%) 14:15:00 INFO - TinderboxPrint: CPU user
1,199.4 (12.5%) 14:15:00 INFO - TinderboxPrint: Swap in / out
0 / 0 14:15:00 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 253796352; Read time: 0; Write time: 500664 14:15:00 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 293785600; Read time: 0; Write time: 331576 14:15:01 INFO - Running post-run listener: _upload_blobber_files 14:15:01 INFO - Blob upload gear active. 14:15:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:15:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:15:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:15:01 INFO - (blobuploader) - INFO - Open directory for files ... 14:15:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:15:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:15:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:15:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:15:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:15:10 INFO - (blobuploader) - INFO - Done attempting. 14:15:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:15:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:15:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:15:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:15:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:15:11 INFO - (blobuploader) - INFO - Done attempting. 14:15:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:15:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:15:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:15:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:15:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:15:12 INFO - (blobuploader) - INFO - Done attempting. 14:15:12 INFO - (blobuploader) - INFO - Iteration through files over. 14:15:12 INFO - Return code: 0 14:15:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:15:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:15:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc75af20de46cf5f400fcb370ef9d32297107fdef678ca012c7838c19b20d9ed6a3c444943bc1c116e36d27cef92d42e886287ba9fa547c231a70589cb9df9e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c06d083e11889a288628ea0d8fdafc936a93135cbde04dd9add71e57d5dabdcf8c1681aec2b288447f26171dd055650542c1f91d5d6c161c774fbf26e4e626e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02db8603bfbb163c8f8e0d010183b8c49caed96ffee798a0084387258173c9601dfc0c23476a16ca1487a35c77689b997cd0b09de9ae1d8e3556e0149e8266ea"} 14:15:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:15:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:15:12 INFO - Contents: 14:15:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc75af20de46cf5f400fcb370ef9d32297107fdef678ca012c7838c19b20d9ed6a3c444943bc1c116e36d27cef92d42e886287ba9fa547c231a70589cb9df9e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c06d083e11889a288628ea0d8fdafc936a93135cbde04dd9add71e57d5dabdcf8c1681aec2b288447f26171dd055650542c1f91d5d6c161c774fbf26e4e626e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02db8603bfbb163c8f8e0d010183b8c49caed96ffee798a0084387258173c9601dfc0c23476a16ca1487a35c77689b997cd0b09de9ae1d8e3556e0149e8266ea"} 14:15:12 INFO - Running post-run listener: copy_logs_to_upload_dir 14:15:12 INFO - Copying logs to upload dir... 14:15:12 INFO - mkdir: /builds/slave/test/build/upload/logs 14:15:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.142816 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-09 14:15:12.124846) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 14:15:12.128675) ========= 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=af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc75af20de46cf5f400fcb370ef9d32297107fdef678ca012c7838c19b20d9ed6a3c444943bc1c116e36d27cef92d42e886287ba9fa547c231a70589cb9df9e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c06d083e11889a288628ea0d8fdafc936a93135cbde04dd9add71e57d5dabdcf8c1681aec2b288447f26171dd055650542c1f91d5d6c161c774fbf26e4e626e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02db8603bfbb163c8f8e0d010183b8c49caed96ffee798a0084387258173c9601dfc0c23476a16ca1487a35c77689b997cd0b09de9ae1d8e3556e0149e8266ea"} build_url:https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/coxbS9lORPSzPuCc6x9sTg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc75af20de46cf5f400fcb370ef9d32297107fdef678ca012c7838c19b20d9ed6a3c444943bc1c116e36d27cef92d42e886287ba9fa547c231a70589cb9df9e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c06d083e11889a288628ea0d8fdafc936a93135cbde04dd9add71e57d5dabdcf8c1681aec2b288447f26171dd055650542c1f91d5d6c161c774fbf26e4e626e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02db8603bfbb163c8f8e0d010183b8c49caed96ffee798a0084387258173c9601dfc0c23476a16ca1487a35c77689b997cd0b09de9ae1d8e3556e0149e8266ea"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 14:15:12.154185) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 14:15:12.154533) ========= 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=af724c981e2a0f424dbabf99000001e7-1470774468.867774-1260304938 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 14:15:12.240285) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 14:15:12.240624) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 14:15:12.240932) ========= ========= Total master_lag: 0.18 =========