builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1470660574.05 results: success (0) buildid: 20160808030441 builduid: f603c1cd8c81472499074ffbf994b474 revision: e78975b53563d80c99ebfbdf8a9fbf6b829a8a48 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:49:34.050498) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 05:49:34.050965) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:49:34.051259) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 05:49:34.489057) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:49:34.489379) ========= 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=337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-08 05:49:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.8M=0s 2016-08-08 05:49:35 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083952 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:49:34.587079) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:49:34.587447) ========= 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=337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018913 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 05:49:34.636949) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 05:49:34.637327) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e78975b53563d80c99ebfbdf8a9fbf6b829a8a48 --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 e78975b53563d80c99ebfbdf8a9fbf6b829a8a48 --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=337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-08 05:49:35,282 truncating revision to first 12 chars 2016-08-08 05:49:35,283 Setting DEBUG logging. 2016-08-08 05:49:35,283 attempt 1/10 2016-08-08 05:49:35,283 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e78975b53563?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 05:49:36,301 unpacking tar archive at: mozilla-central-e78975b53563/testing/mozharness/ program finished with exit code 0 elapsedTime=1.337203 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 05:49:35.988700) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:49:35.989082) ========= script_repo_revision: e78975b53563d80c99ebfbdf8a9fbf6b829a8a48 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 05:49:35.989567) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:49:35.989839) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 05:49:35.998661) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-08 05:49:35.999031) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:49:36 INFO - MultiFileLogger online at 20160808 05:49:36 in /builds/slave/test 05:49:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:49:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:49:36 INFO - {'append_to_log': False, 05:49:36 INFO - 'base_work_dir': '/builds/slave/test', 05:49:36 INFO - 'blob_upload_branch': 'Firefox', 05:49:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:49:36 INFO - 'branch': 'Firefox', 05:49:36 INFO - 'buildbot_json_path': 'buildprops.json', 05:49:36 INFO - 'config_files': ('talos/linux_config.py',), 05:49:36 INFO - 'default_actions': ('clobber', 05:49:36 INFO - 'read-buildbot-config', 05:49:36 INFO - 'download-and-extract', 05:49:36 INFO - 'populate-webroot', 05:49:36 INFO - 'create-virtualenv', 05:49:36 INFO - 'install', 05:49:36 INFO - 'run-tests'), 05:49:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:49:36 INFO - 'download_minidump_stackwalk': True, 05:49:36 INFO - 'download_symbols': 'ondemand', 05:49:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:49:36 INFO - 'tooltool.py': '/tools/tooltool.py', 05:49:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:49:36 INFO - '/tools/misc-python/virtualenv.py')}, 05:49:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:49:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:49:36 INFO - 'installer_path': 'installer.exe', 05:49:36 INFO - 'log_level': 'info', 05:49:36 INFO - 'log_name': 'talos', 05:49:36 INFO - 'log_to_console': True, 05:49:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:49:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:49:36 INFO - 'opt_config_files': (), 05:49:36 INFO - 'pip_index': False, 05:49:36 INFO - 'sps_profile': False, 05:49:36 INFO - 'sps_profile_interval': 0, 05:49:36 INFO - 'suite': 'dromaeojs-e10s', 05:49:36 INFO - 'system_bits': '32', 05:49:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:49:36 INFO - 'title': 'talos-linux64-ix-060', 05:49:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:49:36 INFO - 'use_talos_json': True, 05:49:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:49:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:49:36 INFO - 'work_dir': 'build'} 05:49:36 INFO - [mozharness: 2016-08-08 12:49:36.735948Z] Running clobber step. 05:49:36 INFO - Running pre-action listener: _resource_record_pre_action 05:49:36 INFO - Running main action method: clobber 05:49:36 INFO - rmtree: /builds/slave/test/build 05:49:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:49:37 INFO - Running post-action listener: _resource_record_post_action 05:49:37 INFO - [mozharness: 2016-08-08 12:49:37.195958Z] Finished clobber step (success) 05:49:37 INFO - [mozharness: 2016-08-08 12:49:37.196058Z] Running read-buildbot-config step. 05:49:37 INFO - Running pre-action listener: _resource_record_pre_action 05:49:37 INFO - Running main action method: read_buildbot_config 05:49:37 INFO - Using buildbot properties: 05:49:37 INFO - { 05:49:37 INFO - "project": "", 05:49:37 INFO - "product": "firefox", 05:49:37 INFO - "script_repo_revision": "production", 05:49:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:49:37 INFO - "repository": "", 05:49:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:49:37 INFO - "buildid": "20160808030441", 05:49:37 INFO - "stage_platform": "linux64-pgo", 05:49:37 INFO - "basedir": "/builds/slave/test", 05:49:37 INFO - "nightly_build": "True", 05:49:37 INFO - "buildnumber": 116, 05:49:37 INFO - "slavename": "talos-linux64-ix-060", 05:49:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:49:37 INFO - "platform": "ubuntu64_hw", 05:49:37 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:49:37 INFO - "branch": "mozilla-central", 05:49:37 INFO - "repo_path": "mozilla-central", 05:49:37 INFO - "revision": "e78975b53563d80c99ebfbdf8a9fbf6b829a8a48", 05:49:37 INFO - "pgo_build": "True", 05:49:37 INFO - "builduid": "f603c1cd8c81472499074ffbf994b474", 05:49:37 INFO - "slavebuilddir": "test" 05:49:37 INFO - } 05:49:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:49:37 INFO - Running post-action listener: _resource_record_post_action 05:49:37 INFO - [mozharness: 2016-08-08 12:49:37.198580Z] Finished read-buildbot-config step (success) 05:49:37 INFO - [mozharness: 2016-08-08 12:49:37.198669Z] Running download-and-extract step. 05:49:37 INFO - Running pre-action listener: _resource_record_pre_action 05:49:37 INFO - Running main action method: download_and_extract 05:49:37 INFO - mkdir: /builds/slave/test/build/tests 05:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:37 INFO - trying https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:49:37 INFO - Downloading https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/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 05:49:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/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 05:49:37 INFO - Downloaded 1361 bytes. 05:49:37 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:49:37 INFO - Using the following test package requirements: 05:49:37 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:49:37 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:49:37 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:49:37 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:37 INFO - u'jsshell-linux-x86_64.zip'], 05:49:37 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:49:37 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:49:37 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:49:37 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:49:37 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:49:37 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:49:37 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:49:37 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:37 INFO - trying https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:49:37 INFO - Downloading https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/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 05:49:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/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 05:49:38 INFO - Downloaded 21829245 bytes. 05:49:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:49:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:49:39 INFO - Return code: 0 05:49:39 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 05:49:39 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')]} 05:49:39 INFO - trying https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:49:39 INFO - Downloading https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/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 05:49:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/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 05:49:40 INFO - Downloaded 21829245 bytes. 05:49:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:49:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:49:42 INFO - Return code: 0 05:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:42 INFO - trying https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:49:42 INFO - Downloading https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/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 05:49:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/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 05:49:43 INFO - Downloaded 14413723 bytes. 05:49:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:49:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:49:43 INFO - Return code: 0 05:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:43 INFO - trying https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:49:43 INFO - Downloading https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/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 05:49:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/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 05:49:44 INFO - Downloaded 59965269 bytes. 05:49:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:49:44 INFO - mkdir: /builds/slave/test/properties 05:49:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:49:44 INFO - Writing to file /builds/slave/test/properties/build_url 05:49:44 INFO - Contents: 05:49:44 INFO - build_url:https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:49:45 INFO - Running post-action listener: _resource_record_post_action 05:49:45 INFO - Running post-action listener: set_extra_try_arguments 05:49:45 INFO - [mozharness: 2016-08-08 12:49:45.214057Z] Finished download-and-extract step (success) 05:49:45 INFO - [mozharness: 2016-08-08 12:49:45.214289Z] Running populate-webroot step. 05:49:45 INFO - Running pre-action listener: _resource_record_pre_action 05:49:45 INFO - Running main action method: populate_webroot 05:49:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:49:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:49:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:49:45 INFO - '--tppagecycles', 05:49:45 INFO - '7'], 05:49:45 INFO - 'tests': ['tsvgm']}}, 05:49:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:49:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:49:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:49:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:49:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:49:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:49:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:45 INFO - 'talos_options': ['--disable-e10s'], 05:49:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:45 INFO - 'talos_options': ['--disable-e10s'], 05:49:45 INFO - 'tests': ['damp', 'tps']}, 05:49:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:45 INFO - 'tests': ['damp', 'tps']}, 05:49:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:49:45 INFO - 'tests': ['dromaeo_dom']}, 05:49:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:49:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:49:45 INFO - 'tests': ['basic_compositor_video']}, 05:49:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:49:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:49:45 INFO - 'tests': ['a11yr', 05:49:45 INFO - 'ts_paint', 05:49:45 INFO - 'tpaint', 05:49:45 INFO - 'sessionrestore', 05:49:45 INFO - 'sessionrestore_no_auto_restore', 05:49:45 INFO - 'tabpaint']}, 05:49:45 INFO - 'other-e10s': {'tests': ['a11yr', 05:49:45 INFO - 'ts_paint', 05:49:45 INFO - 'tpaint', 05:49:45 INFO - 'sessionrestore', 05:49:45 INFO - 'sessionrestore_no_auto_restore', 05:49:45 INFO - 'tabpaint']}, 05:49:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:49:45 INFO - 'ts_paint', 05:49:45 INFO - 'tpaint', 05:49:45 INFO - 'sessionrestore', 05:49:45 INFO - 'sessionrestore_no_auto_restore', 05:49:45 INFO - 'tabpaint']}, 05:49:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:49:45 INFO - 'ts_paint', 05:49:45 INFO - 'tpaint', 05:49:45 INFO - 'sessionrestore', 05:49:45 INFO - 'sessionrestore_no_auto_restore', 05:49:45 INFO - 'tabpaint']}, 05:49:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:49:45 INFO - 'tests': ['a11yr', 05:49:45 INFO - 'ts_paint', 05:49:45 INFO - 'tpaint', 05:49:45 INFO - 'sessionrestore', 05:49:45 INFO - 'sessionrestore_no_auto_restore', 05:49:45 INFO - 'tabpaint']}, 05:49:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:49:45 INFO - 'tests': ['a11yr', 05:49:45 INFO - 'ts_paint', 05:49:45 INFO - 'tpaint', 05:49:45 INFO - 'sessionrestore', 05:49:45 INFO - 'sessionrestore_no_auto_restore', 05:49:45 INFO - 'tabpaint']}, 05:49:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:49:45 INFO - 'tests': ['tsvgx', 05:49:45 INFO - 'tsvgr_opacity', 05:49:45 INFO - 'tart', 05:49:45 INFO - 'tscrollx', 05:49:45 INFO - 'cart']}, 05:49:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:49:45 INFO - 'tsvgr_opacity', 05:49:45 INFO - 'tart', 05:49:45 INFO - 'tscrollx', 05:49:45 INFO - 'cart']}, 05:49:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:45 INFO - 'talos_options': ['--disable-e10s'], 05:49:45 INFO - 'tests': ['tp5o']}, 05:49:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:45 INFO - 'tests': ['tp5o']}, 05:49:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:45 INFO - 'talos_options': ['--disable-e10s', 05:49:45 INFO - '--xperf_path', 05:49:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:45 INFO - 'tests': ['tp5n']}, 05:49:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:45 INFO - 'talos_options': ['--xperf_path', 05:49:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:45 INFO - 'tests': ['tp5n']}}, 05:49:45 INFO - 'talos.zip': {'path': '', 05:49:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:49:45 INFO - Running post-action listener: _resource_record_post_action 05:49:45 INFO - [mozharness: 2016-08-08 12:49:45.230497Z] Finished populate-webroot step (success) 05:49:45 INFO - [mozharness: 2016-08-08 12:49:45.230585Z] Running create-virtualenv step. 05:49:45 INFO - Running pre-action listener: _resource_record_pre_action 05:49:45 INFO - Running main action method: create_virtualenv 05:49:45 INFO - Creating virtualenv /builds/slave/test/build/venv 05:49:45 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 05:49:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:49:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:49:45 INFO - Using real prefix '/usr' 05:49:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:49:45 INFO - Installing distribute.............................................................................................................................................................................................done. 05:49:47 INFO - Installing pip.................done. 05:49:47 INFO - Return code: 0 05:49:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b3b0>, '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 0x124c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c740>, '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': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', '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 05:49:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:49:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:49:47 INFO - Using env: {'DISPLAY': ':0', 05:49:47 INFO - 'HOME': '/home/cltbld', 05:49:47 INFO - 'LANG': 'en_US.UTF-8', 05:49:47 INFO - 'LANGUAGE': 'en_US:en', 05:49:47 INFO - 'LOGNAME': 'cltbld', 05:49:47 INFO - 'MAIL': '/var/mail/cltbld', 05:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:47 INFO - 'MOZ_NO_REMOTE': '1', 05:49:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:47 INFO - 'NO_EM_RESTART': '1', 05:49:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:47 INFO - 'PWD': '/builds/slave/test', 05:49:47 INFO - 'SHELL': '/bin/bash', 05:49:47 INFO - 'SHLVL': '1', 05:49:47 INFO - 'TERM': 'linux', 05:49:47 INFO - 'TMOUT': '86400', 05:49:47 INFO - 'USER': 'cltbld', 05:49:47 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', 05:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:47 INFO - '_': '/tools/buildbot/bin/python'} 05:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:48 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 05:49:48 INFO - Cleaning up... 05:49:48 INFO - Return code: 0 05:49:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:48 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 0xf8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b3b0>, '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 0x124c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c740>, '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': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', '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 05:49:48 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 05:49:48 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 05:49:48 INFO - Using env: {'DISPLAY': ':0', 05:49:48 INFO - 'HOME': '/home/cltbld', 05:49:48 INFO - 'LANG': 'en_US.UTF-8', 05:49:48 INFO - 'LANGUAGE': 'en_US:en', 05:49:48 INFO - 'LOGNAME': 'cltbld', 05:49:48 INFO - 'MAIL': '/var/mail/cltbld', 05:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:48 INFO - 'MOZ_NO_REMOTE': '1', 05:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:48 INFO - 'NO_EM_RESTART': '1', 05:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:48 INFO - 'PWD': '/builds/slave/test', 05:49:48 INFO - 'SHELL': '/bin/bash', 05:49:48 INFO - 'SHLVL': '1', 05:49:48 INFO - 'TERM': 'linux', 05:49:48 INFO - 'TMOUT': '86400', 05:49:48 INFO - 'USER': 'cltbld', 05:49:48 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', 05:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:48 INFO - '_': '/tools/buildbot/bin/python'} 05:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:48 INFO - Downloading/unpacking psutil>=3.1.1 05:49:48 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 05:49:48 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 05:49:48 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 05:49:48 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 05:49:48 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 05:49:48 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 05:49:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:49:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:50 INFO - Installing collected packages: psutil 05:49:50 INFO - Running setup.py install for psutil 05:49:50 INFO - building 'psutil._psutil_linux' extension 05:49:50 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 05:49:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:49:50 INFO - building 'psutil._psutil_posix' extension 05:49:50 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 05:49:50 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:49:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:50 INFO - Successfully installed psutil 05:49:50 INFO - Cleaning up... 05:49:50 INFO - Return code: 0 05:49:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b3b0>, '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 0x124c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c740>, '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': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', '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 05:49:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:49:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:49:50 INFO - Using env: {'DISPLAY': ':0', 05:49:50 INFO - 'HOME': '/home/cltbld', 05:49:50 INFO - 'LANG': 'en_US.UTF-8', 05:49:50 INFO - 'LANGUAGE': 'en_US:en', 05:49:50 INFO - 'LOGNAME': 'cltbld', 05:49:50 INFO - 'MAIL': '/var/mail/cltbld', 05:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:50 INFO - 'MOZ_NO_REMOTE': '1', 05:49:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:50 INFO - 'NO_EM_RESTART': '1', 05:49:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:50 INFO - 'PWD': '/builds/slave/test', 05:49:50 INFO - 'SHELL': '/bin/bash', 05:49:50 INFO - 'SHLVL': '1', 05:49:50 INFO - 'TERM': 'linux', 05:49:50 INFO - 'TMOUT': '86400', 05:49:50 INFO - 'USER': 'cltbld', 05:49:50 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', 05:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:50 INFO - '_': '/tools/buildbot/bin/python'} 05:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:49:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:49:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:49:52 INFO - Installing collected packages: mozsystemmonitor 05:49:52 INFO - Running setup.py install for mozsystemmonitor 05:49:53 INFO - Successfully installed mozsystemmonitor 05:49:53 INFO - Cleaning up... 05:49:53 INFO - Return code: 0 05:49:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b3b0>, '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 0x124c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c740>, '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': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', '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 05:49:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:49:53 INFO - Using env: {'DISPLAY': ':0', 05:49:53 INFO - 'HOME': '/home/cltbld', 05:49:53 INFO - 'LANG': 'en_US.UTF-8', 05:49:53 INFO - 'LANGUAGE': 'en_US:en', 05:49:53 INFO - 'LOGNAME': 'cltbld', 05:49:53 INFO - 'MAIL': '/var/mail/cltbld', 05:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:53 INFO - 'MOZ_NO_REMOTE': '1', 05:49:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:53 INFO - 'NO_EM_RESTART': '1', 05:49:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:53 INFO - 'PWD': '/builds/slave/test', 05:49:53 INFO - 'SHELL': '/bin/bash', 05:49:53 INFO - 'SHLVL': '1', 05:49:53 INFO - 'TERM': 'linux', 05:49:53 INFO - 'TMOUT': '86400', 05:49:53 INFO - 'USER': 'cltbld', 05:49:53 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', 05:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:53 INFO - '_': '/tools/buildbot/bin/python'} 05:49:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:53 INFO - Downloading/unpacking jsonschema==2.5.1 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:49:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:55 INFO - Downloading functools32-3.2.3-2.tar.gz 05:49:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:49:55 INFO - warning: no files found matching '*.txt' 05:49:55 INFO - no previously-included directories found matching 'build' 05:49:55 INFO - no previously-included directories found matching 'dist' 05:49:55 INFO - no previously-included directories found matching '.git*' 05:49:55 INFO - Installing collected packages: jsonschema, functools32 05:49:55 INFO - Running setup.py install for functools32 05:49:55 INFO - warning: no files found matching '*.txt' 05:49:55 INFO - no previously-included directories found matching 'build' 05:49:55 INFO - no previously-included directories found matching 'dist' 05:49:55 INFO - no previously-included directories found matching '.git*' 05:49:55 INFO - Successfully installed jsonschema functools32 05:49:55 INFO - Cleaning up... 05:49:55 INFO - Return code: 0 05:49:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b3b0>, '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 0x124c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c740>, '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': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', '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 05:49:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:49:55 INFO - Using env: {'DISPLAY': ':0', 05:49:55 INFO - 'HOME': '/home/cltbld', 05:49:55 INFO - 'LANG': 'en_US.UTF-8', 05:49:55 INFO - 'LANGUAGE': 'en_US:en', 05:49:55 INFO - 'LOGNAME': 'cltbld', 05:49:55 INFO - 'MAIL': '/var/mail/cltbld', 05:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:55 INFO - 'MOZ_NO_REMOTE': '1', 05:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:55 INFO - 'NO_EM_RESTART': '1', 05:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:55 INFO - 'PWD': '/builds/slave/test', 05:49:55 INFO - 'SHELL': '/bin/bash', 05:49:55 INFO - 'SHLVL': '1', 05:49:55 INFO - 'TERM': 'linux', 05:49:55 INFO - 'TMOUT': '86400', 05:49:55 INFO - 'USER': 'cltbld', 05:49:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', 05:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:55 INFO - '_': '/tools/buildbot/bin/python'} 05:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:49:55 INFO - Cleaning up... 05:49:55 INFO - Return code: 0 05:49:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b3b0>, '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 0x124c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c740>, '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': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', '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 05:49:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:49:55 INFO - Using env: {'DISPLAY': ':0', 05:49:55 INFO - 'HOME': '/home/cltbld', 05:49:55 INFO - 'LANG': 'en_US.UTF-8', 05:49:55 INFO - 'LANGUAGE': 'en_US:en', 05:49:55 INFO - 'LOGNAME': 'cltbld', 05:49:55 INFO - 'MAIL': '/var/mail/cltbld', 05:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:55 INFO - 'MOZ_NO_REMOTE': '1', 05:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:55 INFO - 'NO_EM_RESTART': '1', 05:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:55 INFO - 'PWD': '/builds/slave/test', 05:49:55 INFO - 'SHELL': '/bin/bash', 05:49:55 INFO - 'SHLVL': '1', 05:49:55 INFO - 'TERM': 'linux', 05:49:55 INFO - 'TMOUT': '86400', 05:49:55 INFO - 'USER': 'cltbld', 05:49:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', 05:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:55 INFO - '_': '/tools/buildbot/bin/python'} 05:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:56 INFO - Downloading/unpacking blobuploader==1.2.4 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49:57 INFO - Downloading blobuploader-1.2.4.tar.gz 05:49:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:49:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:49:58 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 05:49:58 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 05:49:58 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 05:49:58 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 05:49:58 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 05:49:58 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 05:49:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:49:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:49:58 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 05:49:58 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 05:49:58 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 05:49:58 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 05:49:58 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 05:49:58 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 05:49:58 INFO - Downloading docopt-0.6.1.tar.gz 05:49:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:49:58 INFO - Installing collected packages: blobuploader, requests, docopt 05:49:58 INFO - Running setup.py install for blobuploader 05:49:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:49:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:49:58 INFO - Running setup.py install for requests 05:49:59 INFO - Running setup.py install for docopt 05:49:59 INFO - Successfully installed blobuploader requests docopt 05:49:59 INFO - Cleaning up... 05:49:59 INFO - Return code: 0 05:49:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:59 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')]} 05:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:59 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')]} 05:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:59 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 0xf8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b3b0>, '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 0x124c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c740>, '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': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', '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 05:49:59 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 05:49:59 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 05:49:59 INFO - Using env: {'DISPLAY': ':0', 05:49:59 INFO - 'HOME': '/home/cltbld', 05:49:59 INFO - 'LANG': 'en_US.UTF-8', 05:49:59 INFO - 'LANGUAGE': 'en_US:en', 05:49:59 INFO - 'LOGNAME': 'cltbld', 05:49:59 INFO - 'MAIL': '/var/mail/cltbld', 05:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:59 INFO - 'MOZ_NO_REMOTE': '1', 05:49:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:59 INFO - 'NO_EM_RESTART': '1', 05:49:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:59 INFO - 'PWD': '/builds/slave/test', 05:49:59 INFO - 'SHELL': '/bin/bash', 05:49:59 INFO - 'SHLVL': '1', 05:49:59 INFO - 'TERM': 'linux', 05:49:59 INFO - 'TMOUT': '86400', 05:49:59 INFO - 'USER': 'cltbld', 05:49:59 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', 05:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:59 INFO - '_': '/tools/buildbot/bin/python'} 05:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:59 INFO - Running setup.py (path:/tmp/pip-rSyaoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:59 INFO - Running setup.py (path:/tmp/pip-cIXTXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:59 INFO - Running setup.py (path:/tmp/pip-_nzgjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:59 INFO - Running setup.py (path:/tmp/pip-NYS2vC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:59 INFO - Running setup.py (path:/tmp/pip-ommdUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:59 INFO - Running setup.py (path:/tmp/pip-YmVNMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:50:00 INFO - Running setup.py (path:/tmp/pip-pfIuCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:50:00 INFO - Running setup.py (path:/tmp/pip-Rj8ayJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:50:00 INFO - Running setup.py (path:/tmp/pip-gw4KSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:50:00 INFO - Running setup.py (path:/tmp/pip-6Fz_4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:50:00 INFO - Running setup.py (path:/tmp/pip-4f6Vep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:50:00 INFO - Running setup.py (path:/tmp/pip-eDnJnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:50:00 INFO - Running setup.py (path:/tmp/pip-6MVpuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:50:00 INFO - Running setup.py (path:/tmp/pip-IUtsIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:00 INFO - Running setup.py (path:/tmp/pip-4SI7Yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:50:00 INFO - Running setup.py (path:/tmp/pip-t3ixA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:50:00 INFO - Running setup.py (path:/tmp/pip-aV6Iv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:50:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:50:00 INFO - Running setup.py install for manifestparser 05:50:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:50:00 INFO - Running setup.py install for mozcrash 05:50:01 INFO - Running setup.py install for mozdebug 05:50:01 INFO - Running setup.py install for mozdevice 05:50:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:50:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:50:01 INFO - Running setup.py install for mozfile 05:50:01 INFO - Running setup.py install for mozhttpd 05:50:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:50:01 INFO - Running setup.py install for mozinfo 05:50:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:50:01 INFO - Running setup.py install for mozInstall 05:50:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:50:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:50:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:50:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:50:01 INFO - Running setup.py install for mozleak 05:50:01 INFO - Running setup.py install for mozlog 05:50:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:50:01 INFO - Running setup.py install for moznetwork 05:50:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:50:01 INFO - Running setup.py install for mozprocess 05:50:02 INFO - Running setup.py install for mozprofile 05:50:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:50:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:50:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:50:02 INFO - Running setup.py install for mozrunner 05:50:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:50:02 INFO - Running setup.py install for mozscreenshot 05:50:02 INFO - Running setup.py install for moztest 05:50:02 INFO - Running setup.py install for mozversion 05:50:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:50:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:50:02 INFO - Cleaning up... 05:50:02 INFO - Return code: 0 05:50:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b3b0>, '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 0x124c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c740>, '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': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', '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 05:50:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:50:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:50:02 INFO - Using env: {'DISPLAY': ':0', 05:50:02 INFO - 'HOME': '/home/cltbld', 05:50:02 INFO - 'LANG': 'en_US.UTF-8', 05:50:02 INFO - 'LANGUAGE': 'en_US:en', 05:50:02 INFO - 'LOGNAME': 'cltbld', 05:50:02 INFO - 'MAIL': '/var/mail/cltbld', 05:50:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:02 INFO - 'MOZ_NO_REMOTE': '1', 05:50:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:02 INFO - 'NO_EM_RESTART': '1', 05:50:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:02 INFO - 'PWD': '/builds/slave/test', 05:50:02 INFO - 'SHELL': '/bin/bash', 05:50:02 INFO - 'SHLVL': '1', 05:50:02 INFO - 'TERM': 'linux', 05:50:02 INFO - 'TMOUT': '86400', 05:50:02 INFO - 'USER': 'cltbld', 05:50:02 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', 05:50:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:02 INFO - '_': '/tools/buildbot/bin/python'} 05:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:50:02 INFO - Running setup.py (path:/tmp/pip-3HOyXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:50:02 INFO - Running setup.py (path:/tmp/pip-Ds5T1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:50:03 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)) 05:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:50:03 INFO - Running setup.py (path:/tmp/pip-Hm6MOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:50:03 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)) 05:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:50:03 INFO - Running setup.py (path:/tmp/pip-UBoRV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:50:03 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)) 05:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:50:03 INFO - Running setup.py (path:/tmp/pip-YY7bDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:50:03 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)) 05:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:50:03 INFO - Running setup.py (path:/tmp/pip-_DtrJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:50:03 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)) 05:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:50:03 INFO - Running setup.py (path:/tmp/pip-Z4nDzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:50:03 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)) 05:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:50:03 INFO - Running setup.py (path:/tmp/pip-PPgv0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:50:03 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)) 05:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:50:03 INFO - Running setup.py (path:/tmp/pip-inRxHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:50:03 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)) 05:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:50:03 INFO - Running setup.py (path:/tmp/pip-kBJPp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:50:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:50:03 INFO - Running setup.py (path:/tmp/pip-sof8qF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:50:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:50:03 INFO - Running setup.py (path:/tmp/pip-3sEY1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:50:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:50:03 INFO - Running setup.py (path:/tmp/pip-gSQoDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:50:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:50:03 INFO - Running setup.py (path:/tmp/pip-cpFrEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:50:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:03 INFO - Running setup.py (path:/tmp/pip-a_ZLNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:50:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:50:03 INFO - Running setup.py (path:/tmp/pip-genJmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:50:04 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)) 05:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:50:04 INFO - Running setup.py (path:/tmp/pip-hvq8cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:50:04 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)) 05:50:04 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)) 05:50:04 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)) 05:50:04 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)) 05:50:04 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)) 05:50:04 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)) 05:50:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:50:04 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 05:50:04 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 05:50:04 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 05:50:04 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 05:50:04 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 05:50:04 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 05:50:05 INFO - Downloading blessings-1.6.tar.gz 05:50:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:50:06 INFO - Installing collected packages: blessings 05:50:06 INFO - Running setup.py install for blessings 05:50:06 INFO - Successfully installed blessings 05:50:06 INFO - Cleaning up... 05:50:06 INFO - Return code: 0 05:50:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:50:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:50:06 INFO - Reading from file tmpfile_stdout 05:50:06 INFO - Current package versions: 05:50:06 INFO - argparse == 1.2.1 05:50:06 INFO - blessings == 1.6 05:50:06 INFO - blobuploader == 1.2.4 05:50:06 INFO - docopt == 0.6.1 05:50:06 INFO - functools32 == 3.2.3-2 05:50:06 INFO - jsonschema == 2.5.1 05:50:06 INFO - manifestparser == 1.1 05:50:06 INFO - mozInstall == 1.12 05:50:06 INFO - mozcrash == 0.17 05:50:06 INFO - mozdebug == 0.1 05:50:06 INFO - mozdevice == 0.48 05:50:06 INFO - mozfile == 1.2 05:50:06 INFO - mozhttpd == 0.7 05:50:06 INFO - mozinfo == 0.9 05:50:06 INFO - mozleak == 0.1 05:50:06 INFO - mozlog == 3.3 05:50:06 INFO - moznetwork == 0.27 05:50:06 INFO - mozprocess == 0.23 05:50:06 INFO - mozprofile == 0.28 05:50:06 INFO - mozrunner == 6.12 05:50:06 INFO - mozscreenshot == 0.1 05:50:06 INFO - mozsystemmonitor == 0.3 05:50:06 INFO - moztest == 0.7 05:50:06 INFO - mozversion == 1.4 05:50:06 INFO - psutil == 3.1.1 05:50:06 INFO - requests == 1.2.3 05:50:06 INFO - wsgiref == 0.1.2 05:50:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:06 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 0xf8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b3b0>, '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 0x124c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c740>, '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': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', '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 05:50:06 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 05:50:06 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 05:50:06 INFO - Using env: {'DISPLAY': ':0', 05:50:06 INFO - 'HOME': '/home/cltbld', 05:50:06 INFO - 'LANG': 'en_US.UTF-8', 05:50:06 INFO - 'LANGUAGE': 'en_US:en', 05:50:06 INFO - 'LOGNAME': 'cltbld', 05:50:06 INFO - 'MAIL': '/var/mail/cltbld', 05:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:06 INFO - 'MOZ_NO_REMOTE': '1', 05:50:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:06 INFO - 'NO_EM_RESTART': '1', 05:50:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:06 INFO - 'PWD': '/builds/slave/test', 05:50:06 INFO - 'SHELL': '/bin/bash', 05:50:06 INFO - 'SHLVL': '1', 05:50:06 INFO - 'TERM': 'linux', 05:50:06 INFO - 'TMOUT': '86400', 05:50:06 INFO - 'USER': 'cltbld', 05:50:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', 05:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:06 INFO - '_': '/tools/buildbot/bin/python'} 05:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:50:06 INFO - Cleaning up... 05:50:06 INFO - Return code: 0 05:50:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:50:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:50:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:50:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf8c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124b3b0>, '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 0x124c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c740>, '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': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', '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 05:50:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:50:06 INFO - Using env: {'DISPLAY': ':0', 05:50:06 INFO - 'HOME': '/home/cltbld', 05:50:06 INFO - 'LANG': 'en_US.UTF-8', 05:50:06 INFO - 'LANGUAGE': 'en_US:en', 05:50:06 INFO - 'LOGNAME': 'cltbld', 05:50:06 INFO - 'MAIL': '/var/mail/cltbld', 05:50:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:06 INFO - 'MOZ_NO_REMOTE': '1', 05:50:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:06 INFO - 'NO_EM_RESTART': '1', 05:50:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:06 INFO - 'PWD': '/builds/slave/test', 05:50:06 INFO - 'SHELL': '/bin/bash', 05:50:06 INFO - 'SHLVL': '1', 05:50:06 INFO - 'TERM': 'linux', 05:50:06 INFO - 'TMOUT': '86400', 05:50:06 INFO - 'USER': 'cltbld', 05:50:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', 05:50:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:06 INFO - '_': '/tools/buildbot/bin/python'} 05:50:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:50:06 INFO - Cleaning up... 05:50:06 INFO - Return code: 0 05:50:06 INFO - Running post-action listener: _resource_record_post_action 05:50:06 INFO - Running post-action listener: _start_resource_monitoring 05:50:06 INFO - Starting resource monitoring. 05:50:06 INFO - [mozharness: 2016-08-08 12:50:06.941568Z] Finished create-virtualenv step (success) 05:50:06 INFO - [mozharness: 2016-08-08 12:50:06.941996Z] Running install step. 05:50:06 INFO - Running pre-action listener: _resource_record_pre_action 05:50:06 INFO - Running main action method: install 05:50:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:50:07 INFO - Reading from file tmpfile_stdout 05:50:07 INFO - Detecting whether we're running mozinstall >=1.0... 05:50:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:50:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:50:07 INFO - Reading from file tmpfile_stdout 05:50:07 INFO - Output received: 05:50:07 INFO - Usage: mozinstall [options] installer 05:50:07 INFO - Options: 05:50:07 INFO - -h, --help show this help message and exit 05:50:07 INFO - -d DEST, --destination=DEST 05:50:07 INFO - Directory to install application into. [default: 05:50:07 INFO - "/builds/slave/test"] 05:50:07 INFO - --app=APP Application being installed. [default: firefox] 05:50:07 INFO - mkdir: /builds/slave/test/build/application 05:50:07 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'] 05:50:07 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 05:50:24 INFO - Reading from file tmpfile_stdout 05:50:24 INFO - Output received: 05:50:24 INFO - /builds/slave/test/build/application/firefox/firefox 05:50:24 INFO - Running post-action listener: _resource_record_post_action 05:50:24 INFO - [mozharness: 2016-08-08 12:50:24.291945Z] Finished install step (success) 05:50:24 INFO - [mozharness: 2016-08-08 12:50:24.292195Z] Running run-tests step. 05:50:24 INFO - Running pre-action listener: _resource_record_pre_action 05:50:24 INFO - Running main action method: run_tests 05:50:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:50:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:50:24 INFO - Python 2.7.3 05:50:24 INFO - Return code: 0 05:50:24 INFO - grabbing minidump binary from tooltool 05:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:50:24 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 0x124b3b0>, '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 0x124c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x124c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:50:24 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 05:50:24 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 05:50:24 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 05:50:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:50:24 INFO - Return code: 0 05:50:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:50:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:50:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:50:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:50:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:50:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:50:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:50:24 INFO - Using env: {'DISPLAY': ':0', 05:50:24 INFO - 'HOME': '/home/cltbld', 05:50:24 INFO - 'LANG': 'en_US.UTF-8', 05:50:24 INFO - 'LANGUAGE': 'en_US:en', 05:50:24 INFO - 'LOGNAME': 'cltbld', 05:50:24 INFO - 'MAIL': '/var/mail/cltbld', 05:50:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:50:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:24 INFO - 'MOZ_NO_REMOTE': '1', 05:50:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:50:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:50:24 INFO - 'NO_EM_RESTART': '1', 05:50:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:24 INFO - 'PWD': '/builds/slave/test', 05:50:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:50:24 INFO - 'SHELL': '/bin/bash', 05:50:24 INFO - 'SHLVL': '1', 05:50:24 INFO - 'TERM': 'linux', 05:50:24 INFO - 'TMOUT': '86400', 05:50:24 INFO - 'USER': 'cltbld', 05:50:24 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217', 05:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:24 INFO - '_': '/tools/buildbot/bin/python'} 05:50:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:50:24 INFO - mozversion application_buildid: 20160808030441 05:50:24 INFO - mozversion application_changeset: e78975b53563d80c99ebfbdf8a9fbf6b829a8a48 05:50:24 INFO - mozversion application_display_name: Nightly 05:50:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:50:24 INFO - mozversion application_name: Firefox 05:50:24 INFO - mozversion application_remotingname: firefox 05:50:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:50:24 INFO - mozversion application_vendor: Mozilla 05:50:24 INFO - mozversion application_version: 51.0a1 05:50:24 INFO - mozversion platform_buildid: 20160808030441 05:50:24 INFO - mozversion platform_changeset: e78975b53563d80c99ebfbdf8a9fbf6b829a8a48 05:50:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:50:24 INFO - mozversion platform_version: 51.0a1 05:50:24 INFO - using testdate: 1470660624 05:50:24 INFO - actual date: 1470660624 05:50:24 INFO - starting webserver on 'localhost:41929' 05:50:24 INFO - SUITE-START | Running 2 tests 05:50:24 INFO - TEST-START | dromaeo_css 05:50:24 INFO - operating with platform_type : linux_ 05:50:24 INFO - Initialising browser for dromaeo_css test... 05:50:24 INFO - TEST-INFO | started process 21044 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp92M7sk/profile http://localhost:41929/getInfo.html) 05:50:28 INFO - PROCESS | 21044 | __metrics Screen width/height:1600/1200 05:50:28 INFO - PROCESS | 21044 | colorDepth:24 05:50:28 INFO - PROCESS | 21044 | Browser inner width/height: 1024/697 05:50:28 INFO - PROCESS | 21044 | __metrics 05:50:29 ERROR - PROCESS | 21044 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:50:30 INFO - TEST-INFO | 21044: exit 0 05:50:30 INFO - Browser initialized. 05:50:30 INFO - Running cycle 1/1 for dromaeo_css test... 05:50:30 INFO - TEST-INFO | started process 21164 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp92M7sk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:42 INFO - PROCESS | 21164 | RSS: Main: 163336192 05:50:42 INFO - PROCESS | 21164 | 05:51:32 INFO - PROCESS | 21164 | 1470660692061 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] 05:53:41 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:41929/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41929/tests/dromaeo/cssquery-ext.html) 05:53:42 INFO - PROCESS | 21164 | RSS: Main: 165658624 05:53:42 INFO - PROCESS | 21164 | 05:56:45 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:41929/tests/dromaeo/cssquery-ext.html (next: http://localhost:41929/tests/dromaeo/cssquery-jquery.html) 05:56:45 INFO - PROCESS | 21164 | RSS: Main: 164982784 05:56:45 INFO - PROCESS | 21164 | 05:59:47 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:41929/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41929/tests/dromaeo/cssquery-mootools.html) 05:59:48 INFO - PROCESS | 21164 | RSS: Main: 169553920 05:59:48 INFO - PROCESS | 21164 | 06:02:49 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:41929/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41929/tests/dromaeo/cssquery-prototype.html) 06:02:50 INFO - PROCESS | 21164 | RSS: Main: 164044800 06:02:50 INFO - PROCESS | 21164 | 06:05:53 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:41929/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41929/tests/dromaeo/cssquery-yui.html) 06:05:53 INFO - PROCESS | 21164 | RSS: Main: 166555648 06:05:53 INFO - PROCESS | 21164 | 06:08:56 INFO - PROCESS | 21164 | Cycle 1(1): loaded http://localhost:41929/tests/dromaeo/cssquery-yui.html (next: http://localhost:41929/tests/dromaeo/cssquery-dojo.html) 06:08:56 INFO - PROCESS | 21164 | RSS: Main: 169824256 06:08:56 INFO - PROCESS | 21164 | 06:08:56 INFO - PROCESS | 21164 | __start_tp_report 06:08:56 INFO - PROCESS | 21164 | _x_x_mozilla_page_load 06:08:56 INFO - PROCESS | 21164 | _x_x_mozilla_page_load_details 06:08:56 INFO - PROCESS | 21164 | |i|pagename|runs| 06:08:56 INFO - PROCESS | 21164 | |0;dojo.html;3084.9537256941144;3089.9073027809172;3119.8440077996092;3125.4374212641715;3126.4059828632558;5309.575233981282;5369.650972686777;5410.864728381793;5435.0488664483655;5450.427705090968;5379.569634429246;5409.918851217235;5449.836504904849;5456.863578410542;5522.088855338864;4929.162042452774;5041.621878359138;5042.495750424965;5093.567046801008;5115.309433226523;5083.7712302946275;5089.669171503859;5095.923561146586;5148.922766158511;5153.3558305211845;4857.247126695368;4876.829310974099;4894.730789806559;4907.509249075099;4936.48166942473;4958.429780575208;4961.206207006898;4970.577500912426;4978.303037574742;4978.925316120225;4916.778744956486;4935.111679897617;4970.900581988376;4971.6271279654175;4994.150994330972;5284.762185701653;5377.973110134424;5448.863778405532;5452.563794896399;5519.39286678465;5805.941940580582;5812.82561523155;5821.912671309934;5847.619904706181;5863.912041319383;5837.737301821428;5848.502877255439;5850.122481627747;5858.355580886099;5862.794802181946;5235.528802407802;5408.891822163535;5426.782928682808;5453.536449401845;5459.645123066988;6028.849278767978;6031.547633927473;6032.517398608101;6041.72812223451;6068.696565171724;5768.682722450306;5784.248047753765;5787.479126878517;5788.768449261982;5790.913136302959;5633.943660563424;5669.858253543612;5699;5706.771729130871;5865;5566.137248726453;5605.215269862141;5635.21107045014;5649.350324712628;5681.460261275172;5649.830505084854;5666.943330566642;5709.34342550612;5740.56945729072;5752.165935939265;4182.1844740275965;4203.369494575838;4210.347396153601;4216.831326746896;4258.1483703258855;3714.665680088805;3760.2291530236234;3800.1639639279315;3813.3517302058162;3846;5519.724013799294;5536.197251398606;5547.084731019418;5570.415106413769;5570.415106413769;5742.942570574324;5823.650580965155;5847.152162936435;5850.882982340415;5857.560682948796;5439.700816455053;5440.265564148868;5460.890782184334;5510.8071217507195;5535.612507124543;4907.484714105039;4915.606751459874;4919.269051554898;4921.803127874917;4957.801687932442;5872.735726892385;5965.731542080617;5993.400659933972;5996.5502587305255;6000.129981152709;5687.60186786921;5723.399043100415;5755.7122143893475;5783.306003279633;5836.533077353716;5993.3706960768495;5998.820035398945;6005.849853753691;6009.54928380382;6017.669028203491;5551.22282880389;5625.662460252398;5679.148127780866;5682.090865461506;5687.374388817144;5800.912986305125;5858.619189752652;5871.236739223874;5934.139549765347;5961.254843144607;5702.857428564319;5752.13717942312;5756.798512052058;5763.7118144093465;5790.913136303043;5443.891122177455;5719.599628026164;5730.799422020209;5755.338136114233;5758.0499217630295;5644.8306550803545;5708.457696518824;5719.628224165416;5726.026575482095;5752.568557358299;5683.232763576864;5685.374608792947;5738.454846789548;5745.368009518866;5781.508571771446;5423.647462914898;5495.340559132929;5619.775208991595;5636.5208957237455;5657.858553536194 06:08:56 INFO - PROCESS | 21164 | |1;ext.html;531.4340227657547;564.5765675743193;576.3631187537768;601.2664549249913;602.5179856115107;31997.520037199432;35537.466937995916;42355;43044.354334684926;43349.349759753626;45158.774206128925;45782.855428614304;45785.313220301636;45864.31203531941;45940;9013.639454421815;9105.863412048824;9130.497822619753;9203.17171454569;9210.585523651418;9021.95489022554;9081.455112693227;9086.363954523185;9099.863502047474;9135.862962055575;9116.407433516833;9143;9143.634254629807;9156;9218.35471516994;9065.184133427958;9086.363954523185;9137.725868223964;9160.862587061232;9173.633054677804;8965.148310910517;9036.277097832224;9095.135962083592;9098.909010909872;9104.226140777975;43792.343114853305;44035.55964440347;44158.77920610376;44221.336679949825;44484.55515444869;3696.611855755134;3762.7366084374103;3826.559945606263;3839.3281175794123;3915.275674000319;32473.51289730656;34786.82606586976;35088.47367289493;35330;35346.29307413863;4450.643948484114;4452.688311818174;4518.909621807578;4622.491525932145;4643.466001409847;374330;382297;382435;382713;384297;50794;51232.74383628058;51417.742911285204;51471.13966452531;51758.48241517612;38203.42694859579;69668;69925.65037174782;70134.2986570138;70161.64919175372;17235.310587576358;17832.821671783116;17874.731879021823;17900.194491247665;17904.28382864697;13605.931970340085;13629.86370136286;13683.589492315246;13707.931460342834;13719.176849389069;20766.688499672517;20813.479663008548;21005;21024.15903363879;21037.15851365959;7937.8412431752195;8067.233612806774;8243.8351232975;8256.628451719687;8264.917350826414;1009.2279406254221;1051.369178492898;1067.3435836960214;1083.2904447586843;1174.8897292059094;33666;34169.14577135542;34174;34369;34456.943693883855;1150.6893138852463;1154.8556430446195;1155.422288855572;1171.6719318590808;1219.8353222314875;17515.474535763693;17623.823761762476;17818.376356827448;17886.195121219578;17912.373066942593;536523;537287;539979;548081;548088;60751;61315.38684613186;61357.38642613517;61370;61533.69233153895;1299.7010687541917;1346.3268365817091;1356.9389377478037;1357.2738584857054;1368.3363568669188;31295.687043129277;32659.836700816344;32998.67001330052;33181.33637327288;33502;53386.46613533815;53918.460815392915;53992.73003634957;54000.729996349764;54050.72974635102;383493;387109;457001;457618;460855;29299.560506592843;29877.402451951275;30074.69925300719;30078;30630.84684576652;49030.75484622554;49386.506134938194;50186;50864;51293;42074;42885.356719649855;43001;43055.7847210762;44698.77650611726;42113.57886421097;43018.78490607527;43213.567864320954;43727.84095712087;43754.34368484412;41815.58184418117;42643.57356426396;42749.786251068545;43254.56745432506;46199.921003555595;33544.66455335415;38622.42066369063;38641.227175456894;38911;39602.40596390999;26072.217833465027;26192.86903565546;26222.475550488503;26239.344016399744;26514 06:08:56 INFO - PROCESS | 21164 | |2;jquery.html;385.7396257526169;389.1264112068403;397.60438363827984;401.927653022456;423.1381919553964;13830.17018978862;18619.534511637215;19444.805551944475;20247.898760506196;20351.49121271971;18971.62056758864;19169.808301916975;19423.708644370345;19801.504962375948;19900.50248743782;5623.578231632623;5750.568707346955;5839.357670656224;5854.707264636772;5901.586888917777;5911.201987731644;5916.319623243317;5944.464998150165;6239.469645080151;6504.1869766279215;6510.837229069264;6519.054737063123;6520.152380190569;6651.1021012163465;6659.93340066598;6029.125776762388;6076.665783381913;6110.144579758815;6137.6624285664275;6312.242530896299;5961.612495187799;5961.940380596182;5986.371430999726;6009.399060093956;6020.608660437058;23161.884190578938;23298;23693;23823;23903.282901512983;2474;2573.6782902137234;2776;2793.664760228786;2892.421515696869;10227.94886025565;10360.326578772356;10586.258961872672;10754.408507532082;10892.673219803419;1914.996486016335;1935.9322423715103;1939.2824654877645;1996.19154242532;2003.2387692676834;81631;83775;84170.57914710448;84371.15628843756;86342;9335.253179745605;9946.950265248628;9954.751131221632;9965.252606054575;10033.44816035125;13510.054296199172;13666.453341866214;13676.452941882413;13685.863141368658;13694.93152534231;7841.960790196013;7924;7949.046114466301;8159.755207343789;8166.795830104176;7883.802904927308;7918.376732769769;7995.320397766255;8144.633491492897;8188;4060.675145988373;4135.276326642826;4191.476065491814;4259.1268789897995;4293.334533147367;2007.1068374573174;2037.2156719663037;2038.1809932642389;2038.2560365466795;2052.568960518308;869.6304070769897;994.796066806303;1033.509083185481;1073.1361254190451;1106.468894930438;19807.504812379517;20154.596908061758;20385;20594;20697.793022069585;988.2588058955783;1022.9693109206736;1053.2311412668794;1064.6593090211213;1072.2547829258747;10768.730781730519;11202.383868887126;11277.830832537518;11370.147238957112;11426.2001659883;456638;457182;472572;472716;474037;88023;96206;97631;97692;99900.5004974985;973.0998826085984;999.7400675824192;1014.9898501015043;1026.1431704526653;1035.0425856083093;17088.829111708725;17666.911665442105;18196.27214911442;18491.075446227904;18569;29852.552211717277;36540.63459365479;37402;42659;43388;61084;61663.691681541306;62779.37220627918;63353.68323158355;63378.36621633909;7587.58268295249;8018.4787988780545;8150.388720846079;8583.098774628825;8722.694705685524;13700.93149534246;13973.510927117502;14016;14139.222342771247;14261;12218.26690398579;12243.20419172751;12358.382080896099;12375.75248495043;12602.936985315015;12177.756444870876;12191.146619736888;12377.071719621244;12527.18573292733;12832.230066196058;12524;12722.173058751152;12771.74456510846;12840.33075700153;12853.614391568268;7807.9219207809465;7973.043234811859;8222.13667564921;8254.257116859511;8271;9034.367594268339;12338;12623.93688031554;12697.42861571213;13037.869621303666 06:08:56 INFO - PROCESS | 21164 | |3;mootools.html;1488.5013520470645;1501.2868887278544;1633.730434478311;1748.5628592851788;1781.7861856577213;8001.359891208704;8730.60712267948;8779.078196789325;9542.093501117391;9559.952200238999;8926.509042002688;9156.267498600097;9265.675701350454;9270.721878343644;9294.163525282724;2331.9533609327846;2390.2590197038885;2393.497365553236;2394.652775347582;2401.255610760661;2395.8802059896934;2439.878006099697;2451.8651474168914;2457.606782914734;2457.9631305530434;2416.673749043883;2418.7097548294228;2437.1348171399163;2452.1294940296207;2480.851148931061;2398.1486572266767;2405.9639105413435;2414.7223069346987;2426.8301218914685;2432.817538684588;2346.8709220992837;2356.375560476475;2360.62230043194;2365.7634236576378;2371.6916800815784;9338.346315757899;9359.625614975394;9364.484953327565;9373.062693730571;9404.529773511365;5316.308879845634;5361.035013697533;5367.5169234769055;5371.382291036542;5413.215083812865;3569.39320315547;3571.23218508022;3586.4261718125235;3652.2878038782446;3663.7984910829896;1102.3385968418966;1107.6123356825128;1128.4865386249237;1142.4173671427548;1149.4137989625267;12319.260844349368;12383.690407739788;12397.25616463006;12419.503219871194;12533.686657833536;4497.64018878489;4607.746573938465;4877.146499362598;4887.193613053877;4897.975510122498;10402.27184097106;10409.219308551888;10412.947935260276;10449.111825494767;10499.317544359745;5415;5447.291852059207;5475.178723191473;5485.122380419114;5503.559715222773;4430.579094986036;4903.607711383081;4940.555350018516;4972.378452693413;5010.849674509771;4052.2252563343404;4106.178764247163;4166.833246711693;4242.427272318259;4296.591823776736;1257.8239046533492;1344.1196016609138;1346.2662848747457;1359.904806663544;1364.6383708317303;914.3736540469799;942.1661829280998;998.236349192868;1007.6825799873017;1034.7257976636197;5922.170896074553;6030.668313242813;6078.300995385499;6192.411720886508;6286.811395658137;904.9230815380635;963.2775418436173;994.8159590475785;1001.379144930148;1045.46158728255;4171.270027745132;4296.484421869396;4345.826166953287;4350.978245108754;4436.0462500562535;11304.321740695585;11710.355930423908;11714;11736.647900562997;11750.647480575597;11546.249493782878;11634.825477617842;11653.825192622118;11658.708532286591;11723.882761172279;8297.460665056751;8362.163783621589;8513.616887240089;8520.403571749917;8577.999999999874;6071.757129714939;6201.6899155041165;6221.222347206599;6269.279032911274;6315.684215789101;10774.892251077388;10793.29843560166;10799.13606911461;10903.454827258764;10972.835407468734;10573.629922952967;10637.202209834139;10689.94655026751;10857.511411986638;10906.945465272624;6895.241523432318;7545.50954187976;7739.690412383442;7834.412419068479;7915.248051435105;9042.095790420904;9112.544372781467;9128.817423651622;9155;9184.954075229582;7934.2859142677435;8076.111627720828;8295.211954864279;8302.294304984143;8387.748367548984;7929.246721561442;7963.641636126504;8056.556889371141;8184.468009579358;8187;7273.3817625502425;7295.343419092307;7368.742094026683;7379.409647228316;7391.854262589307;5340.732963351739;5482.424345443671;5516.365617953987;5528.170774383874;5594.4125866785025;5334.359876814807;5421.1055175895535;5479.232907392889;5495.670259784426;5502.862428439321 06:08:56 INFO - PROCESS | 21164 | |4;prototype.html;321.74723153314955;339.2113336492655;345.04594795390767;348.5991110223244;349.8740453436764;5454.154606036066;5501.339839219294;5523.585731070166;5549.69476678783;5575.721213939297;5410.188471729242;5415.810446634368;5453.345598528173;5465.754041068151;5468.6171967962155;4292.012837047481;4304.428883457531;4321.2653848845775;4325.762083085429;4327.523972363053;3766.8699390182974;4280.5291417944;4286.914261714764;4287.614114729674;4307.2246995540945;4273.487181538219;4276.102018576103;4279.914401711964;4292.484901811771;4294.849680261192;4273.764942928137;4277.315629499265;4290.120525292307;4299.72051816634;4299.9570004300185;3504.229069604683;3719.293334266508;3746.4193050077283;3786.5198295116743;3805.809709514541;5368.946310536884;5370.650907690988;5372.91940620891;5377.919331209996;5378.677279363212;4831.975840120812;4841.661083724141;4861.562459378638;4873.829415970424;4893.877653058702;5554;5652.812909289054;5664.065429204176;5710.428957104298;5719.771209151629;4099.89750256243;4101.85643502479;4103.363978583325;4105.7331273467125;4109.849242212185;5717.885642287172;5875.353711091734;5937.812437512472;5970.880582388371;5992.9923475635715;4182.853600123981;4184.81168347419;4184.832606695698;4189.120284740238;4189.581041895847;4222.134462435193;4225.3873188387515;4234.767087810138;4238.660907127422;4238.682098842537;4595.954040459553;4844.685095468783;4844.927326090112;4854.878628034327;4862.6839255448285;5731.312242530923;5747.85630359236;5748.889543976077;5761.995413187878;5776.68228247442;1462.6197188730794;1475.1739026145178;1478.4012474947663;1479.4304192885602;1483.1768368555556;902.684759187006;944.4239014201331;949.2026697573933;958.2334132693817;958.6021800952666;4869.440014398389;4883.731394773322;4885.9967413360355;4890.462049174588;4949.752512374367;5114.616403769732;5159.690418574897;5160.277561141444;5165.560927321219;5190.6107041971245;4586.633069354443;4886.143265559136;4909.4354149273295;4914.8034078637165;4965.776540055706;2752.628395166627;2758;2759.5170845102025;2761.4753196892525;2766.2669392610974;5329.081530648963;5336.973315133399;5358;5385.75764090609;5395.379531353866;5223.947760522422;5266.8946621068135;5535.833924982257;5999.700014999233;6085.17850090241;6187.474064704461;6198.884200843891;6208.4722798561725;6219.6627725038425;6249.375062493714;5635.689367359363;5989.40105989415;5991.610545314541;5995;6000.549958753199;5855.94144058554;5870.853228669317;5884.411208973639;5894.970525147347;5916.792912248051;5969.850753731192;6138.478229350555;6157.507399408126;6183.8771420432395;6204.534659900435;4275.615194632498;4330.783460826883;4335.7615331157085;4381.255186618218;4384.320430333303;5714.628549144292;5900.203472531325;5908.793192238251;5941.287045554561;5950.19672344228;5755.913661295001;5756.568257380797;5770.855728606651;5772.393898640582;5781.768729250783;5680;5690.3456102548735;5702.173184888085;5721.509878973739;5730.799422020209;5508.779648814003;5717.599768016199;5725.914111288417;5758.2514273144225;5763.913541296968;5817.301923769175;5823;5839.795607153729;5845.853853653693;5864.296284445893;5484.2047903053035;5728.570357223308;5728.937582470391;5729.828105156852;5744.454276843693 06:08:56 INFO - PROCESS | 21164 | |5;yui.html;741.8627553902528;781.5232708048093;804.987925181122;844.8605980013298;858.0304256190506;13430.932845335772;14487.565373038826;14510.637234069154;14565.635859103528;14624.195669238188;15103.093814371145;15175.165365904899;15282.235888205601;15287.69424611507;15287.770683439758;789.3527307607764;795.3279478840385;814.3810703865075;816.5998660656265;819.5983967855738;809.348474478045;811.9878201826978;814.5316443045273;814.9307308878753;815.5473712089788;856.8757530158123;858.9914100858974;859.4370687199894;860.371928492201;860.5869182792263;847.1740053447901;853.3514528957975;854.3464249848839;857.9571021448903;858.0089996054567;632.2286810091681;634.9555531112824;636.5130675033603;636.5416899832113;637.827786497643;12552.18410803304;12585.119041667087;12618.68453288666;12640.873591264062;12653.620391388273;14311.141331520143;14336.211508367036;14388.136711797326;14547.490837820626;14719.779203311959;12269.815952760715;12276.32480213588;12486.81269780954;12593.74812503754;12617.306048167347;3925.8429662813455;3939.4484772131923;3976.8608098716695;3978.204359128157;4092.1406504634065;82064.58967705123;82102.48436336;83483;84240.57879710563;84604.57697711472;11492.310461372344;11872.643820685393;12006.279623222634;12187;12258.754824903452;22190.889045554668;22235.55528889413;22268.66597001046;22383.888080559493;22405.66391504129;8867.91132088671;8944.776380590407;9098.590563424661;9364.016778238323;9372.34393592442;4914.36113305268;5003.10027530449;5057.064443078042;5080.796768129308;5085.364329458817;3729.701623870084;3844;3875.2443273561385;3879.4568760373572;3884.8446062157764;590.6603702870866;594.1503649780855;597.7101105963604;611.8990366589552;617.5831313863124;580.9651420914674;603.3483837455537;643.8197304754676;682.6518475577491;733.2960358056325;10024.398536087712;10179.82322462662;10408.895911040792;10564.207684423698;10639.946800265949;618.3044075415158;680.5304340005381;726.9781906542812;729.6825880741894;736.6316841579211;4959.677620954626;5176.637635365563;5180.844574662766;5195.818146364859;5249.553787927993;77507.61246193845;98420.50789746005;100847.49576252219;102548;115256.42371788087;74528;91680;91980;94359.52820235855;94534;56780.148297775566;76316.61841690756;85628.57185714031;86246;87475;9749.415035097916;9959.402435853872;10311;10539.841902371318;10638.095761860019;49998;50791;50916.23625645544;52466.475335246156;53688.1946770791;69875.6506217486;70155;73668;75882.24117758752;76559;12376.381180941096;13420.644838790302;13542;13578.38897249646;13676.452941882611;14100.153990760587;14483.855161448251;15073.321700523722;15240.847591523943;15265.3893844245;13749.381277842322;14087.366068526735;14428.42286308536;14452.855471445571;15233.542993710207;13656.726865462437;13820.723585528032;13949.721005580035;13979.790303145664;14359.497417590333;13376.331183440983;13423.463061477432;13800.654983625489;13828.792568111285;14797.186154761592;11362.938455290085;11526.654200374001;11713.765724685289;11959.820602691141;12063.39683015828;9911.118813597146;10855.728606784893;11580.942095289469;11706.414679266172;11948.62590802069 06:08:56 INFO - PROCESS | 21164 | __end_tp_report 06:08:56 INFO - PROCESS | 21164 | __start_cc_report 06:08:56 INFO - PROCESS | 21164 | _x_x_mozilla_cycle_collect,352 06:08:56 INFO - PROCESS | 21164 | __end_cc_report 06:08:56 INFO - PROCESS | 21164 | __startTimestamp1470661736785__endTimestamp 06:08:56 INFO - PROCESS | 21164 | 06:08:56 INFO - PROCESS | 21164 | ------- Summary: start ------- 06:08:56 INFO - PROCESS | 21164 | Number of tests: 6 06:08:56 INFO - PROCESS | 21164 | 06:08:56 INFO - PROCESS | 21164 | [#0] dojo.html Cycles:165 Average:5386.91 Median:5625.66 stddev:637.85 (11.3%) stddev-sans-first:613.71 06:08:56 INFO - PROCESS | 21164 | Values: 3085.0 3089.9 3119.8 3125.4 3126.4 5309.6 5369.7 5410.9 5435.0 5450.4 5379.6 5409.9 5449.8 5456.9 5522.1 4929.2 5041.6 5042.5 5093.6 5115.3 5083.8 5089.7 5095.9 5148.9 5153.4 4857.2 4876.8 4894.7 4907.5 4936.5 4958.4 4961.2 4970.6 4978.3 4978.9 4916.8 4935.1 4970.9 4971.6 4994.2 5284.8 5378.0 5448.9 5452.6 5519.4 5805.9 5812.8 5821.9 5847.6 5863.9 5837.7 5848.5 5850.1 5858.4 5862.8 5235.5 5408.9 5426.8 5453.5 5459.6 6028.8 6031.5 6032.5 6041.7 6068.7 5768.7 5784.2 5787.5 5788.8 5790.9 5633.9 5669.9 5699.0 5706.8 5865.0 5566.1 5605.2 5635.2 5649.4 5681.5 5649.8 5666.9 5709.3 5740.6 5752.2 4182.2 4203.4 4210.3 4216.8 4258.1 3714.7 3760.2 3800.2 3813.4 3846.0 5519.7 5536.2 5547.1 5570.4 5570.4 5742.9 5823.7 5847.2 5850.9 5857.6 5439.7 5440.3 5460.9 5510.8 5535.6 4907.5 4915.6 4919.3 4921.8 4957.8 5872.7 5965.7 5993.4 5996.6 6000.1 5687.6 5723.4 5755.7 5783.3 5836.5 5993.4 5998.8 6005.8 6009.5 6017.7 5551.2 5625.7 5679.1 5682.1 5687.4 5800.9 5858.6 5871.2 5934.1 5961.3 5702.9 5752.1 5756.8 5763.7 5790.9 5443.9 5719.6 5730.8 5755.3 5758.0 5644.8 5708.5 5719.6 5726.0 5752.6 5683.2 5685.4 5738.5 5745.4 5781.5 5423.6 5495.3 5619.8 5636.5 5657.9 06:08:56 INFO - PROCESS | 21164 | 06:08:56 INFO - PROCESS | 21164 | [#1] ext.html Cycles:180 Average:61759.30 Median:43134.68 stddev:120842.41 (280.2%) stddev-sans-first:121093.96 06:08:56 INFO - PROCESS | 21164 | Values: 531.4 564.6 576.4 601.3 602.5 31997.5 35537.5 42355.0 43044.4 43349.3 45158.8 45782.9 45785.3 45864.3 45940.0 9013.6 9105.9 9130.5 9203.2 9210.6 9022.0 9081.5 9086.4 9099.9 9135.9 9116.4 9143.0 9143.6 9156.0 9218.4 9065.2 9086.4 9137.7 9160.9 9173.6 8965.1 9036.3 9095.1 9098.9 9104.2 43792.3 44035.6 44158.8 44221.3 44484.6 3696.6 3762.7 3826.6 3839.3 3915.3 32473.5 34786.8 35088.5 35330.0 35346.3 4450.6 4452.7 4518.9 4622.5 4643.5 374330.0 382297.0 382435.0 382713.0 384297.0 50794.0 51232.7 51417.7 51471.1 51758.5 38203.4 69668.0 69925.7 70134.3 70161.6 17235.3 17832.8 17874.7 17900.2 17904.3 13605.9 13629.9 13683.6 13707.9 13719.2 20766.7 20813.5 21005.0 21024.2 21037.2 7937.8 8067.2 8243.8 8256.6 8264.9 1009.2 1051.4 1067.3 1083.3 1174.9 33666.0 34169.1 34174.0 34369.0 34456.9 1150.7 1154.9 1155.4 1171.7 1219.8 17515.5 17623.8 17818.4 17886.2 17912.4 536523.0 537287.0 539979.0 548081.0 548088.0 60751.0 61315.4 61357.4 61370.0 61533.7 1299.7 1346.3 1356.9 1357.3 1368.3 31295.7 32659.8 32998.7 33181.3 33502.0 53386.5 53918.5 53992.7 54000.7 54050.7 383493.0 387109.0 457001.0 457618.0 460855.0 29299.6 29877.4 30074.7 30078.0 30630.8 49030.8 49386.5 50186.0 50864.0 51293.0 42074.0 42885.4 43001.0 43055.8 44698.8 42113.6 43018.8 43213.6 43727.8 43754.3 41815.6 42643.6 42749.8 43254.6 46199.9 33544.7 38622.4 38641.2 38911.0 39602.4 26072.2 26192.9 26222.5 26239.3 26514.0 06:08:56 INFO - PROCESS | 21164 | 06:08:56 INFO - PROCESS | 21164 | [#2] jquery.html Cycles:180 Average:28691.70 Median:33196.59 stddev:77252.77 (232.7%) stddev-sans-first:77440.25 06:08:56 INFO - PROCESS | 21164 | Values: 385.7 389.1 397.6 401.9 423.1 13830.2 18619.5 19444.8 20247.9 20351.5 18971.6 19169.8 19423.7 19801.5 19900.5 5623.6 5750.6 5839.4 5854.7 5901.6 5911.2 5916.3 5944.5 6239.5 6504.2 6510.8 6519.1 6520.2 6651.1 6659.9 6029.1 6076.7 6110.1 6137.7 6312.2 5961.6 5961.9 5986.4 6009.4 6020.6 23161.9 23298.0 23693.0 23823.0 23903.3 2474.0 2573.7 2776.0 2793.7 2892.4 10227.9 10360.3 10586.3 10754.4 10892.7 1915.0 1935.9 1939.3 1996.2 2003.2 81631.0 83775.0 84170.6 84371.2 86342.0 9335.3 9947.0 9954.8 9965.3 10033.4 13510.1 13666.5 13676.5 13685.9 13694.9 7842.0 7924.0 7949.0 8159.8 8166.8 7883.8 7918.4 7995.3 8144.6 8188.0 4060.7 4135.3 4191.5 4259.1 4293.3 2007.1 2037.2 2038.2 2038.3 2052.6 869.6 994.8 1033.5 1073.1 1106.5 19807.5 20154.6 20385.0 20594.0 20697.8 988.3 1023.0 1053.2 1064.7 1072.3 10768.7 11202.4 11277.8 11370.1 11426.2 456638.0 457182.0 472572.0 472716.0 474037.0 88023.0 96206.0 97631.0 97692.0 99900.5 973.1 999.7 1015.0 1026.1 1035.0 17088.8 17666.9 18196.3 18491.1 18569.0 29852.6 36540.6 37402.0 42659.0 43388.0 61084.0 61663.7 62779.4 63353.7 63378.4 7587.6 8018.5 8150.4 8583.1 8722.7 13700.9 13973.5 14016.0 14139.2 14261.0 12218.3 12243.2 12358.4 12375.8 12602.9 12177.8 12191.1 12377.1 12527.2 12832.2 12524.0 12722.2 12771.7 12840.3 12853.6 7807.9 7973.0 8222.1 8254.3 8271.0 9034.4 12338.0 12623.9 12697.4 13037.9 06:08:56 INFO - PROCESS | 21164 | 06:08:56 INFO - PROCESS | 21164 | [#3] mootools.html Cycles:180 Average:6051.25 Median:4552.69 stddev:3448.84 (75.8%) stddev-sans-first:3441.47 06:08:56 INFO - PROCESS | 21164 | Values: 1488.5 1501.3 1633.7 1748.6 1781.8 8001.4 8730.6 8779.1 9542.1 9560.0 8926.5 9156.3 9265.7 9270.7 9294.2 2332.0 2390.3 2393.5 2394.7 2401.3 2395.9 2439.9 2451.9 2457.6 2458.0 2416.7 2418.7 2437.1 2452.1 2480.9 2398.1 2406.0 2414.7 2426.8 2432.8 2346.9 2356.4 2360.6 2365.8 2371.7 9338.3 9359.6 9364.5 9373.1 9404.5 5316.3 5361.0 5367.5 5371.4 5413.2 3569.4 3571.2 3586.4 3652.3 3663.8 1102.3 1107.6 1128.5 1142.4 1149.4 12319.3 12383.7 12397.3 12419.5 12533.7 4497.6 4607.7 4877.1 4887.2 4898.0 10402.3 10409.2 10412.9 10449.1 10499.3 5415.0 5447.3 5475.2 5485.1 5503.6 4430.6 4903.6 4940.6 4972.4 5010.8 4052.2 4106.2 4166.8 4242.4 4296.6 1257.8 1344.1 1346.3 1359.9 1364.6 914.4 942.2 998.2 1007.7 1034.7 5922.2 6030.7 6078.3 6192.4 6286.8 904.9 963.3 994.8 1001.4 1045.5 4171.3 4296.5 4345.8 4351.0 4436.0 11304.3 11710.4 11714.0 11736.6 11750.6 11546.2 11634.8 11653.8 11658.7 11723.9 8297.5 8362.2 8513.6 8520.4 8578.0 6071.8 6201.7 6221.2 6269.3 6315.7 10774.9 10793.3 10799.1 10903.5 10972.8 10573.6 10637.2 10689.9 10857.5 10906.9 6895.2 7545.5 7739.7 7834.4 7915.2 9042.1 9112.5 9128.8 9155.0 9185.0 7934.3 8076.1 8295.2 8302.3 8387.7 7929.2 7963.6 8056.6 8184.5 8187.0 7273.4 7295.3 7368.7 7379.4 7391.9 5340.7 5482.4 5516.4 5528.2 5594.4 5334.4 5421.1 5479.2 5495.7 5502.9 06:08:56 INFO - PROCESS | 21164 | 06:08:56 INFO - PROCESS | 21164 | [#4] prototype.html Cycles:180 Average:4752.51 Median:5369.80 stddev:1407.76 (26.2%) stddev-sans-first:1371.87 06:08:56 INFO - PROCESS | 21164 | Values: 321.7 339.2 345.0 348.6 349.9 5454.2 5501.3 5523.6 5549.7 5575.7 5410.2 5415.8 5453.3 5465.8 5468.6 4292.0 4304.4 4321.3 4325.8 4327.5 3766.9 4280.5 4286.9 4287.6 4307.2 4273.5 4276.1 4279.9 4292.5 4294.8 4273.8 4277.3 4290.1 4299.7 4300.0 3504.2 3719.3 3746.4 3786.5 3805.8 5368.9 5370.7 5372.9 5377.9 5378.7 4832.0 4841.7 4861.6 4873.8 4893.9 5554.0 5652.8 5664.1 5710.4 5719.8 4099.9 4101.9 4103.4 4105.7 4109.8 5717.9 5875.4 5937.8 5970.9 5993.0 4182.9 4184.8 4184.8 4189.1 4189.6 4222.1 4225.4 4234.8 4238.7 4238.7 4596.0 4844.7 4844.9 4854.9 4862.7 5731.3 5747.9 5748.9 5762.0 5776.7 1462.6 1475.2 1478.4 1479.4 1483.2 902.7 944.4 949.2 958.2 958.6 4869.4 4883.7 4886.0 4890.5 4949.8 5114.6 5159.7 5160.3 5165.6 5190.6 4586.6 4886.1 4909.4 4914.8 4965.8 2752.6 2758.0 2759.5 2761.5 2766.3 5329.1 5337.0 5358.0 5385.8 5395.4 5223.9 5266.9 5535.8 5999.7 6085.2 6187.5 6198.9 6208.5 6219.7 6249.4 5635.7 5989.4 5991.6 5995.0 6000.5 5855.9 5870.9 5884.4 5895.0 5916.8 5969.9 6138.5 6157.5 6183.9 6204.5 4275.6 4330.8 4335.8 4381.3 4384.3 5714.6 5900.2 5908.8 5941.3 5950.2 5755.9 5756.6 5770.9 5772.4 5781.8 5680.0 5690.3 5702.2 5721.5 5730.8 5508.8 5717.6 5725.9 5758.3 5763.9 5817.3 5823.0 5839.8 5845.9 5864.3 5484.2 5728.6 5728.9 5729.8 5744.5 06:08:56 INFO - PROCESS | 21164 | 06:08:56 INFO - PROCESS | 21164 | [#5] yui.html Cycles:180 Average:20166.14 Median:4937.02 stddev:27891.37 (564.9%) stddev-sans-first:27931.47 06:08:56 INFO - PROCESS | 21164 | Values: 741.9 781.5 805.0 844.9 858.0 13430.9 14487.6 14510.6 14565.6 14624.2 15103.1 15175.2 15282.2 15287.7 15287.8 789.4 795.3 814.4 816.6 819.6 809.3 812.0 814.5 814.9 815.5 856.9 859.0 859.4 860.4 860.6 847.2 853.4 854.3 858.0 858.0 632.2 635.0 636.5 636.5 637.8 12552.2 12585.1 12618.7 12640.9 12653.6 14311.1 14336.2 14388.1 14547.5 14719.8 12269.8 12276.3 12486.8 12593.7 12617.3 3925.8 3939.4 3976.9 3978.2 4092.1 82064.6 82102.5 83483.0 84240.6 84604.6 11492.3 11872.6 12006.3 12187.0 12258.8 22190.9 22235.6 22268.7 22383.9 22405.7 8867.9 8944.8 9098.6 9364.0 9372.3 4914.4 5003.1 5057.1 5080.8 5085.4 3729.7 3844.0 3875.2 3879.5 3884.8 590.7 594.2 597.7 611.9 617.6 581.0 603.3 643.8 682.7 733.3 10024.4 10179.8 10408.9 10564.2 10639.9 618.3 680.5 727.0 729.7 736.6 4959.7 5176.6 5180.8 5195.8 5249.6 77507.6 98420.5 100847.5 102548.0 115256.4 74528.0 91680.0 91980.0 94359.5 94534.0 56780.1 76316.6 85628.6 86246.0 87475.0 9749.4 9959.4 10311.0 10539.8 10638.1 49998.0 50791.0 50916.2 52466.5 53688.2 69875.7 70155.0 73668.0 75882.2 76559.0 12376.4 13420.6 13542.0 13578.4 13676.5 14100.2 14483.9 15073.3 15240.8 15265.4 13749.4 14087.4 14428.4 14452.9 15233.5 13656.7 13820.7 13949.7 13979.8 14359.5 13376.3 13423.5 13800.7 13828.8 14797.2 11362.9 11526.7 11713.8 11959.8 12063.4 9911.1 10855.7 11580.9 11706.4 11948.6 06:08:56 INFO - PROCESS | 21164 | -------- Summary: end -------- 06:08:56 INFO - PROCESS | 21164 | 06:08:57 INFO - TEST-INFO | 21164: exit 0 06:08:57 INFO - TEST-OK | dromaeo_css | took 1112925ms 06:08:57 INFO - TEST-START | kraken 06:08:57 INFO - operating with platform_type : linux_ 06:08:57 INFO - Initialising browser for kraken test... 06:08:57 INFO - TEST-INFO | started process 21404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkEl1Oa/profile http://localhost:41929/getInfo.html) 06:09:01 INFO - PROCESS | 21404 | __metrics Screen width/height:1600/1200 06:09:01 INFO - PROCESS | 21404 | colorDepth:24 06:09:01 INFO - PROCESS | 21404 | Browser inner width/height: 1024/697 06:09:01 INFO - PROCESS | 21404 | __metrics 06:09:02 ERROR - PROCESS | 21404 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:09:03 INFO - TEST-INFO | 21404: exit 0 06:09:03 INFO - Browser initialized. 06:09:03 INFO - Running cycle 1/1 for kraken test... 06:09:03 INFO - TEST-INFO | started process 21522 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkEl1Oa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:09:15 INFO - PROCESS | 21522 | RSS: Main: 164249600 06:09:15 INFO - PROCESS | 21522 | 06:09:17 INFO - PROCESS | 21522 | Cycle 1(1): loaded http://localhost:41929/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41929/tests/kraken/driver.html?testName=audio-beat-detection) 06:09:18 INFO - PROCESS | 21522 | RSS: Main: 169213952 06:09:18 INFO - PROCESS | 21522 | 06:09:21 INFO - PROCESS | 21522 | Cycle 1(1): loaded http://localhost:41929/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41929/tests/kraken/driver.html?testName=audio-dft) 06:09:21 INFO - PROCESS | 21522 | RSS: Main: 167833600 06:09:21 INFO - PROCESS | 21522 | 06:09:24 INFO - PROCESS | 21522 | Cycle 1(1): loaded http://localhost:41929/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41929/tests/kraken/driver.html?testName=audio-fft) 06:09:25 INFO - PROCESS | 21522 | RSS: Main: 164077568 06:09:25 INFO - PROCESS | 21522 | 06:09:27 INFO - PROCESS | 21522 | Cycle 1(1): loaded http://localhost:41929/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41929/tests/kraken/driver.html?testName=audio-oscillator) 06:09:28 INFO - PROCESS | 21522 | RSS: Main: 164884480 06:09:28 INFO - PROCESS | 21522 | 06:09:30 INFO - PROCESS | 21522 | Cycle 1(1): loaded http://localhost:41929/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41929/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:09:30 INFO - PROCESS | 21522 | RSS: Main: 165462016 06:09:30 INFO - PROCESS | 21522 | 06:09:34 INFO - PROCESS | 21522 | Cycle 1(1): loaded http://localhost:41929/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41929/tests/kraken/driver.html?testName=imaging-darkroom) 06:09:34 INFO - PROCESS | 21522 | RSS: Main: 165658624 06:09:34 INFO - PROCESS | 21522 | 06:09:38 INFO - PROCESS | 21522 | Cycle 1(1): loaded http://localhost:41929/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41929/tests/kraken/driver.html?testName=imaging-desaturate) 06:09:38 INFO - PROCESS | 21522 | RSS: Main: 163078144 06:09:38 INFO - PROCESS | 21522 | 06:09:41 INFO - PROCESS | 21522 | Cycle 1(1): loaded http://localhost:41929/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41929/tests/kraken/driver.html?testName=json-parse-financial) 06:09:42 INFO - PROCESS | 21522 | RSS: Main: 165089280 06:09:42 INFO - PROCESS | 21522 | 06:09:43 INFO - PROCESS | 21522 | Cycle 1(1): loaded http://localhost:41929/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41929/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:09:44 INFO - PROCESS | 21522 | RSS: Main: 164966400 06:09:44 INFO - PROCESS | 21522 | 06:09:46 INFO - PROCESS | 21522 | Cycle 1(1): loaded http://localhost:41929/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41929/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:09:46 INFO - PROCESS | 21522 | RSS: Main: 165048320 06:09:46 INFO - PROCESS | 21522 | 06:09:48 INFO - PROCESS | 21522 | Cycle 1(1): loaded http://localhost:41929/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41929/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:09:49 INFO - PROCESS | 21522 | RSS: Main: 165584896 06:09:49 INFO - PROCESS | 21522 | 06:09:52 INFO - PROCESS | 21522 | Cycle 1(1): loaded http://localhost:41929/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:09:52 INFO - PROCESS | 21522 | RSS: Main: 165302272 06:09:52 INFO - PROCESS | 21522 | 06:09:55 INFO - PROCESS | 21522 | Cycle 1(1): loaded http://localhost:41929/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:09:56 INFO - PROCESS | 21522 | RSS: Main: 166309888 06:09:56 INFO - PROCESS | 21522 | 06:09:57 INFO - PROCESS | 21522 | Cycle 1(1): loaded http://localhost:41929/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41929/tests/kraken/driver.html?testName=ai-astar) 06:09:58 INFO - PROCESS | 21522 | RSS: Main: 166719488 06:09:58 INFO - PROCESS | 21522 | 06:09:58 INFO - PROCESS | 21522 | __start_tp_report 06:09:58 INFO - PROCESS | 21522 | _x_x_mozilla_page_load 06:09:58 INFO - PROCESS | 21522 | _x_x_mozilla_page_load_details 06:09:58 INFO - PROCESS | 21522 | |i|pagename|runs| 06:09:58 INFO - PROCESS | 21522 | |0;ai-astar;105;112;110;112;112;114;120;114;113;115 06:09:58 INFO - PROCESS | 21522 | |1;audio-beat-detection;147;120;146;201;121;146;145;122;183;121 06:09:58 INFO - PROCESS | 21522 | |2;audio-dft;161;162;162;163;165;177;163;164;165;162 06:09:58 INFO - PROCESS | 21522 | |3;audio-fft;75;75;76;175;76;75;76;76;161;78 06:09:58 INFO - PROCESS | 21522 | |4;audio-oscillator;87;86;146;85;85;84;139;84;85;145 06:09:58 INFO - PROCESS | 21522 | |5;imaging-gaussian-blur;118;124;117;117;118;118;120;118;118;118 06:09:58 INFO - PROCESS | 21522 | |6;imaging-darkroom;147;148;147;147;147;148;147;147;148;147 06:09:58 INFO - PROCESS | 21522 | |7;imaging-desaturate;95;97;96;95;96;97;96;96;96;95 06:09:58 INFO - PROCESS | 21522 | |8;json-parse-financial;52;52;54;55;53;56;52;51;52;52 06:09:58 INFO - PROCESS | 21522 | |9;json-stringify-tinderbox;60;60;69;59;64;61;60;60;61;60 06:09:58 INFO - PROCESS | 21522 | |10;stanford-crypto-aes;82;77;77;77;77;76;77;76;87;75 06:09:58 INFO - PROCESS | 21522 | |11;stanford-crypto-ccm;125;122;124;125;125;122;139;124;143;138 06:09:58 INFO - PROCESS | 21522 | |12;stanford-crypto-pbkdf2;159;162;161;164;170;156;163;159;158;158 06:09:58 INFO - PROCESS | 21522 | |13;stanford-crypto-sha256-iterative;67;65;66;66;67;70;67;64;63;67 06:09:58 INFO - PROCESS | 21522 | __end_tp_report 06:09:58 INFO - PROCESS | 21522 | __start_cc_report 06:09:58 INFO - PROCESS | 21522 | _x_x_mozilla_cycle_collect,876 06:09:58 INFO - PROCESS | 21522 | __end_cc_report 06:09:58 INFO - PROCESS | 21522 | __startTimestamp1470661798191__endTimestamp 06:09:58 INFO - PROCESS | 21522 | 06:09:58 INFO - PROCESS | 21522 | ------- Summary: start ------- 06:09:58 INFO - PROCESS | 21522 | Number of tests: 14 06:09:58 INFO - PROCESS | 21522 | 06:09:58 INFO - PROCESS | 21522 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.50 stddev:3.80 (3.3%) stddev-sans-first:2.83 06:09:58 INFO - PROCESS | 21522 | Values: 105.0 112.0 110.0 112.0 112.0 114.0 120.0 114.0 113.0 115.0 06:09:58 INFO - PROCESS | 21522 | 06:09:58 INFO - PROCESS | 21522 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:146.00 stddev:27.67 (19.0%) stddev-sans-first:29.34 06:09:58 INFO - PROCESS | 21522 | Values: 147.0 120.0 146.0 201.0 121.0 146.0 145.0 122.0 183.0 121.0 06:09:58 INFO - PROCESS | 21522 | 06:09:58 INFO - PROCESS | 21522 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.50 stddev:4.62 (2.8%) stddev-sans-first:4.74 06:09:58 INFO - PROCESS | 21522 | Values: 161.0 162.0 162.0 163.0 165.0 177.0 163.0 164.0 165.0 162.0 06:09:58 INFO - PROCESS | 21522 | 06:09:58 INFO - PROCESS | 21522 | [#3] audio-fft Cycles:10 Average:94.30 Median:76.00 stddev:38.99 (51.3%) stddev-sans-first:40.73 06:09:58 INFO - PROCESS | 21522 | Values: 75.0 75.0 76.0 175.0 76.0 75.0 76.0 76.0 161.0 78.0 06:09:58 INFO - PROCESS | 21522 | 06:09:58 INFO - PROCESS | 21522 | [#4] audio-oscillator Cycles:10 Average:102.60 Median:85.00 stddev:28.18 (33.2%) stddev-sans-first:29.32 06:09:58 INFO - PROCESS | 21522 | Values: 87.0 86.0 146.0 85.0 85.0 84.0 139.0 84.0 85.0 145.0 06:09:58 INFO - PROCESS | 21522 | 06:09:58 INFO - PROCESS | 21522 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:118.00 stddev:2.07 (1.8%) stddev-sans-first:2.18 06:09:58 INFO - PROCESS | 21522 | Values: 118.0 124.0 117.0 117.0 118.0 118.0 120.0 118.0 118.0 118.0 06:09:58 INFO - PROCESS | 21522 | 06:09:58 INFO - PROCESS | 21522 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 06:09:58 INFO - PROCESS | 21522 | Values: 147.0 148.0 147.0 147.0 147.0 148.0 147.0 147.0 148.0 147.0 06:09:58 INFO - PROCESS | 21522 | 06:09:58 INFO - PROCESS | 21522 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 06:09:58 INFO - PROCESS | 21522 | Values: 95.0 97.0 96.0 95.0 96.0 97.0 96.0 96.0 96.0 95.0 06:09:58 INFO - PROCESS | 21522 | 06:09:58 INFO - PROCESS | 21522 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:52.50 stddev:1.60 (3.0%) stddev-sans-first:1.66 06:09:58 INFO - PROCESS | 21522 | Values: 52.0 52.0 54.0 55.0 53.0 56.0 52.0 51.0 52.0 52.0 06:09:58 INFO - PROCESS | 21522 | 06:09:58 INFO - PROCESS | 21522 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:60.50 stddev:2.99 (4.9%) stddev-sans-first:3.13 06:09:58 INFO - PROCESS | 21522 | Values: 60.0 60.0 69.0 59.0 64.0 61.0 60.0 60.0 61.0 60.0 06:09:58 INFO - PROCESS | 21522 | 06:09:58 INFO - PROCESS | 21522 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:77.00 stddev:3.63 (4.7%) stddev-sans-first:3.57 06:09:58 INFO - PROCESS | 21522 | Values: 82.0 77.0 77.0 77.0 77.0 76.0 77.0 76.0 87.0 75.0 06:09:58 INFO - PROCESS | 21522 | 06:09:58 INFO - PROCESS | 21522 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:125.00 stddev:7.97 (6.4%) stddev-sans-first:8.34 06:09:58 INFO - PROCESS | 21522 | Values: 125.0 122.0 124.0 125.0 125.0 122.0 139.0 124.0 143.0 138.0 06:09:58 INFO - PROCESS | 21522 | 06:09:58 INFO - PROCESS | 21522 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:161.50 stddev:4.03 (2.5%) stddev-sans-first:4.21 06:09:58 INFO - PROCESS | 21522 | Values: 159.0 162.0 161.0 164.0 170.0 156.0 163.0 159.0 158.0 158.0 06:09:58 INFO - PROCESS | 21522 | 06:09:58 INFO - PROCESS | 21522 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:1.93 (2.9%) stddev-sans-first:2.03 06:09:58 INFO - PROCESS | 21522 | Values: 67.0 65.0 66.0 66.0 67.0 70.0 67.0 64.0 63.0 67.0 06:09:58 INFO - PROCESS | 21522 | -------- Summary: end -------- 06:09:58 INFO - PROCESS | 21522 | 06:09:59 INFO - TEST-INFO | 21522: exit 0 06:09:59 INFO - TEST-OK | kraken | took 61710ms 06:09:59 INFO - SUITE-END | took 1174s 06:09:59 INFO - Completed test suite (00:19:34) 06:09:59 INFO - javascript benchmark 06:09:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7406.1746239513, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3084.9537256941144, 3089.9073027809172, 3119.8440077996092, 3125.4374212641715, 3126.4059828632558, 5309.575233981282, 5369.650972686777, 5410.864728381793, 5435.0488664483655, 5450.427705090968, 5379.569634429246, 5409.918851217235, 5449.836504904849, 5456.863578410542, 5522.088855338864, 4929.162042452774, 5041.621878359138, 5042.495750424965, 5093.567046801008, 5115.309433226523, 5083.7712302946275, 5089.669171503859, 5095.923561146586, 5148.922766158511, 5153.3558305211845, 4857.247126695368, 4876.829310974099, 4894.730789806559, 4907.509249075099, 4936.48166942473, 4958.429780575208, 4961.206207006898, 4970.577500912426, 4978.303037574742, 4978.925316120225, 4916.778744956486, 4935.111679897617, 4970.900581988376, 4971.6271279654175, 4994.150994330972, 5284.762185701653, 5377.973110134424, 5448.863778405532, 5452.563794896399, 5519.39286678465, 5805.941940580582, 5812.82561523155, 5821.912671309934, 5847.619904706181, 5863.912041319383, 5837.737301821428, 5848.502877255439, 5850.122481627747, 5858.355580886099, 5862.794802181946, 5235.528802407802, 5408.891822163535, 5426.782928682808, 5453.536449401845, 5459.645123066988, 6028.849278767978, 6031.547633927473, 6032.517398608101, 6041.72812223451, 6068.696565171724, 5768.682722450306, 5784.248047753765, 5787.479126878517, 5788.768449261982, 5790.913136302959, 5633.943660563424, 5669.858253543612, 5699.0, 5706.771729130871, 5865.0, 5566.137248726453, 5605.215269862141, 5635.21107045014, 5649.350324712628, 5681.460261275172, 5649.830505084854, 5666.943330566642, 5709.34342550612, 5740.56945729072, 5752.165935939265, 4182.1844740275965, 4203.369494575838, 4210.347396153601, 4216.831326746896, 4258.1483703258855, 3714.665680088805, 3760.2291530236234, 3800.1639639279315, 3813.3517302058162, 3846.0, 5519.724013799294, 5536.197251398606, 5547.084731019418, 5570.415106413769, 5570.415106413769, 5742.942570574324, 5823.650580965155, 5847.152162936435, 5850.882982340415, 5857.560682948796, 5439.700816455053, 5440.265564148868, 5460.890782184334, 5510.8071217507195, 5535.612507124543, 4907.484714105039, 4915.606751459874, 4919.269051554898, 4921.803127874917, 4957.801687932442, 5872.735726892385, 5965.731542080617, 5993.400659933972, 5996.5502587305255, 6000.129981152709, 5687.60186786921, 5723.399043100415, 5755.7122143893475, 5783.306003279633, 5836.533077353716, 5993.3706960768495, 5998.820035398945, 6005.849853753691, 6009.54928380382, 6017.669028203491, 5551.22282880389, 5625.662460252398, 5679.148127780866, 5682.090865461506, 5687.374388817144, 5800.912986305125, 5858.619189752652, 5871.236739223874, 5934.139549765347, 5961.254843144607, 5702.857428564319, 5752.13717942312, 5756.798512052058, 5763.7118144093465, 5790.913136303043, 5443.891122177455, 5719.599628026164, 5730.799422020209, 5755.338136114233, 5758.0499217630295, 5644.8306550803545, 5708.457696518824, 5719.628224165416, 5726.026575482095, 5752.568557358299, 5683.232763576864, 5685.374608792947, 5738.454846789548, 5745.368009518866, 5781.508571771446, 5423.647462914898, 5495.340559132929, 5619.775208991595, 5636.5208957237455, 5657.858553536194], "value": 5341.502184392067, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.4340227657547, 564.5765675743193, 576.3631187537768, 601.2664549249913, 602.5179856115107, 31997.520037199432, 35537.466937995916, 42355.0, 43044.354334684926, 43349.349759753626, 45158.774206128925, 45782.855428614304, 45785.313220301636, 45864.31203531941, 45940.0, 9013.639454421815, 9105.863412048824, 9130.497822619753, 9203.17171454569, 9210.585523651418, 9021.95489022554, 9081.455112693227, 9086.363954523185, 9099.863502047474, 9135.862962055575, 9116.407433516833, 9143.0, 9143.634254629807, 9156.0, 9218.35471516994, 9065.184133427958, 9086.363954523185, 9137.725868223964, 9160.862587061232, 9173.633054677804, 8965.148310910517, 9036.277097832224, 9095.135962083592, 9098.909010909872, 9104.226140777975, 43792.343114853305, 44035.55964440347, 44158.77920610376, 44221.336679949825, 44484.55515444869, 3696.611855755134, 3762.7366084374103, 3826.559945606263, 3839.3281175794123, 3915.275674000319, 32473.51289730656, 34786.82606586976, 35088.47367289493, 35330.0, 35346.29307413863, 4450.643948484114, 4452.688311818174, 4518.909621807578, 4622.491525932145, 4643.466001409847, 374330.0, 382297.0, 382435.0, 382713.0, 384297.0, 50794.0, 51232.74383628058, 51417.742911285204, 51471.13966452531, 51758.48241517612, 38203.42694859579, 69668.0, 69925.65037174782, 70134.2986570138, 70161.64919175372, 17235.310587576358, 17832.821671783116, 17874.731879021823, 17900.194491247665, 17904.28382864697, 13605.931970340085, 13629.86370136286, 13683.589492315246, 13707.931460342834, 13719.176849389069, 20766.688499672517, 20813.479663008548, 21005.0, 21024.15903363879, 21037.15851365959, 7937.8412431752195, 8067.233612806774, 8243.8351232975, 8256.628451719687, 8264.917350826414, 1009.2279406254221, 1051.369178492898, 1067.3435836960214, 1083.2904447586843, 1174.8897292059094, 33666.0, 34169.14577135542, 34174.0, 34369.0, 34456.943693883855, 1150.6893138852463, 1154.8556430446195, 1155.422288855572, 1171.6719318590808, 1219.8353222314875, 17515.474535763693, 17623.823761762476, 17818.376356827448, 17886.195121219578, 17912.373066942593, 536523.0, 537287.0, 539979.0, 548081.0, 548088.0, 60751.0, 61315.38684613186, 61357.38642613517, 61370.0, 61533.69233153895, 1299.7010687541917, 1346.3268365817091, 1356.9389377478037, 1357.2738584857054, 1368.3363568669188, 31295.687043129277, 32659.836700816344, 32998.67001330052, 33181.33637327288, 33502.0, 53386.46613533815, 53918.460815392915, 53992.73003634957, 54000.729996349764, 54050.72974635102, 383493.0, 387109.0, 457001.0, 457618.0, 460855.0, 29299.560506592843, 29877.402451951275, 30074.69925300719, 30078.0, 30630.84684576652, 49030.75484622554, 49386.506134938194, 50186.0, 50864.0, 51293.0, 42074.0, 42885.356719649855, 43001.0, 43055.7847210762, 44698.77650611726, 42113.57886421097, 43018.78490607527, 43213.567864320954, 43727.84095712087, 43754.34368484412, 41815.58184418117, 42643.57356426396, 42749.786251068545, 43254.56745432506, 46199.921003555595, 33544.66455335415, 38622.42066369063, 38641.227175456894, 38911.0, 39602.40596390999, 26072.217833465027, 26192.86903565546, 26222.475550488503, 26239.344016399744, 26514.0], "value": 20788.183180699936, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.7396257526169, 389.1264112068403, 397.60438363827984, 401.927653022456, 423.1381919553964, 13830.17018978862, 18619.534511637215, 19444.805551944475, 20247.898760506196, 20351.49121271971, 18971.62056758864, 19169.808301916975, 19423.708644370345, 19801.504962375948, 19900.50248743782, 5623.578231632623, 5750.568707346955, 5839.357670656224, 5854.707264636772, 5901.586888917777, 5911.201987731644, 5916.319623243317, 5944.464998150165, 6239.469645080151, 6504.1869766279215, 6510.837229069264, 6519.054737063123, 6520.152380190569, 6651.1021012163465, 6659.93340066598, 6029.125776762388, 6076.665783381913, 6110.144579758815, 6137.6624285664275, 6312.242530896299, 5961.612495187799, 5961.940380596182, 5986.371430999726, 6009.399060093956, 6020.608660437058, 23161.884190578938, 23298.0, 23693.0, 23823.0, 23903.282901512983, 2474.0, 2573.6782902137234, 2776.0, 2793.664760228786, 2892.421515696869, 10227.94886025565, 10360.326578772356, 10586.258961872672, 10754.408507532082, 10892.673219803419, 1914.996486016335, 1935.9322423715103, 1939.2824654877645, 1996.19154242532, 2003.2387692676834, 81631.0, 83775.0, 84170.57914710448, 84371.15628843756, 86342.0, 9335.253179745605, 9946.950265248628, 9954.751131221632, 9965.252606054575, 10033.44816035125, 13510.054296199172, 13666.453341866214, 13676.452941882413, 13685.863141368658, 13694.93152534231, 7841.960790196013, 7924.0, 7949.046114466301, 8159.755207343789, 8166.795830104176, 7883.802904927308, 7918.376732769769, 7995.320397766255, 8144.633491492897, 8188.0, 4060.675145988373, 4135.276326642826, 4191.476065491814, 4259.1268789897995, 4293.334533147367, 2007.1068374573174, 2037.2156719663037, 2038.1809932642389, 2038.2560365466795, 2052.568960518308, 869.6304070769897, 994.796066806303, 1033.509083185481, 1073.1361254190451, 1106.468894930438, 19807.504812379517, 20154.596908061758, 20385.0, 20594.0, 20697.793022069585, 988.2588058955783, 1022.9693109206736, 1053.2311412668794, 1064.6593090211213, 1072.2547829258747, 10768.730781730519, 11202.383868887126, 11277.830832537518, 11370.147238957112, 11426.2001659883, 456638.0, 457182.0, 472572.0, 472716.0, 474037.0, 88023.0, 96206.0, 97631.0, 97692.0, 99900.5004974985, 973.0998826085984, 999.7400675824192, 1014.9898501015043, 1026.1431704526653, 1035.0425856083093, 17088.829111708725, 17666.911665442105, 18196.27214911442, 18491.075446227904, 18569.0, 29852.552211717277, 36540.63459365479, 37402.0, 42659.0, 43388.0, 61084.0, 61663.691681541306, 62779.37220627918, 63353.68323158355, 63378.36621633909, 7587.58268295249, 8018.4787988780545, 8150.388720846079, 8583.098774628825, 8722.694705685524, 13700.93149534246, 13973.510927117502, 14016.0, 14139.222342771247, 14261.0, 12218.26690398579, 12243.20419172751, 12358.382080896099, 12375.75248495043, 12602.936985315015, 12177.756444870876, 12191.146619736888, 12377.071719621244, 12527.18573292733, 12832.230066196058, 12524.0, 12722.173058751152, 12771.74456510846, 12840.33075700153, 12853.614391568268, 7807.9219207809465, 7973.043234811859, 8222.13667564921, 8254.257116859511, 8271.0, 9034.367594268339, 12338.0, 12623.93688031554, 12697.42861571213, 13037.869621303666], "value": 9385.169826614017, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1488.5013520470645, 1501.2868887278544, 1633.730434478311, 1748.5628592851788, 1781.7861856577213, 8001.359891208704, 8730.60712267948, 8779.078196789325, 9542.093501117391, 9559.952200238999, 8926.509042002688, 9156.267498600097, 9265.675701350454, 9270.721878343644, 9294.163525282724, 2331.9533609327846, 2390.2590197038885, 2393.497365553236, 2394.652775347582, 2401.255610760661, 2395.8802059896934, 2439.878006099697, 2451.8651474168914, 2457.606782914734, 2457.9631305530434, 2416.673749043883, 2418.7097548294228, 2437.1348171399163, 2452.1294940296207, 2480.851148931061, 2398.1486572266767, 2405.9639105413435, 2414.7223069346987, 2426.8301218914685, 2432.817538684588, 2346.8709220992837, 2356.375560476475, 2360.62230043194, 2365.7634236576378, 2371.6916800815784, 9338.346315757899, 9359.625614975394, 9364.484953327565, 9373.062693730571, 9404.529773511365, 5316.308879845634, 5361.035013697533, 5367.5169234769055, 5371.382291036542, 5413.215083812865, 3569.39320315547, 3571.23218508022, 3586.4261718125235, 3652.2878038782446, 3663.7984910829896, 1102.3385968418966, 1107.6123356825128, 1128.4865386249237, 1142.4173671427548, 1149.4137989625267, 12319.260844349368, 12383.690407739788, 12397.25616463006, 12419.503219871194, 12533.686657833536, 4497.64018878489, 4607.746573938465, 4877.146499362598, 4887.193613053877, 4897.975510122498, 10402.27184097106, 10409.219308551888, 10412.947935260276, 10449.111825494767, 10499.317544359745, 5415.0, 5447.291852059207, 5475.178723191473, 5485.122380419114, 5503.559715222773, 4430.579094986036, 4903.607711383081, 4940.555350018516, 4972.378452693413, 5010.849674509771, 4052.2252563343404, 4106.178764247163, 4166.833246711693, 4242.427272318259, 4296.591823776736, 1257.8239046533492, 1344.1196016609138, 1346.2662848747457, 1359.904806663544, 1364.6383708317303, 914.3736540469799, 942.1661829280998, 998.236349192868, 1007.6825799873017, 1034.7257976636197, 5922.170896074553, 6030.668313242813, 6078.300995385499, 6192.411720886508, 6286.811395658137, 904.9230815380635, 963.2775418436173, 994.8159590475785, 1001.379144930148, 1045.46158728255, 4171.270027745132, 4296.484421869396, 4345.826166953287, 4350.978245108754, 4436.0462500562535, 11304.321740695585, 11710.355930423908, 11714.0, 11736.647900562997, 11750.647480575597, 11546.249493782878, 11634.825477617842, 11653.825192622118, 11658.708532286591, 11723.882761172279, 8297.460665056751, 8362.163783621589, 8513.616887240089, 8520.403571749917, 8577.999999999874, 6071.757129714939, 6201.6899155041165, 6221.222347206599, 6269.279032911274, 6315.684215789101, 10774.892251077388, 10793.29843560166, 10799.13606911461, 10903.454827258764, 10972.835407468734, 10573.629922952967, 10637.202209834139, 10689.94655026751, 10857.511411986638, 10906.945465272624, 6895.241523432318, 7545.50954187976, 7739.690412383442, 7834.412419068479, 7915.248051435105, 9042.095790420904, 9112.544372781467, 9128.817423651622, 9155.0, 9184.954075229582, 7934.2859142677435, 8076.111627720828, 8295.211954864279, 8302.294304984143, 8387.748367548984, 7929.246721561442, 7963.641636126504, 8056.556889371141, 8184.468009579358, 8187.0, 7273.3817625502425, 7295.343419092307, 7368.742094026683, 7379.409647228316, 7391.854262589307, 5340.732963351739, 5482.424345443671, 5516.365617953987, 5528.170774383874, 5594.4125866785025, 5334.359876814807, 5421.1055175895535, 5479.232907392889, 5495.670259784426, 5502.862428439321], "value": 4832.139498015609, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.74723153314955, 339.2113336492655, 345.04594795390767, 348.5991110223244, 349.8740453436764, 5454.154606036066, 5501.339839219294, 5523.585731070166, 5549.69476678783, 5575.721213939297, 5410.188471729242, 5415.810446634368, 5453.345598528173, 5465.754041068151, 5468.6171967962155, 4292.012837047481, 4304.428883457531, 4321.2653848845775, 4325.762083085429, 4327.523972363053, 3766.8699390182974, 4280.5291417944, 4286.914261714764, 4287.614114729674, 4307.2246995540945, 4273.487181538219, 4276.102018576103, 4279.914401711964, 4292.484901811771, 4294.849680261192, 4273.764942928137, 4277.315629499265, 4290.120525292307, 4299.72051816634, 4299.9570004300185, 3504.229069604683, 3719.293334266508, 3746.4193050077283, 3786.5198295116743, 3805.809709514541, 5368.946310536884, 5370.650907690988, 5372.91940620891, 5377.919331209996, 5378.677279363212, 4831.975840120812, 4841.661083724141, 4861.562459378638, 4873.829415970424, 4893.877653058702, 5554.0, 5652.812909289054, 5664.065429204176, 5710.428957104298, 5719.771209151629, 4099.89750256243, 4101.85643502479, 4103.363978583325, 4105.7331273467125, 4109.849242212185, 5717.885642287172, 5875.353711091734, 5937.812437512472, 5970.880582388371, 5992.9923475635715, 4182.853600123981, 4184.81168347419, 4184.832606695698, 4189.120284740238, 4189.581041895847, 4222.134462435193, 4225.3873188387515, 4234.767087810138, 4238.660907127422, 4238.682098842537, 4595.954040459553, 4844.685095468783, 4844.927326090112, 4854.878628034327, 4862.6839255448285, 5731.312242530923, 5747.85630359236, 5748.889543976077, 5761.995413187878, 5776.68228247442, 1462.6197188730794, 1475.1739026145178, 1478.4012474947663, 1479.4304192885602, 1483.1768368555556, 902.684759187006, 944.4239014201331, 949.2026697573933, 958.2334132693817, 958.6021800952666, 4869.440014398389, 4883.731394773322, 4885.9967413360355, 4890.462049174588, 4949.752512374367, 5114.616403769732, 5159.690418574897, 5160.277561141444, 5165.560927321219, 5190.6107041971245, 4586.633069354443, 4886.143265559136, 4909.4354149273295, 4914.8034078637165, 4965.776540055706, 2752.628395166627, 2758.0, 2759.5170845102025, 2761.4753196892525, 2766.2669392610974, 5329.081530648963, 5336.973315133399, 5358.0, 5385.75764090609, 5395.379531353866, 5223.947760522422, 5266.8946621068135, 5535.833924982257, 5999.700014999233, 6085.17850090241, 6187.474064704461, 6198.884200843891, 6208.4722798561725, 6219.6627725038425, 6249.375062493714, 5635.689367359363, 5989.40105989415, 5991.610545314541, 5995.0, 6000.549958753199, 5855.94144058554, 5870.853228669317, 5884.411208973639, 5894.970525147347, 5916.792912248051, 5969.850753731192, 6138.478229350555, 6157.507399408126, 6183.8771420432395, 6204.534659900435, 4275.615194632498, 4330.783460826883, 4335.7615331157085, 4381.255186618218, 4384.320430333303, 5714.628549144292, 5900.203472531325, 5908.793192238251, 5941.287045554561, 5950.19672344228, 5755.913661295001, 5756.568257380797, 5770.855728606651, 5772.393898640582, 5781.768729250783, 5680.0, 5690.3456102548735, 5702.173184888085, 5721.509878973739, 5730.799422020209, 5508.779648814003, 5717.599768016199, 5725.914111288417, 5758.2514273144225, 5763.913541296968, 5817.301923769175, 5823.0, 5839.795607153729, 5845.853853653693, 5864.296284445893, 5484.2047903053035, 5728.570357223308, 5728.937582470391, 5729.828105156852, 5744.454276843693], "value": 4304.451889747506, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.8627553902528, 781.5232708048093, 804.987925181122, 844.8605980013298, 858.0304256190506, 13430.932845335772, 14487.565373038826, 14510.637234069154, 14565.635859103528, 14624.195669238188, 15103.093814371145, 15175.165365904899, 15282.235888205601, 15287.69424611507, 15287.770683439758, 789.3527307607764, 795.3279478840385, 814.3810703865075, 816.5998660656265, 819.5983967855738, 809.348474478045, 811.9878201826978, 814.5316443045273, 814.9307308878753, 815.5473712089788, 856.8757530158123, 858.9914100858974, 859.4370687199894, 860.371928492201, 860.5869182792263, 847.1740053447901, 853.3514528957975, 854.3464249848839, 857.9571021448903, 858.0089996054567, 632.2286810091681, 634.9555531112824, 636.5130675033603, 636.5416899832113, 637.827786497643, 12552.18410803304, 12585.119041667087, 12618.68453288666, 12640.873591264062, 12653.620391388273, 14311.141331520143, 14336.211508367036, 14388.136711797326, 14547.490837820626, 14719.779203311959, 12269.815952760715, 12276.32480213588, 12486.81269780954, 12593.74812503754, 12617.306048167347, 3925.8429662813455, 3939.4484772131923, 3976.8608098716695, 3978.204359128157, 4092.1406504634065, 82064.58967705123, 82102.48436336, 83483.0, 84240.57879710563, 84604.57697711472, 11492.310461372344, 11872.643820685393, 12006.279623222634, 12187.0, 12258.754824903452, 22190.889045554668, 22235.55528889413, 22268.66597001046, 22383.888080559493, 22405.66391504129, 8867.91132088671, 8944.776380590407, 9098.590563424661, 9364.016778238323, 9372.34393592442, 4914.36113305268, 5003.10027530449, 5057.064443078042, 5080.796768129308, 5085.364329458817, 3729.701623870084, 3844.0, 3875.2443273561385, 3879.4568760373572, 3884.8446062157764, 590.6603702870866, 594.1503649780855, 597.7101105963604, 611.8990366589552, 617.5831313863124, 580.9651420914674, 603.3483837455537, 643.8197304754676, 682.6518475577491, 733.2960358056325, 10024.398536087712, 10179.82322462662, 10408.895911040792, 10564.207684423698, 10639.946800265949, 618.3044075415158, 680.5304340005381, 726.9781906542812, 729.6825880741894, 736.6316841579211, 4959.677620954626, 5176.637635365563, 5180.844574662766, 5195.818146364859, 5249.553787927993, 77507.61246193845, 98420.50789746005, 100847.49576252219, 102548.0, 115256.42371788087, 74528.0, 91680.0, 91980.0, 94359.52820235855, 94534.0, 56780.148297775566, 76316.61841690756, 85628.57185714031, 86246.0, 87475.0, 9749.415035097916, 9959.402435853872, 10311.0, 10539.841902371318, 10638.095761860019, 49998.0, 50791.0, 50916.23625645544, 52466.475335246156, 53688.1946770791, 69875.6506217486, 70155.0, 73668.0, 75882.24117758752, 76559.0, 12376.381180941096, 13420.644838790302, 13542.0, 13578.38897249646, 13676.452941882611, 14100.153990760587, 14483.855161448251, 15073.321700523722, 15240.847591523943, 15265.3893844245, 13749.381277842322, 14087.366068526735, 14428.42286308536, 14452.855471445571, 15233.542993710207, 13656.726865462437, 13820.723585528032, 13949.721005580035, 13979.790303145664, 14359.497417590333, 13376.331183440983, 13423.463061477432, 13800.654983625489, 13828.792568111285, 14797.186154761592, 11362.938455290085, 11526.654200374001, 11713.765724685289, 11959.820602691141, 12063.39683015828, 9911.118813597146, 10855.728606784893, 11580.942095289469, 11706.414679266172, 11948.62590802069], "value": 7612.71973946085, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 110.0, 112.0, 112.0, 114.0, 120.0, 114.0, 113.0, 115.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 120.0, 146.0, 201.0, 121.0, 146.0, 145.0, 122.0, 183.0, 121.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 163.0, 165.0, 177.0, 163.0, 164.0, 165.0, 162.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 175.0, 76.0, 75.0, 76.0, 76.0, 161.0, 78.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 146.0, 85.0, 85.0, 84.0, 139.0, 84.0, 85.0, 145.0], "value": 102.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 124.0, 117.0, 117.0, 118.0, 118.0, 120.0, 118.0, 118.0, 118.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 148.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 54.0, 55.0, 53.0, 56.0, 52.0, 51.0, 52.0, 52.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 69.0, 59.0, 64.0, 61.0, 60.0, 60.0, 61.0, 60.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 77.0, 77.0, 77.0, 76.0, 77.0, 76.0, 87.0, 75.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 122.0, 124.0, 125.0, 125.0, 122.0, 139.0, 124.0, 143.0, 138.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 161.0, 164.0, 170.0, 156.0, 163.0, 159.0, 158.0, 158.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 66.0, 67.0, 70.0, 67.0, 64.0, 63.0, 67.0], "value": 66.2, "unit": "score"}]}]} 06:09:59 INFO - Return code: 0 06:09:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:09:59 ERROR - # TBPL SUCCESS # 06:09:59 INFO - Running post-action listener: _resource_record_post_action 06:09:59 INFO - [mozharness: 2016-08-08 13:09:59.475236Z] Finished run-tests step (success) 06:09:59 INFO - Running post-run listener: _resource_record_post_run 06:09:59 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 548679680; Read time: 12; Write time: 488900 06:09:59 INFO - TinderboxPrint: CPU usage
13.4% 06:09:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:09:59 INFO - TinderboxPrint: I/O write bytes / time
548,679,680 / 488,900 06:09:59 INFO - TinderboxPrint: CPU idle
8,237.4 (86.6%) 06:09:59 INFO - TinderboxPrint: CPU user
1,214.7 (12.8%) 06:09:59 INFO - TinderboxPrint: Swap in / out
0 / 0 06:09:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 251895808; Read time: 0; Write time: 253104 06:09:59 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 296783872; Read time: 0; Write time: 235796 06:10:00 INFO - Running post-run listener: _upload_blobber_files 06:10:00 INFO - Blob upload gear active. 06:10:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:10:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:10:00 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'] 06:10:00 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 06:10:00 INFO - (blobuploader) - INFO - Open directory for files ... 06:10:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:10:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:10:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:01 INFO - (blobuploader) - INFO - Done attempting. 06:10:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:10:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:10:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:06 INFO - (blobuploader) - INFO - Done attempting. 06:10:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:10:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:10:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:10:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:10:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:10:06 INFO - (blobuploader) - INFO - Done attempting. 06:10:06 INFO - (blobuploader) - INFO - Iteration through files over. 06:10:06 INFO - Return code: 0 06:10:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:10:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:10:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a38452d37ce95415c4c444ec77fc09e2d5135f499aeca5a7ab01efb5e07864d781fa0e7fd4d1be77f8834fd397d4b324e820f484ab40ac182969e25cbfb89de8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de65408e066dec4d7fe56547cde928383eba902161330c6515c1a8a7b44baec3d4997fa743a369ce4f36ebed983e17e1480660b7bd93e481c14528ca0f2838cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2df5d3d7f80f8ceae40642a7024b7a0be85d94d1b8020f812b3e34d787e1d2e3bb4413a3db7b3ff580eb583a749b23952c51da50344212ea66ee1ac86436a25e"} 06:10:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:10:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:10:06 INFO - Contents: 06:10:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a38452d37ce95415c4c444ec77fc09e2d5135f499aeca5a7ab01efb5e07864d781fa0e7fd4d1be77f8834fd397d4b324e820f484ab40ac182969e25cbfb89de8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de65408e066dec4d7fe56547cde928383eba902161330c6515c1a8a7b44baec3d4997fa743a369ce4f36ebed983e17e1480660b7bd93e481c14528ca0f2838cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2df5d3d7f80f8ceae40642a7024b7a0be85d94d1b8020f812b3e34d787e1d2e3bb4413a3db7b3ff580eb583a749b23952c51da50344212ea66ee1ac86436a25e"} 06:10:06 INFO - Running post-run listener: copy_logs_to_upload_dir 06:10:06 INFO - Copying logs to upload dir... 06:10:06 INFO - mkdir: /builds/slave/test/build/upload/logs 06:10:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.345598 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-08 06:10:06.356441) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 06:10:06.359736) ========= 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=337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a38452d37ce95415c4c444ec77fc09e2d5135f499aeca5a7ab01efb5e07864d781fa0e7fd4d1be77f8834fd397d4b324e820f484ab40ac182969e25cbfb89de8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de65408e066dec4d7fe56547cde928383eba902161330c6515c1a8a7b44baec3d4997fa743a369ce4f36ebed983e17e1480660b7bd93e481c14528ca0f2838cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2df5d3d7f80f8ceae40642a7024b7a0be85d94d1b8020f812b3e34d787e1d2e3bb4413a3db7b3ff580eb583a749b23952c51da50344212ea66ee1ac86436a25e"} build_url:https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011428 build_url: 'https://queue.taskcluster.net/v1/task/PFOF_dyDTjKhoJFEuUnWIw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a38452d37ce95415c4c444ec77fc09e2d5135f499aeca5a7ab01efb5e07864d781fa0e7fd4d1be77f8834fd397d4b324e820f484ab40ac182969e25cbfb89de8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de65408e066dec4d7fe56547cde928383eba902161330c6515c1a8a7b44baec3d4997fa743a369ce4f36ebed983e17e1480660b7bd93e481c14528ca0f2838cc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2df5d3d7f80f8ceae40642a7024b7a0be85d94d1b8020f812b3e34d787e1d2e3bb4413a3db7b3ff580eb583a749b23952c51da50344212ea66ee1ac86436a25e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 06:10:06.385290) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 06:10:06.385599) ========= 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=337fe3f4b1febe37b85fccc40000019e-1470660573.325108-217963217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 06:10:06.467630) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 06:10:06.467923) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 06:10:06.468268) ========= ========= Total master_lag: 0.16 =========