builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-069 starttime: 1470419294.79 results: success (0) buildid: 20160805093133 builduid: f78521c0ffac4041b9a7022684358587 revision: 204a7ba2fba4bd74e715065492262cc6ffa8f8cf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:14.793877) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:14.794450) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:14.794765) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:14.868161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:14.868535) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-05 10:48:16-- 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% 40.5M=0s 2016-08-05 10:48:16 (40.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102462 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:14.997140) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:14.997443) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021141 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:15.051521) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:15.051861) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 204a7ba2fba4bd74e715065492262cc6ffa8f8cf --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 204a7ba2fba4bd74e715065492262cc6ffa8f8cf --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=05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-05 10:48:16,535 truncating revision to first 12 chars 2016-08-05 10:48:16,535 Setting DEBUG logging. 2016-08-05 10:48:16,535 attempt 1/10 2016-08-05 10:48:16,535 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/204a7ba2fba4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-05 10:48:16,849 unpacking tar archive at: fx-team-204a7ba2fba4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669711 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:15.735700) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:15.736035) ========= script_repo_revision: 204a7ba2fba4bd74e715065492262cc6ffa8f8cf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:15.736455) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:15.736716) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-05 10:48:15.745889) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-05 10:48:15.746207) ========= /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=05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:48:17 INFO - MultiFileLogger online at 20160805 10:48:17 in /builds/slave/test 10:48:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:48:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:48:17 INFO - {'append_to_log': False, 10:48:17 INFO - 'base_work_dir': '/builds/slave/test', 10:48:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:48:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:48:17 INFO - 'branch': 'Fx-Team-Non-PGO', 10:48:17 INFO - 'buildbot_json_path': 'buildprops.json', 10:48:17 INFO - 'config_files': ('talos/linux_config.py',), 10:48:17 INFO - 'default_actions': ('clobber', 10:48:17 INFO - 'read-buildbot-config', 10:48:17 INFO - 'download-and-extract', 10:48:17 INFO - 'populate-webroot', 10:48:17 INFO - 'create-virtualenv', 10:48:17 INFO - 'install', 10:48:17 INFO - 'run-tests'), 10:48:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:48:17 INFO - 'download_minidump_stackwalk': True, 10:48:17 INFO - 'download_symbols': 'ondemand', 10:48:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:48:17 INFO - 'tooltool.py': '/tools/tooltool.py', 10:48:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:48:17 INFO - '/tools/misc-python/virtualenv.py')}, 10:48:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:48:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:48:17 INFO - 'installer_path': 'installer.exe', 10:48:17 INFO - 'log_level': 'info', 10:48:17 INFO - 'log_name': 'talos', 10:48:17 INFO - 'log_to_console': True, 10:48:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:48:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:48:17 INFO - 'opt_config_files': (), 10:48:17 INFO - 'pip_index': False, 10:48:17 INFO - 'sps_profile': False, 10:48:17 INFO - 'sps_profile_interval': 0, 10:48:17 INFO - 'suite': 'dromaeojs', 10:48:17 INFO - 'system_bits': '32', 10:48:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:48:17 INFO - 'title': 'talos-linux64-ix-069', 10:48:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:48:17 INFO - 'use_talos_json': True, 10:48:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:48:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:48:17 INFO - 'work_dir': 'build'} 10:48:17 INFO - [mozharness: 2016-08-05 17:48:17.312920Z] Running clobber step. 10:48:17 INFO - Running pre-action listener: _resource_record_pre_action 10:48:17 INFO - Running main action method: clobber 10:48:17 INFO - rmtree: /builds/slave/test/build 10:48:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:48:17 INFO - Running post-action listener: _resource_record_post_action 10:48:17 INFO - [mozharness: 2016-08-05 17:48:17.778688Z] Finished clobber step (success) 10:48:17 INFO - [mozharness: 2016-08-05 17:48:17.778790Z] Running read-buildbot-config step. 10:48:17 INFO - Running pre-action listener: _resource_record_pre_action 10:48:17 INFO - Running main action method: read_buildbot_config 10:48:17 INFO - Using buildbot properties: 10:48:17 INFO - { 10:48:17 INFO - "project": "", 10:48:17 INFO - "product": "firefox", 10:48:17 INFO - "script_repo_revision": "production", 10:48:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:48:17 INFO - "repository": "", 10:48:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:48:17 INFO - "buildid": "20160805093133", 10:48:17 INFO - "pgo_build": "False", 10:48:17 INFO - "basedir": "/builds/slave/test", 10:48:17 INFO - "buildnumber": 1853, 10:48:17 INFO - "slavename": "talos-linux64-ix-069", 10:48:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:48:17 INFO - "platform": "ubuntu64_hw", 10:48:17 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 10:48:17 INFO - "branch": "fx-team", 10:48:17 INFO - "repo_path": "integration/fx-team", 10:48:17 INFO - "revision": "204a7ba2fba4bd74e715065492262cc6ffa8f8cf", 10:48:17 INFO - "stage_platform": "linux64", 10:48:17 INFO - "builduid": "f78521c0ffac4041b9a7022684358587", 10:48:17 INFO - "slavebuilddir": "test" 10:48:17 INFO - } 10:48:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 10:48:17 INFO - Running post-action listener: _resource_record_post_action 10:48:17 INFO - [mozharness: 2016-08-05 17:48:17.781228Z] Finished read-buildbot-config step (success) 10:48:17 INFO - [mozharness: 2016-08-05 17:48:17.781317Z] Running download-and-extract step. 10:48:17 INFO - Running pre-action listener: _resource_record_pre_action 10:48:17 INFO - Running main action method: download_and_extract 10:48:17 INFO - mkdir: /builds/slave/test/build/tests 10:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:17 INFO - trying https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:48:17 INFO - Downloading https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:48:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:48:18 INFO - Downloaded 1361 bytes. 10:48:18 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 10:48:18 INFO - Using the following test package requirements: 10:48:18 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:48:18 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:48:18 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:48:18 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:18 INFO - u'jsshell-linux-x86_64.zip'], 10:48:18 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:48:18 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 10:48:18 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:48:18 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:48:18 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:48:18 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 10:48:18 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:48:18 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:48:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:18 INFO - trying https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:48:18 INFO - Downloading https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:48:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:48:19 INFO - Downloaded 20254056 bytes. 10:48:19 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 10:48:23 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:48:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:23 INFO - trying https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:48:23 INFO - Downloading https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 10:48:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:48:24 INFO - Downloaded 20254056 bytes. 10:48:24 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 10:48: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')]} 10:48:29 INFO - trying https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:48:29 INFO - Downloading https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 10:48:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:48:30 INFO - Downloaded 14413723 bytes. 10:48:30 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 10:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:30 INFO - trying https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:48:30 INFO - Downloading https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:48:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:48:31 INFO - Downloaded 56134508 bytes. 10:48:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:48:31 INFO - mkdir: /builds/slave/test/properties 10:48:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:48:31 INFO - Writing to file /builds/slave/test/properties/build_url 10:48:31 INFO - Contents: 10:48:31 INFO - build_url:https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 10:48:32 INFO - Running post-action listener: _resource_record_post_action 10:48:32 INFO - Running post-action listener: set_extra_try_arguments 10:48:32 INFO - [mozharness: 2016-08-05 17:48:32.397481Z] Finished download-and-extract step (success) 10:48:32 INFO - [mozharness: 2016-08-05 17:48:32.397704Z] Running populate-webroot step. 10:48:32 INFO - Running pre-action listener: _resource_record_pre_action 10:48:32 INFO - Running main action method: populate_webroot 10:48:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:48:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:48:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:48:32 INFO - '--tppagecycles', 10:48:32 INFO - '7'], 10:48:32 INFO - 'tests': ['tsvgm']}}, 10:48:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:48:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:48:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:48:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:48:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:48:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:48:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:32 INFO - 'talos_options': ['--disable-e10s'], 10:48:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:48:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:48:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:32 INFO - 'talos_options': ['--disable-e10s'], 10:48:32 INFO - 'tests': ['damp', 'tps']}, 10:48:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:32 INFO - 'tests': ['damp', 'tps']}, 10:48:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:48:32 INFO - 'tests': ['dromaeo_dom']}, 10:48:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:48:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:48:32 INFO - 'tests': ['basic_compositor_video']}, 10:48:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:48:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:48:32 INFO - 'tests': ['a11yr', 10:48:32 INFO - 'ts_paint', 10:48:32 INFO - 'tpaint', 10:48:32 INFO - 'sessionrestore', 10:48:32 INFO - 'sessionrestore_no_auto_restore', 10:48:32 INFO - 'tabpaint']}, 10:48:32 INFO - 'other-e10s': {'tests': ['a11yr', 10:48:32 INFO - 'ts_paint', 10:48:32 INFO - 'tpaint', 10:48:32 INFO - 'sessionrestore', 10:48:32 INFO - 'sessionrestore_no_auto_restore', 10:48:32 INFO - 'tabpaint']}, 10:48:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:48:32 INFO - 'ts_paint', 10:48:32 INFO - 'tpaint', 10:48:32 INFO - 'sessionrestore', 10:48:32 INFO - 'sessionrestore_no_auto_restore', 10:48:32 INFO - 'tabpaint']}, 10:48:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:48:32 INFO - 'ts_paint', 10:48:32 INFO - 'tpaint', 10:48:32 INFO - 'sessionrestore', 10:48:32 INFO - 'sessionrestore_no_auto_restore', 10:48:32 INFO - 'tabpaint']}, 10:48:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:48:32 INFO - 'tests': ['a11yr', 10:48:32 INFO - 'ts_paint', 10:48:32 INFO - 'tpaint', 10:48:32 INFO - 'sessionrestore', 10:48:32 INFO - 'sessionrestore_no_auto_restore', 10:48:32 INFO - 'tabpaint']}, 10:48:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:48:32 INFO - 'tests': ['a11yr', 10:48:32 INFO - 'ts_paint', 10:48:32 INFO - 'tpaint', 10:48:32 INFO - 'sessionrestore', 10:48:32 INFO - 'sessionrestore_no_auto_restore', 10:48:32 INFO - 'tabpaint']}, 10:48:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:48:32 INFO - 'tests': ['tsvgx', 10:48:32 INFO - 'tsvgr_opacity', 10:48:32 INFO - 'tart', 10:48:32 INFO - 'tscrollx', 10:48:32 INFO - 'cart']}, 10:48:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:48:32 INFO - 'tsvgr_opacity', 10:48:32 INFO - 'tart', 10:48:32 INFO - 'tscrollx', 10:48:32 INFO - 'cart']}, 10:48:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:32 INFO - 'talos_options': ['--disable-e10s'], 10:48:32 INFO - 'tests': ['tp5o']}, 10:48:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:32 INFO - 'tests': ['tp5o']}, 10:48:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:32 INFO - 'talos_options': ['--disable-e10s', 10:48:32 INFO - '--xperf_path', 10:48:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:48:32 INFO - 'tests': ['tp5n']}, 10:48:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:48:32 INFO - 'talos_options': ['--xperf_path', 10:48:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:48:32 INFO - 'tests': ['tp5n']}}, 10:48:32 INFO - 'talos.zip': {'path': '', 10:48:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:48:32 INFO - Running post-action listener: _resource_record_post_action 10:48:32 INFO - [mozharness: 2016-08-05 17:48:32.413210Z] Finished populate-webroot step (success) 10:48:32 INFO - [mozharness: 2016-08-05 17:48:32.413330Z] Running create-virtualenv step. 10:48:32 INFO - Running pre-action listener: _resource_record_pre_action 10:48:32 INFO - Running main action method: create_virtualenv 10:48:32 INFO - Creating virtualenv /builds/slave/test/build/venv 10:48:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:48:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:48:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:48:32 INFO - Using real prefix '/usr' 10:48:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:48:33 INFO - Installing distribute.............................................................................................................................................................................................done. 10:48:34 INFO - Installing pip.................done. 10:48:34 INFO - Return code: 0 10:48:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:48: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')]} 10:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48: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')]} 10:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:34 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 0xe40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3b0>, '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 0x11002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:48:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:48:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:48:34 INFO - Using env: {'DISPLAY': ':0', 10:48:34 INFO - 'HOME': '/home/cltbld', 10:48:34 INFO - 'LANG': 'en_US.UTF-8', 10:48:35 INFO - 'LANGUAGE': 'en_US:en', 10:48:35 INFO - 'LOGNAME': 'cltbld', 10:48:35 INFO - 'MAIL': '/var/mail/cltbld', 10:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:35 INFO - 'MOZ_NO_REMOTE': '1', 10:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:35 INFO - 'NO_EM_RESTART': '1', 10:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:35 INFO - 'PWD': '/builds/slave/test', 10:48:35 INFO - 'SHELL': '/bin/bash', 10:48:35 INFO - 'SHLVL': '1', 10:48:35 INFO - 'TERM': 'linux', 10:48:35 INFO - 'TMOUT': '86400', 10:48:35 INFO - 'USER': 'cltbld', 10:48:35 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 10:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:35 INFO - '_': '/tools/buildbot/bin/python'} 10:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:48:35 INFO - Cleaning up... 10:48:35 INFO - Return code: 0 10:48:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3b0>, '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 0x11002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:48:35 INFO - Using env: {'DISPLAY': ':0', 10:48:35 INFO - 'HOME': '/home/cltbld', 10:48:35 INFO - 'LANG': 'en_US.UTF-8', 10:48:35 INFO - 'LANGUAGE': 'en_US:en', 10:48:35 INFO - 'LOGNAME': 'cltbld', 10:48:35 INFO - 'MAIL': '/var/mail/cltbld', 10:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:35 INFO - 'MOZ_NO_REMOTE': '1', 10:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:35 INFO - 'NO_EM_RESTART': '1', 10:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:35 INFO - 'PWD': '/builds/slave/test', 10:48:35 INFO - 'SHELL': '/bin/bash', 10:48:35 INFO - 'SHLVL': '1', 10:48:35 INFO - 'TERM': 'linux', 10:48:35 INFO - 'TMOUT': '86400', 10:48:35 INFO - 'USER': 'cltbld', 10:48:35 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 10:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:35 INFO - '_': '/tools/buildbot/bin/python'} 10:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:35 INFO - Downloading/unpacking psutil>=3.1.1 10:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:48:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:48:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:48:37 INFO - Installing collected packages: psutil 10:48:37 INFO - Running setup.py install for psutil 10:48:37 INFO - building 'psutil._psutil_linux' extension 10:48:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:48:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:48:37 INFO - building 'psutil._psutil_posix' extension 10:48:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:48:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:48:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:48:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:48:37 INFO - Successfully installed psutil 10:48:37 INFO - Cleaning up... 10:48:37 INFO - Return code: 0 10:48:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:37 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 0xe40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3b0>, '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 0x11002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:48:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:48:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:48:37 INFO - Using env: {'DISPLAY': ':0', 10:48:37 INFO - 'HOME': '/home/cltbld', 10:48:37 INFO - 'LANG': 'en_US.UTF-8', 10:48:37 INFO - 'LANGUAGE': 'en_US:en', 10:48:37 INFO - 'LOGNAME': 'cltbld', 10:48:37 INFO - 'MAIL': '/var/mail/cltbld', 10:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:37 INFO - 'MOZ_NO_REMOTE': '1', 10:48:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:37 INFO - 'NO_EM_RESTART': '1', 10:48:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:37 INFO - 'PWD': '/builds/slave/test', 10:48:37 INFO - 'SHELL': '/bin/bash', 10:48:37 INFO - 'SHLVL': '1', 10:48:37 INFO - 'TERM': 'linux', 10:48:37 INFO - 'TMOUT': '86400', 10:48:37 INFO - 'USER': 'cltbld', 10:48:37 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 10:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:37 INFO - '_': '/tools/buildbot/bin/python'} 10:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:48:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:48:40 INFO - Installing collected packages: mozsystemmonitor 10:48:40 INFO - Running setup.py install for mozsystemmonitor 10:48:40 INFO - Successfully installed mozsystemmonitor 10:48:40 INFO - Cleaning up... 10:48:40 INFO - Return code: 0 10:48:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3b0>, '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 0x11002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:48:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:48:40 INFO - Using env: {'DISPLAY': ':0', 10:48:40 INFO - 'HOME': '/home/cltbld', 10:48:40 INFO - 'LANG': 'en_US.UTF-8', 10:48:40 INFO - 'LANGUAGE': 'en_US:en', 10:48:40 INFO - 'LOGNAME': 'cltbld', 10:48:40 INFO - 'MAIL': '/var/mail/cltbld', 10:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:40 INFO - 'MOZ_NO_REMOTE': '1', 10:48:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:40 INFO - 'NO_EM_RESTART': '1', 10:48:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:40 INFO - 'PWD': '/builds/slave/test', 10:48:40 INFO - 'SHELL': '/bin/bash', 10:48:40 INFO - 'SHLVL': '1', 10:48:40 INFO - 'TERM': 'linux', 10:48:40 INFO - 'TMOUT': '86400', 10:48:40 INFO - 'USER': 'cltbld', 10:48:40 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 10:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:40 INFO - '_': '/tools/buildbot/bin/python'} 10:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:40 INFO - Downloading/unpacking jsonschema==2.5.1 10:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:48:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:48: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 10:48: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 10:48: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 10:48: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 10:48: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 10:48: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 10:48:42 INFO - Downloading functools32-3.2.3-2.tar.gz 10:48:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:48:42 INFO - warning: no files found matching '*.txt' 10:48:42 INFO - no previously-included directories found matching 'build' 10:48:42 INFO - no previously-included directories found matching 'dist' 10:48:42 INFO - no previously-included directories found matching '.git*' 10:48:42 INFO - Installing collected packages: jsonschema, functools32 10:48:42 INFO - Running setup.py install for functools32 10:48:42 INFO - warning: no files found matching '*.txt' 10:48:42 INFO - no previously-included directories found matching 'build' 10:48:42 INFO - no previously-included directories found matching 'dist' 10:48:42 INFO - no previously-included directories found matching '.git*' 10:48:42 INFO - Successfully installed jsonschema functools32 10:48:42 INFO - Cleaning up... 10:48:42 INFO - Return code: 0 10:48:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48: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', '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 0xe40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3b0>, '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 0x11002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:48: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:48: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 functools32==3.2.3-2 10:48:42 INFO - Using env: {'DISPLAY': ':0', 10:48:42 INFO - 'HOME': '/home/cltbld', 10:48:42 INFO - 'LANG': 'en_US.UTF-8', 10:48:42 INFO - 'LANGUAGE': 'en_US:en', 10:48:42 INFO - 'LOGNAME': 'cltbld', 10:48:42 INFO - 'MAIL': '/var/mail/cltbld', 10:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:42 INFO - 'MOZ_NO_REMOTE': '1', 10:48:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:42 INFO - 'NO_EM_RESTART': '1', 10:48:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:42 INFO - 'PWD': '/builds/slave/test', 10:48:42 INFO - 'SHELL': '/bin/bash', 10:48:42 INFO - 'SHLVL': '1', 10:48:42 INFO - 'TERM': 'linux', 10:48:42 INFO - 'TMOUT': '86400', 10:48:42 INFO - 'USER': 'cltbld', 10:48:42 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 10:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:42 INFO - '_': '/tools/buildbot/bin/python'} 10:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:48:43 INFO - Cleaning up... 10:48:43 INFO - Return code: 0 10:48:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:43 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 0xe40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3b0>, '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 0x11002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:48:43 INFO - Using env: {'DISPLAY': ':0', 10:48:43 INFO - 'HOME': '/home/cltbld', 10:48:43 INFO - 'LANG': 'en_US.UTF-8', 10:48:43 INFO - 'LANGUAGE': 'en_US:en', 10:48:43 INFO - 'LOGNAME': 'cltbld', 10:48:43 INFO - 'MAIL': '/var/mail/cltbld', 10:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:43 INFO - 'MOZ_NO_REMOTE': '1', 10:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:43 INFO - 'NO_EM_RESTART': '1', 10:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:43 INFO - 'PWD': '/builds/slave/test', 10:48:43 INFO - 'SHELL': '/bin/bash', 10:48:43 INFO - 'SHLVL': '1', 10:48:43 INFO - 'TERM': 'linux', 10:48:43 INFO - 'TMOUT': '86400', 10:48:43 INFO - 'USER': 'cltbld', 10:48:43 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 10:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:43 INFO - '_': '/tools/buildbot/bin/python'} 10:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:43 INFO - Downloading/unpacking blobuploader==1.2.4 10:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:45 INFO - Downloading blobuploader-1.2.4.tar.gz 10:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:48:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:48:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:45 INFO - Downloading docopt-0.6.1.tar.gz 10:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:48:45 INFO - Installing collected packages: blobuploader, requests, docopt 10:48:45 INFO - Running setup.py install for blobuploader 10:48:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:48:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:48:45 INFO - Running setup.py install for requests 10:48:46 INFO - Running setup.py install for docopt 10:48:46 INFO - Successfully installed blobuploader requests docopt 10:48:46 INFO - Cleaning up... 10:48:46 INFO - Return code: 0 10:48:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:46 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 0xe40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3b0>, '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 0x11002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:48:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:48:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:48:46 INFO - Using env: {'DISPLAY': ':0', 10:48:46 INFO - 'HOME': '/home/cltbld', 10:48:46 INFO - 'LANG': 'en_US.UTF-8', 10:48:46 INFO - 'LANGUAGE': 'en_US:en', 10:48:46 INFO - 'LOGNAME': 'cltbld', 10:48:46 INFO - 'MAIL': '/var/mail/cltbld', 10:48:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:46 INFO - 'MOZ_NO_REMOTE': '1', 10:48:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:46 INFO - 'NO_EM_RESTART': '1', 10:48:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:46 INFO - 'PWD': '/builds/slave/test', 10:48:46 INFO - 'SHELL': '/bin/bash', 10:48:46 INFO - 'SHLVL': '1', 10:48:46 INFO - 'TERM': 'linux', 10:48:46 INFO - 'TMOUT': '86400', 10:48:46 INFO - 'USER': 'cltbld', 10:48:46 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 10:48:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:46 INFO - '_': '/tools/buildbot/bin/python'} 10:48:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:48:46 INFO - Running setup.py (path:/tmp/pip-a3DhRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:48:46 INFO - Running setup.py (path:/tmp/pip-Fgs9bQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:48:46 INFO - Running setup.py (path:/tmp/pip-kJYWiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:48:46 INFO - Running setup.py (path:/tmp/pip-18Q7nJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:48:47 INFO - Running setup.py (path:/tmp/pip-HA6lRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:48:47 INFO - Running setup.py (path:/tmp/pip-Uk1Oll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:48:47 INFO - Running setup.py (path:/tmp/pip-MJKWFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:48:47 INFO - Running setup.py (path:/tmp/pip-y9Ku65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:48:47 INFO - Running setup.py (path:/tmp/pip-EhwwT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:48:47 INFO - Running setup.py (path:/tmp/pip-t3CHGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:48:47 INFO - Running setup.py (path:/tmp/pip-r2okoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:48:47 INFO - Running setup.py (path:/tmp/pip-onrC1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:48:47 INFO - Running setup.py (path:/tmp/pip-Cer41z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:48:47 INFO - Running setup.py (path:/tmp/pip-aYlmQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:48:47 INFO - Running setup.py (path:/tmp/pip-C1QXoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:48:47 INFO - Running setup.py (path:/tmp/pip-YnJbtz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:48:47 INFO - Running setup.py (path:/tmp/pip-A06H97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:48:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:48:47 INFO - Running setup.py install for manifestparser 10:48:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:48:48 INFO - Running setup.py install for mozcrash 10:48:48 INFO - Running setup.py install for mozdebug 10:48:48 INFO - Running setup.py install for mozdevice 10:48:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:48:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:48:48 INFO - Running setup.py install for mozfile 10:48:48 INFO - Running setup.py install for mozhttpd 10:48:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:48:48 INFO - Running setup.py install for mozinfo 10:48:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:48:48 INFO - Running setup.py install for mozInstall 10:48:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:48:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:48:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:48:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:48:48 INFO - Running setup.py install for mozleak 10:48:48 INFO - Running setup.py install for mozlog 10:48:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:48:48 INFO - Running setup.py install for moznetwork 10:48:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:48:49 INFO - Running setup.py install for mozprocess 10:48:49 INFO - Running setup.py install for mozprofile 10:48:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:48:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:48:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:48:49 INFO - Running setup.py install for mozrunner 10:48:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:48:49 INFO - Running setup.py install for mozscreenshot 10:48:49 INFO - Running setup.py install for moztest 10:48:49 INFO - Running setup.py install for mozversion 10:48:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:48:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:48:49 INFO - Cleaning up... 10:48:49 INFO - Return code: 0 10:48:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:49 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 0xe40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3b0>, '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 0x11002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:48:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:48:49 INFO - Using env: {'DISPLAY': ':0', 10:48:49 INFO - 'HOME': '/home/cltbld', 10:48:49 INFO - 'LANG': 'en_US.UTF-8', 10:48:49 INFO - 'LANGUAGE': 'en_US:en', 10:48:49 INFO - 'LOGNAME': 'cltbld', 10:48:49 INFO - 'MAIL': '/var/mail/cltbld', 10:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:49 INFO - 'MOZ_NO_REMOTE': '1', 10:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:49 INFO - 'NO_EM_RESTART': '1', 10:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:49 INFO - 'PWD': '/builds/slave/test', 10:48:49 INFO - 'SHELL': '/bin/bash', 10:48:49 INFO - 'SHLVL': '1', 10:48:49 INFO - 'TERM': 'linux', 10:48:49 INFO - 'TMOUT': '86400', 10:48:49 INFO - 'USER': 'cltbld', 10:48:49 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 10:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:49 INFO - '_': '/tools/buildbot/bin/python'} 10:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:48:49 INFO - Running setup.py (path:/tmp/pip-2KHu1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:48:50 INFO - Running setup.py (path:/tmp/pip-DScsMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:48:50 INFO - Running setup.py (path:/tmp/pip-bJejA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:48:50 INFO - Running setup.py (path:/tmp/pip-m_Eqjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:48:50 INFO - Running setup.py (path:/tmp/pip-qGyeSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:48:50 INFO - Running setup.py (path:/tmp/pip-CFYSM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:48:50 INFO - Running setup.py (path:/tmp/pip-L9CKgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:48:50 INFO - Running setup.py (path:/tmp/pip-Hs0bum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:48:50 INFO - Running setup.py (path:/tmp/pip-aXYPCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:48:50 INFO - Running setup.py (path:/tmp/pip-b61Dyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:48:50 INFO - Running setup.py (path:/tmp/pip-33au6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:48:50 INFO - Running setup.py (path:/tmp/pip-n5ANQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:48:50 INFO - Running setup.py (path:/tmp/pip-J2C6bG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:48:50 INFO - Running setup.py (path:/tmp/pip-5abOjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:48:51 INFO - Running setup.py (path:/tmp/pip-cpl7a1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:48:51 INFO - Running setup.py (path:/tmp/pip-B8hhUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:48:51 INFO - Running setup.py (path:/tmp/pip-vBStzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:48:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:48:53 INFO - Downloading blessings-1.6.tar.gz 10:48:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:48:53 INFO - Installing collected packages: blessings 10:48:53 INFO - Running setup.py install for blessings 10:48:53 INFO - Successfully installed blessings 10:48:53 INFO - Cleaning up... 10:48:53 INFO - Return code: 0 10:48:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:48:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:48:53 INFO - Reading from file tmpfile_stdout 10:48:53 INFO - Current package versions: 10:48:53 INFO - argparse == 1.2.1 10:48:53 INFO - blessings == 1.6 10:48:53 INFO - blobuploader == 1.2.4 10:48:53 INFO - docopt == 0.6.1 10:48:53 INFO - functools32 == 3.2.3-2 10:48:53 INFO - jsonschema == 2.5.1 10:48:53 INFO - manifestparser == 1.1 10:48:53 INFO - mozInstall == 1.12 10:48:53 INFO - mozcrash == 0.17 10:48:53 INFO - mozdebug == 0.1 10:48:53 INFO - mozdevice == 0.48 10:48:53 INFO - mozfile == 1.2 10:48:53 INFO - mozhttpd == 0.7 10:48:53 INFO - mozinfo == 0.9 10:48:53 INFO - mozleak == 0.1 10:48:53 INFO - mozlog == 3.3 10:48:53 INFO - moznetwork == 0.27 10:48:53 INFO - mozprocess == 0.23 10:48:53 INFO - mozprofile == 0.28 10:48:53 INFO - mozrunner == 6.12 10:48:53 INFO - mozscreenshot == 0.1 10:48:53 INFO - mozsystemmonitor == 0.3 10:48:53 INFO - moztest == 0.7 10:48:53 INFO - mozversion == 1.4 10:48:53 INFO - psutil == 3.1.1 10:48:53 INFO - requests == 1.2.3 10:48:53 INFO - wsgiref == 0.1.2 10:48:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:53 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 0xe40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3b0>, '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 0x11002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:48:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:48:53 INFO - Using env: {'DISPLAY': ':0', 10:48:53 INFO - 'HOME': '/home/cltbld', 10:48:53 INFO - 'LANG': 'en_US.UTF-8', 10:48:53 INFO - 'LANGUAGE': 'en_US:en', 10:48:53 INFO - 'LOGNAME': 'cltbld', 10:48:53 INFO - 'MAIL': '/var/mail/cltbld', 10:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:53 INFO - 'MOZ_NO_REMOTE': '1', 10:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:53 INFO - 'NO_EM_RESTART': '1', 10:48:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:53 INFO - 'PWD': '/builds/slave/test', 10:48:53 INFO - 'SHELL': '/bin/bash', 10:48:53 INFO - 'SHLVL': '1', 10:48:53 INFO - 'TERM': 'linux', 10:48:53 INFO - 'TMOUT': '86400', 10:48:53 INFO - 'USER': 'cltbld', 10:48:53 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 10:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:53 INFO - '_': '/tools/buildbot/bin/python'} 10:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:48:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:48:53 INFO - Cleaning up... 10:48:53 INFO - Return code: 0 10:48:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:48:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe40030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff3b0>, '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 0x11002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:48:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:48:53 INFO - Using env: {'DISPLAY': ':0', 10:48:53 INFO - 'HOME': '/home/cltbld', 10:48:53 INFO - 'LANG': 'en_US.UTF-8', 10:48:53 INFO - 'LANGUAGE': 'en_US:en', 10:48:53 INFO - 'LOGNAME': 'cltbld', 10:48:53 INFO - 'MAIL': '/var/mail/cltbld', 10:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:48:53 INFO - 'MOZ_NO_REMOTE': '1', 10:48:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:48:53 INFO - 'NO_EM_RESTART': '1', 10:48:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:48:53 INFO - 'PWD': '/builds/slave/test', 10:48:53 INFO - 'SHELL': '/bin/bash', 10:48:53 INFO - 'SHLVL': '1', 10:48:53 INFO - 'TERM': 'linux', 10:48:53 INFO - 'TMOUT': '86400', 10:48:53 INFO - 'USER': 'cltbld', 10:48:53 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 10:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:48:53 INFO - '_': '/tools/buildbot/bin/python'} 10:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:48:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:48:54 INFO - Cleaning up... 10:48:54 INFO - Return code: 0 10:48:54 INFO - Running post-action listener: _resource_record_post_action 10:48:54 INFO - Running post-action listener: _start_resource_monitoring 10:48:54 INFO - Starting resource monitoring. 10:48:54 INFO - [mozharness: 2016-08-05 17:48:54.042856Z] Finished create-virtualenv step (success) 10:48:54 INFO - [mozharness: 2016-08-05 17:48:54.043360Z] Running install step. 10:48:54 INFO - Running pre-action listener: _resource_record_pre_action 10:48:54 INFO - Running main action method: install 10:48:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:48:54 INFO - Reading from file tmpfile_stdout 10:48:54 INFO - Detecting whether we're running mozinstall >=1.0... 10:48:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:48:54 INFO - Reading from file tmpfile_stdout 10:48:54 INFO - Output received: 10:48:54 INFO - Usage: mozinstall [options] installer 10:48:54 INFO - Options: 10:48:54 INFO - -h, --help show this help message and exit 10:48:54 INFO - -d DEST, --destination=DEST 10:48:54 INFO - Directory to install application into. [default: 10:48:54 INFO - "/builds/slave/test"] 10:48:54 INFO - --app=APP Application being installed. [default: firefox] 10:48:54 INFO - mkdir: /builds/slave/test/build/application 10:48:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:49:10 INFO - Reading from file tmpfile_stdout 10:49:10 INFO - Output received: 10:49:10 INFO - /builds/slave/test/build/application/firefox/firefox 10:49:10 INFO - Running post-action listener: _resource_record_post_action 10:49:10 INFO - [mozharness: 2016-08-05 17:49:10.508745Z] Finished install step (success) 10:49:10 INFO - [mozharness: 2016-08-05 17:49:10.508995Z] Running run-tests step. 10:49:10 INFO - Running pre-action listener: _resource_record_pre_action 10:49:10 INFO - Running main action method: run_tests 10:49:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:49:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:49:10 INFO - Python 2.7.3 10:49:10 INFO - Return code: 0 10:49:10 INFO - grabbing minidump binary from tooltool 10:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:49:10 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 0x10ff3b0>, '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 0x11002b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1100740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:49:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:49:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:49:10 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:49:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:49:10 INFO - Return code: 0 10:49:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:49:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:49:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:49:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:49:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:49:10 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/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:49:10 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/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:49:10 INFO - Using env: {'DISPLAY': ':0', 10:49:10 INFO - 'HOME': '/home/cltbld', 10:49:10 INFO - 'LANG': 'en_US.UTF-8', 10:49:10 INFO - 'LANGUAGE': 'en_US:en', 10:49:10 INFO - 'LOGNAME': 'cltbld', 10:49:10 INFO - 'MAIL': '/var/mail/cltbld', 10:49:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:49:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:49:10 INFO - 'MOZ_NO_REMOTE': '1', 10:49:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:49:10 INFO - 'NO_EM_RESTART': '1', 10:49:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:49:10 INFO - 'PWD': '/builds/slave/test', 10:49:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:49:10 INFO - 'SHELL': '/bin/bash', 10:49:10 INFO - 'SHLVL': '1', 10:49:10 INFO - 'TERM': 'linux', 10:49:10 INFO - 'TMOUT': '86400', 10:49:10 INFO - 'USER': 'cltbld', 10:49:10 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637', 10:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:49:10 INFO - '_': '/tools/buildbot/bin/python'} 10:49:10 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/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:49:10 INFO - mozversion application_buildid: 20160805093133 10:49:10 INFO - mozversion application_changeset: 204a7ba2fba4bd74e715065492262cc6ffa8f8cf 10:49:10 INFO - mozversion application_display_name: Nightly 10:49:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:49:10 INFO - mozversion application_name: Firefox 10:49:10 INFO - mozversion application_remotingname: firefox 10:49:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:49:10 INFO - mozversion application_vendor: Mozilla 10:49:10 INFO - mozversion application_version: 51.0a1 10:49:10 INFO - mozversion platform_buildid: 20160805093133 10:49:10 INFO - mozversion platform_changeset: 204a7ba2fba4bd74e715065492262cc6ffa8f8cf 10:49:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:49:10 INFO - mozversion platform_version: 51.0a1 10:49:10 INFO - using testdate: 1470419350 10:49:10 INFO - actual date: 1470419350 10:49:10 INFO - starting webserver on 'localhost:48180' 10:49:10 INFO - SUITE-START | Running 2 tests 10:49:10 INFO - TEST-START | dromaeo_css 10:49:10 INFO - operating with platform_type : linux_ 10:49:10 INFO - Initialising browser for dromaeo_css test... 10:49:10 INFO - TEST-INFO | started process 5331 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIWf_h1/profile http://localhost:48180/getInfo.html) 10:49:15 INFO - PROCESS | 5331 | __metrics Screen width/height:1600/1200 10:49:15 INFO - PROCESS | 5331 | colorDepth:24 10:49:15 INFO - PROCESS | 5331 | Browser inner width/height: 1024/697 10:49:15 INFO - PROCESS | 5331 | __metrics 10:49:16 INFO - PROCESS | 5331 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:49:16 INFO - PROCESS | 5331 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:49:17 INFO - TEST-INFO | 5331: exit 0 10:49:17 INFO - Browser initialized. 10:49:17 INFO - Running cycle 1/1 for dromaeo_css test... 10:49:17 INFO - TEST-INFO | started process 5414 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIWf_h1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:49:29 INFO - PROCESS | 5414 | RSS: Main: 158191616 10:49:29 INFO - PROCESS | 5414 | 10:50:20 INFO - PROCESS | 5414 | 1470419420455 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:52:33 INFO - PROCESS | 5414 | Cycle 1(1): loaded http://localhost:48180/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48180/tests/dromaeo/cssquery-ext.html) 10:52:34 INFO - PROCESS | 5414 | RSS: Main: 243523584 10:52:34 INFO - PROCESS | 5414 | 10:55:37 INFO - PROCESS | 5414 | Cycle 1(1): loaded http://localhost:48180/tests/dromaeo/cssquery-ext.html (next: http://localhost:48180/tests/dromaeo/cssquery-jquery.html) 10:55:37 INFO - PROCESS | 5414 | RSS: Main: 243720192 10:55:37 INFO - PROCESS | 5414 | 10:58:40 INFO - PROCESS | 5414 | Cycle 1(1): loaded http://localhost:48180/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48180/tests/dromaeo/cssquery-mootools.html) 10:58:40 INFO - PROCESS | 5414 | RSS: Main: 222101504 10:58:40 INFO - PROCESS | 5414 | 11:01:42 INFO - PROCESS | 5414 | Cycle 1(1): loaded http://localhost:48180/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48180/tests/dromaeo/cssquery-prototype.html) 11:01:43 INFO - PROCESS | 5414 | RSS: Main: 213512192 11:01:43 INFO - PROCESS | 5414 | 11:04:46 INFO - PROCESS | 5414 | Cycle 1(1): loaded http://localhost:48180/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48180/tests/dromaeo/cssquery-yui.html) 11:04:47 INFO - PROCESS | 5414 | RSS: Main: 190148608 11:04:47 INFO - PROCESS | 5414 | 11:07:49 INFO - PROCESS | 5414 | Cycle 1(1): loaded http://localhost:48180/tests/dromaeo/cssquery-yui.html (next: http://localhost:48180/tests/dromaeo/cssquery-dojo.html) 11:07:50 INFO - PROCESS | 5414 | RSS: Main: 281776128 11:07:50 INFO - PROCESS | 5414 | 11:07:50 INFO - PROCESS | 5414 | __start_tp_report 11:07:50 INFO - PROCESS | 5414 | _x_x_mozilla_page_load 11:07:50 INFO - PROCESS | 5414 | _x_x_mozilla_page_load_details 11:07:50 INFO - PROCESS | 5414 | |i|pagename|runs| 11:07:50 INFO - PROCESS | 5414 | |0;dojo.html;2575.6265341525477;2598.6751656042993;2622.344413896526;2639.247814372904;2640.3003204150914;4604.654650901188;4686.08621318843;4784.8803779905475;4796.328514008037;4818.349522814424;4763.618910487161;4778.139934811741;4819.493953134923;4822.107910036646;4823.445303790065;4339.739615623057;4345.500267469234;4425.048614547872;4457.531959144292;4534.8639540813665;4486.349479325512;4525.683202175849;4535.546445355454;4546.97726511367;4561.064981678748;4261.74429534229;4311.698181127323;4319.24413227687;4353.673474489426;4391.67062470316;4341.110072435144;4349.565043495657;4351.912961740747;4388.034632380871;4441.777911104464;4390.165868484977;4397.692161548693;4413.227685155085;4427.535108813592;4448.043670610834;4696.694714843524;4700.130475861976;4755.762211889426;4762.595179409755;4808.471068182497;4993.400791904958;5168.586513078944;5213.6089793265655;5214.8174813881715;5218;5168.3797944246935;5198.220266959948;5203.947960520422;5214.478552144793;5238.319018527605;4640.69835460694;4741.312509686076;4801.735904525284;4849.75751212438;4900.901981960376;5254.500822421864;5280.471952804689;5305.31030965972;5320.361556613231;5322.54758345545;4986;4993.500649934977;4999.500049994971;5043.84868453947;5049.722265275372;4970.72661003641;5087.058894104529;5108.821191258363;5184.870378240575;5196.090684130262;5132.769025393866;5169.379674439091;5172.586193104543;5176.792928282902;5177.508136727005;5082.769411694359;5098.490150984871;5099.082165210298;5104.668196567211;5137.6660517066275;4314.395984562101;4431.822727090945;4439.489458712224;4439.800208990603;4479.440069991251;3768.2086761779783;3803.505544279226;3846.442265871433;3877.941830872539;3944.7041471889725;4368.301071828492;4368.7815609219415;4369.650427965755;4371.453568303962;4421.955780442218;5155.587552995751;5187.06632806091;5208.348956380452;5210.505002024802;5229.50319719626;4200.180964711852;4280.593343632412;4302.161078589645;4324.610785029299;4375.824967001285;4609.354690343354;4631.282151266559;4633.72197668141;4636.652251081183;4679.415073115861;4716.6698331116495;4717.268823332389;4721.1501929652995;4728.432588089451;4771.498992605726;4980.427250866197;5043.823466178666;5125.308083408841;5147.099257629975;5167.896642067062;4779.976100119617;4783.545563171493;4798.088363210979;4809.615230781459;4842.58837998774;5038.924416133834;5039.21892106724;5042.722650254272;5051.898962020666;5119.28330033803;4948.084604348207;5098.439171691037;5114.872128196825;5131.204663277049;5238.921416178837;4962.925556116589;4966.230234313687;4971.577415919687;4985.775640096277;5023.09584274834;5020.748962551785;5022.397312322545;5037.244413338029;5045.722485263199;5066.569341606005;4735.692180008288;4791.9281210782565;4816;4824.975875120602;4902.5587697106;4941.555260026615;4966.453690094159;4977.900441991067;4981.950180498294;4984.850454486371;4866.78099485531;4872.147374209429;4886.682365646222;4888.095702295087;4903.31353610502 11:07:50 INFO - PROCESS | 5414 | |1;ext.html;540.5783488878672;546.3525722019407;546.7594258526248;562.6033646279373;564.6583816790842;28882.277943051435;39851.2029759405;40309;40355.79822100885;43625.34561981565;40020.39969400461;40423.39364909521;40522.79738601303;40551.797241013825;40562.98592535181;7419.554826710388;7694;7835.451518393715;7846.450748447611;7846.960765196166;7463.888041679379;7720.961395193016;7728.188540203282;9767.169790567776;10112.494375281243;9933.602655893792;9957.55191016406;9972.950135249313;9986.450745209011;9990.050945160197;10060.899391006069;10132.898671013269;10139.493025348704;10139.49302534874;10145.44200068996;9938.15525680318;10012.098911097963;10015.549300281433;10016.298859079867;10019.348742331798;37588.43617345714;37925.24149516994;37940.62059379398;37965.240695185945;37970.24059518794;2944.6319210098736;2976.776741744356;2979.7616190704694;3025.243689077731;3031.8029328093826;28711.42577148466;28753.42493150146;29396.70603293961;29425.411491770257;32163.51754723681;3318.8008719476907;3319.13702437368;3348.933021339584;3412.590489141319;3426.194844211608;260933.69533152404;261284;263257;263668;267495;31463;50729.746351268004;51262.48737512652;51391.22913156231;52043;33545;33751.83124084364;33888.830555847555;33899.83050084734;33909.660903391145;13685.178889266675;13967.022308438514;13973.86026139746;13979.231142287272;13985.510507132201;10850.403227822388;10920.344779313267;10944;10945.671629851116;10949.945250273857;7208.891866622005;7566.31903128721;7786.18245084258;7841.490303130278;7966.243206895336;3037;3090.2119959410206;3098.9225269367994;3138.9686103139134;3143.6070491188602;931.1619542411748;946.6923249943658;961.8364877970762;976.272676855747;1005.7183988483237;26866.462670746474;27417.725822741915;27440;27440.17679469619;27824.860875695493;960.6138362272904;995.6664517386612;999.6351331763999;1000.949952502372;1024.6106479537727;14323.641908952359;14825.33286002111;15125.848741512664;15140.955970944002;15317.31072101758;394743;720987.9753006112;739430;740963;741956;49067.75466122646;49283.50716492861;49651.25523117156;49681.50318496841;49702.25446618304;1109.9389533575732;1178.6876477733408;1196.5094311332311;1200.3458115327167;1203.1157099531838;25024;28495;28807.56788648214;28937.56593651055;29222.707772922;40065;40682.59317406788;40749.79625101855;40760.184796303314;40894.79552602218;320096;321932;322832;322871;323264;25121.87439062793;25135.497290054464;25489.23532294034;25506.489870202862;25509;31950.84178448393;35474.290514190085;36397;37646.43530346992;37935;33035.504467433486;35722.642773572974;35863.171834785906;36515.26969460543;37013;34890;35155.296894062485;35207.64792352044;35422.645773542965;35466.8226658865;30920;31539.52690709687;31577.842110789297;31868;34715.652843471245;30982.380352392374;31909.36181276408;32345.838270808494;32576.83711581427;32904.83547582247;24814.875925620257;25256.242312730647;25351.492970140123;25524;25732.228033159034 11:07:50 INFO - PROCESS | 5414 | |2;jquery.html;359.2886085550609;360.2596663855776;367.4433233651019;385.39108209029735;386.9899562142809;16915;17384.21771020304;18074.81925180748;18137.093145342747;18182.636347273048;16783.412580559652;17010.319587216498;17086.743698844526;17238.82761172391;17305.567360815985;4394.758288294142;4577.839775607855;4597.08058388322;4600.953990460102;4608.28571571407;4502.16709908668;4566.84016059438;4567.566081222295;5006.22403527452;5269.314989051418;5285.86785330366;5299.046171689094;5346.198070289449;5350.705711185883;5351.625386222966;5340.813071542497;5348.572114230852;5381.623286369975;5937.910931336033;6002.309734380515;5291.444398338196;5318.149096144598;5325.440828712968;5326.360836699582;5326.76029578666;10565.947170264177;16597.83402165975;21377.78622213789;21409.892950535148;21542.784572154236;1907.9427617171507;1913.425972208332;1923.2979962313655;2003.6092961872441;2202.5925203837182;8715.651373945035;8852.822943541158;8979.102089791035;9376.671816486458;9438.811223775487;1672.4898905833716;1694.4069575648548;1714.554215903874;1773.733939909011;1822.8177182281665;67468.6626566869;69338;74905.62547187283;75852.24147758506;78085.60957195178;9780.657676981271;10190.337628054152;10310.082168775967;10332.483375831178;10360.119389851947;13846.93076534611;14020.158790472604;14040.719185616435;14046.227457489937;14070.366833492517;7365.889511657329;7480.326770590673;7499.2500749924575;7509.286617771303;7574.469787114959;6986.558680750391;7118.145822501333;7191.352778249878;7262.288775117664;7375.8156046099275;4134.152498737752;4171.164687537474;4332.740035597874;4385.9692972151515;4477.955220447819;1699.7110491216522;1794.1298470241923;1840;1840.8895466272068;1846.3906910719431;827.1149869639428;838.4298676899766;862.857628491292;881.2773525708857;930.6649606141783;16853.241604127845;17734.645307093786;17834.19746111428;17909.462716118538;18158.5460363492;817.7424111404888;842.5660784695887;849.5964416901923;853.7140058080613;894.5974311559825;9229.49237791928;9871.457069861226;9981.201503879673;10009.099181073738;10034.891835310478;401595;401720;404704;420914;423458;77301.22698773052;77320.61339693378;77764.61117694376;79282;80142.59928700319;870.4559650218613;885.2431171348533;888.2938064238816;888.560162719458;890.3278025091015;15496.380144794082;15736.449224277096;15855.68288634244;16326.510204693877;16408.26162822652;37183.07042323964;38334;38904;38929;39132.217355653294;50895.491045089075;51776.22335664893;52008;52861.7356913213;53875;6534.346565343618;6824.590524568542;6939.89590156138;7230.240824713329;7386.4090872728975;11589.24669896454;12299.139060266054;12342.876571234172;12477.627460979467;12549.435275412447;9942.900570994198;10126.038026387481;10126.44304563256;10306.12397946153;10514.526846291783;10033.14718248957;10133.18934485254;10430.68707938763;10705.250632455653;10821.9458902705;9746;9966.60133594677;9977.45124018186;10342;10385.896141038493;6889.621070841152;6968.0941477607585;7080.645967701697;7088.929110708827;7482.551046937201;7561.584112873845;9970.252231082843;10296.639617613348;10363.844542332023;10458.738531536772 11:07:50 INFO - PROCESS | 5414 | |3;mootools.html;1254.7553227120716;1302.4594793160838;1386.362273354257;1396.6508372906774;1715.6225630361323;6444.130042444269;7215.278472152789;7522.022137122167;7548.584827834474;7716.459847810655;7579.052618422697;7622.84754304915;7637.3890088792905;7641.61791910405;7643.46495745298;2134.0290167973612;2156.1914282144194;2157.4282815054025;2161.135545781684;2163.0374483354913;2097.8426618003637;2141.967870481944;2143.2498625481035;2156.7196264485674;2161.5244646177894;2111.5037966077957;2137;2140.1867290429614;2143.046344376753;2143.9387503185944;2084.6143463459234;2086.019570801721;2090.822280106193;2091.205341970049;2091.633964056284;2022;2100.453881990678;2104.5475222827167;2106.5049713317358;2112.6830975353664;7128.536645118051;7134.286571342876;7167.569945803269;7572.924270757277;7640.083190017178;4281.593248641374;4456.844010459651;4458.331250312447;4506.008678090815;4508.661850361236;2697.4200546882516;2779.652543432071;2832.730890565393;2833.943321133566;2833.9433211335863;969.3892847506097;972.6644307713827;979.3340528440657;993.344392700814;996.4220751963916;10507.369557826554;10535.10451611614;10560.841587376195;10564.471776411148;10565.101966332793;3799.4490798834568;3880.9223815524097;3980.44273801668;3983.721139520264;4008.07814202735;8540.786480337916;8546.948732304203;8547.786305342415;8553.700620478254;8562.443441176303;4510.188166130062;4513;4517.774111294422;4521.163584736834;4521.84173553924;3450.7929524228125;3902.239063382613;4019.91960160801;4150.066235097079;4153.231652144363;3351;3375.2236985493473;3463;3469.930601387958;3478.6869181773764;994.4878387630376;995.4176806568094;998.0518507417981;1013.2723706081114;1015.5785349080197;767.1101522234181;779.2597032818845;798.0941631248575;803.6102490292203;804.3565147881671;4761.35721677576;4832;4837.346958160603;4932.334134891744;5047.621428392885;404.244063601062;407.1368698359497;878.4377998081233;904.5341649050744;925.634374422113;3219.6780321967617;3239.400710868497;3244.837758112085;3310.519974603669;3354.329134173175;9541.809163816684;9733.610655573697;9833.901660983442;9839;9853.655122070693;9723.854142187873;9742.95128524353;9762.609495620096;9782.266330025277;9785.608575657036;7269.127704675367;7370.410367170613;7375.4099672026105;7378.40972722181;7387.926120738832;4884.242942343943;4889.608831293559;4978.850634480971;5078.289039534542;5093.1341671915125;8835.779105522413;8886.37795354319;8904.777380565538;8949.32880033987;9146.771330716785;8949.418287811272;9192.494412807093;9218.308626852879;9244.95377523135;9253.76865578339;5867.20792692981;6343;6498.675066246763;6677.732890684319;6751.223609284799;7122.145342558926;7387.445941554298;7390.334869861738;7401.925980740339;7402.4078073755045;6550.148480697479;6570.310117437601;6607.438367738796;6743.629100399525;6785.830354241183;6389.233292004989;6458.903116453163;6464.385883341075;6467.094606755152;6480.287168411377;5796.333421656564;5898.587098903207;5899.67551784656;5902;5902.026165682614;4008.4388185654616;4082.408050832672;4098.4876890388705;4123.793810309532;4207.179599977975;4170.35359519275;4275.978620106879;4289.077848262638;4334.826606935687;4379.233634114081 11:07:50 INFO - PROCESS | 5414 | |4;prototype.html;290.15709364296714;298.1740578597285;303.65990091097973;305.37703085705164;307.4895673182515;4755.738434386108;4795.664303498756;4802;4817.530653150788;4825;4505.57197066279;4510.669352541;4652.767361631922;4657.720536767788;4773.90452190956;3739.4764732937274;3744.157564547982;3766.736328457009;3767.8116094195248;3777.8488860445686;3741.850325986957;3747.5690295615946;3762.3792074307707;3770.8868733938025;3775.6413140751583;3579.123114836869;3610.476480910266;3742.120601658608;3744.756590821588;3749.1189570450924;3728.4780130781714;3752.887413377603;3759.4360845873066;3761.511003569532;3762.529683789526;3327.683870032343;3340.9498857517156;3346.4311067118406;3351.2124650707065;3353.111425472252;4418.4256046714045;4601.4248218972625;4611;4612.930806037912;4639.280911458729;4093.488313960755;4174.728642638249;4177.791110444466;4179.707420480568;4191.517975432834;4971.254311853215;4992.575631071363;4992.850214493571;4997.201007637248;5005.6496045276845;3505.7896526208256;3514.7715398499017;3515.6132825389186;3518;3520.1551627609447;4955.554000139969;5152.793888244466;5206.641716093137;5211.140161873286;5231.398389185217;3618.493410922473;3631.3463576555946;3631.9648900063357;3638.599754027055;3642.5993140754495;3682.127940206643;3682.5765037021088;3682.9447558286647;3685.1155722626913;3686.4101743720876;3978.2839088963688;4195.699333206655;4195.741277616703;4208.6633069354375;4230.048239146229;4944.90110197794;4979.402471703419;4998.90002199954;5013.348264725635;5014.548690617862;1266.4554241675983;1279.7888348422591;1280.647821848999;1284.2358796516057;1284.8072789081712;813.5281536708695;813.5850716134814;846.9449485783405;872.6683860133109;884.5930871799045;4334.523202447728;4336.696431249782;4337.652987760972;4341.305391137403;4344.3049112142535;5083.415407228142;5100.821471248562;5109.9744501277255;5112.182050871843;5124.231365295235;4236.894077648022;4339.522652508222;4340.782960851945;4345.217860785026;4347.217500849814;2682.4903268378944;2699.892004319805;2708;2710.1869439168563;2718.891244350204;4709.364235828188;4718.103560323528;4721.409823772028;4733.408323959505;4738.763061846894;5003.974980125076;5198.948010519922;5204.34945631796;5215.6609820361555;5284.07528682479;4844.249141383091;4849.951500485021;4850.393700787402;4856.223004319292;4862.80548778052;5216.2175673647735;5221.582273418194;5226.242194881797;5227.320448341691;5239.266502689703;4934.62990275738;5098.1588037973315;5110.97444512775;5138.3577052868395;5150.922736159036;4836.081144582518;4843;4846.36997190363;4855.198892182751;4857.222844344888;3663.3405986922608;3682.9079273018388;3682.963170368369;3685.852565897334;3690.8154592269743;4949.505049495022;5191.32646686949;5217.947820521898;5221;5226.555742761908;5057.620678449058;5065.645404821775;5078.796848126033;5085.389753229636;5086.949130508796;5035.313170088061;5078.466760990191;5084.51697088776;5087.694738315713;5091.92362114576;4756.9524304756505;4910.042541704333;4976.154053810788;4978.975105124451;4990.900181996412;4821.927671084866;4924.162892308244;5059.418166910852;5063.670861393997;5070.73231692077;4897.804087836589;4936.703797772145;4941.234108713155;4953.182724850503;4954.702717836942 11:07:50 INFO - PROCESS | 5414 | |5;yui.html;604.4515024441081;623.3174673732267;643.314869663808;728.7158008376731;751.4063889527274;12678.556250531234;13532.458701651922;13547.119437236584;13570.117942333742;13579.185248885049;13718.176909385444;13854.792178117312;13874.653133671663;13884.097533660304;13889.861101388982;619.7644894939916;630.1021045010841;751.5828715063151;754.9660265288048;766.2950085920966;773.8839174123871;774.9147593764682;776.1229810314337;776.1888826176659;776.2741836383;823.1521532821204;824.3034635732796;824.431142511668;824.5712229640583;824.7649419915325;655.7606473637112;786.3826895886758;806.4959400374765;810.2302812328312;816.008549612221;587.647411553069;588.814523425124;589.3723184808208;589.4783116941495;590.9982579527702;13533.052686311961;13567.864321356858;13581.52464663742;13589.048766586342;13599.388027538784;12916.677083072904;13193.274369909652;13391.196528208242;13453;13847.446102155902;11537.423128843524;11841.703957401047;11870.465829037714;12205.572804951873;12362.690932726664;4087.652549533293;4092.5498195198506;4117.3206420940805;4212.094399704079;4227.070044590216;55792.721036394556;57192.42807571912;57320;67485.66257168683;68099.63800723958;10300.22748293881;10481.318714283547;10499.580016799395;10529.684109476575;10546.367217966947;18443.07784610764;18545.907270463562;18635.534111647317;18636.813631863508;18731.719024214646;6278.6860656966965;6358.1416508771645;6929.792106236821;7211.098612673416;7217.097862767154;3726.496922915426;3733.104055026774;3745.176061266517;3759.473673685686;3806.371948628501;2723.319170207448;2819.647544056993;2839.4463079699262;2840.5881147233536;2843.303390669258;469.8214678422246;486.7931129270117;488.0507413081522;499.83005778034914;502.22406382139684;488.8582311129804;500.0998203234164;501.6237821633775;510.316176323728;522.5767128625749;7586.582737949466;7903.211333885048;7925.207479252144;8050.838983220303;8119.79700507492;514.8352527191338;524.4964833759557;531.8936611847348;532.2548432194958;555.5611067256822;3582.7133829293593;3835.827387767557;3865.381538953754;3909.9609003910164;3989.8204580793354;58432;58553;58688;98621;102950;53272.73363633235;71432;87982.1201787974;88092;88558;49672;59613.10580341298;80724;85207.72188417178;85756.57121714352;7490.737824176128;7783.455158138876;7814.6874125034365;7875.094364147967;7876.015498062742;34465.898069172894;49050;49319.26021109758;49937.75031124821;50073.24890126724;38117.04707382338;40858.38712419375;42348.85941538521;43834.56165438432;52699.47300527099;9181.586828592595;9297.953510232406;9301.627934882528;9439;9506.287028472754;10455.268131230741;10532.578696852346;10648.680539583826;10743.140548756237;10919.181061420266;8870.911290887008;8923.107689231285;9086;9294.488803115893;9360.15758581731;9120.407173533698;9565.091316324939;9618.807623847624;9649.276304277348;9700.320977531504;9294.953525232331;9447.905520944703;9616.423014619146;9685.854712179182;9985.850212246967;7382.52013619113;7492.175860655215;7961.522308661499;7975.042994840656;8126.431149819456;7767.72812951544;8364.205400486944;8551.657933682833;8571.699990500552;8639.827203456021 11:07:50 INFO - PROCESS | 5414 | __end_tp_report 11:07:50 INFO - PROCESS | 5414 | __start_cc_report 11:07:50 INFO - PROCESS | 5414 | _x_x_mozilla_cycle_collect,995 11:07:50 INFO - PROCESS | 5414 | __end_cc_report 11:07:50 INFO - PROCESS | 5414 | __startTimestamp1470420470168__endTimestamp 11:07:50 INFO - PROCESS | 5414 | 11:07:50 INFO - PROCESS | 5414 | ------- Summary: start ------- 11:07:50 INFO - PROCESS | 5414 | Number of tests: 6 11:07:50 INFO - PROCESS | 5414 | 11:07:50 INFO - PROCESS | 5414 | [#0] dojo.html Cycles:165 Average:4729.54 Median:4819.49 stddev:506.40 (10.5%) stddev-sans-first:478.93 11:07:50 INFO - PROCESS | 5414 | Values: 2575.6 2598.7 2622.3 2639.2 2640.3 4604.7 4686.1 4784.9 4796.3 4818.3 4763.6 4778.1 4819.5 4822.1 4823.4 4339.7 4345.5 4425.0 4457.5 4534.9 4486.3 4525.7 4535.5 4547.0 4561.1 4261.7 4311.7 4319.2 4353.7 4391.7 4341.1 4349.6 4351.9 4388.0 4441.8 4390.2 4397.7 4413.2 4427.5 4448.0 4696.7 4700.1 4755.8 4762.6 4808.5 4993.4 5168.6 5213.6 5214.8 5218.0 5168.4 5198.2 5203.9 5214.5 5238.3 4640.7 4741.3 4801.7 4849.8 4900.9 5254.5 5280.5 5305.3 5320.4 5322.5 4986.0 4993.5 4999.5 5043.8 5049.7 4970.7 5087.1 5108.8 5184.9 5196.1 5132.8 5169.4 5172.6 5176.8 5177.5 5082.8 5098.5 5099.1 5104.7 5137.7 4314.4 4431.8 4439.5 4439.8 4479.4 3768.2 3803.5 3846.4 3877.9 3944.7 4368.3 4368.8 4369.7 4371.5 4422.0 5155.6 5187.1 5208.3 5210.5 5229.5 4200.2 4280.6 4302.2 4324.6 4375.8 4609.4 4631.3 4633.7 4636.7 4679.4 4716.7 4717.3 4721.2 4728.4 4771.5 4980.4 5043.8 5125.3 5147.1 5167.9 4780.0 4783.5 4798.1 4809.6 4842.6 5038.9 5039.2 5042.7 5051.9 5119.3 4948.1 5098.4 5114.9 5131.2 5238.9 4962.9 4966.2 4971.6 4985.8 5023.1 5020.7 5022.4 5037.2 5045.7 5066.6 4735.7 4791.9 4816.0 4825.0 4902.6 4941.6 4966.5 4977.9 4982.0 4984.9 4866.8 4872.1 4886.7 4888.1 4903.3 11:07:50 INFO - PROCESS | 5414 | 11:07:50 INFO - PROCESS | 5414 | [#1] ext.html Cycles:180 Average:54310.99 Median:18177.15 stddev:124413.53 (684.5%) stddev-sans-first:124697.05 11:07:50 INFO - PROCESS | 5414 | Values: 540.6 546.4 546.8 562.6 564.7 28882.3 39851.2 40309.0 40355.8 43625.3 40020.4 40423.4 40522.8 40551.8 40563.0 7419.6 7694.0 7835.5 7846.5 7847.0 7463.9 7721.0 7728.2 9767.2 10112.5 9933.6 9957.6 9973.0 9986.5 9990.1 10060.9 10132.9 10139.5 10139.5 10145.4 9938.2 10012.1 10015.5 10016.3 10019.3 37588.4 37925.2 37940.6 37965.2 37970.2 2944.6 2976.8 2979.8 3025.2 3031.8 28711.4 28753.4 29396.7 29425.4 32163.5 3318.8 3319.1 3348.9 3412.6 3426.2 260933.7 261284.0 263257.0 263668.0 267495.0 31463.0 50729.7 51262.5 51391.2 52043.0 33545.0 33751.8 33888.8 33899.8 33909.7 13685.2 13967.0 13973.9 13979.2 13985.5 10850.4 10920.3 10944.0 10945.7 10949.9 7208.9 7566.3 7786.2 7841.5 7966.2 3037.0 3090.2 3098.9 3139.0 3143.6 931.2 946.7 961.8 976.3 1005.7 26866.5 27417.7 27440.0 27440.2 27824.9 960.6 995.7 999.6 1000.9 1024.6 14323.6 14825.3 15125.8 15141.0 15317.3 394743.0 720988.0 739430.0 740963.0 741956.0 49067.8 49283.5 49651.3 49681.5 49702.3 1109.9 1178.7 1196.5 1200.3 1203.1 25024.0 28495.0 28807.6 28937.6 29222.7 40065.0 40682.6 40749.8 40760.2 40894.8 320096.0 321932.0 322832.0 322871.0 323264.0 25121.9 25135.5 25489.2 25506.5 25509.0 31950.8 35474.3 36397.0 37646.4 37935.0 33035.5 35722.6 35863.2 36515.3 37013.0 34890.0 35155.3 35207.6 35422.6 35466.8 30920.0 31539.5 31577.8 31868.0 34715.7 30982.4 31909.4 32345.8 32576.8 32904.8 24814.9 25256.2 25351.5 25524.0 25732.2 11:07:50 INFO - PROCESS | 5414 | 11:07:50 INFO - PROCESS | 5414 | [#2] jquery.html Cycles:180 Average:25068.76 Median:4490.06 stddev:67811.67 (1510.3%) stddev-sans-first:67976.52 11:07:50 INFO - PROCESS | 5414 | Values: 359.3 360.3 367.4 385.4 387.0 16915.0 17384.2 18074.8 18137.1 18182.6 16783.4 17010.3 17086.7 17238.8 17305.6 4394.8 4577.8 4597.1 4601.0 4608.3 4502.2 4566.8 4567.6 5006.2 5269.3 5285.9 5299.0 5346.2 5350.7 5351.6 5340.8 5348.6 5381.6 5937.9 6002.3 5291.4 5318.1 5325.4 5326.4 5326.8 10565.9 16597.8 21377.8 21409.9 21542.8 1907.9 1913.4 1923.3 2003.6 2202.6 8715.7 8852.8 8979.1 9376.7 9438.8 1672.5 1694.4 1714.6 1773.7 1822.8 67468.7 69338.0 74905.6 75852.2 78085.6 9780.7 10190.3 10310.1 10332.5 10360.1 13846.9 14020.2 14040.7 14046.2 14070.4 7365.9 7480.3 7499.3 7509.3 7574.5 6986.6 7118.1 7191.4 7262.3 7375.8 4134.2 4171.2 4332.7 4386.0 4478.0 1699.7 1794.1 1840.0 1840.9 1846.4 827.1 838.4 862.9 881.3 930.7 16853.2 17734.6 17834.2 17909.5 18158.5 817.7 842.6 849.6 853.7 894.6 9229.5 9871.5 9981.2 10009.1 10034.9 401595.0 401720.0 404704.0 420914.0 423458.0 77301.2 77320.6 77764.6 79282.0 80142.6 870.5 885.2 888.3 888.6 890.3 15496.4 15736.4 15855.7 16326.5 16408.3 37183.1 38334.0 38904.0 38929.0 39132.2 50895.5 51776.2 52008.0 52861.7 53875.0 6534.3 6824.6 6939.9 7230.2 7386.4 11589.2 12299.1 12342.9 12477.6 12549.4 9942.9 10126.0 10126.4 10306.1 10514.5 10033.1 10133.2 10430.7 10705.3 10821.9 9746.0 9966.6 9977.5 10342.0 10385.9 6889.6 6968.1 7080.6 7088.9 7482.6 7561.6 9970.3 10296.6 10363.8 10458.7 11:07:50 INFO - PROCESS | 5414 | 11:07:50 INFO - PROCESS | 5414 | [#3] mootools.html Cycles:180 Average:4976.82 Median:5013.24 stddev:2873.21 (57.3%) stddev-sans-first:2867.66 11:07:50 INFO - PROCESS | 5414 | Values: 1254.8 1302.5 1386.4 1396.7 1715.6 6444.1 7215.3 7522.0 7548.6 7716.5 7579.1 7622.8 7637.4 7641.6 7643.5 2134.0 2156.2 2157.4 2161.1 2163.0 2097.8 2142.0 2143.2 2156.7 2161.5 2111.5 2137.0 2140.2 2143.0 2143.9 2084.6 2086.0 2090.8 2091.2 2091.6 2022.0 2100.5 2104.5 2106.5 2112.7 7128.5 7134.3 7167.6 7572.9 7640.1 4281.6 4456.8 4458.3 4506.0 4508.7 2697.4 2779.7 2832.7 2833.9 2833.9 969.4 972.7 979.3 993.3 996.4 10507.4 10535.1 10560.8 10564.5 10565.1 3799.4 3880.9 3980.4 3983.7 4008.1 8540.8 8546.9 8547.8 8553.7 8562.4 4510.2 4513.0 4517.8 4521.2 4521.8 3450.8 3902.2 4019.9 4150.1 4153.2 3351.0 3375.2 3463.0 3469.9 3478.7 994.5 995.4 998.1 1013.3 1015.6 767.1 779.3 798.1 803.6 804.4 4761.4 4832.0 4837.3 4932.3 5047.6 404.2 407.1 878.4 904.5 925.6 3219.7 3239.4 3244.8 3310.5 3354.3 9541.8 9733.6 9833.9 9839.0 9853.7 9723.9 9743.0 9762.6 9782.3 9785.6 7269.1 7370.4 7375.4 7378.4 7387.9 4884.2 4889.6 4978.9 5078.3 5093.1 8835.8 8886.4 8904.8 8949.3 9146.8 8949.4 9192.5 9218.3 9245.0 9253.8 5867.2 6343.0 6498.7 6677.7 6751.2 7122.1 7387.4 7390.3 7401.9 7402.4 6550.1 6570.3 6607.4 6743.6 6785.8 6389.2 6458.9 6464.4 6467.1 6480.3 5796.3 5898.6 5899.7 5902.0 5902.0 4008.4 4082.4 4098.5 4123.8 4207.2 4170.4 4276.0 4289.1 4334.8 4379.2 11:07:50 INFO - PROCESS | 5414 | 11:07:50 INFO - PROCESS | 5414 | [#4] prototype.html Cycles:180 Average:4145.64 Median:4719.76 stddev:1203.76 (25.5%) stddev-sans-first:1171.84 11:07:50 INFO - PROCESS | 5414 | Values: 290.2 298.2 303.7 305.4 307.5 4755.7 4795.7 4802.0 4817.5 4825.0 4505.6 4510.7 4652.8 4657.7 4773.9 3739.5 3744.2 3766.7 3767.8 3777.8 3741.9 3747.6 3762.4 3770.9 3775.6 3579.1 3610.5 3742.1 3744.8 3749.1 3728.5 3752.9 3759.4 3761.5 3762.5 3327.7 3340.9 3346.4 3351.2 3353.1 4418.4 4601.4 4611.0 4612.9 4639.3 4093.5 4174.7 4177.8 4179.7 4191.5 4971.3 4992.6 4992.9 4997.2 5005.6 3505.8 3514.8 3515.6 3518.0 3520.2 4955.6 5152.8 5206.6 5211.1 5231.4 3618.5 3631.3 3632.0 3638.6 3642.6 3682.1 3682.6 3682.9 3685.1 3686.4 3978.3 4195.7 4195.7 4208.7 4230.0 4944.9 4979.4 4998.9 5013.3 5014.5 1266.5 1279.8 1280.6 1284.2 1284.8 813.5 813.6 846.9 872.7 884.6 4334.5 4336.7 4337.7 4341.3 4344.3 5083.4 5100.8 5110.0 5112.2 5124.2 4236.9 4339.5 4340.8 4345.2 4347.2 2682.5 2699.9 2708.0 2710.2 2718.9 4709.4 4718.1 4721.4 4733.4 4738.8 5004.0 5198.9 5204.3 5215.7 5284.1 4844.2 4850.0 4850.4 4856.2 4862.8 5216.2 5221.6 5226.2 5227.3 5239.3 4934.6 5098.2 5111.0 5138.4 5150.9 4836.1 4843.0 4846.4 4855.2 4857.2 3663.3 3682.9 3683.0 3685.9 3690.8 4949.5 5191.3 5217.9 5221.0 5226.6 5057.6 5065.6 5078.8 5085.4 5086.9 5035.3 5078.5 5084.5 5087.7 5091.9 4757.0 4910.0 4976.2 4979.0 4990.9 4821.9 4924.2 5059.4 5063.7 5070.7 4897.8 4936.7 4941.2 4953.2 4954.7 11:07:50 INFO - PROCESS | 5414 | 11:07:50 INFO - PROCESS | 5414 | [#5] yui.html Cycles:180 Average:16092.76 Median:57876.00 stddev:22760.05 (39.3%) stddev-sans-first:22794.19 11:07:50 INFO - PROCESS | 5414 | Values: 604.5 623.3 643.3 728.7 751.4 12678.6 13532.5 13547.1 13570.1 13579.2 13718.2 13854.8 13874.7 13884.1 13889.9 619.8 630.1 751.6 755.0 766.3 773.9 774.9 776.1 776.2 776.3 823.2 824.3 824.4 824.6 824.8 655.8 786.4 806.5 810.2 816.0 587.6 588.8 589.4 589.5 591.0 13533.1 13567.9 13581.5 13589.0 13599.4 12916.7 13193.3 13391.2 13453.0 13847.4 11537.4 11841.7 11870.5 12205.6 12362.7 4087.7 4092.5 4117.3 4212.1 4227.1 55792.7 57192.4 57320.0 67485.7 68099.6 10300.2 10481.3 10499.6 10529.7 10546.4 18443.1 18545.9 18635.5 18636.8 18731.7 6278.7 6358.1 6929.8 7211.1 7217.1 3726.5 3733.1 3745.2 3759.5 3806.4 2723.3 2819.6 2839.4 2840.6 2843.3 469.8 486.8 488.1 499.8 502.2 488.9 500.1 501.6 510.3 522.6 7586.6 7903.2 7925.2 8050.8 8119.8 514.8 524.5 531.9 532.3 555.6 3582.7 3835.8 3865.4 3910.0 3989.8 58432.0 58553.0 58688.0 98621.0 102950.0 53272.7 71432.0 87982.1 88092.0 88558.0 49672.0 59613.1 80724.0 85207.7 85756.6 7490.7 7783.5 7814.7 7875.1 7876.0 34465.9 49050.0 49319.3 49937.8 50073.2 38117.0 40858.4 42348.9 43834.6 52699.5 9181.6 9298.0 9301.6 9439.0 9506.3 10455.3 10532.6 10648.7 10743.1 10919.2 8870.9 8923.1 9086.0 9294.5 9360.2 9120.4 9565.1 9618.8 9649.3 9700.3 9295.0 9447.9 9616.4 9685.9 9985.9 7382.5 7492.2 7961.5 7975.0 8126.4 7767.7 8364.2 8551.7 8571.7 8639.8 11:07:50 INFO - PROCESS | 5414 | -------- Summary: end -------- 11:07:50 INFO - PROCESS | 5414 | 11:07:51 INFO - TEST-INFO | 5414: exit 0 11:07:51 INFO - TEST-OK | dromaeo_css | took 1120254ms 11:07:51 INFO - TEST-START | kraken 11:07:51 INFO - operating with platform_type : linux_ 11:07:51 INFO - Initialising browser for kraken test... 11:07:51 INFO - TEST-INFO | started process 5718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPHBYfs/profile http://localhost:48180/getInfo.html) 11:07:55 INFO - PROCESS | 5718 | __metrics Screen width/height:1600/1200 11:07:55 INFO - PROCESS | 5718 | colorDepth:24 11:07:55 INFO - PROCESS | 5718 | Browser inner width/height: 1024/697 11:07:55 INFO - PROCESS | 5718 | __metrics 11:07:56 INFO - PROCESS | 5718 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:07:56 INFO - PROCESS | 5718 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:07:57 INFO - TEST-INFO | 5718: exit 0 11:07:57 INFO - Browser initialized. 11:07:57 INFO - Running cycle 1/1 for kraken test... 11:07:57 INFO - TEST-INFO | started process 5798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPHBYfs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:08:09 INFO - PROCESS | 5798 | RSS: Main: 157696000 11:08:09 INFO - PROCESS | 5798 | 11:08:12 INFO - PROCESS | 5798 | Cycle 1(1): loaded http://localhost:48180/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48180/tests/kraken/driver.html?testName=audio-beat-detection) 11:08:12 INFO - PROCESS | 5798 | RSS: Main: 213733376 11:08:12 INFO - PROCESS | 5798 | 11:08:15 INFO - PROCESS | 5798 | Cycle 1(1): loaded http://localhost:48180/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48180/tests/kraken/driver.html?testName=audio-dft) 11:08:16 INFO - PROCESS | 5798 | RSS: Main: 191766528 11:08:16 INFO - PROCESS | 5798 | 11:08:19 INFO - PROCESS | 5798 | Cycle 1(1): loaded http://localhost:48180/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48180/tests/kraken/driver.html?testName=audio-fft) 11:08:20 INFO - PROCESS | 5798 | RSS: Main: 272617472 11:08:20 INFO - PROCESS | 5798 | 11:08:22 INFO - PROCESS | 5798 | Cycle 1(1): loaded http://localhost:48180/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48180/tests/kraken/driver.html?testName=audio-oscillator) 11:08:22 INFO - PROCESS | 5798 | RSS: Main: 181428224 11:08:22 INFO - PROCESS | 5798 | 11:08:25 INFO - PROCESS | 5798 | Cycle 1(1): loaded http://localhost:48180/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48180/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:08:25 INFO - PROCESS | 5798 | RSS: Main: 185503744 11:08:25 INFO - PROCESS | 5798 | 11:08:28 INFO - PROCESS | 5798 | Cycle 1(1): loaded http://localhost:48180/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48180/tests/kraken/driver.html?testName=imaging-darkroom) 11:08:29 INFO - PROCESS | 5798 | RSS: Main: 221872128 11:08:29 INFO - PROCESS | 5798 | 11:08:33 INFO - PROCESS | 5798 | Cycle 1(1): loaded http://localhost:48180/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48180/tests/kraken/driver.html?testName=imaging-desaturate) 11:08:33 INFO - PROCESS | 5798 | RSS: Main: 221396992 11:08:33 INFO - PROCESS | 5798 | 11:08:36 INFO - PROCESS | 5798 | Cycle 1(1): loaded http://localhost:48180/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48180/tests/kraken/driver.html?testName=json-parse-financial) 11:08:37 INFO - PROCESS | 5798 | RSS: Main: 220991488 11:08:37 INFO - PROCESS | 5798 | 11:08:38 INFO - PROCESS | 5798 | Cycle 1(1): loaded http://localhost:48180/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48180/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:08:39 INFO - PROCESS | 5798 | RSS: Main: 185798656 11:08:39 INFO - PROCESS | 5798 | 11:08:41 INFO - PROCESS | 5798 | Cycle 1(1): loaded http://localhost:48180/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48180/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:08:41 INFO - PROCESS | 5798 | RSS: Main: 191717376 11:08:41 INFO - PROCESS | 5798 | 11:08:44 INFO - PROCESS | 5798 | Cycle 1(1): loaded http://localhost:48180/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48180/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:08:44 INFO - PROCESS | 5798 | RSS: Main: 194519040 11:08:44 INFO - PROCESS | 5798 | 11:08:47 INFO - PROCESS | 5798 | Cycle 1(1): loaded http://localhost:48180/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:08:48 INFO - PROCESS | 5798 | RSS: Main: 196014080 11:08:48 INFO - PROCESS | 5798 | 11:08:51 INFO - PROCESS | 5798 | Cycle 1(1): loaded http://localhost:48180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:08:51 INFO - PROCESS | 5798 | RSS: Main: 197271552 11:08:51 INFO - PROCESS | 5798 | 11:08:53 INFO - PROCESS | 5798 | Cycle 1(1): loaded http://localhost:48180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48180/tests/kraken/driver.html?testName=ai-astar) 11:08:53 INFO - PROCESS | 5798 | RSS: Main: 244350976 11:08:53 INFO - PROCESS | 5798 | 11:08:53 INFO - PROCESS | 5798 | __start_tp_report 11:08:53 INFO - PROCESS | 5798 | _x_x_mozilla_page_load 11:08:53 INFO - PROCESS | 5798 | _x_x_mozilla_page_load_details 11:08:53 INFO - PROCESS | 5798 | |i|pagename|runs| 11:08:53 INFO - PROCESS | 5798 | |0;ai-astar;104;115;114;115;114;113;113;114;113;114 11:08:53 INFO - PROCESS | 5798 | |1;audio-beat-detection;151;129;129;178;127;124;146;121;158;124 11:08:53 INFO - PROCESS | 5798 | |2;audio-dft;161;161;162;161;162;163;162;161;166;160 11:08:53 INFO - PROCESS | 5798 | |3;audio-fft;75;76;76;128;76;76;75;77;102;76 11:08:53 INFO - PROCESS | 5798 | |4;audio-oscillator;84;87;111;85;86;85;119;85;84;125 11:08:53 INFO - PROCESS | 5798 | |5;imaging-gaussian-blur;117;116;117;117;117;116;117;116;116;117 11:08:53 INFO - PROCESS | 5798 | |6;imaging-darkroom;146;147;147;146;147;147;147;146;146;146 11:08:53 INFO - PROCESS | 5798 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 11:08:53 INFO - PROCESS | 5798 | |8;json-parse-financial;63;61;61;63;62;62;62;69;62;62 11:08:53 INFO - PROCESS | 5798 | |9;json-stringify-tinderbox;65;66;67;65;66;67;67;68;67;66 11:08:53 INFO - PROCESS | 5798 | |10;stanford-crypto-aes;79;80;80;84;82;80;79;79;80;83 11:08:53 INFO - PROCESS | 5798 | |11;stanford-crypto-ccm;138;135;132;132;127;129;128;130;136;134 11:08:53 INFO - PROCESS | 5798 | |12;stanford-crypto-pbkdf2;166;166;165;168;165;164;166;164;169;165 11:08:53 INFO - PROCESS | 5798 | |13;stanford-crypto-sha256-iterative;67;67;66;70;67;67;65;65;66;72 11:08:53 INFO - PROCESS | 5798 | __end_tp_report 11:08:53 INFO - PROCESS | 5798 | __start_cc_report 11:08:53 INFO - PROCESS | 5798 | _x_x_mozilla_cycle_collect,1930 11:08:53 INFO - PROCESS | 5798 | __end_cc_report 11:08:53 INFO - PROCESS | 5798 | __startTimestamp1470420533663__endTimestamp 11:08:53 INFO - PROCESS | 5798 | 11:08:53 INFO - PROCESS | 5798 | ------- Summary: start ------- 11:08:53 INFO - PROCESS | 5798 | Number of tests: 14 11:08:53 INFO - PROCESS | 5798 | 11:08:53 INFO - PROCESS | 5798 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.21 (2.8%) stddev-sans-first:0.78 11:08:53 INFO - PROCESS | 5798 | Values: 104.0 115.0 114.0 115.0 114.0 113.0 113.0 114.0 113.0 114.0 11:08:53 INFO - PROCESS | 5798 | 11:08:53 INFO - PROCESS | 5798 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:137.50 stddev:18.83 (13.7%) stddev-sans-first:19.44 11:08:53 INFO - PROCESS | 5798 | Values: 151.0 129.0 129.0 178.0 127.0 124.0 146.0 121.0 158.0 124.0 11:08:53 INFO - PROCESS | 5798 | 11:08:53 INFO - PROCESS | 5798 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.66 (1.0%) stddev-sans-first:1.73 11:08:53 INFO - PROCESS | 5798 | Values: 161.0 161.0 162.0 161.0 162.0 163.0 162.0 161.0 166.0 160.0 11:08:53 INFO - PROCESS | 5798 | 11:08:53 INFO - PROCESS | 5798 | [#3] audio-fft Cycles:10 Average:83.70 Median:76.00 stddev:17.61 (23.2%) stddev-sans-first:18.39 11:08:53 INFO - PROCESS | 5798 | Values: 75.0 76.0 76.0 128.0 76.0 76.0 75.0 77.0 102.0 76.0 11:08:53 INFO - PROCESS | 5798 | 11:08:53 INFO - PROCESS | 5798 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:85.00 stddev:16.39 (19.3%) stddev-sans-first:16.89 11:08:53 INFO - PROCESS | 5798 | Values: 84.0 87.0 111.0 85.0 86.0 85.0 119.0 85.0 84.0 125.0 11:08:53 INFO - PROCESS | 5798 | 11:08:53 INFO - PROCESS | 5798 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:08:53 INFO - PROCESS | 5798 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 11:08:53 INFO - PROCESS | 5798 | 11:08:53 INFO - PROCESS | 5798 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 11:08:53 INFO - PROCESS | 5798 | Values: 146.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 146.0 146.0 11:08:53 INFO - PROCESS | 5798 | 11:08:53 INFO - PROCESS | 5798 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:08:53 INFO - PROCESS | 5798 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 11:08:53 INFO - PROCESS | 5798 | 11:08:53 INFO - PROCESS | 5798 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:62.00 stddev:2.31 (3.7%) stddev-sans-first:2.45 11:08:53 INFO - PROCESS | 5798 | Values: 63.0 61.0 61.0 63.0 62.0 62.0 62.0 69.0 62.0 62.0 11:08:53 INFO - PROCESS | 5798 | 11:08:53 INFO - PROCESS | 5798 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:0.88 11:08:53 INFO - PROCESS | 5798 | Values: 65.0 66.0 67.0 65.0 66.0 67.0 67.0 68.0 67.0 66.0 11:08:53 INFO - PROCESS | 5798 | 11:08:53 INFO - PROCESS | 5798 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.00 stddev:1.78 (2.2%) stddev-sans-first:1.79 11:08:53 INFO - PROCESS | 5798 | Values: 79.0 80.0 80.0 84.0 82.0 80.0 79.0 79.0 80.0 83.0 11:08:53 INFO - PROCESS | 5798 | 11:08:53 INFO - PROCESS | 5798 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:133.00 stddev:3.63 (2.7%) stddev-sans-first:3.17 11:08:53 INFO - PROCESS | 5798 | Values: 138.0 135.0 132.0 132.0 127.0 129.0 128.0 130.0 136.0 134.0 11:08:53 INFO - PROCESS | 5798 | 11:08:53 INFO - PROCESS | 5798 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:166.00 stddev:1.62 (1.0%) stddev-sans-first:1.72 11:08:53 INFO - PROCESS | 5798 | Values: 166.0 166.0 165.0 168.0 165.0 164.0 166.0 164.0 169.0 165.0 11:08:53 INFO - PROCESS | 5798 | 11:08:53 INFO - PROCESS | 5798 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:2.20 (3.3%) stddev-sans-first:2.33 11:08:53 INFO - PROCESS | 5798 | Values: 67.0 67.0 66.0 70.0 67.0 67.0 65.0 65.0 66.0 72.0 11:08:53 INFO - PROCESS | 5798 | -------- Summary: end -------- 11:08:53 INFO - PROCESS | 5798 | 11:08:54 INFO - TEST-INFO | 5798: exit 0 11:08:54 INFO - TEST-OK | kraken | took 63781ms 11:08:54 INFO - SUITE-END | took 1184s 11:08:54 INFO - Completed test suite (00:19:44) 11:08:54 INFO - javascript benchmark 11:08:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2575.6265341525477, 2598.6751656042993, 2622.344413896526, 2639.247814372904, 2640.3003204150914, 4604.654650901188, 4686.08621318843, 4784.8803779905475, 4796.328514008037, 4818.349522814424, 4763.618910487161, 4778.139934811741, 4819.493953134923, 4822.107910036646, 4823.445303790065, 4339.739615623057, 4345.500267469234, 4425.048614547872, 4457.531959144292, 4534.8639540813665, 4486.349479325512, 4525.683202175849, 4535.546445355454, 4546.97726511367, 4561.064981678748, 4261.74429534229, 4311.698181127323, 4319.24413227687, 4353.673474489426, 4391.67062470316, 4341.110072435144, 4349.565043495657, 4351.912961740747, 4388.034632380871, 4441.777911104464, 4390.165868484977, 4397.692161548693, 4413.227685155085, 4427.535108813592, 4448.043670610834, 4696.694714843524, 4700.130475861976, 4755.762211889426, 4762.595179409755, 4808.471068182497, 4993.400791904958, 5168.586513078944, 5213.6089793265655, 5214.8174813881715, 5218.0, 5168.3797944246935, 5198.220266959948, 5203.947960520422, 5214.478552144793, 5238.319018527605, 4640.69835460694, 4741.312509686076, 4801.735904525284, 4849.75751212438, 4900.901981960376, 5254.500822421864, 5280.471952804689, 5305.31030965972, 5320.361556613231, 5322.54758345545, 4986.0, 4993.500649934977, 4999.500049994971, 5043.84868453947, 5049.722265275372, 4970.72661003641, 5087.058894104529, 5108.821191258363, 5184.870378240575, 5196.090684130262, 5132.769025393866, 5169.379674439091, 5172.586193104543, 5176.792928282902, 5177.508136727005, 5082.769411694359, 5098.490150984871, 5099.082165210298, 5104.668196567211, 5137.6660517066275, 4314.395984562101, 4431.822727090945, 4439.489458712224, 4439.800208990603, 4479.440069991251, 3768.2086761779783, 3803.505544279226, 3846.442265871433, 3877.941830872539, 3944.7041471889725, 4368.301071828492, 4368.7815609219415, 4369.650427965755, 4371.453568303962, 4421.955780442218, 5155.587552995751, 5187.06632806091, 5208.348956380452, 5210.505002024802, 5229.50319719626, 4200.180964711852, 4280.593343632412, 4302.161078589645, 4324.610785029299, 4375.824967001285, 4609.354690343354, 4631.282151266559, 4633.72197668141, 4636.652251081183, 4679.415073115861, 4716.6698331116495, 4717.268823332389, 4721.1501929652995, 4728.432588089451, 4771.498992605726, 4980.427250866197, 5043.823466178666, 5125.308083408841, 5147.099257629975, 5167.896642067062, 4779.976100119617, 4783.545563171493, 4798.088363210979, 4809.615230781459, 4842.58837998774, 5038.924416133834, 5039.21892106724, 5042.722650254272, 5051.898962020666, 5119.28330033803, 4948.084604348207, 5098.439171691037, 5114.872128196825, 5131.204663277049, 5238.921416178837, 4962.925556116589, 4966.230234313687, 4971.577415919687, 4985.775640096277, 5023.09584274834, 5020.748962551785, 5022.397312322545, 5037.244413338029, 5045.722485263199, 5066.569341606005, 4735.692180008288, 4791.9281210782565, 4816.0, 4824.975875120602, 4902.5587697106, 4941.555260026615, 4966.453690094159, 4977.900441991067, 4981.950180498294, 4984.850454486371, 4866.78099485531, 4872.147374209429, 4886.682365646222, 4888.095702295087, 4903.31353610502], "value": 4696.297354595103, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.5783488878672, 546.3525722019407, 546.7594258526248, 562.6033646279373, 564.6583816790842, 28882.277943051435, 39851.2029759405, 40309.0, 40355.79822100885, 43625.34561981565, 40020.39969400461, 40423.39364909521, 40522.79738601303, 40551.797241013825, 40562.98592535181, 7419.554826710388, 7694.0, 7835.451518393715, 7846.450748447611, 7846.960765196166, 7463.888041679379, 7720.961395193016, 7728.188540203282, 9767.169790567776, 10112.494375281243, 9933.602655893792, 9957.55191016406, 9972.950135249313, 9986.450745209011, 9990.050945160197, 10060.899391006069, 10132.898671013269, 10139.493025348704, 10139.49302534874, 10145.44200068996, 9938.15525680318, 10012.098911097963, 10015.549300281433, 10016.298859079867, 10019.348742331798, 37588.43617345714, 37925.24149516994, 37940.62059379398, 37965.240695185945, 37970.24059518794, 2944.6319210098736, 2976.776741744356, 2979.7616190704694, 3025.243689077731, 3031.8029328093826, 28711.42577148466, 28753.42493150146, 29396.70603293961, 29425.411491770257, 32163.51754723681, 3318.8008719476907, 3319.13702437368, 3348.933021339584, 3412.590489141319, 3426.194844211608, 260933.69533152404, 261284.0, 263257.0, 263668.0, 267495.0, 31463.0, 50729.746351268004, 51262.48737512652, 51391.22913156231, 52043.0, 33545.0, 33751.83124084364, 33888.830555847555, 33899.83050084734, 33909.660903391145, 13685.178889266675, 13967.022308438514, 13973.86026139746, 13979.231142287272, 13985.510507132201, 10850.403227822388, 10920.344779313267, 10944.0, 10945.671629851116, 10949.945250273857, 7208.891866622005, 7566.31903128721, 7786.18245084258, 7841.490303130278, 7966.243206895336, 3037.0, 3090.2119959410206, 3098.9225269367994, 3138.9686103139134, 3143.6070491188602, 931.1619542411748, 946.6923249943658, 961.8364877970762, 976.272676855747, 1005.7183988483237, 26866.462670746474, 27417.725822741915, 27440.0, 27440.17679469619, 27824.860875695493, 960.6138362272904, 995.6664517386612, 999.6351331763999, 1000.949952502372, 1024.6106479537727, 14323.641908952359, 14825.33286002111, 15125.848741512664, 15140.955970944002, 15317.31072101758, 394743.0, 720987.9753006112, 739430.0, 740963.0, 741956.0, 49067.75466122646, 49283.50716492861, 49651.25523117156, 49681.50318496841, 49702.25446618304, 1109.9389533575732, 1178.6876477733408, 1196.5094311332311, 1200.3458115327167, 1203.1157099531838, 25024.0, 28495.0, 28807.56788648214, 28937.56593651055, 29222.707772922, 40065.0, 40682.59317406788, 40749.79625101855, 40760.184796303314, 40894.79552602218, 320096.0, 321932.0, 322832.0, 322871.0, 323264.0, 25121.87439062793, 25135.497290054464, 25489.23532294034, 25506.489870202862, 25509.0, 31950.84178448393, 35474.290514190085, 36397.0, 37646.43530346992, 37935.0, 33035.504467433486, 35722.642773572974, 35863.171834785906, 36515.26969460543, 37013.0, 34890.0, 35155.296894062485, 35207.64792352044, 35422.645773542965, 35466.8226658865, 30920.0, 31539.52690709687, 31577.842110789297, 31868.0, 34715.652843471245, 30982.380352392374, 31909.36181276408, 32345.838270808494, 32576.83711581427, 32904.83547582247, 24814.875925620257, 25256.242312730647, 25351.492970140123, 25524.0, 25732.228033159034], "value": 16922.82711461566, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.2886085550609, 360.2596663855776, 367.4433233651019, 385.39108209029735, 386.9899562142809, 16915.0, 17384.21771020304, 18074.81925180748, 18137.093145342747, 18182.636347273048, 16783.412580559652, 17010.319587216498, 17086.743698844526, 17238.82761172391, 17305.567360815985, 4394.758288294142, 4577.839775607855, 4597.08058388322, 4600.953990460102, 4608.28571571407, 4502.16709908668, 4566.84016059438, 4567.566081222295, 5006.22403527452, 5269.314989051418, 5285.86785330366, 5299.046171689094, 5346.198070289449, 5350.705711185883, 5351.625386222966, 5340.813071542497, 5348.572114230852, 5381.623286369975, 5937.910931336033, 6002.309734380515, 5291.444398338196, 5318.149096144598, 5325.440828712968, 5326.360836699582, 5326.76029578666, 10565.947170264177, 16597.83402165975, 21377.78622213789, 21409.892950535148, 21542.784572154236, 1907.9427617171507, 1913.425972208332, 1923.2979962313655, 2003.6092961872441, 2202.5925203837182, 8715.651373945035, 8852.822943541158, 8979.102089791035, 9376.671816486458, 9438.811223775487, 1672.4898905833716, 1694.4069575648548, 1714.554215903874, 1773.733939909011, 1822.8177182281665, 67468.6626566869, 69338.0, 74905.62547187283, 75852.24147758506, 78085.60957195178, 9780.657676981271, 10190.337628054152, 10310.082168775967, 10332.483375831178, 10360.119389851947, 13846.93076534611, 14020.158790472604, 14040.719185616435, 14046.227457489937, 14070.366833492517, 7365.889511657329, 7480.326770590673, 7499.2500749924575, 7509.286617771303, 7574.469787114959, 6986.558680750391, 7118.145822501333, 7191.352778249878, 7262.288775117664, 7375.8156046099275, 4134.152498737752, 4171.164687537474, 4332.740035597874, 4385.9692972151515, 4477.955220447819, 1699.7110491216522, 1794.1298470241923, 1840.0, 1840.8895466272068, 1846.3906910719431, 827.1149869639428, 838.4298676899766, 862.857628491292, 881.2773525708857, 930.6649606141783, 16853.241604127845, 17734.645307093786, 17834.19746111428, 17909.462716118538, 18158.5460363492, 817.7424111404888, 842.5660784695887, 849.5964416901923, 853.7140058080613, 894.5974311559825, 9229.49237791928, 9871.457069861226, 9981.201503879673, 10009.099181073738, 10034.891835310478, 401595.0, 401720.0, 404704.0, 420914.0, 423458.0, 77301.22698773052, 77320.61339693378, 77764.61117694376, 79282.0, 80142.59928700319, 870.4559650218613, 885.2431171348533, 888.2938064238816, 888.560162719458, 890.3278025091015, 15496.380144794082, 15736.449224277096, 15855.68288634244, 16326.510204693877, 16408.26162822652, 37183.07042323964, 38334.0, 38904.0, 38929.0, 39132.217355653294, 50895.491045089075, 51776.22335664893, 52008.0, 52861.7356913213, 53875.0, 6534.346565343618, 6824.590524568542, 6939.89590156138, 7230.240824713329, 7386.4090872728975, 11589.24669896454, 12299.139060266054, 12342.876571234172, 12477.627460979467, 12549.435275412447, 9942.900570994198, 10126.038026387481, 10126.44304563256, 10306.12397946153, 10514.526846291783, 10033.14718248957, 10133.18934485254, 10430.68707938763, 10705.250632455653, 10821.9458902705, 9746.0, 9966.60133594677, 9977.45124018186, 10342.0, 10385.896141038493, 6889.621070841152, 6968.0941477607585, 7080.645967701697, 7088.929110708827, 7482.551046937201, 7561.584112873845, 9970.252231082843, 10296.639617613348, 10363.844542332023, 10458.738531536772], "value": 8182.341182090244, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1254.7553227120716, 1302.4594793160838, 1386.362273354257, 1396.6508372906774, 1715.6225630361323, 6444.130042444269, 7215.278472152789, 7522.022137122167, 7548.584827834474, 7716.459847810655, 7579.052618422697, 7622.84754304915, 7637.3890088792905, 7641.61791910405, 7643.46495745298, 2134.0290167973612, 2156.1914282144194, 2157.4282815054025, 2161.135545781684, 2163.0374483354913, 2097.8426618003637, 2141.967870481944, 2143.2498625481035, 2156.7196264485674, 2161.5244646177894, 2111.5037966077957, 2137.0, 2140.1867290429614, 2143.046344376753, 2143.9387503185944, 2084.6143463459234, 2086.019570801721, 2090.822280106193, 2091.205341970049, 2091.633964056284, 2022.0, 2100.453881990678, 2104.5475222827167, 2106.5049713317358, 2112.6830975353664, 7128.536645118051, 7134.286571342876, 7167.569945803269, 7572.924270757277, 7640.083190017178, 4281.593248641374, 4456.844010459651, 4458.331250312447, 4506.008678090815, 4508.661850361236, 2697.4200546882516, 2779.652543432071, 2832.730890565393, 2833.943321133566, 2833.9433211335863, 969.3892847506097, 972.6644307713827, 979.3340528440657, 993.344392700814, 996.4220751963916, 10507.369557826554, 10535.10451611614, 10560.841587376195, 10564.471776411148, 10565.101966332793, 3799.4490798834568, 3880.9223815524097, 3980.44273801668, 3983.721139520264, 4008.07814202735, 8540.786480337916, 8546.948732304203, 8547.786305342415, 8553.700620478254, 8562.443441176303, 4510.188166130062, 4513.0, 4517.774111294422, 4521.163584736834, 4521.84173553924, 3450.7929524228125, 3902.239063382613, 4019.91960160801, 4150.066235097079, 4153.231652144363, 3351.0, 3375.2236985493473, 3463.0, 3469.930601387958, 3478.6869181773764, 994.4878387630376, 995.4176806568094, 998.0518507417981, 1013.2723706081114, 1015.5785349080197, 767.1101522234181, 779.2597032818845, 798.0941631248575, 803.6102490292203, 804.3565147881671, 4761.35721677576, 4832.0, 4837.346958160603, 4932.334134891744, 5047.621428392885, 404.244063601062, 407.1368698359497, 878.4377998081233, 904.5341649050744, 925.634374422113, 3219.6780321967617, 3239.400710868497, 3244.837758112085, 3310.519974603669, 3354.329134173175, 9541.809163816684, 9733.610655573697, 9833.901660983442, 9839.0, 9853.655122070693, 9723.854142187873, 9742.95128524353, 9762.609495620096, 9782.266330025277, 9785.608575657036, 7269.127704675367, 7370.410367170613, 7375.4099672026105, 7378.40972722181, 7387.926120738832, 4884.242942343943, 4889.608831293559, 4978.850634480971, 5078.289039534542, 5093.1341671915125, 8835.779105522413, 8886.37795354319, 8904.777380565538, 8949.32880033987, 9146.771330716785, 8949.418287811272, 9192.494412807093, 9218.308626852879, 9244.95377523135, 9253.76865578339, 5867.20792692981, 6343.0, 6498.675066246763, 6677.732890684319, 6751.223609284799, 7122.145342558926, 7387.445941554298, 7390.334869861738, 7401.925980740339, 7402.4078073755045, 6550.148480697479, 6570.310117437601, 6607.438367738796, 6743.629100399525, 6785.830354241183, 6389.233292004989, 6458.903116453163, 6464.385883341075, 6467.094606755152, 6480.287168411377, 5796.333421656564, 5898.587098903207, 5899.67551784656, 5902.0, 5902.026165682614, 4008.4388185654616, 4082.408050832672, 4098.4876890388705, 4123.793810309532, 4207.179599977975, 4170.35359519275, 4275.978620106879, 4289.077848262638, 4334.826606935687, 4379.233634114081], "value": 3966.825977164523, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.15709364296714, 298.1740578597285, 303.65990091097973, 305.37703085705164, 307.4895673182515, 4755.738434386108, 4795.664303498756, 4802.0, 4817.530653150788, 4825.0, 4505.57197066279, 4510.669352541, 4652.767361631922, 4657.720536767788, 4773.90452190956, 3739.4764732937274, 3744.157564547982, 3766.736328457009, 3767.8116094195248, 3777.8488860445686, 3741.850325986957, 3747.5690295615946, 3762.3792074307707, 3770.8868733938025, 3775.6413140751583, 3579.123114836869, 3610.476480910266, 3742.120601658608, 3744.756590821588, 3749.1189570450924, 3728.4780130781714, 3752.887413377603, 3759.4360845873066, 3761.511003569532, 3762.529683789526, 3327.683870032343, 3340.9498857517156, 3346.4311067118406, 3351.2124650707065, 3353.111425472252, 4418.4256046714045, 4601.4248218972625, 4611.0, 4612.930806037912, 4639.280911458729, 4093.488313960755, 4174.728642638249, 4177.791110444466, 4179.707420480568, 4191.517975432834, 4971.254311853215, 4992.575631071363, 4992.850214493571, 4997.201007637248, 5005.6496045276845, 3505.7896526208256, 3514.7715398499017, 3515.6132825389186, 3518.0, 3520.1551627609447, 4955.554000139969, 5152.793888244466, 5206.641716093137, 5211.140161873286, 5231.398389185217, 3618.493410922473, 3631.3463576555946, 3631.9648900063357, 3638.599754027055, 3642.5993140754495, 3682.127940206643, 3682.5765037021088, 3682.9447558286647, 3685.1155722626913, 3686.4101743720876, 3978.2839088963688, 4195.699333206655, 4195.741277616703, 4208.6633069354375, 4230.048239146229, 4944.90110197794, 4979.402471703419, 4998.90002199954, 5013.348264725635, 5014.548690617862, 1266.4554241675983, 1279.7888348422591, 1280.647821848999, 1284.2358796516057, 1284.8072789081712, 813.5281536708695, 813.5850716134814, 846.9449485783405, 872.6683860133109, 884.5930871799045, 4334.523202447728, 4336.696431249782, 4337.652987760972, 4341.305391137403, 4344.3049112142535, 5083.415407228142, 5100.821471248562, 5109.9744501277255, 5112.182050871843, 5124.231365295235, 4236.894077648022, 4339.522652508222, 4340.782960851945, 4345.217860785026, 4347.217500849814, 2682.4903268378944, 2699.892004319805, 2708.0, 2710.1869439168563, 2718.891244350204, 4709.364235828188, 4718.103560323528, 4721.409823772028, 4733.408323959505, 4738.763061846894, 5003.974980125076, 5198.948010519922, 5204.34945631796, 5215.6609820361555, 5284.07528682479, 4844.249141383091, 4849.951500485021, 4850.393700787402, 4856.223004319292, 4862.80548778052, 5216.2175673647735, 5221.582273418194, 5226.242194881797, 5227.320448341691, 5239.266502689703, 4934.62990275738, 5098.1588037973315, 5110.97444512775, 5138.3577052868395, 5150.922736159036, 4836.081144582518, 4843.0, 4846.36997190363, 4855.198892182751, 4857.222844344888, 3663.3405986922608, 3682.9079273018388, 3682.963170368369, 3685.852565897334, 3690.8154592269743, 4949.505049495022, 5191.32646686949, 5217.947820521898, 5221.0, 5226.555742761908, 5057.620678449058, 5065.645404821775, 5078.796848126033, 5085.389753229636, 5086.949130508796, 5035.313170088061, 5078.466760990191, 5084.51697088776, 5087.694738315713, 5091.92362114576, 4756.9524304756505, 4910.042541704333, 4976.154053810788, 4978.975105124451, 4990.900181996412, 4821.927671084866, 4924.162892308244, 5059.418166910852, 5063.670861393997, 5070.73231692077, 4897.804087836589, 4936.703797772145, 4941.234108713155, 4953.182724850503, 4954.702717836942], "value": 3764.8259375068233, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.4515024441081, 623.3174673732267, 643.314869663808, 728.7158008376731, 751.4063889527274, 12678.556250531234, 13532.458701651922, 13547.119437236584, 13570.117942333742, 13579.185248885049, 13718.176909385444, 13854.792178117312, 13874.653133671663, 13884.097533660304, 13889.861101388982, 619.7644894939916, 630.1021045010841, 751.5828715063151, 754.9660265288048, 766.2950085920966, 773.8839174123871, 774.9147593764682, 776.1229810314337, 776.1888826176659, 776.2741836383, 823.1521532821204, 824.3034635732796, 824.431142511668, 824.5712229640583, 824.7649419915325, 655.7606473637112, 786.3826895886758, 806.4959400374765, 810.2302812328312, 816.008549612221, 587.647411553069, 588.814523425124, 589.3723184808208, 589.4783116941495, 590.9982579527702, 13533.052686311961, 13567.864321356858, 13581.52464663742, 13589.048766586342, 13599.388027538784, 12916.677083072904, 13193.274369909652, 13391.196528208242, 13453.0, 13847.446102155902, 11537.423128843524, 11841.703957401047, 11870.465829037714, 12205.572804951873, 12362.690932726664, 4087.652549533293, 4092.5498195198506, 4117.3206420940805, 4212.094399704079, 4227.070044590216, 55792.721036394556, 57192.42807571912, 57320.0, 67485.66257168683, 68099.63800723958, 10300.22748293881, 10481.318714283547, 10499.580016799395, 10529.684109476575, 10546.367217966947, 18443.07784610764, 18545.907270463562, 18635.534111647317, 18636.813631863508, 18731.719024214646, 6278.6860656966965, 6358.1416508771645, 6929.792106236821, 7211.098612673416, 7217.097862767154, 3726.496922915426, 3733.104055026774, 3745.176061266517, 3759.473673685686, 3806.371948628501, 2723.319170207448, 2819.647544056993, 2839.4463079699262, 2840.5881147233536, 2843.303390669258, 469.8214678422246, 486.7931129270117, 488.0507413081522, 499.83005778034914, 502.22406382139684, 488.8582311129804, 500.0998203234164, 501.6237821633775, 510.316176323728, 522.5767128625749, 7586.582737949466, 7903.211333885048, 7925.207479252144, 8050.838983220303, 8119.79700507492, 514.8352527191338, 524.4964833759557, 531.8936611847348, 532.2548432194958, 555.5611067256822, 3582.7133829293593, 3835.827387767557, 3865.381538953754, 3909.9609003910164, 3989.8204580793354, 58432.0, 58553.0, 58688.0, 98621.0, 102950.0, 53272.73363633235, 71432.0, 87982.1201787974, 88092.0, 88558.0, 49672.0, 59613.10580341298, 80724.0, 85207.72188417178, 85756.57121714352, 7490.737824176128, 7783.455158138876, 7814.6874125034365, 7875.094364147967, 7876.015498062742, 34465.898069172894, 49050.0, 49319.26021109758, 49937.75031124821, 50073.24890126724, 38117.04707382338, 40858.38712419375, 42348.85941538521, 43834.56165438432, 52699.47300527099, 9181.586828592595, 9297.953510232406, 9301.627934882528, 9439.0, 9506.287028472754, 10455.268131230741, 10532.578696852346, 10648.680539583826, 10743.140548756237, 10919.181061420266, 8870.911290887008, 8923.107689231285, 9086.0, 9294.488803115893, 9360.15758581731, 9120.407173533698, 9565.091316324939, 9618.807623847624, 9649.276304277348, 9700.320977531504, 9294.953525232331, 9447.905520944703, 9616.423014619146, 9685.854712179182, 9985.850212246967, 7382.52013619113, 7492.175860655215, 7961.522308661499, 7975.042994840656, 8126.431149819456, 7767.72812951544, 8364.205400486944, 8551.657933682833, 8571.699990500552, 8639.827203456021], "value": 6173.2602111357055, "unit": "score"}], "name": "dromaeo_css", "value": 6256.187655937607, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 114.0, 115.0, 114.0, 113.0, 113.0, 114.0, 113.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 129.0, 129.0, 178.0, 127.0, 124.0, 146.0, 121.0, 158.0, 124.0], "value": 138.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 162.0, 163.0, 162.0, 161.0, 166.0, 160.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 128.0, 76.0, 76.0, 75.0, 77.0, 102.0, 76.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 111.0, 85.0, 86.0, 85.0, 119.0, 85.0, 84.0, 125.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 63.0, 62.0, 62.0, 62.0, 69.0, 62.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 65.0, 66.0, 67.0, 67.0, 68.0, 67.0, 66.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 80.0, 84.0, 82.0, 80.0, 79.0, 79.0, 80.0, 83.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 135.0, 132.0, 132.0, 127.0, 129.0, 128.0, 130.0, 136.0, 134.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 165.0, 168.0, 165.0, 164.0, 166.0, 164.0, 169.0, 165.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 70.0, 67.0, 67.0, 65.0, 65.0, 66.0, 72.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1525.3, "alertThreshold": 2.0}]} 11:08:54 INFO - Return code: 0 11:08:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:08:54 INFO - # TBPL SUCCESS # 11:08:54 INFO - Running post-action listener: _resource_record_post_action 11:08:54 INFO - [mozharness: 2016-08-05 18:08:54.944206Z] Finished run-tests step (success) 11:08:54 INFO - Running post-run listener: _resource_record_post_run 11:08:55 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409157632; Read time: 4; Write time: 482676 11:08:55 INFO - TinderboxPrint: CPU usage
13.0% 11:08:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 11:08:55 INFO - TinderboxPrint: I/O write bytes / time
409,157,632 / 482,676 11:08:55 INFO - TinderboxPrint: CPU idle
8,334.4 (87.0%) 11:08:55 INFO - TinderboxPrint: CPU user
1,197.8 (12.5%) 11:08:55 INFO - TinderboxPrint: Swap in / out
0 / 0 11:08:55 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 125149184; Read time: 0; Write time: 120468 11:08:55 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 284008448; Read time: 0; Write time: 362208 11:08:55 INFO - Running post-run listener: _upload_blobber_files 11:08:55 INFO - Blob upload gear active. 11:08:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:08:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:08:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:08:56 INFO - (blobuploader) - INFO - Open directory for files ... 11:08:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:08:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:08:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:08:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:08:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:08:56 INFO - (blobuploader) - INFO - Done attempting. 11:08:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:08:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:08:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:09:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:09:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:09:00 INFO - (blobuploader) - INFO - Done attempting. 11:09:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:09:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:09:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:09:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:09:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:09:01 INFO - (blobuploader) - INFO - Done attempting. 11:09:01 INFO - (blobuploader) - INFO - Iteration through files over. 11:09:01 INFO - Return code: 0 11:09:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:09:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:09:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d8655011e89575d407b2dc5292f9dd5d28b36cd253c63c9e87e9483e2a8dc761e9c5780453fdc9044f35d3543a5816b15f877c0f62a553cfe11d96a0aca98600", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a2f3e38618cf9bd9760c7c23642225ee894ff43b87d54db0adc5fa0f403df24f5eddea2e4c85400782668f741080326f07601ed6b8ce6646f4da9d96dd615008", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e4bf7344374e2641ed18d6d1916d58db1580fb7ce615a5c0592b47923d8b0b40a1c4212f9e633b3e90c81fb9bb8d1068876c18ba31e30675a27cb6fa2938740"} 11:09:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:09:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:09:01 INFO - Contents: 11:09:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d8655011e89575d407b2dc5292f9dd5d28b36cd253c63c9e87e9483e2a8dc761e9c5780453fdc9044f35d3543a5816b15f877c0f62a553cfe11d96a0aca98600", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a2f3e38618cf9bd9760c7c23642225ee894ff43b87d54db0adc5fa0f403df24f5eddea2e4c85400782668f741080326f07601ed6b8ce6646f4da9d96dd615008", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e4bf7344374e2641ed18d6d1916d58db1580fb7ce615a5c0592b47923d8b0b40a1c4212f9e633b3e90c81fb9bb8d1068876c18ba31e30675a27cb6fa2938740"} 11:09:01 INFO - Running post-run listener: copy_logs_to_upload_dir 11:09:01 INFO - Copying logs to upload dir... 11:09:01 INFO - mkdir: /builds/slave/test/build/upload/logs 11:09:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.303848 ========= master_lag: 0.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-05 11:09:00.419490) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 11:09:00.424761) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637 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/d8655011e89575d407b2dc5292f9dd5d28b36cd253c63c9e87e9483e2a8dc761e9c5780453fdc9044f35d3543a5816b15f877c0f62a553cfe11d96a0aca98600", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a2f3e38618cf9bd9760c7c23642225ee894ff43b87d54db0adc5fa0f403df24f5eddea2e4c85400782668f741080326f07601ed6b8ce6646f4da9d96dd615008", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e4bf7344374e2641ed18d6d1916d58db1580fb7ce615a5c0592b47923d8b0b40a1c4212f9e633b3e90c81fb9bb8d1068876c18ba31e30675a27cb6fa2938740"} build_url:https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011254 build_url: 'https://queue.taskcluster.net/v1/task/A7hKMiW8QOmCR2sENHdKLg/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/d8655011e89575d407b2dc5292f9dd5d28b36cd253c63c9e87e9483e2a8dc761e9c5780453fdc9044f35d3543a5816b15f877c0f62a553cfe11d96a0aca98600", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a2f3e38618cf9bd9760c7c23642225ee894ff43b87d54db0adc5fa0f403df24f5eddea2e4c85400782668f741080326f07601ed6b8ce6646f4da9d96dd615008", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3e4bf7344374e2641ed18d6d1916d58db1580fb7ce615a5c0592b47923d8b0b40a1c4212f9e633b3e90c81fb9bb8d1068876c18ba31e30675a27cb6fa2938740"}' ========= master_lag: 0.29 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-05 11:09:00.726895) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:09:00.727297) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1470417242.65244-1100085637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004623 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-05 11:09:00.751228) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 11:09:00.751670) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-05 11:09:00.752090) ========= ========= Total master_lag: 0.75 =========