builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-007 starttime: 1471302533.82 results: success (0) buildid: 20160815145032 builduid: 50515f9696784206b73550064f5e7a21 revision: 054d4856cea6150a6638e5daf7913713281af97d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 16:08:53.815333) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-15 16:08:53.815835) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 16:08:53.816132) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-15 16:08:53.831388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:08:53.831866) ========= 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=923d835db2ba3686ebe126b700000192-1471302534.28445-601915454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-15 16:08:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 215M=0s 2016-08-15 16:08:55 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101132 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:08:53.948137) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:08:53.948459) ========= 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=923d835db2ba3686ebe126b700000192-1471302534.28445-601915454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018676 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:08:53.998796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:08:53.999141) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 054d4856cea6150a6638e5daf7913713281af97d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 054d4856cea6150a6638e5daf7913713281af97d --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=923d835db2ba3686ebe126b700000192-1471302534.28445-601915454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-15 16:08:55,196 truncating revision to first 12 chars 2016-08-15 16:08:55,197 Setting DEBUG logging. 2016-08-15 16:08:55,197 attempt 1/10 2016-08-15 16:08:55,197 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/054d4856cea6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-15 16:08:55,518 unpacking tar archive at: mozilla-central-054d4856cea6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.643264 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:08:54.658574) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 16:08:54.658895) ========= script_repo_revision: 054d4856cea6150a6638e5daf7913713281af97d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-15 16:08:54.659306) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 16:08:54.659706) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-15 16:08:54.673833) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-15 16:08:54.674198) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1471302534.28445-601915454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:08:55 INFO - MultiFileLogger online at 20160815 16:08:55 in /builds/slave/test 16:08:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:08:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:08:55 INFO - {'append_to_log': False, 16:08:55 INFO - 'base_work_dir': '/builds/slave/test', 16:08:55 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:08:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:08:55 INFO - 'branch': 'Firefox-Non-PGO', 16:08:55 INFO - 'buildbot_json_path': 'buildprops.json', 16:08:55 INFO - 'config_files': ('talos/linux_config.py',), 16:08:55 INFO - 'default_actions': ('clobber', 16:08:55 INFO - 'read-buildbot-config', 16:08:55 INFO - 'download-and-extract', 16:08:55 INFO - 'populate-webroot', 16:08:55 INFO - 'create-virtualenv', 16:08:55 INFO - 'install', 16:08:55 INFO - 'run-tests'), 16:08:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:08:55 INFO - 'download_minidump_stackwalk': True, 16:08:55 INFO - 'download_symbols': 'ondemand', 16:08:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:08:55 INFO - 'tooltool.py': '/tools/tooltool.py', 16:08:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:08:55 INFO - '/tools/misc-python/virtualenv.py')}, 16:08:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:08:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:08:55 INFO - 'installer_path': 'installer.exe', 16:08:55 INFO - 'log_level': 'info', 16:08:55 INFO - 'log_name': 'talos', 16:08:55 INFO - 'log_to_console': True, 16:08:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:08:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:08:55 INFO - 'opt_config_files': (), 16:08:55 INFO - 'pip_index': False, 16:08:55 INFO - 'sps_profile': False, 16:08:55 INFO - 'sps_profile_interval': 0, 16:08:55 INFO - 'suite': 'dromaeojs', 16:08:55 INFO - 'system_bits': '32', 16:08:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:08:55 INFO - 'title': 'talos-linux64-ix-007', 16:08:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:08:55 INFO - 'use_talos_json': True, 16:08:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:08:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:08:55 INFO - 'work_dir': 'build'} 16:08:55 INFO - [mozharness: 2016-08-15 23:08:55.966861Z] Running clobber step. 16:08:55 INFO - Running pre-action listener: _resource_record_pre_action 16:08:55 INFO - Running main action method: clobber 16:08:55 INFO - rmtree: /builds/slave/test/build 16:08:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:08:56 INFO - Running post-action listener: _resource_record_post_action 16:08:56 INFO - [mozharness: 2016-08-15 23:08:56.438518Z] Finished clobber step (success) 16:08:56 INFO - [mozharness: 2016-08-15 23:08:56.438619Z] Running read-buildbot-config step. 16:08:56 INFO - Running pre-action listener: _resource_record_pre_action 16:08:56 INFO - Running main action method: read_buildbot_config 16:08:56 INFO - Using buildbot properties: 16:08:56 INFO - { 16:08:56 INFO - "project": "", 16:08:56 INFO - "product": "firefox", 16:08:56 INFO - "script_repo_revision": "production", 16:08:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:08:56 INFO - "repository": "", 16:08:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 16:08:56 INFO - "buildid": "20160815145032", 16:08:56 INFO - "pgo_build": "False", 16:08:56 INFO - "basedir": "/builds/slave/test", 16:08:56 INFO - "buildnumber": 678, 16:08:56 INFO - "slavename": "talos-linux64-ix-007", 16:08:56 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:08:56 INFO - "platform": "ubuntu64_hw", 16:08:56 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:08:56 INFO - "branch": "mozilla-central", 16:08:56 INFO - "repo_path": "mozilla-central", 16:08:56 INFO - "revision": "054d4856cea6150a6638e5daf7913713281af97d", 16:08:56 INFO - "stage_platform": "linux64", 16:08:56 INFO - "builduid": "50515f9696784206b73550064f5e7a21", 16:08:56 INFO - "slavebuilddir": "test" 16:08:56 INFO - } 16:08:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:08:56 INFO - Running post-action listener: _resource_record_post_action 16:08:56 INFO - [mozharness: 2016-08-15 23:08:56.441035Z] Finished read-buildbot-config step (success) 16:08:56 INFO - [mozharness: 2016-08-15 23:08:56.441124Z] Running download-and-extract step. 16:08:56 INFO - Running pre-action listener: _resource_record_pre_action 16:08:56 INFO - Running main action method: download_and_extract 16:08:56 INFO - mkdir: /builds/slave/test/build/tests 16:08:56 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')]} 16:08:56 INFO - trying https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:08:56 INFO - Downloading https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/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 16:08:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/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 16:08:57 INFO - Downloaded 1361 bytes. 16:08:57 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:08:57 INFO - Using the following test package requirements: 16:08:57 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:08:57 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:08:57 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:08:57 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:57 INFO - u'jsshell-linux-x86_64.zip'], 16:08:57 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:08:57 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:08:57 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:08:57 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:08:57 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:08:57 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:08:57 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:08:57 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:08:57 INFO - trying https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:08:57 INFO - Downloading https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/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 16:08:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/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 16:08:57 INFO - Downloaded 20265554 bytes. 16:08:57 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 16:09:02 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 16:09: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')]} 16:09:02 INFO - trying https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:09:02 INFO - Downloading https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/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 16:09:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/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 16:09:02 INFO - Downloaded 20265554 bytes. 16:09:02 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 16:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:09:07 INFO - trying https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:09:07 INFO - Downloading https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/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 16:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/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 16:09:08 INFO - Downloaded 14413719 bytes. 16:09:08 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 16:09:08 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')]} 16:09:08 INFO - trying https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:09:08 INFO - Downloading https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/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 16:09:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/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 16:09:09 INFO - Downloaded 55624765 bytes. 16:09:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:09:09 INFO - mkdir: /builds/slave/test/properties 16:09:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:09:09 INFO - Writing to file /builds/slave/test/properties/build_url 16:09:09 INFO - Contents: 16:09:09 INFO - build_url:https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:09:10 INFO - Running post-action listener: _resource_record_post_action 16:09:10 INFO - Running post-action listener: set_extra_try_arguments 16:09:10 INFO - [mozharness: 2016-08-15 23:09:10.546043Z] Finished download-and-extract step (success) 16:09:10 INFO - [mozharness: 2016-08-15 23:09:10.546266Z] Running populate-webroot step. 16:09:10 INFO - Running pre-action listener: _resource_record_pre_action 16:09:10 INFO - Running main action method: populate_webroot 16:09:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:09:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:09:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:09:10 INFO - '--tppagecycles', 16:09:10 INFO - '7'], 16:09:10 INFO - 'tests': ['tsvgm']}}, 16:09:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:09:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:09:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:09:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:09:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:09:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:09:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:10 INFO - 'talos_options': ['--disable-e10s'], 16:09:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:09:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:09:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:10 INFO - 'talos_options': ['--disable-e10s'], 16:09:10 INFO - 'tests': ['damp', 'tps']}, 16:09:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:10 INFO - 'tests': ['damp', 'tps']}, 16:09:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:09:10 INFO - 'tests': ['dromaeo_dom']}, 16:09:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:09:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:09:10 INFO - 'tests': ['basic_compositor_video']}, 16:09:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:09:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:09:10 INFO - 'tests': ['a11yr', 16:09:10 INFO - 'ts_paint', 16:09:10 INFO - 'tpaint', 16:09:10 INFO - 'sessionrestore', 16:09:10 INFO - 'sessionrestore_no_auto_restore', 16:09:10 INFO - 'tabpaint']}, 16:09:10 INFO - 'other-e10s': {'tests': ['a11yr', 16:09:10 INFO - 'ts_paint', 16:09:10 INFO - 'tpaint', 16:09:10 INFO - 'sessionrestore', 16:09:10 INFO - 'sessionrestore_no_auto_restore', 16:09:10 INFO - 'tabpaint']}, 16:09:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:09:10 INFO - 'ts_paint', 16:09:10 INFO - 'tpaint', 16:09:10 INFO - 'sessionrestore', 16:09:10 INFO - 'sessionrestore_no_auto_restore', 16:09:10 INFO - 'tabpaint']}, 16:09:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:09:10 INFO - 'ts_paint', 16:09:10 INFO - 'tpaint', 16:09:10 INFO - 'sessionrestore', 16:09:10 INFO - 'sessionrestore_no_auto_restore', 16:09:10 INFO - 'tabpaint']}, 16:09:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:09:10 INFO - 'tests': ['a11yr', 16:09:10 INFO - 'ts_paint', 16:09:10 INFO - 'tpaint', 16:09:10 INFO - 'sessionrestore', 16:09:10 INFO - 'sessionrestore_no_auto_restore', 16:09:10 INFO - 'tabpaint']}, 16:09:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:09:10 INFO - 'tests': ['a11yr', 16:09:10 INFO - 'ts_paint', 16:09:10 INFO - 'tpaint', 16:09:10 INFO - 'sessionrestore', 16:09:10 INFO - 'sessionrestore_no_auto_restore', 16:09:10 INFO - 'tabpaint']}, 16:09:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:09:10 INFO - 'tests': ['tsvgx', 16:09:10 INFO - 'tsvgr_opacity', 16:09:10 INFO - 'tart', 16:09:10 INFO - 'tscrollx', 16:09:10 INFO - 'cart']}, 16:09:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:09:10 INFO - 'tsvgr_opacity', 16:09:10 INFO - 'tart', 16:09:10 INFO - 'tscrollx', 16:09:10 INFO - 'cart']}, 16:09:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:10 INFO - 'talos_options': ['--disable-e10s'], 16:09:10 INFO - 'tests': ['tp5o']}, 16:09:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:10 INFO - 'tests': ['tp5o']}, 16:09:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:10 INFO - 'talos_options': ['--disable-e10s', 16:09:10 INFO - '--xperf_path', 16:09:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:09:10 INFO - 'tests': ['tp5n']}, 16:09:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:09:10 INFO - 'talos_options': ['--xperf_path', 16:09:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:09:10 INFO - 'tests': ['tp5n']}}, 16:09:10 INFO - 'talos.zip': {'path': '', 16:09:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:09:10 INFO - Running post-action listener: _resource_record_post_action 16:09:10 INFO - [mozharness: 2016-08-15 23:09:10.566768Z] Finished populate-webroot step (success) 16:09:10 INFO - [mozharness: 2016-08-15 23:09:10.566855Z] Running create-virtualenv step. 16:09:10 INFO - Running pre-action listener: _resource_record_pre_action 16:09:10 INFO - Running main action method: create_virtualenv 16:09:10 INFO - Creating virtualenv /builds/slave/test/build/venv 16:09:10 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 16:09:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:09:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:09:10 INFO - Using real prefix '/usr' 16:09:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:09:11 INFO - Installing distribute.............................................................................................................................................................................................done. 16:09:13 INFO - Installing pip.................done. 16:09:13 INFO - Return code: 0 16:09:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:09:13 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')]} 16:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:13 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')]} 16:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:13 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 0x7f9379eeaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c07230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c01090>, '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 0x1c049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c04e40>, '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': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', '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 16:09:13 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 16:09:13 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 16:09:13 INFO - Using env: {'DISPLAY': ':0', 16:09:13 INFO - 'HOME': '/home/cltbld', 16:09:13 INFO - 'LANG': 'en_US.UTF-8', 16:09:13 INFO - 'LANGUAGE': 'en_US:en', 16:09:13 INFO - 'LOGNAME': 'cltbld', 16:09:13 INFO - 'MAIL': '/var/mail/cltbld', 16:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:13 INFO - 'MOZ_NO_REMOTE': '1', 16:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:09:13 INFO - 'NO_EM_RESTART': '1', 16:09:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:13 INFO - 'PWD': '/builds/slave/test', 16:09:13 INFO - 'SHELL': '/bin/bash', 16:09:13 INFO - 'SHLVL': '1', 16:09:13 INFO - 'TERM': 'linux', 16:09:13 INFO - 'TMOUT': '86400', 16:09:13 INFO - 'USER': 'cltbld', 16:09:13 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', 16:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:13 INFO - '_': '/tools/buildbot/bin/python'} 16:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:13 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 16:09:13 INFO - Cleaning up... 16:09:13 INFO - Return code: 0 16:09:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:09:13 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')]} 16:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:13 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')]} 16:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:13 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 0x7f9379eeaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c07230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c01090>, '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 0x1c049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c04e40>, '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': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', '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 16:09:13 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 16:09:13 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 16:09:13 INFO - Using env: {'DISPLAY': ':0', 16:09:13 INFO - 'HOME': '/home/cltbld', 16:09:13 INFO - 'LANG': 'en_US.UTF-8', 16:09:13 INFO - 'LANGUAGE': 'en_US:en', 16:09:13 INFO - 'LOGNAME': 'cltbld', 16:09:13 INFO - 'MAIL': '/var/mail/cltbld', 16:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:13 INFO - 'MOZ_NO_REMOTE': '1', 16:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:09:13 INFO - 'NO_EM_RESTART': '1', 16:09:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:13 INFO - 'PWD': '/builds/slave/test', 16:09:13 INFO - 'SHELL': '/bin/bash', 16:09:13 INFO - 'SHLVL': '1', 16:09:13 INFO - 'TERM': 'linux', 16:09:13 INFO - 'TMOUT': '86400', 16:09:13 INFO - 'USER': 'cltbld', 16:09:13 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', 16:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:13 INFO - '_': '/tools/buildbot/bin/python'} 16:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:13 INFO - Downloading/unpacking psutil>=3.1.1 16:09:13 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 16:09:13 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 16:09:13 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 16:09:13 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 16:09:13 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 16:09:13 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 16:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:09:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:09:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:09:15 INFO - Installing collected packages: psutil 16:09:15 INFO - Running setup.py install for psutil 16:09:15 INFO - building 'psutil._psutil_linux' extension 16:09:15 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 16:09:15 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 16:09:15 INFO - building 'psutil._psutil_posix' extension 16:09:15 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 16:09:16 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 16:09:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:09:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:09:16 INFO - Successfully installed psutil 16:09:16 INFO - Cleaning up... 16:09:16 INFO - Return code: 0 16:09:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:09:16 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')]} 16:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:16 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')]} 16:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:16 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 0x7f9379eeaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c07230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c01090>, '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 0x1c049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c04e40>, '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': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', '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 16:09:16 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 16:09:16 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 16:09:16 INFO - Using env: {'DISPLAY': ':0', 16:09:16 INFO - 'HOME': '/home/cltbld', 16:09:16 INFO - 'LANG': 'en_US.UTF-8', 16:09:16 INFO - 'LANGUAGE': 'en_US:en', 16:09:16 INFO - 'LOGNAME': 'cltbld', 16:09:16 INFO - 'MAIL': '/var/mail/cltbld', 16:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:16 INFO - 'MOZ_NO_REMOTE': '1', 16:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:09:16 INFO - 'NO_EM_RESTART': '1', 16:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:16 INFO - 'PWD': '/builds/slave/test', 16:09:16 INFO - 'SHELL': '/bin/bash', 16:09:16 INFO - 'SHLVL': '1', 16:09:16 INFO - 'TERM': 'linux', 16:09:16 INFO - 'TMOUT': '86400', 16:09:16 INFO - 'USER': 'cltbld', 16:09:16 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', 16:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:16 INFO - '_': '/tools/buildbot/bin/python'} 16:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:09:16 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 16:09:16 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 16:09:16 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 16:09:16 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 16:09:16 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 16:09:16 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 16:09:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:09:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:09:18 INFO - Installing collected packages: mozsystemmonitor 16:09:18 INFO - Running setup.py install for mozsystemmonitor 16:09:18 INFO - Successfully installed mozsystemmonitor 16:09:18 INFO - Cleaning up... 16:09:18 INFO - Return code: 0 16:09:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:18 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 0x7f9379eeaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c07230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c01090>, '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 0x1c049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c04e40>, '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': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', '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 16:09:18 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 16:09:18 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 16:09:18 INFO - Using env: {'DISPLAY': ':0', 16:09:18 INFO - 'HOME': '/home/cltbld', 16:09:18 INFO - 'LANG': 'en_US.UTF-8', 16:09:18 INFO - 'LANGUAGE': 'en_US:en', 16:09:18 INFO - 'LOGNAME': 'cltbld', 16:09:18 INFO - 'MAIL': '/var/mail/cltbld', 16:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:18 INFO - 'MOZ_NO_REMOTE': '1', 16:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:09:18 INFO - 'NO_EM_RESTART': '1', 16:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:18 INFO - 'PWD': '/builds/slave/test', 16:09:18 INFO - 'SHELL': '/bin/bash', 16:09:18 INFO - 'SHLVL': '1', 16:09:18 INFO - 'TERM': 'linux', 16:09:18 INFO - 'TMOUT': '86400', 16:09:18 INFO - 'USER': 'cltbld', 16:09:18 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', 16:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:18 INFO - '_': '/tools/buildbot/bin/python'} 16:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:18 INFO - Downloading/unpacking jsonschema==2.5.1 16:09:18 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 16:09:18 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 16:09:18 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 16:09:18 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 16:09:18 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 16:09:18 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 16:09:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:09:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:09:20 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 16:09:20 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 16:09:20 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 16:09:20 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 16:09:20 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 16:09:20 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 16:09:20 INFO - Downloading functools32-3.2.3-2.tar.gz 16:09:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:09:20 INFO - warning: no files found matching '*.txt' 16:09:20 INFO - no previously-included directories found matching 'build' 16:09:20 INFO - no previously-included directories found matching 'dist' 16:09:20 INFO - no previously-included directories found matching '.git*' 16:09:20 INFO - Installing collected packages: jsonschema, functools32 16:09:20 INFO - Running setup.py install for functools32 16:09:20 INFO - warning: no files found matching '*.txt' 16:09:20 INFO - no previously-included directories found matching 'build' 16:09:20 INFO - no previously-included directories found matching 'dist' 16:09:20 INFO - no previously-included directories found matching '.git*' 16:09:20 INFO - Successfully installed jsonschema functools32 16:09:20 INFO - Cleaning up... 16:09:21 INFO - Return code: 0 16:09:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:09:21 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')]} 16:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:21 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')]} 16:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:21 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 0x7f9379eeaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c07230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c01090>, '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 0x1c049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c04e40>, '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': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', '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 16:09:21 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 16:09:21 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 16:09:21 INFO - Using env: {'DISPLAY': ':0', 16:09:21 INFO - 'HOME': '/home/cltbld', 16:09:21 INFO - 'LANG': 'en_US.UTF-8', 16:09:21 INFO - 'LANGUAGE': 'en_US:en', 16:09:21 INFO - 'LOGNAME': 'cltbld', 16:09:21 INFO - 'MAIL': '/var/mail/cltbld', 16:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:21 INFO - 'MOZ_NO_REMOTE': '1', 16:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:09:21 INFO - 'NO_EM_RESTART': '1', 16:09:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:21 INFO - 'PWD': '/builds/slave/test', 16:09:21 INFO - 'SHELL': '/bin/bash', 16:09:21 INFO - 'SHLVL': '1', 16:09:21 INFO - 'TERM': 'linux', 16:09:21 INFO - 'TMOUT': '86400', 16:09:21 INFO - 'USER': 'cltbld', 16:09:21 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', 16:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:21 INFO - '_': '/tools/buildbot/bin/python'} 16:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:09:21 INFO - Cleaning up... 16:09:21 INFO - Return code: 0 16:09:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:09:21 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')]} 16:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:21 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')]} 16:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:21 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 0x7f9379eeaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c07230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c01090>, '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 0x1c049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c04e40>, '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': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', '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 16:09:21 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 16:09:21 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 16:09:21 INFO - Using env: {'DISPLAY': ':0', 16:09:21 INFO - 'HOME': '/home/cltbld', 16:09:21 INFO - 'LANG': 'en_US.UTF-8', 16:09:21 INFO - 'LANGUAGE': 'en_US:en', 16:09:21 INFO - 'LOGNAME': 'cltbld', 16:09:21 INFO - 'MAIL': '/var/mail/cltbld', 16:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:21 INFO - 'MOZ_NO_REMOTE': '1', 16:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:09:21 INFO - 'NO_EM_RESTART': '1', 16:09:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:21 INFO - 'PWD': '/builds/slave/test', 16:09:21 INFO - 'SHELL': '/bin/bash', 16:09:21 INFO - 'SHLVL': '1', 16:09:21 INFO - 'TERM': 'linux', 16:09:21 INFO - 'TMOUT': '86400', 16:09:21 INFO - 'USER': 'cltbld', 16:09:21 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', 16:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:21 INFO - '_': '/tools/buildbot/bin/python'} 16:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:21 INFO - Downloading/unpacking blobuploader==1.2.4 16:09:21 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 16:09:21 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 16:09:21 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 16:09:21 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 16:09:21 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 16:09:21 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 16:09:23 INFO - Downloading blobuploader-1.2.4.tar.gz 16:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:09:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:09:23 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 16:09:23 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 16:09:23 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 16:09:23 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 16:09:23 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 16:09:23 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 16:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:09:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:09:23 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 16:09:23 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 16:09:23 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 16:09:23 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 16:09:23 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 16:09:23 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 16:09:24 INFO - Downloading docopt-0.6.1.tar.gz 16:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:09:24 INFO - Installing collected packages: blobuploader, requests, docopt 16:09:24 INFO - Running setup.py install for blobuploader 16:09:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:09:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:09:24 INFO - Running setup.py install for requests 16:09:24 INFO - Running setup.py install for docopt 16:09:24 INFO - Successfully installed blobuploader requests docopt 16:09:24 INFO - Cleaning up... 16:09:24 INFO - Return code: 0 16:09:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:09:24 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')]} 16:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:24 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')]} 16:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:24 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 0x7f9379eeaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c07230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c01090>, '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 0x1c049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c04e40>, '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': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', '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 16:09:24 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 16:09:24 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 16:09:24 INFO - Using env: {'DISPLAY': ':0', 16:09:24 INFO - 'HOME': '/home/cltbld', 16:09:24 INFO - 'LANG': 'en_US.UTF-8', 16:09:24 INFO - 'LANGUAGE': 'en_US:en', 16:09:24 INFO - 'LOGNAME': 'cltbld', 16:09:24 INFO - 'MAIL': '/var/mail/cltbld', 16:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:24 INFO - 'MOZ_NO_REMOTE': '1', 16:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:09:24 INFO - 'NO_EM_RESTART': '1', 16:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:24 INFO - 'PWD': '/builds/slave/test', 16:09:24 INFO - 'SHELL': '/bin/bash', 16:09:24 INFO - 'SHLVL': '1', 16:09:24 INFO - 'TERM': 'linux', 16:09:24 INFO - 'TMOUT': '86400', 16:09:24 INFO - 'USER': 'cltbld', 16:09:24 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', 16:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:24 INFO - '_': '/tools/buildbot/bin/python'} 16:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:09:24 INFO - Running setup.py (path:/tmp/pip-PhgMVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:09:25 INFO - Running setup.py (path:/tmp/pip-mvwITr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:09:25 INFO - Running setup.py (path:/tmp/pip-VEhhOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:09:25 INFO - Running setup.py (path:/tmp/pip-TLnMR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:09:25 INFO - Running setup.py (path:/tmp/pip-MwHVzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:09:25 INFO - Running setup.py (path:/tmp/pip-5DKbjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:09:25 INFO - Running setup.py (path:/tmp/pip-Bmb3f0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:09:25 INFO - Running setup.py (path:/tmp/pip-F1ilHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:09:25 INFO - Running setup.py (path:/tmp/pip-BOkArj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:09:25 INFO - Running setup.py (path:/tmp/pip-37Rkci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:09:25 INFO - Running setup.py (path:/tmp/pip-eAUP_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:09:25 INFO - Running setup.py (path:/tmp/pip-7FXpLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:09:25 INFO - Running setup.py (path:/tmp/pip-WBUtLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:09:25 INFO - Running setup.py (path:/tmp/pip-vspq_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:09:25 INFO - Running setup.py (path:/tmp/pip-ow2nyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:09:26 INFO - Running setup.py (path:/tmp/pip-Yv_YkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:09:26 INFO - Running setup.py (path:/tmp/pip-iVvEMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:09:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:09:26 INFO - Running setup.py install for manifestparser 16:09:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:09:26 INFO - Running setup.py install for mozcrash 16:09:26 INFO - Running setup.py install for mozdebug 16:09:26 INFO - Running setup.py install for mozdevice 16:09:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:09:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:09:26 INFO - Running setup.py install for mozfile 16:09:26 INFO - Running setup.py install for mozhttpd 16:09:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:09:26 INFO - Running setup.py install for mozinfo 16:09:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:09:26 INFO - Running setup.py install for mozInstall 16:09:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:09:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:09:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:09:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:09:26 INFO - Running setup.py install for mozleak 16:09:27 INFO - Running setup.py install for mozlog 16:09:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:09:27 INFO - Running setup.py install for moznetwork 16:09:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:09:27 INFO - Running setup.py install for mozprocess 16:09:27 INFO - Running setup.py install for mozprofile 16:09:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:09:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:09:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:09:27 INFO - Running setup.py install for mozrunner 16:09:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:09:27 INFO - Running setup.py install for mozscreenshot 16:09:27 INFO - Running setup.py install for moztest 16:09:27 INFO - Running setup.py install for mozversion 16:09:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:09:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:09:27 INFO - Cleaning up... 16:09:27 INFO - Return code: 0 16:09:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:09:27 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')]} 16:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:27 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')]} 16:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:27 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 0x7f9379eeaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c07230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c01090>, '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 0x1c049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c04e40>, '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': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', '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 16:09:27 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 16:09:27 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 16:09:27 INFO - Using env: {'DISPLAY': ':0', 16:09:27 INFO - 'HOME': '/home/cltbld', 16:09:27 INFO - 'LANG': 'en_US.UTF-8', 16:09:27 INFO - 'LANGUAGE': 'en_US:en', 16:09:27 INFO - 'LOGNAME': 'cltbld', 16:09:27 INFO - 'MAIL': '/var/mail/cltbld', 16:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:27 INFO - 'MOZ_NO_REMOTE': '1', 16:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:09:27 INFO - 'NO_EM_RESTART': '1', 16:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:27 INFO - 'PWD': '/builds/slave/test', 16:09:27 INFO - 'SHELL': '/bin/bash', 16:09:27 INFO - 'SHLVL': '1', 16:09:27 INFO - 'TERM': 'linux', 16:09:27 INFO - 'TMOUT': '86400', 16:09:27 INFO - 'USER': 'cltbld', 16:09:27 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', 16:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:27 INFO - '_': '/tools/buildbot/bin/python'} 16:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:09:28 INFO - Running setup.py (path:/tmp/pip-FX873w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:09:28 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)) 16:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:09:28 INFO - Running setup.py (path:/tmp/pip-iHRybP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:09:28 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)) 16:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:09:28 INFO - Running setup.py (path:/tmp/pip-wcPoGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:09:28 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)) 16:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:09:28 INFO - Running setup.py (path:/tmp/pip-3_mP1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:09:28 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)) 16:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:09:28 INFO - Running setup.py (path:/tmp/pip-XI3Ezx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:09:28 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)) 16:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:09:28 INFO - Running setup.py (path:/tmp/pip-pJbGJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:09:28 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)) 16:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:09:28 INFO - Running setup.py (path:/tmp/pip-8MUHVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:09:28 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)) 16:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:09:28 INFO - Running setup.py (path:/tmp/pip-c7L4Oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:09:28 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)) 16:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:09:28 INFO - Running setup.py (path:/tmp/pip-h3qY0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:09:28 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)) 16:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:09:28 INFO - Running setup.py (path:/tmp/pip-HnF3r0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:09:28 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)) 16:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:09:28 INFO - Running setup.py (path:/tmp/pip-fq82xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:09:28 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)) 16:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:09:29 INFO - Running setup.py (path:/tmp/pip-2Qqjim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:09:29 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)) 16:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:09:29 INFO - Running setup.py (path:/tmp/pip-0YggIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:09:29 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)) 16:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:09:29 INFO - Running setup.py (path:/tmp/pip-APFFQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:09:29 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)) 16:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:09:29 INFO - Running setup.py (path:/tmp/pip-INnslZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:09:29 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)) 16:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:09:29 INFO - Running setup.py (path:/tmp/pip-NGrrfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:09:29 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)) 16:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:09:29 INFO - Running setup.py (path:/tmp/pip-pbHlsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:09:29 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)) 16:09:29 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)) 16:09:29 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)) 16:09:29 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)) 16:09:29 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)) 16:09:29 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)) 16:09:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:09:29 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 16:09:29 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 16:09:29 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 16:09:29 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 16:09:29 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 16:09:29 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 16:09:31 INFO - Downloading blessings-1.6.tar.gz 16:09:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:09:31 INFO - Installing collected packages: blessings 16:09:31 INFO - Running setup.py install for blessings 16:09:31 INFO - Successfully installed blessings 16:09:31 INFO - Cleaning up... 16:09:31 INFO - Return code: 0 16:09:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:09:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:09:31 INFO - Reading from file tmpfile_stdout 16:09:31 INFO - Current package versions: 16:09:31 INFO - argparse == 1.2.1 16:09:31 INFO - blessings == 1.6 16:09:31 INFO - blobuploader == 1.2.4 16:09:31 INFO - docopt == 0.6.1 16:09:31 INFO - functools32 == 3.2.3-2 16:09:31 INFO - jsonschema == 2.5.1 16:09:31 INFO - manifestparser == 1.1 16:09:31 INFO - mozInstall == 1.12 16:09:31 INFO - mozcrash == 0.17 16:09:31 INFO - mozdebug == 0.1 16:09:31 INFO - mozdevice == 0.48 16:09:31 INFO - mozfile == 1.2 16:09:31 INFO - mozhttpd == 0.7 16:09:31 INFO - mozinfo == 0.9 16:09:31 INFO - mozleak == 0.1 16:09:31 INFO - mozlog == 3.3 16:09:31 INFO - moznetwork == 0.27 16:09:31 INFO - mozprocess == 0.23 16:09:31 INFO - mozprofile == 0.28 16:09:31 INFO - mozrunner == 6.12 16:09:31 INFO - mozscreenshot == 0.1 16:09:31 INFO - mozsystemmonitor == 0.3 16:09:31 INFO - moztest == 0.7 16:09:31 INFO - mozversion == 1.4 16:09:31 INFO - psutil == 3.1.1 16:09:31 INFO - requests == 1.2.3 16:09:31 INFO - wsgiref == 0.1.2 16:09:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:31 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 0x7f9379eeaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c07230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c01090>, '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 0x1c049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c04e40>, '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': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', '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 16:09:31 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 16:09:31 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 16:09:31 INFO - Using env: {'DISPLAY': ':0', 16:09:31 INFO - 'HOME': '/home/cltbld', 16:09:31 INFO - 'LANG': 'en_US.UTF-8', 16:09:31 INFO - 'LANGUAGE': 'en_US:en', 16:09:31 INFO - 'LOGNAME': 'cltbld', 16:09:31 INFO - 'MAIL': '/var/mail/cltbld', 16:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:31 INFO - 'MOZ_NO_REMOTE': '1', 16:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:09:31 INFO - 'NO_EM_RESTART': '1', 16:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:31 INFO - 'PWD': '/builds/slave/test', 16:09:31 INFO - 'SHELL': '/bin/bash', 16:09:31 INFO - 'SHLVL': '1', 16:09:31 INFO - 'TERM': 'linux', 16:09:31 INFO - 'TMOUT': '86400', 16:09:31 INFO - 'USER': 'cltbld', 16:09:31 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', 16:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:31 INFO - '_': '/tools/buildbot/bin/python'} 16:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:31 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)) 16:09:31 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)) 16:09:31 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)) 16:09:31 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)) 16:09:31 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)) 16:09:31 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)) 16:09:31 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)) 16:09:31 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)) 16:09:31 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)) 16:09:31 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)) 16:09:31 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)) 16:09:31 INFO - Cleaning up... 16:09:31 INFO - Return code: 0 16:09:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:09:31 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 0x7f9379eeaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c07230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c01090>, '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 0x1c049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c04e40>, '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': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', '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 16:09:31 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 16:09:31 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 16:09:31 INFO - Using env: {'DISPLAY': ':0', 16:09:31 INFO - 'HOME': '/home/cltbld', 16:09:31 INFO - 'LANG': 'en_US.UTF-8', 16:09:31 INFO - 'LANGUAGE': 'en_US:en', 16:09:31 INFO - 'LOGNAME': 'cltbld', 16:09:31 INFO - 'MAIL': '/var/mail/cltbld', 16:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:32 INFO - 'MOZ_NO_REMOTE': '1', 16:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:09:32 INFO - 'NO_EM_RESTART': '1', 16:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:32 INFO - 'PWD': '/builds/slave/test', 16:09:32 INFO - 'SHELL': '/bin/bash', 16:09:32 INFO - 'SHLVL': '1', 16:09:32 INFO - 'TERM': 'linux', 16:09:32 INFO - 'TMOUT': '86400', 16:09:32 INFO - 'USER': 'cltbld', 16:09:32 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', 16:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:32 INFO - '_': '/tools/buildbot/bin/python'} 16:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:09:32 INFO - Cleaning up... 16:09:32 INFO - Return code: 0 16:09:32 INFO - Running post-action listener: _resource_record_post_action 16:09:32 INFO - Running post-action listener: _start_resource_monitoring 16:09:32 INFO - Starting resource monitoring. 16:09:32 INFO - [mozharness: 2016-08-15 23:09:32.234990Z] Finished create-virtualenv step (success) 16:09:32 INFO - [mozharness: 2016-08-15 23:09:32.235450Z] Running install step. 16:09:32 INFO - Running pre-action listener: _resource_record_pre_action 16:09:32 INFO - Running main action method: install 16:09:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:09:32 INFO - Reading from file tmpfile_stdout 16:09:32 INFO - Detecting whether we're running mozinstall >=1.0... 16:09:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:09:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:09:32 INFO - Reading from file tmpfile_stdout 16:09:32 INFO - Output received: 16:09:32 INFO - Usage: mozinstall [options] installer 16:09:32 INFO - Options: 16:09:32 INFO - -h, --help show this help message and exit 16:09:32 INFO - -d DEST, --destination=DEST 16:09:32 INFO - Directory to install application into. [default: 16:09:32 INFO - "/builds/slave/test"] 16:09:32 INFO - --app=APP Application being installed. [default: firefox] 16:09:32 INFO - mkdir: /builds/slave/test/build/application 16:09:32 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'] 16:09:32 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 16:09:48 INFO - Reading from file tmpfile_stdout 16:09:48 INFO - Output received: 16:09:48 INFO - /builds/slave/test/build/application/firefox/firefox 16:09:48 INFO - Running post-action listener: _resource_record_post_action 16:09:48 INFO - [mozharness: 2016-08-15 23:09:48.560855Z] Finished install step (success) 16:09:48 INFO - [mozharness: 2016-08-15 23:09:48.561102Z] Running run-tests step. 16:09:48 INFO - Running pre-action listener: _resource_record_pre_action 16:09:48 INFO - Running main action method: run_tests 16:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:09:48 INFO - Python 2.7.3 16:09:48 INFO - Return code: 0 16:09:48 INFO - grabbing minidump binary from tooltool 16:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:09:48 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 0x1c01090>, '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 0x1c049b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c04e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:09:48 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 16:09:48 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 16:09:48 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 16:09:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:09:48 INFO - Return code: 0 16:09:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:09:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:09:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:09:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:09:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:09:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:09:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:09:48 INFO - Using env: {'DISPLAY': ':0', 16:09:48 INFO - 'HOME': '/home/cltbld', 16:09:48 INFO - 'LANG': 'en_US.UTF-8', 16:09:48 INFO - 'LANGUAGE': 'en_US:en', 16:09:48 INFO - 'LOGNAME': 'cltbld', 16:09:48 INFO - 'MAIL': '/var/mail/cltbld', 16:09:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:09:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:09:48 INFO - 'MOZ_NO_REMOTE': '1', 16:09:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:09:48 INFO - 'NO_EM_RESTART': '1', 16:09:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:09:48 INFO - 'PWD': '/builds/slave/test', 16:09:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:09:48 INFO - 'SHELL': '/bin/bash', 16:09:48 INFO - 'SHLVL': '1', 16:09:48 INFO - 'TERM': 'linux', 16:09:48 INFO - 'TMOUT': '86400', 16:09:48 INFO - 'USER': 'cltbld', 16:09:48 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1471302534.28445-601915454', 16:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:09:48 INFO - '_': '/tools/buildbot/bin/python'} 16:09:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:09:48 INFO - mozversion application_buildid: 20160815145032 16:09:48 INFO - mozversion application_changeset: 054d4856cea6150a6638e5daf7913713281af97d 16:09:48 INFO - mozversion application_display_name: Nightly 16:09:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:09:48 INFO - mozversion application_name: Firefox 16:09:48 INFO - mozversion application_remotingname: firefox 16:09:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:09:48 INFO - mozversion application_vendor: Mozilla 16:09:48 INFO - mozversion application_version: 51.0a1 16:09:48 INFO - mozversion platform_buildid: 20160815145032 16:09:48 INFO - mozversion platform_changeset: 054d4856cea6150a6638e5daf7913713281af97d 16:09:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:09:48 INFO - mozversion platform_version: 51.0a1 16:09:48 INFO - using testdate: 1471302588 16:09:48 INFO - actual date: 1471302588 16:09:48 INFO - starting webserver on 'localhost:55082' 16:09:48 INFO - SUITE-START | Running 2 tests 16:09:48 INFO - TEST-START | dromaeo_css 16:09:48 INFO - operating with platform_type : linux_ 16:09:48 INFO - Initialising browser for dromaeo_css test... 16:09:48 INFO - TEST-INFO | started process 5809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkaGYNo/profile http://localhost:55082/getInfo.html) 16:09:52 INFO - PROCESS | 5809 | __metrics Screen width/height:1600/1200 16:09:52 INFO - PROCESS | 5809 | colorDepth:24 16:09:52 INFO - PROCESS | 5809 | Browser inner width/height: 1024/697 16:09:52 INFO - PROCESS | 5809 | __metrics 16:09:53 INFO - PROCESS | 5809 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:09:53 INFO - PROCESS | 5809 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:09:54 INFO - TEST-INFO | 5809: exit 0 16:09:54 INFO - Browser initialized. 16:09:54 INFO - Running cycle 1/1 for dromaeo_css test... 16:09:54 INFO - TEST-INFO | started process 5890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkaGYNo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:10:06 INFO - PROCESS | 5890 | RSS: Main: 156712960 16:10:06 INFO - PROCESS | 5890 | 16:10:57 INFO - PROCESS | 5890 | 1471302657113 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] 16:13:10 INFO - PROCESS | 5890 | Cycle 1(1): loaded http://localhost:55082/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55082/tests/dromaeo/cssquery-ext.html) 16:13:11 INFO - PROCESS | 5890 | RSS: Main: 228192256 16:13:11 INFO - PROCESS | 5890 | 16:16:14 INFO - PROCESS | 5890 | Cycle 1(1): loaded http://localhost:55082/tests/dromaeo/cssquery-ext.html (next: http://localhost:55082/tests/dromaeo/cssquery-jquery.html) 16:16:14 INFO - PROCESS | 5890 | RSS: Main: 240320512 16:16:14 INFO - PROCESS | 5890 | 16:19:16 INFO - PROCESS | 5890 | Cycle 1(1): loaded http://localhost:55082/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55082/tests/dromaeo/cssquery-mootools.html) 16:19:17 INFO - PROCESS | 5890 | RSS: Main: 230055936 16:19:17 INFO - PROCESS | 5890 | 16:22:19 INFO - PROCESS | 5890 | Cycle 1(1): loaded http://localhost:55082/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55082/tests/dromaeo/cssquery-prototype.html) 16:22:20 INFO - PROCESS | 5890 | RSS: Main: 192552960 16:22:20 INFO - PROCESS | 5890 | 16:25:23 INFO - PROCESS | 5890 | Cycle 1(1): loaded http://localhost:55082/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55082/tests/dromaeo/cssquery-yui.html) 16:25:24 INFO - PROCESS | 5890 | RSS: Main: 190275584 16:25:24 INFO - PROCESS | 5890 | 16:28:27 INFO - PROCESS | 5890 | Cycle 1(1): loaded http://localhost:55082/tests/dromaeo/cssquery-yui.html (next: http://localhost:55082/tests/dromaeo/cssquery-dojo.html) 16:28:27 INFO - PROCESS | 5890 | RSS: Main: 277913600 16:28:27 INFO - PROCESS | 5890 | 16:28:27 INFO - PROCESS | 5890 | __start_tp_report 16:28:27 INFO - PROCESS | 5890 | _x_x_mozilla_page_load 16:28:27 INFO - PROCESS | 5890 | _x_x_mozilla_page_load_details 16:28:27 INFO - PROCESS | 5890 | |i|pagename|runs| 16:28:27 INFO - PROCESS | 5890 | |0;dojo.html;2593;2635.4597307551953;2636.3672718547555;2664.4804263168676;2674.652295201622;4602.2636378179495;4727.834525791598;4749.287606858973;4798.568128868401;4806.038792241553;4673.509281525442;4747.098051370237;4761.119192949307;4767.594754445868;4794.640401969848;4340.956590434087;4353.28170851809;4388.122375524892;4397.516273209944;4417.138657961698;4363.280058790296;4419.9337009944875;4480.48474425442;4500.077484115748;4536.818527258923;4475.977620111895;4498.415206023213;4528.932066019012;4536.410266665329;4544.9091018179615;4303.2469317869245;4330.545292744248;4358.259095953696;4371.562843715603;4389.824407023715;4310.741355518679;4315.115401342718;4325.675574331937;4354.238008348526;4434.977825110886;4757.5718185363485;4768.761561921925;4786.425628924517;4810.302506136591;4812.663113582051;5014.323066386064;5027.547520723116;5140.691558506502;5151.793928242866;5156.071907056728;5112;5166.689998600096;5191.766370513336;5192.636515443921;5193.143131383317;4758.476567577563;4779.880502987384;4782.521747825259;4795.064962332382;4823.638227132944;4966.1309270877455;5020.849374518771;5065.290859279704;5230.660007099526;5245.370555533361;4917;4930.950690493121;4932.605391568666;4932.704037757674;4939.5554400104165;4986.775595098156;4992.425871024879;4992.975035124801;5027.3464449621315;5038.571721403649;4893.09477746618;4943.110240156734;4974.253861920741;4999.400071991312;5043.621728370387;5062.265971434122;5065.797368105308;5067.797288108434;5096.770645320969;5098.515641014098;4253.462754935123;4254.212970600449;4254.404383386328;4291.485021797342;4301.978490107592;3682.650148235913;3701.9074523137137;3718.3678774608384;3729.2355067211156;3755.7183211259266;4423.955760442419;4471.8658440246845;4480.551944805494;4516.706414083074;4536.251518499411;5167.534921857051;5168.8449346519665;5170.6122040847085;5175.430702622709;5223.634345595772;4482.7758612069265;4489.753063581535;4493.213687604656;4495.662825288116;4534.9342904417435;4397.758123303249;4512.864614061584;4545.340925565774;4563.041761230113;4620.422447194101;4869.415670119608;4876.95123048765;4880.658353915192;4885.731284779371;4932.21084626458;5140.177571588528;5169.276301317894;5184.377874655065;5186.299849520417;5236.502532259429;4694.155052090657;4755.0014496954645;4786.401699787527;4808.2547205183255;4869.342638743724;4956.355673762388;4968.0312339093525;4970.229614409773;4971.254311853251;5025.597952163891;5097.133487307241;5108.872278193075;5111.258867464271;5113.4659602119955;5115.897682046412;4874.610031197567;4959.404871415453;5016.799328026838;5023.598112150946;5058.190689489664;4971.403431588088;4981.078500477423;5026.246063090565;5032.270320803536;5080.364954380702;4957.876053098701;4973.303737476684;4983.950160498349;5016.473270306566;5022.372203474566;4905;4996.175631020841;4999.075171093359;5013.623978201576;5099.745012749422;4943.876403089952;4951.356323677899;4957.776900039579;4961.330220420197;4972.403311602631 16:28:27 INFO - PROCESS | 5890 | |1;ext.html;561.9775208991639;566.6600039976013;570.3611954610836;570.8087790590153;571.3201290464347;28425.14724558264;38204.42693359602;39300.410493842544;39393.40909886351;43709.12581748363;39985.80007099968;40169.59830401695;40265.396019059735;40363.79818100906;40378.394324085086;7517.511361761482;7684.154742978296;7685.730999415022;7687.692492300302;7695.846083078335;7469.327760501554;7545.509541879787;7548.471606987513;7548.5093468924615;7557.546547207157;7539.736109236178;7580.620968951558;7584.544927304351;7585.848283034336;7586.279303466189;7505.737299194529;7511.098668159856;7540.057492813398;7551.169371369172;7561.697532098709;7613.200613935568;7633.389328853678;7669.424793140537;7671.501352412075;7690.884636730453;37326.44010339847;37628;37634;37637.81181094104;37659;2932;3054.602901622797;3247.4804031355106;3276.5085237214607;3619.239959608485;28304.716952830415;28358.574621380696;28754.712452875414;28781.856090719622;28830.620976448463;3406.5230867678547;3449.896503104911;3468.0462872709954;3470.7917524948584;3529.1000794797164;260173;263392;263886;264787;264855;54848.725756370965;55058.44941550613;55082;55278;55289.60076786956;32156.67843321537;33101.66898330986;33162.83418582891;34899;35018.29963400718;13232;13347.399367028507;13349;13391.732165356638;13395.26326052057;10317.74205644865;10392.532336044897;10410.635627753143;10416.166706663449;10417.114545263586;17674.293028278982;17805.554861128316;17815.10924453772;17850.821491785176;17918;6924.6537673116145;7008.423104801481;7039.225685174627;7137.607431591312;7210.495265331377;798.5568009754642;890.670451932789;905.538175530471;963.4700914496999;1045.2630895218851;27944.58083128714;28351.57472637912;28430.573541396894;28517.287067823472;28851.855740721163;770.7263921307855;936.948467834262;948.8149810786969;958.2525630008465;988.1995583577325;13832.377543010589;14732.337044833008;14758.262086895613;14866.18235997009;14914;379672;725655;741924;742304;744303;49158.508414916105;49789.253161202614;49841.25238121431;49880.750596246784;49973;1083.534080345459;1177.5937301630925;1189.74420499593;1216.6593353860756;1225.6261840138843;24081.759182408652;28604.42791144207;29101.7089829099;29314.853425732734;29426.411471770873;40943.795281023406;41447.37828932508;41503.37744933768;41519;41536.16927661369;313876;316532;316654;317125;317519;25313.620295695946;25420.618690719282;25837.612435813102;25899.223023309332;25903;41293.38059929043;41471.7926410366;41629.167416652104;42230.366544501245;42452.150956981306;34749.47875781815;34809.65190348064;35454.290914182086;35522;35622;34564.65435345614;34751;34914.47628285527;34936.30127397489;35113;29688.406231875673;29852.253693656963;30041.399172016874;34334.48498272578;35698.286034279685;29985;32815.34369312648;32844.34311313808;32855.34289314248;32889.34221315513;24307.878460607582;24549.754502454747;24965.750342496343;25166.24501264965;25228 16:28:27 INFO - PROCESS | 5890 | |2;jquery.html;356.44750636513413;357.68345014662026;360.7348598779897;363.358671944019;372.3818461354151;15896.443624473146;16784.49646510605;17599.208035638396;17699.82300176998;17703.645927081452;14814.555563333117;15132.546023619281;17009.319627214896;17558.912205438955;17672.469825905213;4756.5956893664;4987.376577927759;4989.126902792015;4990.975045124769;4994.900101997958;3656.524651795263;3840.0399900024995;3843.5964223756523;3870.6903447724117;4916.434610019858;3749.7000239980734;3852.7303088783797;5852.385499522553;5858.589898707092;5875.059990401536;5801.100829371454;5805.680687562182;5814.360420353758;5818.476337129637;5819.7963071292725;3276.6887145721116;5041.773120209599;5047.697138171685;5049.444561098277;5055.281204390525;19327.710084348746;20350.592988140153;20364.18543258268;21443.67834482484;21828.781712182834;1820.781506219249;1859.1262106809913;1902.533879199605;1951.804819518051;1964.695472201811;9124.406913550598;9374.531273436301;9689.806203875953;9781.706548803477;9902.851457228147;1719.3810228317795;1724.6723122606666;1748.3181559191926;1779.146009915235;1785.3394244129754;61415.692921535105;69529;69536.6523167381;73318;74544.25455745427;10220.182385409149;10230.437325946996;10259.794804103876;10298.433586152834;10457.84313235302;13808;13808.516701915585;13931.442742290195;13942.58172254834;13944;6527.3472652734345;6540.247871494744;6626.204855417381;6667.19993600771;6899.75850845218;6035.336113027563;6183.134361189437;6308.243010838637;6423.357664233633;6431.42117209444;4337;4337.197618440536;4377.606015458624;4422.204003279377;4425.690201685851;1756.2887030752565;1821.3898344054626;1837.8162183781783;1886.1135266424758;1887.6310230660708;789.810445493089;803.4054799448367;817.9509229446252;822.7778499805019;827.0736774812249;16793.40717273336;16805.495835124966;17535.473935781945;17851.28594856217;18037.18832652534;787.7006737439851;819.5533434278333;864.1962974433837;889.3907673243849;902.7968707040864;9144.405613635225;9984.750381240527;9998.200143988464;10033.197344212445;10127.493625318704;374839;382673;384362;384512;388319;76297.6185119082;76744;77699.22300777033;77871;82343;868.8218915122385;887.3566664168555;908.9000209976897;911.7674992876774;914.5290175559592;15202.52709024728;15228;15695.136767477898;15983.600409989844;16139.112348820927;37350;37677.05807354728;37882.24235515329;38080.619193808816;38847.805760971016;49682.75158624184;51917.7404112977;51982.74008629932;52411.73794131005;52771;7441.851162976818;7580.241975802596;7720.961395192988;7958.61876692682;8359.164083591591;6279.843003924939;8955.41789783662;10612.84080738805;11334.60328888485;11870.762584748083;9916.504174791087;10133.341332813638;10296.897031029594;10604.8939510607;10696.705041683146;9569.186619137174;9751.317407781387;10446.425446600206;10666.786664266827;10695.5187016586;10215.846762298721;10497.737556561147;10609.89390106089;10623.681289561326;11071.335719856834;7197.8920316196345;7300.269973002657;7501.474896757175;7585.924140758521;7721.957535732604;9277.211437027658;9754.585585090264;10400.998781248963;10858.891411085788;11102.611408600984 16:28:27 INFO - PROCESS | 5890 | |3;mootools.html;1266.2845492296847;1369.7397494476052;1392.5891861900739;1470.69115485748;1659.4523807143637;6664.300248473914;7557.395408367332;7760.534367937914;7819.100803407609;8066.193380661931;7892.763217103482;7960.681572737083;7975.641096150673;7978.960105199466;7987.960060199705;2129.4995676016124;2151.752548456932;2156.5255643758346;2161.0059372688584;2162.632352500079;2134.3810295014505;2164.880931548772;2186.529896072344;2197.571473562656;2205.2061257947125;2156.590247852903;2166.674998750192;2179.9128034878586;2180.4875854174256;2205.8897055147177;2131.275366375432;2134.8185404240658;2138.5829763196184;2140.0904615538334;2140.8715477071346;2051.507638166844;2109.6624540073512;2115.5557332960097;2115.7461104667536;2116.354511873878;7822.6088695564995;7826.960865195694;7893.447458677895;7896.486728362638;7924.881126783102;4360.585744354281;4423.60187583119;4501.122281155176;4501.437320334958;4508.977455112737;2946.955795663067;2976.523756198998;2987.4622567937763;2988.073697153889;2994.0718377303106;867.5618812499711;907.237920147073;919.4575200631659;927.0266220468482;931.5994122527311;10560.419176945265;10687.786244275148;10695.358278503314;10699.83950240747;10716.678499645022;3865.188310454836;4026.154507553388;4139.654612251031;4169.395437661522;4193.496780386373;8352.081271060179;8366.539840308842;8389;8394.412391132562;8397.6221070052;4394;4418.182636212311;4436.578525040116;4440.867578767394;4441.022974945507;3572.2141128952107;3916.5300163980505;4022.939655905164;4025.6376926076796;4071.959280407217;3375.9493607595905;3447.1382154461385;3550.1124718820297;3550.804705741209;3561.519194908706;1044.2794471814423;1084.446932064637;1089.1885545268667;1095.3537412926253;1097.939613321259;660.7059858362983;796.8605494038636;804.9195080492021;817.65249768848;833.9992009588518;4904.43598986114;4916.311716359713;5041.395032596039;5041.974790126026;5191.065608190562;402.6155021954027;410.3803257081828;415.19659458947035;425.6637256567339;425.7934901572735;3274.607047154309;3377.257003459284;3430.519727238189;3443.483477478348;3572.732045096628;9401.952990235142;9865.802683946424;9884.456354900405;9904.851427228597;9912.207023438252;9838.60645574169;9840.606375745034;9862.852057219148;9864.013598640222;9869.605215791431;7308.086489188851;7390.556566606021;7400.5189662671755;7402.296781805828;7407.296306850841;4878.634102442402;4918.794895250687;4982.75086245679;5059.215821547666;5293.629445938901;8773.078826723102;8872.689455869271;9073.682421115229;9109.225715813966;9220.44677319363;9041.50271735061;9171;9229.907700922904;9317.44095354281;9327.393719408217;6284.874302513833;6304.84237894038;6328.46208072319;6334.904976425265;6340.365963403623;7318.81702957409;7391.667374968247;7404.00045993784;7408.666610002455;7423.703051877865;6687.76592819249;6693.531452798257;6802.18373795128;6876.931230687629;6948.687309071003;6596.175478065242;6652;6706.5640733352175;6726.159230096238;6731.899021514779;6016.127661488972;6062.454379105901;6123.2652081750475;6126.295476020136;6129.754809807558;4276.273033584236;4281.186574550826;4347.282698354863;4374.147041326911;4457.866264012085;4391.736495810262;4400.867973960786;4463.776811159364;4541.704789188692;4544.431946006749 16:28:27 INFO - PROCESS | 5890 | |4;prototype.html;291.9649642042954;295.45783487300804;298.09973878885756;301.1492533592602;304.92681756378477;4781.545753153449;4792.880177995552;4824.686395384298;4829.372181616385;4830.9275360869615;4731.337612734212;4735.550122738343;4763.476017638057;4770.594499467549;4775.80896764129;3777.773333599993;3790.6209379062147;3799.4300854871713;3802.8668996585125;3827.10063135163;3607.693346065588;3668.0646435158997;3831.9653693502737;3835.175437280984;3840.423936409533;3253.2029652735114;3624.625870055118;3658.48781170635;3673.622391603149;3744.5132132822832;3589.6410358964026;3730.5150330457004;3736.1406876418578;3736.5889752127246;3742.925141497155;3307.140143562667;3313.6189338226172;3319.3527262183884;3333.1333853198103;3338.4992251162275;4438.955610443919;4513.86458406245;4607.331936869169;4632.976835115836;4655.255159174516;4248.214080395137;4255.191513612434;4260.169266992938;4261.74429534229;4266.8293268269235;4954.9009019819405;4955.776990035457;4957.256411538298;4961.5534601886;4972.825951091694;3386.9830650846834;3476.8609255629744;3495.5106285120105;3654;3664.9816750916075;5098.184290513537;5141.974290128563;5166.199239117943;5209.895802083937;5221.503957124067;3598.7300952428673;3600.6399360063783;3604.9279014419567;3607.9458808117897;3622.945655815165;3642.453631955228;3676.3382591133854;3679.6504332088407;3680.1351682354625;3692.058525076142;3995.420664003703;4168.979155104205;4184.66522678185;4184.979075104605;4190.329547272422;4963.354763880745;4967.7019378837385;4970.751462426864;4978.5768209701855;4987.177115775857;1243.5771837575269;1252.8058150986612;1256.742367814614;1266.0884163402336;1268.3911722373311;817.627979269431;823.9093699693029;830.98338033239;833.9583020849054;858.1632907914733;4439.977800110979;4442.511323754385;4443;4446.399736035659;4448.799804008762;5078.898422031539;5090.796368145307;5091.770870310845;5100.846974590768;5115.514026167508;4297.742135471882;4436.511983681792;4437.156940181355;4461.977690111528;4463.486699029589;2668.546347120994;2673.409321453732;2691.461707658476;2697.597249430285;2710.3873195448678;4798.520147985174;4804.8318308859025;4815.422149342101;4817.879553011203;4843.370361852936;5018.447970723218;5033.5469807716745;5179.01598696254;5209.192575150858;5243.344581927259;4835.709857408567;4871.975640121776;4881.8275867239445;4886.53577910098;4891.413030436371;4919.754012299442;5088.949110508996;5145.125328694206;5202.297689811979;5211.088059589632;4970.030843985388;4980.908018632111;5007.7245751484015;5019.447860735243;5042.949570504248;4852.80588776445;4862.708237505761;4867.858142417325;4902.92645610309;4912.1649319615035;3659.743817932719;3665.633436656313;3669.7614655048405;3671.4492826076303;3676.9816150919073;4968.378952630921;5053.8736531587;5091.87270318245;5096.745162741922;5137.17805151174;4957.752112394438;4960.727160006234;4964.702117872939;4971.975140124277;4998.3002379667605;4928.186849169847;4936.506349365035;4945.431275403231;4962.627802914723;5024.623153263593;4655.86032419028;4923.655344125877;4938.555530002317;4944.3572335596145;4956.553910148104;5011.924821127613;5015.648904576645;5036.622253331088;5043.99120175959;5059.620528460307;4797.616190704665;4924.778384972613;4955.132851751001;4956.760809797551;4957.702537847741 16:28:27 INFO - PROCESS | 5890 | |5;yui.html;619.6096459230685;621.8694074244409;637.7130291368884;685.7668392746468;701.62112459272;12410.379481025946;13112.016598755084;13472.191668499885;13567.050306478539;13784.379702913368;12909.870901291008;13102.08285420021;13122;13125.474981000749;13160.47358105677;638.3743930947674;755.8186035351504;761.3718682087273;781.0666253826679;782.8277778888636;774.5855967057626;784.0669603172236;784.2236186175702;784.5057613703359;785.1481142959896;827.7806381308958;829.0755807274905;829.1666874790827;829.4484168028254;829.6308142876422;661.3023260460212;676.8477092654163;821.8356328734277;822.0382152881143;822.481836443043;497.6789970469063;498.01393241382266;575.7927146227355;592.8340064781868;594.4263785447064;12010.819837702442;12039;12048.759024819454;12055.33695646739;12062.819057714141;11954.402279885971;12087;12095.879041209651;12219.327936963464;13184.208947463183;11521.36632485213;11737.589184378507;11833;12171.573994910135;12327.75344493114;3985.202959408101;3994.3009973254566;4033.69747268956;4155.771432571208;4198.8320467181275;64333.3566664332;66258.66870665664;66316.34209144762;66891.66554167197;67100.6644966772;10248.436336001443;10302;10464.13752809877;10507.579696812041;10724.713034435918;19605.1177697004;19615.705764413546;19625.509362266057;19753.506162346057;19787.208511659373;6479.481641468766;6541.345865413516;6544.3782840630065;6760.1549806274215;6771.187457505131;3396.4650866298275;3405.3529829332347;3420.3843308204764;3463.9480407793903;3464.1685995361436;2742.506348857225;2819.0274355347374;2840.786940979435;2843.9146825595267;2845.8007939444456;501.12553593978015;502.55774918071864;505.7521814310961;513.0406140517182;518.7302602646603;492.5493173746054;493.7629937629886;523.8637954131954;530.7717681397037;537.1352123081836;7253.347198752138;7288.599127048064;7532.322091011835;7585.810354741066;7837.451378403457;485.10498130948343;490.6050629243422;521.9269302297681;550.2653956967494;554.7254109215964;3293.440115180425;3422.2299982503737;3449.724022078278;3488.1977145256733;3587.461880717861;55200.72399638056;62987.6850615744;100584;102958.48520757498;103440.48279758553;86919.7725523306;87903;88341.67487487564;91589;93536;44962.77518612386;70259.64870175616;73713;76369.61815190778;77094;6774.796756097325;6904.965475172592;7051.471139664648;7059.717611295696;7202;45851.541484584726;47117;47788.7610561945;48296;48840.755796220794;59797.402025980926;60391.69804150951;69294;69744.65127674329;71543.64228178826;8722.433041852259;8813.691520796741;8948.73153805387;8949.149830766068;9013.233875120688;8922.581577674866;9303.162715355651;9357.438553686801;9358.719238422858;9497.24022078246;8250.834983300421;8366.83266334682;8635.740927772176;8673.869891951499;8682.175193356621;8874.600642970952;9456.952715236379;9484.95257523708;9532.523373831142;9563.665271715734;9214.078592140731;9292.860607091034;9316.860247096434;9373.859392108987;9448;8200.15003303702;8343.963904041913;8486.40595158333;8532.146785321418;8573.356998225283;7941.722039728582;8030.317423018875;8177.550234737147;8235.258826705625;8260.586970651324 16:28:27 INFO - PROCESS | 5890 | __end_tp_report 16:28:27 INFO - PROCESS | 5890 | __start_cc_report 16:28:27 INFO - PROCESS | 5890 | _x_x_mozilla_cycle_collect,1077 16:28:27 INFO - PROCESS | 5890 | __end_cc_report 16:28:27 INFO - PROCESS | 5890 | __startTimestamp1471303707366__endTimestamp 16:28:27 INFO - PROCESS | 5890 | 16:28:27 INFO - PROCESS | 5890 | ------- Summary: start ------- 16:28:27 INFO - PROCESS | 5890 | Number of tests: 6 16:28:27 INFO - PROCESS | 5890 | 16:28:27 INFO - PROCESS | 5890 | [#0] dojo.html Cycles:165 Average:4718.18 Median:4876.95 stddev:497.05 (10.2%) stddev-sans-first:469.78 16:28:27 INFO - PROCESS | 5890 | Values: 2593.0 2635.5 2636.4 2664.5 2674.7 4602.3 4727.8 4749.3 4798.6 4806.0 4673.5 4747.1 4761.1 4767.6 4794.6 4341.0 4353.3 4388.1 4397.5 4417.1 4363.3 4419.9 4480.5 4500.1 4536.8 4476.0 4498.4 4528.9 4536.4 4544.9 4303.2 4330.5 4358.3 4371.6 4389.8 4310.7 4315.1 4325.7 4354.2 4435.0 4757.6 4768.8 4786.4 4810.3 4812.7 5014.3 5027.5 5140.7 5151.8 5156.1 5112.0 5166.7 5191.8 5192.6 5193.1 4758.5 4779.9 4782.5 4795.1 4823.6 4966.1 5020.8 5065.3 5230.7 5245.4 4917.0 4931.0 4932.6 4932.7 4939.6 4986.8 4992.4 4993.0 5027.3 5038.6 4893.1 4943.1 4974.3 4999.4 5043.6 5062.3 5065.8 5067.8 5096.8 5098.5 4253.5 4254.2 4254.4 4291.5 4302.0 3682.7 3701.9 3718.4 3729.2 3755.7 4424.0 4471.9 4480.6 4516.7 4536.3 5167.5 5168.8 5170.6 5175.4 5223.6 4482.8 4489.8 4493.2 4495.7 4534.9 4397.8 4512.9 4545.3 4563.0 4620.4 4869.4 4877.0 4880.7 4885.7 4932.2 5140.2 5169.3 5184.4 5186.3 5236.5 4694.2 4755.0 4786.4 4808.3 4869.3 4956.4 4968.0 4970.2 4971.3 5025.6 5097.1 5108.9 5111.3 5113.5 5115.9 4874.6 4959.4 5016.8 5023.6 5058.2 4971.4 4981.1 5026.2 5032.3 5080.4 4957.9 4973.3 4984.0 5016.5 5022.4 4905.0 4996.2 4999.1 5013.6 5099.7 4943.9 4951.4 4957.8 4961.3 4972.4 16:28:27 INFO - PROCESS | 5890 | 16:28:27 INFO - PROCESS | 5890 | [#1] ext.html Cycles:180 Average:54590.60 Median:19321.05 stddev:124107.14 (642.3%) stddev-sans-first:124389.00 16:28:27 INFO - PROCESS | 5890 | Values: 562.0 566.7 570.4 570.8 571.3 28425.1 38204.4 39300.4 39393.4 43709.1 39985.8 40169.6 40265.4 40363.8 40378.4 7517.5 7684.2 7685.7 7687.7 7695.8 7469.3 7545.5 7548.5 7548.5 7557.5 7539.7 7580.6 7584.5 7585.8 7586.3 7505.7 7511.1 7540.1 7551.2 7561.7 7613.2 7633.4 7669.4 7671.5 7690.9 37326.4 37628.0 37634.0 37637.8 37659.0 2932.0 3054.6 3247.5 3276.5 3619.2 28304.7 28358.6 28754.7 28781.9 28830.6 3406.5 3449.9 3468.0 3470.8 3529.1 260173.0 263392.0 263886.0 264787.0 264855.0 54848.7 55058.4 55082.0 55278.0 55289.6 32156.7 33101.7 33162.8 34899.0 35018.3 13232.0 13347.4 13349.0 13391.7 13395.3 10317.7 10392.5 10410.6 10416.2 10417.1 17674.3 17805.6 17815.1 17850.8 17918.0 6924.7 7008.4 7039.2 7137.6 7210.5 798.6 890.7 905.5 963.5 1045.3 27944.6 28351.6 28430.6 28517.3 28851.9 770.7 936.9 948.8 958.3 988.2 13832.4 14732.3 14758.3 14866.2 14914.0 379672.0 725655.0 741924.0 742304.0 744303.0 49158.5 49789.3 49841.3 49880.8 49973.0 1083.5 1177.6 1189.7 1216.7 1225.6 24081.8 28604.4 29101.7 29314.9 29426.4 40943.8 41447.4 41503.4 41519.0 41536.2 313876.0 316532.0 316654.0 317125.0 317519.0 25313.6 25420.6 25837.6 25899.2 25903.0 41293.4 41471.8 41629.2 42230.4 42452.2 34749.5 34809.7 35454.3 35522.0 35622.0 34564.7 34751.0 34914.5 34936.3 35113.0 29688.4 29852.3 30041.4 34334.5 35698.3 29985.0 32815.3 32844.3 32855.3 32889.3 24307.9 24549.8 24965.8 25166.2 25228.0 16:28:27 INFO - PROCESS | 5890 | 16:28:27 INFO - PROCESS | 5890 | [#2] jquery.html Cycles:180 Average:24116.21 Median:213583.40 stddev:63368.41 (29.7%) stddev-sans-first:63521.06 16:28:27 INFO - PROCESS | 5890 | Values: 356.4 357.7 360.7 363.4 372.4 15896.4 16784.5 17599.2 17699.8 17703.6 14814.6 15132.5 17009.3 17558.9 17672.5 4756.6 4987.4 4989.1 4991.0 4994.9 3656.5 3840.0 3843.6 3870.7 4916.4 3749.7 3852.7 5852.4 5858.6 5875.1 5801.1 5805.7 5814.4 5818.5 5819.8 3276.7 5041.8 5047.7 5049.4 5055.3 19327.7 20350.6 20364.2 21443.7 21828.8 1820.8 1859.1 1902.5 1951.8 1964.7 9124.4 9374.5 9689.8 9781.7 9902.9 1719.4 1724.7 1748.3 1779.1 1785.3 61415.7 69529.0 69536.7 73318.0 74544.3 10220.2 10230.4 10259.8 10298.4 10457.8 13808.0 13808.5 13931.4 13942.6 13944.0 6527.3 6540.2 6626.2 6667.2 6899.8 6035.3 6183.1 6308.2 6423.4 6431.4 4337.0 4337.2 4377.6 4422.2 4425.7 1756.3 1821.4 1837.8 1886.1 1887.6 789.8 803.4 818.0 822.8 827.1 16793.4 16805.5 17535.5 17851.3 18037.2 787.7 819.6 864.2 889.4 902.8 9144.4 9984.8 9998.2 10033.2 10127.5 374839.0 382673.0 384362.0 384512.0 388319.0 76297.6 76744.0 77699.2 77871.0 82343.0 868.8 887.4 908.9 911.8 914.5 15202.5 15228.0 15695.1 15983.6 16139.1 37350.0 37677.1 37882.2 38080.6 38847.8 49682.8 51917.7 51982.7 52411.7 52771.0 7441.9 7580.2 7721.0 7958.6 8359.2 6279.8 8955.4 10612.8 11334.6 11870.8 9916.5 10133.3 10296.9 10604.9 10696.7 9569.2 9751.3 10446.4 10666.8 10695.5 10215.8 10497.7 10609.9 10623.7 11071.3 7197.9 7300.3 7501.5 7585.9 7722.0 9277.2 9754.6 10401.0 10858.9 11102.6 16:28:27 INFO - PROCESS | 5890 | 16:28:27 INFO - PROCESS | 5890 | [#3] mootools.html Cycles:180 Average:5055.90 Median:4891.54 stddev:2917.93 (59.7%) stddev-sans-first:2912.22 16:28:27 INFO - PROCESS | 5890 | Values: 1266.3 1369.7 1392.6 1470.7 1659.5 6664.3 7557.4 7760.5 7819.1 8066.2 7892.8 7960.7 7975.6 7979.0 7988.0 2129.5 2151.8 2156.5 2161.0 2162.6 2134.4 2164.9 2186.5 2197.6 2205.2 2156.6 2166.7 2179.9 2180.5 2205.9 2131.3 2134.8 2138.6 2140.1 2140.9 2051.5 2109.7 2115.6 2115.7 2116.4 7822.6 7827.0 7893.4 7896.5 7924.9 4360.6 4423.6 4501.1 4501.4 4509.0 2947.0 2976.5 2987.5 2988.1 2994.1 867.6 907.2 919.5 927.0 931.6 10560.4 10687.8 10695.4 10699.8 10716.7 3865.2 4026.2 4139.7 4169.4 4193.5 8352.1 8366.5 8389.0 8394.4 8397.6 4394.0 4418.2 4436.6 4440.9 4441.0 3572.2 3916.5 4022.9 4025.6 4072.0 3375.9 3447.1 3550.1 3550.8 3561.5 1044.3 1084.4 1089.2 1095.4 1097.9 660.7 796.9 804.9 817.7 834.0 4904.4 4916.3 5041.4 5042.0 5191.1 402.6 410.4 415.2 425.7 425.8 3274.6 3377.3 3430.5 3443.5 3572.7 9402.0 9865.8 9884.5 9904.9 9912.2 9838.6 9840.6 9862.9 9864.0 9869.6 7308.1 7390.6 7400.5 7402.3 7407.3 4878.6 4918.8 4982.8 5059.2 5293.6 8773.1 8872.7 9073.7 9109.2 9220.4 9041.5 9171.0 9229.9 9317.4 9327.4 6284.9 6304.8 6328.5 6334.9 6340.4 7318.8 7391.7 7404.0 7408.7 7423.7 6687.8 6693.5 6802.2 6876.9 6948.7 6596.2 6652.0 6706.6 6726.2 6731.9 6016.1 6062.5 6123.3 6126.3 6129.8 4276.3 4281.2 4347.3 4374.1 4457.9 4391.7 4400.9 4463.8 4541.7 4544.4 16:28:27 INFO - PROCESS | 5890 | 16:28:27 INFO - PROCESS | 5890 | [#4] prototype.html Cycles:180 Average:4138.86 Median:4778.68 stddev:1201.59 (25.1%) stddev-sans-first:1169.75 16:28:27 INFO - PROCESS | 5890 | Values: 292.0 295.5 298.1 301.1 304.9 4781.5 4792.9 4824.7 4829.4 4830.9 4731.3 4735.6 4763.5 4770.6 4775.8 3777.8 3790.6 3799.4 3802.9 3827.1 3607.7 3668.1 3832.0 3835.2 3840.4 3253.2 3624.6 3658.5 3673.6 3744.5 3589.6 3730.5 3736.1 3736.6 3742.9 3307.1 3313.6 3319.4 3333.1 3338.5 4439.0 4513.9 4607.3 4633.0 4655.3 4248.2 4255.2 4260.2 4261.7 4266.8 4954.9 4955.8 4957.3 4961.6 4972.8 3387.0 3476.9 3495.5 3654.0 3665.0 5098.2 5142.0 5166.2 5209.9 5221.5 3598.7 3600.6 3604.9 3607.9 3622.9 3642.5 3676.3 3679.7 3680.1 3692.1 3995.4 4169.0 4184.7 4185.0 4190.3 4963.4 4967.7 4970.8 4978.6 4987.2 1243.6 1252.8 1256.7 1266.1 1268.4 817.6 823.9 831.0 834.0 858.2 4440.0 4442.5 4443.0 4446.4 4448.8 5078.9 5090.8 5091.8 5100.8 5115.5 4297.7 4436.5 4437.2 4462.0 4463.5 2668.5 2673.4 2691.5 2697.6 2710.4 4798.5 4804.8 4815.4 4817.9 4843.4 5018.4 5033.5 5179.0 5209.2 5243.3 4835.7 4872.0 4881.8 4886.5 4891.4 4919.8 5088.9 5145.1 5202.3 5211.1 4970.0 4980.9 5007.7 5019.4 5042.9 4852.8 4862.7 4867.9 4902.9 4912.2 3659.7 3665.6 3669.8 3671.4 3677.0 4968.4 5053.9 5091.9 5096.7 5137.2 4957.8 4960.7 4964.7 4972.0 4998.3 4928.2 4936.5 4945.4 4962.6 5024.6 4655.9 4923.7 4938.6 4944.4 4956.6 5011.9 5015.6 5036.6 5044.0 5059.6 4797.6 4924.8 4955.1 4956.8 4957.7 16:28:27 INFO - PROCESS | 5890 | 16:28:27 INFO - PROCESS | 5890 | [#5] yui.html Cycles:180 Average:17182.10 Median:638.04 stddev:25356.67 (3974.1%) stddev-sans-first:25397.30 16:28:27 INFO - PROCESS | 5890 | Values: 619.6 621.9 637.7 685.8 701.6 12410.4 13112.0 13472.2 13567.1 13784.4 12909.9 13102.1 13122.0 13125.5 13160.5 638.4 755.8 761.4 781.1 782.8 774.6 784.1 784.2 784.5 785.1 827.8 829.1 829.2 829.4 829.6 661.3 676.8 821.8 822.0 822.5 497.7 498.0 575.8 592.8 594.4 12010.8 12039.0 12048.8 12055.3 12062.8 11954.4 12087.0 12095.9 12219.3 13184.2 11521.4 11737.6 11833.0 12171.6 12327.8 3985.2 3994.3 4033.7 4155.8 4198.8 64333.4 66258.7 66316.3 66891.7 67100.7 10248.4 10302.0 10464.1 10507.6 10724.7 19605.1 19615.7 19625.5 19753.5 19787.2 6479.5 6541.3 6544.4 6760.2 6771.2 3396.5 3405.4 3420.4 3463.9 3464.2 2742.5 2819.0 2840.8 2843.9 2845.8 501.1 502.6 505.8 513.0 518.7 492.5 493.8 523.9 530.8 537.1 7253.3 7288.6 7532.3 7585.8 7837.5 485.1 490.6 521.9 550.3 554.7 3293.4 3422.2 3449.7 3488.2 3587.5 55200.7 62987.7 100584.0 102958.5 103440.5 86919.8 87903.0 88341.7 91589.0 93536.0 44962.8 70259.6 73713.0 76369.6 77094.0 6774.8 6905.0 7051.5 7059.7 7202.0 45851.5 47117.0 47788.8 48296.0 48840.8 59797.4 60391.7 69294.0 69744.7 71543.6 8722.4 8813.7 8948.7 8949.1 9013.2 8922.6 9303.2 9357.4 9358.7 9497.2 8250.8 8366.8 8635.7 8673.9 8682.2 8874.6 9457.0 9485.0 9532.5 9563.7 9214.1 9292.9 9316.9 9373.9 9448.0 8200.2 8344.0 8486.4 8532.1 8573.4 7941.7 8030.3 8177.6 8235.3 8260.6 16:28:27 INFO - PROCESS | 5890 | -------- Summary: end -------- 16:28:27 INFO - PROCESS | 5890 | 16:28:28 INFO - TEST-INFO | 5890: exit 0 16:28:28 INFO - TEST-OK | dromaeo_css | took 1119343ms 16:28:28 INFO - TEST-START | kraken 16:28:28 INFO - operating with platform_type : linux_ 16:28:28 INFO - Initialising browser for kraken test... 16:28:28 INFO - TEST-INFO | started process 6196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDu5TC6/profile http://localhost:55082/getInfo.html) 16:28:31 INFO - PROCESS | 6196 | __metrics Screen width/height:1600/1200 16:28:31 INFO - PROCESS | 6196 | colorDepth:24 16:28:31 INFO - PROCESS | 6196 | Browser inner width/height: 1024/697 16:28:31 INFO - PROCESS | 6196 | __metrics 16:28:32 INFO - PROCESS | 6196 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:28:32 INFO - PROCESS | 6196 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:28:33 INFO - TEST-INFO | 6196: exit 0 16:28:33 INFO - Browser initialized. 16:28:33 INFO - Running cycle 1/1 for kraken test... 16:28:33 INFO - TEST-INFO | started process 6274 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDu5TC6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:28:45 INFO - PROCESS | 6274 | RSS: Main: 157040640 16:28:45 INFO - PROCESS | 6274 | 16:28:48 INFO - PROCESS | 6274 | Cycle 1(1): loaded http://localhost:55082/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55082/tests/kraken/driver.html?testName=audio-beat-detection) 16:28:49 INFO - PROCESS | 6274 | RSS: Main: 204328960 16:28:49 INFO - PROCESS | 6274 | 16:28:51 INFO - PROCESS | 6274 | Cycle 1(1): loaded http://localhost:55082/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55082/tests/kraken/driver.html?testName=audio-dft) 16:28:52 INFO - PROCESS | 6274 | RSS: Main: 195805184 16:28:52 INFO - PROCESS | 6274 | 16:28:55 INFO - PROCESS | 6274 | Cycle 1(1): loaded http://localhost:55082/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55082/tests/kraken/driver.html?testName=audio-fft) 16:28:56 INFO - PROCESS | 6274 | RSS: Main: 277368832 16:28:56 INFO - PROCESS | 6274 | 16:28:58 INFO - PROCESS | 6274 | Cycle 1(1): loaded http://localhost:55082/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55082/tests/kraken/driver.html?testName=audio-oscillator) 16:28:59 INFO - PROCESS | 6274 | RSS: Main: 186929152 16:28:59 INFO - PROCESS | 6274 | 16:29:01 INFO - PROCESS | 6274 | Cycle 1(1): loaded http://localhost:55082/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55082/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:29:01 INFO - PROCESS | 6274 | RSS: Main: 191954944 16:29:01 INFO - PROCESS | 6274 | 16:29:05 INFO - PROCESS | 6274 | Cycle 1(1): loaded http://localhost:55082/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55082/tests/kraken/driver.html?testName=imaging-darkroom) 16:29:05 INFO - PROCESS | 6274 | RSS: Main: 228802560 16:29:05 INFO - PROCESS | 6274 | 16:29:09 INFO - PROCESS | 6274 | Cycle 1(1): loaded http://localhost:55082/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55082/tests/kraken/driver.html?testName=imaging-desaturate) 16:29:09 INFO - PROCESS | 6274 | RSS: Main: 221847552 16:29:09 INFO - PROCESS | 6274 | 16:29:12 INFO - PROCESS | 6274 | Cycle 1(1): loaded http://localhost:55082/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55082/tests/kraken/driver.html?testName=json-parse-financial) 16:29:13 INFO - PROCESS | 6274 | RSS: Main: 225435648 16:29:13 INFO - PROCESS | 6274 | 16:29:15 INFO - PROCESS | 6274 | Cycle 1(1): loaded http://localhost:55082/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55082/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:29:15 INFO - PROCESS | 6274 | RSS: Main: 189460480 16:29:15 INFO - PROCESS | 6274 | 16:29:17 INFO - PROCESS | 6274 | Cycle 1(1): loaded http://localhost:55082/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55082/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:29:18 INFO - PROCESS | 6274 | RSS: Main: 197607424 16:29:18 INFO - PROCESS | 6274 | 16:29:20 INFO - PROCESS | 6274 | Cycle 1(1): loaded http://localhost:55082/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55082/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:29:21 INFO - PROCESS | 6274 | RSS: Main: 194355200 16:29:21 INFO - PROCESS | 6274 | 16:29:23 INFO - PROCESS | 6274 | Cycle 1(1): loaded http://localhost:55082/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55082/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:29:24 INFO - PROCESS | 6274 | RSS: Main: 189349888 16:29:24 INFO - PROCESS | 6274 | 16:29:27 INFO - PROCESS | 6274 | Cycle 1(1): loaded http://localhost:55082/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55082/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:29:28 INFO - PROCESS | 6274 | RSS: Main: 191995904 16:29:28 INFO - PROCESS | 6274 | 16:29:29 INFO - PROCESS | 6274 | Cycle 1(1): loaded http://localhost:55082/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55082/tests/kraken/driver.html?testName=ai-astar) 16:29:30 INFO - PROCESS | 6274 | RSS: Main: 242163712 16:29:30 INFO - PROCESS | 6274 | 16:29:30 INFO - PROCESS | 6274 | __start_tp_report 16:29:30 INFO - PROCESS | 6274 | _x_x_mozilla_page_load 16:29:30 INFO - PROCESS | 6274 | _x_x_mozilla_page_load_details 16:29:30 INFO - PROCESS | 6274 | |i|pagename|runs| 16:29:30 INFO - PROCESS | 6274 | |0;ai-astar;108;115;114;114;111;115;115;114;115;115 16:29:30 INFO - PROCESS | 6274 | |1;audio-beat-detection;147;126;123;195;123;126;149;124;176;123 16:29:30 INFO - PROCESS | 6274 | |2;audio-dft;162;161;162;161;161;162;161;162;163;161 16:29:30 INFO - PROCESS | 6274 | |3;audio-fft;76;76;76;106;77;78;76;76;101;77 16:29:30 INFO - PROCESS | 6274 | |4;audio-oscillator;87;86;145;86;87;86;115;87;86;131 16:29:30 INFO - PROCESS | 6274 | |5;imaging-gaussian-blur;117;117;116;117;117;123;116;117;117;117 16:29:30 INFO - PROCESS | 6274 | |6;imaging-darkroom;148;148;148;147;147;147;148;148;146;147 16:29:30 INFO - PROCESS | 6274 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 16:29:30 INFO - PROCESS | 6274 | |8;json-parse-financial;66;64;65;63;65;68;69;65;66;65 16:29:30 INFO - PROCESS | 6274 | |9;json-stringify-tinderbox;65;65;66;65;66;65;67;66;66;67 16:29:30 INFO - PROCESS | 6274 | |10;stanford-crypto-aes;83;85;88;85;84;83;82;82;82;82 16:29:30 INFO - PROCESS | 6274 | |11;stanford-crypto-ccm;134;138;144;131;139;136;131;150;152;132 16:29:30 INFO - PROCESS | 6274 | |12;stanford-crypto-pbkdf2;173;174;171;174;175;172;170;178;169;172 16:29:30 INFO - PROCESS | 6274 | |13;stanford-crypto-sha256-iterative;69;68;70;70;70;71;68;69;68;68 16:29:30 INFO - PROCESS | 6274 | __end_tp_report 16:29:30 INFO - PROCESS | 6274 | __start_cc_report 16:29:30 INFO - PROCESS | 6274 | _x_x_mozilla_cycle_collect,1942 16:29:30 INFO - PROCESS | 6274 | __end_cc_report 16:29:30 INFO - PROCESS | 6274 | __startTimestamp1471303770185__endTimestamp 16:29:30 INFO - PROCESS | 6274 | 16:29:30 INFO - PROCESS | 6274 | ------- Summary: start ------- 16:29:30 INFO - PROCESS | 6274 | Number of tests: 14 16:29:30 INFO - PROCESS | 6274 | 16:29:30 INFO - PROCESS | 6274 | [#0] ai-astar Cycles:10 Average:113.60 Median:115.00 stddev:2.32 (2.0%) stddev-sans-first:1.30 16:29:30 INFO - PROCESS | 6274 | Values: 108.0 115.0 114.0 114.0 111.0 115.0 115.0 114.0 115.0 115.0 16:29:30 INFO - PROCESS | 6274 | 16:29:30 INFO - PROCESS | 6274 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:136.50 stddev:25.72 (18.8%) stddev-sans-first:27.19 16:29:30 INFO - PROCESS | 6274 | Values: 147.0 126.0 123.0 195.0 123.0 126.0 149.0 124.0 176.0 123.0 16:29:30 INFO - PROCESS | 6274 | 16:29:30 INFO - PROCESS | 6274 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 16:29:30 INFO - PROCESS | 6274 | Values: 162.0 161.0 162.0 161.0 161.0 162.0 161.0 162.0 163.0 161.0 16:29:30 INFO - PROCESS | 6274 | 16:29:30 INFO - PROCESS | 6274 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:11.46 (15.1%) stddev-sans-first:11.96 16:29:30 INFO - PROCESS | 6274 | Values: 76.0 76.0 76.0 106.0 77.0 78.0 76.0 76.0 101.0 77.0 16:29:30 INFO - PROCESS | 6274 | 16:29:30 INFO - PROCESS | 6274 | [#4] audio-oscillator Cycles:10 Average:99.60 Median:86.00 stddev:22.36 (26.0%) stddev-sans-first:23.25 16:29:30 INFO - PROCESS | 6274 | Values: 87.0 86.0 145.0 86.0 87.0 86.0 115.0 87.0 86.0 131.0 16:29:30 INFO - PROCESS | 6274 | 16:29:30 INFO - PROCESS | 6274 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:2.01 (1.7%) stddev-sans-first:2.13 16:29:30 INFO - PROCESS | 6274 | Values: 117.0 117.0 116.0 117.0 117.0 123.0 116.0 117.0 117.0 117.0 16:29:30 INFO - PROCESS | 6274 | 16:29:30 INFO - PROCESS | 6274 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 16:29:30 INFO - PROCESS | 6274 | Values: 148.0 148.0 148.0 147.0 147.0 147.0 148.0 148.0 146.0 147.0 16:29:30 INFO - PROCESS | 6274 | 16:29:30 INFO - PROCESS | 6274 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 16:29:30 INFO - PROCESS | 6274 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 16:29:30 INFO - PROCESS | 6274 | 16:29:30 INFO - PROCESS | 6274 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:65.50 stddev:1.78 (2.7%) stddev-sans-first:1.88 16:29:30 INFO - PROCESS | 6274 | Values: 66.0 64.0 65.0 63.0 65.0 68.0 69.0 65.0 66.0 65.0 16:29:30 INFO - PROCESS | 6274 | 16:29:30 INFO - PROCESS | 6274 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 16:29:30 INFO - PROCESS | 6274 | Values: 65.0 65.0 66.0 65.0 66.0 65.0 67.0 66.0 66.0 67.0 16:29:30 INFO - PROCESS | 6274 | 16:29:30 INFO - PROCESS | 6274 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.50 stddev:1.96 (2.3%) stddev-sans-first:2.06 16:29:30 INFO - PROCESS | 6274 | Values: 83.0 85.0 88.0 85.0 84.0 83.0 82.0 82.0 82.0 82.0 16:29:30 INFO - PROCESS | 6274 | 16:29:30 INFO - PROCESS | 6274 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:138.50 stddev:7.65 (5.5%) stddev-sans-first:7.92 16:29:30 INFO - PROCESS | 6274 | Values: 134.0 138.0 144.0 131.0 139.0 136.0 131.0 150.0 152.0 132.0 16:29:30 INFO - PROCESS | 6274 | 16:29:30 INFO - PROCESS | 6274 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:173.50 stddev:2.62 (1.5%) stddev-sans-first:2.77 16:29:30 INFO - PROCESS | 6274 | Values: 173.0 174.0 171.0 174.0 175.0 172.0 170.0 178.0 169.0 172.0 16:29:30 INFO - PROCESS | 6274 | 16:29:30 INFO - PROCESS | 6274 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:1.10 (1.6%) stddev-sans-first:1.17 16:29:30 INFO - PROCESS | 6274 | Values: 69.0 68.0 70.0 70.0 70.0 71.0 68.0 69.0 68.0 68.0 16:29:30 INFO - PROCESS | 6274 | -------- Summary: end -------- 16:29:30 INFO - PROCESS | 6274 | 16:29:31 INFO - TEST-INFO | 6274: exit 0 16:29:31 INFO - TEST-OK | kraken | took 63144ms 16:29:31 INFO - SUITE-END | took 1182s 16:29:31 INFO - Completed test suite (00:19:42) 16:29:31 INFO - javascript benchmark 16:29:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2593.0, 2635.4597307551953, 2636.3672718547555, 2664.4804263168676, 2674.652295201622, 4602.2636378179495, 4727.834525791598, 4749.287606858973, 4798.568128868401, 4806.038792241553, 4673.509281525442, 4747.098051370237, 4761.119192949307, 4767.594754445868, 4794.640401969848, 4340.956590434087, 4353.28170851809, 4388.122375524892, 4397.516273209944, 4417.138657961698, 4363.280058790296, 4419.9337009944875, 4480.48474425442, 4500.077484115748, 4536.818527258923, 4475.977620111895, 4498.415206023213, 4528.932066019012, 4536.410266665329, 4544.9091018179615, 4303.2469317869245, 4330.545292744248, 4358.259095953696, 4371.562843715603, 4389.824407023715, 4310.741355518679, 4315.115401342718, 4325.675574331937, 4354.238008348526, 4434.977825110886, 4757.5718185363485, 4768.761561921925, 4786.425628924517, 4810.302506136591, 4812.663113582051, 5014.323066386064, 5027.547520723116, 5140.691558506502, 5151.793928242866, 5156.071907056728, 5112.0, 5166.689998600096, 5191.766370513336, 5192.636515443921, 5193.143131383317, 4758.476567577563, 4779.880502987384, 4782.521747825259, 4795.064962332382, 4823.638227132944, 4966.1309270877455, 5020.849374518771, 5065.290859279704, 5230.660007099526, 5245.370555533361, 4917.0, 4930.950690493121, 4932.605391568666, 4932.704037757674, 4939.5554400104165, 4986.775595098156, 4992.425871024879, 4992.975035124801, 5027.3464449621315, 5038.571721403649, 4893.09477746618, 4943.110240156734, 4974.253861920741, 4999.400071991312, 5043.621728370387, 5062.265971434122, 5065.797368105308, 5067.797288108434, 5096.770645320969, 5098.515641014098, 4253.462754935123, 4254.212970600449, 4254.404383386328, 4291.485021797342, 4301.978490107592, 3682.650148235913, 3701.9074523137137, 3718.3678774608384, 3729.2355067211156, 3755.7183211259266, 4423.955760442419, 4471.8658440246845, 4480.551944805494, 4516.706414083074, 4536.251518499411, 5167.534921857051, 5168.8449346519665, 5170.6122040847085, 5175.430702622709, 5223.634345595772, 4482.7758612069265, 4489.753063581535, 4493.213687604656, 4495.662825288116, 4534.9342904417435, 4397.758123303249, 4512.864614061584, 4545.340925565774, 4563.041761230113, 4620.422447194101, 4869.415670119608, 4876.95123048765, 4880.658353915192, 4885.731284779371, 4932.21084626458, 5140.177571588528, 5169.276301317894, 5184.377874655065, 5186.299849520417, 5236.502532259429, 4694.155052090657, 4755.0014496954645, 4786.401699787527, 4808.2547205183255, 4869.342638743724, 4956.355673762388, 4968.0312339093525, 4970.229614409773, 4971.254311853251, 5025.597952163891, 5097.133487307241, 5108.872278193075, 5111.258867464271, 5113.4659602119955, 5115.897682046412, 4874.610031197567, 4959.404871415453, 5016.799328026838, 5023.598112150946, 5058.190689489664, 4971.403431588088, 4981.078500477423, 5026.246063090565, 5032.270320803536, 5080.364954380702, 4957.876053098701, 4973.303737476684, 4983.950160498349, 5016.473270306566, 5022.372203474566, 4905.0, 4996.175631020841, 4999.075171093359, 5013.623978201576, 5099.745012749422, 4943.876403089952, 4951.356323677899, 4957.776900039579, 4961.330220420197, 4972.403311602631], "value": 4685.930667516292, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.9775208991639, 566.6600039976013, 570.3611954610836, 570.8087790590153, 571.3201290464347, 28425.14724558264, 38204.42693359602, 39300.410493842544, 39393.40909886351, 43709.12581748363, 39985.80007099968, 40169.59830401695, 40265.396019059735, 40363.79818100906, 40378.394324085086, 7517.511361761482, 7684.154742978296, 7685.730999415022, 7687.692492300302, 7695.846083078335, 7469.327760501554, 7545.509541879787, 7548.471606987513, 7548.5093468924615, 7557.546547207157, 7539.736109236178, 7580.620968951558, 7584.544927304351, 7585.848283034336, 7586.279303466189, 7505.737299194529, 7511.098668159856, 7540.057492813398, 7551.169371369172, 7561.697532098709, 7613.200613935568, 7633.389328853678, 7669.424793140537, 7671.501352412075, 7690.884636730453, 37326.44010339847, 37628.0, 37634.0, 37637.81181094104, 37659.0, 2932.0, 3054.602901622797, 3247.4804031355106, 3276.5085237214607, 3619.239959608485, 28304.716952830415, 28358.574621380696, 28754.712452875414, 28781.856090719622, 28830.620976448463, 3406.5230867678547, 3449.896503104911, 3468.0462872709954, 3470.7917524948584, 3529.1000794797164, 260173.0, 263392.0, 263886.0, 264787.0, 264855.0, 54848.725756370965, 55058.44941550613, 55082.0, 55278.0, 55289.60076786956, 32156.67843321537, 33101.66898330986, 33162.83418582891, 34899.0, 35018.29963400718, 13232.0, 13347.399367028507, 13349.0, 13391.732165356638, 13395.26326052057, 10317.74205644865, 10392.532336044897, 10410.635627753143, 10416.166706663449, 10417.114545263586, 17674.293028278982, 17805.554861128316, 17815.10924453772, 17850.821491785176, 17918.0, 6924.6537673116145, 7008.423104801481, 7039.225685174627, 7137.607431591312, 7210.495265331377, 798.5568009754642, 890.670451932789, 905.538175530471, 963.4700914496999, 1045.2630895218851, 27944.58083128714, 28351.57472637912, 28430.573541396894, 28517.287067823472, 28851.855740721163, 770.7263921307855, 936.948467834262, 948.8149810786969, 958.2525630008465, 988.1995583577325, 13832.377543010589, 14732.337044833008, 14758.262086895613, 14866.18235997009, 14914.0, 379672.0, 725655.0, 741924.0, 742304.0, 744303.0, 49158.508414916105, 49789.253161202614, 49841.25238121431, 49880.750596246784, 49973.0, 1083.534080345459, 1177.5937301630925, 1189.74420499593, 1216.6593353860756, 1225.6261840138843, 24081.759182408652, 28604.42791144207, 29101.7089829099, 29314.853425732734, 29426.411471770873, 40943.795281023406, 41447.37828932508, 41503.37744933768, 41519.0, 41536.16927661369, 313876.0, 316532.0, 316654.0, 317125.0, 317519.0, 25313.620295695946, 25420.618690719282, 25837.612435813102, 25899.223023309332, 25903.0, 41293.38059929043, 41471.7926410366, 41629.167416652104, 42230.366544501245, 42452.150956981306, 34749.47875781815, 34809.65190348064, 35454.290914182086, 35522.0, 35622.0, 34564.65435345614, 34751.0, 34914.47628285527, 34936.30127397489, 35113.0, 29688.406231875673, 29852.253693656963, 30041.399172016874, 34334.48498272578, 35698.286034279685, 29985.0, 32815.34369312648, 32844.34311313808, 32855.34289314248, 32889.34221315513, 24307.878460607582, 24549.754502454747, 24965.750342496343, 25166.24501264965, 25228.0], "value": 17315.306542285438, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.44750636513413, 357.68345014662026, 360.7348598779897, 363.358671944019, 372.3818461354151, 15896.443624473146, 16784.49646510605, 17599.208035638396, 17699.82300176998, 17703.645927081452, 14814.555563333117, 15132.546023619281, 17009.319627214896, 17558.912205438955, 17672.469825905213, 4756.5956893664, 4987.376577927759, 4989.126902792015, 4990.975045124769, 4994.900101997958, 3656.524651795263, 3840.0399900024995, 3843.5964223756523, 3870.6903447724117, 4916.434610019858, 3749.7000239980734, 3852.7303088783797, 5852.385499522553, 5858.589898707092, 5875.059990401536, 5801.100829371454, 5805.680687562182, 5814.360420353758, 5818.476337129637, 5819.7963071292725, 3276.6887145721116, 5041.773120209599, 5047.697138171685, 5049.444561098277, 5055.281204390525, 19327.710084348746, 20350.592988140153, 20364.18543258268, 21443.67834482484, 21828.781712182834, 1820.781506219249, 1859.1262106809913, 1902.533879199605, 1951.804819518051, 1964.695472201811, 9124.406913550598, 9374.531273436301, 9689.806203875953, 9781.706548803477, 9902.851457228147, 1719.3810228317795, 1724.6723122606666, 1748.3181559191926, 1779.146009915235, 1785.3394244129754, 61415.692921535105, 69529.0, 69536.6523167381, 73318.0, 74544.25455745427, 10220.182385409149, 10230.437325946996, 10259.794804103876, 10298.433586152834, 10457.84313235302, 13808.0, 13808.516701915585, 13931.442742290195, 13942.58172254834, 13944.0, 6527.3472652734345, 6540.247871494744, 6626.204855417381, 6667.19993600771, 6899.75850845218, 6035.336113027563, 6183.134361189437, 6308.243010838637, 6423.357664233633, 6431.42117209444, 4337.0, 4337.197618440536, 4377.606015458624, 4422.204003279377, 4425.690201685851, 1756.2887030752565, 1821.3898344054626, 1837.8162183781783, 1886.1135266424758, 1887.6310230660708, 789.810445493089, 803.4054799448367, 817.9509229446252, 822.7778499805019, 827.0736774812249, 16793.40717273336, 16805.495835124966, 17535.473935781945, 17851.28594856217, 18037.18832652534, 787.7006737439851, 819.5533434278333, 864.1962974433837, 889.3907673243849, 902.7968707040864, 9144.405613635225, 9984.750381240527, 9998.200143988464, 10033.197344212445, 10127.493625318704, 374839.0, 382673.0, 384362.0, 384512.0, 388319.0, 76297.6185119082, 76744.0, 77699.22300777033, 77871.0, 82343.0, 868.8218915122385, 887.3566664168555, 908.9000209976897, 911.7674992876774, 914.5290175559592, 15202.52709024728, 15228.0, 15695.136767477898, 15983.600409989844, 16139.112348820927, 37350.0, 37677.05807354728, 37882.24235515329, 38080.619193808816, 38847.805760971016, 49682.75158624184, 51917.7404112977, 51982.74008629932, 52411.73794131005, 52771.0, 7441.851162976818, 7580.241975802596, 7720.961395192988, 7958.61876692682, 8359.164083591591, 6279.843003924939, 8955.41789783662, 10612.84080738805, 11334.60328888485, 11870.762584748083, 9916.504174791087, 10133.341332813638, 10296.897031029594, 10604.8939510607, 10696.705041683146, 9569.186619137174, 9751.317407781387, 10446.425446600206, 10666.786664266827, 10695.5187016586, 10215.846762298721, 10497.737556561147, 10609.89390106089, 10623.681289561326, 11071.335719856834, 7197.8920316196345, 7300.269973002657, 7501.474896757175, 7585.924140758521, 7721.957535732604, 9277.211437027658, 9754.585585090264, 10400.998781248963, 10858.891411085788, 11102.611408600984], "value": 8046.791130568618, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1266.2845492296847, 1369.7397494476052, 1392.5891861900739, 1470.69115485748, 1659.4523807143637, 6664.300248473914, 7557.395408367332, 7760.534367937914, 7819.100803407609, 8066.193380661931, 7892.763217103482, 7960.681572737083, 7975.641096150673, 7978.960105199466, 7987.960060199705, 2129.4995676016124, 2151.752548456932, 2156.5255643758346, 2161.0059372688584, 2162.632352500079, 2134.3810295014505, 2164.880931548772, 2186.529896072344, 2197.571473562656, 2205.2061257947125, 2156.590247852903, 2166.674998750192, 2179.9128034878586, 2180.4875854174256, 2205.8897055147177, 2131.275366375432, 2134.8185404240658, 2138.5829763196184, 2140.0904615538334, 2140.8715477071346, 2051.507638166844, 2109.6624540073512, 2115.5557332960097, 2115.7461104667536, 2116.354511873878, 7822.6088695564995, 7826.960865195694, 7893.447458677895, 7896.486728362638, 7924.881126783102, 4360.585744354281, 4423.60187583119, 4501.122281155176, 4501.437320334958, 4508.977455112737, 2946.955795663067, 2976.523756198998, 2987.4622567937763, 2988.073697153889, 2994.0718377303106, 867.5618812499711, 907.237920147073, 919.4575200631659, 927.0266220468482, 931.5994122527311, 10560.419176945265, 10687.786244275148, 10695.358278503314, 10699.83950240747, 10716.678499645022, 3865.188310454836, 4026.154507553388, 4139.654612251031, 4169.395437661522, 4193.496780386373, 8352.081271060179, 8366.539840308842, 8389.0, 8394.412391132562, 8397.6221070052, 4394.0, 4418.182636212311, 4436.578525040116, 4440.867578767394, 4441.022974945507, 3572.2141128952107, 3916.5300163980505, 4022.939655905164, 4025.6376926076796, 4071.959280407217, 3375.9493607595905, 3447.1382154461385, 3550.1124718820297, 3550.804705741209, 3561.519194908706, 1044.2794471814423, 1084.446932064637, 1089.1885545268667, 1095.3537412926253, 1097.939613321259, 660.7059858362983, 796.8605494038636, 804.9195080492021, 817.65249768848, 833.9992009588518, 4904.43598986114, 4916.311716359713, 5041.395032596039, 5041.974790126026, 5191.065608190562, 402.6155021954027, 410.3803257081828, 415.19659458947035, 425.6637256567339, 425.7934901572735, 3274.607047154309, 3377.257003459284, 3430.519727238189, 3443.483477478348, 3572.732045096628, 9401.952990235142, 9865.802683946424, 9884.456354900405, 9904.851427228597, 9912.207023438252, 9838.60645574169, 9840.606375745034, 9862.852057219148, 9864.013598640222, 9869.605215791431, 7308.086489188851, 7390.556566606021, 7400.5189662671755, 7402.296781805828, 7407.296306850841, 4878.634102442402, 4918.794895250687, 4982.75086245679, 5059.215821547666, 5293.629445938901, 8773.078826723102, 8872.689455869271, 9073.682421115229, 9109.225715813966, 9220.44677319363, 9041.50271735061, 9171.0, 9229.907700922904, 9317.44095354281, 9327.393719408217, 6284.874302513833, 6304.84237894038, 6328.46208072319, 6334.904976425265, 6340.365963403623, 7318.81702957409, 7391.667374968247, 7404.00045993784, 7408.666610002455, 7423.703051877865, 6687.76592819249, 6693.531452798257, 6802.18373795128, 6876.931230687629, 6948.687309071003, 6596.175478065242, 6652.0, 6706.5640733352175, 6726.159230096238, 6731.899021514779, 6016.127661488972, 6062.454379105901, 6123.2652081750475, 6126.295476020136, 6129.754809807558, 4276.273033584236, 4281.186574550826, 4347.282698354863, 4374.147041326911, 4457.866264012085, 4391.736495810262, 4400.867973960786, 4463.776811159364, 4541.704789188692, 4544.431946006749], "value": 3975.5069751187593, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.9649642042954, 295.45783487300804, 298.09973878885756, 301.1492533592602, 304.92681756378477, 4781.545753153449, 4792.880177995552, 4824.686395384298, 4829.372181616385, 4830.9275360869615, 4731.337612734212, 4735.550122738343, 4763.476017638057, 4770.594499467549, 4775.80896764129, 3777.773333599993, 3790.6209379062147, 3799.4300854871713, 3802.8668996585125, 3827.10063135163, 3607.693346065588, 3668.0646435158997, 3831.9653693502737, 3835.175437280984, 3840.423936409533, 3253.2029652735114, 3624.625870055118, 3658.48781170635, 3673.622391603149, 3744.5132132822832, 3589.6410358964026, 3730.5150330457004, 3736.1406876418578, 3736.5889752127246, 3742.925141497155, 3307.140143562667, 3313.6189338226172, 3319.3527262183884, 3333.1333853198103, 3338.4992251162275, 4438.955610443919, 4513.86458406245, 4607.331936869169, 4632.976835115836, 4655.255159174516, 4248.214080395137, 4255.191513612434, 4260.169266992938, 4261.74429534229, 4266.8293268269235, 4954.9009019819405, 4955.776990035457, 4957.256411538298, 4961.5534601886, 4972.825951091694, 3386.9830650846834, 3476.8609255629744, 3495.5106285120105, 3654.0, 3664.9816750916075, 5098.184290513537, 5141.974290128563, 5166.199239117943, 5209.895802083937, 5221.503957124067, 3598.7300952428673, 3600.6399360063783, 3604.9279014419567, 3607.9458808117897, 3622.945655815165, 3642.453631955228, 3676.3382591133854, 3679.6504332088407, 3680.1351682354625, 3692.058525076142, 3995.420664003703, 4168.979155104205, 4184.66522678185, 4184.979075104605, 4190.329547272422, 4963.354763880745, 4967.7019378837385, 4970.751462426864, 4978.5768209701855, 4987.177115775857, 1243.5771837575269, 1252.8058150986612, 1256.742367814614, 1266.0884163402336, 1268.3911722373311, 817.627979269431, 823.9093699693029, 830.98338033239, 833.9583020849054, 858.1632907914733, 4439.977800110979, 4442.511323754385, 4443.0, 4446.399736035659, 4448.799804008762, 5078.898422031539, 5090.796368145307, 5091.770870310845, 5100.846974590768, 5115.514026167508, 4297.742135471882, 4436.511983681792, 4437.156940181355, 4461.977690111528, 4463.486699029589, 2668.546347120994, 2673.409321453732, 2691.461707658476, 2697.597249430285, 2710.3873195448678, 4798.520147985174, 4804.8318308859025, 4815.422149342101, 4817.879553011203, 4843.370361852936, 5018.447970723218, 5033.5469807716745, 5179.01598696254, 5209.192575150858, 5243.344581927259, 4835.709857408567, 4871.975640121776, 4881.8275867239445, 4886.53577910098, 4891.413030436371, 4919.754012299442, 5088.949110508996, 5145.125328694206, 5202.297689811979, 5211.088059589632, 4970.030843985388, 4980.908018632111, 5007.7245751484015, 5019.447860735243, 5042.949570504248, 4852.80588776445, 4862.708237505761, 4867.858142417325, 4902.92645610309, 4912.1649319615035, 3659.743817932719, 3665.633436656313, 3669.7614655048405, 3671.4492826076303, 3676.9816150919073, 4968.378952630921, 5053.8736531587, 5091.87270318245, 5096.745162741922, 5137.17805151174, 4957.752112394438, 4960.727160006234, 4964.702117872939, 4971.975140124277, 4998.3002379667605, 4928.186849169847, 4936.506349365035, 4945.431275403231, 4962.627802914723, 5024.623153263593, 4655.86032419028, 4923.655344125877, 4938.555530002317, 4944.3572335596145, 4956.553910148104, 5011.924821127613, 5015.648904576645, 5036.622253331088, 5043.99120175959, 5059.620528460307, 4797.616190704665, 4924.778384972613, 4955.132851751001, 4956.760809797551, 4957.702537847741], "value": 3756.0084782132535, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [619.6096459230685, 621.8694074244409, 637.7130291368884, 685.7668392746468, 701.62112459272, 12410.379481025946, 13112.016598755084, 13472.191668499885, 13567.050306478539, 13784.379702913368, 12909.870901291008, 13102.08285420021, 13122.0, 13125.474981000749, 13160.47358105677, 638.3743930947674, 755.8186035351504, 761.3718682087273, 781.0666253826679, 782.8277778888636, 774.5855967057626, 784.0669603172236, 784.2236186175702, 784.5057613703359, 785.1481142959896, 827.7806381308958, 829.0755807274905, 829.1666874790827, 829.4484168028254, 829.6308142876422, 661.3023260460212, 676.8477092654163, 821.8356328734277, 822.0382152881143, 822.481836443043, 497.6789970469063, 498.01393241382266, 575.7927146227355, 592.8340064781868, 594.4263785447064, 12010.819837702442, 12039.0, 12048.759024819454, 12055.33695646739, 12062.819057714141, 11954.402279885971, 12087.0, 12095.879041209651, 12219.327936963464, 13184.208947463183, 11521.36632485213, 11737.589184378507, 11833.0, 12171.573994910135, 12327.75344493114, 3985.202959408101, 3994.3009973254566, 4033.69747268956, 4155.771432571208, 4198.8320467181275, 64333.3566664332, 66258.66870665664, 66316.34209144762, 66891.66554167197, 67100.6644966772, 10248.436336001443, 10302.0, 10464.13752809877, 10507.579696812041, 10724.713034435918, 19605.1177697004, 19615.705764413546, 19625.509362266057, 19753.506162346057, 19787.208511659373, 6479.481641468766, 6541.345865413516, 6544.3782840630065, 6760.1549806274215, 6771.187457505131, 3396.4650866298275, 3405.3529829332347, 3420.3843308204764, 3463.9480407793903, 3464.1685995361436, 2742.506348857225, 2819.0274355347374, 2840.786940979435, 2843.9146825595267, 2845.8007939444456, 501.12553593978015, 502.55774918071864, 505.7521814310961, 513.0406140517182, 518.7302602646603, 492.5493173746054, 493.7629937629886, 523.8637954131954, 530.7717681397037, 537.1352123081836, 7253.347198752138, 7288.599127048064, 7532.322091011835, 7585.810354741066, 7837.451378403457, 485.10498130948343, 490.6050629243422, 521.9269302297681, 550.2653956967494, 554.7254109215964, 3293.440115180425, 3422.2299982503737, 3449.724022078278, 3488.1977145256733, 3587.461880717861, 55200.72399638056, 62987.6850615744, 100584.0, 102958.48520757498, 103440.48279758553, 86919.7725523306, 87903.0, 88341.67487487564, 91589.0, 93536.0, 44962.77518612386, 70259.64870175616, 73713.0, 76369.61815190778, 77094.0, 6774.796756097325, 6904.965475172592, 7051.471139664648, 7059.717611295696, 7202.0, 45851.541484584726, 47117.0, 47788.7610561945, 48296.0, 48840.755796220794, 59797.402025980926, 60391.69804150951, 69294.0, 69744.65127674329, 71543.64228178826, 8722.433041852259, 8813.691520796741, 8948.73153805387, 8949.149830766068, 9013.233875120688, 8922.581577674866, 9303.162715355651, 9357.438553686801, 9358.719238422858, 9497.24022078246, 8250.834983300421, 8366.83266334682, 8635.740927772176, 8673.869891951499, 8682.175193356621, 8874.600642970952, 9456.952715236379, 9484.95257523708, 9532.523373831142, 9563.665271715734, 9214.078592140731, 9292.860607091034, 9316.860247096434, 9373.859392108987, 9448.0, 8200.15003303702, 8343.963904041913, 8486.40595158333, 8532.146785321418, 8573.356998225283, 7941.722039728582, 8030.317423018875, 8177.550234737147, 8235.258826705625, 8260.586970651324], "value": 6148.9225638915905, "unit": "score"}], "name": "dromaeo_css", "value": 6256.089162653219, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 114.0, 114.0, 111.0, 115.0, 115.0, 114.0, 115.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 126.0, 123.0, 195.0, 123.0, 126.0, 149.0, 124.0, 176.0, 123.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 161.0, 162.0, 161.0, 162.0, 163.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 106.0, 77.0, 78.0, 76.0, 76.0, 101.0, 77.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 145.0, 86.0, 87.0, 86.0, 115.0, 87.0, 86.0, 131.0], "value": 99.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 123.0, 116.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 148.0, 146.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 63.0, 65.0, 68.0, 69.0, 65.0, 66.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 67.0, 66.0, 66.0, 67.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 88.0, 85.0, 84.0, 83.0, 82.0, 82.0, 82.0, 82.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 138.0, 144.0, 131.0, 139.0, 136.0, 131.0, 150.0, 152.0, 132.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 171.0, 174.0, 175.0, 172.0, 170.0, 178.0, 169.0, 172.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 70.0, 70.0, 70.0, 71.0, 68.0, 69.0, 68.0, 68.0], "value": 69.1, "unit": "score"}], "name": "kraken", "value": 1553.2999999999997, "alertThreshold": 2.0}]} 16:29:31 INFO - Return code: 0 16:29:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:29:31 INFO - # TBPL SUCCESS # 16:29:31 INFO - Running post-action listener: _resource_record_post_action 16:29:31 INFO - [mozharness: 2016-08-15 23:29:31.501801Z] Finished run-tests step (success) 16:29:31 INFO - Running post-run listener: _resource_record_post_run 16:29:31 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399294464; Read time: 8; Write time: 272912 16:29:31 INFO - TinderboxPrint: CPU usage
13.0% 16:29:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:29:31 INFO - TinderboxPrint: I/O write bytes / time
399,294,464 / 272,912 16:29:31 INFO - TinderboxPrint: CPU idle
8,327.3 (87.0%) 16:29:31 INFO - TinderboxPrint: CPU user
1,200.6 (12.5%) 16:29:31 INFO - TinderboxPrint: Swap in / out
0 / 0 16:29:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 116789248; Read time: 0; Write time: 76792 16:29:31 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 282505216; Read time: 0; Write time: 196120 16:29:32 INFO - Running post-run listener: _upload_blobber_files 16:29:32 INFO - Blob upload gear active. 16:29:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:29:32 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 16:29:32 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:29:32 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:29:32 INFO - (blobuploader) - INFO - Open directory for files ... 16:29:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:29:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:29:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:29:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:29:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:29:33 INFO - (blobuploader) - INFO - Done attempting. 16:29:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:29:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:29:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:29:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:29:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:29:36 INFO - (blobuploader) - INFO - Done attempting. 16:29:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:29:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:29:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:29:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:29:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:29:37 INFO - (blobuploader) - INFO - Done attempting. 16:29:37 INFO - (blobuploader) - INFO - Iteration through files over. 16:29:37 INFO - Return code: 0 16:29:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:29:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:29:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0b6210708a4d1d1e12e063ed17ae03f130683519c10e1f81f5f8c0bae9583a58f3bcb09175d11c2c999b028acb2778067be8bf38ba3d0278ca1af7cf908f719", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5aa4ba21b35ef04a148844cbba7a66f460970590b80fbdda887c8b981574846c069860240b596d4563aa94b4dbc73e9bd575d8359e730823f68576dd78273004", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed7025be919270117b5c54253f3c5d07bca6f6410c8f381b532a295b4e996ed03d95e008a752b4995a308eae05243144b55a7baf0300c8cb45e8236c7b3f5546"} 16:29:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:29:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:29:37 INFO - Contents: 16:29:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0b6210708a4d1d1e12e063ed17ae03f130683519c10e1f81f5f8c0bae9583a58f3bcb09175d11c2c999b028acb2778067be8bf38ba3d0278ca1af7cf908f719", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5aa4ba21b35ef04a148844cbba7a66f460970590b80fbdda887c8b981574846c069860240b596d4563aa94b4dbc73e9bd575d8359e730823f68576dd78273004", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed7025be919270117b5c54253f3c5d07bca6f6410c8f381b532a295b4e996ed03d95e008a752b4995a308eae05243144b55a7baf0300c8cb45e8236c7b3f5546"} 16:29:37 INFO - Running post-run listener: copy_logs_to_upload_dir 16:29:37 INFO - Copying logs to upload dir... 16:29:37 INFO - mkdir: /builds/slave/test/build/upload/logs 16:29:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.847969 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-15 16:29:36.535178) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 16:29:36.538805) ========= 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=923d835db2ba3686ebe126b700000192-1471302534.28445-601915454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0b6210708a4d1d1e12e063ed17ae03f130683519c10e1f81f5f8c0bae9583a58f3bcb09175d11c2c999b028acb2778067be8bf38ba3d0278ca1af7cf908f719", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5aa4ba21b35ef04a148844cbba7a66f460970590b80fbdda887c8b981574846c069860240b596d4563aa94b4dbc73e9bd575d8359e730823f68576dd78273004", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed7025be919270117b5c54253f3c5d07bca6f6410c8f381b532a295b4e996ed03d95e008a752b4995a308eae05243144b55a7baf0300c8cb45e8236c7b3f5546"} build_url:https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/SaU78bb3REmKJ3F_Y_dnAA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0b6210708a4d1d1e12e063ed17ae03f130683519c10e1f81f5f8c0bae9583a58f3bcb09175d11c2c999b028acb2778067be8bf38ba3d0278ca1af7cf908f719", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5aa4ba21b35ef04a148844cbba7a66f460970590b80fbdda887c8b981574846c069860240b596d4563aa94b4dbc73e9bd575d8359e730823f68576dd78273004", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed7025be919270117b5c54253f3c5d07bca6f6410c8f381b532a295b4e996ed03d95e008a752b4995a308eae05243144b55a7baf0300c8cb45e8236c7b3f5546"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-15 16:29:36.565515) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:29:36.565832) ========= 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=923d835db2ba3686ebe126b700000192-1471302534.28445-601915454 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-15 16:29:36.650429) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 16:29:36.650754) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-15 16:29:36.651059) ========= ========= Total master_lag: 0.17 =========