builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-009 starttime: 1472603068.59 results: success (0) buildid: 20160830143002 builduid: 2ecc959bc72e4ddbb051d1ba5ce4a176 revision: 0066d2c20597326c4d7314f7e9cfac52beefae9f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 17:24:28.587144) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 17:24:28.587707) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 17:24:28.588009) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 17:24:28.606498) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 17:24:28.606766) ========= 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=17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-30 17:24:28-- 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% 790K=0.02s 2016-08-30 17:24:28 (790 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094232 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 17:24:28.715495) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 17:24:28.715786) ========= 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=17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020254 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 17:24:28.766072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 17:24:28.766407) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0066d2c20597326c4d7314f7e9cfac52beefae9f --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 0066d2c20597326c4d7314f7e9cfac52beefae9f --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=17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-30 17:24:29,012 truncating revision to first 12 chars 2016-08-30 17:24:29,012 Setting DEBUG logging. 2016-08-30 17:24:29,012 attempt 1/10 2016-08-30 17:24:29,012 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0066d2c20597?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 17:24:29,492 unpacking tar archive at: fx-team-0066d2c20597/testing/mozharness/ program finished with exit code 0 elapsedTime=0.765940 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 17:24:29.545263) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 17:24:29.545537) ========= script_repo_revision: 0066d2c20597326c4d7314f7e9cfac52beefae9f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 17:24:29.545898) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 17:24:29.546160) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 17:24:29.556670) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-30 17:24:29.556997) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:24:29 INFO - MultiFileLogger online at 20160830 17:24:29 in /builds/slave/test 17:24:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:24:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:24:29 INFO - {'append_to_log': False, 17:24:29 INFO - 'base_work_dir': '/builds/slave/test', 17:24:29 INFO - 'blob_upload_branch': 'Fx-Team', 17:24:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:24:29 INFO - 'branch': 'Fx-Team', 17:24:29 INFO - 'buildbot_json_path': 'buildprops.json', 17:24:29 INFO - 'config_files': ('talos/linux_config.py',), 17:24:29 INFO - 'default_actions': ('clobber', 17:24:29 INFO - 'read-buildbot-config', 17:24:29 INFO - 'download-and-extract', 17:24:29 INFO - 'populate-webroot', 17:24:29 INFO - 'create-virtualenv', 17:24:29 INFO - 'install', 17:24:29 INFO - 'run-tests'), 17:24:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:24:29 INFO - 'download_minidump_stackwalk': True, 17:24:29 INFO - 'download_symbols': 'ondemand', 17:24:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:24:29 INFO - 'tooltool.py': '/tools/tooltool.py', 17:24:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:24:29 INFO - '/tools/misc-python/virtualenv.py')}, 17:24:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:24:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:24:29 INFO - 'installer_path': 'installer.exe', 17:24:29 INFO - 'log_level': 'info', 17:24:29 INFO - 'log_name': 'talos', 17:24:29 INFO - 'log_to_console': True, 17:24:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:24:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:24:29 INFO - 'opt_config_files': (), 17:24:29 INFO - 'pip_index': False, 17:24:29 INFO - 'sps_profile': False, 17:24:29 INFO - 'sps_profile_interval': 0, 17:24:29 INFO - 'suite': 'dromaeojs-e10s', 17:24:29 INFO - 'system_bits': '32', 17:24:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:24:29 INFO - 'title': 'talos-linux64-ix-009', 17:24:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:24:29 INFO - 'use_talos_json': True, 17:24:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:24:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:24:29 INFO - 'work_dir': 'build'} 17:24:29 INFO - [mozharness: 2016-08-31 00:24:29.901893Z] Running clobber step. 17:24:29 INFO - Running pre-action listener: _resource_record_pre_action 17:24:29 INFO - Running main action method: clobber 17:24:29 INFO - rmtree: /builds/slave/test/build 17:24:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:24:30 INFO - Running post-action listener: _resource_record_post_action 17:24:30 INFO - [mozharness: 2016-08-31 00:24:30.370537Z] Finished clobber step (success) 17:24:30 INFO - [mozharness: 2016-08-31 00:24:30.370639Z] Running read-buildbot-config step. 17:24:30 INFO - Running pre-action listener: _resource_record_pre_action 17:24:30 INFO - Running main action method: read_buildbot_config 17:24:30 INFO - Using buildbot properties: 17:24:30 INFO - { 17:24:30 INFO - "project": "", 17:24:30 INFO - "product": "firefox", 17:24:30 INFO - "script_repo_revision": "production", 17:24:30 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 17:24:30 INFO - "repository": "", 17:24:30 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 17:24:30 INFO - "buildid": "20160830143002", 17:24:30 INFO - "pgo_build": "True", 17:24:30 INFO - "basedir": "/builds/slave/test", 17:24:30 INFO - "buildnumber": 1096, 17:24:30 INFO - "slavename": "talos-linux64-ix-009", 17:24:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:24:30 INFO - "platform": "ubuntu64_hw", 17:24:30 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:24:30 INFO - "branch": "fx-team", 17:24:30 INFO - "repo_path": "integration/fx-team", 17:24:30 INFO - "revision": "0066d2c20597326c4d7314f7e9cfac52beefae9f", 17:24:30 INFO - "stage_platform": "linux64-pgo", 17:24:30 INFO - "builduid": "2ecc959bc72e4ddbb051d1ba5ce4a176", 17:24:30 INFO - "slavebuilddir": "test" 17:24:30 INFO - } 17:24:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 17:24:30 INFO - Running post-action listener: _resource_record_post_action 17:24:30 INFO - [mozharness: 2016-08-31 00:24:30.373080Z] Finished read-buildbot-config step (success) 17:24:30 INFO - [mozharness: 2016-08-31 00:24:30.373171Z] Running download-and-extract step. 17:24:30 INFO - Running pre-action listener: _resource_record_pre_action 17:24:30 INFO - Running main action method: download_and_extract 17:24:30 INFO - mkdir: /builds/slave/test/build/tests 17:24: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')]} 17:24:30 INFO - trying https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:24:30 INFO - Downloading https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/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 17:24:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/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 17:24:30 INFO - Downloaded 1361 bytes. 17:24:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:24:30 INFO - Using the following test package requirements: 17:24:30 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:24:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:24:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:24:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:30 INFO - u'jsshell-linux-x86_64.zip'], 17:24:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:24:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:24:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:24:30 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:24:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:24:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:24:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:24:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:24: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')]} 17:24:30 INFO - trying https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:24:30 INFO - Downloading https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/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 17:24:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/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 17:24:31 INFO - Downloaded 21885702 bytes. 17:24:31 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 17:24:36 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 17:24:36 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')]} 17:24:36 INFO - trying https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:24:36 INFO - Downloading https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/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 17:24:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/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 17:24:37 INFO - Downloaded 21885702 bytes. 17:24:37 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 17:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:41 INFO - trying https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:24:41 INFO - Downloading https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/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 17:24:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/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 17:24:42 INFO - Downloaded 14413998 bytes. 17:24:42 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 17:24: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')]} 17:24:42 INFO - trying https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:24:42 INFO - Downloading https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/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 17:24:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/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 17:24:43 INFO - Downloaded 59723776 bytes. 17:24:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:24:43 INFO - mkdir: /builds/slave/test/properties 17:24:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:24:43 INFO - Writing to file /builds/slave/test/properties/build_url 17:24:43 INFO - Contents: 17:24:43 INFO - build_url:https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:24:44 INFO - Running post-action listener: _resource_record_post_action 17:24:44 INFO - Running post-action listener: set_extra_try_arguments 17:24:44 INFO - [mozharness: 2016-08-31 00:24:44.594134Z] Finished download-and-extract step (success) 17:24:44 INFO - [mozharness: 2016-08-31 00:24:44.594362Z] Running populate-webroot step. 17:24:44 INFO - Running pre-action listener: _resource_record_pre_action 17:24:44 INFO - Running main action method: populate_webroot 17:24:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:24:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:24:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:24:44 INFO - '--tppagecycles', 17:24:44 INFO - '7'], 17:24:44 INFO - 'tests': ['tsvgm']}}, 17:24:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:24:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:24:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:24:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:24:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:24:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:24:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:44 INFO - 'talos_options': ['--disable-e10s'], 17:24:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:44 INFO - 'talos_options': ['--disable-e10s'], 17:24:44 INFO - 'tests': ['damp', 'tps']}, 17:24:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:44 INFO - 'tests': ['damp', 'tps']}, 17:24:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:24:44 INFO - 'tests': ['dromaeo_dom']}, 17:24:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:24:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:24:44 INFO - 'tests': ['basic_compositor_video']}, 17:24:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:24:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:24:44 INFO - 'tests': ['a11yr', 17:24:44 INFO - 'ts_paint', 17:24:44 INFO - 'tpaint', 17:24:44 INFO - 'sessionrestore', 17:24:44 INFO - 'sessionrestore_no_auto_restore', 17:24:44 INFO - 'tabpaint']}, 17:24:44 INFO - 'other-e10s': {'tests': ['a11yr', 17:24:44 INFO - 'ts_paint', 17:24:44 INFO - 'tpaint', 17:24:44 INFO - 'sessionrestore', 17:24:44 INFO - 'sessionrestore_no_auto_restore', 17:24:44 INFO - 'tabpaint']}, 17:24:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:24:44 INFO - 'ts_paint', 17:24:44 INFO - 'tpaint', 17:24:44 INFO - 'sessionrestore', 17:24:44 INFO - 'sessionrestore_no_auto_restore', 17:24:44 INFO - 'tabpaint']}, 17:24:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:24:44 INFO - 'ts_paint', 17:24:44 INFO - 'tpaint', 17:24:44 INFO - 'sessionrestore', 17:24:44 INFO - 'sessionrestore_no_auto_restore', 17:24:44 INFO - 'tabpaint']}, 17:24:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:24:44 INFO - 'tests': ['a11yr', 17:24:44 INFO - 'ts_paint', 17:24:44 INFO - 'tpaint', 17:24:44 INFO - 'sessionrestore', 17:24:44 INFO - 'sessionrestore_no_auto_restore', 17:24:44 INFO - 'tabpaint']}, 17:24:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:24:44 INFO - 'tests': ['a11yr', 17:24:44 INFO - 'ts_paint', 17:24:44 INFO - 'tpaint', 17:24:44 INFO - 'sessionrestore', 17:24:44 INFO - 'sessionrestore_no_auto_restore', 17:24:44 INFO - 'tabpaint']}, 17:24:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:24:44 INFO - 'tests': ['tsvgx', 17:24:44 INFO - 'tsvgr_opacity', 17:24:44 INFO - 'tart', 17:24:44 INFO - 'tscrollx', 17:24:44 INFO - 'cart']}, 17:24:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:24:44 INFO - 'tsvgr_opacity', 17:24:44 INFO - 'tart', 17:24:44 INFO - 'tscrollx', 17:24:44 INFO - 'cart']}, 17:24:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:44 INFO - 'talos_options': ['--disable-e10s'], 17:24:44 INFO - 'tests': ['tp5o']}, 17:24:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:44 INFO - 'tests': ['tp5o']}, 17:24:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:44 INFO - 'talos_options': ['--disable-e10s', 17:24:44 INFO - '--xperf_path', 17:24:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:44 INFO - 'tests': ['tp5n']}, 17:24:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:24:44 INFO - 'talos_options': ['--xperf_path', 17:24:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:44 INFO - 'tests': ['tp5n']}}, 17:24:44 INFO - 'talos.zip': {'path': '', 17:24:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:24:44 INFO - Running post-action listener: _resource_record_post_action 17:24:44 INFO - [mozharness: 2016-08-31 00:24:44.612157Z] Finished populate-webroot step (success) 17:24:44 INFO - [mozharness: 2016-08-31 00:24:44.612247Z] Running create-virtualenv step. 17:24:44 INFO - Running pre-action listener: _resource_record_pre_action 17:24:44 INFO - Running main action method: create_virtualenv 17:24:44 INFO - Creating virtualenv /builds/slave/test/build/venv 17:24:44 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 17:24:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:24:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:24:44 INFO - Using real prefix '/usr' 17:24:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:24:45 INFO - Installing distribute.............................................................................................................................................................................................done. 17:24:47 INFO - Installing pip.................done. 17:24:47 INFO - Return code: 0 17:24:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f904b5bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e7850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e2370>, '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 0x22e58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5d80>, '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': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', '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 17:24:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:24:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:24:47 INFO - Using env: {'DISPLAY': ':0', 17:24:47 INFO - 'HOME': '/home/cltbld', 17:24:47 INFO - 'LANG': 'en_US.UTF-8', 17:24:47 INFO - 'LANGUAGE': 'en_US:en', 17:24:47 INFO - 'LOGNAME': 'cltbld', 17:24:47 INFO - 'MAIL': '/var/mail/cltbld', 17:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:47 INFO - 'MOZ_NO_REMOTE': '1', 17:24:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:47 INFO - 'NO_EM_RESTART': '1', 17:24:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:47 INFO - 'PWD': '/builds/slave/test', 17:24:47 INFO - 'SHELL': '/bin/bash', 17:24:47 INFO - 'SHLVL': '1', 17:24:47 INFO - 'TERM': 'linux', 17:24:47 INFO - 'TMOUT': '86400', 17:24:47 INFO - 'USER': 'cltbld', 17:24:47 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', 17:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:47 INFO - '_': '/tools/buildbot/bin/python'} 17:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:47 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 17:24:47 INFO - Cleaning up... 17:24:47 INFO - Return code: 0 17:24:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f904b5bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e7850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e2370>, '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 0x22e58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5d80>, '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': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', '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 17:24:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:24:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:24:47 INFO - Using env: {'DISPLAY': ':0', 17:24:47 INFO - 'HOME': '/home/cltbld', 17:24:47 INFO - 'LANG': 'en_US.UTF-8', 17:24:47 INFO - 'LANGUAGE': 'en_US:en', 17:24:47 INFO - 'LOGNAME': 'cltbld', 17:24:47 INFO - 'MAIL': '/var/mail/cltbld', 17:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:47 INFO - 'MOZ_NO_REMOTE': '1', 17:24:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:47 INFO - 'NO_EM_RESTART': '1', 17:24:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:47 INFO - 'PWD': '/builds/slave/test', 17:24:47 INFO - 'SHELL': '/bin/bash', 17:24:47 INFO - 'SHLVL': '1', 17:24:47 INFO - 'TERM': 'linux', 17:24:47 INFO - 'TMOUT': '86400', 17:24:47 INFO - 'USER': 'cltbld', 17:24:47 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', 17:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:47 INFO - '_': '/tools/buildbot/bin/python'} 17:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:47 INFO - Downloading/unpacking psutil>=3.1.1 17:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:24:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:49 INFO - Installing collected packages: psutil 17:24:49 INFO - Running setup.py install for psutil 17:24:49 INFO - building 'psutil._psutil_linux' extension 17:24:49 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 17:24:49 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 17:24:49 INFO - building 'psutil._psutil_posix' extension 17:24:49 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 17:24:50 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 17:24:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:50 INFO - Successfully installed psutil 17:24:50 INFO - Cleaning up... 17:24:50 INFO - Return code: 0 17:24:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f904b5bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e7850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e2370>, '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 0x22e58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5d80>, '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': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', '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 17:24:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:24:50 INFO - Using env: {'DISPLAY': ':0', 17:24:50 INFO - 'HOME': '/home/cltbld', 17:24:50 INFO - 'LANG': 'en_US.UTF-8', 17:24:50 INFO - 'LANGUAGE': 'en_US:en', 17:24:50 INFO - 'LOGNAME': 'cltbld', 17:24:50 INFO - 'MAIL': '/var/mail/cltbld', 17:24:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:50 INFO - 'MOZ_NO_REMOTE': '1', 17:24:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:50 INFO - 'NO_EM_RESTART': '1', 17:24:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:50 INFO - 'PWD': '/builds/slave/test', 17:24:50 INFO - 'SHELL': '/bin/bash', 17:24:50 INFO - 'SHLVL': '1', 17:24:50 INFO - 'TERM': 'linux', 17:24:50 INFO - 'TMOUT': '86400', 17:24:50 INFO - 'USER': 'cltbld', 17:24:50 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', 17:24:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:50 INFO - '_': '/tools/buildbot/bin/python'} 17:24:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:24:50 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 17:24:50 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 17:24:50 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 17:24:50 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 17:24:50 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 17:24:50 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 17:24:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:24:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:24:52 INFO - Installing collected packages: mozsystemmonitor 17:24:52 INFO - Running setup.py install for mozsystemmonitor 17:24:52 INFO - Successfully installed mozsystemmonitor 17:24:52 INFO - Cleaning up... 17:24:52 INFO - Return code: 0 17:24:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f904b5bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e7850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e2370>, '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 0x22e58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5d80>, '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': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', '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 17:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:24:52 INFO - Using env: {'DISPLAY': ':0', 17:24:52 INFO - 'HOME': '/home/cltbld', 17:24:52 INFO - 'LANG': 'en_US.UTF-8', 17:24:52 INFO - 'LANGUAGE': 'en_US:en', 17:24:52 INFO - 'LOGNAME': 'cltbld', 17:24:52 INFO - 'MAIL': '/var/mail/cltbld', 17:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:52 INFO - 'MOZ_NO_REMOTE': '1', 17:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:52 INFO - 'NO_EM_RESTART': '1', 17:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:52 INFO - 'PWD': '/builds/slave/test', 17:24:52 INFO - 'SHELL': '/bin/bash', 17:24:52 INFO - 'SHLVL': '1', 17:24:52 INFO - 'TERM': 'linux', 17:24:52 INFO - 'TMOUT': '86400', 17:24:52 INFO - 'USER': 'cltbld', 17:24:52 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', 17:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:52 INFO - '_': '/tools/buildbot/bin/python'} 17:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:52 INFO - Downloading/unpacking jsonschema==2.5.1 17:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:24:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:24:54 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 17:24:54 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 17:24:54 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 17:24:54 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 17:24:54 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 17:24:54 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 17:24:54 INFO - Downloading functools32-3.2.3-2.tar.gz 17:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:24:54 INFO - warning: no files found matching '*.txt' 17:24:54 INFO - no previously-included directories found matching 'build' 17:24:54 INFO - no previously-included directories found matching 'dist' 17:24:54 INFO - no previously-included directories found matching '.git*' 17:24:54 INFO - Installing collected packages: jsonschema, functools32 17:24:55 INFO - Running setup.py install for functools32 17:24:55 INFO - warning: no files found matching '*.txt' 17:24:55 INFO - no previously-included directories found matching 'build' 17:24:55 INFO - no previously-included directories found matching 'dist' 17:24:55 INFO - no previously-included directories found matching '.git*' 17:24:55 INFO - Successfully installed jsonschema functools32 17:24:55 INFO - Cleaning up... 17:24:55 INFO - Return code: 0 17:24:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f904b5bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e7850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e2370>, '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 0x22e58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5d80>, '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': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', '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 17:24:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:24:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:24:55 INFO - Using env: {'DISPLAY': ':0', 17:24:55 INFO - 'HOME': '/home/cltbld', 17:24:55 INFO - 'LANG': 'en_US.UTF-8', 17:24:55 INFO - 'LANGUAGE': 'en_US:en', 17:24:55 INFO - 'LOGNAME': 'cltbld', 17:24:55 INFO - 'MAIL': '/var/mail/cltbld', 17:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:55 INFO - 'MOZ_NO_REMOTE': '1', 17:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:55 INFO - 'NO_EM_RESTART': '1', 17:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:55 INFO - 'PWD': '/builds/slave/test', 17:24:55 INFO - 'SHELL': '/bin/bash', 17:24:55 INFO - 'SHLVL': '1', 17:24:55 INFO - 'TERM': 'linux', 17:24:55 INFO - 'TMOUT': '86400', 17:24:55 INFO - 'USER': 'cltbld', 17:24:55 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', 17:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:55 INFO - '_': '/tools/buildbot/bin/python'} 17:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:24:55 INFO - Cleaning up... 17:24:55 INFO - Return code: 0 17:24:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f904b5bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e7850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e2370>, '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 0x22e58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5d80>, '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': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', '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 17:24:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:24:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:24:55 INFO - Using env: {'DISPLAY': ':0', 17:24:55 INFO - 'HOME': '/home/cltbld', 17:24:55 INFO - 'LANG': 'en_US.UTF-8', 17:24:55 INFO - 'LANGUAGE': 'en_US:en', 17:24:55 INFO - 'LOGNAME': 'cltbld', 17:24:55 INFO - 'MAIL': '/var/mail/cltbld', 17:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:55 INFO - 'MOZ_NO_REMOTE': '1', 17:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:55 INFO - 'NO_EM_RESTART': '1', 17:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:55 INFO - 'PWD': '/builds/slave/test', 17:24:55 INFO - 'SHELL': '/bin/bash', 17:24:55 INFO - 'SHLVL': '1', 17:24:55 INFO - 'TERM': 'linux', 17:24:55 INFO - 'TMOUT': '86400', 17:24:55 INFO - 'USER': 'cltbld', 17:24:55 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', 17:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:55 INFO - '_': '/tools/buildbot/bin/python'} 17:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:55 INFO - Downloading/unpacking blobuploader==1.2.4 17:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:57 INFO - Downloading blobuploader-1.2.4.tar.gz 17:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:24:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:24:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:58 INFO - Downloading docopt-0.6.1.tar.gz 17:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:24:58 INFO - Installing collected packages: blobuploader, requests, docopt 17:24:58 INFO - Running setup.py install for blobuploader 17:24:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:24:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:24:58 INFO - Running setup.py install for requests 17:24:58 INFO - Running setup.py install for docopt 17:24:58 INFO - Successfully installed blobuploader requests docopt 17:24:58 INFO - Cleaning up... 17:24:58 INFO - Return code: 0 17:24:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:58 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 0x7f904b5bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e7850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e2370>, '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 0x22e58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5d80>, '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': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', '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 17:24:58 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 17:24:58 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 17:24:58 INFO - Using env: {'DISPLAY': ':0', 17:24:58 INFO - 'HOME': '/home/cltbld', 17:24:58 INFO - 'LANG': 'en_US.UTF-8', 17:24:58 INFO - 'LANGUAGE': 'en_US:en', 17:24:58 INFO - 'LOGNAME': 'cltbld', 17:24:58 INFO - 'MAIL': '/var/mail/cltbld', 17:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:58 INFO - 'MOZ_NO_REMOTE': '1', 17:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:24:58 INFO - 'NO_EM_RESTART': '1', 17:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:58 INFO - 'PWD': '/builds/slave/test', 17:24:58 INFO - 'SHELL': '/bin/bash', 17:24:58 INFO - 'SHLVL': '1', 17:24:58 INFO - 'TERM': 'linux', 17:24:58 INFO - 'TMOUT': '86400', 17:24:58 INFO - 'USER': 'cltbld', 17:24:58 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', 17:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:58 INFO - '_': '/tools/buildbot/bin/python'} 17:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:24:59 INFO - Running setup.py (path:/tmp/pip-D_c7fw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:24:59 INFO - Running setup.py (path:/tmp/pip-lwP0Ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:24:59 INFO - Running setup.py (path:/tmp/pip-0Y0hKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:24:59 INFO - Running setup.py (path:/tmp/pip-nIJCQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:24:59 INFO - Running setup.py (path:/tmp/pip-cRgZYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:24:59 INFO - Running setup.py (path:/tmp/pip-s95DCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:24:59 INFO - Running setup.py (path:/tmp/pip-jrqagv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:24:59 INFO - Running setup.py (path:/tmp/pip-NuVqky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:24:59 INFO - Running setup.py (path:/tmp/pip-MjFVsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:24:59 INFO - Running setup.py (path:/tmp/pip-w4wcDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:24:59 INFO - Running setup.py (path:/tmp/pip-7I2nof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:24:59 INFO - Running setup.py (path:/tmp/pip-6A0sBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:24:59 INFO - Running setup.py (path:/tmp/pip-MkWKpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:25:00 INFO - Running setup.py (path:/tmp/pip-a_ROvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:00 INFO - Running setup.py (path:/tmp/pip-D2ROU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:25:00 INFO - Running setup.py (path:/tmp/pip-O_yPcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:25:00 INFO - Running setup.py (path:/tmp/pip-rcMtdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:25:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:25:00 INFO - Running setup.py install for manifestparser 17:25:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:25:00 INFO - Running setup.py install for mozcrash 17:25:00 INFO - Running setup.py install for mozdebug 17:25:00 INFO - Running setup.py install for mozdevice 17:25:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:25:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:25:00 INFO - Running setup.py install for mozfile 17:25:00 INFO - Running setup.py install for mozhttpd 17:25:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:25:00 INFO - Running setup.py install for mozinfo 17:25:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:25:01 INFO - Running setup.py install for mozInstall 17:25:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:25:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:25:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:25:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:25:01 INFO - Running setup.py install for mozleak 17:25:01 INFO - Running setup.py install for mozlog 17:25:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:25:01 INFO - Running setup.py install for moznetwork 17:25:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:25:01 INFO - Running setup.py install for mozprocess 17:25:01 INFO - Running setup.py install for mozprofile 17:25:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:25:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:25:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:25:01 INFO - Running setup.py install for mozrunner 17:25:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:25:01 INFO - Running setup.py install for mozscreenshot 17:25:01 INFO - Running setup.py install for moztest 17:25:02 INFO - Running setup.py install for mozversion 17:25:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:25:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:25:02 INFO - Cleaning up... 17:25:02 INFO - Return code: 0 17:25:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:25:02 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')]} 17:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:02 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')]} 17:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:02 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 0x7f904b5bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e7850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e2370>, '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 0x22e58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5d80>, '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': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', '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 17:25:02 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 17:25:02 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 17:25:02 INFO - Using env: {'DISPLAY': ':0', 17:25:02 INFO - 'HOME': '/home/cltbld', 17:25:02 INFO - 'LANG': 'en_US.UTF-8', 17:25:02 INFO - 'LANGUAGE': 'en_US:en', 17:25:02 INFO - 'LOGNAME': 'cltbld', 17:25:02 INFO - 'MAIL': '/var/mail/cltbld', 17:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:02 INFO - 'MOZ_NO_REMOTE': '1', 17:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:02 INFO - 'NO_EM_RESTART': '1', 17:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:02 INFO - 'PWD': '/builds/slave/test', 17:25:02 INFO - 'SHELL': '/bin/bash', 17:25:02 INFO - 'SHLVL': '1', 17:25:02 INFO - 'TERM': 'linux', 17:25:02 INFO - 'TMOUT': '86400', 17:25:02 INFO - 'USER': 'cltbld', 17:25:02 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', 17:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:02 INFO - '_': '/tools/buildbot/bin/python'} 17:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:25:02 INFO - Running setup.py (path:/tmp/pip-BxK7i_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:25:02 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)) 17:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:25:02 INFO - Running setup.py (path:/tmp/pip-906PS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:25:02 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)) 17:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:25:02 INFO - Running setup.py (path:/tmp/pip-x0Dbtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:25:02 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)) 17:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:25:02 INFO - Running setup.py (path:/tmp/pip-LTib7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:25:02 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)) 17:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:25:02 INFO - Running setup.py (path:/tmp/pip-542Wyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:25:02 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)) 17:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:25:02 INFO - Running setup.py (path:/tmp/pip-0Do9cR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:25:02 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)) 17:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:25:02 INFO - Running setup.py (path:/tmp/pip-TISLuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:25:02 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)) 17:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:25:02 INFO - Running setup.py (path:/tmp/pip-LyLoZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:25:02 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)) 17:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:25:02 INFO - Running setup.py (path:/tmp/pip-41295Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:25:02 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)) 17:25:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:25:02 INFO - Running setup.py (path:/tmp/pip-SOs2yH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:25:03 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)) 17:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:25:03 INFO - Running setup.py (path:/tmp/pip-Cr8ckW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:25:03 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)) 17:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:25:03 INFO - Running setup.py (path:/tmp/pip-8bdc17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:25:03 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)) 17:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:25:03 INFO - Running setup.py (path:/tmp/pip-KWsw4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:25:03 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)) 17:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:25:03 INFO - Running setup.py (path:/tmp/pip-bIeJwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:25:03 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)) 17:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:03 INFO - Running setup.py (path:/tmp/pip-dbBsef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:03 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)) 17:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:25:03 INFO - Running setup.py (path:/tmp/pip-Y46psc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:25:03 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)) 17:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:25:03 INFO - Running setup.py (path:/tmp/pip-o9TGnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:25:03 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)) 17:25:03 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)) 17:25:03 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)) 17:25:03 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)) 17:25:03 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)) 17:25:03 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)) 17:25:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:25:03 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 17:25:03 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 17:25:03 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 17:25:03 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 17:25:03 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 17:25:03 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 17:25:05 INFO - Downloading blessings-1.6.tar.gz 17:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:25:05 INFO - Installing collected packages: blessings 17:25:05 INFO - Running setup.py install for blessings 17:25:05 INFO - Successfully installed blessings 17:25:05 INFO - Cleaning up... 17:25:05 INFO - Return code: 0 17:25:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:25:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:25:05 INFO - Reading from file tmpfile_stdout 17:25:05 INFO - Current package versions: 17:25:05 INFO - argparse == 1.2.1 17:25:05 INFO - blessings == 1.6 17:25:05 INFO - blobuploader == 1.2.4 17:25:05 INFO - docopt == 0.6.1 17:25:05 INFO - functools32 == 3.2.3-2 17:25:05 INFO - jsonschema == 2.5.1 17:25:05 INFO - manifestparser == 1.1 17:25:05 INFO - mozInstall == 1.12 17:25:05 INFO - mozcrash == 0.17 17:25:05 INFO - mozdebug == 0.1 17:25:05 INFO - mozdevice == 0.48 17:25:05 INFO - mozfile == 1.2 17:25:05 INFO - mozhttpd == 0.7 17:25:05 INFO - mozinfo == 0.9 17:25:05 INFO - mozleak == 0.1 17:25:05 INFO - mozlog == 3.3 17:25:05 INFO - moznetwork == 0.27 17:25:05 INFO - mozprocess == 0.23 17:25:05 INFO - mozprofile == 0.28 17:25:05 INFO - mozrunner == 6.12 17:25:05 INFO - mozscreenshot == 0.1 17:25:05 INFO - mozsystemmonitor == 0.3 17:25:05 INFO - moztest == 0.7 17:25:05 INFO - mozversion == 1.4 17:25:05 INFO - psutil == 3.1.1 17:25:05 INFO - requests == 1.2.3 17:25:05 INFO - wsgiref == 0.1.2 17:25:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:05 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 0x7f904b5bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e7850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e2370>, '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 0x22e58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5d80>, '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': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', '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 17:25:05 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 17:25:05 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 17:25:05 INFO - Using env: {'DISPLAY': ':0', 17:25:05 INFO - 'HOME': '/home/cltbld', 17:25:05 INFO - 'LANG': 'en_US.UTF-8', 17:25:05 INFO - 'LANGUAGE': 'en_US:en', 17:25:05 INFO - 'LOGNAME': 'cltbld', 17:25:05 INFO - 'MAIL': '/var/mail/cltbld', 17:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:05 INFO - 'MOZ_NO_REMOTE': '1', 17:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:05 INFO - 'NO_EM_RESTART': '1', 17:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:05 INFO - 'PWD': '/builds/slave/test', 17:25:05 INFO - 'SHELL': '/bin/bash', 17:25:05 INFO - 'SHLVL': '1', 17:25:05 INFO - 'TERM': 'linux', 17:25:05 INFO - 'TMOUT': '86400', 17:25:05 INFO - 'USER': 'cltbld', 17:25:05 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', 17:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:05 INFO - '_': '/tools/buildbot/bin/python'} 17:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:06 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)) 17:25:06 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)) 17:25:06 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)) 17:25:06 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)) 17:25:06 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)) 17:25:06 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)) 17:25:06 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)) 17:25:06 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)) 17:25:06 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)) 17:25:06 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)) 17:25:06 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)) 17:25:06 INFO - Cleaning up... 17:25:06 INFO - Return code: 0 17:25:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:25:06 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')]} 17:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:06 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')]} 17:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:06 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 0x7f904b5bbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x221a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e7850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22e2370>, '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 0x22e58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5d80>, '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': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', '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 17:25:06 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 17:25:06 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 17:25:06 INFO - Using env: {'DISPLAY': ':0', 17:25:06 INFO - 'HOME': '/home/cltbld', 17:25:06 INFO - 'LANG': 'en_US.UTF-8', 17:25:06 INFO - 'LANGUAGE': 'en_US:en', 17:25:06 INFO - 'LOGNAME': 'cltbld', 17:25:06 INFO - 'MAIL': '/var/mail/cltbld', 17:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:06 INFO - 'MOZ_NO_REMOTE': '1', 17:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:06 INFO - 'NO_EM_RESTART': '1', 17:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:06 INFO - 'PWD': '/builds/slave/test', 17:25:06 INFO - 'SHELL': '/bin/bash', 17:25:06 INFO - 'SHLVL': '1', 17:25:06 INFO - 'TERM': 'linux', 17:25:06 INFO - 'TMOUT': '86400', 17:25:06 INFO - 'USER': 'cltbld', 17:25:06 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', 17:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:06 INFO - '_': '/tools/buildbot/bin/python'} 17:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:25:06 INFO - Cleaning up... 17:25:06 INFO - Return code: 0 17:25:06 INFO - Running post-action listener: _resource_record_post_action 17:25:06 INFO - Running post-action listener: _start_resource_monitoring 17:25:06 INFO - Starting resource monitoring. 17:25:06 INFO - [mozharness: 2016-08-31 00:25:06.361817Z] Finished create-virtualenv step (success) 17:25:06 INFO - [mozharness: 2016-08-31 00:25:06.362332Z] Running install step. 17:25:06 INFO - Running pre-action listener: _resource_record_pre_action 17:25:06 INFO - Running main action method: install 17:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:25:06 INFO - Reading from file tmpfile_stdout 17:25:06 INFO - Detecting whether we're running mozinstall >=1.0... 17:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:25:06 INFO - Reading from file tmpfile_stdout 17:25:06 INFO - Output received: 17:25:06 INFO - Usage: mozinstall [options] installer 17:25:06 INFO - Options: 17:25:06 INFO - -h, --help show this help message and exit 17:25:06 INFO - -d DEST, --destination=DEST 17:25:06 INFO - Directory to install application into. [default: 17:25:06 INFO - "/builds/slave/test"] 17:25:06 INFO - --app=APP Application being installed. [default: firefox] 17:25:06 INFO - mkdir: /builds/slave/test/build/application 17:25:06 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'] 17:25:06 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 17:25:23 INFO - Reading from file tmpfile_stdout 17:25:23 INFO - Output received: 17:25:23 INFO - /builds/slave/test/build/application/firefox/firefox 17:25:23 INFO - Running post-action listener: _resource_record_post_action 17:25:23 INFO - [mozharness: 2016-08-31 00:25:23.666852Z] Finished install step (success) 17:25:23 INFO - [mozharness: 2016-08-31 00:25:23.667137Z] Running run-tests step. 17:25:23 INFO - Running pre-action listener: _resource_record_pre_action 17:25:23 INFO - Running main action method: run_tests 17:25:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:25:23 INFO - Python 2.7.3 17:25:23 INFO - Return code: 0 17:25:23 INFO - grabbing minidump binary from tooltool 17:25: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')]} 17:25:23 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 0x22e2370>, '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 0x22e58f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22e5d80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:25:23 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 17:25:23 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 17:25:23 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 17:25:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:25:23 INFO - Return code: 0 17:25:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:25:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:25:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:25:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:25:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:25:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:25:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:25:23 INFO - Using env: {'DISPLAY': ':0', 17:25:23 INFO - 'HOME': '/home/cltbld', 17:25:23 INFO - 'LANG': 'en_US.UTF-8', 17:25:23 INFO - 'LANGUAGE': 'en_US:en', 17:25:23 INFO - 'LOGNAME': 'cltbld', 17:25:23 INFO - 'MAIL': '/var/mail/cltbld', 17:25:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:25:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:25:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:23 INFO - 'MOZ_NO_REMOTE': '1', 17:25:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:25:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:23 INFO - 'NO_EM_RESTART': '1', 17:25:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:23 INFO - 'PWD': '/builds/slave/test', 17:25:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:25:23 INFO - 'SHELL': '/bin/bash', 17:25:23 INFO - 'SHLVL': '1', 17:25:23 INFO - 'TERM': 'linux', 17:25:23 INFO - 'TMOUT': '86400', 17:25:23 INFO - 'USER': 'cltbld', 17:25:23 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625', 17:25:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:23 INFO - '_': '/tools/buildbot/bin/python'} 17:25:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:25:23 INFO - mozversion application_buildid: 20160830143002 17:25:23 INFO - mozversion application_changeset: 0066d2c20597326c4d7314f7e9cfac52beefae9f 17:25:23 INFO - mozversion application_display_name: Nightly 17:25:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:25:23 INFO - mozversion application_name: Firefox 17:25:23 INFO - mozversion application_remotingname: firefox 17:25:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:25:23 INFO - mozversion application_vendor: Mozilla 17:25:23 INFO - mozversion application_version: 51.0a1 17:25:23 INFO - mozversion platform_buildid: 20160830143002 17:25:23 INFO - mozversion platform_changeset: 0066d2c20597326c4d7314f7e9cfac52beefae9f 17:25:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:25:23 INFO - mozversion platform_version: 51.0a1 17:25:23 INFO - using testdate: 1472603123 17:25:23 INFO - actual date: 1472603123 17:25:23 INFO - starting webserver on 'localhost:49684' 17:25:23 INFO - SUITE-START | Running 2 tests 17:25:23 INFO - TEST-START | dromaeo_css 17:25:23 INFO - operating with platform_type : linux_ 17:25:23 INFO - Initialising browser for dromaeo_css test... 17:25:23 INFO - TEST-INFO | started process 20380 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEWxfYi/profile http://localhost:49684/getInfo.html) 17:25:28 INFO - PROCESS | 20380 | __metrics Screen width/height:1600/1200 17:25:28 INFO - PROCESS | 20380 | colorDepth:24 17:25:28 INFO - PROCESS | 20380 | Browser inner width/height: 1024/697 17:25:28 INFO - PROCESS | 20380 | __metrics 17:25:29 ERROR - PROCESS | 20380 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 17:25:30 INFO - TEST-INFO | 20380: exit 0 17:25:30 INFO - Browser initialized. 17:25:30 INFO - Running cycle 1/1 for dromaeo_css test... 17:25:30 INFO - TEST-INFO | started process 20501 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEWxfYi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:25:42 INFO - PROCESS | 20501 | RSS: Main: 191512576 17:25:42 INFO - PROCESS | 20501 | 17:26:31 INFO - PROCESS | 20501 | 1472603191789 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] 17:28:41 INFO - PROCESS | 20501 | Cycle 1(1): loaded http://localhost:49684/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49684/tests/dromaeo/cssquery-ext.html) 17:28:42 INFO - PROCESS | 20501 | RSS: Main: 206180352 17:28:42 INFO - PROCESS | 20501 | 17:31:44 INFO - PROCESS | 20501 | Cycle 1(1): loaded http://localhost:49684/tests/dromaeo/cssquery-ext.html (next: http://localhost:49684/tests/dromaeo/cssquery-jquery.html) 17:31:45 INFO - PROCESS | 20501 | RSS: Main: 199413760 17:31:45 INFO - PROCESS | 20501 | 17:34:47 INFO - PROCESS | 20501 | Cycle 1(1): loaded http://localhost:49684/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49684/tests/dromaeo/cssquery-mootools.html) 17:34:47 INFO - PROCESS | 20501 | RSS: Main: 197173248 17:34:47 INFO - PROCESS | 20501 | 17:37:49 INFO - PROCESS | 20501 | Cycle 1(1): loaded http://localhost:49684/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49684/tests/dromaeo/cssquery-prototype.html) 17:37:50 INFO - PROCESS | 20501 | RSS: Main: 193617920 17:37:50 INFO - PROCESS | 20501 | 17:40:52 INFO - PROCESS | 20501 | Cycle 1(1): loaded http://localhost:49684/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49684/tests/dromaeo/cssquery-yui.html) 17:40:53 INFO - PROCESS | 20501 | RSS: Main: 197312512 17:40:53 INFO - PROCESS | 20501 | 17:43:56 INFO - PROCESS | 20501 | Cycle 1(1): loaded http://localhost:49684/tests/dromaeo/cssquery-yui.html (next: http://localhost:49684/tests/dromaeo/cssquery-dojo.html) 17:43:56 INFO - PROCESS | 20501 | RSS: Main: 197758976 17:43:56 INFO - PROCESS | 20501 | 17:43:56 INFO - PROCESS | 20501 | __start_tp_report 17:43:56 INFO - PROCESS | 20501 | _x_x_mozilla_page_load 17:43:56 INFO - PROCESS | 20501 | _x_x_mozilla_page_load_details 17:43:56 INFO - PROCESS | 20501 | |i|pagename|runs| 17:43:56 INFO - PROCESS | 20501 | |0;dojo.html;3048.542718592211;3060.7857449978496;3072.692730726927;3095.690430956903;3104.0998110547944;5291.9470805291985;5301.7879284828605;5318.0693378658725;5328.520433161015;5344.438833922441;5305.098133317336;5339.359276886769;5400.594955378343;5408.2698835657175;5447.373552041517;4846.369971903657;4934;4963.057019166346;4980.302757613937;4993.6005119590345;4966.428860681031;4980.203167493201;4981.72600506972;5036;5044.596432285409;4715.693479923794;4766.785494652714;4767.284907263938;4904.901901961958;4906.533879281463;4808.663393562452;4816.470188279286;4843;4845.248986407078;4854.053459575384;4821.180399332122;4864.805407783684;4880;4899.632527560411;4911;5369.650972686802;5388.544507810563;5432.456754324576;5443.401225865152;5444.91832622511;5759.308882934075;5775.48020678141;5785.537157027427;5803.7098145093;5810.244668193108;5823.650580965155;5824.3302020267365;5851.64890106595;5857.76568937242;5859.150423188614;5273.419923808378;5278.5249327560705;5315.096433606296;5329.200619907045;5371.677699338053;5814.622049566765;5834.299884013945;5837.241158649348;5858.794942177004;5869.882602347929;5597.216389705444;5610.298712660918;5621.213030175779;5624.3813180550105;5644.266245388073;5585.832425027255;5713.371529131792;5754.88490230193;5797.710114494258;5876.08920617305;5527.309086364205;5545.724483368767;5565.888682226333;5582.413846546136;5593.440655934455;5603.551715862721;5611.7474713637985;5626.071698169756;5632.211490391349;5643.80246691372;4305.203537345538;4379.4087798147475;4388.144311859157;4432.911341773147;4475.753833539186;3886.630770076895;3929.135590170158;3967.0875698589484;3987.043109653662;4020.8793736187963;5514.338279406497;5516.9448305517235;5519;5553.055980483327;5553.222548843165;5683;5768.307803063659;5821.18503409523;5849.239598852122;5951.1073338999495;5535.6955367455175;5537.335519737577;5549.084401073777;5570.080936645408;5583.106702927594;4985.52637499437;4991.6006719463085;4995.275685025724;5002.124628190052;5050.9494905051215;5768.826935191951;5920.792772253037;5991.161237426677;5995.340512543617;5996.16053752475;5834.737436815269;5841.970790146022;5844.15259787337;5889.911651325147;5920.8815823684145;5971.641701497924;5982.282126144716;6009.939900601113;6013.428724271187;6019.668918209541;5442.482964118402;5652.152177173457;5661.405552416937;5728;5755.050416681201;5806.970965145148;5859.5019423349495;5860.062390017577;5901.0558310670085;5918.437748413894;5697.230873832145;5698.116791897262;5704.229928959538;5707.1153971134545;5720.771169153188;5536.667799932017;5611.382747897646;5675.545956323567;5682.488576028178;5686.516646084963;5587.525060369914;5626.043572592587;5628.240187574789;5633.577481688808;5683.346415162309;5700.800471983461;5733.31200255972;5759.107338362561;5759.8560035999435;5762.625429347079;5414.485623865727;5430;5491.588130890279;5536.390996990247;5602.52378547828 17:43:56 INFO - PROCESS | 20501 | |1;ext.html;542.0179961112066;587.7560812262911;595.5414330965157;597.4294548705989;630.1367127035961;38874.22251554967;43200.78399608001;43201.56798432015;43214.567854321445;43330.78334608326;42835.57164428355;42938.14123717524;43148.35277470833;43439.34840977388;43563.564364356345;8805.91194088059;8912.242459390927;8935.687250946186;8950.239229665454;8954.820903581924;8802.86795698065;8843.46939183651;8873;8887.866681999743;8888.333374996868;8814.338924580683;8836.248918841875;8839.29285657146;8908.465492070496;8918.643254269822;8834.42576232546;8859.911400885972;8893;8915.821683566357;8936.642534298686;8693.739187824376;8798.956005219932;8839.60221790021;8840.955795221047;8847.646094156225;41054.178916421806;41056.384154237414;41277.380839287434;41440.79279603613;41598.37602435936;3284.655111213336;3441.3117376524547;3487.511748355232;3495.790252584853;3758.39865621502;32497.6750232497;32497.837510812296;32554.348913021844;32661.18347041319;32686.836565817255;3911.4915061041884;4299.9570004300185;4300.419443375135;4313.525512193656;4340.327249276367;332199;333581;335050;338877.3056134728;339257;59456;59536.70231648814;60034.69982650146;60050.699746500984;60104.39895600988;37272.25455490875;37839.432408513894;37856;39467.407988880186;62486.375136248964;16529.6694066118;16638.502534771927;16699.499015029567;16702.83297167037;16725.58186045334;12558;12599.811002834966;12633.494660213672;12639.052071094704;12643.87356126427;19387.90306048461;19399.24531315501;19521.624543520687;19523.902380488005;19650.50873728168;7188.424926005907;7229.493935424575;7296.6716497757725;7474.40204783616;7482.625868706543;893.5666201892077;936.3492372800974;981.5877331520778;993.438707130469;1012.9037741414554;30189.849050754605;30273.697263027527;30894.845525772227;31801;32079;1099.7729597564994;1118.5917140243753;1145.8796826333282;1157.5080590748898;1158;16066.357345706274;17008.187586371077;17466.737998930028;17783.911080444515;18028.819711802975;529053;533795;537283;538645;539615;58756;59225.703871480364;59599.7420270874;59603;59624.40375596189;1315.5132600937523;1385.6535866033491;1391.2765362011899;1417.362187015847;1419.8935079868845;31037.051480109352;31450.528242076845;31476;32219.677803221668;32762.50856237206;51334.48665513297;52166;52226.21660675017;52279.477205227464;52468.21297680614;491506;495287;495907;496499;497889;28570.571441428812;28913.229317162433;29236.415271694023;29246.415071698873;29384.853075734485;47427.762861185474;48307.275390869865;48357.27464088112;48376.5162348372;48574.51425485841;38309.656392774355;39898.800505997286;41650;43382.78308608563;43519.347209791245;40057.39913901352;40736.1852762949;41513.58486415097;42033.369499458146;42281.577184229;34378;39081.6091839078;40182;40368;41563.7921810389;33845.83077084599;36186.4572031425;36340.636593633724;36522.8173859129;36884.81557592195;28058.158255252376;28279.434411311246;28341.71658283391;28345.29136771515;28377.858110709316 17:43:56 INFO - PROCESS | 20501 | |2;jquery.html;385.90545316397487;389.3808843938138;393.61622418142304;400.84166754132116;413.0520455554502;18471.63056738866;19829.801701982975;20136.8993155034;20150.19399224031;20919.895400522975;18543.629127417476;18831.24675012998;19041.143148558313;19403.514912127168;19697.63628364595;5213.400458947222;5217.087009773293;5276.2085687146855;5341.786328546873;5366.356037275533;5305.495977882114;5358.3569971603265;5379.81170659027;5390.568754499631;5394.541463975547;5186.974065129669;5289.418164001957;5350.143976963686;5367.704776237305;5407.324084489439;5359.410464848864;5374.3013408256875;5382.381026181981;5410.972945135289;5411.675299482004;5144.408393034774;5156.510131537498;5230.712310822903;5242.475752424765;5274.868128296785;14223;14320.64198395038;14327.212003339811;23250.186243481396;24248.51502969931;2286.1655495743935;2512.4221429071235;2615.6076588511687;2658.255688407249;3014.3669829335868;9756.609735610567;10527.78944421115;10951.507182176822;12280.385980700928;14435.061720988208;1917.1277068933603;2006.5685877536255;2012.7282816819834;2020.1515363547346;2036.256766280312;82287;82891.58554207251;83009.50971470865;83712.58143709242;85366;10438.68683939483;10657.147428205724;10865.239433239756;11473;11513.88486115145;14348.282585870873;14351.928240358731;14391.496297629532;14391.568252952427;14434.350454229374;7764.728234511765;7786.727464538714;8014.879776803353;8034.196580341919;8112.3104536113915;7559.3196612304055;7655.6937722490475;7681.961590192013;7871.527708337518;7907.881381779278;4364.454443194601;4804.183288840905;4850.320955066293;4936.136176169156;4942.9258561121615;1883.9434816955513;1944.8541359398102;1951.268274397101;1958.9902050489657;1983.6429442700164;912.5118061836886;941.2140862379989;981.7153025622632;998.805232979562;1003.3578509753763;17446.214920328617;18634.81365186358;19003.23987040503;19212.327568535035;19256.97801730826;821.4701517521165;827.432016329065;891.3404080980029;923.422860712055;928.758522784081;9892.851607225897;10309.5145592381;10349.223808214414;10361.171106311476;10459.895401045893;530644;537298;549613.0154793843;559820;561592;90078.54960725154;94547;97875;98535;99152;1037.5797801890246;1064.7763969566322;1090.836374543809;1144.6165534546021;1144.7538779162353;17421.47735567935;17504;17532;17610.471685849447;17875;41898.79050604728;42490.57509424866;42783.35824962566;43146.784266078466;45301.09397812091;57692.711536442046;60477.39522604718;60920;62196.37803621906;62200.37799621946;8595.65617375298;8628.439151455135;8771.473711577326;8803.735887923373;8883.067277935983;12955.611331660066;13516.79724804109;13721.931390342985;13761.243131627856;14010.789838152232;9622.566984485855;11005.61480348184;11418.200725949437;11453.713657158638;11776.646700598996;11150.72123196894;11523.942380288045;11562.340661648037;11638.592649257236;11708.297502149899;11338.773224535627;11519.94240028828;11880.643580692593;11959.282443053444;12345.506179753069;8530.445521041112;8600.483970961763;8689.695860644848;8853.73438796837;8867.778305542413;8815.206631403205;11348.432578371214;11531.654050378502;11543.711407214887;11680.766384672428 17:43:56 INFO - PROCESS | 20501 | |3;mootools.html;1466.200920498328;1483.0879009409211;1655.7433597792347;1700.7278835386342;1781.1272476486517;7618.73334433295;8538.060813310538;8701.47791132531;9296.90703092969;9308.90691093089;8698.39111262212;8830.028696843343;8988.191062804346;9014.954925225366;9021.954890225556;2446.3272600034957;2475.1089607741287;2481.553320402327;2489.4523204894895;2494.538510375586;2400.8199385046105;2485.453200295932;2490.9377265568414;2509.6737424134835;2521.962170567443;2472.4807790364043;2481.4292712676097;2494.9251522454356;2505.6993160820725;2511.3219430753684;2415.5048215115858;2421.1162925532144;2429.890654920524;2474.8638824864624;2477.7893879020303;2385.9522809543887;2429.8906549205153;2434.476587533689;2453.4847681986803;2457.8893949772305;8856.424332418437;9015.053419390935;9016.323775716783;9022.052684468103;9062.365634405594;5297.894042119136;5456.48163424474;5460.535854452376;5464.0711079116645;5489.945100548984;3460.1003739027783;3545.2377738786286;3641.1248207173326;3641.1625326175126;3642.797876700709;991.1327588360185;1016.8830584482805;1024.3853687787343;1030.2582140858644;1035.2701345551368;12727;12755.36223188846;12778.552750653682;12780.488780448772;12814.423350949322;4587.9541204588195;4728.598069164091;4869.488703686133;4870.853874383774;4896.241082632127;10588.682339529827;10605.469726513798;10630.681079567625;10687.358758474516;10691.786164276671;5404.3784964728775;5430.5384042356845;5447.155690867922;5453.045716999509;5489.670619762827;4452.30989196675;4861.368022157097;4958.132326842788;4982.3522942018035;4991.550760431579;3926.9214615707524;4080.18396320737;4108.630223279919;4140.503139623264;4169.207850508394;1327.3429652322163;1330.2750001249342;1335.3857225676104;1335.5442567601167;1339.9866001339863;677.3091446724313;769.3076231391681;781.6560713286136;790.8022994251437;798.2297083314629;5895.469407753323;6193.38066193377;6271.090691849657;6277.905831412532;6298.559100862895;458.3422788298802;462.69462154978225;466.6733286699324;483.7605385334282;484.97817598208167;4186.748795072305;4238.957610423856;4357.302831546937;4368.453943257093;4460.821567137278;10935.726606834734;11253.66239012831;11349.319040857576;11367.317960922372;11374.260673056391;11151.498182581803;11232.775344493064;11247.212695111428;11289.943550282196;11296.830547541793;8106.148854370324;8362.665493380318;8400.41197116196;8415.747527574182;8422.83154336922;5916.201312822886;6081.094517469604;6187.783427580013;6202.782902598387;6358.141650877073;10007.249456290952;10402;10486.318389304672;10615.681529554126;10624.84062739044;10180.625615542103;10214.591416343263;10465.633702820365;10506.947465262625;10612.946935265274;7673;8286.627101780314;8418.6211620476;8452.197041281068;8643.265322447662;8663.566821659018;8749.956250218707;8751.343649226461;8792.47245165292;8814.779630509289;7686.231376862269;7689.231076892266;7722.575258360844;7736.922630773845;7983.800404989922;7859.214078592095;7921.603919804102;7943.84112317762;7980.8004799878145;8049.396295277995;7142.5000249982;7176.174739904978;7205.459590530626;7232.0959880015;7270.636468176675;4922.680025798311;5081.7713202905215;5229.294045303835;5300.1254792958725;5397.59518036141;5357.624966252325;5447.536959358499;5504.311961004874;5510.724463776875;5581.6930068846605 17:43:56 INFO - PROCESS | 20501 | |4;prototype.html;323.4969622237421;335.07519246878616;337.5763416911777;344.546920799149;345.2404709638792;5380.21986811912;5435.483629055238;5442.91835622465;5500.339959204896;5595.916061259084;5465.152901300305;5492.176173573956;5505.311836020497;5522.260487946294;5530.5022547970675;4306.741595504264;4310.956890431087;4311.719738217022;4314.303560274829;4317.460317460317;4147.6474499667565;4259.10558782656;4270.871873843789;4293.420388247578;4303.182395344875;4245.320748680212;4274.722143060691;4275.187714334266;4276.23027854986;4288.571142885718;4286.292761694317;4292;4301.591348821857;4303.634191093761;4324.243257429937;3704.9629503704887;3857.2092720992127;3860.884173474772;3863.2466668999555;3865.768053916746;5348.625596208267;5360.9463905360835;5380.21986811914;5415.160650099241;5428.375736790241;4900.289458028566;4910.754462276907;4916.385451818523;4916.557509824133;4979.875503112415;5519.172124181365;5735.426457354273;5736.1682556029145;5755.194272801811;5811.27359080115;4136.255474014676;4156.314208155681;4158.812853421603;4176.728512646669;4203.369494575808;6075.569772091155;6080.665563394012;6099.207103076616;6101.60339577926;6135.846603834895;4122.876313710593;4208.22147902639;4289.442372491556;4331.263685173528;4341.261985462479;4262.65898728101;4265.76538290397;4267.317229243306;4279.422277992493;4326.502452217972;4926.187179115477;4937.5556199942175;4961.107000739829;4976.357801925428;4979.029089327619;5699;5797.9420205797405;5850.824475265749;5884.352721200665;5887.735051922588;1457.4680241711699;1473.7789331600345;1481.4148411377446;1489.9942538786493;1491.4332553629552;938.9108034736689;954.5752140297501;963.5086106085806;972.2222222222194;973.6689525561343;4811.422629284508;4837.709737415696;4881.780319885614;4884.609231261491;4899.951000490021;5132.28148059272;5138.997895410434;5140.691558506502;5171.741412929414;5207.479252074838;4691.577758001797;4869.342638743724;4886.486918873538;4916.608409068197;4959.677620954699;2744.4373903349765;2747.958780618292;2759.599858020576;2759.779217662582;2761.4891245119315;5187.299714538564;5296.232046353257;5332.840014799563;5342.813001544927;5403.324584426947;4865.8053677853195;5249.265102885599;5299.436666183485;5311.840644780663;5340.279062326536;5290.973545132327;5342.2253773202665;5377.166539186433;5394.406615272317;5394.595405344615;5142.534377702337;5151.871203219949;5173.508516690908;5210.557102646318;5238.449962754008;4935.582851777709;4941.678790878582;5067.9103992640285;5092.872678183075;5129.563987060992;5274.683518988873;5282.735863206901;5292.655977361459;5293.232481290114;5330.8933821324135;3854.3062248795486;4081.755094694328;4167.229062623424;4232.936505952352;4245.448091748053;5776.393478684846;5807.245058142415;5814.761316892942;5838.2702162229725;5856;5562.749676264659;5637.154426836008;5677.51741102011;5685.857853553529;5733.512651424676;5616.775328986958;5655.915161272502;5668.064769313017;5677.176809362537;5689.207899511641;5639.125935480007;5647.181158731879;5663.801766938137;5725.456081672234;5726.770929162787;5453.863653408696;5724.398938111605;5746.2529871116485;5788.768449261982;5802.796902108406;5610.551155907599;5646.745896434588;5654.575906807088;5659.405762395054;5679.602427830012 17:43:56 INFO - PROCESS | 20501 | |5;yui.html;736.6795443981865;786.3394748411333;811.7199566149678;814.576420261464;842.6418772021897;15810.367585296588;16215.432459863907;16671.249793759296;16723;17263.654726905486;15352;15660.451884184056;15665.060096394225;15668.686626267468;15681.529554113366;795.2365728900263;800.0878997942336;801.3669201330941;805.2269820971874;834.9457285276468;829.2702421868777;832.8251067275879;837.1210229259284;838.9286910612606;839.08539691736;867.9001914779818;871.6818361298144;872.2629378175432;873.4191762477944;874.514644372373;868.1882439918664;871.4901782457271;871.5903525343078;871.9346049046347;872.5986046418654;634.7270673610345;635.6091004032533;637.2066776862836;637.8501052252764;638;16094.75857862133;16131.677366452604;16151.757723634155;16174.27215775293;16186.838131618651;14994.400223991028;15224.086554806747;15287.388504459808;15335.693286134327;15383;11734.295942243407;11740.882591174064;11821.704457388549;12000.63998080059;12103.273803571814;3687.3547129252543;3748.19413826026;3832.405977073558;3880.3209438348176;3913.139109395957;77084;77354;77441.61279193625;78907;79320.20679793185;11197.72005699864;11259.099272058216;11298.20912536131;11513.251638643462;11540.826887596693;20791.272305469538;21030.684539731916;21052.894735526224;21062.789372106083;21104.155833766785;8208.891969106944;8361.080281169066;8401.36989725773;8436.957815211008;8561.614727337284;4375.671824613103;4561.543845615412;4592.862214133581;4691.6628760803005;4709.0817290628;3564.6078931317534;3695.131644063643;3713;3718.1262403335195;3725.795081270502;628.0673200297555;631.5452873930763;638.559394018126;638.5721566550422;643.0643413832862;610.7465401858268;689.7585844954326;696.5681277607814;719.6221983458621;720.7009091227083;9130.95434522823;9649.035096490295;9755;9788.265880059023;9984.003199360157;683.3166833166833;720.495653042872;724.641302555228;731.5427857589007;733.5598640815468;4575.382323386367;4782.274103760892;4796.472388037313;4882.511748825089;4889.951100488949;108383;111711;125615.37192314163;127128;129024;89865.55067224622;90245.54877225703;90410;92139;100215;83801.58099209465;85165;85425.57287213524;86915;89478.55260723786;9715.951420243136;10179.84730229062;10233.232507562112;10274.126699230648;10328.122109620766;49050;49673;50735;51114.74442627763;52419.21371179511;69843.06333961467;75332.62333688297;75343.62328188324;75944.62027689826;76760.61619691867;12430.937845311077;12581;13433.66415839612;13444.529441469502;13573.52492662752;14689.19209443491;14774.704505909607;15172.620684482976;15207.315670795062;15916;12664.683382915133;12691.301978391277;12933.00474988577;13408.32958352059;13847.169169849842;13420.261885595995;13670.453181872614;14063.859361406256;14189.929050354682;14787.991825234474;12436.502539898303;12861.099723019299;12974.545890893773;13456.730865382442;14388.928055360075;10280.411017496817;10314.484275786332;10823.242373033812;10861;11168.609098681507;9707.9029209707;10607.946960265457;11315.20793544444;11674.533018679158;11866.110041747077 17:43:56 INFO - PROCESS | 20501 | __end_tp_report 17:43:56 INFO - PROCESS | 20501 | __start_cc_report 17:43:56 INFO - PROCESS | 20501 | _x_x_mozilla_cycle_collect,325 17:43:56 INFO - PROCESS | 20501 | __end_cc_report 17:43:56 INFO - PROCESS | 20501 | __startTimestamp1472604236471__endTimestamp 17:43:56 INFO - PROCESS | 20501 | 17:43:56 INFO - PROCESS | 20501 | ------- Summary: start ------- 17:43:56 INFO - PROCESS | 20501 | Number of tests: 6 17:43:56 INFO - PROCESS | 20501 | 17:43:56 INFO - PROCESS | 20501 | [#0] dojo.html Cycles:165 Average:5357.13 Median:5570.08 stddev:616.19 (11.1%) stddev-sans-first:590.87 17:43:56 INFO - PROCESS | 20501 | Values: 3048.5 3060.8 3072.7 3095.7 3104.1 5291.9 5301.8 5318.1 5328.5 5344.4 5305.1 5339.4 5400.6 5408.3 5447.4 4846.4 4934.0 4963.1 4980.3 4993.6 4966.4 4980.2 4981.7 5036.0 5044.6 4715.7 4766.8 4767.3 4904.9 4906.5 4808.7 4816.5 4843.0 4845.2 4854.1 4821.2 4864.8 4880.0 4899.6 4911.0 5369.7 5388.5 5432.5 5443.4 5444.9 5759.3 5775.5 5785.5 5803.7 5810.2 5823.7 5824.3 5851.6 5857.8 5859.2 5273.4 5278.5 5315.1 5329.2 5371.7 5814.6 5834.3 5837.2 5858.8 5869.9 5597.2 5610.3 5621.2 5624.4 5644.3 5585.8 5713.4 5754.9 5797.7 5876.1 5527.3 5545.7 5565.9 5582.4 5593.4 5603.6 5611.7 5626.1 5632.2 5643.8 4305.2 4379.4 4388.1 4432.9 4475.8 3886.6 3929.1 3967.1 3987.0 4020.9 5514.3 5516.9 5519.0 5553.1 5553.2 5683.0 5768.3 5821.2 5849.2 5951.1 5535.7 5537.3 5549.1 5570.1 5583.1 4985.5 4991.6 4995.3 5002.1 5050.9 5768.8 5920.8 5991.2 5995.3 5996.2 5834.7 5842.0 5844.2 5889.9 5920.9 5971.6 5982.3 6009.9 6013.4 6019.7 5442.5 5652.2 5661.4 5728.0 5755.1 5807.0 5859.5 5860.1 5901.1 5918.4 5697.2 5698.1 5704.2 5707.1 5720.8 5536.7 5611.4 5675.5 5682.5 5686.5 5587.5 5626.0 5628.2 5633.6 5683.3 5700.8 5733.3 5759.1 5759.9 5762.6 5414.5 5430.0 5491.6 5536.4 5602.5 17:43:56 INFO - PROCESS | 20501 | 17:43:56 INFO - PROCESS | 20501 | [#1] ext.html Cycles:180 Average:61006.36 Median:41581.08 stddev:123176.63 (296.2%) stddev-sans-first:123438.52 17:43:56 INFO - PROCESS | 20501 | Values: 542.0 587.8 595.5 597.4 630.1 38874.2 43200.8 43201.6 43214.6 43330.8 42835.6 42938.1 43148.4 43439.3 43563.6 8805.9 8912.2 8935.7 8950.2 8954.8 8802.9 8843.5 8873.0 8887.9 8888.3 8814.3 8836.2 8839.3 8908.5 8918.6 8834.4 8859.9 8893.0 8915.8 8936.6 8693.7 8799.0 8839.6 8841.0 8847.6 41054.2 41056.4 41277.4 41440.8 41598.4 3284.7 3441.3 3487.5 3495.8 3758.4 32497.7 32497.8 32554.3 32661.2 32686.8 3911.5 4300.0 4300.4 4313.5 4340.3 332199.0 333581.0 335050.0 338877.3 339257.0 59456.0 59536.7 60034.7 60050.7 60104.4 37272.3 37839.4 37856.0 39467.4 62486.4 16529.7 16638.5 16699.5 16702.8 16725.6 12558.0 12599.8 12633.5 12639.1 12643.9 19387.9 19399.2 19521.6 19523.9 19650.5 7188.4 7229.5 7296.7 7474.4 7482.6 893.6 936.3 981.6 993.4 1012.9 30189.8 30273.7 30894.8 31801.0 32079.0 1099.8 1118.6 1145.9 1157.5 1158.0 16066.4 17008.2 17466.7 17783.9 18028.8 529053.0 533795.0 537283.0 538645.0 539615.0 58756.0 59225.7 59599.7 59603.0 59624.4 1315.5 1385.7 1391.3 1417.4 1419.9 31037.1 31450.5 31476.0 32219.7 32762.5 51334.5 52166.0 52226.2 52279.5 52468.2 491506.0 495287.0 495907.0 496499.0 497889.0 28570.6 28913.2 29236.4 29246.4 29384.9 47427.8 48307.3 48357.3 48376.5 48574.5 38309.7 39898.8 41650.0 43382.8 43519.3 40057.4 40736.2 41513.6 42033.4 42281.6 34378.0 39081.6 40182.0 40368.0 41563.8 33845.8 36186.5 36340.6 36522.8 36884.8 28058.2 28279.4 28341.7 28345.3 28377.9 17:43:56 INFO - PROCESS | 20501 | 17:43:56 INFO - PROCESS | 20501 | [#2] jquery.html Cycles:180 Average:30695.80 Median:406.95 stddev:90243.80 (22175.8%) stddev-sans-first:90468.25 17:43:56 INFO - PROCESS | 20501 | Values: 385.9 389.4 393.6 400.8 413.1 18471.6 19829.8 20136.9 20150.2 20919.9 18543.6 18831.2 19041.1 19403.5 19697.6 5213.4 5217.1 5276.2 5341.8 5366.4 5305.5 5358.4 5379.8 5390.6 5394.5 5187.0 5289.4 5350.1 5367.7 5407.3 5359.4 5374.3 5382.4 5411.0 5411.7 5144.4 5156.5 5230.7 5242.5 5274.9 14223.0 14320.6 14327.2 23250.2 24248.5 2286.2 2512.4 2615.6 2658.3 3014.4 9756.6 10527.8 10951.5 12280.4 14435.1 1917.1 2006.6 2012.7 2020.2 2036.3 82287.0 82891.6 83009.5 83712.6 85366.0 10438.7 10657.1 10865.2 11473.0 11513.9 14348.3 14351.9 14391.5 14391.6 14434.4 7764.7 7786.7 8014.9 8034.2 8112.3 7559.3 7655.7 7682.0 7871.5 7907.9 4364.5 4804.2 4850.3 4936.1 4942.9 1883.9 1944.9 1951.3 1959.0 1983.6 912.5 941.2 981.7 998.8 1003.4 17446.2 18634.8 19003.2 19212.3 19257.0 821.5 827.4 891.3 923.4 928.8 9892.9 10309.5 10349.2 10361.2 10459.9 530644.0 537298.0 549613.0 559820.0 561592.0 90078.5 94547.0 97875.0 98535.0 99152.0 1037.6 1064.8 1090.8 1144.6 1144.8 17421.5 17504.0 17532.0 17610.5 17875.0 41898.8 42490.6 42783.4 43146.8 45301.1 57692.7 60477.4 60920.0 62196.4 62200.4 8595.7 8628.4 8771.5 8803.7 8883.1 12955.6 13516.8 13721.9 13761.2 14010.8 9622.6 11005.6 11418.2 11453.7 11776.6 11150.7 11523.9 11562.3 11638.6 11708.3 11338.8 11519.9 11880.6 11959.3 12345.5 8530.4 8600.5 8689.7 8853.7 8867.8 8815.2 11348.4 11531.7 11543.7 11680.8 17:43:56 INFO - PROCESS | 20501 | 17:43:56 INFO - PROCESS | 20501 | [#3] mootools.html Cycles:180 Average:5963.70 Median:484.37 stddev:3411.18 (704.3%) stddev-sans-first:3404.00 17:43:56 INFO - PROCESS | 20501 | Values: 1466.2 1483.1 1655.7 1700.7 1781.1 7618.7 8538.1 8701.5 9296.9 9308.9 8698.4 8830.0 8988.2 9015.0 9022.0 2446.3 2475.1 2481.6 2489.5 2494.5 2400.8 2485.5 2490.9 2509.7 2522.0 2472.5 2481.4 2494.9 2505.7 2511.3 2415.5 2421.1 2429.9 2474.9 2477.8 2386.0 2429.9 2434.5 2453.5 2457.9 8856.4 9015.1 9016.3 9022.1 9062.4 5297.9 5456.5 5460.5 5464.1 5489.9 3460.1 3545.2 3641.1 3641.2 3642.8 991.1 1016.9 1024.4 1030.3 1035.3 12727.0 12755.4 12778.6 12780.5 12814.4 4588.0 4728.6 4869.5 4870.9 4896.2 10588.7 10605.5 10630.7 10687.4 10691.8 5404.4 5430.5 5447.2 5453.0 5489.7 4452.3 4861.4 4958.1 4982.4 4991.6 3926.9 4080.2 4108.6 4140.5 4169.2 1327.3 1330.3 1335.4 1335.5 1340.0 677.3 769.3 781.7 790.8 798.2 5895.5 6193.4 6271.1 6277.9 6298.6 458.3 462.7 466.7 483.8 485.0 4186.7 4239.0 4357.3 4368.5 4460.8 10935.7 11253.7 11349.3 11367.3 11374.3 11151.5 11232.8 11247.2 11289.9 11296.8 8106.1 8362.7 8400.4 8415.7 8422.8 5916.2 6081.1 6187.8 6202.8 6358.1 10007.2 10402.0 10486.3 10615.7 10624.8 10180.6 10214.6 10465.6 10506.9 10612.9 7673.0 8286.6 8418.6 8452.2 8643.3 8663.6 8750.0 8751.3 8792.5 8814.8 7686.2 7689.2 7722.6 7736.9 7983.8 7859.2 7921.6 7943.8 7980.8 8049.4 7142.5 7176.2 7205.5 7232.1 7270.6 4922.7 5081.8 5229.3 5300.1 5397.6 5357.6 5447.5 5504.3 5510.7 5581.7 17:43:56 INFO - PROCESS | 20501 | 17:43:56 INFO - PROCESS | 20501 | [#4] prototype.html Cycles:180 Average:4657.11 Median:5161.81 stddev:1334.60 (25.9%) stddev-sans-first:1298.10 17:43:56 INFO - PROCESS | 20501 | Values: 323.5 335.1 337.6 344.5 345.2 5380.2 5435.5 5442.9 5500.3 5595.9 5465.2 5492.2 5505.3 5522.3 5530.5 4306.7 4311.0 4311.7 4314.3 4317.5 4147.6 4259.1 4270.9 4293.4 4303.2 4245.3 4274.7 4275.2 4276.2 4288.6 4286.3 4292.0 4301.6 4303.6 4324.2 3705.0 3857.2 3860.9 3863.2 3865.8 5348.6 5360.9 5380.2 5415.2 5428.4 4900.3 4910.8 4916.4 4916.6 4979.9 5519.2 5735.4 5736.2 5755.2 5811.3 4136.3 4156.3 4158.8 4176.7 4203.4 6075.6 6080.7 6099.2 6101.6 6135.8 4122.9 4208.2 4289.4 4331.3 4341.3 4262.7 4265.8 4267.3 4279.4 4326.5 4926.2 4937.6 4961.1 4976.4 4979.0 5699.0 5797.9 5850.8 5884.4 5887.7 1457.5 1473.8 1481.4 1490.0 1491.4 938.9 954.6 963.5 972.2 973.7 4811.4 4837.7 4881.8 4884.6 4900.0 5132.3 5139.0 5140.7 5171.7 5207.5 4691.6 4869.3 4886.5 4916.6 4959.7 2744.4 2748.0 2759.6 2759.8 2761.5 5187.3 5296.2 5332.8 5342.8 5403.3 4865.8 5249.3 5299.4 5311.8 5340.3 5291.0 5342.2 5377.2 5394.4 5394.6 5142.5 5151.9 5173.5 5210.6 5238.4 4935.6 4941.7 5067.9 5092.9 5129.6 5274.7 5282.7 5292.7 5293.2 5330.9 3854.3 4081.8 4167.2 4232.9 4245.4 5776.4 5807.2 5814.8 5838.3 5856.0 5562.7 5637.2 5677.5 5685.9 5733.5 5616.8 5655.9 5668.1 5677.2 5689.2 5639.1 5647.2 5663.8 5725.5 5726.8 5453.9 5724.4 5746.3 5788.8 5802.8 5610.6 5646.7 5654.6 5659.4 5679.6 17:43:56 INFO - PROCESS | 20501 | 17:43:56 INFO - PROCESS | 20501 | [#5] yui.html Cycles:180 Average:20900.39 Median:4568.46 stddev:30049.16 (657.8%) stddev-sans-first:30095.32 17:43:56 INFO - PROCESS | 20501 | Values: 736.7 786.3 811.7 814.6 842.6 15810.4 16215.4 16671.2 16723.0 17263.7 15352.0 15660.5 15665.1 15668.7 15681.5 795.2 800.1 801.4 805.2 834.9 829.3 832.8 837.1 838.9 839.1 867.9 871.7 872.3 873.4 874.5 868.2 871.5 871.6 871.9 872.6 634.7 635.6 637.2 637.9 638.0 16094.8 16131.7 16151.8 16174.3 16186.8 14994.4 15224.1 15287.4 15335.7 15383.0 11734.3 11740.9 11821.7 12000.6 12103.3 3687.4 3748.2 3832.4 3880.3 3913.1 77084.0 77354.0 77441.6 78907.0 79320.2 11197.7 11259.1 11298.2 11513.3 11540.8 20791.3 21030.7 21052.9 21062.8 21104.2 8208.9 8361.1 8401.4 8437.0 8561.6 4375.7 4561.5 4592.9 4691.7 4709.1 3564.6 3695.1 3713.0 3718.1 3725.8 628.1 631.5 638.6 638.6 643.1 610.7 689.8 696.6 719.6 720.7 9131.0 9649.0 9755.0 9788.3 9984.0 683.3 720.5 724.6 731.5 733.6 4575.4 4782.3 4796.5 4882.5 4890.0 108383.0 111711.0 125615.4 127128.0 129024.0 89865.6 90245.5 90410.0 92139.0 100215.0 83801.6 85165.0 85425.6 86915.0 89478.6 9716.0 10179.8 10233.2 10274.1 10328.1 49050.0 49673.0 50735.0 51114.7 52419.2 69843.1 75332.6 75343.6 75944.6 76760.6 12430.9 12581.0 13433.7 13444.5 13573.5 14689.2 14774.7 15172.6 15207.3 15916.0 12664.7 12691.3 12933.0 13408.3 13847.2 13420.3 13670.5 14063.9 14189.9 14788.0 12436.5 12861.1 12974.5 13456.7 14388.9 10280.4 10314.5 10823.2 10861.0 11168.6 9707.9 10607.9 11315.2 11674.5 11866.1 17:43:56 INFO - PROCESS | 20501 | -------- Summary: end -------- 17:43:56 INFO - PROCESS | 20501 | 17:43:57 INFO - TEST-INFO | 20501: exit 0 17:43:57 INFO - TEST-OK | dromaeo_css | took 1113561ms 17:43:57 INFO - TEST-START | kraken 17:43:57 INFO - operating with platform_type : linux_ 17:43:57 INFO - Initialising browser for kraken test... 17:43:57 INFO - TEST-INFO | started process 20862 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptSZ1XQ/profile http://localhost:49684/getInfo.html) 17:44:01 INFO - PROCESS | 20862 | __metrics Screen width/height:1600/1200 17:44:01 INFO - PROCESS | 20862 | colorDepth:24 17:44:01 INFO - PROCESS | 20862 | Browser inner width/height: 1024/697 17:44:01 INFO - PROCESS | 20862 | __metrics 17:44:02 ERROR - PROCESS | 20862 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 17:44:03 INFO - TEST-INFO | 20862: exit 0 17:44:03 INFO - Browser initialized. 17:44:03 INFO - Running cycle 1/1 for kraken test... 17:44:03 INFO - TEST-INFO | started process 20985 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptSZ1XQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:44:15 INFO - PROCESS | 20985 | RSS: Main: 191913984 17:44:15 INFO - PROCESS | 20985 | 17:44:18 INFO - PROCESS | 20985 | Cycle 1(1): loaded http://localhost:49684/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49684/tests/kraken/driver.html?testName=audio-beat-detection) 17:44:19 INFO - PROCESS | 20985 | RSS: Main: 205381632 17:44:19 INFO - PROCESS | 20985 | 17:44:21 INFO - PROCESS | 20985 | Cycle 1(1): loaded http://localhost:49684/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49684/tests/kraken/driver.html?testName=audio-dft) 17:44:22 INFO - PROCESS | 20985 | RSS: Main: 204541952 17:44:22 INFO - PROCESS | 20985 | 17:44:25 INFO - PROCESS | 20985 | Cycle 1(1): loaded http://localhost:49684/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49684/tests/kraken/driver.html?testName=audio-fft) 17:44:26 INFO - PROCESS | 20985 | RSS: Main: 195026944 17:44:26 INFO - PROCESS | 20985 | 17:44:28 INFO - PROCESS | 20985 | Cycle 1(1): loaded http://localhost:49684/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49684/tests/kraken/driver.html?testName=audio-oscillator) 17:44:28 INFO - PROCESS | 20985 | RSS: Main: 195780608 17:44:28 INFO - PROCESS | 20985 | 17:44:31 INFO - PROCESS | 20985 | Cycle 1(1): loaded http://localhost:49684/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49684/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:44:31 INFO - PROCESS | 20985 | RSS: Main: 196136960 17:44:31 INFO - PROCESS | 20985 | 17:44:34 INFO - PROCESS | 20985 | Cycle 1(1): loaded http://localhost:49684/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49684/tests/kraken/driver.html?testName=imaging-darkroom) 17:44:35 INFO - PROCESS | 20985 | RSS: Main: 196546560 17:44:35 INFO - PROCESS | 20985 | 17:44:38 INFO - PROCESS | 20985 | Cycle 1(1): loaded http://localhost:49684/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49684/tests/kraken/driver.html?testName=imaging-desaturate) 17:44:39 INFO - PROCESS | 20985 | RSS: Main: 193781760 17:44:39 INFO - PROCESS | 20985 | 17:44:42 INFO - PROCESS | 20985 | Cycle 1(1): loaded http://localhost:49684/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49684/tests/kraken/driver.html?testName=json-parse-financial) 17:44:42 INFO - PROCESS | 20985 | RSS: Main: 195252224 17:44:42 INFO - PROCESS | 20985 | 17:44:44 INFO - PROCESS | 20985 | Cycle 1(1): loaded http://localhost:49684/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49684/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:44:45 INFO - PROCESS | 20985 | RSS: Main: 195788800 17:44:45 INFO - PROCESS | 20985 | 17:44:46 INFO - PROCESS | 20985 | Cycle 1(1): loaded http://localhost:49684/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49684/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:44:47 INFO - PROCESS | 20985 | RSS: Main: 195473408 17:44:47 INFO - PROCESS | 20985 | 17:44:49 INFO - PROCESS | 20985 | Cycle 1(1): loaded http://localhost:49684/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49684/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:44:50 INFO - PROCESS | 20985 | RSS: Main: 196190208 17:44:50 INFO - PROCESS | 20985 | 17:44:53 INFO - PROCESS | 20985 | Cycle 1(1): loaded http://localhost:49684/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49684/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:44:53 INFO - PROCESS | 20985 | RSS: Main: 196059136 17:44:53 INFO - PROCESS | 20985 | 17:44:56 INFO - PROCESS | 20985 | Cycle 1(1): loaded http://localhost:49684/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49684/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:44:57 INFO - PROCESS | 20985 | RSS: Main: 196395008 17:44:57 INFO - PROCESS | 20985 | 17:44:58 INFO - PROCESS | 20985 | Cycle 1(1): loaded http://localhost:49684/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49684/tests/kraken/driver.html?testName=ai-astar) 17:44:59 INFO - PROCESS | 20985 | RSS: Main: 198017024 17:44:59 INFO - PROCESS | 20985 | 17:44:59 INFO - PROCESS | 20985 | __start_tp_report 17:44:59 INFO - PROCESS | 20985 | _x_x_mozilla_page_load 17:44:59 INFO - PROCESS | 20985 | _x_x_mozilla_page_load_details 17:44:59 INFO - PROCESS | 20985 | |i|pagename|runs| 17:44:59 INFO - PROCESS | 20985 | |0;ai-astar;108;115;114;116;119;112;113;113;113;131 17:44:59 INFO - PROCESS | 20985 | |1;audio-beat-detection;149;119;147;181;120;154;153;123;199;122 17:44:59 INFO - PROCESS | 20985 | |2;audio-dft;163;165;166;167;166;166;164;163;164;164 17:44:59 INFO - PROCESS | 20985 | |3;audio-fft;76;76;76;175;78;77;77;77;161;77 17:44:59 INFO - PROCESS | 20985 | |4;audio-oscillator;82;82;142;83;83;82;147;82;82;144 17:44:59 INFO - PROCESS | 20985 | |5;imaging-gaussian-blur;117;117;117;118;117;118;119;117;117;119 17:44:59 INFO - PROCESS | 20985 | |6;imaging-darkroom;147;147;150;146;148;147;147;148;148;147 17:44:59 INFO - PROCESS | 20985 | |7;imaging-desaturate;98;96;96;95;95;95;95;96;96;96 17:44:59 INFO - PROCESS | 20985 | |8;json-parse-financial;52;53;52;53;58;53;57;56;53;55 17:44:59 INFO - PROCESS | 20985 | |9;json-stringify-tinderbox;61;62;62;62;62;61;61;62;63;63 17:44:59 INFO - PROCESS | 20985 | |10;stanford-crypto-aes;80;80;79;80;82;85;79;88;78;78 17:44:59 INFO - PROCESS | 20985 | |11;stanford-crypto-ccm;136;149;127;129;127;142;128;129;166;142 17:44:59 INFO - PROCESS | 20985 | |12;stanford-crypto-pbkdf2;171;172;176;169;167;166;164;165;167;169 17:44:59 INFO - PROCESS | 20985 | |13;stanford-crypto-sha256-iterative;66;66;66;65;66;65;66;66;67;67 17:44:59 INFO - PROCESS | 20985 | __end_tp_report 17:44:59 INFO - PROCESS | 20985 | __start_cc_report 17:44:59 INFO - PROCESS | 20985 | _x_x_mozilla_cycle_collect,837 17:44:59 INFO - PROCESS | 20985 | __end_cc_report 17:44:59 INFO - PROCESS | 20985 | __startTimestamp1472604299044__endTimestamp 17:44:59 INFO - PROCESS | 20985 | 17:44:59 INFO - PROCESS | 20985 | ------- Summary: start ------- 17:44:59 INFO - PROCESS | 20985 | Number of tests: 14 17:44:59 INFO - PROCESS | 20985 | 17:44:59 INFO - PROCESS | 20985 | [#0] ai-astar Cycles:10 Average:115.40 Median:114.50 stddev:6.17 (5.4%) stddev-sans-first:5.93 17:44:59 INFO - PROCESS | 20985 | Values: 108.0 115.0 114.0 116.0 119.0 112.0 113.0 113.0 113.0 131.0 17:44:59 INFO - PROCESS | 20985 | 17:44:59 INFO - PROCESS | 20985 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:151.00 stddev:27.21 (18.0%) stddev-sans-first:28.84 17:44:59 INFO - PROCESS | 20985 | Values: 149.0 119.0 147.0 181.0 120.0 154.0 153.0 123.0 199.0 122.0 17:44:59 INFO - PROCESS | 20985 | 17:44:59 INFO - PROCESS | 20985 | [#2] audio-dft Cycles:10 Average:164.80 Median:165.50 stddev:1.40 (0.8%) stddev-sans-first:1.32 17:44:59 INFO - PROCESS | 20985 | Values: 163.0 165.0 166.0 167.0 166.0 166.0 164.0 163.0 164.0 164.0 17:44:59 INFO - PROCESS | 20985 | 17:44:59 INFO - PROCESS | 20985 | [#3] audio-fft Cycles:10 Average:95.00 Median:77.00 stddev:38.62 (50.2%) stddev-sans-first:40.35 17:44:59 INFO - PROCESS | 20985 | Values: 76.0 76.0 76.0 175.0 78.0 77.0 77.0 77.0 161.0 77.0 17:44:59 INFO - PROCESS | 20985 | 17:44:59 INFO - PROCESS | 20985 | [#4] audio-oscillator Cycles:10 Average:100.90 Median:82.00 stddev:30.00 (36.6%) stddev-sans-first:31.03 17:44:59 INFO - PROCESS | 20985 | Values: 82.0 82.0 142.0 83.0 83.0 82.0 147.0 82.0 82.0 144.0 17:44:59 INFO - PROCESS | 20985 | 17:44:59 INFO - PROCESS | 20985 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.50 stddev:0.84 (0.7%) stddev-sans-first:0.87 17:44:59 INFO - PROCESS | 20985 | Values: 117.0 117.0 117.0 118.0 117.0 118.0 119.0 117.0 117.0 119.0 17:44:59 INFO - PROCESS | 20985 | 17:44:59 INFO - PROCESS | 20985 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 17:44:59 INFO - PROCESS | 20985 | Values: 147.0 147.0 150.0 146.0 148.0 147.0 147.0 148.0 148.0 147.0 17:44:59 INFO - PROCESS | 20985 | 17:44:59 INFO - PROCESS | 20985 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.53 17:44:59 INFO - PROCESS | 20985 | Values: 98.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 17:44:59 INFO - PROCESS | 20985 | 17:44:59 INFO - PROCESS | 20985 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:2.15 (4.0%) stddev-sans-first:2.13 17:44:59 INFO - PROCESS | 20985 | Values: 52.0 53.0 52.0 53.0 58.0 53.0 57.0 56.0 53.0 55.0 17:44:59 INFO - PROCESS | 20985 | 17:44:59 INFO - PROCESS | 20985 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 17:44:59 INFO - PROCESS | 20985 | Values: 61.0 62.0 62.0 62.0 62.0 61.0 61.0 62.0 63.0 63.0 17:44:59 INFO - PROCESS | 20985 | 17:44:59 INFO - PROCESS | 20985 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.00 stddev:3.25 (4.1%) stddev-sans-first:3.43 17:44:59 INFO - PROCESS | 20985 | Values: 80.0 80.0 79.0 80.0 82.0 85.0 79.0 88.0 78.0 78.0 17:44:59 INFO - PROCESS | 20985 | 17:44:59 INFO - PROCESS | 20985 | [#11] stanford-crypto-ccm Cycles:10 Average:137.50 Median:139.00 stddev:12.66 (9.1%) stddev-sans-first:13.42 17:44:59 INFO - PROCESS | 20985 | Values: 136.0 149.0 127.0 129.0 127.0 142.0 128.0 129.0 166.0 142.0 17:44:59 INFO - PROCESS | 20985 | 17:44:59 INFO - PROCESS | 20985 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:169.00 stddev:3.63 (2.1%) stddev-sans-first:3.74 17:44:59 INFO - PROCESS | 20985 | Values: 171.0 172.0 176.0 169.0 167.0 166.0 164.0 165.0 167.0 169.0 17:44:59 INFO - PROCESS | 20985 | 17:44:59 INFO - PROCESS | 20985 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 17:44:59 INFO - PROCESS | 20985 | Values: 66.0 66.0 66.0 65.0 66.0 65.0 66.0 66.0 67.0 67.0 17:44:59 INFO - PROCESS | 20985 | -------- Summary: end -------- 17:44:59 INFO - PROCESS | 20985 | 17:45:00 INFO - TEST-INFO | 20985: exit 0 17:45:00 INFO - TEST-OK | kraken | took 62717ms 17:45:00 INFO - SUITE-END | took 1176s 17:45:00 INFO - Completed test suite (00:19:36) 17:45:00 INFO - javascript benchmark 17:45:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7257.4653330101, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3048.542718592211, 3060.7857449978496, 3072.692730726927, 3095.690430956903, 3104.0998110547944, 5291.9470805291985, 5301.7879284828605, 5318.0693378658725, 5328.520433161015, 5344.438833922441, 5305.098133317336, 5339.359276886769, 5400.594955378343, 5408.2698835657175, 5447.373552041517, 4846.369971903657, 4934.0, 4963.057019166346, 4980.302757613937, 4993.6005119590345, 4966.428860681031, 4980.203167493201, 4981.72600506972, 5036.0, 5044.596432285409, 4715.693479923794, 4766.785494652714, 4767.284907263938, 4904.901901961958, 4906.533879281463, 4808.663393562452, 4816.470188279286, 4843.0, 4845.248986407078, 4854.053459575384, 4821.180399332122, 4864.805407783684, 4880.0, 4899.632527560411, 4911.0, 5369.650972686802, 5388.544507810563, 5432.456754324576, 5443.401225865152, 5444.91832622511, 5759.308882934075, 5775.48020678141, 5785.537157027427, 5803.7098145093, 5810.244668193108, 5823.650580965155, 5824.3302020267365, 5851.64890106595, 5857.76568937242, 5859.150423188614, 5273.419923808378, 5278.5249327560705, 5315.096433606296, 5329.200619907045, 5371.677699338053, 5814.622049566765, 5834.299884013945, 5837.241158649348, 5858.794942177004, 5869.882602347929, 5597.216389705444, 5610.298712660918, 5621.213030175779, 5624.3813180550105, 5644.266245388073, 5585.832425027255, 5713.371529131792, 5754.88490230193, 5797.710114494258, 5876.08920617305, 5527.309086364205, 5545.724483368767, 5565.888682226333, 5582.413846546136, 5593.440655934455, 5603.551715862721, 5611.7474713637985, 5626.071698169756, 5632.211490391349, 5643.80246691372, 4305.203537345538, 4379.4087798147475, 4388.144311859157, 4432.911341773147, 4475.753833539186, 3886.630770076895, 3929.135590170158, 3967.0875698589484, 3987.043109653662, 4020.8793736187963, 5514.338279406497, 5516.9448305517235, 5519.0, 5553.055980483327, 5553.222548843165, 5683.0, 5768.307803063659, 5821.18503409523, 5849.239598852122, 5951.1073338999495, 5535.6955367455175, 5537.335519737577, 5549.084401073777, 5570.080936645408, 5583.106702927594, 4985.52637499437, 4991.6006719463085, 4995.275685025724, 5002.124628190052, 5050.9494905051215, 5768.826935191951, 5920.792772253037, 5991.161237426677, 5995.340512543617, 5996.16053752475, 5834.737436815269, 5841.970790146022, 5844.15259787337, 5889.911651325147, 5920.8815823684145, 5971.641701497924, 5982.282126144716, 6009.939900601113, 6013.428724271187, 6019.668918209541, 5442.482964118402, 5652.152177173457, 5661.405552416937, 5728.0, 5755.050416681201, 5806.970965145148, 5859.5019423349495, 5860.062390017577, 5901.0558310670085, 5918.437748413894, 5697.230873832145, 5698.116791897262, 5704.229928959538, 5707.1153971134545, 5720.771169153188, 5536.667799932017, 5611.382747897646, 5675.545956323567, 5682.488576028178, 5686.516646084963, 5587.525060369914, 5626.043572592587, 5628.240187574789, 5633.577481688808, 5683.346415162309, 5700.800471983461, 5733.31200255972, 5759.107338362561, 5759.8560035999435, 5762.625429347079, 5414.485623865727, 5430.0, 5491.588130890279, 5536.390996990247, 5602.52378547828], "value": 5314.764242655198, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.0179961112066, 587.7560812262911, 595.5414330965157, 597.4294548705989, 630.1367127035961, 38874.22251554967, 43200.78399608001, 43201.56798432015, 43214.567854321445, 43330.78334608326, 42835.57164428355, 42938.14123717524, 43148.35277470833, 43439.34840977388, 43563.564364356345, 8805.91194088059, 8912.242459390927, 8935.687250946186, 8950.239229665454, 8954.820903581924, 8802.86795698065, 8843.46939183651, 8873.0, 8887.866681999743, 8888.333374996868, 8814.338924580683, 8836.248918841875, 8839.29285657146, 8908.465492070496, 8918.643254269822, 8834.42576232546, 8859.911400885972, 8893.0, 8915.821683566357, 8936.642534298686, 8693.739187824376, 8798.956005219932, 8839.60221790021, 8840.955795221047, 8847.646094156225, 41054.178916421806, 41056.384154237414, 41277.380839287434, 41440.79279603613, 41598.37602435936, 3284.655111213336, 3441.3117376524547, 3487.511748355232, 3495.790252584853, 3758.39865621502, 32497.6750232497, 32497.837510812296, 32554.348913021844, 32661.18347041319, 32686.836565817255, 3911.4915061041884, 4299.9570004300185, 4300.419443375135, 4313.525512193656, 4340.327249276367, 332199.0, 333581.0, 335050.0, 338877.3056134728, 339257.0, 59456.0, 59536.70231648814, 60034.69982650146, 60050.699746500984, 60104.39895600988, 37272.25455490875, 37839.432408513894, 37856.0, 39467.407988880186, 62486.375136248964, 16529.6694066118, 16638.502534771927, 16699.499015029567, 16702.83297167037, 16725.58186045334, 12558.0, 12599.811002834966, 12633.494660213672, 12639.052071094704, 12643.87356126427, 19387.90306048461, 19399.24531315501, 19521.624543520687, 19523.902380488005, 19650.50873728168, 7188.424926005907, 7229.493935424575, 7296.6716497757725, 7474.40204783616, 7482.625868706543, 893.5666201892077, 936.3492372800974, 981.5877331520778, 993.438707130469, 1012.9037741414554, 30189.849050754605, 30273.697263027527, 30894.845525772227, 31801.0, 32079.0, 1099.7729597564994, 1118.5917140243753, 1145.8796826333282, 1157.5080590748898, 1158.0, 16066.357345706274, 17008.187586371077, 17466.737998930028, 17783.911080444515, 18028.819711802975, 529053.0, 533795.0, 537283.0, 538645.0, 539615.0, 58756.0, 59225.703871480364, 59599.7420270874, 59603.0, 59624.40375596189, 1315.5132600937523, 1385.6535866033491, 1391.2765362011899, 1417.362187015847, 1419.8935079868845, 31037.051480109352, 31450.528242076845, 31476.0, 32219.677803221668, 32762.50856237206, 51334.48665513297, 52166.0, 52226.21660675017, 52279.477205227464, 52468.21297680614, 491506.0, 495287.0, 495907.0, 496499.0, 497889.0, 28570.571441428812, 28913.229317162433, 29236.415271694023, 29246.415071698873, 29384.853075734485, 47427.762861185474, 48307.275390869865, 48357.27464088112, 48376.5162348372, 48574.51425485841, 38309.656392774355, 39898.800505997286, 41650.0, 43382.78308608563, 43519.347209791245, 40057.39913901352, 40736.1852762949, 41513.58486415097, 42033.369499458146, 42281.577184229, 34378.0, 39081.6091839078, 40182.0, 40368.0, 41563.7921810389, 33845.83077084599, 36186.4572031425, 36340.636593633724, 36522.8173859129, 36884.81557592195, 28058.158255252376, 28279.434411311246, 28341.71658283391, 28345.29136771515, 28377.858110709316], "value": 19943.07899855382, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.90545316397487, 389.3808843938138, 393.61622418142304, 400.84166754132116, 413.0520455554502, 18471.63056738866, 19829.801701982975, 20136.8993155034, 20150.19399224031, 20919.895400522975, 18543.629127417476, 18831.24675012998, 19041.143148558313, 19403.514912127168, 19697.63628364595, 5213.400458947222, 5217.087009773293, 5276.2085687146855, 5341.786328546873, 5366.356037275533, 5305.495977882114, 5358.3569971603265, 5379.81170659027, 5390.568754499631, 5394.541463975547, 5186.974065129669, 5289.418164001957, 5350.143976963686, 5367.704776237305, 5407.324084489439, 5359.410464848864, 5374.3013408256875, 5382.381026181981, 5410.972945135289, 5411.675299482004, 5144.408393034774, 5156.510131537498, 5230.712310822903, 5242.475752424765, 5274.868128296785, 14223.0, 14320.64198395038, 14327.212003339811, 23250.186243481396, 24248.51502969931, 2286.1655495743935, 2512.4221429071235, 2615.6076588511687, 2658.255688407249, 3014.3669829335868, 9756.609735610567, 10527.78944421115, 10951.507182176822, 12280.385980700928, 14435.061720988208, 1917.1277068933603, 2006.5685877536255, 2012.7282816819834, 2020.1515363547346, 2036.256766280312, 82287.0, 82891.58554207251, 83009.50971470865, 83712.58143709242, 85366.0, 10438.68683939483, 10657.147428205724, 10865.239433239756, 11473.0, 11513.88486115145, 14348.282585870873, 14351.928240358731, 14391.496297629532, 14391.568252952427, 14434.350454229374, 7764.728234511765, 7786.727464538714, 8014.879776803353, 8034.196580341919, 8112.3104536113915, 7559.3196612304055, 7655.6937722490475, 7681.961590192013, 7871.527708337518, 7907.881381779278, 4364.454443194601, 4804.183288840905, 4850.320955066293, 4936.136176169156, 4942.9258561121615, 1883.9434816955513, 1944.8541359398102, 1951.268274397101, 1958.9902050489657, 1983.6429442700164, 912.5118061836886, 941.2140862379989, 981.7153025622632, 998.805232979562, 1003.3578509753763, 17446.214920328617, 18634.81365186358, 19003.23987040503, 19212.327568535035, 19256.97801730826, 821.4701517521165, 827.432016329065, 891.3404080980029, 923.422860712055, 928.758522784081, 9892.851607225897, 10309.5145592381, 10349.223808214414, 10361.171106311476, 10459.895401045893, 530644.0, 537298.0, 549613.0154793843, 559820.0, 561592.0, 90078.54960725154, 94547.0, 97875.0, 98535.0, 99152.0, 1037.5797801890246, 1064.7763969566322, 1090.836374543809, 1144.6165534546021, 1144.7538779162353, 17421.47735567935, 17504.0, 17532.0, 17610.471685849447, 17875.0, 41898.79050604728, 42490.57509424866, 42783.35824962566, 43146.784266078466, 45301.09397812091, 57692.711536442046, 60477.39522604718, 60920.0, 62196.37803621906, 62200.37799621946, 8595.65617375298, 8628.439151455135, 8771.473711577326, 8803.735887923373, 8883.067277935983, 12955.611331660066, 13516.79724804109, 13721.931390342985, 13761.243131627856, 14010.789838152232, 9622.566984485855, 11005.61480348184, 11418.200725949437, 11453.713657158638, 11776.646700598996, 11150.72123196894, 11523.942380288045, 11562.340661648037, 11638.592649257236, 11708.297502149899, 11338.773224535627, 11519.94240028828, 11880.643580692593, 11959.282443053444, 12345.506179753069, 8530.445521041112, 8600.483970961763, 8689.695860644848, 8853.73438796837, 8867.778305542413, 8815.206631403205, 11348.432578371214, 11531.654050378502, 11543.711407214887, 11680.766384672428], "value": 9140.006182831612, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1466.200920498328, 1483.0879009409211, 1655.7433597792347, 1700.7278835386342, 1781.1272476486517, 7618.73334433295, 8538.060813310538, 8701.47791132531, 9296.90703092969, 9308.90691093089, 8698.39111262212, 8830.028696843343, 8988.191062804346, 9014.954925225366, 9021.954890225556, 2446.3272600034957, 2475.1089607741287, 2481.553320402327, 2489.4523204894895, 2494.538510375586, 2400.8199385046105, 2485.453200295932, 2490.9377265568414, 2509.6737424134835, 2521.962170567443, 2472.4807790364043, 2481.4292712676097, 2494.9251522454356, 2505.6993160820725, 2511.3219430753684, 2415.5048215115858, 2421.1162925532144, 2429.890654920524, 2474.8638824864624, 2477.7893879020303, 2385.9522809543887, 2429.8906549205153, 2434.476587533689, 2453.4847681986803, 2457.8893949772305, 8856.424332418437, 9015.053419390935, 9016.323775716783, 9022.052684468103, 9062.365634405594, 5297.894042119136, 5456.48163424474, 5460.535854452376, 5464.0711079116645, 5489.945100548984, 3460.1003739027783, 3545.2377738786286, 3641.1248207173326, 3641.1625326175126, 3642.797876700709, 991.1327588360185, 1016.8830584482805, 1024.3853687787343, 1030.2582140858644, 1035.2701345551368, 12727.0, 12755.36223188846, 12778.552750653682, 12780.488780448772, 12814.423350949322, 4587.9541204588195, 4728.598069164091, 4869.488703686133, 4870.853874383774, 4896.241082632127, 10588.682339529827, 10605.469726513798, 10630.681079567625, 10687.358758474516, 10691.786164276671, 5404.3784964728775, 5430.5384042356845, 5447.155690867922, 5453.045716999509, 5489.670619762827, 4452.30989196675, 4861.368022157097, 4958.132326842788, 4982.3522942018035, 4991.550760431579, 3926.9214615707524, 4080.18396320737, 4108.630223279919, 4140.503139623264, 4169.207850508394, 1327.3429652322163, 1330.2750001249342, 1335.3857225676104, 1335.5442567601167, 1339.9866001339863, 677.3091446724313, 769.3076231391681, 781.6560713286136, 790.8022994251437, 798.2297083314629, 5895.469407753323, 6193.38066193377, 6271.090691849657, 6277.905831412532, 6298.559100862895, 458.3422788298802, 462.69462154978225, 466.6733286699324, 483.7605385334282, 484.97817598208167, 4186.748795072305, 4238.957610423856, 4357.302831546937, 4368.453943257093, 4460.821567137278, 10935.726606834734, 11253.66239012831, 11349.319040857576, 11367.317960922372, 11374.260673056391, 11151.498182581803, 11232.775344493064, 11247.212695111428, 11289.943550282196, 11296.830547541793, 8106.148854370324, 8362.665493380318, 8400.41197116196, 8415.747527574182, 8422.83154336922, 5916.201312822886, 6081.094517469604, 6187.783427580013, 6202.782902598387, 6358.141650877073, 10007.249456290952, 10402.0, 10486.318389304672, 10615.681529554126, 10624.84062739044, 10180.625615542103, 10214.591416343263, 10465.633702820365, 10506.947465262625, 10612.946935265274, 7673.0, 8286.627101780314, 8418.6211620476, 8452.197041281068, 8643.265322447662, 8663.566821659018, 8749.956250218707, 8751.343649226461, 8792.47245165292, 8814.779630509289, 7686.231376862269, 7689.231076892266, 7722.575258360844, 7736.922630773845, 7983.800404989922, 7859.214078592095, 7921.603919804102, 7943.84112317762, 7980.8004799878145, 8049.396295277995, 7142.5000249982, 7176.174739904978, 7205.459590530626, 7232.0959880015, 7270.636468176675, 4922.680025798311, 5081.7713202905215, 5229.294045303835, 5300.1254792958725, 5397.59518036141, 5357.624966252325, 5447.536959358499, 5504.311961004874, 5510.724463776875, 5581.6930068846605], "value": 4664.325021442648, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.4969622237421, 335.07519246878616, 337.5763416911777, 344.546920799149, 345.2404709638792, 5380.21986811912, 5435.483629055238, 5442.91835622465, 5500.339959204896, 5595.916061259084, 5465.152901300305, 5492.176173573956, 5505.311836020497, 5522.260487946294, 5530.5022547970675, 4306.741595504264, 4310.956890431087, 4311.719738217022, 4314.303560274829, 4317.460317460317, 4147.6474499667565, 4259.10558782656, 4270.871873843789, 4293.420388247578, 4303.182395344875, 4245.320748680212, 4274.722143060691, 4275.187714334266, 4276.23027854986, 4288.571142885718, 4286.292761694317, 4292.0, 4301.591348821857, 4303.634191093761, 4324.243257429937, 3704.9629503704887, 3857.2092720992127, 3860.884173474772, 3863.2466668999555, 3865.768053916746, 5348.625596208267, 5360.9463905360835, 5380.21986811914, 5415.160650099241, 5428.375736790241, 4900.289458028566, 4910.754462276907, 4916.385451818523, 4916.557509824133, 4979.875503112415, 5519.172124181365, 5735.426457354273, 5736.1682556029145, 5755.194272801811, 5811.27359080115, 4136.255474014676, 4156.314208155681, 4158.812853421603, 4176.728512646669, 4203.369494575808, 6075.569772091155, 6080.665563394012, 6099.207103076616, 6101.60339577926, 6135.846603834895, 4122.876313710593, 4208.22147902639, 4289.442372491556, 4331.263685173528, 4341.261985462479, 4262.65898728101, 4265.76538290397, 4267.317229243306, 4279.422277992493, 4326.502452217972, 4926.187179115477, 4937.5556199942175, 4961.107000739829, 4976.357801925428, 4979.029089327619, 5699.0, 5797.9420205797405, 5850.824475265749, 5884.352721200665, 5887.735051922588, 1457.4680241711699, 1473.7789331600345, 1481.4148411377446, 1489.9942538786493, 1491.4332553629552, 938.9108034736689, 954.5752140297501, 963.5086106085806, 972.2222222222194, 973.6689525561343, 4811.422629284508, 4837.709737415696, 4881.780319885614, 4884.609231261491, 4899.951000490021, 5132.28148059272, 5138.997895410434, 5140.691558506502, 5171.741412929414, 5207.479252074838, 4691.577758001797, 4869.342638743724, 4886.486918873538, 4916.608409068197, 4959.677620954699, 2744.4373903349765, 2747.958780618292, 2759.599858020576, 2759.779217662582, 2761.4891245119315, 5187.299714538564, 5296.232046353257, 5332.840014799563, 5342.813001544927, 5403.324584426947, 4865.8053677853195, 5249.265102885599, 5299.436666183485, 5311.840644780663, 5340.279062326536, 5290.973545132327, 5342.2253773202665, 5377.166539186433, 5394.406615272317, 5394.595405344615, 5142.534377702337, 5151.871203219949, 5173.508516690908, 5210.557102646318, 5238.449962754008, 4935.582851777709, 4941.678790878582, 5067.9103992640285, 5092.872678183075, 5129.563987060992, 5274.683518988873, 5282.735863206901, 5292.655977361459, 5293.232481290114, 5330.8933821324135, 3854.3062248795486, 4081.755094694328, 4167.229062623424, 4232.936505952352, 4245.448091748053, 5776.393478684846, 5807.245058142415, 5814.761316892942, 5838.2702162229725, 5856.0, 5562.749676264659, 5637.154426836008, 5677.51741102011, 5685.857853553529, 5733.512651424676, 5616.775328986958, 5655.915161272502, 5668.064769313017, 5677.176809362537, 5689.207899511641, 5639.125935480007, 5647.181158731879, 5663.801766938137, 5725.456081672234, 5726.770929162787, 5453.863653408696, 5724.398938111605, 5746.2529871116485, 5788.768449261982, 5802.796902108406, 5610.551155907599, 5646.745896434588, 5654.575906807088, 5659.405762395054, 5679.602427830012], "value": 4234.24187421553, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.6795443981865, 786.3394748411333, 811.7199566149678, 814.576420261464, 842.6418772021897, 15810.367585296588, 16215.432459863907, 16671.249793759296, 16723.0, 17263.654726905486, 15352.0, 15660.451884184056, 15665.060096394225, 15668.686626267468, 15681.529554113366, 795.2365728900263, 800.0878997942336, 801.3669201330941, 805.2269820971874, 834.9457285276468, 829.2702421868777, 832.8251067275879, 837.1210229259284, 838.9286910612606, 839.08539691736, 867.9001914779818, 871.6818361298144, 872.2629378175432, 873.4191762477944, 874.514644372373, 868.1882439918664, 871.4901782457271, 871.5903525343078, 871.9346049046347, 872.5986046418654, 634.7270673610345, 635.6091004032533, 637.2066776862836, 637.8501052252764, 638.0, 16094.75857862133, 16131.677366452604, 16151.757723634155, 16174.27215775293, 16186.838131618651, 14994.400223991028, 15224.086554806747, 15287.388504459808, 15335.693286134327, 15383.0, 11734.295942243407, 11740.882591174064, 11821.704457388549, 12000.63998080059, 12103.273803571814, 3687.3547129252543, 3748.19413826026, 3832.405977073558, 3880.3209438348176, 3913.139109395957, 77084.0, 77354.0, 77441.61279193625, 78907.0, 79320.20679793185, 11197.72005699864, 11259.099272058216, 11298.20912536131, 11513.251638643462, 11540.826887596693, 20791.272305469538, 21030.684539731916, 21052.894735526224, 21062.789372106083, 21104.155833766785, 8208.891969106944, 8361.080281169066, 8401.36989725773, 8436.957815211008, 8561.614727337284, 4375.671824613103, 4561.543845615412, 4592.862214133581, 4691.6628760803005, 4709.0817290628, 3564.6078931317534, 3695.131644063643, 3713.0, 3718.1262403335195, 3725.795081270502, 628.0673200297555, 631.5452873930763, 638.559394018126, 638.5721566550422, 643.0643413832862, 610.7465401858268, 689.7585844954326, 696.5681277607814, 719.6221983458621, 720.7009091227083, 9130.95434522823, 9649.035096490295, 9755.0, 9788.265880059023, 9984.003199360157, 683.3166833166833, 720.495653042872, 724.641302555228, 731.5427857589007, 733.5598640815468, 4575.382323386367, 4782.274103760892, 4796.472388037313, 4882.511748825089, 4889.951100488949, 108383.0, 111711.0, 125615.37192314163, 127128.0, 129024.0, 89865.55067224622, 90245.54877225703, 90410.0, 92139.0, 100215.0, 83801.58099209465, 85165.0, 85425.57287213524, 86915.0, 89478.55260723786, 9715.951420243136, 10179.84730229062, 10233.232507562112, 10274.126699230648, 10328.122109620766, 49050.0, 49673.0, 50735.0, 51114.74442627763, 52419.21371179511, 69843.06333961467, 75332.62333688297, 75343.62328188324, 75944.62027689826, 76760.61619691867, 12430.937845311077, 12581.0, 13433.66415839612, 13444.529441469502, 13573.52492662752, 14689.19209443491, 14774.704505909607, 15172.620684482976, 15207.315670795062, 15916.0, 12664.683382915133, 12691.301978391277, 12933.00474988577, 13408.32958352059, 13847.169169849842, 13420.261885595995, 13670.453181872614, 14063.859361406256, 14189.929050354682, 14787.991825234474, 12436.502539898303, 12861.099723019299, 12974.545890893773, 13456.730865382442, 14388.928055360075, 10280.411017496817, 10314.484275786332, 10823.242373033812, 10861.0, 11168.609098681507, 9707.9029209707, 10607.946960265457, 11315.20793544444, 11674.533018679158, 11866.110041747077], "value": 7636.215029322857, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 114.0, 116.0, 119.0, 112.0, 113.0, 113.0, 113.0, 131.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 119.0, 147.0, 181.0, 120.0, 154.0, 153.0, 123.0, 199.0, 122.0], "value": 146.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 166.0, 167.0, 166.0, 166.0, 164.0, 163.0, 164.0, 164.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 175.0, 78.0, 77.0, 77.0, 77.0, 161.0, 77.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 142.0, 83.0, 83.0, 82.0, 147.0, 82.0, 82.0, 144.0], "value": 100.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 119.0, 117.0, 117.0, 119.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 150.0, 146.0, 148.0, 147.0, 147.0, 148.0, 148.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 52.0, 53.0, 58.0, 53.0, 57.0, 56.0, 53.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 62.0, 61.0, 61.0, 62.0, 63.0, 63.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 80.0, 82.0, 85.0, 79.0, 88.0, 78.0, 78.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 149.0, 127.0, 129.0, 127.0, 142.0, 128.0, 129.0, 166.0, 142.0], "value": 137.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 176.0, 169.0, 167.0, 166.0, 164.0, 165.0, 167.0, 169.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0, 67.0, 67.0], "value": 66.0, "unit": "score"}]}]} 17:45:00 INFO - Return code: 0 17:45:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:45:00 ERROR - # TBPL SUCCESS # 17:45:00 INFO - Running post-action listener: _resource_record_post_action 17:45:00 INFO - [mozharness: 2016-08-31 00:45:00.857162Z] Finished run-tests step (success) 17:45:00 INFO - Running post-run listener: _resource_record_post_run 17:45:00 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 418721792; Read time: 12; Write time: 382380 17:45:00 INFO - TinderboxPrint: CPU usage
13.4% 17:45:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:45:00 INFO - TinderboxPrint: I/O write bytes / time
418,721,792 / 382,380 17:45:00 INFO - TinderboxPrint: CPU idle
8,242.0 (86.6%) 17:45:00 INFO - TinderboxPrint: CPU user
1,215.3 (12.8%) 17:45:00 INFO - TinderboxPrint: Swap in / out
0 / 0 17:45:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 128851968; Read time: 0; Write time: 98752 17:45:00 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 288878592; Read time: 0; Write time: 283572 17:45:01 INFO - Running post-run listener: _upload_blobber_files 17:45:01 INFO - Blob upload gear active. 17:45:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:45:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:45:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:45:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:45:01 INFO - (blobuploader) - INFO - Open directory for files ... 17:45:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:45:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:45:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:08 INFO - (blobuploader) - INFO - Done attempting. 17:45:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:45:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:45:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:09 INFO - (blobuploader) - INFO - Done attempting. 17:45:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:45:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:45:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:10 INFO - (blobuploader) - INFO - Done attempting. 17:45:10 INFO - (blobuploader) - INFO - Iteration through files over. 17:45:10 INFO - Return code: 0 17:45:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:45:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:45:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b309085f0e815800adbd513a95ff97a101a0e14ebcae655e4b5cbc71e7d2c20ef832f77ba27efaefd98f23567537488c4237e74b9d99c8731ece00915dcd9224", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5496a824950fe0c703d04a9e1005317c6a0c8ab611cd804dd29863105742b6a5398a851a2f1efc835a1dcd400f074794855cabc525000aa3fe6f7a4885720e08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68d5bd0438a457aadf4f5626490c23cd5cb3610480ce00ac267ba3dc03539b5af45a3c2a5a8da624a4591268b20b0077739a04d337c684ecd40bd43f3e01f0aa"} 17:45:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:45:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:45:10 INFO - Contents: 17:45:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b309085f0e815800adbd513a95ff97a101a0e14ebcae655e4b5cbc71e7d2c20ef832f77ba27efaefd98f23567537488c4237e74b9d99c8731ece00915dcd9224", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5496a824950fe0c703d04a9e1005317c6a0c8ab611cd804dd29863105742b6a5398a851a2f1efc835a1dcd400f074794855cabc525000aa3fe6f7a4885720e08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68d5bd0438a457aadf4f5626490c23cd5cb3610480ce00ac267ba3dc03539b5af45a3c2a5a8da624a4591268b20b0077739a04d337c684ecd40bd43f3e01f0aa"} 17:45:10 INFO - Running post-run listener: copy_logs_to_upload_dir 17:45:10 INFO - Copying logs to upload dir... 17:45:10 INFO - mkdir: /builds/slave/test/build/upload/logs 17:45:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.343777 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-08-30 17:45:09.917984) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 17:45:09.921033) ========= 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=17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b309085f0e815800adbd513a95ff97a101a0e14ebcae655e4b5cbc71e7d2c20ef832f77ba27efaefd98f23567537488c4237e74b9d99c8731ece00915dcd9224", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5496a824950fe0c703d04a9e1005317c6a0c8ab611cd804dd29863105742b6a5398a851a2f1efc835a1dcd400f074794855cabc525000aa3fe6f7a4885720e08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68d5bd0438a457aadf4f5626490c23cd5cb3610480ce00ac267ba3dc03539b5af45a3c2a5a8da624a4591268b20b0077739a04d337c684ecd40bd43f3e01f0aa"} build_url:https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011387 build_url: 'https://queue.taskcluster.net/v1/task/IUGHpk9hSEuNaqR76oe7nA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b309085f0e815800adbd513a95ff97a101a0e14ebcae655e4b5cbc71e7d2c20ef832f77ba27efaefd98f23567537488c4237e74b9d99c8731ece00915dcd9224", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5496a824950fe0c703d04a9e1005317c6a0c8ab611cd804dd29863105742b6a5398a851a2f1efc835a1dcd400f074794855cabc525000aa3fe6f7a4885720e08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/68d5bd0438a457aadf4f5626490c23cd5cb3610480ce00ac267ba3dc03539b5af45a3c2a5a8da624a4591268b20b0077739a04d337c684ecd40bd43f3e01f0aa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 17:45:09.947269) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 17:45:09.947573) ========= 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=17051fcd5208b27b50bedfeb000001dd-1472597853.535488-1214161625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 17:45:10.031529) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 17:45:10.031885) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 17:45:10.032206) ========= ========= Total master_lag: 0.17 =========