builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1472674468.19 results: success (0) buildid: 20160831103033 builduid: b3b2c5e2c88247268e7a138bd06a6ec9 revision: b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 13:14:28.187076) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-31 13:14:28.187516) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 13:14:28.187844) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-31 13:14:28.210146) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 13:14:28.210505) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-31 13:14:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 22.4M=0.001s 2016-08-31 13:14:28 (22.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.076923 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 13:14:28.305940) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 13:14:28.306256) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017574 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 13:14:28.361662) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 13:14:28.362021) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a --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 b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-31 13:14:28,550 truncating revision to first 12 chars 2016-08-31 13:14:28,550 Setting DEBUG logging. 2016-08-31 13:14:28,550 attempt 1/10 2016-08-31 13:14:28,550 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b3ec8a3373e8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-31 13:14:28,853 unpacking tar archive at: mozilla-central-b3ec8a3373e8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584597 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 13:14:28.963990) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 13:14:28.964795) ========= script_repo_revision: b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-31 13:14:28.965708) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 13:14:28.966371) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-31 13:14:28.982306) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-31 13:14:28.982625) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:14:29 INFO - MultiFileLogger online at 20160831 13:14:29 in /builds/slave/test 13:14:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:14:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:14:29 INFO - {'append_to_log': False, 13:14:29 INFO - 'base_work_dir': '/builds/slave/test', 13:14:29 INFO - 'blob_upload_branch': 'Firefox', 13:14:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:14:29 INFO - 'branch': 'Firefox', 13:14:29 INFO - 'buildbot_json_path': 'buildprops.json', 13:14:29 INFO - 'config_files': ('talos/linux_config.py',), 13:14:29 INFO - 'default_actions': ('clobber', 13:14:29 INFO - 'read-buildbot-config', 13:14:29 INFO - 'download-and-extract', 13:14:29 INFO - 'populate-webroot', 13:14:29 INFO - 'create-virtualenv', 13:14:29 INFO - 'install', 13:14:29 INFO - 'run-tests'), 13:14:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:14:29 INFO - 'download_minidump_stackwalk': True, 13:14:29 INFO - 'download_symbols': 'ondemand', 13:14:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:14:29 INFO - 'tooltool.py': '/tools/tooltool.py', 13:14:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:14:29 INFO - '/tools/misc-python/virtualenv.py')}, 13:14:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:14:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:14:29 INFO - 'installer_path': 'installer.exe', 13:14:29 INFO - 'log_level': 'info', 13:14:29 INFO - 'log_name': 'talos', 13:14:29 INFO - 'log_to_console': True, 13:14:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:14:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:14:29 INFO - 'opt_config_files': (), 13:14:29 INFO - 'pip_index': False, 13:14:29 INFO - 'sps_profile': False, 13:14:29 INFO - 'sps_profile_interval': 0, 13:14:29 INFO - 'suite': 'dromaeojs', 13:14:29 INFO - 'system_bits': '32', 13:14:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:14:29 INFO - 'title': 'talos-linux64-ix-009', 13:14:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:14:29 INFO - 'use_talos_json': True, 13:14:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:14:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:14:29 INFO - 'work_dir': 'build'} 13:14:29 INFO - [mozharness: 2016-08-31 20:14:29.262412Z] Running clobber step. 13:14:29 INFO - Running pre-action listener: _resource_record_pre_action 13:14:29 INFO - Running main action method: clobber 13:14:29 INFO - rmtree: /builds/slave/test/build 13:14:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:14:29 INFO - Running post-action listener: _resource_record_post_action 13:14:29 INFO - [mozharness: 2016-08-31 20:14:29.719705Z] Finished clobber step (success) 13:14:29 INFO - [mozharness: 2016-08-31 20:14:29.719806Z] Running read-buildbot-config step. 13:14:29 INFO - Running pre-action listener: _resource_record_pre_action 13:14:29 INFO - Running main action method: read_buildbot_config 13:14:29 INFO - Using buildbot properties: 13:14:29 INFO - { 13:14:29 INFO - "project": "", 13:14:29 INFO - "product": "firefox", 13:14:29 INFO - "script_repo_revision": "production", 13:14:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 13:14:29 INFO - "repository": "", 13:14:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 13:14:29 INFO - "buildid": "20160831103033", 13:14:29 INFO - "pgo_build": "True", 13:14:29 INFO - "basedir": "/builds/slave/test", 13:14:29 INFO - "buildnumber": 847, 13:14:29 INFO - "slavename": "talos-linux64-ix-009", 13:14:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:14:29 INFO - "platform": "ubuntu64_hw", 13:14:29 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 13:14:29 INFO - "branch": "mozilla-central", 13:14:29 INFO - "repo_path": "mozilla-central", 13:14:29 INFO - "revision": "b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a", 13:14:29 INFO - "stage_platform": "linux64-pgo", 13:14:29 INFO - "builduid": "b3b2c5e2c88247268e7a138bd06a6ec9", 13:14:29 INFO - "slavebuilddir": "test" 13:14:29 INFO - } 13:14:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 13:14:29 INFO - Running post-action listener: _resource_record_post_action 13:14:29 INFO - [mozharness: 2016-08-31 20:14:29.722259Z] Finished read-buildbot-config step (success) 13:14:29 INFO - [mozharness: 2016-08-31 20:14:29.722349Z] Running download-and-extract step. 13:14:29 INFO - Running pre-action listener: _resource_record_pre_action 13:14:29 INFO - Running main action method: download_and_extract 13:14:29 INFO - mkdir: /builds/slave/test/build/tests 13:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:29 INFO - trying https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:14:29 INFO - Downloading https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:14:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:14:30 INFO - Downloaded 1361 bytes. 13:14:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 13:14:30 INFO - Using the following test package requirements: 13:14:30 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:14:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:14:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:14:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:30 INFO - u'jsshell-linux-x86_64.zip'], 13:14:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:14:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 13:14:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:14:30 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:14:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:14:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 13:14:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:14:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:14:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:30 INFO - trying https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:14:30 INFO - Downloading https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:14:31 INFO - Downloaded 21903825 bytes. 13:14:31 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 13:14:35 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:35 INFO - trying https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:14:35 INFO - Downloading https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 13:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:14:36 INFO - Downloaded 21903825 bytes. 13:14:36 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 13:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:40 INFO - trying https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 13:14:40 INFO - Downloading https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 13:14:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:14:41 INFO - Downloaded 14413998 bytes. 13:14:41 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 13:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:41 INFO - trying https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:14:41 INFO - Downloading https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:14:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:14:43 INFO - Downloaded 59726914 bytes. 13:14:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:14:43 INFO - mkdir: /builds/slave/test/properties 13:14:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:14:43 INFO - Writing to file /builds/slave/test/properties/build_url 13:14:43 INFO - Contents: 13:14:43 INFO - build_url:https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 13:14:43 INFO - Running post-action listener: _resource_record_post_action 13:14:43 INFO - Running post-action listener: set_extra_try_arguments 13:14:43 INFO - [mozharness: 2016-08-31 20:14:43.904045Z] Finished download-and-extract step (success) 13:14:43 INFO - [mozharness: 2016-08-31 20:14:43.904273Z] Running populate-webroot step. 13:14:43 INFO - Running pre-action listener: _resource_record_pre_action 13:14:43 INFO - Running main action method: populate_webroot 13:14:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:14:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:14:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:14:43 INFO - '--tppagecycles', 13:14:43 INFO - '7'], 13:14:43 INFO - 'tests': ['tsvgm']}}, 13:14:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:14:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:14:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:14:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:14:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:14:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:14:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:43 INFO - 'talos_options': ['--disable-e10s'], 13:14:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:14:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:14:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:43 INFO - 'talos_options': ['--disable-e10s'], 13:14:43 INFO - 'tests': ['damp', 'tps']}, 13:14:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:43 INFO - 'tests': ['damp', 'tps']}, 13:14:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:14:43 INFO - 'tests': ['dromaeo_dom']}, 13:14:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:14:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:14:43 INFO - 'tests': ['basic_compositor_video']}, 13:14:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:14:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:14:43 INFO - 'tests': ['a11yr', 13:14:43 INFO - 'ts_paint', 13:14:43 INFO - 'tpaint', 13:14:43 INFO - 'sessionrestore', 13:14:43 INFO - 'sessionrestore_no_auto_restore', 13:14:43 INFO - 'tabpaint']}, 13:14:43 INFO - 'other-e10s': {'tests': ['a11yr', 13:14:43 INFO - 'ts_paint', 13:14:43 INFO - 'tpaint', 13:14:43 INFO - 'sessionrestore', 13:14:43 INFO - 'sessionrestore_no_auto_restore', 13:14:43 INFO - 'tabpaint']}, 13:14:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:14:43 INFO - 'ts_paint', 13:14:43 INFO - 'tpaint', 13:14:43 INFO - 'sessionrestore', 13:14:43 INFO - 'sessionrestore_no_auto_restore', 13:14:43 INFO - 'tabpaint']}, 13:14:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:14:43 INFO - 'ts_paint', 13:14:43 INFO - 'tpaint', 13:14:43 INFO - 'sessionrestore', 13:14:43 INFO - 'sessionrestore_no_auto_restore', 13:14:43 INFO - 'tabpaint']}, 13:14:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:14:43 INFO - 'tests': ['a11yr', 13:14:43 INFO - 'ts_paint', 13:14:43 INFO - 'tpaint', 13:14:43 INFO - 'sessionrestore', 13:14:43 INFO - 'sessionrestore_no_auto_restore', 13:14:43 INFO - 'tabpaint']}, 13:14:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:14:43 INFO - 'tests': ['a11yr', 13:14:43 INFO - 'ts_paint', 13:14:43 INFO - 'tpaint', 13:14:43 INFO - 'sessionrestore', 13:14:43 INFO - 'sessionrestore_no_auto_restore', 13:14:43 INFO - 'tabpaint']}, 13:14:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:14:43 INFO - 'tests': ['tsvgx', 13:14:43 INFO - 'tsvgr_opacity', 13:14:43 INFO - 'tart', 13:14:43 INFO - 'tscrollx', 13:14:43 INFO - 'cart']}, 13:14:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:14:43 INFO - 'tsvgr_opacity', 13:14:43 INFO - 'tart', 13:14:43 INFO - 'tscrollx', 13:14:43 INFO - 'cart']}, 13:14:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:43 INFO - 'talos_options': ['--disable-e10s'], 13:14:43 INFO - 'tests': ['tp5o']}, 13:14:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:43 INFO - 'tests': ['tp5o']}, 13:14:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:43 INFO - 'talos_options': ['--disable-e10s', 13:14:43 INFO - '--xperf_path', 13:14:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:14:43 INFO - 'tests': ['tp5n']}, 13:14:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:14:43 INFO - 'talos_options': ['--xperf_path', 13:14:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:14:43 INFO - 'tests': ['tp5n']}}, 13:14:43 INFO - 'talos.zip': {'path': '', 13:14:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:14:43 INFO - Running post-action listener: _resource_record_post_action 13:14:43 INFO - [mozharness: 2016-08-31 20:14:43.923170Z] Finished populate-webroot step (success) 13:14:43 INFO - [mozharness: 2016-08-31 20:14:43.923259Z] Running create-virtualenv step. 13:14:43 INFO - Running pre-action listener: _resource_record_pre_action 13:14:43 INFO - Running main action method: create_virtualenv 13:14:43 INFO - Creating virtualenv /builds/slave/test/build/venv 13:14:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:14:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:14:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:14:44 INFO - Using real prefix '/usr' 13:14:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:14:44 INFO - Installing distribute.............................................................................................................................................................................................done. 13:14:46 INFO - Installing pip.................done. 13:14:46 INFO - Return code: 0 13:14:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:46 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 0x7f78f6d39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ae850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a9370>, '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 0x14ac8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14acd80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:14:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:14:46 INFO - Using env: {'DISPLAY': ':0', 13:14:46 INFO - 'HOME': '/home/cltbld', 13:14:46 INFO - 'LANG': 'en_US.UTF-8', 13:14:46 INFO - 'LANGUAGE': 'en_US:en', 13:14:46 INFO - 'LOGNAME': 'cltbld', 13:14:46 INFO - 'MAIL': '/var/mail/cltbld', 13:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:46 INFO - 'MOZ_NO_REMOTE': '1', 13:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:46 INFO - 'NO_EM_RESTART': '1', 13:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:46 INFO - 'PWD': '/builds/slave/test', 13:14:46 INFO - 'SHELL': '/bin/bash', 13:14:46 INFO - 'SHLVL': '1', 13:14:46 INFO - 'TERM': 'linux', 13:14:46 INFO - 'TMOUT': '86400', 13:14:46 INFO - 'USER': 'cltbld', 13:14:46 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 13:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:46 INFO - '_': '/tools/buildbot/bin/python'} 13:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:14:46 INFO - Cleaning up... 13:14:46 INFO - Return code: 0 13:14:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:46 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 0x7f78f6d39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ae850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a9370>, '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 0x14ac8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14acd80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:14:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:14:46 INFO - Using env: {'DISPLAY': ':0', 13:14:46 INFO - 'HOME': '/home/cltbld', 13:14:46 INFO - 'LANG': 'en_US.UTF-8', 13:14:46 INFO - 'LANGUAGE': 'en_US:en', 13:14:46 INFO - 'LOGNAME': 'cltbld', 13:14:46 INFO - 'MAIL': '/var/mail/cltbld', 13:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:46 INFO - 'MOZ_NO_REMOTE': '1', 13:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:46 INFO - 'NO_EM_RESTART': '1', 13:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:46 INFO - 'PWD': '/builds/slave/test', 13:14:46 INFO - 'SHELL': '/bin/bash', 13:14:46 INFO - 'SHLVL': '1', 13:14:46 INFO - 'TERM': 'linux', 13:14:46 INFO - 'TMOUT': '86400', 13:14:46 INFO - 'USER': 'cltbld', 13:14:46 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 13:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:46 INFO - '_': '/tools/buildbot/bin/python'} 13:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:46 INFO - Downloading/unpacking psutil>=3.1.1 13:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:14:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:14:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:14:48 INFO - Installing collected packages: psutil 13:14:48 INFO - Running setup.py install for psutil 13:14:48 INFO - building 'psutil._psutil_linux' extension 13:14:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 13:14:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 13:14:49 INFO - building 'psutil._psutil_posix' extension 13:14:49 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 13:14:49 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 13:14:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:14:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:14:49 INFO - Successfully installed psutil 13:14:49 INFO - Cleaning up... 13:14:49 INFO - Return code: 0 13:14:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:49 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 0x7f78f6d39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ae850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a9370>, '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 0x14ac8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14acd80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:14:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:14:49 INFO - Using env: {'DISPLAY': ':0', 13:14:49 INFO - 'HOME': '/home/cltbld', 13:14:49 INFO - 'LANG': 'en_US.UTF-8', 13:14:49 INFO - 'LANGUAGE': 'en_US:en', 13:14:49 INFO - 'LOGNAME': 'cltbld', 13:14:49 INFO - 'MAIL': '/var/mail/cltbld', 13:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:49 INFO - 'MOZ_NO_REMOTE': '1', 13:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:49 INFO - 'NO_EM_RESTART': '1', 13:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:49 INFO - 'PWD': '/builds/slave/test', 13:14:49 INFO - 'SHELL': '/bin/bash', 13:14:49 INFO - 'SHLVL': '1', 13:14:49 INFO - 'TERM': 'linux', 13:14:49 INFO - 'TMOUT': '86400', 13:14:49 INFO - 'USER': 'cltbld', 13:14:49 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 13:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:49 INFO - '_': '/tools/buildbot/bin/python'} 13:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:14:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:14:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:14:51 INFO - Installing collected packages: mozsystemmonitor 13:14:51 INFO - Running setup.py install for mozsystemmonitor 13:14:51 INFO - Successfully installed mozsystemmonitor 13:14:51 INFO - Cleaning up... 13:14:51 INFO - Return code: 0 13:14:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:51 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 0x7f78f6d39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ae850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a9370>, '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 0x14ac8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14acd80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:14:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:14:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:14:51 INFO - Using env: {'DISPLAY': ':0', 13:14:51 INFO - 'HOME': '/home/cltbld', 13:14:51 INFO - 'LANG': 'en_US.UTF-8', 13:14:51 INFO - 'LANGUAGE': 'en_US:en', 13:14:51 INFO - 'LOGNAME': 'cltbld', 13:14:51 INFO - 'MAIL': '/var/mail/cltbld', 13:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:51 INFO - 'MOZ_NO_REMOTE': '1', 13:14:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:51 INFO - 'NO_EM_RESTART': '1', 13:14:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:51 INFO - 'PWD': '/builds/slave/test', 13:14:51 INFO - 'SHELL': '/bin/bash', 13:14:51 INFO - 'SHLVL': '1', 13:14:51 INFO - 'TERM': 'linux', 13:14:51 INFO - 'TMOUT': '86400', 13:14:51 INFO - 'USER': 'cltbld', 13:14:51 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 13:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:51 INFO - '_': '/tools/buildbot/bin/python'} 13:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:51 INFO - Downloading/unpacking jsonschema==2.5.1 13:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:14:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:54 INFO - Downloading functools32-3.2.3-2.tar.gz 13:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:14:54 INFO - warning: no files found matching '*.txt' 13:14:54 INFO - no previously-included directories found matching 'build' 13:14:54 INFO - no previously-included directories found matching 'dist' 13:14:54 INFO - no previously-included directories found matching '.git*' 13:14:54 INFO - Installing collected packages: jsonschema, functools32 13:14:54 INFO - Running setup.py install for functools32 13:14:54 INFO - warning: no files found matching '*.txt' 13:14:54 INFO - no previously-included directories found matching 'build' 13:14:54 INFO - no previously-included directories found matching 'dist' 13:14:54 INFO - no previously-included directories found matching '.git*' 13:14:54 INFO - Successfully installed jsonschema functools32 13:14:54 INFO - Cleaning up... 13:14:54 INFO - Return code: 0 13:14:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:54 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 0x7f78f6d39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ae850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a9370>, '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 0x14ac8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14acd80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:14:54 INFO - Using env: {'DISPLAY': ':0', 13:14:54 INFO - 'HOME': '/home/cltbld', 13:14:54 INFO - 'LANG': 'en_US.UTF-8', 13:14:54 INFO - 'LANGUAGE': 'en_US:en', 13:14:54 INFO - 'LOGNAME': 'cltbld', 13:14:54 INFO - 'MAIL': '/var/mail/cltbld', 13:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:54 INFO - 'MOZ_NO_REMOTE': '1', 13:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:54 INFO - 'NO_EM_RESTART': '1', 13:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:54 INFO - 'PWD': '/builds/slave/test', 13:14:54 INFO - 'SHELL': '/bin/bash', 13:14:54 INFO - 'SHLVL': '1', 13:14:54 INFO - 'TERM': 'linux', 13:14:54 INFO - 'TMOUT': '86400', 13:14:54 INFO - 'USER': 'cltbld', 13:14:54 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 13:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:54 INFO - '_': '/tools/buildbot/bin/python'} 13:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:14:54 INFO - Cleaning up... 13:14:54 INFO - Return code: 0 13:14:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:54 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 0x7f78f6d39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ae850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a9370>, '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 0x14ac8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14acd80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:14:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:14:54 INFO - Using env: {'DISPLAY': ':0', 13:14:54 INFO - 'HOME': '/home/cltbld', 13:14:54 INFO - 'LANG': 'en_US.UTF-8', 13:14:54 INFO - 'LANGUAGE': 'en_US:en', 13:14:54 INFO - 'LOGNAME': 'cltbld', 13:14:54 INFO - 'MAIL': '/var/mail/cltbld', 13:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:54 INFO - 'MOZ_NO_REMOTE': '1', 13:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:54 INFO - 'NO_EM_RESTART': '1', 13:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:54 INFO - 'PWD': '/builds/slave/test', 13:14:54 INFO - 'SHELL': '/bin/bash', 13:14:54 INFO - 'SHLVL': '1', 13:14:54 INFO - 'TERM': 'linux', 13:14:54 INFO - 'TMOUT': '86400', 13:14:54 INFO - 'USER': 'cltbld', 13:14:54 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 13:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:54 INFO - '_': '/tools/buildbot/bin/python'} 13:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:54 INFO - Downloading/unpacking blobuploader==1.2.4 13:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:56 INFO - Downloading blobuploader-1.2.4.tar.gz 13:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:14:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:14:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:14:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:14:57 INFO - Downloading docopt-0.6.1.tar.gz 13:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:14:57 INFO - Installing collected packages: blobuploader, requests, docopt 13:14:57 INFO - Running setup.py install for blobuploader 13:14:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:14:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:14:57 INFO - Running setup.py install for requests 13:14:57 INFO - Running setup.py install for docopt 13:14:57 INFO - Successfully installed blobuploader requests docopt 13:14:57 INFO - Cleaning up... 13:14:58 INFO - Return code: 0 13:14:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:14:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f78f6d39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ae850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a9370>, '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 0x14ac8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14acd80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:14:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:14:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:14:58 INFO - Using env: {'DISPLAY': ':0', 13:14:58 INFO - 'HOME': '/home/cltbld', 13:14:58 INFO - 'LANG': 'en_US.UTF-8', 13:14:58 INFO - 'LANGUAGE': 'en_US:en', 13:14:58 INFO - 'LOGNAME': 'cltbld', 13:14:58 INFO - 'MAIL': '/var/mail/cltbld', 13:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:14:58 INFO - 'MOZ_NO_REMOTE': '1', 13:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:14:58 INFO - 'NO_EM_RESTART': '1', 13:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:14:58 INFO - 'PWD': '/builds/slave/test', 13:14:58 INFO - 'SHELL': '/bin/bash', 13:14:58 INFO - 'SHLVL': '1', 13:14:58 INFO - 'TERM': 'linux', 13:14:58 INFO - 'TMOUT': '86400', 13:14:58 INFO - 'USER': 'cltbld', 13:14:58 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 13:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:14:58 INFO - '_': '/tools/buildbot/bin/python'} 13:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:14:58 INFO - Running setup.py (path:/tmp/pip-k74KtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:14:58 INFO - Running setup.py (path:/tmp/pip-MoIefZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:14:58 INFO - Running setup.py (path:/tmp/pip-KUDfYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:14:58 INFO - Running setup.py (path:/tmp/pip-5UcfhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:14:58 INFO - Running setup.py (path:/tmp/pip-PJTggN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:14:58 INFO - Running setup.py (path:/tmp/pip-RZT7O3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:14:58 INFO - Running setup.py (path:/tmp/pip-qW2MAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:14:58 INFO - Running setup.py (path:/tmp/pip-oYWAfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:14:58 INFO - Running setup.py (path:/tmp/pip-sZsqUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:14:58 INFO - Running setup.py (path:/tmp/pip-D9x7Nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:14:58 INFO - Running setup.py (path:/tmp/pip-EQqYNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:14:58 INFO - Running setup.py (path:/tmp/pip-cFH8zI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:14:59 INFO - Running setup.py (path:/tmp/pip-SeUlvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:14:59 INFO - Running setup.py (path:/tmp/pip-_5pry8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:14:59 INFO - Running setup.py (path:/tmp/pip-7O6FqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:14:59 INFO - Running setup.py (path:/tmp/pip-g9rqes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:14:59 INFO - Running setup.py (path:/tmp/pip-Vefc8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:14:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:14:59 INFO - Running setup.py install for manifestparser 13:14:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:14:59 INFO - Running setup.py install for mozcrash 13:14:59 INFO - Running setup.py install for mozdebug 13:14:59 INFO - Running setup.py install for mozdevice 13:14:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:14:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:14:59 INFO - Running setup.py install for mozfile 13:14:59 INFO - Running setup.py install for mozhttpd 13:15:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Running setup.py install for mozinfo 13:15:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Running setup.py install for mozInstall 13:15:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Running setup.py install for mozleak 13:15:00 INFO - Running setup.py install for mozlog 13:15:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Running setup.py install for moznetwork 13:15:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Running setup.py install for mozprocess 13:15:00 INFO - Running setup.py install for mozprofile 13:15:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Running setup.py install for mozrunner 13:15:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:15:00 INFO - Running setup.py install for mozscreenshot 13:15:01 INFO - Running setup.py install for moztest 13:15:01 INFO - Running setup.py install for mozversion 13:15:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:15:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:15:01 INFO - Cleaning up... 13:15:01 INFO - Return code: 0 13:15:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:01 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 0x7f78f6d39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ae850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a9370>, '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 0x14ac8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14acd80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:15:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:15:01 INFO - Using env: {'DISPLAY': ':0', 13:15:01 INFO - 'HOME': '/home/cltbld', 13:15:01 INFO - 'LANG': 'en_US.UTF-8', 13:15:01 INFO - 'LANGUAGE': 'en_US:en', 13:15:01 INFO - 'LOGNAME': 'cltbld', 13:15:01 INFO - 'MAIL': '/var/mail/cltbld', 13:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:01 INFO - 'MOZ_NO_REMOTE': '1', 13:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:01 INFO - 'NO_EM_RESTART': '1', 13:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:01 INFO - 'PWD': '/builds/slave/test', 13:15:01 INFO - 'SHELL': '/bin/bash', 13:15:01 INFO - 'SHLVL': '1', 13:15:01 INFO - 'TERM': 'linux', 13:15:01 INFO - 'TMOUT': '86400', 13:15:01 INFO - 'USER': 'cltbld', 13:15:01 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 13:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:01 INFO - '_': '/tools/buildbot/bin/python'} 13:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:15:01 INFO - Running setup.py (path:/tmp/pip-Jm1Tme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:15:01 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:15:01 INFO - Running setup.py (path:/tmp/pip-hwNOrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:15:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:15:01 INFO - Running setup.py (path:/tmp/pip-OnUAOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:15:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:15:01 INFO - Running setup.py (path:/tmp/pip-8eE2ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:15:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:15:01 INFO - Running setup.py (path:/tmp/pip-xNg_m3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:15:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:15:01 INFO - Running setup.py (path:/tmp/pip-uQhgSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:15:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:15:01 INFO - Running setup.py (path:/tmp/pip-6AHAxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:15:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:15:01 INFO - Running setup.py (path:/tmp/pip-TPVrI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:15:02 INFO - Running setup.py (path:/tmp/pip-rwRv1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:15:02 INFO - Running setup.py (path:/tmp/pip-r3C4Ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:15:02 INFO - Running setup.py (path:/tmp/pip-y9QVIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:15:02 INFO - Running setup.py (path:/tmp/pip-ekZkAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:15:02 INFO - Running setup.py (path:/tmp/pip-V549U4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:15:02 INFO - Running setup.py (path:/tmp/pip-26UYUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:02 INFO - Running setup.py (path:/tmp/pip-OtWmCL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:15:02 INFO - Running setup.py (path:/tmp/pip-16OTsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:15:02 INFO - Running setup.py (path:/tmp/pip-9jcY1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:15:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:15:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:15:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:15:04 INFO - Downloading blessings-1.6.tar.gz 13:15:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:15:04 INFO - Installing collected packages: blessings 13:15:04 INFO - Running setup.py install for blessings 13:15:04 INFO - Successfully installed blessings 13:15:04 INFO - Cleaning up... 13:15:04 INFO - Return code: 0 13:15:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:15:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:15:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:15:05 INFO - Reading from file tmpfile_stdout 13:15:05 INFO - Current package versions: 13:15:05 INFO - argparse == 1.2.1 13:15:05 INFO - blessings == 1.6 13:15:05 INFO - blobuploader == 1.2.4 13:15:05 INFO - docopt == 0.6.1 13:15:05 INFO - functools32 == 3.2.3-2 13:15:05 INFO - jsonschema == 2.5.1 13:15:05 INFO - manifestparser == 1.1 13:15:05 INFO - mozInstall == 1.12 13:15:05 INFO - mozcrash == 0.17 13:15:05 INFO - mozdebug == 0.1 13:15:05 INFO - mozdevice == 0.48 13:15:05 INFO - mozfile == 1.2 13:15:05 INFO - mozhttpd == 0.7 13:15:05 INFO - mozinfo == 0.9 13:15:05 INFO - mozleak == 0.1 13:15:05 INFO - mozlog == 3.3 13:15:05 INFO - moznetwork == 0.27 13:15:05 INFO - mozprocess == 0.23 13:15:05 INFO - mozprofile == 0.28 13:15:05 INFO - mozrunner == 6.12 13:15:05 INFO - mozscreenshot == 0.1 13:15:05 INFO - mozsystemmonitor == 0.3 13:15:05 INFO - moztest == 0.7 13:15:05 INFO - mozversion == 1.4 13:15:05 INFO - psutil == 3.1.1 13:15:05 INFO - requests == 1.2.3 13:15:05 INFO - wsgiref == 0.1.2 13:15:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:15: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')]} 13:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15: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')]} 13:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f78f6d39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ae850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a9370>, '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 0x14ac8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14acd80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:15:05 INFO - Using env: {'DISPLAY': ':0', 13:15:05 INFO - 'HOME': '/home/cltbld', 13:15:05 INFO - 'LANG': 'en_US.UTF-8', 13:15:05 INFO - 'LANGUAGE': 'en_US:en', 13:15:05 INFO - 'LOGNAME': 'cltbld', 13:15:05 INFO - 'MAIL': '/var/mail/cltbld', 13:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:05 INFO - 'MOZ_NO_REMOTE': '1', 13:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:05 INFO - 'NO_EM_RESTART': '1', 13:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:05 INFO - 'PWD': '/builds/slave/test', 13:15:05 INFO - 'SHELL': '/bin/bash', 13:15:05 INFO - 'SHLVL': '1', 13:15:05 INFO - 'TERM': 'linux', 13:15:05 INFO - 'TMOUT': '86400', 13:15:05 INFO - 'USER': 'cltbld', 13:15:05 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 13:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:05 INFO - '_': '/tools/buildbot/bin/python'} 13:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:15:05 INFO - Cleaning up... 13:15:05 INFO - Return code: 0 13:15:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:15: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')]} 13:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:15:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15: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')]} 13:15:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:15:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:15:05 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 0x7f78f6d39f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ae850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a9370>, '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 0x14ac8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14acd80>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 13:15:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:15:05 INFO - Using env: {'DISPLAY': ':0', 13:15:05 INFO - 'HOME': '/home/cltbld', 13:15:05 INFO - 'LANG': 'en_US.UTF-8', 13:15:05 INFO - 'LANGUAGE': 'en_US:en', 13:15:05 INFO - 'LOGNAME': 'cltbld', 13:15:05 INFO - 'MAIL': '/var/mail/cltbld', 13:15:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:05 INFO - 'MOZ_NO_REMOTE': '1', 13:15:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:05 INFO - 'NO_EM_RESTART': '1', 13:15:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:05 INFO - 'PWD': '/builds/slave/test', 13:15:05 INFO - 'SHELL': '/bin/bash', 13:15:05 INFO - 'SHLVL': '1', 13:15:05 INFO - 'TERM': 'linux', 13:15:05 INFO - 'TMOUT': '86400', 13:15:05 INFO - 'USER': 'cltbld', 13:15:05 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 13:15:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:05 INFO - '_': '/tools/buildbot/bin/python'} 13:15:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:15:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:15:05 INFO - Cleaning up... 13:15:05 INFO - Return code: 0 13:15:05 INFO - Running post-action listener: _resource_record_post_action 13:15:05 INFO - Running post-action listener: _start_resource_monitoring 13:15:05 INFO - Starting resource monitoring. 13:15:05 INFO - [mozharness: 2016-08-31 20:15:05.563640Z] Finished create-virtualenv step (success) 13:15:05 INFO - [mozharness: 2016-08-31 20:15:05.564108Z] Running install step. 13:15:05 INFO - Running pre-action listener: _resource_record_pre_action 13:15:05 INFO - Running main action method: install 13:15:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:15:05 INFO - Reading from file tmpfile_stdout 13:15:05 INFO - Detecting whether we're running mozinstall >=1.0... 13:15:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:15:05 INFO - Reading from file tmpfile_stdout 13:15:05 INFO - Output received: 13:15:05 INFO - Usage: mozinstall [options] installer 13:15:05 INFO - Options: 13:15:05 INFO - -h, --help show this help message and exit 13:15:05 INFO - -d DEST, --destination=DEST 13:15:05 INFO - Directory to install application into. [default: 13:15:05 INFO - "/builds/slave/test"] 13:15:05 INFO - --app=APP Application being installed. [default: firefox] 13:15:05 INFO - mkdir: /builds/slave/test/build/application 13:15:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:15:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:15:22 INFO - Reading from file tmpfile_stdout 13:15:22 INFO - Output received: 13:15:22 INFO - /builds/slave/test/build/application/firefox/firefox 13:15:22 INFO - Running post-action listener: _resource_record_post_action 13:15:22 INFO - [mozharness: 2016-08-31 20:15:22.866488Z] Finished install step (success) 13:15:22 INFO - [mozharness: 2016-08-31 20:15:22.866766Z] Running run-tests step. 13:15:22 INFO - Running pre-action listener: _resource_record_pre_action 13:15:22 INFO - Running main action method: run_tests 13:15:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:15:22 INFO - Python 2.7.3 13:15:22 INFO - Return code: 0 13:15:22 INFO - grabbing minidump binary from tooltool 13:15: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')]} 13:15:22 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 0x14a9370>, '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 0x14ac8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14acd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:15:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:15:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:15:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:15:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:15:22 INFO - Return code: 0 13:15:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:15:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:15:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:15:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:15:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:15:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:15:22 INFO - Using env: {'DISPLAY': ':0', 13:15:22 INFO - 'HOME': '/home/cltbld', 13:15:22 INFO - 'LANG': 'en_US.UTF-8', 13:15:22 INFO - 'LANGUAGE': 'en_US:en', 13:15:22 INFO - 'LOGNAME': 'cltbld', 13:15:22 INFO - 'MAIL': '/var/mail/cltbld', 13:15:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:15:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:15:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:15:22 INFO - 'MOZ_NO_REMOTE': '1', 13:15:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:15:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:15:22 INFO - 'NO_EM_RESTART': '1', 13:15:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:15:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:15:22 INFO - 'PWD': '/builds/slave/test', 13:15:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:15:22 INFO - 'SHELL': '/bin/bash', 13:15:22 INFO - 'SHLVL': '1', 13:15:22 INFO - 'TERM': 'linux', 13:15:22 INFO - 'TMOUT': '86400', 13:15:22 INFO - 'USER': 'cltbld', 13:15:22 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649', 13:15:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:15:22 INFO - '_': '/tools/buildbot/bin/python'} 13:15:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:15:23 INFO - mozversion application_buildid: 20160831103033 13:15:23 INFO - mozversion application_changeset: b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a 13:15:23 INFO - mozversion application_display_name: Nightly 13:15:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:15:23 INFO - mozversion application_name: Firefox 13:15:23 INFO - mozversion application_remotingname: firefox 13:15:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:15:23 INFO - mozversion application_vendor: Mozilla 13:15:23 INFO - mozversion application_version: 51.0a1 13:15:23 INFO - mozversion platform_buildid: 20160831103033 13:15:23 INFO - mozversion platform_changeset: b3ec8a3373e8faca26c39e9ff577a2d4f8b6927a 13:15:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:15:23 INFO - mozversion platform_version: 51.0a1 13:15:23 INFO - using testdate: 1472674523 13:15:23 INFO - actual date: 1472674523 13:15:23 INFO - starting webserver on 'localhost:56404' 13:15:23 INFO - SUITE-START | Running 2 tests 13:15:23 INFO - TEST-START | dromaeo_css 13:15:23 INFO - operating with platform_type : linux_ 13:15:23 INFO - Initialising browser for dromaeo_css test... 13:15:23 INFO - TEST-INFO | started process 25303 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqy_IqJ/profile http://localhost:56404/getInfo.html) 13:15:27 INFO - PROCESS | 25303 | __metrics Screen width/height:1600/1200 13:15:27 INFO - PROCESS | 25303 | colorDepth:24 13:15:27 INFO - PROCESS | 25303 | Browser inner width/height: 1024/697 13:15:27 INFO - PROCESS | 25303 | __metrics 13:15:28 INFO - PROCESS | 25303 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:15:28 INFO - PROCESS | 25303 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:15:28 INFO - PROCESS | 25303 | console.error: PushService: 13:15:28 INFO - PROCESS | 25303 | stateChangeProcessEnqueue: Error transitioning state 13:15:28 INFO - PROCESS | 25303 | UnknownError 13:15:29 INFO - TEST-INFO | 25303: exit 0 13:15:29 INFO - Browser initialized. 13:15:29 INFO - Running cycle 1/1 for dromaeo_css test... 13:15:29 INFO - TEST-INFO | started process 25386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqy_IqJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:15:41 INFO - PROCESS | 25386 | RSS: Main: 180219904 13:15:41 INFO - PROCESS | 25386 | 13:16:33 INFO - PROCESS | 25386 | 1472674593167 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:18:42 INFO - PROCESS | 25386 | Cycle 1(1): loaded http://localhost:56404/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56404/tests/dromaeo/cssquery-ext.html) 13:18:43 INFO - PROCESS | 25386 | RSS: Main: 351399936 13:18:43 INFO - PROCESS | 25386 | 13:21:46 INFO - PROCESS | 25386 | Cycle 1(1): loaded http://localhost:56404/tests/dromaeo/cssquery-ext.html (next: http://localhost:56404/tests/dromaeo/cssquery-jquery.html) 13:21:47 INFO - PROCESS | 25386 | RSS: Main: 277131264 13:21:47 INFO - PROCESS | 25386 | 13:24:49 INFO - PROCESS | 25386 | Cycle 1(1): loaded http://localhost:56404/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56404/tests/dromaeo/cssquery-mootools.html) 13:24:49 INFO - PROCESS | 25386 | RSS: Main: 213966848 13:24:49 INFO - PROCESS | 25386 | 13:27:52 INFO - PROCESS | 25386 | Cycle 1(1): loaded http://localhost:56404/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56404/tests/dromaeo/cssquery-prototype.html) 13:27:52 INFO - PROCESS | 25386 | RSS: Main: 244150272 13:27:52 INFO - PROCESS | 25386 | 13:30:55 INFO - PROCESS | 25386 | Cycle 1(1): loaded http://localhost:56404/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56404/tests/dromaeo/cssquery-yui.html) 13:30:55 INFO - PROCESS | 25386 | RSS: Main: 214073344 13:30:55 INFO - PROCESS | 25386 | 13:33:58 INFO - PROCESS | 25386 | Cycle 1(1): loaded http://localhost:56404/tests/dromaeo/cssquery-yui.html (next: http://localhost:56404/tests/dromaeo/cssquery-dojo.html) 13:33:58 INFO - PROCESS | 25386 | RSS: Main: 301727744 13:33:58 INFO - PROCESS | 25386 | 13:33:58 INFO - PROCESS | 25386 | __start_tp_report 13:33:58 INFO - PROCESS | 25386 | _x_x_mozilla_page_load 13:33:58 INFO - PROCESS | 25386 | _x_x_mozilla_page_load_details 13:33:58 INFO - PROCESS | 25386 | |i|pagename|runs| 13:33:58 INFO - PROCESS | 25386 | |0;dojo.html;3037.195143287029;3044.101989912976;3070.4319700855335;3094.5822313987605;3113.408452394045;5365.946340536593;5367.355917289926;5433.293671822657;5487.259220005298;5489.423610520893;5342.2253773202865;5346.91979620306;5358.03555360036;5362.8123015694455;5438.592105592076;4799.136155492001;4833.347498087748;4878.878028049309;4882.6826256293225;5049.747512624373;4975.9004819903585;5019.64862459628;5020.146575082226;5035.068512325213;5038.59691224703;4775.832845850396;4864.124457597631;4872.853814385574;4908.460069392364;4924.926126108094;4781.665283430161;4817.494163112858;4970.304157417964;4970.428400733889;4985.501449855022;4790.209615413452;4809.735464549449;4823.614110871122;4829.661923665345;4882.584980276681;5241.42344342122;5347.278117454132;5360.705161216131;5371.248025276464;5380.488853558905;5547.833564993016;5633.239512665778;5674.404187560329;5680.176374425727;5701.77192912283;5671.291088613923;5711.62874413166;5716.1425786131995;5717.628354156966;5731.226284451587;5331.280277162611;5335.733213339317;5337.066013447631;5348;5389.9191512127345;5937.732802023919;6044.486218671462;6050.45545900871;6053.909191362133;6057.273127224761;5745.942540574624;5749.8275051748515;5752.395998420189;5753.108268218432;5808.419158084158;5607.158926161109;5666.97166514173;5792.247007888947;5802.448767367094;5802.47777700009;5698.686572238566;5740.598158128974;5744.052231381859;5778.624389414675;5809.970950145223;5703.600747947604;5744.51171650406;5746.166805813217;5748.252727145528;5769.653820770767;4400.559944005574;4400.73595584266;4436.534163912807;4467.352233926063;4500.819967201275;4000.2799496090984;4017.2367250222946;4046.0289530512464;4064.227796718614;4067.5525692173837;5549.889002220014;5561.749721262472;5562.3881373048935;5563.8887222256135;5565.805196818092;5572.916406253909;5770.19217309577;5875.50058245054;5887.411258874164;5889.234399528034;5484.149956756709;5525.060739674265;5532.5020748132865;5570.359408667974;5577.749001294951;5012.373453318335;5024.472430394829;5025.623078269071;5030.2957585938;5083.288339632454;5844.883102338014;5854.4730974212525;6006.909896351558;6012.549058820606;6021.789237376671;5725.34158571753;5788.884222315446;5796.913046304393;5836.212111364912;5857.824265272048;5915.674637894957;5922.407759224043;5925.229720136354;5926.644401335933;5940.910886336622;5511.53151982086;5563.165525171256;5607.102863541813;5704.372519022987;5717.056685646821;5669.858253543694;5699.857503562444;5702.344230413555;5704.572157088152;5710.543156547383;5597.80407685729;5607.102863541813;5655.462731040545;5684.545236381162;5750.223719797941;5649.378568357395;5650.378458369658;5655;5658.236138121301;5663.858403539944;5603.579731520071;5626.915596265977;5649.180868773922;5656.85857853557;5657.12314591239;5556.333240011225;5783.306003279633;5832.795852145155;5855.151003104441;5869.501092407193;5423.376311724044;5676.943230567642;5677.375488696158;5680.176374425768;5687.516561092353 13:33:58 INFO - PROCESS | 25386 | |1;ext.html;533.1116552665106;580.4601720400028;597.5219824140686;629.9464545513631;632.3865850125379;41766.79116604417;43407.56592434075;43441.34837977425;43508.3473747894;46170;44306.77846610762;44630;44637.33044004334;44733.77633111838;44820;8953.641854325835;9052.411593246417;9096.40873343234;9103.54482275887;9107.180353768159;8868.467891926473;8944.329175311845;8953;8953.283737301033;8955.19403253707;8744.562771861414;8761.386702930766;8777.692780752675;8779.736607901774;8784.077671844429;8922.330825188104;8964.59659315326;8965.596548155316;8969.686060987899;8972.730818075468;8923.375363724543;8986.236169925563;8990.100989901022;9000.369974101815;9004.234640055603;35018.82490587556;35051.4742278866;35285;35289.82355088208;35322.823385883166;3386.373520898617;3464.9133771655656;3583.695385892176;3646.2342907989355;3772.5284339457567;27796.861015694994;27943.720562794315;28009.71990280112;28034.299142521395;28429.57355639667;3815.2560250751117;3898.961010389888;3907.5701672815967;4037.1723796621623;4066.430699702044;350978;351703;352045;352382;352768;35330.29339413197;35672.64327356745;55481.72259138679;55748.44251557514;55802.441975580536;31756.206094847814;31928.521072183936;31964;32043.51934720981;32055;13750.793738093937;13800.723985520433;13808.240546769823;13831.377588008563;13903.582892513241;12352.44414001372;12406.13157079014;12423.068269879795;12427;12449.190802597803;7631.1605723370385;7635.465517413728;7715.614219289013;7734.342580880688;7737.497062690907;3321.1199032256472;3371.174062354739;3384.6953774160443;3389.8305084745666;3434.690877821008;961.3030552849128;998.5756053677159;1060.2525219720078;1065.7069305940772;1129.8192289233684;30808.752236538505;31231.531527027113;31477.8426107868;31502.84248578788;31837;845.4673555659895;1009.5709323537467;1047.6542740895486;1063.5426766490484;1093.5625749700184;15261.389544418322;16226.188690565425;16286.837131628532;16323.836761632232;16643.41748038837;535175;537030;537128;537723;540680;43212.3518147228;43319.566804332186;43341.349879751826;43377.132457351305;43593.346099807895;1249.0819247852821;1330.0623060742153;1361.6800051987775;1367.3505085084505;1374.9587512374644;25983.480330392907;26916.596251056642;27616.033438829545;27693.86153069222;28104.85947570249;39304.213915722095;39816.800915995234;40011.399829002;40167;40181;373028;376808;376832;377691;502372;27877.86061069682;40469;43081;43446.565534345515;44022.77988610036;37862.24275514529;37949.43075853809;38218.617813821504;38832.80583597064;47412.52587474081;37378.8131059343;40672.1865562693;40937.385939211534;41862;42020.15959680728;40357.798211008754;40676.59323406728;40795.98010049773;41985.58014419817;42187;33285.50071748974;33394.16514587155;33426.33147337088;35556.111097222776;37904.81047594855;34209.65790342164;36471.63528364682;36827.447588286734;37040.44439333466;37523.43714844334;24035.158769442987;24127.396815079763;24168.758312417354;24714.629280560446;24852 13:33:58 INFO - PROCESS | 25386 | |2;jquery.html;364.1696930997327;388.1654442947662;409.1101853468705;414.3081054638753;416.27568031624963;12612.180208286454;16779.664406711858;20007;20108.296209632666;20228.39314820556;18623.348182813603;18863.528411789714;19204;20027.098780554872;21175.682364764503;6420.614763114205;6420.903686444695;6607.306232845554;6678.465722742193;6686.231083425396;4738.9526104739025;6528.902066469007;6627.37039981201;6627.668616569176;7146.964265178693;7401.481896267263;7588.392928565729;7604.239576042379;7604.581748003858;7611.733589324374;7369.926300736977;7551.207123252062;7578.166401695809;7588.165301816795;7601.6579253933705;7040.5071644984355;7273.818154546126;7295.52579082358;7327.157376901671;7360.374368178711;24583.87708061466;26226.737732622812;26260.212193634223;26279;26290.6056409154;2618.423946731716;3187.8406079695924;3237.6438591754886;3334.5665063541583;3337.0656216259486;11061.446927653586;16527.173641318008;16537.83462165375;16807.747883781754;16945.830541694548;2043.9386818395471;2049.7130401743766;2091.0799248330836;2130.5312831177116;2159.9244026459;99275.50362248142;100080.49959750155;102800.48599756953;102892.48553757183;103756;17536.91231543834;17764.822351776576;17839.73240401395;18178.636427271646;18300;31490;31581;31601.84199079036;31654.36691266162;31760.68239317577;9855.408675479352;10099.242556808269;10101.848472272923;10193.439360835077;10450.634227801991;8463.195996380335;8529.616167272488;8531.658733650584;8662.82674346522;8762.123787621314;8412.705555305534;8666.913330866611;8686.478811271343;8727.825443491094;8786.489580722931;3208.5828842250826;3290.851911663981;3301.5212794144713;3309.420851351004;3586.516853932584;885.4112015509743;917.3165991336497;964.238251781099;993.6224234790877;1048.234788604323;17787.19957601911;19182.424527264204;19679.90160049219;19697.522685798624;19713.40859774209;913.853783394667;950.201482513305;955.3455882720359;988.5749127874939;997.152420442618;9823.803523929482;10192.541335639915;10650.520726567323;10729.570817167227;10815.459227038617;467458;470497;472015;480775;491901;84396.57801710952;92212.21539286358;95018.04981950091;99619;100952.49523752334;1007.9949600251952;1019.9031092046243;1045.994770026145;1063.4895250279908;1083.6748975307535;17097.230624621672;17318;17844.28622855071;18267.634647306713;18495.90752046231;42552.57447425486;42916.30492271168;43423;43983.340249896915;44321.55678443174;54835.72582137064;54877;57516.42483575278;61800.381996179465;63651;7645.541267523967;7650.387968962581;7712.730054448068;8106.756797296091;8165.38759593021;11446.713832154262;12987.545435909698;13240.668983275495;13381.866181338451;13584.93207533956;11070.114390848552;11186.944065279622;11569.942150289195;11719.179657423898;11844.70388240301;5655.971720141373;8274.965629296337;10849.240553161202;11074.390908499787;11078.778424431304;11439.14206434504;11447.141464390037;11697.766044679229;11821.29072255633;11846.526138954345;7639.701250787491;7689.115751688628;7746.535207887545;7918.208179182036;8230.892037517366;9684.225261979165;11434.371109589052;11647.534098636299;11910.583129590423;11926.701832454259 13:33:58 INFO - PROCESS | 25386 | |3;mootools.html;1231.2858542045615;1307.6207899709084;1334.2261488336765;1396.0158088547576;1508.675634738531;8517.701880434179;8887.64449422023;8893.421927574704;9175.816483670322;9186.173244408003;9016.54917254138;9121.133492318235;9158.358914875944;9200.677976270816;9226.584803683834;2391.031632188962;2416.1664225842055;2418.9274321770376;2440.670509481215;2443.609022556391;2343.5547246023284;2375.893084811179;2410.7950824179966;2411.228406909781;2411.2645643078854;2382.95234095318;2398.760123987605;2399.7960173385195;2408.0728919365997;2413.5414271288487;2320.4082958845556;2344.4256157241416;2348.283773449097;2350.4123969007746;2363.4800343924308;2229.297771202066;2254.9210777622707;2288.1533832482087;2293.9655905161435;2302.7927486526128;8584.05575386707;8816.823663526759;8935.151160639729;8942.150495702897;8942.195202431747;5038.874028149289;5209.453007434241;5254.737263136828;5267.841964741064;5271.262023316739;3324.2852786650747;3460.602030766469;3479.0954351868445;3528.6824185823143;3533.4346504559403;1122.7361570031037;1160.6866146140494;1178.181164090957;1179.151011271883;1180.811070228768;12508.186967847152;12521;12565.18326308787;12585.433655485525;12587.118901676979;4343.1530851484285;4475.149721552894;4614.353990441341;4638.5593368629925;4646.767661616906;9643.758906027406;9668.226541876633;9672.70981870545;9683.128518433234;9693.903060969442;5133.435322114565;5165.74171291434;5169.431362550116;5170.97414512925;5171.844844654666;4228.471441069866;4529.569690879362;4619.653525985565;4657.394538709946;4836.685615434985;3902.5902280260166;3918.1380096378753;4012.7592344459426;4044.5753195914594;4080.2859499587453;1192.2369683402628;1200.3278164227886;1210.449245593253;1220.5727995201787;1233.660743295601;839.5424493650975;845.9383473740417;864.1358641358642;937.386012162035;944.9905500944902;5905.7932972346625;5945.64326140433;6274.1843560337775;6446.419822216023;6612.206535215709;934.5841100710119;1017.9185665146771;1020.7699721835171;1023.0945613132283;1033.4419413516766;3894.5131858517684;3932.623581746423;3967.1668949520345;4044.656204222615;4118.299889018874;10705.625303114353;11479.483423245974;11508.769824603462;11549.88450115505;11594.710132246593;11263.211575189822;11463.426828658534;11487.415331550334;11488.597899073493;11494.712632184095;8370.414071015091;8566.3146948244;8577.05652378238;8582.570871456526;8592.65629374818;5719.885602287848;5740.971295143498;5792.913106303325;5805.622634528742;5945.227120474311;10366.481675916324;10411;10509;10623.256372053882;10653.934606539284;10205.234607404325;10649.680509584725;10665;10864.185186111232;10960.56157753681;7121.252268511732;7197.604131772803;7279.381252593377;7600.885986710315;7753.340966017951;8016.198380161937;8155.755327340189;8157.79605509867;8195.057568379474;8207.302379297827;7438.114884163921;7637.88543171864;7691.50005249657;7701.922980770345;7787.805304867197;7429.368503677248;7704.845903081795;7842.686292548462;7881.054273487218;8033.758987230392;7043.154821421463;7155.212926578176;7167.068281123421;7168.24733403006;7168.4265258780215;5187.922181167361;5190.247414124855;5277.815276465305;5328.3605967284175;5509.834704958857;5079.898402031865;5144.614153938544;5199.29809475716;5257.8159764408065;5351.438098999549 13:33:58 INFO - PROCESS | 25386 | |4;prototype.html;319.08900090242355;334.19792498004784;334.82254405165264;335.3962866839688;336.4532634468988;5029.547340739333;5102;5133.255677926699;5202.294806700514;5231.529162375381;5116.2627994023205;5128.153854613994;5145.202493613487;5147.897042059157;5168.095583272921;4027.9597204028023;4034.415009823581;4038.9805097451276;4050;4087;3848;3990.8603198888045;4080.2655522006025;4080.7551546907134;4094.3653733671326;4066.9186616267657;4068.613481719247;4071.877843664695;4080.204360149772;4097.569755175693;4040.6767458603535;4049.5140583130215;4054.837806487737;4071.7377612939786;4078.8164532596106;3620.113072297304;3622.601513833476;3641.6540428659237;3650.251698401848;3655;4887.458521568764;5006.249062640597;5010.398752149729;5011.594434671378;5014.373203349582;4602.815887364535;4617.7691115444095;4617.8383756568355;4628.629709623222;4653.930191047137;5286.392064912546;5316.574674026068;5347.572194224453;5355.410904800468;5365.3293338332705;3689.520362352877;3910.667593254577;3919.412088186766;3923.9607603923882;3956.307646161939;5567.164925261243;5577.8605534861545;5584.888302233932;5596.761295481799;5616.652003519167;4001.3997900315185;4019.1157945252;4023.6177563131455;4027.375756757707;4033.3748269018347;3990.7605543667473;4049.311617025113;4061.411095391211;4076.164386300801;4079.73481723687;4600.079984003146;4604.848787803049;4626.421697287839;4630.814767409266;4633.166030114612;5379.359295414858;5379.67721936685;5380.569554435636;5383.353997520244;5455.754491047913;1365.6275443179738;1397.6855207578417;1408.084744915813;1414.8893118901613;1420.3111490926892;904.2810965282616;914.346242436661;935.3873213045466;945.5036106044382;946.6639343033262;4577.8397756078375;4580.7938642761155;4639.608117564717;4696.201645720235;4721.6694831362165;4804.51060171348;4820.421549414093;4827.503473923095;4828.275758636232;4829.9275510867365;4544.727316361029;4564.292534657134;4584.908301833944;4643.233866412072;4652.371669915503;2765.5298599238176;2965.7395606866994;2976.300569366197;2985.1939976206304;2993.5060714981782;5766.711664416763;5774.451427114502;5786.553361659585;5789.247397838254;5805.274340707411;5474.479924407175;5663.66018038919;5696.82909512707;5744.655320680772;5764.682942438122;5651.180578816131;5669.43305669438;5682.403347648437;5691;5700.144978253295;5526.457829398521;5550.251670723709;5568.693721845338;5596.972015139898;5628.324601047901;5299.814506492255;5487.5609951203005;5538.169274608841;5543.473370029841;5545.611807173459;5730.5129064030025;5758.654480731169;5764.250647415977;5768.567357448124;5780.826575202583;3848.6138594070735;4029.717919745707;4032.2459730017536;4035.7174997749876;4073.694472914484;5139.717315547531;5179.948200517946;5527.088030474926;5542.695151766691;5544.916826247529;5381.273528073816;5404.621676482609;5429.049916264559;5444.50999410055;5453.918191227214;5185.714711226271;5353.661584603849;5405.702686352131;5420.753226757789;5456.508914197741;5298.470152984671;5317.5214230717875;5333.7333133343955;5341.198820177005;5361.498780341511;5425.972870135624;5457.645253058538;5473.808416705396;5524.1989911463415;5525.502704756591;5126.256692779451;5358.33020872391;5377.489138531833;5399.487048730364;5405 13:33:58 INFO - PROCESS | 25386 | |5;yui.html;800.523688405399;805.9516429014263;813.7111325479455;816.1960468938095;825.5418242875202;14578.489752858652;15415.306311216022;15659;15713.135777532245;15741.842581574181;14849.851501484982;14889.181095039796;14968.32642531086;14971.550853474386;15024.17367044812;761.7448154868111;796.8884356190109;807.1363640904235;809.6639894443799;809.76112046946;540.9486098820606;550.9118541033436;556.2796178948252;663.3466035954605;803.4737247103157;835.0230230630177;836.1304243586662;836.7824365664941;842.465034702965;844.2570537926616;833.8874251976027;834.6619619054293;834.8121672623672;835.2691395029349;836.8912041434605;505.63846849502784;605.7576969212306;615.9507239420835;617.688067525901;621.987560248797;14569.927150364181;14598.562043138723;14633.634159146;14641.41434342625;14650.267486625733;12961.870381296161;13140.802887956592;13540.729185416236;13891.513797017156;14064.22646754428;13044.86955130446;13056.151350162208;13268.601941941757;13398;13490.595282141454;4381.737095774264;4389.582989615981;4442.555744425564;4463.620592249663;4644.698094623838;82324;82747;83701.58149209277;85908.97274381592;87104;11084.113270938306;11102;11106.777864442665;11126.721831954104;11383.373914434786;21196.89401553013;21283;21300.25449109274;21392.465188370104;21446.24938127158;8173.591320434073;8196.959015204886;8242.835143297101;8383;8493.023302320313;4444.333349997526;4541.296099104644;4543;4676.8129274828625;4747.95252047482;3170.476871316207;3294.3081952789703;3296.258341873059;3297.554830097954;3299.0762586475826;579.6493121661418;584.8888711144868;587.700272860844;588.0825911577866;590.400743245606;520.8723862653674;604.1210039392673;608.3004544773546;627.2848952194502;672.3411057164006;9463.290253231035;9632.133108020313;9667.178289845442;10408.531616077295;10622.57445764503;645.9515536334794;666.5434177588368;693.9548929319578;720.935115839577;722.1298335505703;4679.906401871944;5228.869278267997;5409.83770486886;5483.4516548344845;5514.696691681996;115408.42295788467;117195;117922.41038794752;121234.3938280303;123168;102266;104747;105016;105700;110288.48557572089;87305.56347218351;89970.99999999869;91388.54305728429;94800.52599736956;95404;9603.519824008632;10158.949205253926;10407.895921040692;10419.635312764018;10461.529231184462;51394.74302628463;51685;51707.224391633405;52961;52994;74156;74252.2574774267;80617.59691201507;81500.18499815163;81825;12105.878941210474;12272.938635306766;12551.3096779678;12583.496660133493;12898.290594017419;14436.278186090864;14477.927610361881;14652.26738663084;14669.706605868036;14832.555023349316;13019.544315948897;13151.868481315065;13569.592912212649;13652.726945461234;14089.295535223402;13635.522756703467;13701;13730.794038089236;14103.506377277157;14602.707945841235;12993.067117262479;13114.934425328194;13344.399502022237;13757.243351615758;13785.379657915619;10780.568777248822;10794.298370605886;11141.16441266892;11351.772964540829;11352;10921.508532116233;11093;11136.49885755159;11341.886581134084;11385.943070284595 13:33:58 INFO - PROCESS | 25386 | __end_tp_report 13:33:58 INFO - PROCESS | 25386 | __start_cc_report 13:33:58 INFO - PROCESS | 25386 | _x_x_mozilla_cycle_collect,1477 13:33:58 INFO - PROCESS | 25386 | __end_cc_report 13:33:58 INFO - PROCESS | 25386 | __startTimestamp1472675638988__endTimestamp 13:33:59 INFO - PROCESS | 25386 | 13:33:59 INFO - PROCESS | 25386 | ------- Summary: start ------- 13:33:59 INFO - PROCESS | 25386 | Number of tests: 6 13:33:59 INFO - PROCESS | 25386 | 13:33:59 INFO - PROCESS | 25386 | [#0] dojo.html Cycles:165 Average:5370.13 Median:5603.58 stddev:609.16 (10.9%) stddev-sans-first:582.89 13:33:59 INFO - PROCESS | 25386 | Values: 3037.2 3044.1 3070.4 3094.6 3113.4 5365.9 5367.4 5433.3 5487.3 5489.4 5342.2 5346.9 5358.0 5362.8 5438.6 4799.1 4833.3 4878.9 4882.7 5049.7 4975.9 5019.6 5020.1 5035.1 5038.6 4775.8 4864.1 4872.9 4908.5 4924.9 4781.7 4817.5 4970.3 4970.4 4985.5 4790.2 4809.7 4823.6 4829.7 4882.6 5241.4 5347.3 5360.7 5371.2 5380.5 5547.8 5633.2 5674.4 5680.2 5701.8 5671.3 5711.6 5716.1 5717.6 5731.2 5331.3 5335.7 5337.1 5348.0 5389.9 5937.7 6044.5 6050.5 6053.9 6057.3 5745.9 5749.8 5752.4 5753.1 5808.4 5607.2 5667.0 5792.2 5802.4 5802.5 5698.7 5740.6 5744.1 5778.6 5810.0 5703.6 5744.5 5746.2 5748.3 5769.7 4400.6 4400.7 4436.5 4467.4 4500.8 4000.3 4017.2 4046.0 4064.2 4067.6 5549.9 5561.7 5562.4 5563.9 5565.8 5572.9 5770.2 5875.5 5887.4 5889.2 5484.1 5525.1 5532.5 5570.4 5577.7 5012.4 5024.5 5025.6 5030.3 5083.3 5844.9 5854.5 6006.9 6012.5 6021.8 5725.3 5788.9 5796.9 5836.2 5857.8 5915.7 5922.4 5925.2 5926.6 5940.9 5511.5 5563.2 5607.1 5704.4 5717.1 5669.9 5699.9 5702.3 5704.6 5710.5 5597.8 5607.1 5655.5 5684.5 5750.2 5649.4 5650.4 5655.0 5658.2 5663.9 5603.6 5626.9 5649.2 5656.9 5657.1 5556.3 5783.3 5832.8 5855.2 5869.5 5423.4 5676.9 5677.4 5680.2 5687.5 13:33:59 INFO - PROCESS | 25386 | 13:33:59 INFO - PROCESS | 25386 | [#1] ext.html Cycles:180 Average:56406.14 Median:37927.12 stddev:116666.26 (307.6%) stddev-sans-first:116918.12 13:33:59 INFO - PROCESS | 25386 | Values: 533.1 580.5 597.5 629.9 632.4 41766.8 43407.6 43441.3 43508.3 46170.0 44306.8 44630.0 44637.3 44733.8 44820.0 8953.6 9052.4 9096.4 9103.5 9107.2 8868.5 8944.3 8953.0 8953.3 8955.2 8744.6 8761.4 8777.7 8779.7 8784.1 8922.3 8964.6 8965.6 8969.7 8972.7 8923.4 8986.2 8990.1 9000.4 9004.2 35018.8 35051.5 35285.0 35289.8 35322.8 3386.4 3464.9 3583.7 3646.2 3772.5 27796.9 27943.7 28009.7 28034.3 28429.6 3815.3 3899.0 3907.6 4037.2 4066.4 350978.0 351703.0 352045.0 352382.0 352768.0 35330.3 35672.6 55481.7 55748.4 55802.4 31756.2 31928.5 31964.0 32043.5 32055.0 13750.8 13800.7 13808.2 13831.4 13903.6 12352.4 12406.1 12423.1 12427.0 12449.2 7631.2 7635.5 7715.6 7734.3 7737.5 3321.1 3371.2 3384.7 3389.8 3434.7 961.3 998.6 1060.3 1065.7 1129.8 30808.8 31231.5 31477.8 31502.8 31837.0 845.5 1009.6 1047.7 1063.5 1093.6 15261.4 16226.2 16286.8 16323.8 16643.4 535175.0 537030.0 537128.0 537723.0 540680.0 43212.4 43319.6 43341.3 43377.1 43593.3 1249.1 1330.1 1361.7 1367.4 1375.0 25983.5 26916.6 27616.0 27693.9 28104.9 39304.2 39816.8 40011.4 40167.0 40181.0 373028.0 376808.0 376832.0 377691.0 502372.0 27877.9 40469.0 43081.0 43446.6 44022.8 37862.2 37949.4 38218.6 38832.8 47412.5 37378.8 40672.2 40937.4 41862.0 42020.2 40357.8 40676.6 40796.0 41985.6 42187.0 33285.5 33394.2 33426.3 35556.1 37904.8 34209.7 36471.6 36827.4 37040.4 37523.4 24035.2 24127.4 24168.8 24714.6 24852.0 13:33:59 INFO - PROCESS | 25386 | 13:33:59 INFO - PROCESS | 25386 | [#2] jquery.html Cycles:180 Average:30494.06 Median:3296.19 stddev:78992.56 (2396.5%) stddev-sans-first:79181.76 13:33:59 INFO - PROCESS | 25386 | Values: 364.2 388.2 409.1 414.3 416.3 12612.2 16779.7 20007.0 20108.3 20228.4 18623.3 18863.5 19204.0 20027.1 21175.7 6420.6 6420.9 6607.3 6678.5 6686.2 4739.0 6528.9 6627.4 6627.7 7147.0 7401.5 7588.4 7604.2 7604.6 7611.7 7369.9 7551.2 7578.2 7588.2 7601.7 7040.5 7273.8 7295.5 7327.2 7360.4 24583.9 26226.7 26260.2 26279.0 26290.6 2618.4 3187.8 3237.6 3334.6 3337.1 11061.4 16527.2 16537.8 16807.7 16945.8 2043.9 2049.7 2091.1 2130.5 2159.9 99275.5 100080.5 102800.5 102892.5 103756.0 17536.9 17764.8 17839.7 18178.6 18300.0 31490.0 31581.0 31601.8 31654.4 31760.7 9855.4 10099.2 10101.8 10193.4 10450.6 8463.2 8529.6 8531.7 8662.8 8762.1 8412.7 8666.9 8686.5 8727.8 8786.5 3208.6 3290.9 3301.5 3309.4 3586.5 885.4 917.3 964.2 993.6 1048.2 17787.2 19182.4 19679.9 19697.5 19713.4 913.9 950.2 955.3 988.6 997.2 9823.8 10192.5 10650.5 10729.6 10815.5 467458.0 470497.0 472015.0 480775.0 491901.0 84396.6 92212.2 95018.0 99619.0 100952.5 1008.0 1019.9 1046.0 1063.5 1083.7 17097.2 17318.0 17844.3 18267.6 18495.9 42552.6 42916.3 43423.0 43983.3 44321.6 54835.7 54877.0 57516.4 61800.4 63651.0 7645.5 7650.4 7712.7 8106.8 8165.4 11446.7 12987.5 13240.7 13381.9 13584.9 11070.1 11186.9 11569.9 11719.2 11844.7 5656.0 8275.0 10849.2 11074.4 11078.8 11439.1 11447.1 11697.8 11821.3 11846.5 7639.7 7689.1 7746.5 7918.2 8230.9 9684.2 11434.4 11647.5 11910.6 11926.7 13:33:59 INFO - PROCESS | 25386 | 13:33:59 INFO - PROCESS | 25386 | [#3] mootools.html Cycles:180 Average:5853.24 Median:4642.66 stddev:3383.22 (72.9%) stddev-sans-first:3374.87 13:33:59 INFO - PROCESS | 25386 | Values: 1231.3 1307.6 1334.2 1396.0 1508.7 8517.7 8887.6 8893.4 9175.8 9186.2 9016.5 9121.1 9158.4 9200.7 9226.6 2391.0 2416.2 2418.9 2440.7 2443.6 2343.6 2375.9 2410.8 2411.2 2411.3 2383.0 2398.8 2399.8 2408.1 2413.5 2320.4 2344.4 2348.3 2350.4 2363.5 2229.3 2254.9 2288.2 2294.0 2302.8 8584.1 8816.8 8935.2 8942.2 8942.2 5038.9 5209.5 5254.7 5267.8 5271.3 3324.3 3460.6 3479.1 3528.7 3533.4 1122.7 1160.7 1178.2 1179.2 1180.8 12508.2 12521.0 12565.2 12585.4 12587.1 4343.2 4475.1 4614.4 4638.6 4646.8 9643.8 9668.2 9672.7 9683.1 9693.9 5133.4 5165.7 5169.4 5171.0 5171.8 4228.5 4529.6 4619.7 4657.4 4836.7 3902.6 3918.1 4012.8 4044.6 4080.3 1192.2 1200.3 1210.4 1220.6 1233.7 839.5 845.9 864.1 937.4 945.0 5905.8 5945.6 6274.2 6446.4 6612.2 934.6 1017.9 1020.8 1023.1 1033.4 3894.5 3932.6 3967.2 4044.7 4118.3 10705.6 11479.5 11508.8 11549.9 11594.7 11263.2 11463.4 11487.4 11488.6 11494.7 8370.4 8566.3 8577.1 8582.6 8592.7 5719.9 5741.0 5792.9 5805.6 5945.2 10366.5 10411.0 10509.0 10623.3 10653.9 10205.2 10649.7 10665.0 10864.2 10960.6 7121.3 7197.6 7279.4 7600.9 7753.3 8016.2 8155.8 8157.8 8195.1 8207.3 7438.1 7637.9 7691.5 7701.9 7787.8 7429.4 7704.8 7842.7 7881.1 8033.8 7043.2 7155.2 7167.1 7168.2 7168.4 5187.9 5190.2 5277.8 5328.4 5509.8 5079.9 5144.6 5199.3 5257.8 5351.4 13:33:59 INFO - PROCESS | 25386 | 13:33:59 INFO - PROCESS | 25386 | [#4] prototype.html Cycles:180 Average:4515.50 Median:5065.77 stddev:1312.29 (25.9%) stddev-sans-first:1277.61 13:33:59 INFO - PROCESS | 25386 | Values: 319.1 334.2 334.8 335.4 336.5 5029.5 5102.0 5133.3 5202.3 5231.5 5116.3 5128.2 5145.2 5147.9 5168.1 4028.0 4034.4 4039.0 4050.0 4087.0 3848.0 3990.9 4080.3 4080.8 4094.4 4066.9 4068.6 4071.9 4080.2 4097.6 4040.7 4049.5 4054.8 4071.7 4078.8 3620.1 3622.6 3641.7 3650.3 3655.0 4887.5 5006.2 5010.4 5011.6 5014.4 4602.8 4617.8 4617.8 4628.6 4653.9 5286.4 5316.6 5347.6 5355.4 5365.3 3689.5 3910.7 3919.4 3924.0 3956.3 5567.2 5577.9 5584.9 5596.8 5616.7 4001.4 4019.1 4023.6 4027.4 4033.4 3990.8 4049.3 4061.4 4076.2 4079.7 4600.1 4604.8 4626.4 4630.8 4633.2 5379.4 5379.7 5380.6 5383.4 5455.8 1365.6 1397.7 1408.1 1414.9 1420.3 904.3 914.3 935.4 945.5 946.7 4577.8 4580.8 4639.6 4696.2 4721.7 4804.5 4820.4 4827.5 4828.3 4829.9 4544.7 4564.3 4584.9 4643.2 4652.4 2765.5 2965.7 2976.3 2985.2 2993.5 5766.7 5774.5 5786.6 5789.2 5805.3 5474.5 5663.7 5696.8 5744.7 5764.7 5651.2 5669.4 5682.4 5691.0 5700.1 5526.5 5550.3 5568.7 5597.0 5628.3 5299.8 5487.6 5538.2 5543.5 5545.6 5730.5 5758.7 5764.3 5768.6 5780.8 3848.6 4029.7 4032.2 4035.7 4073.7 5139.7 5179.9 5527.1 5542.7 5544.9 5381.3 5404.6 5429.0 5444.5 5453.9 5185.7 5353.7 5405.7 5420.8 5456.5 5298.5 5317.5 5333.7 5341.2 5361.5 5426.0 5457.6 5473.8 5524.2 5525.5 5126.3 5358.3 5377.5 5399.5 5405.0 13:33:59 INFO - PROCESS | 25386 | 13:33:59 INFO - PROCESS | 25386 | [#5] yui.html Cycles:180 Average:21617.25 Median:3840.41 stddev:31748.89 (826.7%) stddev-sans-first:31799.48 13:33:59 INFO - PROCESS | 25386 | Values: 800.5 806.0 813.7 816.2 825.5 14578.5 15415.3 15659.0 15713.1 15741.8 14849.9 14889.2 14968.3 14971.6 15024.2 761.7 796.9 807.1 809.7 809.8 540.9 550.9 556.3 663.3 803.5 835.0 836.1 836.8 842.5 844.3 833.9 834.7 834.8 835.3 836.9 505.6 605.8 616.0 617.7 622.0 14569.9 14598.6 14633.6 14641.4 14650.3 12961.9 13140.8 13540.7 13891.5 14064.2 13044.9 13056.2 13268.6 13398.0 13490.6 4381.7 4389.6 4442.6 4463.6 4644.7 82324.0 82747.0 83701.6 85909.0 87104.0 11084.1 11102.0 11106.8 11126.7 11383.4 21196.9 21283.0 21300.3 21392.5 21446.2 8173.6 8197.0 8242.8 8383.0 8493.0 4444.3 4541.3 4543.0 4676.8 4748.0 3170.5 3294.3 3296.3 3297.6 3299.1 579.6 584.9 587.7 588.1 590.4 520.9 604.1 608.3 627.3 672.3 9463.3 9632.1 9667.2 10408.5 10622.6 646.0 666.5 694.0 720.9 722.1 4679.9 5228.9 5409.8 5483.5 5514.7 115408.4 117195.0 117922.4 121234.4 123168.0 102266.0 104747.0 105016.0 105700.0 110288.5 87305.6 89971.0 91388.5 94800.5 95404.0 9603.5 10158.9 10407.9 10419.6 10461.5 51394.7 51685.0 51707.2 52961.0 52994.0 74156.0 74252.3 80617.6 81500.2 81825.0 12105.9 12272.9 12551.3 12583.5 12898.3 14436.3 14477.9 14652.3 14669.7 14832.6 13019.5 13151.9 13569.6 13652.7 14089.3 13635.5 13701.0 13730.8 14103.5 14602.7 12993.1 13114.9 13344.4 13757.2 13785.4 10780.6 10794.3 11141.2 11351.8 11352.0 10921.5 11093.0 11136.5 11341.9 11385.9 13:33:59 INFO - PROCESS | 25386 | -------- Summary: end -------- 13:33:59 INFO - PROCESS | 25386 | 13:33:59 INFO - TEST-INFO | 25386: exit 0 13:33:59 INFO - TEST-OK | dromaeo_css | took 1116751ms 13:33:59 INFO - TEST-START | kraken 13:33:59 INFO - operating with platform_type : linux_ 13:33:59 INFO - Initialising browser for kraken test... 13:33:59 INFO - TEST-INFO | started process 25692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMMMZsm/profile http://localhost:56404/getInfo.html) 13:34:04 INFO - PROCESS | 25692 | __metrics Screen width/height:1600/1200 13:34:04 INFO - PROCESS | 25692 | colorDepth:24 13:34:04 INFO - PROCESS | 25692 | Browser inner width/height: 1024/697 13:34:04 INFO - PROCESS | 25692 | __metrics 13:34:04 INFO - PROCESS | 25692 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:34:04 INFO - PROCESS | 25692 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:34:05 INFO - PROCESS | 25692 | console.error: PushService: 13:34:05 INFO - PROCESS | 25692 | stateChangeProcessEnqueue: Error transitioning state 13:34:05 INFO - PROCESS | 25692 | UnknownError 13:34:05 INFO - TEST-INFO | 25692: exit 0 13:34:05 INFO - Browser initialized. 13:34:05 INFO - Running cycle 1/1 for kraken test... 13:34:05 INFO - TEST-INFO | started process 25777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMMMZsm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:34:17 INFO - PROCESS | 25777 | RSS: Main: 180133888 13:34:17 INFO - PROCESS | 25777 | 13:34:20 INFO - PROCESS | 25777 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56404/tests/kraken/driver.html?testName=audio-beat-detection) 13:34:21 INFO - PROCESS | 25777 | RSS: Main: 234119168 13:34:21 INFO - PROCESS | 25777 | 13:34:23 INFO - PROCESS | 25777 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56404/tests/kraken/driver.html?testName=audio-dft) 13:34:24 INFO - PROCESS | 25777 | RSS: Main: 224817152 13:34:24 INFO - PROCESS | 25777 | 13:34:27 INFO - PROCESS | 25777 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56404/tests/kraken/driver.html?testName=audio-fft) 13:34:28 INFO - PROCESS | 25777 | RSS: Main: 302096384 13:34:28 INFO - PROCESS | 25777 | 13:34:30 INFO - PROCESS | 25777 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56404/tests/kraken/driver.html?testName=audio-oscillator) 13:34:30 INFO - PROCESS | 25777 | RSS: Main: 212164608 13:34:30 INFO - PROCESS | 25777 | 13:34:33 INFO - PROCESS | 25777 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56404/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:34:33 INFO - PROCESS | 25777 | RSS: Main: 214446080 13:34:33 INFO - PROCESS | 25777 | 13:34:36 INFO - PROCESS | 25777 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56404/tests/kraken/driver.html?testName=imaging-darkroom) 13:34:37 INFO - PROCESS | 25777 | RSS: Main: 252473344 13:34:37 INFO - PROCESS | 25777 | 13:34:40 INFO - PROCESS | 25777 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56404/tests/kraken/driver.html?testName=imaging-desaturate) 13:34:41 INFO - PROCESS | 25777 | RSS: Main: 250982400 13:34:41 INFO - PROCESS | 25777 | 13:34:43 INFO - PROCESS | 25777 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56404/tests/kraken/driver.html?testName=json-parse-financial) 13:34:44 INFO - PROCESS | 25777 | RSS: Main: 251572224 13:34:44 INFO - PROCESS | 25777 | 13:34:46 INFO - PROCESS | 25777 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56404/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:34:46 INFO - PROCESS | 25777 | RSS: Main: 213475328 13:34:46 INFO - PROCESS | 25777 | 13:34:48 INFO - PROCESS | 25777 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56404/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:34:49 INFO - PROCESS | 25777 | RSS: Main: 220700672 13:34:49 INFO - PROCESS | 25777 | 13:34:51 INFO - PROCESS | 25777 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56404/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:34:51 INFO - PROCESS | 25777 | RSS: Main: 222359552 13:34:51 INFO - PROCESS | 25777 | 13:34:54 INFO - PROCESS | 25777 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:34:54 INFO - PROCESS | 25777 | RSS: Main: 223547392 13:34:54 INFO - PROCESS | 25777 | 13:34:57 INFO - PROCESS | 25777 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:34:58 INFO - PROCESS | 25777 | RSS: Main: 221503488 13:34:58 INFO - PROCESS | 25777 | 13:35:00 INFO - PROCESS | 25777 | Cycle 1(1): loaded http://localhost:56404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56404/tests/kraken/driver.html?testName=ai-astar) 13:35:00 INFO - PROCESS | 25777 | RSS: Main: 271921152 13:35:00 INFO - PROCESS | 25777 | 13:35:00 INFO - PROCESS | 25777 | __start_tp_report 13:35:00 INFO - PROCESS | 25777 | _x_x_mozilla_page_load 13:35:00 INFO - PROCESS | 25777 | _x_x_mozilla_page_load_details 13:35:00 INFO - PROCESS | 25777 | |i|pagename|runs| 13:35:00 INFO - PROCESS | 25777 | |0;ai-astar;109;113;130;113;111;112;110;111;110;110 13:35:00 INFO - PROCESS | 25777 | |1;audio-beat-detection;150;118;152;188;120;144;146;121;188;121 13:35:00 INFO - PROCESS | 25777 | |2;audio-dft;159;162;160;159;160;162;160;162;161;162 13:35:00 INFO - PROCESS | 25777 | |3;audio-fft;74;75;74;188;76;75;75;75;168;75 13:35:00 INFO - PROCESS | 25777 | |4;audio-oscillator;81;80;158;80;82;81;153;81;81;151 13:35:00 INFO - PROCESS | 25777 | |5;imaging-gaussian-blur;117;116;117;117;117;117;118;116;117;117 13:35:00 INFO - PROCESS | 25777 | |6;imaging-darkroom;146;145;146;146;146;147;148;146;147;147 13:35:00 INFO - PROCESS | 25777 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;94 13:35:00 INFO - PROCESS | 25777 | |8;json-parse-financial;50;50;58;50;53;52;52;53;52;51 13:35:00 INFO - PROCESS | 25777 | |9;json-stringify-tinderbox;60;61;61;61;61;60;61;61;62;62 13:35:00 INFO - PROCESS | 25777 | |10;stanford-crypto-aes;81;85;79;79;88;82;85;80;79;79 13:35:00 INFO - PROCESS | 25777 | |11;stanford-crypto-ccm;135;132;123;125;136;134;128;123;167;125 13:35:00 INFO - PROCESS | 25777 | |12;stanford-crypto-pbkdf2;166;169;166;166;169;167;166;161;168;167 13:35:00 INFO - PROCESS | 25777 | |13;stanford-crypto-sha256-iterative;68;65;65;66;65;65;65;65;63;63 13:35:00 INFO - PROCESS | 25777 | __end_tp_report 13:35:00 INFO - PROCESS | 25777 | __start_cc_report 13:35:00 INFO - PROCESS | 25777 | _x_x_mozilla_cycle_collect,1723 13:35:00 INFO - PROCESS | 25777 | __end_cc_report 13:35:00 INFO - PROCESS | 25777 | __startTimestamp1472675700262__endTimestamp 13:35:00 INFO - PROCESS | 25777 | 13:35:00 INFO - PROCESS | 25777 | ------- Summary: start ------- 13:35:00 INFO - PROCESS | 25777 | Number of tests: 14 13:35:00 INFO - PROCESS | 25777 | 13:35:00 INFO - PROCESS | 25777 | [#0] ai-astar Cycles:10 Average:112.90 Median:111.50 stddev:6.15 (5.5%) stddev-sans-first:6.36 13:35:00 INFO - PROCESS | 25777 | Values: 109.0 113.0 130.0 113.0 111.0 112.0 110.0 111.0 110.0 110.0 13:35:00 INFO - PROCESS | 25777 | 13:35:00 INFO - PROCESS | 25777 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:148.00 stddev:26.41 (17.8%) stddev-sans-first:27.95 13:35:00 INFO - PROCESS | 25777 | Values: 150.0 118.0 152.0 188.0 120.0 144.0 146.0 121.0 188.0 121.0 13:35:00 INFO - PROCESS | 25777 | 13:35:00 INFO - PROCESS | 25777 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.17 13:35:00 INFO - PROCESS | 25777 | Values: 159.0 162.0 160.0 159.0 160.0 162.0 160.0 162.0 161.0 162.0 13:35:00 INFO - PROCESS | 25777 | 13:35:00 INFO - PROCESS | 25777 | [#3] audio-fft Cycles:10 Average:95.50 Median:75.00 stddev:43.74 (58.3%) stddev-sans-first:45.70 13:35:00 INFO - PROCESS | 25777 | Values: 74.0 75.0 74.0 188.0 76.0 75.0 75.0 75.0 168.0 75.0 13:35:00 INFO - PROCESS | 25777 | 13:35:00 INFO - PROCESS | 25777 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:81.00 stddev:35.38 (43.7%) stddev-sans-first:36.63 13:35:00 INFO - PROCESS | 25777 | Values: 81.0 80.0 158.0 80.0 82.0 81.0 153.0 81.0 81.0 151.0 13:35:00 INFO - PROCESS | 25777 | 13:35:00 INFO - PROCESS | 25777 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 13:35:00 INFO - PROCESS | 25777 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 118.0 116.0 117.0 117.0 13:35:00 INFO - PROCESS | 25777 | 13:35:00 INFO - PROCESS | 25777 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 13:35:00 INFO - PROCESS | 25777 | Values: 146.0 145.0 146.0 146.0 146.0 147.0 148.0 146.0 147.0 147.0 13:35:00 INFO - PROCESS | 25777 | 13:35:00 INFO - PROCESS | 25777 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:35:00 INFO - PROCESS | 25777 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 13:35:00 INFO - PROCESS | 25777 | 13:35:00 INFO - PROCESS | 25777 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:2.38 (4.6%) stddev-sans-first:2.40 13:35:00 INFO - PROCESS | 25777 | Values: 50.0 50.0 58.0 50.0 53.0 52.0 52.0 53.0 52.0 51.0 13:35:00 INFO - PROCESS | 25777 | 13:35:00 INFO - PROCESS | 25777 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 13:35:00 INFO - PROCESS | 25777 | Values: 60.0 61.0 61.0 61.0 61.0 60.0 61.0 61.0 62.0 62.0 13:35:00 INFO - PROCESS | 25777 | 13:35:00 INFO - PROCESS | 25777 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:81.50 stddev:3.23 (4.0%) stddev-sans-first:3.42 13:35:00 INFO - PROCESS | 25777 | Values: 81.0 85.0 79.0 79.0 88.0 82.0 85.0 80.0 79.0 79.0 13:35:00 INFO - PROCESS | 25777 | 13:35:00 INFO - PROCESS | 25777 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:133.00 stddev:13.01 (9.8%) stddev-sans-first:13.78 13:35:00 INFO - PROCESS | 25777 | Values: 135.0 132.0 123.0 125.0 136.0 134.0 128.0 123.0 167.0 125.0 13:35:00 INFO - PROCESS | 25777 | 13:35:00 INFO - PROCESS | 25777 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:167.00 stddev:2.27 (1.4%) stddev-sans-first:2.40 13:35:00 INFO - PROCESS | 25777 | Values: 166.0 169.0 166.0 166.0 169.0 167.0 166.0 161.0 168.0 167.0 13:35:00 INFO - PROCESS | 25777 | 13:35:00 INFO - PROCESS | 25777 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.41 (2.2%) stddev-sans-first:1.00 13:35:00 INFO - PROCESS | 25777 | Values: 68.0 65.0 65.0 66.0 65.0 65.0 65.0 65.0 63.0 63.0 13:35:00 INFO - PROCESS | 25777 | -------- Summary: end -------- 13:35:00 INFO - PROCESS | 25777 | 13:35:01 INFO - TEST-INFO | 25777: exit 0 13:35:01 INFO - TEST-OK | kraken | took 61627ms 13:35:01 INFO - SUITE-END | took 1178s 13:35:01 INFO - Completed test suite (00:19:38) 13:35:01 INFO - javascript benchmark 13:35:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3037.195143287029, 3044.101989912976, 3070.4319700855335, 3094.5822313987605, 3113.408452394045, 5365.946340536593, 5367.355917289926, 5433.293671822657, 5487.259220005298, 5489.423610520893, 5342.2253773202865, 5346.91979620306, 5358.03555360036, 5362.8123015694455, 5438.592105592076, 4799.136155492001, 4833.347498087748, 4878.878028049309, 4882.6826256293225, 5049.747512624373, 4975.9004819903585, 5019.64862459628, 5020.146575082226, 5035.068512325213, 5038.59691224703, 4775.832845850396, 4864.124457597631, 4872.853814385574, 4908.460069392364, 4924.926126108094, 4781.665283430161, 4817.494163112858, 4970.304157417964, 4970.428400733889, 4985.501449855022, 4790.209615413452, 4809.735464549449, 4823.614110871122, 4829.661923665345, 4882.584980276681, 5241.42344342122, 5347.278117454132, 5360.705161216131, 5371.248025276464, 5380.488853558905, 5547.833564993016, 5633.239512665778, 5674.404187560329, 5680.176374425727, 5701.77192912283, 5671.291088613923, 5711.62874413166, 5716.1425786131995, 5717.628354156966, 5731.226284451587, 5331.280277162611, 5335.733213339317, 5337.066013447631, 5348.0, 5389.9191512127345, 5937.732802023919, 6044.486218671462, 6050.45545900871, 6053.909191362133, 6057.273127224761, 5745.942540574624, 5749.8275051748515, 5752.395998420189, 5753.108268218432, 5808.419158084158, 5607.158926161109, 5666.97166514173, 5792.247007888947, 5802.448767367094, 5802.47777700009, 5698.686572238566, 5740.598158128974, 5744.052231381859, 5778.624389414675, 5809.970950145223, 5703.600747947604, 5744.51171650406, 5746.166805813217, 5748.252727145528, 5769.653820770767, 4400.559944005574, 4400.73595584266, 4436.534163912807, 4467.352233926063, 4500.819967201275, 4000.2799496090984, 4017.2367250222946, 4046.0289530512464, 4064.227796718614, 4067.5525692173837, 5549.889002220014, 5561.749721262472, 5562.3881373048935, 5563.8887222256135, 5565.805196818092, 5572.916406253909, 5770.19217309577, 5875.50058245054, 5887.411258874164, 5889.234399528034, 5484.149956756709, 5525.060739674265, 5532.5020748132865, 5570.359408667974, 5577.749001294951, 5012.373453318335, 5024.472430394829, 5025.623078269071, 5030.2957585938, 5083.288339632454, 5844.883102338014, 5854.4730974212525, 6006.909896351558, 6012.549058820606, 6021.789237376671, 5725.34158571753, 5788.884222315446, 5796.913046304393, 5836.212111364912, 5857.824265272048, 5915.674637894957, 5922.407759224043, 5925.229720136354, 5926.644401335933, 5940.910886336622, 5511.53151982086, 5563.165525171256, 5607.102863541813, 5704.372519022987, 5717.056685646821, 5669.858253543694, 5699.857503562444, 5702.344230413555, 5704.572157088152, 5710.543156547383, 5597.80407685729, 5607.102863541813, 5655.462731040545, 5684.545236381162, 5750.223719797941, 5649.378568357395, 5650.378458369658, 5655.0, 5658.236138121301, 5663.858403539944, 5603.579731520071, 5626.915596265977, 5649.180868773922, 5656.85857853557, 5657.12314591239, 5556.333240011225, 5783.306003279633, 5832.795852145155, 5855.151003104441, 5869.501092407193, 5423.376311724044, 5676.943230567642, 5677.375488696158, 5680.176374425768, 5687.516561092353], "value": 5328.767407357573, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.1116552665106, 580.4601720400028, 597.5219824140686, 629.9464545513631, 632.3865850125379, 41766.79116604417, 43407.56592434075, 43441.34837977425, 43508.3473747894, 46170.0, 44306.77846610762, 44630.0, 44637.33044004334, 44733.77633111838, 44820.0, 8953.641854325835, 9052.411593246417, 9096.40873343234, 9103.54482275887, 9107.180353768159, 8868.467891926473, 8944.329175311845, 8953.0, 8953.283737301033, 8955.19403253707, 8744.562771861414, 8761.386702930766, 8777.692780752675, 8779.736607901774, 8784.077671844429, 8922.330825188104, 8964.59659315326, 8965.596548155316, 8969.686060987899, 8972.730818075468, 8923.375363724543, 8986.236169925563, 8990.100989901022, 9000.369974101815, 9004.234640055603, 35018.82490587556, 35051.4742278866, 35285.0, 35289.82355088208, 35322.823385883166, 3386.373520898617, 3464.9133771655656, 3583.695385892176, 3646.2342907989355, 3772.5284339457567, 27796.861015694994, 27943.720562794315, 28009.71990280112, 28034.299142521395, 28429.57355639667, 3815.2560250751117, 3898.961010389888, 3907.5701672815967, 4037.1723796621623, 4066.430699702044, 350978.0, 351703.0, 352045.0, 352382.0, 352768.0, 35330.29339413197, 35672.64327356745, 55481.72259138679, 55748.44251557514, 55802.441975580536, 31756.206094847814, 31928.521072183936, 31964.0, 32043.51934720981, 32055.0, 13750.793738093937, 13800.723985520433, 13808.240546769823, 13831.377588008563, 13903.582892513241, 12352.44414001372, 12406.13157079014, 12423.068269879795, 12427.0, 12449.190802597803, 7631.1605723370385, 7635.465517413728, 7715.614219289013, 7734.342580880688, 7737.497062690907, 3321.1199032256472, 3371.174062354739, 3384.6953774160443, 3389.8305084745666, 3434.690877821008, 961.3030552849128, 998.5756053677159, 1060.2525219720078, 1065.7069305940772, 1129.8192289233684, 30808.752236538505, 31231.531527027113, 31477.8426107868, 31502.84248578788, 31837.0, 845.4673555659895, 1009.5709323537467, 1047.6542740895486, 1063.5426766490484, 1093.5625749700184, 15261.389544418322, 16226.188690565425, 16286.837131628532, 16323.836761632232, 16643.41748038837, 535175.0, 537030.0, 537128.0, 537723.0, 540680.0, 43212.3518147228, 43319.566804332186, 43341.349879751826, 43377.132457351305, 43593.346099807895, 1249.0819247852821, 1330.0623060742153, 1361.6800051987775, 1367.3505085084505, 1374.9587512374644, 25983.480330392907, 26916.596251056642, 27616.033438829545, 27693.86153069222, 28104.85947570249, 39304.213915722095, 39816.800915995234, 40011.399829002, 40167.0, 40181.0, 373028.0, 376808.0, 376832.0, 377691.0, 502372.0, 27877.86061069682, 40469.0, 43081.0, 43446.565534345515, 44022.77988610036, 37862.24275514529, 37949.43075853809, 38218.617813821504, 38832.80583597064, 47412.52587474081, 37378.8131059343, 40672.1865562693, 40937.385939211534, 41862.0, 42020.15959680728, 40357.798211008754, 40676.59323406728, 40795.98010049773, 41985.58014419817, 42187.0, 33285.50071748974, 33394.16514587155, 33426.33147337088, 35556.111097222776, 37904.81047594855, 34209.65790342164, 36471.63528364682, 36827.447588286734, 37040.44439333466, 37523.43714844334, 24035.158769442987, 24127.396815079763, 24168.758312417354, 24714.629280560446, 24852.0], "value": 17919.64975333425, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.1696930997327, 388.1654442947662, 409.1101853468705, 414.3081054638753, 416.27568031624963, 12612.180208286454, 16779.664406711858, 20007.0, 20108.296209632666, 20228.39314820556, 18623.348182813603, 18863.528411789714, 19204.0, 20027.098780554872, 21175.682364764503, 6420.614763114205, 6420.903686444695, 6607.306232845554, 6678.465722742193, 6686.231083425396, 4738.9526104739025, 6528.902066469007, 6627.37039981201, 6627.668616569176, 7146.964265178693, 7401.481896267263, 7588.392928565729, 7604.239576042379, 7604.581748003858, 7611.733589324374, 7369.926300736977, 7551.207123252062, 7578.166401695809, 7588.165301816795, 7601.6579253933705, 7040.5071644984355, 7273.818154546126, 7295.52579082358, 7327.157376901671, 7360.374368178711, 24583.87708061466, 26226.737732622812, 26260.212193634223, 26279.0, 26290.6056409154, 2618.423946731716, 3187.8406079695924, 3237.6438591754886, 3334.5665063541583, 3337.0656216259486, 11061.446927653586, 16527.173641318008, 16537.83462165375, 16807.747883781754, 16945.830541694548, 2043.9386818395471, 2049.7130401743766, 2091.0799248330836, 2130.5312831177116, 2159.9244026459, 99275.50362248142, 100080.49959750155, 102800.48599756953, 102892.48553757183, 103756.0, 17536.91231543834, 17764.822351776576, 17839.73240401395, 18178.636427271646, 18300.0, 31490.0, 31581.0, 31601.84199079036, 31654.36691266162, 31760.68239317577, 9855.408675479352, 10099.242556808269, 10101.848472272923, 10193.439360835077, 10450.634227801991, 8463.195996380335, 8529.616167272488, 8531.658733650584, 8662.82674346522, 8762.123787621314, 8412.705555305534, 8666.913330866611, 8686.478811271343, 8727.825443491094, 8786.489580722931, 3208.5828842250826, 3290.851911663981, 3301.5212794144713, 3309.420851351004, 3586.516853932584, 885.4112015509743, 917.3165991336497, 964.238251781099, 993.6224234790877, 1048.234788604323, 17787.19957601911, 19182.424527264204, 19679.90160049219, 19697.522685798624, 19713.40859774209, 913.853783394667, 950.201482513305, 955.3455882720359, 988.5749127874939, 997.152420442618, 9823.803523929482, 10192.541335639915, 10650.520726567323, 10729.570817167227, 10815.459227038617, 467458.0, 470497.0, 472015.0, 480775.0, 491901.0, 84396.57801710952, 92212.21539286358, 95018.04981950091, 99619.0, 100952.49523752334, 1007.9949600251952, 1019.9031092046243, 1045.994770026145, 1063.4895250279908, 1083.6748975307535, 17097.230624621672, 17318.0, 17844.28622855071, 18267.634647306713, 18495.90752046231, 42552.57447425486, 42916.30492271168, 43423.0, 43983.340249896915, 44321.55678443174, 54835.72582137064, 54877.0, 57516.42483575278, 61800.381996179465, 63651.0, 7645.541267523967, 7650.387968962581, 7712.730054448068, 8106.756797296091, 8165.38759593021, 11446.713832154262, 12987.545435909698, 13240.668983275495, 13381.866181338451, 13584.93207533956, 11070.114390848552, 11186.944065279622, 11569.942150289195, 11719.179657423898, 11844.70388240301, 5655.971720141373, 8274.965629296337, 10849.240553161202, 11074.390908499787, 11078.778424431304, 11439.14206434504, 11447.141464390037, 11697.766044679229, 11821.29072255633, 11846.526138954345, 7639.701250787491, 7689.115751688628, 7746.535207887545, 7918.208179182036, 8230.892037517366, 9684.225261979165, 11434.371109589052, 11647.534098636299, 11910.583129590423, 11926.701832454259], "value": 10405.034048175445, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1231.2858542045615, 1307.6207899709084, 1334.2261488336765, 1396.0158088547576, 1508.675634738531, 8517.701880434179, 8887.64449422023, 8893.421927574704, 9175.816483670322, 9186.173244408003, 9016.54917254138, 9121.133492318235, 9158.358914875944, 9200.677976270816, 9226.584803683834, 2391.031632188962, 2416.1664225842055, 2418.9274321770376, 2440.670509481215, 2443.609022556391, 2343.5547246023284, 2375.893084811179, 2410.7950824179966, 2411.228406909781, 2411.2645643078854, 2382.95234095318, 2398.760123987605, 2399.7960173385195, 2408.0728919365997, 2413.5414271288487, 2320.4082958845556, 2344.4256157241416, 2348.283773449097, 2350.4123969007746, 2363.4800343924308, 2229.297771202066, 2254.9210777622707, 2288.1533832482087, 2293.9655905161435, 2302.7927486526128, 8584.05575386707, 8816.823663526759, 8935.151160639729, 8942.150495702897, 8942.195202431747, 5038.874028149289, 5209.453007434241, 5254.737263136828, 5267.841964741064, 5271.262023316739, 3324.2852786650747, 3460.602030766469, 3479.0954351868445, 3528.6824185823143, 3533.4346504559403, 1122.7361570031037, 1160.6866146140494, 1178.181164090957, 1179.151011271883, 1180.811070228768, 12508.186967847152, 12521.0, 12565.18326308787, 12585.433655485525, 12587.118901676979, 4343.1530851484285, 4475.149721552894, 4614.353990441341, 4638.5593368629925, 4646.767661616906, 9643.758906027406, 9668.226541876633, 9672.70981870545, 9683.128518433234, 9693.903060969442, 5133.435322114565, 5165.74171291434, 5169.431362550116, 5170.97414512925, 5171.844844654666, 4228.471441069866, 4529.569690879362, 4619.653525985565, 4657.394538709946, 4836.685615434985, 3902.5902280260166, 3918.1380096378753, 4012.7592344459426, 4044.5753195914594, 4080.2859499587453, 1192.2369683402628, 1200.3278164227886, 1210.449245593253, 1220.5727995201787, 1233.660743295601, 839.5424493650975, 845.9383473740417, 864.1358641358642, 937.386012162035, 944.9905500944902, 5905.7932972346625, 5945.64326140433, 6274.1843560337775, 6446.419822216023, 6612.206535215709, 934.5841100710119, 1017.9185665146771, 1020.7699721835171, 1023.0945613132283, 1033.4419413516766, 3894.5131858517684, 3932.623581746423, 3967.1668949520345, 4044.656204222615, 4118.299889018874, 10705.625303114353, 11479.483423245974, 11508.769824603462, 11549.88450115505, 11594.710132246593, 11263.211575189822, 11463.426828658534, 11487.415331550334, 11488.597899073493, 11494.712632184095, 8370.414071015091, 8566.3146948244, 8577.05652378238, 8582.570871456526, 8592.65629374818, 5719.885602287848, 5740.971295143498, 5792.913106303325, 5805.622634528742, 5945.227120474311, 10366.481675916324, 10411.0, 10509.0, 10623.256372053882, 10653.934606539284, 10205.234607404325, 10649.680509584725, 10665.0, 10864.185186111232, 10960.56157753681, 7121.252268511732, 7197.604131772803, 7279.381252593377, 7600.885986710315, 7753.340966017951, 8016.198380161937, 8155.755327340189, 8157.79605509867, 8195.057568379474, 8207.302379297827, 7438.114884163921, 7637.88543171864, 7691.50005249657, 7701.922980770345, 7787.805304867197, 7429.368503677248, 7704.845903081795, 7842.686292548462, 7881.054273487218, 8033.758987230392, 7043.154821421463, 7155.212926578176, 7167.068281123421, 7168.24733403006, 7168.4265258780215, 5187.922181167361, 5190.247414124855, 5277.815276465305, 5328.3605967284175, 5509.834704958857, 5079.898402031865, 5144.614153938544, 5199.29809475716, 5257.8159764408065, 5351.438098999549], "value": 4652.815330446817, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.08900090242355, 334.19792498004784, 334.82254405165264, 335.3962866839688, 336.4532634468988, 5029.547340739333, 5102.0, 5133.255677926699, 5202.294806700514, 5231.529162375381, 5116.2627994023205, 5128.153854613994, 5145.202493613487, 5147.897042059157, 5168.095583272921, 4027.9597204028023, 4034.415009823581, 4038.9805097451276, 4050.0, 4087.0, 3848.0, 3990.8603198888045, 4080.2655522006025, 4080.7551546907134, 4094.3653733671326, 4066.9186616267657, 4068.613481719247, 4071.877843664695, 4080.204360149772, 4097.569755175693, 4040.6767458603535, 4049.5140583130215, 4054.837806487737, 4071.7377612939786, 4078.8164532596106, 3620.113072297304, 3622.601513833476, 3641.6540428659237, 3650.251698401848, 3655.0, 4887.458521568764, 5006.249062640597, 5010.398752149729, 5011.594434671378, 5014.373203349582, 4602.815887364535, 4617.7691115444095, 4617.8383756568355, 4628.629709623222, 4653.930191047137, 5286.392064912546, 5316.574674026068, 5347.572194224453, 5355.410904800468, 5365.3293338332705, 3689.520362352877, 3910.667593254577, 3919.412088186766, 3923.9607603923882, 3956.307646161939, 5567.164925261243, 5577.8605534861545, 5584.888302233932, 5596.761295481799, 5616.652003519167, 4001.3997900315185, 4019.1157945252, 4023.6177563131455, 4027.375756757707, 4033.3748269018347, 3990.7605543667473, 4049.311617025113, 4061.411095391211, 4076.164386300801, 4079.73481723687, 4600.079984003146, 4604.848787803049, 4626.421697287839, 4630.814767409266, 4633.166030114612, 5379.359295414858, 5379.67721936685, 5380.569554435636, 5383.353997520244, 5455.754491047913, 1365.6275443179738, 1397.6855207578417, 1408.084744915813, 1414.8893118901613, 1420.3111490926892, 904.2810965282616, 914.346242436661, 935.3873213045466, 945.5036106044382, 946.6639343033262, 4577.8397756078375, 4580.7938642761155, 4639.608117564717, 4696.201645720235, 4721.6694831362165, 4804.51060171348, 4820.421549414093, 4827.503473923095, 4828.275758636232, 4829.9275510867365, 4544.727316361029, 4564.292534657134, 4584.908301833944, 4643.233866412072, 4652.371669915503, 2765.5298599238176, 2965.7395606866994, 2976.300569366197, 2985.1939976206304, 2993.5060714981782, 5766.711664416763, 5774.451427114502, 5786.553361659585, 5789.247397838254, 5805.274340707411, 5474.479924407175, 5663.66018038919, 5696.82909512707, 5744.655320680772, 5764.682942438122, 5651.180578816131, 5669.43305669438, 5682.403347648437, 5691.0, 5700.144978253295, 5526.457829398521, 5550.251670723709, 5568.693721845338, 5596.972015139898, 5628.324601047901, 5299.814506492255, 5487.5609951203005, 5538.169274608841, 5543.473370029841, 5545.611807173459, 5730.5129064030025, 5758.654480731169, 5764.250647415977, 5768.567357448124, 5780.826575202583, 3848.6138594070735, 4029.717919745707, 4032.2459730017536, 4035.7174997749876, 4073.694472914484, 5139.717315547531, 5179.948200517946, 5527.088030474926, 5542.695151766691, 5544.916826247529, 5381.273528073816, 5404.621676482609, 5429.049916264559, 5444.50999410055, 5453.918191227214, 5185.714711226271, 5353.661584603849, 5405.702686352131, 5420.753226757789, 5456.508914197741, 5298.470152984671, 5317.5214230717875, 5333.7333133343955, 5341.198820177005, 5361.498780341511, 5425.972870135624, 5457.645253058538, 5473.808416705396, 5524.1989911463415, 5525.502704756591, 5126.256692779451, 5358.33020872391, 5377.489138531833, 5399.487048730364, 5405.0], "value": 4102.840445160052, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.523688405399, 805.9516429014263, 813.7111325479455, 816.1960468938095, 825.5418242875202, 14578.489752858652, 15415.306311216022, 15659.0, 15713.135777532245, 15741.842581574181, 14849.851501484982, 14889.181095039796, 14968.32642531086, 14971.550853474386, 15024.17367044812, 761.7448154868111, 796.8884356190109, 807.1363640904235, 809.6639894443799, 809.76112046946, 540.9486098820606, 550.9118541033436, 556.2796178948252, 663.3466035954605, 803.4737247103157, 835.0230230630177, 836.1304243586662, 836.7824365664941, 842.465034702965, 844.2570537926616, 833.8874251976027, 834.6619619054293, 834.8121672623672, 835.2691395029349, 836.8912041434605, 505.63846849502784, 605.7576969212306, 615.9507239420835, 617.688067525901, 621.987560248797, 14569.927150364181, 14598.562043138723, 14633.634159146, 14641.41434342625, 14650.267486625733, 12961.870381296161, 13140.802887956592, 13540.729185416236, 13891.513797017156, 14064.22646754428, 13044.86955130446, 13056.151350162208, 13268.601941941757, 13398.0, 13490.595282141454, 4381.737095774264, 4389.582989615981, 4442.555744425564, 4463.620592249663, 4644.698094623838, 82324.0, 82747.0, 83701.58149209277, 85908.97274381592, 87104.0, 11084.113270938306, 11102.0, 11106.777864442665, 11126.721831954104, 11383.373914434786, 21196.89401553013, 21283.0, 21300.25449109274, 21392.465188370104, 21446.24938127158, 8173.591320434073, 8196.959015204886, 8242.835143297101, 8383.0, 8493.023302320313, 4444.333349997526, 4541.296099104644, 4543.0, 4676.8129274828625, 4747.95252047482, 3170.476871316207, 3294.3081952789703, 3296.258341873059, 3297.554830097954, 3299.0762586475826, 579.6493121661418, 584.8888711144868, 587.700272860844, 588.0825911577866, 590.400743245606, 520.8723862653674, 604.1210039392673, 608.3004544773546, 627.2848952194502, 672.3411057164006, 9463.290253231035, 9632.133108020313, 9667.178289845442, 10408.531616077295, 10622.57445764503, 645.9515536334794, 666.5434177588368, 693.9548929319578, 720.935115839577, 722.1298335505703, 4679.906401871944, 5228.869278267997, 5409.83770486886, 5483.4516548344845, 5514.696691681996, 115408.42295788467, 117195.0, 117922.41038794752, 121234.3938280303, 123168.0, 102266.0, 104747.0, 105016.0, 105700.0, 110288.48557572089, 87305.56347218351, 89970.99999999869, 91388.54305728429, 94800.52599736956, 95404.0, 9603.519824008632, 10158.949205253926, 10407.895921040692, 10419.635312764018, 10461.529231184462, 51394.74302628463, 51685.0, 51707.224391633405, 52961.0, 52994.0, 74156.0, 74252.2574774267, 80617.59691201507, 81500.18499815163, 81825.0, 12105.878941210474, 12272.938635306766, 12551.3096779678, 12583.496660133493, 12898.290594017419, 14436.278186090864, 14477.927610361881, 14652.26738663084, 14669.706605868036, 14832.555023349316, 13019.544315948897, 13151.868481315065, 13569.592912212649, 13652.726945461234, 14089.295535223402, 13635.522756703467, 13701.0, 13730.794038089236, 14103.506377277157, 14602.707945841235, 12993.067117262479, 13114.934425328194, 13344.399502022237, 13757.243351615758, 13785.379657915619, 10780.568777248822, 10794.298370605886, 11141.16441266892, 11351.772964540829, 11352.0, 10921.508532116233, 11093.0, 11136.49885755159, 11341.886581134084, 11385.943070284595], "value": 7549.901620525976, "unit": "score"}], "name": "dromaeo_css", "value": 7233.207242088434, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 113.0, 130.0, 113.0, 111.0, 112.0, 110.0, 111.0, 110.0, 110.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 118.0, 152.0, 188.0, 120.0, 144.0, 146.0, 121.0, 188.0, 121.0], "value": 144.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 160.0, 159.0, 160.0, 162.0, 160.0, 162.0, 161.0, 162.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 188.0, 76.0, 75.0, 75.0, 75.0, 168.0, 75.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 158.0, 80.0, 82.0, 81.0, 153.0, 81.0, 81.0, 151.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 148.0, 146.0, 147.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 58.0, 50.0, 53.0, 52.0, 52.0, 53.0, 52.0, 51.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 62.0, 62.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 79.0, 79.0, 88.0, 82.0, 85.0, 80.0, 79.0, 79.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 123.0, 125.0, 136.0, 134.0, 128.0, 123.0, 167.0, 125.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 169.0, 166.0, 166.0, 169.0, 167.0, 166.0, 161.0, 168.0, 167.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0, 63.0, 63.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1533.8999999999999, "alertThreshold": 2.0}]} 13:35:01 INFO - Return code: 0 13:35:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:35:02 INFO - # TBPL SUCCESS # 13:35:02 INFO - Running post-action listener: _resource_record_post_action 13:35:02 INFO - [mozharness: 2016-08-31 20:35:02.062368Z] Finished run-tests step (success) 13:35:02 INFO - Running post-run listener: _resource_record_post_run 13:35:02 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 418738176; Read time: 248; Write time: 361652 13:35:02 INFO - TinderboxPrint: CPU usage
13.1% 13:35:02 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 248 13:35:02 INFO - TinderboxPrint: I/O write bytes / time
418,738,176 / 361,652 13:35:02 INFO - TinderboxPrint: CPU idle
8,293.6 (86.9%) 13:35:02 INFO - TinderboxPrint: CPU user
1,198.0 (12.6%) 13:35:02 INFO - TinderboxPrint: Swap in / out
0 / 0 13:35:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 128872448; Read time: 0; Write time: 99092 13:35:02 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288690176; Read time: 228; Write time: 262528 13:35:02 INFO - Running post-run listener: _upload_blobber_files 13:35:02 INFO - Blob upload gear active. 13:35:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:35:02 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 13:35:02 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:35:02 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:35:03 INFO - (blobuploader) - INFO - Open directory for files ... 13:35:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:35:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:35:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:35:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:35:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:35:03 INFO - (blobuploader) - INFO - Done attempting. 13:35:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:35:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:35:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:35:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:35:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:35:04 INFO - (blobuploader) - INFO - Done attempting. 13:35:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:35:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:35:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:35:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:35:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:35:10 INFO - (blobuploader) - INFO - Done attempting. 13:35:10 INFO - (blobuploader) - INFO - Iteration through files over. 13:35:10 INFO - Return code: 0 13:35:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:35:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:35:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1a1dfd112c971d939379dd1e4608e74fbb949cd68a8bef6a46efd824cfee874c1583ba19262e2db619a7938fcda6ad5d929fed6129780f86eebb89018d75807", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00cbce4fa863d8f2c2fb509add46e18378bd92f8a592079ef9e2c461acfcce3bbfde7ef7478f6553f5d4ad3d9625dfc30017dcc95837d20a3550f2550fda2001", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3df96935f1ca7676a6c02b7b3435c00d0be645854c2615313b4e852cabec82197d6472e8ff665d020546880358b059171546277a6eb7e80d585603db7f98cb25"} 13:35:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:35:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:35:10 INFO - Contents: 13:35:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1a1dfd112c971d939379dd1e4608e74fbb949cd68a8bef6a46efd824cfee874c1583ba19262e2db619a7938fcda6ad5d929fed6129780f86eebb89018d75807", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00cbce4fa863d8f2c2fb509add46e18378bd92f8a592079ef9e2c461acfcce3bbfde7ef7478f6553f5d4ad3d9625dfc30017dcc95837d20a3550f2550fda2001", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3df96935f1ca7676a6c02b7b3435c00d0be645854c2615313b4e852cabec82197d6472e8ff665d020546880358b059171546277a6eb7e80d585603db7f98cb25"} 13:35:10 INFO - Running post-run listener: copy_logs_to_upload_dir 13:35:10 INFO - Copying logs to upload dir... 13:35:10 INFO - mkdir: /builds/slave/test/build/upload/logs 13:35:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.223997 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-31 13:35:10.229163) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 13:35:10.232978) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649 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/sha512/c1a1dfd112c971d939379dd1e4608e74fbb949cd68a8bef6a46efd824cfee874c1583ba19262e2db619a7938fcda6ad5d929fed6129780f86eebb89018d75807", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00cbce4fa863d8f2c2fb509add46e18378bd92f8a592079ef9e2c461acfcce3bbfde7ef7478f6553f5d4ad3d9625dfc30017dcc95837d20a3550f2550fda2001", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3df96935f1ca7676a6c02b7b3435c00d0be645854c2615313b4e852cabec82197d6472e8ff665d020546880358b059171546277a6eb7e80d585603db7f98cb25"} build_url:https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011256 build_url: 'https://queue.taskcluster.net/v1/task/DWYeFO_NQQuVvjw2JMZbig/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/sha512/c1a1dfd112c971d939379dd1e4608e74fbb949cd68a8bef6a46efd824cfee874c1583ba19262e2db619a7938fcda6ad5d929fed6129780f86eebb89018d75807", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00cbce4fa863d8f2c2fb509add46e18378bd92f8a592079ef9e2c461acfcce3bbfde7ef7478f6553f5d4ad3d9625dfc30017dcc95837d20a3550f2550fda2001", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3df96935f1ca7676a6c02b7b3435c00d0be645854c2615313b4e852cabec82197d6472e8ff665d020546880358b059171546277a6eb7e80d585603db7f98cb25"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-31 13:35:10.260220) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 13:35:10.260706) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1472671654.527678-804879649 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-31 13:35:10.342256) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 13:35:10.342614) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-31 13:35:10.343161) ========= ========= Total master_lag: 0.19 =========