builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-005 starttime: 1472131670.96 results: success (0) buildid: 20160825050926 builduid: b9e652ba04d04b6fa6abb1e18425c857 revision: eb7d22f1a38d415c17542ad87e0b5280ca8c1e5c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 06:27:50.955855) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 06:27:50.956333) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 06:27:50.956690) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 06:27:51.013844) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 06:27:51.014195) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-25 06:27:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2016-08-25 06:27:51 (46.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108318 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 06:27:51.146889) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 06:27:51.147238) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018238 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 06:27:51.214164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 06:27:51.214509) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev eb7d22f1a38d415c17542ad87e0b5280ca8c1e5c --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 eb7d22f1a38d415c17542ad87e0b5280ca8c1e5c --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=7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-25 06:27:51,594 truncating revision to first 12 chars 2016-08-25 06:27:51,595 Setting DEBUG logging. 2016-08-25 06:27:51,595 attempt 1/10 2016-08-25 06:27:51,595 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/eb7d22f1a38d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-25 06:27:51,880 unpacking tar archive at: mozilla-central-eb7d22f1a38d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.572996 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 06:27:51.809479) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 06:27:51.809817) ========= script_repo_revision: eb7d22f1a38d415c17542ad87e0b5280ca8c1e5c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 06:27:51.810286) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 06:27:51.810589) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 06:27:51.821500) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-08-25 06:27:51.821866) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:27:52 INFO - MultiFileLogger online at 20160825 06:27:52 in /builds/slave/test 06:27:52 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 06:27:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:27:52 INFO - {'append_to_log': False, 06:27:52 INFO - 'base_work_dir': '/builds/slave/test', 06:27:52 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:27:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:27:52 INFO - 'branch': 'Firefox-Non-PGO', 06:27:52 INFO - 'buildbot_json_path': 'buildprops.json', 06:27:52 INFO - 'config_files': ('talos/linux_config.py',), 06:27:52 INFO - 'default_actions': ('clobber', 06:27:52 INFO - 'read-buildbot-config', 06:27:52 INFO - 'download-and-extract', 06:27:52 INFO - 'populate-webroot', 06:27:52 INFO - 'create-virtualenv', 06:27:52 INFO - 'install', 06:27:52 INFO - 'run-tests'), 06:27:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:27:52 INFO - 'download_minidump_stackwalk': True, 06:27:52 INFO - 'download_symbols': 'ondemand', 06:27:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:27:52 INFO - 'tooltool.py': '/tools/tooltool.py', 06:27:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:27:52 INFO - '/tools/misc-python/virtualenv.py')}, 06:27:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:27:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:27:52 INFO - 'installer_path': 'installer.exe', 06:27:52 INFO - 'log_level': 'info', 06:27:52 INFO - 'log_name': 'talos', 06:27:52 INFO - 'log_to_console': True, 06:27:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:27:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:27:52 INFO - 'opt_config_files': (), 06:27:52 INFO - 'pip_index': False, 06:27:52 INFO - 'sps_profile': False, 06:27:52 INFO - 'sps_profile_interval': 0, 06:27:52 INFO - 'suite': 'dromaeojs', 06:27:52 INFO - 'system_bits': '32', 06:27:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:27:52 INFO - 'title': 'talos-linux64-ix-005', 06:27:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:27:52 INFO - 'use_talos_json': True, 06:27:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:27:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:27:52 INFO - 'work_dir': 'build'} 06:27:52 INFO - [mozharness: 2016-08-25 13:27:52.291033Z] Running clobber step. 06:27:52 INFO - Running pre-action listener: _resource_record_pre_action 06:27:52 INFO - Running main action method: clobber 06:27:52 INFO - rmtree: /builds/slave/test/build 06:27:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:27:52 INFO - Running post-action listener: _resource_record_post_action 06:27:52 INFO - [mozharness: 2016-08-25 13:27:52.751420Z] Finished clobber step (success) 06:27:52 INFO - [mozharness: 2016-08-25 13:27:52.751522Z] Running read-buildbot-config step. 06:27:52 INFO - Running pre-action listener: _resource_record_pre_action 06:27:52 INFO - Running main action method: read_buildbot_config 06:27:52 INFO - Using buildbot properties: 06:27:52 INFO - { 06:27:52 INFO - "project": "", 06:27:52 INFO - "product": "firefox", 06:27:52 INFO - "script_repo_revision": "production", 06:27:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 06:27:52 INFO - "repository": "", 06:27:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 06:27:52 INFO - "buildid": "20160825050926", 06:27:52 INFO - "pgo_build": "False", 06:27:52 INFO - "basedir": "/builds/slave/test", 06:27:52 INFO - "buildnumber": 610, 06:27:52 INFO - "slavename": "talos-linux64-ix-005", 06:27:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:27:52 INFO - "platform": "ubuntu64_hw", 06:27:52 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 06:27:52 INFO - "branch": "mozilla-central", 06:27:52 INFO - "repo_path": "mozilla-central", 06:27:52 INFO - "revision": "eb7d22f1a38d415c17542ad87e0b5280ca8c1e5c", 06:27:52 INFO - "stage_platform": "linux64", 06:27:52 INFO - "builduid": "b9e652ba04d04b6fa6abb1e18425c857", 06:27:52 INFO - "slavebuilddir": "test" 06:27:52 INFO - } 06:27:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/IhE7ox_0TvyDH8fFDoC3_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 06:27:52 INFO - Running post-action listener: _resource_record_post_action 06:27:52 INFO - [mozharness: 2016-08-25 13:27:52.753976Z] Finished read-buildbot-config step (success) 06:27:52 INFO - [mozharness: 2016-08-25 13:27:52.754064Z] Running download-and-extract step. 06:27:52 INFO - Running pre-action listener: _resource_record_pre_action 06:27:52 INFO - Running main action method: download_and_extract 06:27:52 INFO - mkdir: /builds/slave/test/build/tests 06:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:27:52 INFO - trying https://queue.taskcluster.net/v1/task/IhE7ox_0TvyDH8fFDoC3_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:27:52 INFO - Downloading https://queue.taskcluster.net/v1/task/IhE7ox_0TvyDH8fFDoC3_w/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 06:27:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IhE7ox_0TvyDH8fFDoC3_w/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 06:27:53 INFO - Downloaded 1361 bytes. 06:27:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 06:27:53 INFO - Using the following test package requirements: 06:27:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 06:27:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:27:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:27:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:53 INFO - u'jsshell-linux-x86_64.zip'], 06:27:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:27:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 06:27:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:27:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:27:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:27:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 06:27:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:27:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:27:53 INFO - trying https://queue.taskcluster.net/v1/task/IhE7ox_0TvyDH8fFDoC3_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:27:53 INFO - Downloading https://queue.taskcluster.net/v1/task/IhE7ox_0TvyDH8fFDoC3_w/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 06:27:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IhE7ox_0TvyDH8fFDoC3_w/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 06:27:54 INFO - Downloaded 20324128 bytes. 06:27:54 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 06:27:58 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 06:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:27:58 INFO - trying https://queue.taskcluster.net/v1/task/IhE7ox_0TvyDH8fFDoC3_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 06:27:58 INFO - Downloading https://queue.taskcluster.net/v1/task/IhE7ox_0TvyDH8fFDoC3_w/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 06:27:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IhE7ox_0TvyDH8fFDoC3_w/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 06:27:59 INFO - Downloaded 20324128 bytes. 06:27:59 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 06:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:03 INFO - trying https://queue.taskcluster.net/v1/task/IhE7ox_0TvyDH8fFDoC3_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 06:28:03 INFO - Downloading https://queue.taskcluster.net/v1/task/IhE7ox_0TvyDH8fFDoC3_w/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 06:28:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IhE7ox_0TvyDH8fFDoC3_w/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 06:28:05 INFO - Downloaded 14413981 bytes. 06:28:05 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 06:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:05 INFO - trying https://queue.taskcluster.net/v1/task/IhE7ox_0TvyDH8fFDoC3_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:28:05 INFO - Downloading https://queue.taskcluster.net/v1/task/IhE7ox_0TvyDH8fFDoC3_w/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 06:28:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IhE7ox_0TvyDH8fFDoC3_w/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 06:28:07 INFO - Downloaded 55761856 bytes. 06:28:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IhE7ox_0TvyDH8fFDoC3_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:28:07 INFO - mkdir: /builds/slave/test/properties 06:28:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:28:07 INFO - Writing to file /builds/slave/test/properties/build_url 06:28:07 INFO - Contents: 06:28:07 INFO - build_url:https://queue.taskcluster.net/v1/task/IhE7ox_0TvyDH8fFDoC3_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 06:28:07 INFO - Running post-action listener: _resource_record_post_action 06:28:07 INFO - Running post-action listener: set_extra_try_arguments 06:28:07 INFO - [mozharness: 2016-08-25 13:28:07.886598Z] Finished download-and-extract step (success) 06:28:07 INFO - [mozharness: 2016-08-25 13:28:07.886821Z] Running populate-webroot step. 06:28:07 INFO - Running pre-action listener: _resource_record_pre_action 06:28:07 INFO - Running main action method: populate_webroot 06:28:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:28:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:28:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:28:07 INFO - '--tppagecycles', 06:28:07 INFO - '7'], 06:28:07 INFO - 'tests': ['tsvgm']}}, 06:28:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:28:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:28:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:28:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:28:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:28:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:28:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:07 INFO - 'talos_options': ['--disable-e10s'], 06:28:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:28:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:28:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:07 INFO - 'talos_options': ['--disable-e10s'], 06:28:07 INFO - 'tests': ['damp', 'tps']}, 06:28:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:07 INFO - 'tests': ['damp', 'tps']}, 06:28:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:28:07 INFO - 'tests': ['dromaeo_dom']}, 06:28:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:28:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:28:07 INFO - 'tests': ['basic_compositor_video']}, 06:28:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:28:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:28:07 INFO - 'tests': ['a11yr', 06:28:07 INFO - 'ts_paint', 06:28:07 INFO - 'tpaint', 06:28:07 INFO - 'sessionrestore', 06:28:07 INFO - 'sessionrestore_no_auto_restore', 06:28:07 INFO - 'tabpaint']}, 06:28:07 INFO - 'other-e10s': {'tests': ['a11yr', 06:28:07 INFO - 'ts_paint', 06:28:07 INFO - 'tpaint', 06:28:07 INFO - 'sessionrestore', 06:28:07 INFO - 'sessionrestore_no_auto_restore', 06:28:07 INFO - 'tabpaint']}, 06:28:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:28:07 INFO - 'ts_paint', 06:28:07 INFO - 'tpaint', 06:28:07 INFO - 'sessionrestore', 06:28:07 INFO - 'sessionrestore_no_auto_restore', 06:28:07 INFO - 'tabpaint']}, 06:28:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:28:07 INFO - 'ts_paint', 06:28:07 INFO - 'tpaint', 06:28:07 INFO - 'sessionrestore', 06:28:07 INFO - 'sessionrestore_no_auto_restore', 06:28:07 INFO - 'tabpaint']}, 06:28:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:28:07 INFO - 'tests': ['a11yr', 06:28:07 INFO - 'ts_paint', 06:28:07 INFO - 'tpaint', 06:28:07 INFO - 'sessionrestore', 06:28:07 INFO - 'sessionrestore_no_auto_restore', 06:28:07 INFO - 'tabpaint']}, 06:28:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:28:07 INFO - 'tests': ['a11yr', 06:28:07 INFO - 'ts_paint', 06:28:07 INFO - 'tpaint', 06:28:07 INFO - 'sessionrestore', 06:28:07 INFO - 'sessionrestore_no_auto_restore', 06:28:07 INFO - 'tabpaint']}, 06:28:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:28:07 INFO - 'tests': ['tsvgx', 06:28:07 INFO - 'tsvgr_opacity', 06:28:07 INFO - 'tart', 06:28:07 INFO - 'tscrollx', 06:28:07 INFO - 'cart']}, 06:28:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:28:07 INFO - 'tsvgr_opacity', 06:28:07 INFO - 'tart', 06:28:07 INFO - 'tscrollx', 06:28:07 INFO - 'cart']}, 06:28:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:07 INFO - 'talos_options': ['--disable-e10s'], 06:28:07 INFO - 'tests': ['tp5o']}, 06:28:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:07 INFO - 'tests': ['tp5o']}, 06:28:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:07 INFO - 'talos_options': ['--disable-e10s', 06:28:07 INFO - '--xperf_path', 06:28:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:28:07 INFO - 'tests': ['tp5n']}, 06:28:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:07 INFO - 'talos_options': ['--xperf_path', 06:28:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:28:07 INFO - 'tests': ['tp5n']}}, 06:28:07 INFO - 'talos.zip': {'path': '', 06:28:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:28:07 INFO - Running post-action listener: _resource_record_post_action 06:28:07 INFO - [mozharness: 2016-08-25 13:28:07.909276Z] Finished populate-webroot step (success) 06:28:07 INFO - [mozharness: 2016-08-25 13:28:07.909364Z] Running create-virtualenv step. 06:28:07 INFO - Running pre-action listener: _resource_record_pre_action 06:28:07 INFO - Running main action method: create_virtualenv 06:28:07 INFO - Creating virtualenv /builds/slave/test/build/venv 06:28:07 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 06:28:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:28:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:28:08 INFO - Using real prefix '/usr' 06:28:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:28:08 INFO - Installing distribute.............................................................................................................................................................................................done. 06:28:10 INFO - Installing pip.................done. 06:28:10 INFO - Return code: 0 06:28:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:10 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 0x7f4f8bedff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be090>, '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 0x13c19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c1e40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', '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 06:28:10 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 06:28:10 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 06:28:10 INFO - Using env: {'DISPLAY': ':0', 06:28:10 INFO - 'HOME': '/home/cltbld', 06:28:10 INFO - 'LANG': 'en_US.UTF-8', 06:28:10 INFO - 'LANGUAGE': 'en_US:en', 06:28:10 INFO - 'LOGNAME': 'cltbld', 06:28:10 INFO - 'MAIL': '/var/mail/cltbld', 06:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:10 INFO - 'MOZ_NO_REMOTE': '1', 06:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:10 INFO - 'NO_EM_RESTART': '1', 06:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:10 INFO - 'PWD': '/builds/slave/test', 06:28:10 INFO - 'SHELL': '/bin/bash', 06:28:10 INFO - 'SHLVL': '1', 06:28:10 INFO - 'TERM': 'linux', 06:28:10 INFO - 'TMOUT': '86400', 06:28:10 INFO - 'USER': 'cltbld', 06:28:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', 06:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:10 INFO - '_': '/tools/buildbot/bin/python'} 06:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:10 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 06:28:10 INFO - Cleaning up... 06:28:10 INFO - Return code: 0 06:28:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:10 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 0x7f4f8bedff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be090>, '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 0x13c19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c1e40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', '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 06:28:10 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 06:28:10 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 06:28:10 INFO - Using env: {'DISPLAY': ':0', 06:28:10 INFO - 'HOME': '/home/cltbld', 06:28:10 INFO - 'LANG': 'en_US.UTF-8', 06:28:10 INFO - 'LANGUAGE': 'en_US:en', 06:28:10 INFO - 'LOGNAME': 'cltbld', 06:28:10 INFO - 'MAIL': '/var/mail/cltbld', 06:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:10 INFO - 'MOZ_NO_REMOTE': '1', 06:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:10 INFO - 'NO_EM_RESTART': '1', 06:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:10 INFO - 'PWD': '/builds/slave/test', 06:28:10 INFO - 'SHELL': '/bin/bash', 06:28:10 INFO - 'SHLVL': '1', 06:28:10 INFO - 'TERM': 'linux', 06:28:10 INFO - 'TMOUT': '86400', 06:28:10 INFO - 'USER': 'cltbld', 06:28:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', 06:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:10 INFO - '_': '/tools/buildbot/bin/python'} 06:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:10 INFO - Downloading/unpacking psutil>=3.1.1 06:28:10 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 06:28:10 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 06:28:10 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 06:28:10 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 06:28:10 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 06:28:10 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 06:28:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:28:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:28:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:28:12 INFO - Installing collected packages: psutil 06:28:12 INFO - Running setup.py install for psutil 06:28:12 INFO - building 'psutil._psutil_linux' extension 06:28:12 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 06:28:13 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 06:28:13 INFO - building 'psutil._psutil_posix' extension 06:28:13 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 06:28:13 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 06:28:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:28:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:28:13 INFO - Successfully installed psutil 06:28:13 INFO - Cleaning up... 06:28:13 INFO - Return code: 0 06:28:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:28: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')]} 06:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28: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')]} 06:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4f8bedff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be090>, '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 0x13c19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c1e40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', '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 06:28: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:28: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 mozsystemmonitor==0.3 06:28:13 INFO - Using env: {'DISPLAY': ':0', 06:28:13 INFO - 'HOME': '/home/cltbld', 06:28:13 INFO - 'LANG': 'en_US.UTF-8', 06:28:13 INFO - 'LANGUAGE': 'en_US:en', 06:28:13 INFO - 'LOGNAME': 'cltbld', 06:28:13 INFO - 'MAIL': '/var/mail/cltbld', 06:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:13 INFO - 'MOZ_NO_REMOTE': '1', 06:28:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:13 INFO - 'NO_EM_RESTART': '1', 06:28:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:13 INFO - 'PWD': '/builds/slave/test', 06:28:13 INFO - 'SHELL': '/bin/bash', 06:28:13 INFO - 'SHLVL': '1', 06:28:13 INFO - 'TERM': 'linux', 06:28:13 INFO - 'TMOUT': '86400', 06:28:13 INFO - 'USER': 'cltbld', 06:28:13 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', 06:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:13 INFO - '_': '/tools/buildbot/bin/python'} 06:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:28:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:28:15 INFO - Installing collected packages: mozsystemmonitor 06:28:15 INFO - Running setup.py install for mozsystemmonitor 06:28:15 INFO - Successfully installed mozsystemmonitor 06:28:15 INFO - Cleaning up... 06:28:15 INFO - Return code: 0 06:28:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:28:15 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')]} 06:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:15 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')]} 06:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:15 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 0x7f4f8bedff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be090>, '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 0x13c19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c1e40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', '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 06:28:15 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 06:28:15 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 06:28:15 INFO - Using env: {'DISPLAY': ':0', 06:28:15 INFO - 'HOME': '/home/cltbld', 06:28:15 INFO - 'LANG': 'en_US.UTF-8', 06:28:15 INFO - 'LANGUAGE': 'en_US:en', 06:28:15 INFO - 'LOGNAME': 'cltbld', 06:28:15 INFO - 'MAIL': '/var/mail/cltbld', 06:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:15 INFO - 'MOZ_NO_REMOTE': '1', 06:28:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:15 INFO - 'NO_EM_RESTART': '1', 06:28:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:15 INFO - 'PWD': '/builds/slave/test', 06:28:15 INFO - 'SHELL': '/bin/bash', 06:28:15 INFO - 'SHLVL': '1', 06:28:15 INFO - 'TERM': 'linux', 06:28:15 INFO - 'TMOUT': '86400', 06:28:15 INFO - 'USER': 'cltbld', 06:28:15 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', 06:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:15 INFO - '_': '/tools/buildbot/bin/python'} 06:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:15 INFO - Downloading/unpacking jsonschema==2.5.1 06:28:15 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 06:28:15 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 06:28:15 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 06:28:15 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 06:28:15 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 06:28:15 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 06:28:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:28:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:28:17 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 06:28:17 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 06:28:17 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 06:28:17 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 06:28:17 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 06:28:17 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 06:28:18 INFO - Downloading functools32-3.2.3-2.tar.gz 06:28:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:28:18 INFO - warning: no files found matching '*.txt' 06:28:18 INFO - no previously-included directories found matching 'build' 06:28:18 INFO - no previously-included directories found matching 'dist' 06:28:18 INFO - no previously-included directories found matching '.git*' 06:28:18 INFO - Installing collected packages: jsonschema, functools32 06:28:18 INFO - Running setup.py install for functools32 06:28:18 INFO - warning: no files found matching '*.txt' 06:28:18 INFO - no previously-included directories found matching 'build' 06:28:18 INFO - no previously-included directories found matching 'dist' 06:28:18 INFO - no previously-included directories found matching '.git*' 06:28:18 INFO - Successfully installed jsonschema functools32 06:28:18 INFO - Cleaning up... 06:28:18 INFO - Return code: 0 06:28:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:28: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')]} 06:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28: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')]} 06:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28: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', '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 0x7f4f8bedff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be090>, '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 0x13c19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c1e40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', '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 06:28: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:28: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 functools32==3.2.3-2 06:28:18 INFO - Using env: {'DISPLAY': ':0', 06:28:18 INFO - 'HOME': '/home/cltbld', 06:28:18 INFO - 'LANG': 'en_US.UTF-8', 06:28:18 INFO - 'LANGUAGE': 'en_US:en', 06:28:18 INFO - 'LOGNAME': 'cltbld', 06:28:18 INFO - 'MAIL': '/var/mail/cltbld', 06:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:18 INFO - 'MOZ_NO_REMOTE': '1', 06:28:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:18 INFO - 'NO_EM_RESTART': '1', 06:28:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:18 INFO - 'PWD': '/builds/slave/test', 06:28:18 INFO - 'SHELL': '/bin/bash', 06:28:18 INFO - 'SHLVL': '1', 06:28:18 INFO - 'TERM': 'linux', 06:28:18 INFO - 'TMOUT': '86400', 06:28:18 INFO - 'USER': 'cltbld', 06:28:18 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', 06:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:18 INFO - '_': '/tools/buildbot/bin/python'} 06:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:28:18 INFO - Cleaning up... 06:28:18 INFO - Return code: 0 06:28:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:28: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')]} 06:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28: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')]} 06:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28: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', '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 0x7f4f8bedff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be090>, '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 0x13c19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c1e40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', '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 06:28: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:28: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 blobuploader==1.2.4 06:28:18 INFO - Using env: {'DISPLAY': ':0', 06:28:18 INFO - 'HOME': '/home/cltbld', 06:28:18 INFO - 'LANG': 'en_US.UTF-8', 06:28:18 INFO - 'LANGUAGE': 'en_US:en', 06:28:18 INFO - 'LOGNAME': 'cltbld', 06:28:18 INFO - 'MAIL': '/var/mail/cltbld', 06:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:18 INFO - 'MOZ_NO_REMOTE': '1', 06:28:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:18 INFO - 'NO_EM_RESTART': '1', 06:28:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:18 INFO - 'PWD': '/builds/slave/test', 06:28:18 INFO - 'SHELL': '/bin/bash', 06:28:18 INFO - 'SHLVL': '1', 06:28:18 INFO - 'TERM': 'linux', 06:28:18 INFO - 'TMOUT': '86400', 06:28:18 INFO - 'USER': 'cltbld', 06:28:18 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', 06:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:18 INFO - '_': '/tools/buildbot/bin/python'} 06:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:18 INFO - Downloading/unpacking blobuploader==1.2.4 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28:20 INFO - Downloading blobuploader-1.2.4.tar.gz 06:28:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:28:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:28:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28:21 INFO - Downloading docopt-0.6.1.tar.gz 06:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:28:21 INFO - Installing collected packages: blobuploader, requests, docopt 06:28:21 INFO - Running setup.py install for blobuploader 06:28:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:28:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:28:21 INFO - Running setup.py install for requests 06:28:21 INFO - Running setup.py install for docopt 06:28:21 INFO - Successfully installed blobuploader requests docopt 06:28:21 INFO - Cleaning up... 06:28:22 INFO - Return code: 0 06:28:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:22 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')]} 06:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:22 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')]} 06:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:22 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 0x7f4f8bedff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be090>, '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 0x13c19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c1e40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', '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 06:28:22 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 06:28:22 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 06:28:22 INFO - Using env: {'DISPLAY': ':0', 06:28:22 INFO - 'HOME': '/home/cltbld', 06:28:22 INFO - 'LANG': 'en_US.UTF-8', 06:28:22 INFO - 'LANGUAGE': 'en_US:en', 06:28:22 INFO - 'LOGNAME': 'cltbld', 06:28:22 INFO - 'MAIL': '/var/mail/cltbld', 06:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:22 INFO - 'MOZ_NO_REMOTE': '1', 06:28:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:22 INFO - 'NO_EM_RESTART': '1', 06:28:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:22 INFO - 'PWD': '/builds/slave/test', 06:28:22 INFO - 'SHELL': '/bin/bash', 06:28:22 INFO - 'SHLVL': '1', 06:28:22 INFO - 'TERM': 'linux', 06:28:22 INFO - 'TMOUT': '86400', 06:28:22 INFO - 'USER': 'cltbld', 06:28:22 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', 06:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:22 INFO - '_': '/tools/buildbot/bin/python'} 06:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:28:22 INFO - Running setup.py (path:/tmp/pip-xFCen5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:28:22 INFO - Running setup.py (path:/tmp/pip-6dMrDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:28:22 INFO - Running setup.py (path:/tmp/pip-XFGYPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:28:22 INFO - Running setup.py (path:/tmp/pip-6afsjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:28:22 INFO - Running setup.py (path:/tmp/pip-_WwfGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:28:22 INFO - Running setup.py (path:/tmp/pip-vrT8ut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:28:22 INFO - Running setup.py (path:/tmp/pip-6Va8zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:28:22 INFO - Running setup.py (path:/tmp/pip-apo4ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:28:22 INFO - Running setup.py (path:/tmp/pip-BqD6ju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:28:22 INFO - Running setup.py (path:/tmp/pip-Zu33Qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:28:22 INFO - Running setup.py (path:/tmp/pip-IK46sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:28:23 INFO - Running setup.py (path:/tmp/pip-45PXRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:28:23 INFO - Running setup.py (path:/tmp/pip-AQCVUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:28:23 INFO - Running setup.py (path:/tmp/pip-byKaB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:23 INFO - Running setup.py (path:/tmp/pip-r2Drfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:28:23 INFO - Running setup.py (path:/tmp/pip-JwN27X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:28:23 INFO - Running setup.py (path:/tmp/pip-4LomyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:28:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:28:23 INFO - Running setup.py install for manifestparser 06:28:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:28:23 INFO - Running setup.py install for mozcrash 06:28:23 INFO - Running setup.py install for mozdebug 06:28:23 INFO - Running setup.py install for mozdevice 06:28:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:28:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:28:23 INFO - Running setup.py install for mozfile 06:28:23 INFO - Running setup.py install for mozhttpd 06:28:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:28:24 INFO - Running setup.py install for mozinfo 06:28:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:28:24 INFO - Running setup.py install for mozInstall 06:28:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:28:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:28:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:28:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:28:24 INFO - Running setup.py install for mozleak 06:28:24 INFO - Running setup.py install for mozlog 06:28:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:28:24 INFO - Running setup.py install for moznetwork 06:28:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:28:24 INFO - Running setup.py install for mozprocess 06:28:24 INFO - Running setup.py install for mozprofile 06:28:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:28:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:28:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:28:24 INFO - Running setup.py install for mozrunner 06:28:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:28:24 INFO - Running setup.py install for mozscreenshot 06:28:25 INFO - Running setup.py install for moztest 06:28:25 INFO - Running setup.py install for mozversion 06:28:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:28:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:28:25 INFO - Cleaning up... 06:28:25 INFO - Return code: 0 06:28:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:25 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')]} 06:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:25 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')]} 06:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:25 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 0x7f4f8bedff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be090>, '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 0x13c19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c1e40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', '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 06:28:25 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 06:28:25 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 06:28:25 INFO - Using env: {'DISPLAY': ':0', 06:28:25 INFO - 'HOME': '/home/cltbld', 06:28:25 INFO - 'LANG': 'en_US.UTF-8', 06:28:25 INFO - 'LANGUAGE': 'en_US:en', 06:28:25 INFO - 'LOGNAME': 'cltbld', 06:28:25 INFO - 'MAIL': '/var/mail/cltbld', 06:28:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:25 INFO - 'MOZ_NO_REMOTE': '1', 06:28:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:25 INFO - 'NO_EM_RESTART': '1', 06:28:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:25 INFO - 'PWD': '/builds/slave/test', 06:28:25 INFO - 'SHELL': '/bin/bash', 06:28:25 INFO - 'SHLVL': '1', 06:28:25 INFO - 'TERM': 'linux', 06:28:25 INFO - 'TMOUT': '86400', 06:28:25 INFO - 'USER': 'cltbld', 06:28:25 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', 06:28:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:25 INFO - '_': '/tools/buildbot/bin/python'} 06:28:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:28:25 INFO - Running setup.py (path:/tmp/pip-xMQ0ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:28:25 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)) 06:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:28:25 INFO - Running setup.py (path:/tmp/pip-j94Y53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:28:25 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)) 06:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:28:25 INFO - Running setup.py (path:/tmp/pip-elDcuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:28:25 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)) 06:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:28:25 INFO - Running setup.py (path:/tmp/pip-8xAPNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:28:25 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)) 06:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:28:25 INFO - Running setup.py (path:/tmp/pip-comVBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:28:25 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)) 06:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:28:25 INFO - Running setup.py (path:/tmp/pip-ph0J7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:28:25 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)) 06:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:28:25 INFO - Running setup.py (path:/tmp/pip-BDlL8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:28:25 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)) 06:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:28:25 INFO - Running setup.py (path:/tmp/pip-z8yfUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:28:26 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)) 06:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:28:26 INFO - Running setup.py (path:/tmp/pip-r_0Hw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:28:26 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)) 06:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:28:26 INFO - Running setup.py (path:/tmp/pip-oLhcek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:28:26 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)) 06:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:28:26 INFO - Running setup.py (path:/tmp/pip-UeNrDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:28:26 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)) 06:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:28:26 INFO - Running setup.py (path:/tmp/pip-MLa2Gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:28:26 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)) 06:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:28:26 INFO - Running setup.py (path:/tmp/pip-siUazn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:28:26 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)) 06:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:28:26 INFO - Running setup.py (path:/tmp/pip-n0YA4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:28:26 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)) 06:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:26 INFO - Running setup.py (path:/tmp/pip-E7rG2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:26 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)) 06:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:28:26 INFO - Running setup.py (path:/tmp/pip-h8qFDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:28:26 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)) 06:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:28:26 INFO - Running setup.py (path:/tmp/pip-LJ23Qu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:28:26 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)) 06:28:26 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)) 06:28:26 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)) 06:28:26 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)) 06:28:26 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)) 06:28:26 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)) 06:28:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:28:26 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 06:28:26 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 06:28:26 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 06:28:26 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 06:28:26 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 06:28:26 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 06:28:28 INFO - Downloading blessings-1.6.tar.gz 06:28:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:28:28 INFO - Installing collected packages: blessings 06:28:28 INFO - Running setup.py install for blessings 06:28:28 INFO - Successfully installed blessings 06:28:28 INFO - Cleaning up... 06:28:28 INFO - Return code: 0 06:28:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:28:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:28:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:28:29 INFO - Reading from file tmpfile_stdout 06:28:29 INFO - Current package versions: 06:28:29 INFO - argparse == 1.2.1 06:28:29 INFO - blessings == 1.6 06:28:29 INFO - blobuploader == 1.2.4 06:28:29 INFO - docopt == 0.6.1 06:28:29 INFO - functools32 == 3.2.3-2 06:28:29 INFO - jsonschema == 2.5.1 06:28:29 INFO - manifestparser == 1.1 06:28:29 INFO - mozInstall == 1.12 06:28:29 INFO - mozcrash == 0.17 06:28:29 INFO - mozdebug == 0.1 06:28:29 INFO - mozdevice == 0.48 06:28:29 INFO - mozfile == 1.2 06:28:29 INFO - mozhttpd == 0.7 06:28:29 INFO - mozinfo == 0.9 06:28:29 INFO - mozleak == 0.1 06:28:29 INFO - mozlog == 3.3 06:28:29 INFO - moznetwork == 0.27 06:28:29 INFO - mozprocess == 0.23 06:28:29 INFO - mozprofile == 0.28 06:28:29 INFO - mozrunner == 6.12 06:28:29 INFO - mozscreenshot == 0.1 06:28:29 INFO - mozsystemmonitor == 0.3 06:28:29 INFO - moztest == 0.7 06:28:29 INFO - mozversion == 1.4 06:28:29 INFO - psutil == 3.1.1 06:28:29 INFO - requests == 1.2.3 06:28:29 INFO - wsgiref == 0.1.2 06:28:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:29 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 0x7f4f8bedff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be090>, '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 0x13c19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c1e40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', '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 06:28:29 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 06:28:29 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 06:28:29 INFO - Using env: {'DISPLAY': ':0', 06:28:29 INFO - 'HOME': '/home/cltbld', 06:28:29 INFO - 'LANG': 'en_US.UTF-8', 06:28:29 INFO - 'LANGUAGE': 'en_US:en', 06:28:29 INFO - 'LOGNAME': 'cltbld', 06:28:29 INFO - 'MAIL': '/var/mail/cltbld', 06:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:29 INFO - 'MOZ_NO_REMOTE': '1', 06:28:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:29 INFO - 'NO_EM_RESTART': '1', 06:28:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:29 INFO - 'PWD': '/builds/slave/test', 06:28:29 INFO - 'SHELL': '/bin/bash', 06:28:29 INFO - 'SHLVL': '1', 06:28:29 INFO - 'TERM': 'linux', 06:28:29 INFO - 'TMOUT': '86400', 06:28:29 INFO - 'USER': 'cltbld', 06:28:29 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', 06:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:29 INFO - '_': '/tools/buildbot/bin/python'} 06:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:29 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)) 06:28:29 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)) 06:28:29 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)) 06:28:29 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)) 06:28:29 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)) 06:28:29 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)) 06:28:29 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)) 06:28:29 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)) 06:28:29 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)) 06:28:29 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)) 06:28:29 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)) 06:28:29 INFO - Cleaning up... 06:28:29 INFO - Return code: 0 06:28:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:29 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 0x7f4f8bedff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c4230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13be090>, '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 0x13c19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c1e40>, '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': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', '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 06:28:29 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 06:28:29 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 06:28:29 INFO - Using env: {'DISPLAY': ':0', 06:28:29 INFO - 'HOME': '/home/cltbld', 06:28:29 INFO - 'LANG': 'en_US.UTF-8', 06:28:29 INFO - 'LANGUAGE': 'en_US:en', 06:28:29 INFO - 'LOGNAME': 'cltbld', 06:28:29 INFO - 'MAIL': '/var/mail/cltbld', 06:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:29 INFO - 'MOZ_NO_REMOTE': '1', 06:28:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:29 INFO - 'NO_EM_RESTART': '1', 06:28:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:29 INFO - 'PWD': '/builds/slave/test', 06:28:29 INFO - 'SHELL': '/bin/bash', 06:28:29 INFO - 'SHLVL': '1', 06:28:29 INFO - 'TERM': 'linux', 06:28:29 INFO - 'TMOUT': '86400', 06:28:29 INFO - 'USER': 'cltbld', 06:28:29 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', 06:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:29 INFO - '_': '/tools/buildbot/bin/python'} 06:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:28:29 INFO - Cleaning up... 06:28:29 INFO - Return code: 0 06:28:29 INFO - Running post-action listener: _resource_record_post_action 06:28:29 INFO - Running post-action listener: _start_resource_monitoring 06:28:29 INFO - Starting resource monitoring. 06:28:29 INFO - [mozharness: 2016-08-25 13:28:29.541325Z] Finished create-virtualenv step (success) 06:28:29 INFO - [mozharness: 2016-08-25 13:28:29.541892Z] Running install step. 06:28:29 INFO - Running pre-action listener: _resource_record_pre_action 06:28:29 INFO - Running main action method: install 06:28:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:28:29 INFO - Reading from file tmpfile_stdout 06:28:29 INFO - Detecting whether we're running mozinstall >=1.0... 06:28:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:28:29 INFO - Reading from file tmpfile_stdout 06:28:29 INFO - Output received: 06:28:29 INFO - Usage: mozinstall [options] installer 06:28:29 INFO - Options: 06:28:29 INFO - -h, --help show this help message and exit 06:28:29 INFO - -d DEST, --destination=DEST 06:28:29 INFO - Directory to install application into. [default: 06:28:29 INFO - "/builds/slave/test"] 06:28:29 INFO - --app=APP Application being installed. [default: firefox] 06:28:29 INFO - mkdir: /builds/slave/test/build/application 06:28:29 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'] 06:28:29 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 06:28:45 INFO - Reading from file tmpfile_stdout 06:28:45 INFO - Output received: 06:28:45 INFO - /builds/slave/test/build/application/firefox/firefox 06:28:45 INFO - Running post-action listener: _resource_record_post_action 06:28:45 INFO - [mozharness: 2016-08-25 13:28:45.904817Z] Finished install step (success) 06:28:45 INFO - [mozharness: 2016-08-25 13:28:45.905061Z] Running run-tests step. 06:28:45 INFO - Running pre-action listener: _resource_record_pre_action 06:28:45 INFO - Running main action method: run_tests 06:28:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:28:45 INFO - Python 2.7.3 06:28:45 INFO - Return code: 0 06:28:45 INFO - grabbing minidump binary from tooltool 06:28:45 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')]} 06:28:45 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 0x13be090>, '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 0x13c19b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13c1e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:28:45 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 06:28:45 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 06:28:45 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 06:28:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:28:45 INFO - Return code: 0 06:28:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:28:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:28:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:28:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:28:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:28:45 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/IhE7ox_0TvyDH8fFDoC3_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 06:28:45 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/IhE7ox_0TvyDH8fFDoC3_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 06:28:45 INFO - Using env: {'DISPLAY': ':0', 06:28:45 INFO - 'HOME': '/home/cltbld', 06:28:45 INFO - 'LANG': 'en_US.UTF-8', 06:28:45 INFO - 'LANGUAGE': 'en_US:en', 06:28:45 INFO - 'LOGNAME': 'cltbld', 06:28:45 INFO - 'MAIL': '/var/mail/cltbld', 06:28:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:28:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:45 INFO - 'MOZ_NO_REMOTE': '1', 06:28:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:28:45 INFO - 'NO_EM_RESTART': '1', 06:28:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:45 INFO - 'PWD': '/builds/slave/test', 06:28:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:28:45 INFO - 'SHELL': '/bin/bash', 06:28:45 INFO - 'SHLVL': '1', 06:28:45 INFO - 'TERM': 'linux', 06:28:45 INFO - 'TMOUT': '86400', 06:28:45 INFO - 'USER': 'cltbld', 06:28:45 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501', 06:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:45 INFO - '_': '/tools/buildbot/bin/python'} 06:28:45 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/IhE7ox_0TvyDH8fFDoC3_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 06:28:46 INFO - mozversion application_buildid: 20160825050926 06:28:46 INFO - mozversion application_changeset: eb7d22f1a38d415c17542ad87e0b5280ca8c1e5c 06:28:46 INFO - mozversion application_display_name: Nightly 06:28:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:28:46 INFO - mozversion application_name: Firefox 06:28:46 INFO - mozversion application_remotingname: firefox 06:28:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:28:46 INFO - mozversion application_vendor: Mozilla 06:28:46 INFO - mozversion application_version: 51.0a1 06:28:46 INFO - mozversion platform_buildid: 20160825050926 06:28:46 INFO - mozversion platform_changeset: eb7d22f1a38d415c17542ad87e0b5280ca8c1e5c 06:28:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:28:46 INFO - mozversion platform_version: 51.0a1 06:28:46 INFO - using testdate: 1472131726 06:28:46 INFO - actual date: 1472131726 06:28:46 INFO - starting webserver on 'localhost:60090' 06:28:46 INFO - SUITE-START | Running 2 tests 06:28:46 INFO - TEST-START | dromaeo_css 06:28:46 INFO - operating with platform_type : linux_ 06:28:46 INFO - Initialising browser for dromaeo_css test... 06:28:46 INFO - TEST-INFO | started process 23289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwSHRHE/profile http://localhost:60090/getInfo.html) 06:28:50 INFO - PROCESS | 23289 | __metrics Screen width/height:1600/1200 06:28:50 INFO - PROCESS | 23289 | colorDepth:24 06:28:50 INFO - PROCESS | 23289 | Browser inner width/height: 1024/697 06:28:50 INFO - PROCESS | 23289 | __metrics 06:28:51 INFO - PROCESS | 23289 | 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" 06:28:51 INFO - PROCESS | 23289 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:28:51 INFO - PROCESS | 23289 | console.error: PushService: 06:28:51 INFO - PROCESS | 23289 | stateChangeProcessEnqueue: Error transitioning state 06:28:51 INFO - PROCESS | 23289 | UnknownError 06:28:52 INFO - TEST-INFO | 23289: exit 0 06:28:52 INFO - Browser initialized. 06:28:52 INFO - Running cycle 1/1 for dromaeo_css test... 06:28:52 INFO - TEST-INFO | started process 23371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwSHRHE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:29:04 INFO - PROCESS | 23371 | RSS: Main: 183853056 06:29:04 INFO - PROCESS | 23371 | 06:29:56 INFO - PROCESS | 23371 | 1472131796813 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] 06:32:08 INFO - PROCESS | 23371 | Cycle 1(1): loaded http://localhost:60090/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60090/tests/dromaeo/cssquery-ext.html) 06:32:09 INFO - PROCESS | 23371 | RSS: Main: 270786560 06:32:09 INFO - PROCESS | 23371 | 06:35:12 INFO - PROCESS | 23371 | Cycle 1(1): loaded http://localhost:60090/tests/dromaeo/cssquery-ext.html (next: http://localhost:60090/tests/dromaeo/cssquery-jquery.html) 06:35:12 INFO - PROCESS | 23371 | RSS: Main: 279126016 06:35:12 INFO - PROCESS | 23371 | 06:38:15 INFO - PROCESS | 23371 | Cycle 1(1): loaded http://localhost:60090/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60090/tests/dromaeo/cssquery-mootools.html) 06:38:15 INFO - PROCESS | 23371 | RSS: Main: 259497984 06:38:15 INFO - PROCESS | 23371 | 06:41:17 INFO - PROCESS | 23371 | Cycle 1(1): loaded http://localhost:60090/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60090/tests/dromaeo/cssquery-prototype.html) 06:41:18 INFO - PROCESS | 23371 | RSS: Main: 214519808 06:41:18 INFO - PROCESS | 23371 | 06:44:21 INFO - PROCESS | 23371 | Cycle 1(1): loaded http://localhost:60090/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60090/tests/dromaeo/cssquery-yui.html) 06:44:22 INFO - PROCESS | 23371 | RSS: Main: 215461888 06:44:22 INFO - PROCESS | 23371 | 06:47:24 INFO - PROCESS | 23371 | Cycle 1(1): loaded http://localhost:60090/tests/dromaeo/cssquery-yui.html (next: http://localhost:60090/tests/dromaeo/cssquery-dojo.html) 06:47:25 INFO - PROCESS | 23371 | RSS: Main: 305033216 06:47:25 INFO - PROCESS | 23371 | 06:47:25 INFO - PROCESS | 23371 | __start_tp_report 06:47:25 INFO - PROCESS | 23371 | _x_x_mozilla_page_load 06:47:25 INFO - PROCESS | 23371 | _x_x_mozilla_page_load_details 06:47:25 INFO - PROCESS | 23371 | |i|pagename|runs| 06:47:25 INFO - PROCESS | 23371 | |0;dojo.html;2545.10921177588;2548.9107881224154;2560.60310651849;2575.9999999999995;2585.9353516162096;4412.073464572436;4516.23224051912;4537.2286711259085;4577.542245775421;4577.656675749316;4526.886827829306;4532.320151977205;4587.678862479619;4588.403507544023;4600.378948841905;4148.522919864224;4184.246835569596;4213.978930105345;4274.829006839723;4360.193364227628;4303.7848107594655;4314.784260786963;4315.115401342733;4342.630876375511;4366.585174408426;4172.395002724618;4216.683748718859;4244.278472659656;4290.313549832027;4297.72064815786;4117.97941010293;4152.294110001307;4175.582441755831;4189.832406703728;4217.662586993064;4148.605882441163;4209.410682504452;4219.746815191098;4222.366645003274;4279.828806847722;4494.07871386365;4550.317452382136;4558.452985641744;4596.632269418438;4668.883277918046;4822.493638167977;4825.541573550507;4829.734364609945;4859.465458799529;4877.097736918681;4848.951510484885;4852.902941941176;4862.36789217403;4862.829800956985;4920.3357546731095;4461.933071003938;4546.909061818745;4586.8165273388695;4594.264917613166;4644.930326045112;4966.155753521838;4966.850994470172;4989.476105008995;5044.142495775727;5049.141645920203;4765.880852978634;4775.71345719258;4784.880377990508;4785.353977213102;4830.8792280193275;4709.552592503706;4753.762311884461;4853.757312134379;4864.221724524059;4915.287283343895;4790.616750659939;4794.640401969867;4812.326274321597;4863.270509423614;4865.878353041202;4790.401199850019;4798.688085274516;4799.328094066834;4801.591864691471;4860.73265970375;4173.561776013536;4211.663066954637;4215.59951804578;4219.07180420307;4259.1268789897995;3655.5247817784048;3667.2298817248143;3678.4114541673202;3740.85036598533;3779.3197224499854;4199.118185181146;4199.517055538591;4208.957910420918;4220.07158425146;4258.552851950562;4810.2063159578975;4885.389326334208;4898.632602554822;4899.118158731462;4957.950420495749;4132.938005929914;4152.1280531088205;4172.979135104305;4186.623203911662;4230.894227644333;4429.224885645;4434.578715022068;4436.578525040116;4442.68901176921;4509.053098849278;4536.455625324982;4542.88642783933;4544.272916333371;4548;4601.447826260937;4676.158291507561;4770.666053376231;4775.283707443911;4853.95146048535;4888.828890988798;4540.750258735669;4555.40779698637;4564.863054108382;4571.702839315434;4626.907461850677;4781.450133234723;4788.257820037899;4791.664583479123;4812.903741925072;4814.446338671098;4774.140654682052;4777.044591081867;4806.47128815823;4828.058528586892;4835.854924352275;4756.7383793890285;4762.833300834593;4763.54746299101;4791.257355109963;4824.204006338915;4741.146593613183;4746.8101275948575;4748.477667456508;4795.808167673254;4811.711297322172;4592.219322715213;4618.9307160391945;4638.072385522976;4691.929621055619;4694.248920172756;4745.928811067905;4748.240281554935;4748.264019077049;4793.328933949319;4803.783829727601;4628.375169352229;4636.235021221461;4660.4174478190225;4664.393628828367;4717.575418212377 06:47:25 INFO - PROCESS | 23371 | |1;ext.html;534.1080395739116;563.7350445290713;574.5403677058353;581.0702875399362;586.4575267877212;28358.149255522316;38919.80540097299;40006.199876002465;40119;43463.34804977928;39710.20579588407;40134;40144.39783403251;40179.59820401795;40201.39697904534;7386.482946193769;7674.808129796744;7828.686852525892;7833.412494062968;7833.451658383916;7438.218987006368;7672.65473053714;7675.961620191892;9775.169110625606;10105.343152695052;10187.286889917708;10262.692119236435;10271.28101032928;10273.17814574836;10273.640422585211;10167.33912295702;10212.540435680337;10239.180865530778;10240.23198260126;10243.026912443305;9989.350692204984;10065.345752526062;10067.597296108146;10071.395716257048;10072.94963525185;38450.80774596137;38967.22065558673;39300.213995719925;39337.60662393368;39398;3010.1872494426384;3109.003985647691;3127.124405166557;3410.334984677989;3553.6091029986683;29440.263993400124;29681.109566713032;29972.8501357494;30748.2312942176;30799.538006929914;3440.208751987032;3553.626869178725;3570.821458927069;3597.6402359764074;3662.4140137578124;255964;256043.71978140177;256585;257155;257785;31101;32042.19894502656;53543;53798.731006344715;53878.461215387346;33695.494567581016;33837.123844473004;33917.152071197925;33955.490667640006;33955.83022084923;12573.559925402567;12662.240265584094;12670.176438531465;12674.49302027927;12678.429470673842;10259.384436933808;10333.741656458498;10345.120664743581;10350.585976561004;10396.68809935688;7236.891446628199;7543.679856025174;7838.686452541949;7924.167962363984;7953.5625540594665;3069.969300307013;3095.2416657918952;3142.5600415941785;3144.6540880503126;3182.443072462356;862.9816816156995;897.5781382750097;916.8945571259258;1014.2291858187831;1031.3657100883054;27703;28474;28749.425011499654;29011.854940725585;29029.41941161165;902.4089221559889;915.4964769376816;945.7021038372891;963.1235575626147;1030.2273295028729;14241.287935603179;15192;15217.163056032025;15473.845261547465;15539.223038848013;371895;372943;373481;373790;375611;44281.557184428384;48841;49863;50216.49783502118;54181.72909135429;1148.2995372822572;1182.739797244605;1204.349651188366;1210.6852218423273;1214.15009493355;26896.865515672296;27773.444531109668;28258.71741282643;28462.57306140451;28867.85566072156;43267.35098973455;43824;43860;43899.34150987674;43946.560534394244;310323;313123;313236.0367387222;314733;315830;25172.210391609668;25527.617085743357;25608.487830243663;25639;25646.87176564105;42296.365554516095;42345;42956.78521607372;43232;43483;35904.82047589745;35993.1001724959;36493.81753091217;36590.451143233404;36817.631823682495;36296.45555316725;36477.81761091178;36577.45133823048;36739.993507953615;37248;35064.82467587646;35453.645463545035;36258;36266.8186659065;36335.091622709646;30886.845565772925;33234.16914577155;33732.83133584316;33818.32363352768;33917.321653567284;24556.176039755657;24615.261542153763;24835.751642483345;25485.617715733908;25505.61741573915 06:47:25 INFO - PROCESS | 23371 | |2;jquery.html;356.39057212167194;367.2416460010079;377.53374582390745;379.62227583554363;389.65515518765903;12805.167664101828;15960.600984975381;16356.754648680264;17762.467125986208;17995.37016204433;17021.744673829904;17574.560635984108;17627.383041593548;17732.82267177328;17754;4848.985605351708;5010.849674509753;5047.141985862394;5050.368703912011;5053;3687.0966613179676;3871.3031654302354;5025.14572522672;5111.923321150186;5114.539691427771;3899.278633452806;3944.901377465572;5946.762129514836;5965.940340596582;6017.428344307284;5791.189233507313;6043.395660433922;6054.757809687607;6056.031035034373;6061.666608336562;5387.73061346935;5404.918926216071;5407.432219616962;5412.512873841334;5413.729313534308;20618.17527298906;21334.146634134617;21350.786492135034;21391;21502;1882.585831117152;1894.5737209127974;1932.951676208092;1937.2444746548858;2032.7662318833227;12892.80660790089;13278.66803329915;13593.456261749518;13818.101823381448;14323.212223327713;1702.8212037736107;1726.6028813372868;1779.4127937780631;1812.4834422189613;1826.5616252099533;45825.77087114577;48197.518024820005;54851.451485485035;55926.72036639832;70599.64700176517;9133.543322833964;9157.954210228907;9182.494962777111;9386.906130938603;9796.559154837907;11901.404929753478;11910;11939.58211462612;11961.162718609788;11966;6874.175098988154;6902.654867256617;7128.893066604005;7142.785716428515;7153.4992550522;6637.9668101660145;6699.866002680016;6705.731770729214;6732.596044237263;6951.82620434483;6074.51403887688;6227.501799856001;6229.127922090911;6230.532710046765;6257.530685198537;1715.7254839225664;1822.2780469326326;1823.644389344065;1854.2397616976975;1859.809721778036;841.9073901870789;845.0957475501277;845.7862966642887;851.6210286422606;860.2945584620676;17195.656086878193;18092.366767163086;18109.649714802803;18255.087245637664;18485;876.5923845411914;891.4829398948724;897.6229983406985;899.1567287061498;910.4416589383852;9781.853272200922;10013.249006324555;10138.493075346203;10180.63537240246;10255;397486;404497;411936;412049;413531;48855.755721221874;61674.999999999105;63695;65299;68203.65898170478;850.6427300533667;916.1022198245756;947.6209516193439;979.9069088436587;982.4400091947664;15132.621684457976;16001.439949601709;16635.50093497197;16660.25028873728;16918.661626767644;24859.51966724696;27653;35870.461943071394;36038.639613603526;37896;42835.571644284406;43716.34425483684;44758.32862507;45155.77422112868;45498.772506137255;7635.236476352543;7655.770326890202;7811.648475818715;7909.485883417559;8071.556064416513;11917.880821191677;12144.332061736335;12288.1398302118;12507.499700012262;13035.47858085704;10182.847257291294;10195.84706229422;10698.8930110701;10816.513256903616;11123.666290011313;10525.578976840841;10555.94722026385;11016.889831101586;11026.779464410507;11137.387443690675;10120.493975301353;10474.947625261824;10747;10802.243842930919;11297.491612877277;7753.340966017726;7788.454808163601;7974.880376794236;8056.154103819014;8081.272685458337;10399.792004159723;10501.632442864464;10541.209409294486;10778.784424311627;10953.068989135694 06:47:25 INFO - PROCESS | 23371 | |3;mootools.html;1368.6988862450264;1393.4913756478886;1460.9780853287202;1579.2182869479595;1665.8250883657215;6640.269570347258;7147.571145731246;7165.176004759448;7703.807404814883;7712.46012779105;7391.6304184790815;7505.5121417107985;7508.211637778037;7516.624168791553;7519.54882707038;2114.3551216878845;2139.294032969124;2141.2612648636195;2143.8284937204985;2144.9785502145014;1858.6004009138032;2088.749350077993;2090.1012564597218;2114.851960362775;2153.052656830997;2145.206273678741;2153.2248390579457;2158.0936006877073;2167.8807665578465;2170.913163473459;2078.2414418737203;2085.655866781979;2139.732533433321;2140;2144.0994782191515;2090.95818083639;2096.329174664108;2112.4824418017683;2114.619368513667;2118.480972161815;7672.46292759507;7700.845983080307;7720.459567830254;7724.150343462215;7727.072751269828;4341.60925516705;4468.3074123510905;4471.150481408555;4477.238869392211;4479.9552004479865;2757.806953513255;2860.6281183446017;2886.422715456917;2900.535914253709;2956.8078074925274;907.2605826251583;944.3059351376733;960.3757557587624;964.5948701545368;966.6133546581424;10044.246681498917;10063;10067;10072.94963525185;10073.647422340257;3694.519712437366;3945.447637330776;4154.709170358046;4162.271602469556;4165.10450253191;8741.082186370466;8759.781005474786;8767.298616110696;8775.824483510421;8801.163889430494;4435.2903535434825;4458.398116254264;4464.017916058462;4467.374567560544;4469.709468884512;4034.6973976951845;4076;4082.0203151243486;4082.775447350424;4083.5508094109623;3513.350030244413;3594.1374070223483;3599.8200089995394;3615.439606860941;3640.508531348287;1036.8185567525652;1093.639099097296;1165.347405452949;1166.3351889423118;1168.485866218878;783.9882401763978;797.9920200798034;799.8720204767209;809.2473999180818;811.123986095016;4764.571188592974;4806.351142595705;4896.094222568836;4957.82647607332;5099.5410413063;848.3976376772561;850.7107583421666;859.5014891362995;889.1375365895071;892.1970226795936;3353.245519758035;3386.068831071426;3390.4914262860766;3405.914852128667;3477.8608855646;8491.74524764258;8822.691205807765;8826.955865220632;8836.64653413869;8838.027816940132;8876.911230887737;8892.288616910631;8895.06601806801;8901.821963560693;8902.332325075517;6730.59616423026;6746.291639377893;6750.83122921921;6782.050512928194;6855.691493882788;4659.720416775004;4802.855914322576;4808.519148085164;4860.562549370574;4869.391326084239;8217.096119426738;8252.174782521699;8279.420440569102;8292.2951549119;8337.624806883583;8229.177082291722;8364.3726720495;8391.874121888055;8599.39804213699;8605.139486051345;6364.331745166691;6515.609063456208;6518.087467754613;6520.9347906520325;6523.543351965507;7283.490155689051;7293.890591641023;7295.124585049828;7305.525140865827;7314.4148468123485;6578.7368505261165;6714.630695311805;6716.328367163244;6733.293004234485;6765.797026089225;6613.900791488228;6624.370684784938;6643.335666433318;6673.366030227121;6712.362325579063;5806.2581225632985;5897.233359663216;5898.908701890164;5900.468957793819;5908.202392676933;4404.317330813729;4448.332750087513;4456;4534.909301814011;4604.815807367668;4603.608693261111;4641.8143274270005;4674.929876051794;4744.691595046311;4781.067691800205 06:47:25 INFO - PROCESS | 23371 | |4;prototype.html;296.6603239291012;301.49198600358386;303.8347935666718;306.7959806728526;309.0928125950335;4832.758362081895;4838.225883858575;4857.708537487753;4871.878203044926;4887.486813884544;4744.193487107192;4754.429468463789;4773.785179666923;4785.856424307268;4801.991581767824;3552.6269741677074;3704.1850792825535;3718.869839555616;3728.4780130781714;3736.1033351995598;3621.6559426854406;3778.6977041836585;3787.0532366908274;3790.753601015925;3799.4680744695765;3738.420544815558;3742.6818720408796;3751.8311675974646;3754.361758501048;3768.7173461990324;3578.3380074686265;3736.3834967230373;3751.324761542935;3755.324041672498;3763.3414152523474;3299.224682199681;3300.6369299377047;3301.4717645176656;3304.487804390323;3309.1561651778884;4696.107739529479;4700.882477938045;4707.176244157259;4720.881977950545;4721.173794585934;4249.298865687158;4252.7029256076885;4279.7218180818145;4279.7218180818145;4288.44250247469;4874.53691899269;5003.424606170301;5008.92308153745;5009.146615752158;5031.77357018935;3570.3037907608027;3577.874774382884;3583.964160358415;3584.354816133095;3588.820558972041;5216.452272511369;5260.368755749297;5261.368635763694;5261.815836445744;5262.657927234755;3469.7397695172963;3591.94612080819;3642.0530662028063;3668.2480091581697;3675.3935600626132;3684.5762737285017;3690.612485689018;3693.90765230866;3696.9445458318146;3697.4638677391627;4214.7892605370225;4221.577842215754;4221.6200541951375;4232.449781528381;4233.809478573472;4902.994726892889;5018.447970723218;5030.220315851049;5032.547070763576;5039.949600504021;1240.4913985265998;1268.4165283969294;1277.1443133100845;1279.584135156078;1282.1217466035796;785.4148659248896;803.8954935858301;820.3847114664002;823.3454403749034;830.6760363458257;4229.703920725519;4306.870793876189;4331.696781225347;4334.284843000933;4350.630196433275;5179;5187.429382767892;5205.6616319939085;5225.268462415265;5232.136697444879;4450.310201918708;4469.184413819338;4475.4181956345465;4494.910101797946;4499.6400287976885;2673.304940715428;2742.9302571996936;2769.424435275173;2773.1680495851165;2773.611694362791;4833.709977401367;4879.804807807719;4898.21628539432;4912.459629440758;4922.704637721748;5052.267421223902;5294.708791016531;5302.655327403706;5309.3894202166475;5309.628326017219;4808.543188397097;4877.609791216694;4880.389951256093;4880.682755620874;4883.780229889592;5143.202803565453;5164.715940623302;5182.352205974254;5182.8963420732125;5186.222066689876;4873.561379475864;5034.370703662043;5094.133997220407;5104.69371837691;5113.386393632639;4917.8361520930675;4930.309756634146;4940.505949405031;4947;4950.975245123751;3677.5770786359913;3682.263547290499;3693.781052252804;3695.8891233263043;3702.7963462009848;5001.549860512571;5213.322268105122;5219.164933610756;5232.26748255237;5237.397699264633;5085.160948443466;5101.668391554537;5108.208227724708;5109.8283229628005;5110.182370820651;5090.440051594395;5101.464346243591;5102.821401250939;5118.488151185001;5120.206368012964;4773.355596994361;5032.823851165192;5033.421156567042;5044.899102018013;5049.596032317332;4891.755412229445;4951.430585482572;5089.796408143781;5118.97440512795;5140.331756871583;4994.4755800640405;4996.6002719783055;5003.474635163401;5008.449070602158;5014.42334131565 06:47:25 INFO - PROCESS | 23371 | |5;yui.html;626.2641396359278;660.2605082307816;664.0835646807408;674.5177198303212;709.6806437103305;13202.53791117311;14200.573982780506;14223.57329280122;14229.644258893533;14278.143311401323;13668;13776.104553204035;13884;13939.442422303096;13947.581572552814;611.382503671293;730.2989130434762;746.1978373248766;758.1584441270186;771.0477560213133;755.395683453238;766.7814672818248;770.8766597344426;772.2123434097217;775.3642013548892;825.0594322472386;825.7275099217244;826.099551488877;826.1573195340749;826.2192228344217;650.4828661214345;758.3213024343237;784.8430313937235;800.5036877136183;812.305478815616;587.7149582452507;590.0853676800984;598.0729868703493;598.4344794169511;598.4703537369415;13508.864911350858;13517.391717372644;13530.594082177551;13592.660183495393;13619.931900340534;12451.564195253122;12840.229586224856;13144.934275328658;13287.13633613812;13581.388837502336;12154.574589889311;12308.876911230953;12366.19619724715;12428.62714118578;12551.811722824164;4099.446574712406;4119.629233368982;4138.8551400700835;4175.895602609929;4182.330827067654;66949.66525167391;67102.32897671059;67106.3289367105;67137.66431167813;67156.9999999995;10132.810126834394;10180.847287290697;10202.540885660163;10629.734256643645;10710.785784284271;19788.307409240606;19886.105125269398;19910.60178796416;19927.60144797096;19996.50008749764;6872;6969.1985421676145;7004.509684322151;7014.894776578355;7065.752698655522;3667.3582123128344;3697.6672099510633;3743.831527581265;3772.6227377262053;3802.6387493188104;2692.3403766077436;2788.721127887195;2791.762700170508;2801.0756450371737;2806.6211061506433;487.2058544572395;494.4560982918832;497.6218074263586;501.94478607353165;505.70669011972967;518.6706441409657;534.5429657642737;543.747157571731;545.4164044472456;565.9462351076642;7016.684249208696;7423.740169094056;7841.803954901173;7930.446573676172;7942.880856787153;528.8228443471403;561.1610642090102;577.2928163000375;584.141312270961;620.404411764711;3750.2184714489244;3766.39737641976;3829.5021647186245;4082.3468245080644;4147.315692910696;94790;96254;97321;98869.50565247127;99583.50208249057;79663.60168199238;82885;82970;83091;83330;44004.77997610055;52641.7367913158;69196.6540167306;70343;71741;8134.267915887599;8241.423100382915;8430.241278284984;8470.280026197843;8766.693165739169;39717;43236.13527729491;44028;44160.33759493546;45896.54103458922;40239;46490.53509464862;60085;61896;61924;11708.590199342982;11757.353345566076;11828.17202795796;11894.524219031488;12027;12122;12780;12921.095523313277;13006.739865202831;13206.471741130246;11278.379689117177;11467.254628449124;12002.099842512021;12582.370881456074;12857.485700571873;11139.220254582102;11554.537818487166;11916.880831191924;12139.696507587381;12375.566855160027;11633.59282425111;12011;12014.399280036137;12239.816402753788;12283;9150.862737059082;9596;9715.611375544899;9843.901560984299;9913.256505761952;8465;8621.913780862362;8643.91356086431;9076.909230907871;9599.232061434928 06:47:25 INFO - PROCESS | 23371 | __end_tp_report 06:47:25 INFO - PROCESS | 23371 | __start_cc_report 06:47:25 INFO - PROCESS | 23371 | _x_x_mozilla_cycle_collect,923 06:47:25 INFO - PROCESS | 23371 | __end_cc_report 06:47:25 INFO - PROCESS | 23371 | __startTimestamp1472132845242__endTimestamp 06:47:25 INFO - PROCESS | 23371 | 06:47:25 INFO - PROCESS | 23371 | ------- Summary: start ------- 06:47:25 INFO - PROCESS | 23371 | Number of tests: 6 06:47:25 INFO - PROCESS | 23371 | 06:47:25 INFO - PROCESS | 23371 | [#0] dojo.html Cycles:165 Average:4507.56 Median:4601.45 stddev:450.78 (9.8%) stddev-sans-first:425.06 06:47:25 INFO - PROCESS | 23371 | Values: 2545.1 2548.9 2560.6 2576.0 2585.9 4412.1 4516.2 4537.2 4577.5 4577.7 4526.9 4532.3 4587.7 4588.4 4600.4 4148.5 4184.2 4214.0 4274.8 4360.2 4303.8 4314.8 4315.1 4342.6 4366.6 4172.4 4216.7 4244.3 4290.3 4297.7 4118.0 4152.3 4175.6 4189.8 4217.7 4148.6 4209.4 4219.7 4222.4 4279.8 4494.1 4550.3 4558.5 4596.6 4668.9 4822.5 4825.5 4829.7 4859.5 4877.1 4849.0 4852.9 4862.4 4862.8 4920.3 4461.9 4546.9 4586.8 4594.3 4644.9 4966.2 4966.9 4989.5 5044.1 5049.1 4765.9 4775.7 4784.9 4785.4 4830.9 4709.6 4753.8 4853.8 4864.2 4915.3 4790.6 4794.6 4812.3 4863.3 4865.9 4790.4 4798.7 4799.3 4801.6 4860.7 4173.6 4211.7 4215.6 4219.1 4259.1 3655.5 3667.2 3678.4 3740.9 3779.3 4199.1 4199.5 4209.0 4220.1 4258.6 4810.2 4885.4 4898.6 4899.1 4958.0 4132.9 4152.1 4173.0 4186.6 4230.9 4429.2 4434.6 4436.6 4442.7 4509.1 4536.5 4542.9 4544.3 4548.0 4601.4 4676.2 4770.7 4775.3 4854.0 4888.8 4540.8 4555.4 4564.9 4571.7 4626.9 4781.5 4788.3 4791.7 4812.9 4814.4 4774.1 4777.0 4806.5 4828.1 4835.9 4756.7 4762.8 4763.5 4791.3 4824.2 4741.1 4746.8 4748.5 4795.8 4811.7 4592.2 4618.9 4638.1 4691.9 4694.2 4745.9 4748.2 4748.3 4793.3 4803.8 4628.4 4636.2 4660.4 4664.4 4717.6 06:47:25 INFO - PROCESS | 23371 | 06:47:25 INFO - PROCESS | 23371 | [#1] ext.html Cycles:180 Average:46149.40 Median:33917.24 stddev:83733.22 (246.9%) stddev-sans-first:83898.07 06:47:25 INFO - PROCESS | 23371 | Values: 534.1 563.7 574.5 581.1 586.5 28358.1 38919.8 40006.2 40119.0 43463.3 39710.2 40134.0 40144.4 40179.6 40201.4 7386.5 7674.8 7828.7 7833.4 7833.5 7438.2 7672.7 7676.0 9775.2 10105.3 10187.3 10262.7 10271.3 10273.2 10273.6 10167.3 10212.5 10239.2 10240.2 10243.0 9989.4 10065.3 10067.6 10071.4 10072.9 38450.8 38967.2 39300.2 39337.6 39398.0 3010.2 3109.0 3127.1 3410.3 3553.6 29440.3 29681.1 29972.9 30748.2 30799.5 3440.2 3553.6 3570.8 3597.6 3662.4 255964.0 256043.7 256585.0 257155.0 257785.0 31101.0 32042.2 53543.0 53798.7 53878.5 33695.5 33837.1 33917.2 33955.5 33955.8 12573.6 12662.2 12670.2 12674.5 12678.4 10259.4 10333.7 10345.1 10350.6 10396.7 7236.9 7543.7 7838.7 7924.2 7953.6 3070.0 3095.2 3142.6 3144.7 3182.4 863.0 897.6 916.9 1014.2 1031.4 27703.0 28474.0 28749.4 29011.9 29029.4 902.4 915.5 945.7 963.1 1030.2 14241.3 15192.0 15217.2 15473.8 15539.2 371895.0 372943.0 373481.0 373790.0 375611.0 44281.6 48841.0 49863.0 50216.5 54181.7 1148.3 1182.7 1204.3 1210.7 1214.2 26896.9 27773.4 28258.7 28462.6 28867.9 43267.4 43824.0 43860.0 43899.3 43946.6 310323.0 313123.0 313236.0 314733.0 315830.0 25172.2 25527.6 25608.5 25639.0 25646.9 42296.4 42345.0 42956.8 43232.0 43483.0 35904.8 35993.1 36493.8 36590.5 36817.6 36296.5 36477.8 36577.5 36740.0 37248.0 35064.8 35453.6 36258.0 36266.8 36335.1 30886.8 33234.2 33732.8 33818.3 33917.3 24556.2 24615.3 24835.8 25485.6 25505.6 06:47:25 INFO - PROCESS | 23371 | 06:47:25 INFO - PROCESS | 23371 | [#2] jquery.html Cycles:180 Average:23920.95 Median:2144.47 stddev:66635.97 (3107.3%) stddev-sans-first:66799.42 06:47:25 INFO - PROCESS | 23371 | Values: 356.4 367.2 377.5 379.6 389.7 12805.2 15960.6 16356.8 17762.5 17995.4 17021.7 17574.6 17627.4 17732.8 17754.0 4849.0 5010.8 5047.1 5050.4 5053.0 3687.1 3871.3 5025.1 5111.9 5114.5 3899.3 3944.9 5946.8 5965.9 6017.4 5791.2 6043.4 6054.8 6056.0 6061.7 5387.7 5404.9 5407.4 5412.5 5413.7 20618.2 21334.1 21350.8 21391.0 21502.0 1882.6 1894.6 1933.0 1937.2 2032.8 12892.8 13278.7 13593.5 13818.1 14323.2 1702.8 1726.6 1779.4 1812.5 1826.6 45825.8 48197.5 54851.5 55926.7 70599.6 9133.5 9158.0 9182.5 9386.9 9796.6 11901.4 11910.0 11939.6 11961.2 11966.0 6874.2 6902.7 7128.9 7142.8 7153.5 6638.0 6699.9 6705.7 6732.6 6951.8 6074.5 6227.5 6229.1 6230.5 6257.5 1715.7 1822.3 1823.6 1854.2 1859.8 841.9 845.1 845.8 851.6 860.3 17195.7 18092.4 18109.6 18255.1 18485.0 876.6 891.5 897.6 899.2 910.4 9781.9 10013.2 10138.5 10180.6 10255.0 397486.0 404497.0 411936.0 412049.0 413531.0 48855.8 61675.0 63695.0 65299.0 68203.7 850.6 916.1 947.6 979.9 982.4 15132.6 16001.4 16635.5 16660.3 16918.7 24859.5 27653.0 35870.5 36038.6 37896.0 42835.6 43716.3 44758.3 45155.8 45498.8 7635.2 7655.8 7811.6 7909.5 8071.6 11917.9 12144.3 12288.1 12507.5 13035.5 10182.8 10195.8 10698.9 10816.5 11123.7 10525.6 10555.9 11016.9 11026.8 11137.4 10120.5 10474.9 10747.0 10802.2 11297.5 7753.3 7788.5 7974.9 8056.2 8081.3 10399.8 10501.6 10541.2 10778.8 10953.1 06:47:25 INFO - PROCESS | 23371 | 06:47:25 INFO - PROCESS | 23371 | [#3] mootools.html Cycles:180 Average:4917.92 Median:4864.98 stddev:2692.02 (55.3%) stddev-sans-first:2686.36 06:47:25 INFO - PROCESS | 23371 | Values: 1368.7 1393.5 1461.0 1579.2 1665.8 6640.3 7147.6 7165.2 7703.8 7712.5 7391.6 7505.5 7508.2 7516.6 7519.5 2114.4 2139.3 2141.3 2143.8 2145.0 1858.6 2088.7 2090.1 2114.9 2153.1 2145.2 2153.2 2158.1 2167.9 2170.9 2078.2 2085.7 2139.7 2140.0 2144.1 2091.0 2096.3 2112.5 2114.6 2118.5 7672.5 7700.8 7720.5 7724.2 7727.1 4341.6 4468.3 4471.2 4477.2 4480.0 2757.8 2860.6 2886.4 2900.5 2956.8 907.3 944.3 960.4 964.6 966.6 10044.2 10063.0 10067.0 10072.9 10073.6 3694.5 3945.4 4154.7 4162.3 4165.1 8741.1 8759.8 8767.3 8775.8 8801.2 4435.3 4458.4 4464.0 4467.4 4469.7 4034.7 4076.0 4082.0 4082.8 4083.6 3513.4 3594.1 3599.8 3615.4 3640.5 1036.8 1093.6 1165.3 1166.3 1168.5 784.0 798.0 799.9 809.2 811.1 4764.6 4806.4 4896.1 4957.8 5099.5 848.4 850.7 859.5 889.1 892.2 3353.2 3386.1 3390.5 3405.9 3477.9 8491.7 8822.7 8827.0 8836.6 8838.0 8876.9 8892.3 8895.1 8901.8 8902.3 6730.6 6746.3 6750.8 6782.1 6855.7 4659.7 4802.9 4808.5 4860.6 4869.4 8217.1 8252.2 8279.4 8292.3 8337.6 8229.2 8364.4 8391.9 8599.4 8605.1 6364.3 6515.6 6518.1 6520.9 6523.5 7283.5 7293.9 7295.1 7305.5 7314.4 6578.7 6714.6 6716.3 6733.3 6765.8 6613.9 6624.4 6643.3 6673.4 6712.4 5806.3 5897.2 5898.9 5900.5 5908.2 4404.3 4448.3 4456.0 4534.9 4604.8 4603.6 4641.8 4674.9 4744.7 4781.1 06:47:25 INFO - PROCESS | 23371 | 06:47:25 INFO - PROCESS | 23371 | [#4] prototype.html Cycles:180 Average:4182.60 Median:4805.27 stddev:1224.41 (25.5%) stddev-sans-first:1192.60 06:47:25 INFO - PROCESS | 23371 | Values: 296.7 301.5 303.8 306.8 309.1 4832.8 4838.2 4857.7 4871.9 4887.5 4744.2 4754.4 4773.8 4785.9 4802.0 3552.6 3704.2 3718.9 3728.5 3736.1 3621.7 3778.7 3787.1 3790.8 3799.5 3738.4 3742.7 3751.8 3754.4 3768.7 3578.3 3736.4 3751.3 3755.3 3763.3 3299.2 3300.6 3301.5 3304.5 3309.2 4696.1 4700.9 4707.2 4720.9 4721.2 4249.3 4252.7 4279.7 4279.7 4288.4 4874.5 5003.4 5008.9 5009.1 5031.8 3570.3 3577.9 3584.0 3584.4 3588.8 5216.5 5260.4 5261.4 5261.8 5262.7 3469.7 3591.9 3642.1 3668.2 3675.4 3684.6 3690.6 3693.9 3696.9 3697.5 4214.8 4221.6 4221.6 4232.4 4233.8 4903.0 5018.4 5030.2 5032.5 5039.9 1240.5 1268.4 1277.1 1279.6 1282.1 785.4 803.9 820.4 823.3 830.7 4229.7 4306.9 4331.7 4334.3 4350.6 5179.0 5187.4 5205.7 5225.3 5232.1 4450.3 4469.2 4475.4 4494.9 4499.6 2673.3 2742.9 2769.4 2773.2 2773.6 4833.7 4879.8 4898.2 4912.5 4922.7 5052.3 5294.7 5302.7 5309.4 5309.6 4808.5 4877.6 4880.4 4880.7 4883.8 5143.2 5164.7 5182.4 5182.9 5186.2 4873.6 5034.4 5094.1 5104.7 5113.4 4917.8 4930.3 4940.5 4947.0 4951.0 3677.6 3682.3 3693.8 3695.9 3702.8 5001.5 5213.3 5219.2 5232.3 5237.4 5085.2 5101.7 5108.2 5109.8 5110.2 5090.4 5101.5 5102.8 5118.5 5120.2 4773.4 5032.8 5033.4 5044.9 5049.6 4891.8 4951.4 5089.8 5119.0 5140.3 4994.5 4996.6 5003.5 5008.4 5014.4 06:47:25 INFO - PROCESS | 23371 | 06:47:25 INFO - PROCESS | 23371 | [#5] yui.html Cycles:180 Average:17380.74 Median:499.78 stddev:24368.31 (4875.8%) stddev-sans-first:24404.19 06:47:25 INFO - PROCESS | 23371 | Values: 626.3 660.3 664.1 674.5 709.7 13202.5 14200.6 14223.6 14229.6 14278.1 13668.0 13776.1 13884.0 13939.4 13947.6 611.4 730.3 746.2 758.2 771.0 755.4 766.8 770.9 772.2 775.4 825.1 825.7 826.1 826.2 826.2 650.5 758.3 784.8 800.5 812.3 587.7 590.1 598.1 598.4 598.5 13508.9 13517.4 13530.6 13592.7 13619.9 12451.6 12840.2 13144.9 13287.1 13581.4 12154.6 12308.9 12366.2 12428.6 12551.8 4099.4 4119.6 4138.9 4175.9 4182.3 66949.7 67102.3 67106.3 67137.7 67157.0 10132.8 10180.8 10202.5 10629.7 10710.8 19788.3 19886.1 19910.6 19927.6 19996.5 6872.0 6969.2 7004.5 7014.9 7065.8 3667.4 3697.7 3743.8 3772.6 3802.6 2692.3 2788.7 2791.8 2801.1 2806.6 487.2 494.5 497.6 501.9 505.7 518.7 534.5 543.7 545.4 565.9 7016.7 7423.7 7841.8 7930.4 7942.9 528.8 561.2 577.3 584.1 620.4 3750.2 3766.4 3829.5 4082.3 4147.3 94790.0 96254.0 97321.0 98869.5 99583.5 79663.6 82885.0 82970.0 83091.0 83330.0 44004.8 52641.7 69196.7 70343.0 71741.0 8134.3 8241.4 8430.2 8470.3 8766.7 39717.0 43236.1 44028.0 44160.3 45896.5 40239.0 46490.5 60085.0 61896.0 61924.0 11708.6 11757.4 11828.2 11894.5 12027.0 12122.0 12780.0 12921.1 13006.7 13206.5 11278.4 11467.3 12002.1 12582.4 12857.5 11139.2 11554.5 11916.9 12139.7 12375.6 11633.6 12011.0 12014.4 12239.8 12283.0 9150.9 9596.0 9715.6 9843.9 9913.3 8465.0 8621.9 8643.9 9076.9 9599.2 06:47:25 INFO - PROCESS | 23371 | -------- Summary: end -------- 06:47:25 INFO - PROCESS | 23371 | 06:47:26 INFO - TEST-INFO | 23371: exit 0 06:47:26 INFO - TEST-OK | dromaeo_css | took 1120001ms 06:47:26 INFO - TEST-START | kraken 06:47:26 INFO - operating with platform_type : linux_ 06:47:26 INFO - Initialising browser for kraken test... 06:47:26 INFO - TEST-INFO | started process 23676 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg7wRp0/profile http://localhost:60090/getInfo.html) 06:47:30 INFO - PROCESS | 23676 | __metrics Screen width/height:1600/1200 06:47:30 INFO - PROCESS | 23676 | colorDepth:24 06:47:30 INFO - PROCESS | 23676 | Browser inner width/height: 1024/697 06:47:30 INFO - PROCESS | 23676 | __metrics 06:47:31 INFO - PROCESS | 23676 | 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" 06:47:31 INFO - PROCESS | 23676 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:47:31 INFO - PROCESS | 23676 | console.error: PushService: 06:47:31 INFO - PROCESS | 23676 | stateChangeProcessEnqueue: Error transitioning state 06:47:31 INFO - PROCESS | 23676 | UnknownError 06:47:32 INFO - TEST-INFO | 23676: exit 0 06:47:32 INFO - Browser initialized. 06:47:32 INFO - Running cycle 1/1 for kraken test... 06:47:32 INFO - TEST-INFO | started process 23754 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg7wRp0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:47:44 INFO - PROCESS | 23754 | RSS: Main: 181874688 06:47:44 INFO - PROCESS | 23754 | 06:47:47 INFO - PROCESS | 23754 | Cycle 1(1): loaded http://localhost:60090/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60090/tests/kraken/driver.html?testName=audio-beat-detection) 06:47:48 INFO - PROCESS | 23754 | RSS: Main: 234835968 06:47:48 INFO - PROCESS | 23754 | 06:47:50 INFO - PROCESS | 23754 | Cycle 1(1): loaded http://localhost:60090/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60090/tests/kraken/driver.html?testName=audio-dft) 06:47:51 INFO - PROCESS | 23754 | RSS: Main: 225935360 06:47:51 INFO - PROCESS | 23754 | 06:47:54 INFO - PROCESS | 23754 | Cycle 1(1): loaded http://localhost:60090/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60090/tests/kraken/driver.html?testName=audio-fft) 06:47:55 INFO - PROCESS | 23754 | RSS: Main: 303271936 06:47:55 INFO - PROCESS | 23754 | 06:47:57 INFO - PROCESS | 23754 | Cycle 1(1): loaded http://localhost:60090/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60090/tests/kraken/driver.html?testName=audio-oscillator) 06:47:58 INFO - PROCESS | 23754 | RSS: Main: 213651456 06:47:58 INFO - PROCESS | 23754 | 06:48:00 INFO - PROCESS | 23754 | Cycle 1(1): loaded http://localhost:60090/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60090/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:48:01 INFO - PROCESS | 23754 | RSS: Main: 215670784 06:48:01 INFO - PROCESS | 23754 | 06:48:04 INFO - PROCESS | 23754 | Cycle 1(1): loaded http://localhost:60090/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60090/tests/kraken/driver.html?testName=imaging-darkroom) 06:48:04 INFO - PROCESS | 23754 | RSS: Main: 253726720 06:48:04 INFO - PROCESS | 23754 | 06:48:08 INFO - PROCESS | 23754 | Cycle 1(1): loaded http://localhost:60090/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60090/tests/kraken/driver.html?testName=imaging-desaturate) 06:48:08 INFO - PROCESS | 23754 | RSS: Main: 247631872 06:48:08 INFO - PROCESS | 23754 | 06:48:11 INFO - PROCESS | 23754 | Cycle 1(1): loaded http://localhost:60090/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60090/tests/kraken/driver.html?testName=json-parse-financial) 06:48:12 INFO - PROCESS | 23754 | RSS: Main: 251142144 06:48:12 INFO - PROCESS | 23754 | 06:48:14 INFO - PROCESS | 23754 | Cycle 1(1): loaded http://localhost:60090/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60090/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:48:14 INFO - PROCESS | 23754 | RSS: Main: 214867968 06:48:14 INFO - PROCESS | 23754 | 06:48:16 INFO - PROCESS | 23754 | Cycle 1(1): loaded http://localhost:60090/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60090/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:48:17 INFO - PROCESS | 23754 | RSS: Main: 222117888 06:48:17 INFO - PROCESS | 23754 | 06:48:19 INFO - PROCESS | 23754 | Cycle 1(1): loaded http://localhost:60090/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60090/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:48:20 INFO - PROCESS | 23754 | RSS: Main: 223277056 06:48:20 INFO - PROCESS | 23754 | 06:48:23 INFO - PROCESS | 23754 | Cycle 1(1): loaded http://localhost:60090/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60090/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:48:23 INFO - PROCESS | 23754 | RSS: Main: 219250688 06:48:23 INFO - PROCESS | 23754 | 06:48:26 INFO - PROCESS | 23754 | Cycle 1(1): loaded http://localhost:60090/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60090/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:48:27 INFO - PROCESS | 23754 | RSS: Main: 221204480 06:48:27 INFO - PROCESS | 23754 | 06:48:29 INFO - PROCESS | 23754 | Cycle 1(1): loaded http://localhost:60090/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60090/tests/kraken/driver.html?testName=ai-astar) 06:48:29 INFO - PROCESS | 23754 | RSS: Main: 272592896 06:48:29 INFO - PROCESS | 23754 | 06:48:29 INFO - PROCESS | 23754 | __start_tp_report 06:48:29 INFO - PROCESS | 23754 | _x_x_mozilla_page_load 06:48:29 INFO - PROCESS | 23754 | _x_x_mozilla_page_load_details 06:48:29 INFO - PROCESS | 23754 | |i|pagename|runs| 06:48:29 INFO - PROCESS | 23754 | |0;ai-astar;114;114;128;114;114;114;112;112;113;113 06:48:29 INFO - PROCESS | 23754 | |1;audio-beat-detection;157;125;150;180;123;147;159;124;193;127 06:48:29 INFO - PROCESS | 23754 | |2;audio-dft;162;162;161;161;161;162;161;162;162;159 06:48:29 INFO - PROCESS | 23754 | |3;audio-fft;75;76;76;164;77;78;76;75;174;75 06:48:29 INFO - PROCESS | 23754 | |4;audio-oscillator;86;86;161;86;87;87;140;88;87;135 06:48:29 INFO - PROCESS | 23754 | |5;imaging-gaussian-blur;118;118;118;117;118;118;118;120;118;116 06:48:29 INFO - PROCESS | 23754 | |6;imaging-darkroom;146;146;146;146;147;146;147;146;146;146 06:48:29 INFO - PROCESS | 23754 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;94;95 06:48:29 INFO - PROCESS | 23754 | |8;json-parse-financial;65;66;67;68;66;66;66;65;65;65 06:48:29 INFO - PROCESS | 23754 | |9;json-stringify-tinderbox;65;65;65;66;66;66;66;65;66;66 06:48:29 INFO - PROCESS | 23754 | |10;stanford-crypto-aes;86;84;82;81;86;90;81;83;82;83 06:48:29 INFO - PROCESS | 23754 | |11;stanford-crypto-ccm;136;131;138;140;139;139;133;130;146;134 06:48:29 INFO - PROCESS | 23754 | |12;stanford-crypto-pbkdf2;176;174;175;174;173;172;171;171;178;173 06:48:29 INFO - PROCESS | 23754 | |13;stanford-crypto-sha256-iterative;71;68;69;68;68;67;67;67;67;68 06:48:29 INFO - PROCESS | 23754 | __end_tp_report 06:48:29 INFO - PROCESS | 23754 | __start_cc_report 06:48:29 INFO - PROCESS | 23754 | _x_x_mozilla_cycle_collect,1995 06:48:29 INFO - PROCESS | 23754 | __end_cc_report 06:48:29 INFO - PROCESS | 23754 | __startTimestamp1472132909336__endTimestamp 06:48:29 INFO - PROCESS | 23754 | 06:48:29 INFO - PROCESS | 23754 | ------- Summary: start ------- 06:48:29 INFO - PROCESS | 23754 | Number of tests: 14 06:48:29 INFO - PROCESS | 23754 | 06:48:29 INFO - PROCESS | 23754 | [#0] ai-astar Cycles:10 Average:114.80 Median:114.00 stddev:4.71 (4.1%) stddev-sans-first:4.99 06:48:29 INFO - PROCESS | 23754 | Values: 114.0 114.0 128.0 114.0 114.0 114.0 112.0 112.0 113.0 113.0 06:48:29 INFO - PROCESS | 23754 | 06:48:29 INFO - PROCESS | 23754 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:153.50 stddev:24.55 (16.0%) stddev-sans-first:25.85 06:48:29 INFO - PROCESS | 23754 | Values: 157.0 125.0 150.0 180.0 123.0 147.0 159.0 124.0 193.0 127.0 06:48:29 INFO - PROCESS | 23754 | 06:48:29 INFO - PROCESS | 23754 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 06:48:29 INFO - PROCESS | 23754 | Values: 162.0 162.0 161.0 161.0 161.0 162.0 161.0 162.0 162.0 159.0 06:48:29 INFO - PROCESS | 23754 | 06:48:29 INFO - PROCESS | 23754 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:39.29 (51.7%) stddev-sans-first:41.03 06:48:29 INFO - PROCESS | 23754 | Values: 75.0 76.0 76.0 164.0 77.0 78.0 76.0 75.0 174.0 75.0 06:48:29 INFO - PROCESS | 23754 | 06:48:29 INFO - PROCESS | 23754 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:86.50 stddev:29.06 (33.6%) stddev-sans-first:30.06 06:48:29 INFO - PROCESS | 23754 | Values: 86.0 86.0 161.0 86.0 87.0 87.0 140.0 88.0 87.0 135.0 06:48:29 INFO - PROCESS | 23754 | 06:48:29 INFO - PROCESS | 23754 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.99 (0.8%) stddev-sans-first:1.05 06:48:29 INFO - PROCESS | 23754 | Values: 118.0 118.0 118.0 117.0 118.0 118.0 118.0 120.0 118.0 116.0 06:48:29 INFO - PROCESS | 23754 | 06:48:29 INFO - PROCESS | 23754 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 06:48:29 INFO - PROCESS | 23754 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 06:48:29 INFO - PROCESS | 23754 | 06:48:29 INFO - PROCESS | 23754 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:48:29 INFO - PROCESS | 23754 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 06:48:29 INFO - PROCESS | 23754 | 06:48:29 INFO - PROCESS | 23754 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:66.00 stddev:0.99 (1.5%) stddev-sans-first:1.00 06:48:29 INFO - PROCESS | 23754 | Values: 65.0 66.0 67.0 68.0 66.0 66.0 66.0 65.0 65.0 65.0 06:48:29 INFO - PROCESS | 23754 | 06:48:29 INFO - PROCESS | 23754 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 06:48:29 INFO - PROCESS | 23754 | Values: 65.0 65.0 65.0 66.0 66.0 66.0 66.0 65.0 66.0 66.0 06:48:29 INFO - PROCESS | 23754 | 06:48:29 INFO - PROCESS | 23754 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.50 stddev:2.82 (3.4%) stddev-sans-first:2.88 06:48:29 INFO - PROCESS | 23754 | Values: 86.0 84.0 82.0 81.0 86.0 90.0 81.0 83.0 82.0 83.0 06:48:29 INFO - PROCESS | 23754 | 06:48:29 INFO - PROCESS | 23754 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:138.50 stddev:4.81 (3.5%) stddev-sans-first:5.10 06:48:29 INFO - PROCESS | 23754 | Values: 136.0 131.0 138.0 140.0 139.0 139.0 133.0 130.0 146.0 134.0 06:48:29 INFO - PROCESS | 23754 | 06:48:29 INFO - PROCESS | 23754 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:174.00 stddev:2.21 (1.3%) stddev-sans-first:2.19 06:48:29 INFO - PROCESS | 23754 | Values: 176.0 174.0 175.0 174.0 173.0 172.0 171.0 171.0 178.0 173.0 06:48:29 INFO - PROCESS | 23754 | 06:48:29 INFO - PROCESS | 23754 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:1.25 (1.8%) stddev-sans-first:0.71 06:48:29 INFO - PROCESS | 23754 | Values: 71.0 68.0 69.0 68.0 68.0 67.0 67.0 67.0 67.0 68.0 06:48:29 INFO - PROCESS | 23754 | -------- Summary: end -------- 06:48:29 INFO - PROCESS | 23754 | 06:48:30 INFO - TEST-INFO | 23754: exit 0 06:48:30 INFO - TEST-OK | kraken | took 64450ms 06:48:30 INFO - SUITE-END | took 1184s 06:48:30 INFO - Completed test suite (00:19:44) 06:48:30 INFO - javascript benchmark 06:48:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2545.10921177588, 2548.9107881224154, 2560.60310651849, 2575.9999999999995, 2585.9353516162096, 4412.073464572436, 4516.23224051912, 4537.2286711259085, 4577.542245775421, 4577.656675749316, 4526.886827829306, 4532.320151977205, 4587.678862479619, 4588.403507544023, 4600.378948841905, 4148.522919864224, 4184.246835569596, 4213.978930105345, 4274.829006839723, 4360.193364227628, 4303.7848107594655, 4314.784260786963, 4315.115401342733, 4342.630876375511, 4366.585174408426, 4172.395002724618, 4216.683748718859, 4244.278472659656, 4290.313549832027, 4297.72064815786, 4117.97941010293, 4152.294110001307, 4175.582441755831, 4189.832406703728, 4217.662586993064, 4148.605882441163, 4209.410682504452, 4219.746815191098, 4222.366645003274, 4279.828806847722, 4494.07871386365, 4550.317452382136, 4558.452985641744, 4596.632269418438, 4668.883277918046, 4822.493638167977, 4825.541573550507, 4829.734364609945, 4859.465458799529, 4877.097736918681, 4848.951510484885, 4852.902941941176, 4862.36789217403, 4862.829800956985, 4920.3357546731095, 4461.933071003938, 4546.909061818745, 4586.8165273388695, 4594.264917613166, 4644.930326045112, 4966.155753521838, 4966.850994470172, 4989.476105008995, 5044.142495775727, 5049.141645920203, 4765.880852978634, 4775.71345719258, 4784.880377990508, 4785.353977213102, 4830.8792280193275, 4709.552592503706, 4753.762311884461, 4853.757312134379, 4864.221724524059, 4915.287283343895, 4790.616750659939, 4794.640401969867, 4812.326274321597, 4863.270509423614, 4865.878353041202, 4790.401199850019, 4798.688085274516, 4799.328094066834, 4801.591864691471, 4860.73265970375, 4173.561776013536, 4211.663066954637, 4215.59951804578, 4219.07180420307, 4259.1268789897995, 3655.5247817784048, 3667.2298817248143, 3678.4114541673202, 3740.85036598533, 3779.3197224499854, 4199.118185181146, 4199.517055538591, 4208.957910420918, 4220.07158425146, 4258.552851950562, 4810.2063159578975, 4885.389326334208, 4898.632602554822, 4899.118158731462, 4957.950420495749, 4132.938005929914, 4152.1280531088205, 4172.979135104305, 4186.623203911662, 4230.894227644333, 4429.224885645, 4434.578715022068, 4436.578525040116, 4442.68901176921, 4509.053098849278, 4536.455625324982, 4542.88642783933, 4544.272916333371, 4548.0, 4601.447826260937, 4676.158291507561, 4770.666053376231, 4775.283707443911, 4853.95146048535, 4888.828890988798, 4540.750258735669, 4555.40779698637, 4564.863054108382, 4571.702839315434, 4626.907461850677, 4781.450133234723, 4788.257820037899, 4791.664583479123, 4812.903741925072, 4814.446338671098, 4774.140654682052, 4777.044591081867, 4806.47128815823, 4828.058528586892, 4835.854924352275, 4756.7383793890285, 4762.833300834593, 4763.54746299101, 4791.257355109963, 4824.204006338915, 4741.146593613183, 4746.8101275948575, 4748.477667456508, 4795.808167673254, 4811.711297322172, 4592.219322715213, 4618.9307160391945, 4638.072385522976, 4691.929621055619, 4694.248920172756, 4745.928811067905, 4748.240281554935, 4748.264019077049, 4793.328933949319, 4803.783829727601, 4628.375169352229, 4636.235021221461, 4660.4174478190225, 4664.393628828367, 4717.575418212377], "value": 4479.79689262824, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.1080395739116, 563.7350445290713, 574.5403677058353, 581.0702875399362, 586.4575267877212, 28358.149255522316, 38919.80540097299, 40006.199876002465, 40119.0, 43463.34804977928, 39710.20579588407, 40134.0, 40144.39783403251, 40179.59820401795, 40201.39697904534, 7386.482946193769, 7674.808129796744, 7828.686852525892, 7833.412494062968, 7833.451658383916, 7438.218987006368, 7672.65473053714, 7675.961620191892, 9775.169110625606, 10105.343152695052, 10187.286889917708, 10262.692119236435, 10271.28101032928, 10273.17814574836, 10273.640422585211, 10167.33912295702, 10212.540435680337, 10239.180865530778, 10240.23198260126, 10243.026912443305, 9989.350692204984, 10065.345752526062, 10067.597296108146, 10071.395716257048, 10072.94963525185, 38450.80774596137, 38967.22065558673, 39300.213995719925, 39337.60662393368, 39398.0, 3010.1872494426384, 3109.003985647691, 3127.124405166557, 3410.334984677989, 3553.6091029986683, 29440.263993400124, 29681.109566713032, 29972.8501357494, 30748.2312942176, 30799.538006929914, 3440.208751987032, 3553.626869178725, 3570.821458927069, 3597.6402359764074, 3662.4140137578124, 255964.0, 256043.71978140177, 256585.0, 257155.0, 257785.0, 31101.0, 32042.19894502656, 53543.0, 53798.731006344715, 53878.461215387346, 33695.494567581016, 33837.123844473004, 33917.152071197925, 33955.490667640006, 33955.83022084923, 12573.559925402567, 12662.240265584094, 12670.176438531465, 12674.49302027927, 12678.429470673842, 10259.384436933808, 10333.741656458498, 10345.120664743581, 10350.585976561004, 10396.68809935688, 7236.891446628199, 7543.679856025174, 7838.686452541949, 7924.167962363984, 7953.5625540594665, 3069.969300307013, 3095.2416657918952, 3142.5600415941785, 3144.6540880503126, 3182.443072462356, 862.9816816156995, 897.5781382750097, 916.8945571259258, 1014.2291858187831, 1031.3657100883054, 27703.0, 28474.0, 28749.425011499654, 29011.854940725585, 29029.41941161165, 902.4089221559889, 915.4964769376816, 945.7021038372891, 963.1235575626147, 1030.2273295028729, 14241.287935603179, 15192.0, 15217.163056032025, 15473.845261547465, 15539.223038848013, 371895.0, 372943.0, 373481.0, 373790.0, 375611.0, 44281.557184428384, 48841.0, 49863.0, 50216.49783502118, 54181.72909135429, 1148.2995372822572, 1182.739797244605, 1204.349651188366, 1210.6852218423273, 1214.15009493355, 26896.865515672296, 27773.444531109668, 28258.71741282643, 28462.57306140451, 28867.85566072156, 43267.35098973455, 43824.0, 43860.0, 43899.34150987674, 43946.560534394244, 310323.0, 313123.0, 313236.0367387222, 314733.0, 315830.0, 25172.210391609668, 25527.617085743357, 25608.487830243663, 25639.0, 25646.87176564105, 42296.365554516095, 42345.0, 42956.78521607372, 43232.0, 43483.0, 35904.82047589745, 35993.1001724959, 36493.81753091217, 36590.451143233404, 36817.631823682495, 36296.45555316725, 36477.81761091178, 36577.45133823048, 36739.993507953615, 37248.0, 35064.82467587646, 35453.645463545035, 36258.0, 36266.8186659065, 36335.091622709646, 30886.845565772925, 33234.16914577155, 33732.83133584316, 33818.32363352768, 33917.321653567284, 24556.176039755657, 24615.261542153763, 24835.751642483345, 25485.617715733908, 25505.61741573915], "value": 16852.58227174854, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.39057212167194, 367.2416460010079, 377.53374582390745, 379.62227583554363, 389.65515518765903, 12805.167664101828, 15960.600984975381, 16356.754648680264, 17762.467125986208, 17995.37016204433, 17021.744673829904, 17574.560635984108, 17627.383041593548, 17732.82267177328, 17754.0, 4848.985605351708, 5010.849674509753, 5047.141985862394, 5050.368703912011, 5053.0, 3687.0966613179676, 3871.3031654302354, 5025.14572522672, 5111.923321150186, 5114.539691427771, 3899.278633452806, 3944.901377465572, 5946.762129514836, 5965.940340596582, 6017.428344307284, 5791.189233507313, 6043.395660433922, 6054.757809687607, 6056.031035034373, 6061.666608336562, 5387.73061346935, 5404.918926216071, 5407.432219616962, 5412.512873841334, 5413.729313534308, 20618.17527298906, 21334.146634134617, 21350.786492135034, 21391.0, 21502.0, 1882.585831117152, 1894.5737209127974, 1932.951676208092, 1937.2444746548858, 2032.7662318833227, 12892.80660790089, 13278.66803329915, 13593.456261749518, 13818.101823381448, 14323.212223327713, 1702.8212037736107, 1726.6028813372868, 1779.4127937780631, 1812.4834422189613, 1826.5616252099533, 45825.77087114577, 48197.518024820005, 54851.451485485035, 55926.72036639832, 70599.64700176517, 9133.543322833964, 9157.954210228907, 9182.494962777111, 9386.906130938603, 9796.559154837907, 11901.404929753478, 11910.0, 11939.58211462612, 11961.162718609788, 11966.0, 6874.175098988154, 6902.654867256617, 7128.893066604005, 7142.785716428515, 7153.4992550522, 6637.9668101660145, 6699.866002680016, 6705.731770729214, 6732.596044237263, 6951.82620434483, 6074.51403887688, 6227.501799856001, 6229.127922090911, 6230.532710046765, 6257.530685198537, 1715.7254839225664, 1822.2780469326326, 1823.644389344065, 1854.2397616976975, 1859.809721778036, 841.9073901870789, 845.0957475501277, 845.7862966642887, 851.6210286422606, 860.2945584620676, 17195.656086878193, 18092.366767163086, 18109.649714802803, 18255.087245637664, 18485.0, 876.5923845411914, 891.4829398948724, 897.6229983406985, 899.1567287061498, 910.4416589383852, 9781.853272200922, 10013.249006324555, 10138.493075346203, 10180.63537240246, 10255.0, 397486.0, 404497.0, 411936.0, 412049.0, 413531.0, 48855.755721221874, 61674.999999999105, 63695.0, 65299.0, 68203.65898170478, 850.6427300533667, 916.1022198245756, 947.6209516193439, 979.9069088436587, 982.4400091947664, 15132.621684457976, 16001.439949601709, 16635.50093497197, 16660.25028873728, 16918.661626767644, 24859.51966724696, 27653.0, 35870.461943071394, 36038.639613603526, 37896.0, 42835.571644284406, 43716.34425483684, 44758.32862507, 45155.77422112868, 45498.772506137255, 7635.236476352543, 7655.770326890202, 7811.648475818715, 7909.485883417559, 8071.556064416513, 11917.880821191677, 12144.332061736335, 12288.1398302118, 12507.499700012262, 13035.47858085704, 10182.847257291294, 10195.84706229422, 10698.8930110701, 10816.513256903616, 11123.666290011313, 10525.578976840841, 10555.94722026385, 11016.889831101586, 11026.779464410507, 11137.387443690675, 10120.493975301353, 10474.947625261824, 10747.0, 10802.243842930919, 11297.491612877277, 7753.340966017726, 7788.454808163601, 7974.880376794236, 8056.154103819014, 8081.272685458337, 10399.792004159723, 10501.632442864464, 10541.209409294486, 10778.784424311627, 10953.068989135694], "value": 8255.814664475323, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.6988862450264, 1393.4913756478886, 1460.9780853287202, 1579.2182869479595, 1665.8250883657215, 6640.269570347258, 7147.571145731246, 7165.176004759448, 7703.807404814883, 7712.46012779105, 7391.6304184790815, 7505.5121417107985, 7508.211637778037, 7516.624168791553, 7519.54882707038, 2114.3551216878845, 2139.294032969124, 2141.2612648636195, 2143.8284937204985, 2144.9785502145014, 1858.6004009138032, 2088.749350077993, 2090.1012564597218, 2114.851960362775, 2153.052656830997, 2145.206273678741, 2153.2248390579457, 2158.0936006877073, 2167.8807665578465, 2170.913163473459, 2078.2414418737203, 2085.655866781979, 2139.732533433321, 2140.0, 2144.0994782191515, 2090.95818083639, 2096.329174664108, 2112.4824418017683, 2114.619368513667, 2118.480972161815, 7672.46292759507, 7700.845983080307, 7720.459567830254, 7724.150343462215, 7727.072751269828, 4341.60925516705, 4468.3074123510905, 4471.150481408555, 4477.238869392211, 4479.9552004479865, 2757.806953513255, 2860.6281183446017, 2886.422715456917, 2900.535914253709, 2956.8078074925274, 907.2605826251583, 944.3059351376733, 960.3757557587624, 964.5948701545368, 966.6133546581424, 10044.246681498917, 10063.0, 10067.0, 10072.94963525185, 10073.647422340257, 3694.519712437366, 3945.447637330776, 4154.709170358046, 4162.271602469556, 4165.10450253191, 8741.082186370466, 8759.781005474786, 8767.298616110696, 8775.824483510421, 8801.163889430494, 4435.2903535434825, 4458.398116254264, 4464.017916058462, 4467.374567560544, 4469.709468884512, 4034.6973976951845, 4076.0, 4082.0203151243486, 4082.775447350424, 4083.5508094109623, 3513.350030244413, 3594.1374070223483, 3599.8200089995394, 3615.439606860941, 3640.508531348287, 1036.8185567525652, 1093.639099097296, 1165.347405452949, 1166.3351889423118, 1168.485866218878, 783.9882401763978, 797.9920200798034, 799.8720204767209, 809.2473999180818, 811.123986095016, 4764.571188592974, 4806.351142595705, 4896.094222568836, 4957.82647607332, 5099.5410413063, 848.3976376772561, 850.7107583421666, 859.5014891362995, 889.1375365895071, 892.1970226795936, 3353.245519758035, 3386.068831071426, 3390.4914262860766, 3405.914852128667, 3477.8608855646, 8491.74524764258, 8822.691205807765, 8826.955865220632, 8836.64653413869, 8838.027816940132, 8876.911230887737, 8892.288616910631, 8895.06601806801, 8901.821963560693, 8902.332325075517, 6730.59616423026, 6746.291639377893, 6750.83122921921, 6782.050512928194, 6855.691493882788, 4659.720416775004, 4802.855914322576, 4808.519148085164, 4860.562549370574, 4869.391326084239, 8217.096119426738, 8252.174782521699, 8279.420440569102, 8292.2951549119, 8337.624806883583, 8229.177082291722, 8364.3726720495, 8391.874121888055, 8599.39804213699, 8605.139486051345, 6364.331745166691, 6515.609063456208, 6518.087467754613, 6520.9347906520325, 6523.543351965507, 7283.490155689051, 7293.890591641023, 7295.124585049828, 7305.525140865827, 7314.4148468123485, 6578.7368505261165, 6714.630695311805, 6716.328367163244, 6733.293004234485, 6765.797026089225, 6613.900791488228, 6624.370684784938, 6643.335666433318, 6673.366030227121, 6712.362325579063, 5806.2581225632985, 5897.233359663216, 5898.908701890164, 5900.468957793819, 5908.202392676933, 4404.317330813729, 4448.332750087513, 4456.0, 4534.909301814011, 4604.815807367668, 4603.608693261111, 4641.8143274270005, 4674.929876051794, 4744.691595046311, 4781.067691800205], "value": 3995.301458152462, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.6603239291012, 301.49198600358386, 303.8347935666718, 306.7959806728526, 309.0928125950335, 4832.758362081895, 4838.225883858575, 4857.708537487753, 4871.878203044926, 4887.486813884544, 4744.193487107192, 4754.429468463789, 4773.785179666923, 4785.856424307268, 4801.991581767824, 3552.6269741677074, 3704.1850792825535, 3718.869839555616, 3728.4780130781714, 3736.1033351995598, 3621.6559426854406, 3778.6977041836585, 3787.0532366908274, 3790.753601015925, 3799.4680744695765, 3738.420544815558, 3742.6818720408796, 3751.8311675974646, 3754.361758501048, 3768.7173461990324, 3578.3380074686265, 3736.3834967230373, 3751.324761542935, 3755.324041672498, 3763.3414152523474, 3299.224682199681, 3300.6369299377047, 3301.4717645176656, 3304.487804390323, 3309.1561651778884, 4696.107739529479, 4700.882477938045, 4707.176244157259, 4720.881977950545, 4721.173794585934, 4249.298865687158, 4252.7029256076885, 4279.7218180818145, 4279.7218180818145, 4288.44250247469, 4874.53691899269, 5003.424606170301, 5008.92308153745, 5009.146615752158, 5031.77357018935, 3570.3037907608027, 3577.874774382884, 3583.964160358415, 3584.354816133095, 3588.820558972041, 5216.452272511369, 5260.368755749297, 5261.368635763694, 5261.815836445744, 5262.657927234755, 3469.7397695172963, 3591.94612080819, 3642.0530662028063, 3668.2480091581697, 3675.3935600626132, 3684.5762737285017, 3690.612485689018, 3693.90765230866, 3696.9445458318146, 3697.4638677391627, 4214.7892605370225, 4221.577842215754, 4221.6200541951375, 4232.449781528381, 4233.809478573472, 4902.994726892889, 5018.447970723218, 5030.220315851049, 5032.547070763576, 5039.949600504021, 1240.4913985265998, 1268.4165283969294, 1277.1443133100845, 1279.584135156078, 1282.1217466035796, 785.4148659248896, 803.8954935858301, 820.3847114664002, 823.3454403749034, 830.6760363458257, 4229.703920725519, 4306.870793876189, 4331.696781225347, 4334.284843000933, 4350.630196433275, 5179.0, 5187.429382767892, 5205.6616319939085, 5225.268462415265, 5232.136697444879, 4450.310201918708, 4469.184413819338, 4475.4181956345465, 4494.910101797946, 4499.6400287976885, 2673.304940715428, 2742.9302571996936, 2769.424435275173, 2773.1680495851165, 2773.611694362791, 4833.709977401367, 4879.804807807719, 4898.21628539432, 4912.459629440758, 4922.704637721748, 5052.267421223902, 5294.708791016531, 5302.655327403706, 5309.3894202166475, 5309.628326017219, 4808.543188397097, 4877.609791216694, 4880.389951256093, 4880.682755620874, 4883.780229889592, 5143.202803565453, 5164.715940623302, 5182.352205974254, 5182.8963420732125, 5186.222066689876, 4873.561379475864, 5034.370703662043, 5094.133997220407, 5104.69371837691, 5113.386393632639, 4917.8361520930675, 4930.309756634146, 4940.505949405031, 4947.0, 4950.975245123751, 3677.5770786359913, 3682.263547290499, 3693.781052252804, 3695.8891233263043, 3702.7963462009848, 5001.549860512571, 5213.322268105122, 5219.164933610756, 5232.26748255237, 5237.397699264633, 5085.160948443466, 5101.668391554537, 5108.208227724708, 5109.8283229628005, 5110.182370820651, 5090.440051594395, 5101.464346243591, 5102.821401250939, 5118.488151185001, 5120.206368012964, 4773.355596994361, 5032.823851165192, 5033.421156567042, 5044.899102018013, 5049.596032317332, 4891.755412229445, 4951.430585482572, 5089.796408143781, 5118.97440512795, 5140.331756871583, 4994.4755800640405, 4996.6002719783055, 5003.474635163401, 5008.449070602158, 5014.42334131565], "value": 3791.5007274405875, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [626.2641396359278, 660.2605082307816, 664.0835646807408, 674.5177198303212, 709.6806437103305, 13202.53791117311, 14200.573982780506, 14223.57329280122, 14229.644258893533, 14278.143311401323, 13668.0, 13776.104553204035, 13884.0, 13939.442422303096, 13947.581572552814, 611.382503671293, 730.2989130434762, 746.1978373248766, 758.1584441270186, 771.0477560213133, 755.395683453238, 766.7814672818248, 770.8766597344426, 772.2123434097217, 775.3642013548892, 825.0594322472386, 825.7275099217244, 826.099551488877, 826.1573195340749, 826.2192228344217, 650.4828661214345, 758.3213024343237, 784.8430313937235, 800.5036877136183, 812.305478815616, 587.7149582452507, 590.0853676800984, 598.0729868703493, 598.4344794169511, 598.4703537369415, 13508.864911350858, 13517.391717372644, 13530.594082177551, 13592.660183495393, 13619.931900340534, 12451.564195253122, 12840.229586224856, 13144.934275328658, 13287.13633613812, 13581.388837502336, 12154.574589889311, 12308.876911230953, 12366.19619724715, 12428.62714118578, 12551.811722824164, 4099.446574712406, 4119.629233368982, 4138.8551400700835, 4175.895602609929, 4182.330827067654, 66949.66525167391, 67102.32897671059, 67106.3289367105, 67137.66431167813, 67156.9999999995, 10132.810126834394, 10180.847287290697, 10202.540885660163, 10629.734256643645, 10710.785784284271, 19788.307409240606, 19886.105125269398, 19910.60178796416, 19927.60144797096, 19996.50008749764, 6872.0, 6969.1985421676145, 7004.509684322151, 7014.894776578355, 7065.752698655522, 3667.3582123128344, 3697.6672099510633, 3743.831527581265, 3772.6227377262053, 3802.6387493188104, 2692.3403766077436, 2788.721127887195, 2791.762700170508, 2801.0756450371737, 2806.6211061506433, 487.2058544572395, 494.4560982918832, 497.6218074263586, 501.94478607353165, 505.70669011972967, 518.6706441409657, 534.5429657642737, 543.747157571731, 545.4164044472456, 565.9462351076642, 7016.684249208696, 7423.740169094056, 7841.803954901173, 7930.446573676172, 7942.880856787153, 528.8228443471403, 561.1610642090102, 577.2928163000375, 584.141312270961, 620.404411764711, 3750.2184714489244, 3766.39737641976, 3829.5021647186245, 4082.3468245080644, 4147.315692910696, 94790.0, 96254.0, 97321.0, 98869.50565247127, 99583.50208249057, 79663.60168199238, 82885.0, 82970.0, 83091.0, 83330.0, 44004.77997610055, 52641.7367913158, 69196.6540167306, 70343.0, 71741.0, 8134.267915887599, 8241.423100382915, 8430.241278284984, 8470.280026197843, 8766.693165739169, 39717.0, 43236.13527729491, 44028.0, 44160.33759493546, 45896.54103458922, 40239.0, 46490.53509464862, 60085.0, 61896.0, 61924.0, 11708.590199342982, 11757.353345566076, 11828.17202795796, 11894.524219031488, 12027.0, 12122.0, 12780.0, 12921.095523313277, 13006.739865202831, 13206.471741130246, 11278.379689117177, 11467.254628449124, 12002.099842512021, 12582.370881456074, 12857.485700571873, 11139.220254582102, 11554.537818487166, 11916.880831191924, 12139.696507587381, 12375.566855160027, 11633.59282425111, 12011.0, 12014.399280036137, 12239.816402753788, 12283.0, 9150.862737059082, 9596.0, 9715.611375544899, 9843.901560984299, 9913.256505761952, 8465.0, 8621.913780862362, 8643.91356086431, 9076.909230907871, 9599.232061434928], "value": 6554.537577811802, "unit": "score"}], "name": "dromaeo_css", "value": 6289.358164442661, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 128.0, 114.0, 114.0, 114.0, 112.0, 112.0, 113.0, 113.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 150.0, 180.0, 123.0, 147.0, 159.0, 124.0, 193.0, 127.0], "value": 148.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 162.0, 159.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 164.0, 77.0, 78.0, 76.0, 75.0, 174.0, 75.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 161.0, 86.0, 87.0, 87.0, 140.0, 88.0, 87.0, 135.0], "value": 104.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 120.0, 118.0, 116.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 68.0, 66.0, 66.0, 66.0, 65.0, 65.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 82.0, 81.0, 86.0, 90.0, 81.0, 83.0, 82.0, 83.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 131.0, 138.0, 140.0, 139.0, 139.0, 133.0, 130.0, 146.0, 134.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 174.0, 175.0, 174.0, 173.0, 172.0, 171.0, 171.0, 178.0, 173.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 69.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 68.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1575.9999999999998, "alertThreshold": 2.0}]} 06:48:31 INFO - Return code: 0 06:48:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:48:31 INFO - # TBPL SUCCESS # 06:48:31 INFO - Running post-action listener: _resource_record_post_action 06:48:31 INFO - [mozharness: 2016-08-25 13:48:31.146231Z] Finished run-tests step (success) 06:48:31 INFO - Running post-run listener: _resource_record_post_run 06:48:31 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 417931264; Read time: 16; Write time: 279936 06:48:31 INFO - TinderboxPrint: CPU usage
13.0% 06:48:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 06:48:31 INFO - TinderboxPrint: I/O write bytes / time
417,931,264 / 279,936 06:48:31 INFO - TinderboxPrint: CPU idle
8,335.9 (87.0%) 06:48:31 INFO - TinderboxPrint: CPU user
1,198.5 (12.5%) 06:48:31 INFO - TinderboxPrint: Swap in / out
0 / 0 06:48:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124809216; Read time: 0; Write time: 90884 06:48:31 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 291983360; Read time: 0; Write time: 189024 06:48:31 INFO - Running post-run listener: _upload_blobber_files 06:48:31 INFO - Blob upload gear active. 06:48:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:48:31 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 06:48:31 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'] 06:48:31 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 06:48:32 INFO - (blobuploader) - INFO - Open directory for files ... 06:48:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:48:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:48:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:32 INFO - (blobuploader) - INFO - Done attempting. 06:48:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:48:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:48:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:33 INFO - (blobuploader) - INFO - Done attempting. 06:48:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:48:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:48:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:37 INFO - (blobuploader) - INFO - Done attempting. 06:48:37 INFO - (blobuploader) - INFO - Iteration through files over. 06:48:37 INFO - Return code: 0 06:48:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:48:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:48:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f74f6c346f9878cc1c45474a475493a151e0491031d96ec769ccdaba0d750cc0fd7fea7813c68e6fe6c29c0dc5cf8192ba71fcfa7fdc25b43022e978609cb9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54c517177a3e603eb265fadd41cf8a6e0b32bc6558cae4a9cf9d0db846c0b0a9e07fc2ba0b1cbfc3083d3e6ac7f0ae7766fee178af5c40c40c236fb699f33e99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/357a89531c8818b37590c4451ed7a907dccb6f49510bd8ae01b73c85902dcd3fe47559d01e03889548e3a6890861a944550bee14b17dc7c35417f93b56973881"} 06:48:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:48:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:48:37 INFO - Contents: 06:48:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2f74f6c346f9878cc1c45474a475493a151e0491031d96ec769ccdaba0d750cc0fd7fea7813c68e6fe6c29c0dc5cf8192ba71fcfa7fdc25b43022e978609cb9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54c517177a3e603eb265fadd41cf8a6e0b32bc6558cae4a9cf9d0db846c0b0a9e07fc2ba0b1cbfc3083d3e6ac7f0ae7766fee178af5c40c40c236fb699f33e99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/357a89531c8818b37590c4451ed7a907dccb6f49510bd8ae01b73c85902dcd3fe47559d01e03889548e3a6890861a944550bee14b17dc7c35417f93b56973881"} 06:48:37 INFO - Running post-run listener: copy_logs_to_upload_dir 06:48:37 INFO - Copying logs to upload dir... 06:48:37 INFO - mkdir: /builds/slave/test/build/upload/logs 06:48:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.978329 ========= master_lag: 6.35 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-08-25 06:48:43.145267) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 06:48:43.148487) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501 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/2f74f6c346f9878cc1c45474a475493a151e0491031d96ec769ccdaba0d750cc0fd7fea7813c68e6fe6c29c0dc5cf8192ba71fcfa7fdc25b43022e978609cb9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54c517177a3e603eb265fadd41cf8a6e0b32bc6558cae4a9cf9d0db846c0b0a9e07fc2ba0b1cbfc3083d3e6ac7f0ae7766fee178af5c40c40c236fb699f33e99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/357a89531c8818b37590c4451ed7a907dccb6f49510bd8ae01b73c85902dcd3fe47559d01e03889548e3a6890861a944550bee14b17dc7c35417f93b56973881"} build_url:https://queue.taskcluster.net/v1/task/IhE7ox_0TvyDH8fFDoC3_w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/IhE7ox_0TvyDH8fFDoC3_w/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/2f74f6c346f9878cc1c45474a475493a151e0491031d96ec769ccdaba0d750cc0fd7fea7813c68e6fe6c29c0dc5cf8192ba71fcfa7fdc25b43022e978609cb9a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54c517177a3e603eb265fadd41cf8a6e0b32bc6558cae4a9cf9d0db846c0b0a9e07fc2ba0b1cbfc3083d3e6ac7f0ae7766fee178af5c40c40c236fb699f33e99", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/357a89531c8818b37590c4451ed7a907dccb6f49510bd8ae01b73c85902dcd3fe47559d01e03889548e3a6890861a944550bee14b17dc7c35417f93b56973881"}' ========= master_lag: 0.17 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 06:48:43.326279) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 06:48:43.326659) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1472130865.14424-2077599501 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 06:48:43.343346) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 06:48:43.343663) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 06:48:43.343963) ========= ========= Total master_lag: 6.62 =========