builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1470574000.19 results: success (0) buildid: 20160807030201 builduid: 385434159a9e4a9ab7046755010987d2 revision: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 05:46:40.194513) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 05:46:40.194968) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 05:46:40.195342) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 05:46:40.251234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 05:46:40.251517) ========= 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=0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-07 05:46:40-- 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-07 05:46:40 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086473 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 05:46:40.367753) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 05:46:40.368059) ========= 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=0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020376 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 05:46:40.437621) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 05:46:40.437929) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d42aacfe34af25e2f5110e2ca3d24a210eabeb33 --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 d42aacfe34af25e2f5110e2ca3d24a210eabeb33 --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=0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-07 05:46:40,914 truncating revision to first 12 chars 2016-08-07 05:46:40,914 Setting DEBUG logging. 2016-08-07 05:46:40,914 attempt 1/10 2016-08-07 05:46:40,914 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d42aacfe34af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 05:46:41,236 unpacking tar archive at: mozilla-central-d42aacfe34af/testing/mozharness/ program finished with exit code 0 elapsedTime=0.684266 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 05:46:41.144271) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 05:46:41.144559) ========= script_repo_revision: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 05:46:41.144954) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 05:46:41.145236) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 05:46:41.155787) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-07 05:46:41.156089) ========= /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=0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:46:41 INFO - MultiFileLogger online at 20160807 05:46:41 in /builds/slave/test 05:46:41 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:46:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:46:41 INFO - {'append_to_log': False, 05:46:41 INFO - 'base_work_dir': '/builds/slave/test', 05:46:41 INFO - 'blob_upload_branch': 'Firefox', 05:46:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:46:41 INFO - 'branch': 'Firefox', 05:46:41 INFO - 'buildbot_json_path': 'buildprops.json', 05:46:41 INFO - 'config_files': ('talos/linux_config.py',), 05:46:41 INFO - 'default_actions': ('clobber', 05:46:41 INFO - 'read-buildbot-config', 05:46:41 INFO - 'download-and-extract', 05:46:41 INFO - 'populate-webroot', 05:46:41 INFO - 'create-virtualenv', 05:46:41 INFO - 'install', 05:46:41 INFO - 'run-tests'), 05:46:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:46:41 INFO - 'download_minidump_stackwalk': True, 05:46:41 INFO - 'download_symbols': 'ondemand', 05:46:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:46:41 INFO - 'tooltool.py': '/tools/tooltool.py', 05:46:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:46:41 INFO - '/tools/misc-python/virtualenv.py')}, 05:46:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:46:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:46:41 INFO - 'installer_path': 'installer.exe', 05:46:41 INFO - 'log_level': 'info', 05:46:41 INFO - 'log_name': 'talos', 05:46:41 INFO - 'log_to_console': True, 05:46:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:46:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:46:41 INFO - 'opt_config_files': (), 05:46:41 INFO - 'pip_index': False, 05:46:41 INFO - 'sps_profile': False, 05:46:41 INFO - 'sps_profile_interval': 0, 05:46:41 INFO - 'suite': 'dromaeojs-e10s', 05:46:41 INFO - 'system_bits': '32', 05:46:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:46:41 INFO - 'title': 'talos-linux64-ix-058', 05:46:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:46:41 INFO - 'use_talos_json': True, 05:46:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:46:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:46:41 INFO - 'work_dir': 'build'} 05:46:41 INFO - [mozharness: 2016-08-07 12:46:41.729047Z] Running clobber step. 05:46:41 INFO - Running pre-action listener: _resource_record_pre_action 05:46:41 INFO - Running main action method: clobber 05:46:41 INFO - rmtree: /builds/slave/test/build 05:46:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:46:42 INFO - Running post-action listener: _resource_record_post_action 05:46:42 INFO - [mozharness: 2016-08-07 12:46:42.188906Z] Finished clobber step (success) 05:46:42 INFO - [mozharness: 2016-08-07 12:46:42.189008Z] Running read-buildbot-config step. 05:46:42 INFO - Running pre-action listener: _resource_record_pre_action 05:46:42 INFO - Running main action method: read_buildbot_config 05:46:42 INFO - Using buildbot properties: 05:46:42 INFO - { 05:46:42 INFO - "project": "", 05:46:42 INFO - "product": "firefox", 05:46:42 INFO - "script_repo_revision": "production", 05:46:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:46:42 INFO - "repository": "", 05:46:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:46:42 INFO - "buildid": "20160807030201", 05:46:42 INFO - "stage_platform": "linux64-pgo", 05:46:42 INFO - "basedir": "/builds/slave/test", 05:46:42 INFO - "nightly_build": "True", 05:46:42 INFO - "buildnumber": 308, 05:46:42 INFO - "slavename": "talos-linux64-ix-058", 05:46:42 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:46:42 INFO - "platform": "ubuntu64_hw", 05:46:42 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:46:42 INFO - "branch": "mozilla-central", 05:46:42 INFO - "repo_path": "mozilla-central", 05:46:42 INFO - "revision": "d42aacfe34af25e2f5110e2ca3d24a210eabeb33", 05:46:42 INFO - "pgo_build": "True", 05:46:42 INFO - "builduid": "385434159a9e4a9ab7046755010987d2", 05:46:42 INFO - "slavebuilddir": "test" 05:46:42 INFO - } 05:46:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/ekaZlwOmTUW3URQTgOTiAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:46:42 INFO - Running post-action listener: _resource_record_post_action 05:46:42 INFO - [mozharness: 2016-08-07 12:46:42.191561Z] Finished read-buildbot-config step (success) 05:46:42 INFO - [mozharness: 2016-08-07 12:46:42.191650Z] Running download-and-extract step. 05:46:42 INFO - Running pre-action listener: _resource_record_pre_action 05:46:42 INFO - Running main action method: download_and_extract 05:46:42 INFO - mkdir: /builds/slave/test/build/tests 05:46: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:46:42 INFO - trying https://queue.taskcluster.net/v1/task/ekaZlwOmTUW3URQTgOTiAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:46:42 INFO - Downloading https://queue.taskcluster.net/v1/task/ekaZlwOmTUW3URQTgOTiAg/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:46:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ekaZlwOmTUW3URQTgOTiAg/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:46:42 INFO - Downloaded 1361 bytes. 05:46:42 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:46:42 INFO - Using the following test package requirements: 05:46:42 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:46:42 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:46:42 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:46:42 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:42 INFO - u'jsshell-linux-x86_64.zip'], 05:46:42 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:46:42 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:46:42 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:46:42 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:46:42 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:46:42 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:46:42 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:46:42 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:46: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:46:42 INFO - trying https://queue.taskcluster.net/v1/task/ekaZlwOmTUW3URQTgOTiAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:46:42 INFO - Downloading https://queue.taskcluster.net/v1/task/ekaZlwOmTUW3URQTgOTiAg/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:46:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ekaZlwOmTUW3URQTgOTiAg/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:46:44 INFO - Downloaded 21829089 bytes. 05:46:44 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:46:44 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:46:45 INFO - Return code: 0 05:46:45 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:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:45 INFO - trying https://queue.taskcluster.net/v1/task/ekaZlwOmTUW3URQTgOTiAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:46:45 INFO - Downloading https://queue.taskcluster.net/v1/task/ekaZlwOmTUW3URQTgOTiAg/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:46:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ekaZlwOmTUW3URQTgOTiAg/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:46:48 INFO - Downloaded 21829089 bytes. 05:46:48 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:46:48 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:46:49 INFO - Return code: 0 05:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:49 INFO - trying https://queue.taskcluster.net/v1/task/ekaZlwOmTUW3URQTgOTiAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:46:49 INFO - Downloading https://queue.taskcluster.net/v1/task/ekaZlwOmTUW3URQTgOTiAg/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:46:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ekaZlwOmTUW3URQTgOTiAg/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:46:50 INFO - Downloaded 14413723 bytes. 05:46:50 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:46:50 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:46:51 INFO - Return code: 0 05:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:51 INFO - trying https://queue.taskcluster.net/v1/task/ekaZlwOmTUW3URQTgOTiAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:46:51 INFO - Downloading https://queue.taskcluster.net/v1/task/ekaZlwOmTUW3URQTgOTiAg/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:46:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ekaZlwOmTUW3URQTgOTiAg/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:46:52 INFO - Downloaded 59970364 bytes. 05:46:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ekaZlwOmTUW3URQTgOTiAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:46:52 INFO - mkdir: /builds/slave/test/properties 05:46:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:46:52 INFO - Writing to file /builds/slave/test/properties/build_url 05:46:52 INFO - Contents: 05:46:52 INFO - build_url:https://queue.taskcluster.net/v1/task/ekaZlwOmTUW3URQTgOTiAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:46:53 INFO - Running post-action listener: _resource_record_post_action 05:46:53 INFO - Running post-action listener: set_extra_try_arguments 05:46:53 INFO - [mozharness: 2016-08-07 12:46:53.368521Z] Finished download-and-extract step (success) 05:46:53 INFO - [mozharness: 2016-08-07 12:46:53.368753Z] Running populate-webroot step. 05:46:53 INFO - Running pre-action listener: _resource_record_pre_action 05:46:53 INFO - Running main action method: populate_webroot 05:46:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:46:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:46:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:46:53 INFO - '--tppagecycles', 05:46:53 INFO - '7'], 05:46:53 INFO - 'tests': ['tsvgm']}}, 05:46:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:46:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:46:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:46:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:46:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:46:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:46:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:53 INFO - 'talos_options': ['--disable-e10s'], 05:46:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:53 INFO - 'talos_options': ['--disable-e10s'], 05:46:53 INFO - 'tests': ['damp', 'tps']}, 05:46:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:53 INFO - 'tests': ['damp', 'tps']}, 05:46:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:46:53 INFO - 'tests': ['dromaeo_dom']}, 05:46:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:46:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:46:53 INFO - 'tests': ['basic_compositor_video']}, 05:46:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:46:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:46:53 INFO - 'tests': ['a11yr', 05:46:53 INFO - 'ts_paint', 05:46:53 INFO - 'tpaint', 05:46:53 INFO - 'sessionrestore', 05:46:53 INFO - 'sessionrestore_no_auto_restore', 05:46:53 INFO - 'tabpaint']}, 05:46:53 INFO - 'other-e10s': {'tests': ['a11yr', 05:46:53 INFO - 'ts_paint', 05:46:53 INFO - 'tpaint', 05:46:53 INFO - 'sessionrestore', 05:46:53 INFO - 'sessionrestore_no_auto_restore', 05:46:53 INFO - 'tabpaint']}, 05:46:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:46:53 INFO - 'ts_paint', 05:46:53 INFO - 'tpaint', 05:46:53 INFO - 'sessionrestore', 05:46:53 INFO - 'sessionrestore_no_auto_restore', 05:46:53 INFO - 'tabpaint']}, 05:46:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:46:53 INFO - 'ts_paint', 05:46:53 INFO - 'tpaint', 05:46:53 INFO - 'sessionrestore', 05:46:53 INFO - 'sessionrestore_no_auto_restore', 05:46:53 INFO - 'tabpaint']}, 05:46:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:46:53 INFO - 'tests': ['a11yr', 05:46:53 INFO - 'ts_paint', 05:46:53 INFO - 'tpaint', 05:46:53 INFO - 'sessionrestore', 05:46:53 INFO - 'sessionrestore_no_auto_restore', 05:46:53 INFO - 'tabpaint']}, 05:46:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:46:53 INFO - 'tests': ['a11yr', 05:46:53 INFO - 'ts_paint', 05:46:53 INFO - 'tpaint', 05:46:53 INFO - 'sessionrestore', 05:46:53 INFO - 'sessionrestore_no_auto_restore', 05:46:53 INFO - 'tabpaint']}, 05:46:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:46:53 INFO - 'tests': ['tsvgx', 05:46:53 INFO - 'tsvgr_opacity', 05:46:53 INFO - 'tart', 05:46:53 INFO - 'tscrollx', 05:46:53 INFO - 'cart']}, 05:46:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:46:53 INFO - 'tsvgr_opacity', 05:46:53 INFO - 'tart', 05:46:53 INFO - 'tscrollx', 05:46:53 INFO - 'cart']}, 05:46:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:53 INFO - 'talos_options': ['--disable-e10s'], 05:46:53 INFO - 'tests': ['tp5o']}, 05:46:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:53 INFO - 'tests': ['tp5o']}, 05:46:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:53 INFO - 'talos_options': ['--disable-e10s', 05:46:53 INFO - '--xperf_path', 05:46:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:53 INFO - 'tests': ['tp5n']}, 05:46:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:53 INFO - 'talos_options': ['--xperf_path', 05:46:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:53 INFO - 'tests': ['tp5n']}}, 05:46:53 INFO - 'talos.zip': {'path': '', 05:46:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:46:53 INFO - Running post-action listener: _resource_record_post_action 05:46:53 INFO - [mozharness: 2016-08-07 12:46:53.390057Z] Finished populate-webroot step (success) 05:46:53 INFO - [mozharness: 2016-08-07 12:46:53.390146Z] Running create-virtualenv step. 05:46:53 INFO - Running pre-action listener: _resource_record_pre_action 05:46:53 INFO - Running main action method: create_virtualenv 05:46:53 INFO - Creating virtualenv /builds/slave/test/build/venv 05:46:53 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:46:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:46:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:46:53 INFO - Using real prefix '/usr' 05:46:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:46:53 INFO - Installing distribute.............................................................................................................................................................................................done. 05:46:55 INFO - Installing pip.................done. 05:46:55 INFO - Return code: 0 05:46:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:46: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:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c3b0>, '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 0x1f8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d740>, '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': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', '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:46: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', 'pip>=1.5'] in /builds/slave/test/build 05:46: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 pip>=1.5 05:46:55 INFO - Using env: {'DISPLAY': ':0', 05:46:55 INFO - 'HOME': '/home/cltbld', 05:46:55 INFO - 'LANG': 'en_US.UTF-8', 05:46:55 INFO - 'LANGUAGE': 'en_US:en', 05:46:55 INFO - 'LOGNAME': 'cltbld', 05:46:55 INFO - 'MAIL': '/var/mail/cltbld', 05:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:55 INFO - 'MOZ_NO_REMOTE': '1', 05:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:55 INFO - 'NO_EM_RESTART': '1', 05:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:55 INFO - 'PWD': '/builds/slave/test', 05:46:55 INFO - 'SHELL': '/bin/bash', 05:46:55 INFO - 'SHLVL': '1', 05:46:55 INFO - 'TERM': 'linux', 05:46:55 INFO - 'TMOUT': '86400', 05:46:55 INFO - 'USER': 'cltbld', 05:46:55 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', 05:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:55 INFO - '_': '/tools/buildbot/bin/python'} 05:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:56 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:46:56 INFO - Cleaning up... 05:46:56 INFO - Return code: 0 05:46:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:56 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 0x1ccd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c3b0>, '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 0x1f8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d740>, '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': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', '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:46:56 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:46:56 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:46:56 INFO - Using env: {'DISPLAY': ':0', 05:46:56 INFO - 'HOME': '/home/cltbld', 05:46:56 INFO - 'LANG': 'en_US.UTF-8', 05:46:56 INFO - 'LANGUAGE': 'en_US:en', 05:46:56 INFO - 'LOGNAME': 'cltbld', 05:46:56 INFO - 'MAIL': '/var/mail/cltbld', 05:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:56 INFO - 'MOZ_NO_REMOTE': '1', 05:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:56 INFO - 'NO_EM_RESTART': '1', 05:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:56 INFO - 'PWD': '/builds/slave/test', 05:46:56 INFO - 'SHELL': '/bin/bash', 05:46:56 INFO - 'SHLVL': '1', 05:46:56 INFO - 'TERM': 'linux', 05:46:56 INFO - 'TMOUT': '86400', 05:46:56 INFO - 'USER': 'cltbld', 05:46:56 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', 05:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:56 INFO - '_': '/tools/buildbot/bin/python'} 05:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:56 INFO - Downloading/unpacking psutil>=3.1.1 05:46: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:46: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:46: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:46: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:46: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:46: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:46:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:46:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:59 INFO - Installing collected packages: psutil 05:46:59 INFO - Running setup.py install for psutil 05:46:59 INFO - building 'psutil._psutil_linux' extension 05:46:59 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:46:59 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:46:59 INFO - building 'psutil._psutil_posix' extension 05:46:59 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:46:59 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:46:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:59 INFO - Successfully installed psutil 05:46:59 INFO - Cleaning up... 05:46:59 INFO - Return code: 0 05:46:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:46: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:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:59 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 0x1ccd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c3b0>, '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 0x1f8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d740>, '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': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', '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:46:59 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:46:59 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:46:59 INFO - Using env: {'DISPLAY': ':0', 05:46:59 INFO - 'HOME': '/home/cltbld', 05:46:59 INFO - 'LANG': 'en_US.UTF-8', 05:46:59 INFO - 'LANGUAGE': 'en_US:en', 05:46:59 INFO - 'LOGNAME': 'cltbld', 05:46:59 INFO - 'MAIL': '/var/mail/cltbld', 05:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:59 INFO - 'MOZ_NO_REMOTE': '1', 05:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:59 INFO - 'NO_EM_RESTART': '1', 05:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:59 INFO - 'PWD': '/builds/slave/test', 05:46:59 INFO - 'SHELL': '/bin/bash', 05:46:59 INFO - 'SHLVL': '1', 05:46:59 INFO - 'TERM': 'linux', 05:46:59 INFO - 'TMOUT': '86400', 05:46:59 INFO - 'USER': 'cltbld', 05:46:59 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', 05:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:59 INFO - '_': '/tools/buildbot/bin/python'} 05:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:46:59 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:46:59 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:46:59 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:46:59 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:46:59 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:46:59 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:47:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:47:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:47:02 INFO - Installing collected packages: mozsystemmonitor 05:47:02 INFO - Running setup.py install for mozsystemmonitor 05:47:02 INFO - Successfully installed mozsystemmonitor 05:47:02 INFO - Cleaning up... 05:47:02 INFO - Return code: 0 05:47:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:47: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:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:02 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 0x1ccd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c3b0>, '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 0x1f8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d740>, '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': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', '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:47:02 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:47:02 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:47:02 INFO - Using env: {'DISPLAY': ':0', 05:47:02 INFO - 'HOME': '/home/cltbld', 05:47:02 INFO - 'LANG': 'en_US.UTF-8', 05:47:02 INFO - 'LANGUAGE': 'en_US:en', 05:47:02 INFO - 'LOGNAME': 'cltbld', 05:47:02 INFO - 'MAIL': '/var/mail/cltbld', 05:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:02 INFO - 'MOZ_NO_REMOTE': '1', 05:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:02 INFO - 'NO_EM_RESTART': '1', 05:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:02 INFO - 'PWD': '/builds/slave/test', 05:47:02 INFO - 'SHELL': '/bin/bash', 05:47:02 INFO - 'SHLVL': '1', 05:47:02 INFO - 'TERM': 'linux', 05:47:02 INFO - 'TMOUT': '86400', 05:47:02 INFO - 'USER': 'cltbld', 05:47:02 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', 05:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:02 INFO - '_': '/tools/buildbot/bin/python'} 05:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:02 INFO - Downloading/unpacking jsonschema==2.5.1 05:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:47:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:47:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:47:05 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:47:05 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:47:05 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:47:05 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:47:05 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:47:05 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:47:05 INFO - Downloading functools32-3.2.3-2.tar.gz 05:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:47:05 INFO - warning: no files found matching '*.txt' 05:47:05 INFO - no previously-included directories found matching 'build' 05:47:05 INFO - no previously-included directories found matching 'dist' 05:47:05 INFO - no previously-included directories found matching '.git*' 05:47:05 INFO - Installing collected packages: jsonschema, functools32 05:47:05 INFO - Running setup.py install for functools32 05:47:05 INFO - warning: no files found matching '*.txt' 05:47:05 INFO - no previously-included directories found matching 'build' 05:47:05 INFO - no previously-included directories found matching 'dist' 05:47:05 INFO - no previously-included directories found matching '.git*' 05:47:05 INFO - Successfully installed jsonschema functools32 05:47:05 INFO - Cleaning up... 05:47:05 INFO - Return code: 0 05:47:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ccd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c3b0>, '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 0x1f8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d740>, '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': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', '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:47:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:47:05 INFO - Using env: {'DISPLAY': ':0', 05:47:05 INFO - 'HOME': '/home/cltbld', 05:47:05 INFO - 'LANG': 'en_US.UTF-8', 05:47:05 INFO - 'LANGUAGE': 'en_US:en', 05:47:05 INFO - 'LOGNAME': 'cltbld', 05:47:05 INFO - 'MAIL': '/var/mail/cltbld', 05:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:05 INFO - 'MOZ_NO_REMOTE': '1', 05:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:05 INFO - 'NO_EM_RESTART': '1', 05:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:05 INFO - 'PWD': '/builds/slave/test', 05:47:05 INFO - 'SHELL': '/bin/bash', 05:47:05 INFO - 'SHLVL': '1', 05:47:05 INFO - 'TERM': 'linux', 05:47:05 INFO - 'TMOUT': '86400', 05:47:05 INFO - 'USER': 'cltbld', 05:47:05 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', 05:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:05 INFO - '_': '/tools/buildbot/bin/python'} 05:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:47:06 INFO - Cleaning up... 05:47:06 INFO - Return code: 0 05:47:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:47: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:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47: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', '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 0x1ccd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c3b0>, '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 0x1f8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d740>, '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': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', '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:47: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:47: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 blobuploader==1.2.4 05:47:06 INFO - Using env: {'DISPLAY': ':0', 05:47:06 INFO - 'HOME': '/home/cltbld', 05:47:06 INFO - 'LANG': 'en_US.UTF-8', 05:47:06 INFO - 'LANGUAGE': 'en_US:en', 05:47:06 INFO - 'LOGNAME': 'cltbld', 05:47:06 INFO - 'MAIL': '/var/mail/cltbld', 05:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:06 INFO - 'MOZ_NO_REMOTE': '1', 05:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:06 INFO - 'NO_EM_RESTART': '1', 05:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:06 INFO - 'PWD': '/builds/slave/test', 05:47:06 INFO - 'SHELL': '/bin/bash', 05:47:06 INFO - 'SHLVL': '1', 05:47:06 INFO - 'TERM': 'linux', 05:47:06 INFO - 'TMOUT': '86400', 05:47:06 INFO - 'USER': 'cltbld', 05:47:06 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', 05:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:06 INFO - '_': '/tools/buildbot/bin/python'} 05:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:06 INFO - Downloading/unpacking blobuploader==1.2.4 05:47:06 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:47:06 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:47:06 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:47:06 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:47:06 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:47:06 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:47:08 INFO - Downloading blobuploader-1.2.4.tar.gz 05:47:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:47:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:47:08 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:47:08 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:47:08 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:47:08 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:47:08 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:47:08 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:47:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:47:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:47:09 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:47:09 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:47:09 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:47:09 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:47:09 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:47:09 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:47:09 INFO - Downloading docopt-0.6.1.tar.gz 05:47:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:47:09 INFO - Installing collected packages: blobuploader, requests, docopt 05:47:09 INFO - Running setup.py install for blobuploader 05:47:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:47:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:47:09 INFO - Running setup.py install for requests 05:47:10 INFO - Running setup.py install for docopt 05:47:10 INFO - Successfully installed blobuploader requests docopt 05:47:10 INFO - Cleaning up... 05:47:10 INFO - Return code: 0 05:47:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:10 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 0x1ccd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c3b0>, '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 0x1f8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d740>, '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': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', '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:47:10 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:47:10 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:47:10 INFO - Using env: {'DISPLAY': ':0', 05:47:10 INFO - 'HOME': '/home/cltbld', 05:47:10 INFO - 'LANG': 'en_US.UTF-8', 05:47:10 INFO - 'LANGUAGE': 'en_US:en', 05:47:10 INFO - 'LOGNAME': 'cltbld', 05:47:10 INFO - 'MAIL': '/var/mail/cltbld', 05:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:10 INFO - 'MOZ_NO_REMOTE': '1', 05:47:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:10 INFO - 'NO_EM_RESTART': '1', 05:47:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:10 INFO - 'PWD': '/builds/slave/test', 05:47:10 INFO - 'SHELL': '/bin/bash', 05:47:10 INFO - 'SHLVL': '1', 05:47:10 INFO - 'TERM': 'linux', 05:47:10 INFO - 'TMOUT': '86400', 05:47:10 INFO - 'USER': 'cltbld', 05:47:10 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', 05:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:10 INFO - '_': '/tools/buildbot/bin/python'} 05:47:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:47:10 INFO - Running setup.py (path:/tmp/pip-vaBfgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:47:10 INFO - Running setup.py (path:/tmp/pip-5UuxAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:47:10 INFO - Running setup.py (path:/tmp/pip-BALwX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:47:10 INFO - Running setup.py (path:/tmp/pip-EzaglX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:47:10 INFO - Running setup.py (path:/tmp/pip-LvhZWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:47:10 INFO - Running setup.py (path:/tmp/pip-BgfLHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:47:10 INFO - Running setup.py (path:/tmp/pip-EeSn13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:47:10 INFO - Running setup.py (path:/tmp/pip-dhvaOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:47:11 INFO - Running setup.py (path:/tmp/pip-npzWCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:47:11 INFO - Running setup.py (path:/tmp/pip-Dd19fD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:47:11 INFO - Running setup.py (path:/tmp/pip-YNhBGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:47:11 INFO - Running setup.py (path:/tmp/pip-mLLwEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:47:11 INFO - Running setup.py (path:/tmp/pip-TCrvdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:47:11 INFO - Running setup.py (path:/tmp/pip-rZqN4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:11 INFO - Running setup.py (path:/tmp/pip-hxGDnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:47:11 INFO - Running setup.py (path:/tmp/pip-thqde6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:47:11 INFO - Running setup.py (path:/tmp/pip-6oC0J0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:47:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:47:11 INFO - Running setup.py install for manifestparser 05:47:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:47:11 INFO - Running setup.py install for mozcrash 05:47:11 INFO - Running setup.py install for mozdebug 05:47:11 INFO - Running setup.py install for mozdevice 05:47:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:47:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:47:12 INFO - Running setup.py install for mozfile 05:47:12 INFO - Running setup.py install for mozhttpd 05:47:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:47:12 INFO - Running setup.py install for mozinfo 05:47:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:47:12 INFO - Running setup.py install for mozInstall 05:47:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:47:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:47:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:47:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:47:12 INFO - Running setup.py install for mozleak 05:47:12 INFO - Running setup.py install for mozlog 05:47:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:47:12 INFO - Running setup.py install for moznetwork 05:47:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:47:12 INFO - Running setup.py install for mozprocess 05:47:12 INFO - Running setup.py install for mozprofile 05:47:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:47:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:47:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:47:13 INFO - Running setup.py install for mozrunner 05:47:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:47:13 INFO - Running setup.py install for mozscreenshot 05:47:13 INFO - Running setup.py install for moztest 05:47:13 INFO - Running setup.py install for mozversion 05:47:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:47:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:47:13 INFO - Cleaning up... 05:47:13 INFO - Return code: 0 05:47:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:13 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 0x1ccd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c3b0>, '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 0x1f8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d740>, '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': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', '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:47:13 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:47:13 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:47:13 INFO - Using env: {'DISPLAY': ':0', 05:47:13 INFO - 'HOME': '/home/cltbld', 05:47:13 INFO - 'LANG': 'en_US.UTF-8', 05:47:13 INFO - 'LANGUAGE': 'en_US:en', 05:47:13 INFO - 'LOGNAME': 'cltbld', 05:47:13 INFO - 'MAIL': '/var/mail/cltbld', 05:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:13 INFO - 'MOZ_NO_REMOTE': '1', 05:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:13 INFO - 'NO_EM_RESTART': '1', 05:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:13 INFO - 'PWD': '/builds/slave/test', 05:47:13 INFO - 'SHELL': '/bin/bash', 05:47:13 INFO - 'SHLVL': '1', 05:47:13 INFO - 'TERM': 'linux', 05:47:13 INFO - 'TMOUT': '86400', 05:47:13 INFO - 'USER': 'cltbld', 05:47:13 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', 05:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:13 INFO - '_': '/tools/buildbot/bin/python'} 05:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:47:13 INFO - Running setup.py (path:/tmp/pip-uQFtXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:47:13 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:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:47:13 INFO - Running setup.py (path:/tmp/pip-tAykoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:47:13 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:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:47:13 INFO - Running setup.py (path:/tmp/pip-jJVv85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:47:13 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:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:47:13 INFO - Running setup.py (path:/tmp/pip-tGus2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:47:13 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:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:47:14 INFO - Running setup.py (path:/tmp/pip-fMb8ET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:47:14 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:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:47:14 INFO - Running setup.py (path:/tmp/pip-r1sEwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:47:14 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:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:47:14 INFO - Running setup.py (path:/tmp/pip-cHQnNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:47:14 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:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:47:14 INFO - Running setup.py (path:/tmp/pip-8SsB91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:47:14 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:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:47:14 INFO - Running setup.py (path:/tmp/pip-CsvW0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:47:14 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:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:47:14 INFO - Running setup.py (path:/tmp/pip-i9nh_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:47:14 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:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:47:14 INFO - Running setup.py (path:/tmp/pip-i1bAoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:47:14 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:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:47:14 INFO - Running setup.py (path:/tmp/pip-Ae_wDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:47:14 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:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:47:14 INFO - Running setup.py (path:/tmp/pip-xZwL2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:47:14 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:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:47:14 INFO - Running setup.py (path:/tmp/pip-RjY27G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:47:14 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:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:14 INFO - Running setup.py (path:/tmp/pip-VpiVX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:47:14 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:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:47:14 INFO - Running setup.py (path:/tmp/pip-KJfn4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:47:14 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:47:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:47:14 INFO - Running setup.py (path:/tmp/pip-wLfllP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:47:14 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:47:14 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:47:14 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:47:14 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:47:14 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:47:14 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:47:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:47:14 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:47:14 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:47:14 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:47:14 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:47:14 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:47:14 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:47:16 INFO - Downloading blessings-1.6.tar.gz 05:47:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:47:16 INFO - Installing collected packages: blessings 05:47:16 INFO - Running setup.py install for blessings 05:47:17 INFO - Successfully installed blessings 05:47:17 INFO - Cleaning up... 05:47:17 INFO - Return code: 0 05:47:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:47:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:47:17 INFO - Reading from file tmpfile_stdout 05:47:17 INFO - Current package versions: 05:47:17 INFO - argparse == 1.2.1 05:47:17 INFO - blessings == 1.6 05:47:17 INFO - blobuploader == 1.2.4 05:47:17 INFO - docopt == 0.6.1 05:47:17 INFO - functools32 == 3.2.3-2 05:47:17 INFO - jsonschema == 2.5.1 05:47:17 INFO - manifestparser == 1.1 05:47:17 INFO - mozInstall == 1.12 05:47:17 INFO - mozcrash == 0.17 05:47:17 INFO - mozdebug == 0.1 05:47:17 INFO - mozdevice == 0.48 05:47:17 INFO - mozfile == 1.2 05:47:17 INFO - mozhttpd == 0.7 05:47:17 INFO - mozinfo == 0.9 05:47:17 INFO - mozleak == 0.1 05:47:17 INFO - mozlog == 3.3 05:47:17 INFO - moznetwork == 0.27 05:47:17 INFO - mozprocess == 0.23 05:47:17 INFO - mozprofile == 0.28 05:47:17 INFO - mozrunner == 6.12 05:47:17 INFO - mozscreenshot == 0.1 05:47:17 INFO - mozsystemmonitor == 0.3 05:47:17 INFO - moztest == 0.7 05:47:17 INFO - mozversion == 1.4 05:47:17 INFO - psutil == 3.1.1 05:47:17 INFO - requests == 1.2.3 05:47:17 INFO - wsgiref == 0.1.2 05:47:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:47:17 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:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:17 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:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:17 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 0x1ccd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c3b0>, '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 0x1f8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d740>, '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': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', '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:47:17 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:47:17 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:47:17 INFO - Using env: {'DISPLAY': ':0', 05:47:17 INFO - 'HOME': '/home/cltbld', 05:47:17 INFO - 'LANG': 'en_US.UTF-8', 05:47:17 INFO - 'LANGUAGE': 'en_US:en', 05:47:17 INFO - 'LOGNAME': 'cltbld', 05:47:17 INFO - 'MAIL': '/var/mail/cltbld', 05:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:17 INFO - 'MOZ_NO_REMOTE': '1', 05:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:17 INFO - 'NO_EM_RESTART': '1', 05:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:17 INFO - 'PWD': '/builds/slave/test', 05:47:17 INFO - 'SHELL': '/bin/bash', 05:47:17 INFO - 'SHLVL': '1', 05:47:17 INFO - 'TERM': 'linux', 05:47:17 INFO - 'TMOUT': '86400', 05:47:17 INFO - 'USER': 'cltbld', 05:47:17 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', 05:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:17 INFO - '_': '/tools/buildbot/bin/python'} 05:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 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:47:17 INFO - Cleaning up... 05:47:17 INFO - Return code: 0 05:47:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:47:17 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:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:17 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:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:47:17 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 0x1ccd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8c3b0>, '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 0x1f8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d740>, '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': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', '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:47:17 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:47:17 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:47:17 INFO - Using env: {'DISPLAY': ':0', 05:47:17 INFO - 'HOME': '/home/cltbld', 05:47:17 INFO - 'LANG': 'en_US.UTF-8', 05:47:17 INFO - 'LANGUAGE': 'en_US:en', 05:47:17 INFO - 'LOGNAME': 'cltbld', 05:47:17 INFO - 'MAIL': '/var/mail/cltbld', 05:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:17 INFO - 'MOZ_NO_REMOTE': '1', 05:47:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:17 INFO - 'NO_EM_RESTART': '1', 05:47:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:17 INFO - 'PWD': '/builds/slave/test', 05:47:17 INFO - 'SHELL': '/bin/bash', 05:47:17 INFO - 'SHLVL': '1', 05:47:17 INFO - 'TERM': 'linux', 05:47:17 INFO - 'TMOUT': '86400', 05:47:17 INFO - 'USER': 'cltbld', 05:47:17 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', 05:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:17 INFO - '_': '/tools/buildbot/bin/python'} 05:47:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:47:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:47:17 INFO - Cleaning up... 05:47:17 INFO - Return code: 0 05:47:17 INFO - Running post-action listener: _resource_record_post_action 05:47:17 INFO - Running post-action listener: _start_resource_monitoring 05:47:17 INFO - Starting resource monitoring. 05:47:17 INFO - [mozharness: 2016-08-07 12:47:17.778184Z] Finished create-virtualenv step (success) 05:47:17 INFO - [mozharness: 2016-08-07 12:47:17.778626Z] Running install step. 05:47:17 INFO - Running pre-action listener: _resource_record_pre_action 05:47:17 INFO - Running main action method: install 05:47:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:47:17 INFO - Reading from file tmpfile_stdout 05:47:17 INFO - Detecting whether we're running mozinstall >=1.0... 05:47:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:47:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:47:18 INFO - Reading from file tmpfile_stdout 05:47:18 INFO - Output received: 05:47:18 INFO - Usage: mozinstall [options] installer 05:47:18 INFO - Options: 05:47:18 INFO - -h, --help show this help message and exit 05:47:18 INFO - -d DEST, --destination=DEST 05:47:18 INFO - Directory to install application into. [default: 05:47:18 INFO - "/builds/slave/test"] 05:47:18 INFO - --app=APP Application being installed. [default: firefox] 05:47:18 INFO - mkdir: /builds/slave/test/build/application 05:47:18 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:47:18 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:47:35 INFO - Reading from file tmpfile_stdout 05:47:35 INFO - Output received: 05:47:35 INFO - /builds/slave/test/build/application/firefox/firefox 05:47:35 INFO - Running post-action listener: _resource_record_post_action 05:47:35 INFO - [mozharness: 2016-08-07 12:47:35.144254Z] Finished install step (success) 05:47:35 INFO - [mozharness: 2016-08-07 12:47:35.144588Z] Running run-tests step. 05:47:35 INFO - Running pre-action listener: _resource_record_pre_action 05:47:35 INFO - Running main action method: run_tests 05:47:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:47:35 INFO - Python 2.7.3 05:47:35 INFO - Return code: 0 05:47:35 INFO - grabbing minidump binary from tooltool 05:47:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:47:35 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 0x1f8c3b0>, '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 0x1f8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:47:35 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:47:35 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:47:35 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:47:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:47:35 INFO - Return code: 0 05:47:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:47:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:47:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:47:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:47:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:47:35 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/ekaZlwOmTUW3URQTgOTiAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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:47:35 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/ekaZlwOmTUW3URQTgOTiAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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:47:35 INFO - Using env: {'DISPLAY': ':0', 05:47:35 INFO - 'HOME': '/home/cltbld', 05:47:35 INFO - 'LANG': 'en_US.UTF-8', 05:47:35 INFO - 'LANGUAGE': 'en_US:en', 05:47:35 INFO - 'LOGNAME': 'cltbld', 05:47:35 INFO - 'MAIL': '/var/mail/cltbld', 05:47:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:47:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:47:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:35 INFO - 'MOZ_NO_REMOTE': '1', 05:47:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:47:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:47:35 INFO - 'NO_EM_RESTART': '1', 05:47:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:47:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:35 INFO - 'PWD': '/builds/slave/test', 05:47:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:47:35 INFO - 'SHELL': '/bin/bash', 05:47:35 INFO - 'SHLVL': '1', 05:47:35 INFO - 'TERM': 'linux', 05:47:35 INFO - 'TMOUT': '86400', 05:47:35 INFO - 'USER': 'cltbld', 05:47:35 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348', 05:47:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:35 INFO - '_': '/tools/buildbot/bin/python'} 05:47:35 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/ekaZlwOmTUW3URQTgOTiAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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:47:35 INFO - mozversion application_buildid: 20160807030201 05:47:35 INFO - mozversion application_changeset: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 05:47:35 INFO - mozversion application_display_name: Nightly 05:47:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:47:35 INFO - mozversion application_name: Firefox 05:47:35 INFO - mozversion application_remotingname: firefox 05:47:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:47:35 INFO - mozversion application_vendor: Mozilla 05:47:35 INFO - mozversion application_version: 51.0a1 05:47:35 INFO - mozversion platform_buildid: 20160807030201 05:47:35 INFO - mozversion platform_changeset: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 05:47:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:47:35 INFO - mozversion platform_version: 51.0a1 05:47:35 INFO - using testdate: 1470574055 05:47:35 INFO - actual date: 1470574055 05:47:35 INFO - starting webserver on 'localhost:57099' 05:47:35 INFO - SUITE-START | Running 2 tests 05:47:35 INFO - TEST-START | dromaeo_css 05:47:35 INFO - operating with platform_type : linux_ 05:47:35 INFO - Initialising browser for dromaeo_css test... 05:47:35 INFO - TEST-INFO | started process 16942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP_GJnB/profile http://localhost:57099/getInfo.html) 05:47:39 INFO - PROCESS | 16942 | __metrics Screen width/height:1600/1200 05:47:39 INFO - PROCESS | 16942 | colorDepth:24 05:47:39 INFO - PROCESS | 16942 | Browser inner width/height: 1024/697 05:47:39 INFO - PROCESS | 16942 | __metrics 05:47:40 ERROR - PROCESS | 16942 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:47:41 INFO - TEST-INFO | 16942: exit 0 05:47:41 INFO - Browser initialized. 05:47:41 INFO - Running cycle 1/1 for dromaeo_css test... 05:47:41 INFO - TEST-INFO | started process 17066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP_GJnB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:53 INFO - PROCESS | 17066 | RSS: Main: 163430400 05:47:53 INFO - PROCESS | 17066 | 05:48:42 INFO - PROCESS | 17066 | 1470574122712 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:50:52 INFO - PROCESS | 17066 | Cycle 1(1): loaded http://localhost:57099/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57099/tests/dromaeo/cssquery-ext.html) 05:50:53 INFO - PROCESS | 17066 | RSS: Main: 166633472 05:50:53 INFO - PROCESS | 17066 | 05:53:55 INFO - PROCESS | 17066 | Cycle 1(1): loaded http://localhost:57099/tests/dromaeo/cssquery-ext.html (next: http://localhost:57099/tests/dromaeo/cssquery-jquery.html) 05:53:56 INFO - PROCESS | 17066 | RSS: Main: 166080512 05:53:56 INFO - PROCESS | 17066 | 05:56:58 INFO - PROCESS | 17066 | Cycle 1(1): loaded http://localhost:57099/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57099/tests/dromaeo/cssquery-mootools.html) 05:56:58 INFO - PROCESS | 17066 | RSS: Main: 169943040 05:56:58 INFO - PROCESS | 17066 | 06:00:00 INFO - PROCESS | 17066 | Cycle 1(1): loaded http://localhost:57099/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57099/tests/dromaeo/cssquery-prototype.html) 06:00:01 INFO - PROCESS | 17066 | RSS: Main: 164098048 06:00:01 INFO - PROCESS | 17066 | 06:03:03 INFO - PROCESS | 17066 | Cycle 1(1): loaded http://localhost:57099/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57099/tests/dromaeo/cssquery-yui.html) 06:03:04 INFO - PROCESS | 17066 | RSS: Main: 166207488 06:03:04 INFO - PROCESS | 17066 | 06:06:06 INFO - PROCESS | 17066 | Cycle 1(1): loaded http://localhost:57099/tests/dromaeo/cssquery-yui.html (next: http://localhost:57099/tests/dromaeo/cssquery-dojo.html) 06:06:07 INFO - PROCESS | 17066 | RSS: Main: 169664512 06:06:07 INFO - PROCESS | 17066 | 06:06:07 INFO - PROCESS | 17066 | __start_tp_report 06:06:07 INFO - PROCESS | 17066 | _x_x_mozilla_page_load 06:06:07 INFO - PROCESS | 17066 | _x_x_mozilla_page_load_details 06:06:07 INFO - PROCESS | 17066 | |i|pagename|runs| 06:06:07 INFO - PROCESS | 17066 | |0;dojo.html;3090.7527397808176;3120.7815452918303;3128.9687103128977;3161.762867784915;3162.3517178978313;5381.730913454331;5426.213199086135;5432.918506222405;5453.15476101204;5482.369527504338;5347.385050719168;5354.27717258171;5369.060414427469;5418.241446197526;5432.375276843164;4794.5205479452125;4870.6103511718975;4933.605311575084;4974.7015179089185;5003.449620541755;4973.154563724158;5009.398872135349;5016.147254966646;5071.036503064424;5121.846344609649;4807.23084306511;4888.193448081062;4923.01539692063;4924.876878078041;4971.353724015855;4892.877678058041;4922.852314430537;4926.916078462733;4947.925781113287;4965.826196083156;4852.199387101159;4861.8784530386665;4872.902541949141;4904.681195722303;4904.779284932187;5316.255724198577;5369.758360873731;5407.675539467645;5458.2904222451225;5480.588955828329;5830.067189249742;5832.941670583325;5833.445822646884;5835.883282334372;5837.678927658977;5759.856003599902;5833.445822646841;5841.532677385841;5845.85385365365;5858.502027327682;5416.295881535415;5459.454054594548;5466.945330546644;5494.2582751328055;5540.612157149041;5990.850228744316;5994;5997.550183736237;6005.489533389711;6005.879882402328;5641.548676105902;5716.714164291769;5733.455321744427;5751.626144300607;5767.452092051249;5708.457696518824;5756.740946657411;5790.044642634002;5817.156512305692;5892.823215303548;5739.913901291484;5800.709964501758;5841.386654401312;5857;5862.091375836752;5751.252337196222;5855.268091488564;5855.941440585625;5869.647821130746;5907.172995780594;4370.213361594943;4387.605115539617;4389.912201756011;4407.140607581491;4477.977610111929;3928.253631809947;3969.543502497192;3971.8808435746973;3981.462502562175;3983.6016398359934;5400.243965844785;5502.064649009678;5519.69641669712;5520.337559492887;5543.805966791224;5751.971240143856;5779.8555036124435;5809.68046757424;5887.087501437284;5900.350961394243;5582.469665381782;5608.747606357723;5617.634853734576;5617.662940223599;5632.464915832989;4938.616488992834;4983.127952608352;4995.475475075137;5003.924941125886;5013.846815232517;5929.703514824241;5970.13433052205;5984.850378740566;5995.190649262381;6158.692065396713;5813.418658134153;5819.301683797971;5820.563457740602;5831.4168583141345;5874.441928016831;6020.668863212565;6034.63792172471;6038.788642397495;6048.788292409745;6071.058985857199;5508.925759476863;5676.347220069745;5688.232088667977;5698.20225168485;5720.342160651412;5821;5850.5027072699295;5853.970730146322;5860.531157507475;5890.7349169288345;5670.574706896917;5706.058500347396;5712.428757124254;5721.885562288814;5725.227094342377;5604.579656525695;5636.802711905064;5706.4864162225595;5718.285214348207;5758.1650660654805;5682.715864206691;5694.715264236689;5708.200851880823;5712.057510510719;5712.11462223356;5743.4543718346695;5764.567657425626;5812.970935145467;5817.243758311392;5825.912611310919;5442.129259318648;5482.17767334903;5493.752781124939;5531.861703457284;5566.805161819479 06:06:07 INFO - PROCESS | 17066 | |1;ext.html;561.2058936604705;584.5528170949227;585.1164741240727;585.9267591551055;617.8455386153462;38524.61475385245;42841.571584284146;42907.92730181739;43028.354574681405;43208.56791432085;43153;44187.337189942176;44328;44374;44405.77797111018;8826.426282291663;8885.822283554326;8929.821403571925;8934;8963.238124759404;8911.287097032222;8957.19385255327;8965.596548155349;8966.968798588148;9000.954995225047;8958;9047.864282035742;9053.230475409599;9058.365914385995;9064.365494415393;8885.777855553599;8976.8653470198;8996.775080623003;9006.86489702655;9057.456552606865;8817.07420720828;8842.690505832265;8902.33232507558;8922;8927.107289271085;41285.1742965139;41375.793121034505;41638;41736;41760.58239417628;3547.7516573839844;3641.308151451216;3664.3770559005034;3677.963220367789;3790.3556395412847;32613.347733045208;33086.50370244448;33562;33674.49488257678;33848.32303353944;4302;4372.27857403528;4385.539518350559;4436.64506839452;4521.502634710212;363634;365415;365505;366668;367075;57871;58155.41844581585;58504.41495585075;58585.70707146437;58789;60897;61134.38865611376;61225;61614.38385616176;61643.691781541704;16538.6692266154;16763.245653945356;16892.324307027826;16917.40789072401;16928.83071169297;12999.935000324938;13039.674008149872;13054.608361749162;13132.621074787201;13173;15874.682506349809;16002.67994640124;16116.113613751357;16219.35122595083;16603.335866565445;6524.608523488606;6526.706298216592;6549.380247900783;6607.654282729562;6733.326667333227;890.528020149322;991.1426615977127;995.6216637677636;1062.3254233561745;1066.5627092891878;32576.34847303088;32697.346053078803;32913.506297405555;33314;33420.331593368486;1085.148158695436;1126.9492872820742;1130.6099395708632;1170.53763763313;1196.1268274159738;16573.50279491593;16899.662006759794;17061.658766824596;17588.736168957475;18168.909155454403;251296;493955;496666;498041;773606;60237;60388;60621.69689151526;61072;61088.694556526934;1323.3780123342015;1329.6011196640968;1343.267918984156;1360.5782207515701;1363.229775177002;31638.841805790824;33315.66684333223;33829.3234135311;33892.32215355728;33917.660823392434;51888.962220756126;51976.740116299174;52072;52164.478355215964;52321.47678523166;434749;436645;437045;438875;443349;28536.857315714118;28566.285842854097;28724.569131462627;28865.278368040967;28968.565471518366;46618.76690616525;47822.76088619535;48504.27243591278;48523.27215091706;48875.755621221666;40279.3958090623;40821.79589102035;41499.7925010373;43359.56640433555;45524.54475455335;42989.14021719486;43493.565064350216;43562.564374355854;43645;44132.558674412845;36271.63728362683;41474.58525414828;42264.577354226065;42465.36301955411;43226;35084.64915350814;37966.43050354192;38221.42667859929;38563.2287354257;38835.805820971844;28468.28829279202;28837.42325153527;29000.419991600473;29022.27444313909;29249.70750292555 06:06:07 INFO - PROCESS | 17066 | |2;jquery.html;380.96190380961906;385.51810237203495;392.4035466091541;397.2901255614686;405.0925925925925;18782.43652690418;19751.901240493815;20261.696074558895;20284.39146825594;20472.69290960635;10875.510602022909;11091;11095.945885140918;19467.805321946777;19798.30705925293;5039.672421292605;5131.050755610224;5182;5194.298769666103;5201.843944681666;5292;5542.196381524676;5554.472325129126;5652.717364131798;5681.744321505542;5663.575231857607;5676.574256930726;6487.6756162191705;6594.142761441006;6670.166229221348;6574.671266436707;6611.471082313427;6638.966805165992;6644.235912870034;6655.800325990228;5755.856103597402;5800.361960184377;5894.616849904743;5904.822855314347;5911.142884281798;12722.473303203675;13031.804522932163;21475.248366307103;22120.115195392165;22305.107795688153;2254.1997590855176;2312.7455979842202;2367.6093444581625;2600.8439493630444;2709.823861449019;9485.47829869357;9851.704448866474;9873.407595544219;9909.554070066864;10212.74468138295;1847.4272975377676;1898.4874083997381;1966.488712934633;2001.949951251216;2022.1810166882435;78624.60687696525;80428;81675.9999999994;81700;85583.57208213981;9772.804543909082;10126.54430550627;10361.481925903674;11070.28043177191;11287.322760634388;15282.541523754306;15315;15361.539153825403;15409.152496612569;15465;7757;8053.234942680436;8065.6370463329295;8279.54462504568;8300.833983320299;7803.570803605742;7895.763127106196;7969.481983671159;8111.716089936942;8167.183281671785;4394.340848872695;4459.531749166291;4519.751413672214;4560.612347950461;4805;1965.9803401965796;1970.940871773849;1990.8307793837396;1999.3701983875033;2069.368842503051;883.4964070479894;963.3401120232663;1000.46475135802;1021.4739409204266;1035.5288343803552;19723.901380493007;19873.801261987195;19995;20047.097880595407;20048.49878753043;968.1722127580957;986.4574484033752;1003.3127307794184;1011.595361855249;1014.0467960117466;10576.20678449104;11102.944485277683;11167.162462815322;11238;11317.547298107984;458890;461067;466239;489320;499635;71079.64460177666;93111;94653.52673236589;97083;98849.50575247078;969.4425705219527;1000.4747507558444;1005.5977608956476;1028.0644613401769;1029.8197815382277;13689.794653080411;16971.660566788843;17329.82670173282;18379.356722514647;18452.723209151605;29844.85077574598;31972.20069498281;43099.784501077294;43235.783821080695;44026.559734402246;54348.728256360046;54801.45198547964;58295.70852145712;58651.4134858663;59141;8477.576121194039;8534.146585341665;8560.785980350292;8639.87040194385;9128.908710913072;12826.166299190523;13610.38753256086;14090.647733806736;14160.150390976574;14342.211178385289;11993.700157495783;11995.340256285988;12217.411736474201;12239.143259971717;12519.123661343618;11830.231034983042;11894.345810980132;12146.39268036577;12190.268583884996;12486;12251.264924104582;12446;12724.936375318064;12866.742665146832;13125.737485250433;8573.74278771638;8622.310215182644;8820.338474614558;8977.640894364413;9067.254202141468;10453.634122805664;11648.41757912118;12069.21550099276;12212.75574488523;12337.321447320484 06:06:07 INFO - PROCESS | 17066 | |3;mootools.html;1446.146773403692;1481.1631428243043;1575.6454797670526;1728.567858035491;1733.2460379734816;8179.100298967109;8580.270676992455;8748.081451447602;9283.814323713521;9290.117438843308;8774.166454186841;9044.23124034458;9060.909390906088;9062.229710474618;9064.501452420114;2347.1667558016916;2371.9169829055986;2382.5830479666074;2393.8803059847023;2402.0511897800448;2333.894974726133;2356.7878890899815;2394.0782798622567;2399.4241382068267;2402.7116745990506;2299.2642354446584;2308.088305119477;2326.2788535553946;2332.47519308156;2341.285907798121;2282.2468585366955;2305.469741959342;2307.400075980249;2310.376198426424;2315.849469784467;2282.783135602115;2302.861828290308;2304.585174668559;2304.8501847379866;2316.5366926614743;9401.388909720914;9465.148136667663;9495.240380769523;9499.097585729414;9499.952500237523;5112.41207261166;5278.524932756032;5377.623566350357;5417.647852889589;5418.431064738185;3218.5815843940372;3302.3065156317202;3381.898543043713;3392.287619599887;3404.591449026108;983.6999715086896;997.9351342162736;1005.1958433253368;1026.7792424628667;1051.7475805806628;12877.420516076705;12889.484420623165;12938.611841644766;13012;13014.739705205842;4575.816967321336;4650.651201159926;4834.105690447279;4861.27080937855;4870.732109733928;10906.72733181661;10925.562977480811;10931.398773067558;10935.17986151026;10953.671389858317;5411.431799661058;5427.348718153768;5427.810026649048;5428.5385742211565;5463.153211252183;4446.73319600825;4855.465898751135;4963.60291176705;4976.751162441863;4985.152524070917;4002.779847108379;4088.5298190707854;4118.341065429517;4198.979005104955;4214.4099826024385;1250.156144602408;1262.678017105632;1271.5041133957764;1287.7424515097018;1306.2293246984325;939.3002213351098;952.4523399045577;959.3764053365369;967.1585720423277;1010.4745532323151;5831.2127862738835;6057.727402266909;6140.907886381708;6166.568340216142;6183.84540386494;401.8714011516287;414.30396933152593;425.213355292706;427.20113387964705;427.8759159843673;4136.131412403369;4202.3696445533415;4213.241616508996;4220.2192594370135;4239.957600424018;10506.789864202674;10695.251332406657;10741.087007604285;10763.19276054299;10787.730306742395;10686.465676716132;10729.785404292026;10795.730106747236;10796.406197659204;10801.891981080245;8056.234657707626;8189.71336003249;8295.294899933453;8359.665613375519;8558.95720521406;6253.687315634291;6320.936790632219;6437.871242575216;6492.188476440445;6552.705128269144;10550.736231594272;10685.732856678645;10846.45767711627;10937.45312734376;10956.506957186786;10654.680359589225;10946.562137514411;10975.945120274668;10995.285306455055;11048.61892263467;7482.438817088849;7910.841783164419;8085.716999904975;8340.582970851312;8692.087330830425;8628.439151455135;8964.641414343614;8975.102489750972;9001;9002.144796244347;7473.364763995121;7475.0656167979005;7749.3413059890545;8012.118666946748;8044.396670249637;7751.0311211098615;7933;7961.283484486424;8061.556614386031;8091.757247282591;7367.410607151308;7467.290607392289;7510.286522780327;7550;7563.243675632392;5321.813736519203;5392.703401312965;5398.703071331114;5577.386487486292;5643.068893632505;5244.449332819999;5340.732963351895;5484.972575137258;5528.55771538284;5641.435856414326 06:06:07 INFO - PROCESS | 17066 | |4;prototype.html;325.80451728962623;332.48298895217926;332.59589598637655;332.6241347277576;336.8652538984406;5435.701036442994;5520.861978450541;5566.888662226753;5596.237185286642;5604.747786349614;5461.508464238218;5470.2888624478865;5477.411550650307;5485.204645326426;5508.64193827401;4070;4209.758121354208;4268.231718290706;4295.484541854982;4300.354946757996;4277.379779931908;4295.914081718363;4309.892252693677;4324.913501729963;4326.891827704317;4295.4201182840225;4312.935305970413;4319.69762116652;4321.783910804463;4325.718828276168;4068.9796551017203;4263.360495925605;4274.850380236708;4308.526062133163;4311.563966359013;3761.7554858934354;3777.508923839883;3780.092777733352;3785.3754130568423;3801.2967600993907;5372.677639341652;5373.963710503553;5382.542483888874;5388.7305634718105;5411.756470958816;4854.417469903634;4872.6832755870755;4912.803487860481;4933.86521100149;4976.502349765031;5630.774769009235;5689.288838895138;5693.77224911003;5704.572157088193;5754.712264386764;4201.243776120297;4207.326827707552;4210.642095421893;4210.894727631803;4222.641075508585;5765.971170144165;5868.882622347529;5941.732622031976;5981.162637230835;5990.2212712347555;4209.34755112958;4213.641840443596;4223.493180818322;4224.831006759757;4269.167512335065;4303.074838909587;4306.224879521654;4307.6338511226895;4314.676399270004;4320.092780516064;4636.744979026186;4838.588719958843;4873.731944743073;4898.461169271377;4927.926081108786;5714.685692286964;5715.857103572361;5723.828285151452;5742.913856292159;5749.8787736391005;1485.8959872809016;1494.8579884910916;1497.7044856199527;1503.5639664497173;1509.9622509437352;938.4650749073099;968.6367612145445;988.2193067476757;995.7751965082844;1005.527402121002;5430.375506816767;5445.292112025411;5456.454354564512;5473.890522189534;5477.890442191134;5810.767569297265;5823.767049318065;5831.825045248649;5841.4450627190345;5852.297724273115;5266.315379000705;5375.715320988565;5437.238786569884;5491.203775452537;5509.47659972302;3055.801372910754;3095.622448010659;3097.7521798256084;3105.891293804706;3123.531470279431;5843.444872737083;6027.758889644453;6034.39656034393;6061.181740464981;6062.514998800086;5831.358550559435;5855.590108692436;5857.70711464425;5870.618409803349;6011.428914253226;6025.0962355646125;6058;6058.27300723916;6083.6045657032155;6087.29996050451;5597.216389705526;5792.594518383673;5910.822675319747;5927.673977931255;5933.02105152645;5827.271591051119;5861.912071319019;5868.882622347614;5886.146508756292;5889.764409423747;5828.300603927556;6178.598391104564;6238.844028899314;6284.874302514016;6340.7318536292005;4110.34234522475;4117.911566325256;4126.339785634284;4134.131832315247;4154.563770804022;5702.429757024431;5925;5965.313988891333;5973.641581505123;5987.592915664728;5619.353774315842;5727.971360143172;5734.3978882218435;5745.798897038583;5760.481556659921;5710.8572285691525;5752.424757524214;5759.481646651821;5762.654240745401;5775.451332123442;5533.6403133796175;5642.407547207648;5669;5706;5742.1673857289625;5722.5135863450405;5725.312962444534;5733.770649173986;5758.827235182951;5770.6241848519085;5423.864403389947;5622.578306626938;5629.774809007594;5650.85872853182;5727.455891690282 06:06:07 INFO - PROCESS | 17066 | |5;yui.html;684.5858255755268;770.1566784371112;774.1909704358944;791.4380789639353;873.5195642396682;14440.277986100693;14835;14969.5509134726;14986.400543978256;15057.472988445406;14139.646508837284;14436.711265774704;14551.3451894665;14564.271786410663;14607.123572585653;806.7055524733474;819.5205804604284;822.116225058062;823.127484866041;823.4976664234812;659.7525927777084;800.0399520575304;805.5972013993004;819.5574389829485;832.592029905345;873.2228316798023;873.6243415331405;875.347865839947;876.2508055612456;878.661715239631;871.2594294849359;871.2594294849391;872.4590753732663;873.1922971251566;874.2656168818191;632.7975047984647;634.3181080338609;634.7524465458475;636.4399328590856;637.4167636612494;14781.334839932122;14827.77758333626;14850.108993460426;14913.2543372832;14928.776068358984;14578.343974521173;14603.415863365453;14641.121532707964;14971.77542336855;15028;12338.259704417764;12361.567345142967;12462.626121216377;12648.430820613094;12929.48282068716;3814.4850445189822;3821.6179578166816;3851.4222866569958;3902.2195560887935;3910.3808812546677;80413.99999999942;81840.18159818444;82213.17786822114;82795.17204827996;82957.17042829616;11326.490307936163;11431.828522572168;11467.999999999833;11516.251443656136;11714.297142171497;22579.661305080437;22922.186340868604;22935;22952.770472295397;23062.65406018911;7969.362451003905;8005.239502247277;8029.718959836495;8050.315723163597;8238.09380968093;4393.824247030083;4465.620422264144;4489;4498.752568608693;4520.141173177086;3589.10272431892;3719.4420836874683;3725;3741.382671859167;3760.811959402019;610.7495926670133;614.6250787019915;628.23982980594;629.4586655476287;637.3753721353007;661.454300202335;670.3932940688685;678.7386856060452;685.85939882325;708.0193931404938;9639.614415423304;10049.196064314838;10174.287799854088;10230.028147325993;10413.739656508496;577.206341280739;680.877442060424;714.1572943926217;726.5023458930649;759.2104211619853;4901.823562345083;4988.950110498921;5024.221245706921;5068.923966140511;5085.338905942203;77126;93632;95547.52226238964;97147;127213.36393317975;91331.54334228419;94077.5296123515;94210.5289473562;96580.51709741406;99382.00617993872;59095.99999999914;61501.384986150464;62505;83422.58288708517;90813.40430317089;9114.982022371232;9999.600015999278;10271.589136434459;10467.267291289536;10470.842937356098;52310.47689523208;53738;53936;54382;55663.721681392955;80221.59889200516;81384.59307703661;82965;83433.16566834497;83884;14310.642233944234;14341.85658143447;14470.348834302271;14496.34766435534;14740.041897276642;14469.710605787615;14513.419463221353;14604;15049.849501504845;15369.231538423257;13716.24560649134;13748.450061997408;13832.446702131801;14197.290135493391;14496.202708851115;13621.727565448833;13775.448982040607;13920.164790112221;13966.4413423466;13972.510962116277;13045.282509461691;13434.731305373642;13464.865351346753;13538.661533461742;13968.930155349159;10969.670909872717;11125.554977800797;11403.705979626578;11452.141089418494;11524.539018439504;10648.89351106479;11325.660230193107;12282.728875519295;12403.565875194325;12552.435140418886 06:06:07 INFO - PROCESS | 17066 | __end_tp_report 06:06:07 INFO - PROCESS | 17066 | __start_cc_report 06:06:07 INFO - PROCESS | 17066 | _x_x_mozilla_cycle_collect,358 06:06:07 INFO - PROCESS | 17066 | __end_cc_report 06:06:07 INFO - PROCESS | 17066 | __startTimestamp1470575167074__endTimestamp 06:06:07 INFO - PROCESS | 17066 | 06:06:07 INFO - PROCESS | 17066 | ------- Summary: start ------- 06:06:07 INFO - PROCESS | 17066 | Number of tests: 6 06:06:07 INFO - PROCESS | 17066 | 06:06:07 INFO - PROCESS | 17066 | [#0] dojo.html Cycles:165 Average:5406.89 Median:5636.80 stddev:624.61 (11.1%) stddev-sans-first:599.52 06:06:07 INFO - PROCESS | 17066 | Values: 3090.8 3120.8 3129.0 3161.8 3162.4 5381.7 5426.2 5432.9 5453.2 5482.4 5347.4 5354.3 5369.1 5418.2 5432.4 4794.5 4870.6 4933.6 4974.7 5003.4 4973.2 5009.4 5016.1 5071.0 5121.8 4807.2 4888.2 4923.0 4924.9 4971.4 4892.9 4922.9 4926.9 4947.9 4965.8 4852.2 4861.9 4872.9 4904.7 4904.8 5316.3 5369.8 5407.7 5458.3 5480.6 5830.1 5832.9 5833.4 5835.9 5837.7 5759.9 5833.4 5841.5 5845.9 5858.5 5416.3 5459.5 5466.9 5494.3 5540.6 5990.9 5994.0 5997.6 6005.5 6005.9 5641.5 5716.7 5733.5 5751.6 5767.5 5708.5 5756.7 5790.0 5817.2 5892.8 5739.9 5800.7 5841.4 5857.0 5862.1 5751.3 5855.3 5855.9 5869.6 5907.2 4370.2 4387.6 4389.9 4407.1 4478.0 3928.3 3969.5 3971.9 3981.5 3983.6 5400.2 5502.1 5519.7 5520.3 5543.8 5752.0 5779.9 5809.7 5887.1 5900.4 5582.5 5608.7 5617.6 5617.7 5632.5 4938.6 4983.1 4995.5 5003.9 5013.8 5929.7 5970.1 5984.9 5995.2 6158.7 5813.4 5819.3 5820.6 5831.4 5874.4 6020.7 6034.6 6038.8 6048.8 6071.1 5508.9 5676.3 5688.2 5698.2 5720.3 5821.0 5850.5 5854.0 5860.5 5890.7 5670.6 5706.1 5712.4 5721.9 5725.2 5604.6 5636.8 5706.5 5718.3 5758.2 5682.7 5694.7 5708.2 5712.1 5712.1 5743.5 5764.6 5813.0 5817.2 5825.9 5442.1 5482.2 5493.8 5531.9 5566.8 06:06:07 INFO - PROCESS | 17066 | 06:06:07 INFO - PROCESS | 17066 | [#1] ext.html Cycles:180 Average:60100.86 Median:43090.68 stddev:119392.14 (277.1%) stddev-sans-first:119643.38 06:06:07 INFO - PROCESS | 17066 | Values: 561.2 584.6 585.1 585.9 617.8 38524.6 42841.6 42907.9 43028.4 43208.6 43153.0 44187.3 44328.0 44374.0 44405.8 8826.4 8885.8 8929.8 8934.0 8963.2 8911.3 8957.2 8965.6 8967.0 9001.0 8958.0 9047.9 9053.2 9058.4 9064.4 8885.8 8976.9 8996.8 9006.9 9057.5 8817.1 8842.7 8902.3 8922.0 8927.1 41285.2 41375.8 41638.0 41736.0 41760.6 3547.8 3641.3 3664.4 3678.0 3790.4 32613.3 33086.5 33562.0 33674.5 33848.3 4302.0 4372.3 4385.5 4436.6 4521.5 363634.0 365415.0 365505.0 366668.0 367075.0 57871.0 58155.4 58504.4 58585.7 58789.0 60897.0 61134.4 61225.0 61614.4 61643.7 16538.7 16763.2 16892.3 16917.4 16928.8 12999.9 13039.7 13054.6 13132.6 13173.0 15874.7 16002.7 16116.1 16219.4 16603.3 6524.6 6526.7 6549.4 6607.7 6733.3 890.5 991.1 995.6 1062.3 1066.6 32576.3 32697.3 32913.5 33314.0 33420.3 1085.1 1126.9 1130.6 1170.5 1196.1 16573.5 16899.7 17061.7 17588.7 18168.9 251296.0 493955.0 496666.0 498041.0 773606.0 60237.0 60388.0 60621.7 61072.0 61088.7 1323.4 1329.6 1343.3 1360.6 1363.2 31638.8 33315.7 33829.3 33892.3 33917.7 51889.0 51976.7 52072.0 52164.5 52321.5 434749.0 436645.0 437045.0 438875.0 443349.0 28536.9 28566.3 28724.6 28865.3 28968.6 46618.8 47822.8 48504.3 48523.3 48875.8 40279.4 40821.8 41499.8 43359.6 45524.5 42989.1 43493.6 43562.6 43645.0 44132.6 36271.6 41474.6 42264.6 42465.4 43226.0 35084.6 37966.4 38221.4 38563.2 38835.8 28468.3 28837.4 29000.4 29022.3 29249.7 06:06:07 INFO - PROCESS | 17066 | 06:06:07 INFO - PROCESS | 17066 | [#2] jquery.html Cycles:180 Average:28314.62 Median:30908.53 stddev:78461.06 (253.8%) stddev-sans-first:78653.13 06:06:07 INFO - PROCESS | 17066 | Values: 381.0 385.5 392.4 397.3 405.1 18782.4 19751.9 20261.7 20284.4 20472.7 10875.5 11091.0 11095.9 19467.8 19798.3 5039.7 5131.1 5182.0 5194.3 5201.8 5292.0 5542.2 5554.5 5652.7 5681.7 5663.6 5676.6 6487.7 6594.1 6670.2 6574.7 6611.5 6639.0 6644.2 6655.8 5755.9 5800.4 5894.6 5904.8 5911.1 12722.5 13031.8 21475.2 22120.1 22305.1 2254.2 2312.7 2367.6 2600.8 2709.8 9485.5 9851.7 9873.4 9909.6 10212.7 1847.4 1898.5 1966.5 2001.9 2022.2 78624.6 80428.0 81676.0 81700.0 85583.6 9772.8 10126.5 10361.5 11070.3 11287.3 15282.5 15315.0 15361.5 15409.2 15465.0 7757.0 8053.2 8065.6 8279.5 8300.8 7803.6 7895.8 7969.5 8111.7 8167.2 4394.3 4459.5 4519.8 4560.6 4805.0 1966.0 1970.9 1990.8 1999.4 2069.4 883.5 963.3 1000.5 1021.5 1035.5 19723.9 19873.8 19995.0 20047.1 20048.5 968.2 986.5 1003.3 1011.6 1014.0 10576.2 11102.9 11167.2 11238.0 11317.5 458890.0 461067.0 466239.0 489320.0 499635.0 71079.6 93111.0 94653.5 97083.0 98849.5 969.4 1000.5 1005.6 1028.1 1029.8 13689.8 16971.7 17329.8 18379.4 18452.7 29844.9 31972.2 43099.8 43235.8 44026.6 54348.7 54801.5 58295.7 58651.4 59141.0 8477.6 8534.1 8560.8 8639.9 9128.9 12826.2 13610.4 14090.6 14160.2 14342.2 11993.7 11995.3 12217.4 12239.1 12519.1 11830.2 11894.3 12146.4 12190.3 12486.0 12251.3 12446.0 12724.9 12866.7 13125.7 8573.7 8622.3 8820.3 8977.6 9067.3 10453.6 11648.4 12069.2 12212.8 12337.3 06:06:07 INFO - PROCESS | 17066 | 06:06:07 INFO - PROCESS | 17066 | [#3] mootools.html Cycles:180 Average:5978.76 Median:4613.23 stddev:3465.68 (75.1%) stddev-sans-first:3458.67 06:06:07 INFO - PROCESS | 17066 | Values: 1446.1 1481.2 1575.6 1728.6 1733.2 8179.1 8580.3 8748.1 9283.8 9290.1 8774.2 9044.2 9060.9 9062.2 9064.5 2347.2 2371.9 2382.6 2393.9 2402.1 2333.9 2356.8 2394.1 2399.4 2402.7 2299.3 2308.1 2326.3 2332.5 2341.3 2282.2 2305.5 2307.4 2310.4 2315.8 2282.8 2302.9 2304.6 2304.9 2316.5 9401.4 9465.1 9495.2 9499.1 9500.0 5112.4 5278.5 5377.6 5417.6 5418.4 3218.6 3302.3 3381.9 3392.3 3404.6 983.7 997.9 1005.2 1026.8 1051.7 12877.4 12889.5 12938.6 13012.0 13014.7 4575.8 4650.7 4834.1 4861.3 4870.7 10906.7 10925.6 10931.4 10935.2 10953.7 5411.4 5427.3 5427.8 5428.5 5463.2 4446.7 4855.5 4963.6 4976.8 4985.2 4002.8 4088.5 4118.3 4199.0 4214.4 1250.2 1262.7 1271.5 1287.7 1306.2 939.3 952.5 959.4 967.2 1010.5 5831.2 6057.7 6140.9 6166.6 6183.8 401.9 414.3 425.2 427.2 427.9 4136.1 4202.4 4213.2 4220.2 4240.0 10506.8 10695.3 10741.1 10763.2 10787.7 10686.5 10729.8 10795.7 10796.4 10801.9 8056.2 8189.7 8295.3 8359.7 8559.0 6253.7 6320.9 6437.9 6492.2 6552.7 10550.7 10685.7 10846.5 10937.5 10956.5 10654.7 10946.6 10975.9 10995.3 11048.6 7482.4 7910.8 8085.7 8340.6 8692.1 8628.4 8964.6 8975.1 9001.0 9002.1 7473.4 7475.1 7749.3 8012.1 8044.4 7751.0 7933.0 7961.3 8061.6 8091.8 7367.4 7467.3 7510.3 7550.0 7563.2 5321.8 5392.7 5398.7 5577.4 5643.1 5244.4 5340.7 5485.0 5528.6 5641.4 06:06:07 INFO - PROCESS | 17066 | 06:06:07 INFO - PROCESS | 17066 | [#4] prototype.html Cycles:180 Average:4835.42 Median:5499.92 stddev:1415.27 (25.7%) stddev-sans-first:1378.17 06:06:07 INFO - PROCESS | 17066 | Values: 325.8 332.5 332.6 332.6 336.9 5435.7 5520.9 5566.9 5596.2 5604.7 5461.5 5470.3 5477.4 5485.2 5508.6 4070.0 4209.8 4268.2 4295.5 4300.4 4277.4 4295.9 4309.9 4324.9 4326.9 4295.4 4312.9 4319.7 4321.8 4325.7 4069.0 4263.4 4274.9 4308.5 4311.6 3761.8 3777.5 3780.1 3785.4 3801.3 5372.7 5374.0 5382.5 5388.7 5411.8 4854.4 4872.7 4912.8 4933.9 4976.5 5630.8 5689.3 5693.8 5704.6 5754.7 4201.2 4207.3 4210.6 4210.9 4222.6 5766.0 5868.9 5941.7 5981.2 5990.2 4209.3 4213.6 4223.5 4224.8 4269.2 4303.1 4306.2 4307.6 4314.7 4320.1 4636.7 4838.6 4873.7 4898.5 4927.9 5714.7 5715.9 5723.8 5742.9 5749.9 1485.9 1494.9 1497.7 1503.6 1510.0 938.5 968.6 988.2 995.8 1005.5 5430.4 5445.3 5456.5 5473.9 5477.9 5810.8 5823.8 5831.8 5841.4 5852.3 5266.3 5375.7 5437.2 5491.2 5509.5 3055.8 3095.6 3097.8 3105.9 3123.5 5843.4 6027.8 6034.4 6061.2 6062.5 5831.4 5855.6 5857.7 5870.6 6011.4 6025.1 6058.0 6058.3 6083.6 6087.3 5597.2 5792.6 5910.8 5927.7 5933.0 5827.3 5861.9 5868.9 5886.1 5889.8 5828.3 6178.6 6238.8 6284.9 6340.7 4110.3 4117.9 4126.3 4134.1 4154.6 5702.4 5925.0 5965.3 5973.6 5987.6 5619.4 5728.0 5734.4 5745.8 5760.5 5710.9 5752.4 5759.5 5762.7 5775.5 5533.6 5642.4 5669.0 5706.0 5742.2 5722.5 5725.3 5733.8 5758.8 5770.6 5423.9 5622.6 5629.8 5650.9 5727.5 06:06:07 INFO - PROCESS | 17066 | 06:06:07 INFO - PROCESS | 17066 | [#5] yui.html Cycles:180 Average:20411.34 Median:4493.88 stddev:28442.60 (632.9%) stddev-sans-first:28483.82 06:06:07 INFO - PROCESS | 17066 | Values: 684.6 770.2 774.2 791.4 873.5 14440.3 14835.0 14969.6 14986.4 15057.5 14139.6 14436.7 14551.3 14564.3 14607.1 806.7 819.5 822.1 823.1 823.5 659.8 800.0 805.6 819.6 832.6 873.2 873.6 875.3 876.3 878.7 871.3 871.3 872.5 873.2 874.3 632.8 634.3 634.8 636.4 637.4 14781.3 14827.8 14850.1 14913.3 14928.8 14578.3 14603.4 14641.1 14971.8 15028.0 12338.3 12361.6 12462.6 12648.4 12929.5 3814.5 3821.6 3851.4 3902.2 3910.4 80414.0 81840.2 82213.2 82795.2 82957.2 11326.5 11431.8 11468.0 11516.3 11714.3 22579.7 22922.2 22935.0 22952.8 23062.7 7969.4 8005.2 8029.7 8050.3 8238.1 4393.8 4465.6 4489.0 4498.8 4520.1 3589.1 3719.4 3725.0 3741.4 3760.8 610.7 614.6 628.2 629.5 637.4 661.5 670.4 678.7 685.9 708.0 9639.6 10049.2 10174.3 10230.0 10413.7 577.2 680.9 714.2 726.5 759.2 4901.8 4989.0 5024.2 5068.9 5085.3 77126.0 93632.0 95547.5 97147.0 127213.4 91331.5 94077.5 94210.5 96580.5 99382.0 59096.0 61501.4 62505.0 83422.6 90813.4 9115.0 9999.6 10271.6 10467.3 10470.8 52310.5 53738.0 53936.0 54382.0 55663.7 80221.6 81384.6 82965.0 83433.2 83884.0 14310.6 14341.9 14470.3 14496.3 14740.0 14469.7 14513.4 14604.0 15049.8 15369.2 13716.2 13748.5 13832.4 14197.3 14496.2 13621.7 13775.4 13920.2 13966.4 13972.5 13045.3 13434.7 13464.9 13538.7 13968.9 10969.7 11125.6 11403.7 11452.1 11524.5 10648.9 11325.7 12282.7 12403.6 12552.4 06:06:07 INFO - PROCESS | 17066 | -------- Summary: end -------- 06:06:07 INFO - PROCESS | 17066 | 06:06:07 INFO - TEST-INFO | 17066: exit 0 06:06:07 INFO - TEST-OK | dromaeo_css | took 1112447ms 06:06:07 INFO - TEST-START | kraken 06:06:07 INFO - operating with platform_type : linux_ 06:06:07 INFO - Initialising browser for kraken test... 06:06:07 INFO - TEST-INFO | started process 17316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDDouEu/profile http://localhost:57099/getInfo.html) 06:06:12 INFO - PROCESS | 17316 | __metrics Screen width/height:1600/1200 06:06:12 INFO - PROCESS | 17316 | colorDepth:24 06:06:12 INFO - PROCESS | 17316 | Browser inner width/height: 1024/697 06:06:12 INFO - PROCESS | 17316 | __metrics 06:06:12 ERROR - PROCESS | 17316 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 06:06:13 INFO - TEST-INFO | 17316: exit 0 06:06:13 INFO - Browser initialized. 06:06:13 INFO - Running cycle 1/1 for kraken test... 06:06:13 INFO - TEST-INFO | started process 17437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDDouEu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:25 INFO - PROCESS | 17437 | RSS: Main: 164081664 06:06:25 INFO - PROCESS | 17437 | 06:06:27 INFO - PROCESS | 17437 | Cycle 1(1): loaded http://localhost:57099/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57099/tests/kraken/driver.html?testName=audio-beat-detection) 06:06:28 INFO - PROCESS | 17437 | RSS: Main: 169586688 06:06:28 INFO - PROCESS | 17437 | 06:06:31 INFO - PROCESS | 17437 | Cycle 1(1): loaded http://localhost:57099/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57099/tests/kraken/driver.html?testName=audio-dft) 06:06:32 INFO - PROCESS | 17437 | RSS: Main: 168726528 06:06:32 INFO - PROCESS | 17437 | 06:06:34 INFO - PROCESS | 17437 | Cycle 1(1): loaded http://localhost:57099/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57099/tests/kraken/driver.html?testName=audio-fft) 06:06:35 INFO - PROCESS | 17437 | RSS: Main: 164585472 06:06:35 INFO - PROCESS | 17437 | 06:06:37 INFO - PROCESS | 17437 | Cycle 1(1): loaded http://localhost:57099/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57099/tests/kraken/driver.html?testName=audio-oscillator) 06:06:38 INFO - PROCESS | 17437 | RSS: Main: 165285888 06:06:38 INFO - PROCESS | 17437 | 06:06:40 INFO - PROCESS | 17437 | Cycle 1(1): loaded http://localhost:57099/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57099/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:06:41 INFO - PROCESS | 17437 | RSS: Main: 165629952 06:06:41 INFO - PROCESS | 17437 | 06:06:44 INFO - PROCESS | 17437 | Cycle 1(1): loaded http://localhost:57099/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57099/tests/kraken/driver.html?testName=imaging-darkroom) 06:06:44 INFO - PROCESS | 17437 | RSS: Main: 166031360 06:06:44 INFO - PROCESS | 17437 | 06:06:48 INFO - PROCESS | 17437 | Cycle 1(1): loaded http://localhost:57099/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57099/tests/kraken/driver.html?testName=imaging-desaturate) 06:06:49 INFO - PROCESS | 17437 | RSS: Main: 162832384 06:06:49 INFO - PROCESS | 17437 | 06:06:51 INFO - PROCESS | 17437 | Cycle 1(1): loaded http://localhost:57099/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57099/tests/kraken/driver.html?testName=json-parse-financial) 06:06:52 INFO - PROCESS | 17437 | RSS: Main: 164990976 06:06:52 INFO - PROCESS | 17437 | 06:06:54 INFO - PROCESS | 17437 | Cycle 1(1): loaded http://localhost:57099/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57099/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:06:54 INFO - PROCESS | 17437 | RSS: Main: 164765696 06:06:54 INFO - PROCESS | 17437 | 06:06:56 INFO - PROCESS | 17437 | Cycle 1(1): loaded http://localhost:57099/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57099/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:06:57 INFO - PROCESS | 17437 | RSS: Main: 165220352 06:06:57 INFO - PROCESS | 17437 | 06:06:59 INFO - PROCESS | 17437 | Cycle 1(1): loaded http://localhost:57099/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57099/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:06:59 INFO - PROCESS | 17437 | RSS: Main: 165728256 06:06:59 INFO - PROCESS | 17437 | 06:07:02 INFO - PROCESS | 17437 | Cycle 1(1): loaded http://localhost:57099/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57099/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:07:03 INFO - PROCESS | 17437 | RSS: Main: 165789696 06:07:03 INFO - PROCESS | 17437 | 06:07:05 INFO - PROCESS | 17437 | Cycle 1(1): loaded http://localhost:57099/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57099/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:07:06 INFO - PROCESS | 17437 | RSS: Main: 166162432 06:07:06 INFO - PROCESS | 17437 | 06:07:08 INFO - PROCESS | 17437 | Cycle 1(1): loaded http://localhost:57099/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57099/tests/kraken/driver.html?testName=ai-astar) 06:07:08 INFO - PROCESS | 17437 | RSS: Main: 166719488 06:07:08 INFO - PROCESS | 17437 | 06:07:08 INFO - PROCESS | 17437 | __start_tp_report 06:07:08 INFO - PROCESS | 17437 | _x_x_mozilla_page_load 06:07:08 INFO - PROCESS | 17437 | _x_x_mozilla_page_load_details 06:07:08 INFO - PROCESS | 17437 | |i|pagename|runs| 06:07:08 INFO - PROCESS | 17437 | |0;ai-astar;103;111;107;113;112;112;112;113;112;112 06:07:08 INFO - PROCESS | 17437 | |1;audio-beat-detection;147;122;143;187;120;151;150;127;178;119 06:07:08 INFO - PROCESS | 17437 | |2;audio-dft;162;164;165;162;166;167;166;163;162;163 06:07:08 INFO - PROCESS | 17437 | |3;audio-fft;74;76;75;187;76;76;76;78;163;76 06:07:08 INFO - PROCESS | 17437 | |4;audio-oscillator;86;84;149;86;85;85;148;85;84;145 06:07:08 INFO - PROCESS | 17437 | |5;imaging-gaussian-blur;117;119;118;118;119;117;117;117;118;117 06:07:08 INFO - PROCESS | 17437 | |6;imaging-darkroom;148;147;148;147;147;147;147;148;147;146 06:07:08 INFO - PROCESS | 17437 | |7;imaging-desaturate;96;96;97;95;96;96;95;96;95;96 06:07:08 INFO - PROCESS | 17437 | |8;json-parse-financial;53;52;52;53;52;53;51;51;52;52 06:07:08 INFO - PROCESS | 17437 | |9;json-stringify-tinderbox;62;62;63;63;64;62;63;63;62;63 06:07:08 INFO - PROCESS | 17437 | |10;stanford-crypto-aes;79;76;78;76;79;77;78;78;81;77 06:07:08 INFO - PROCESS | 17437 | |11;stanford-crypto-ccm;138;134;131;138;126;126;149;125;128;129 06:07:08 INFO - PROCESS | 17437 | |12;stanford-crypto-pbkdf2;164;164;161;165;165;168;159;162;161;160 06:07:08 INFO - PROCESS | 17437 | |13;stanford-crypto-sha256-iterative;67;68;65;66;64;65;64;64;69;64 06:07:08 INFO - PROCESS | 17437 | __end_tp_report 06:07:08 INFO - PROCESS | 17437 | __start_cc_report 06:07:08 INFO - PROCESS | 17437 | _x_x_mozilla_cycle_collect,879 06:07:08 INFO - PROCESS | 17437 | __end_cc_report 06:07:08 INFO - PROCESS | 17437 | __startTimestamp1470575228486__endTimestamp 06:07:08 INFO - PROCESS | 17437 | 06:07:08 INFO - PROCESS | 17437 | ------- Summary: start ------- 06:07:08 INFO - PROCESS | 17437 | Number of tests: 14 06:07:08 INFO - PROCESS | 17437 | 06:07:08 INFO - PROCESS | 17437 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.20 (2.9%) stddev-sans-first:1.81 06:07:08 INFO - PROCESS | 17437 | Values: 103.0 111.0 107.0 113.0 112.0 112.0 112.0 113.0 112.0 112.0 06:07:08 INFO - PROCESS | 17437 | 06:07:08 INFO - PROCESS | 17437 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:148.50 stddev:23.74 (16.0%) stddev-sans-first:25.16 06:07:08 INFO - PROCESS | 17437 | Values: 147.0 122.0 143.0 187.0 120.0 151.0 150.0 127.0 178.0 119.0 06:07:08 INFO - PROCESS | 17437 | 06:07:08 INFO - PROCESS | 17437 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.50 stddev:1.89 (1.1%) stddev-sans-first:1.86 06:07:08 INFO - PROCESS | 17437 | Values: 162.0 164.0 165.0 162.0 166.0 167.0 166.0 163.0 162.0 163.0 06:07:08 INFO - PROCESS | 17437 | 06:07:08 INFO - PROCESS | 17437 | [#3] audio-fft Cycles:10 Average:95.70 Median:76.00 stddev:42.19 (55.5%) stddev-sans-first:44.01 06:07:08 INFO - PROCESS | 17437 | Values: 74.0 76.0 75.0 187.0 76.0 76.0 76.0 78.0 163.0 76.0 06:07:08 INFO - PROCESS | 17437 | 06:07:08 INFO - PROCESS | 17437 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:85.00 stddev:30.13 (35.5%) stddev-sans-first:31.27 06:07:08 INFO - PROCESS | 17437 | Values: 86.0 84.0 149.0 86.0 85.0 85.0 148.0 85.0 84.0 145.0 06:07:08 INFO - PROCESS | 17437 | 06:07:08 INFO - PROCESS | 17437 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 06:07:08 INFO - PROCESS | 17437 | Values: 117.0 119.0 118.0 118.0 119.0 117.0 117.0 117.0 118.0 117.0 06:07:08 INFO - PROCESS | 17437 | 06:07:08 INFO - PROCESS | 17437 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 06:07:08 INFO - PROCESS | 17437 | Values: 148.0 147.0 148.0 147.0 147.0 147.0 147.0 148.0 147.0 146.0 06:07:08 INFO - PROCESS | 17437 | 06:07:08 INFO - PROCESS | 17437 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 06:07:08 INFO - PROCESS | 17437 | Values: 96.0 96.0 97.0 95.0 96.0 96.0 95.0 96.0 95.0 96.0 06:07:08 INFO - PROCESS | 17437 | 06:07:08 INFO - PROCESS | 17437 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:0.74 (1.4%) stddev-sans-first:0.71 06:07:08 INFO - PROCESS | 17437 | Values: 53.0 52.0 52.0 53.0 52.0 53.0 51.0 51.0 52.0 52.0 06:07:08 INFO - PROCESS | 17437 | 06:07:08 INFO - PROCESS | 17437 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 06:07:08 INFO - PROCESS | 17437 | Values: 62.0 62.0 63.0 63.0 64.0 62.0 63.0 63.0 62.0 63.0 06:07:08 INFO - PROCESS | 17437 | 06:07:08 INFO - PROCESS | 17437 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:78.00 stddev:1.52 (2.0%) stddev-sans-first:1.56 06:07:08 INFO - PROCESS | 17437 | Values: 79.0 76.0 78.0 76.0 79.0 77.0 78.0 78.0 81.0 77.0 06:07:08 INFO - PROCESS | 17437 | 06:07:08 INFO - PROCESS | 17437 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:132.50 stddev:7.53 (5.7%) stddev-sans-first:7.71 06:07:08 INFO - PROCESS | 17437 | Values: 138.0 134.0 131.0 138.0 126.0 126.0 149.0 125.0 128.0 129.0 06:07:08 INFO - PROCESS | 17437 | 06:07:08 INFO - PROCESS | 17437 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.90 Median:164.00 stddev:2.77 (1.7%) stddev-sans-first:2.91 06:07:08 INFO - PROCESS | 17437 | Values: 164.0 164.0 161.0 165.0 165.0 168.0 159.0 162.0 161.0 160.0 06:07:08 INFO - PROCESS | 17437 | 06:07:08 INFO - PROCESS | 17437 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:1.84 (2.8%) stddev-sans-first:1.88 06:07:08 INFO - PROCESS | 17437 | Values: 67.0 68.0 65.0 66.0 64.0 65.0 64.0 64.0 69.0 64.0 06:07:08 INFO - PROCESS | 17437 | -------- Summary: end -------- 06:07:08 INFO - PROCESS | 17437 | 06:07:09 INFO - TEST-INFO | 17437: exit 0 06:07:09 INFO - TEST-OK | kraken | took 61639ms 06:07:09 INFO - SUITE-END | took 1174s 06:07:09 INFO - Completed test suite (00:19:34) 06:07:09 INFO - javascript benchmark 06:07:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7320.23297386972, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.7527397808176, 3120.7815452918303, 3128.9687103128977, 3161.762867784915, 3162.3517178978313, 5381.730913454331, 5426.213199086135, 5432.918506222405, 5453.15476101204, 5482.369527504338, 5347.385050719168, 5354.27717258171, 5369.060414427469, 5418.241446197526, 5432.375276843164, 4794.5205479452125, 4870.6103511718975, 4933.605311575084, 4974.7015179089185, 5003.449620541755, 4973.154563724158, 5009.398872135349, 5016.147254966646, 5071.036503064424, 5121.846344609649, 4807.23084306511, 4888.193448081062, 4923.01539692063, 4924.876878078041, 4971.353724015855, 4892.877678058041, 4922.852314430537, 4926.916078462733, 4947.925781113287, 4965.826196083156, 4852.199387101159, 4861.8784530386665, 4872.902541949141, 4904.681195722303, 4904.779284932187, 5316.255724198577, 5369.758360873731, 5407.675539467645, 5458.2904222451225, 5480.588955828329, 5830.067189249742, 5832.941670583325, 5833.445822646884, 5835.883282334372, 5837.678927658977, 5759.856003599902, 5833.445822646841, 5841.532677385841, 5845.85385365365, 5858.502027327682, 5416.295881535415, 5459.454054594548, 5466.945330546644, 5494.2582751328055, 5540.612157149041, 5990.850228744316, 5994.0, 5997.550183736237, 6005.489533389711, 6005.879882402328, 5641.548676105902, 5716.714164291769, 5733.455321744427, 5751.626144300607, 5767.452092051249, 5708.457696518824, 5756.740946657411, 5790.044642634002, 5817.156512305692, 5892.823215303548, 5739.913901291484, 5800.709964501758, 5841.386654401312, 5857.0, 5862.091375836752, 5751.252337196222, 5855.268091488564, 5855.941440585625, 5869.647821130746, 5907.172995780594, 4370.213361594943, 4387.605115539617, 4389.912201756011, 4407.140607581491, 4477.977610111929, 3928.253631809947, 3969.543502497192, 3971.8808435746973, 3981.462502562175, 3983.6016398359934, 5400.243965844785, 5502.064649009678, 5519.69641669712, 5520.337559492887, 5543.805966791224, 5751.971240143856, 5779.8555036124435, 5809.68046757424, 5887.087501437284, 5900.350961394243, 5582.469665381782, 5608.747606357723, 5617.634853734576, 5617.662940223599, 5632.464915832989, 4938.616488992834, 4983.127952608352, 4995.475475075137, 5003.924941125886, 5013.846815232517, 5929.703514824241, 5970.13433052205, 5984.850378740566, 5995.190649262381, 6158.692065396713, 5813.418658134153, 5819.301683797971, 5820.563457740602, 5831.4168583141345, 5874.441928016831, 6020.668863212565, 6034.63792172471, 6038.788642397495, 6048.788292409745, 6071.058985857199, 5508.925759476863, 5676.347220069745, 5688.232088667977, 5698.20225168485, 5720.342160651412, 5821.0, 5850.5027072699295, 5853.970730146322, 5860.531157507475, 5890.7349169288345, 5670.574706896917, 5706.058500347396, 5712.428757124254, 5721.885562288814, 5725.227094342377, 5604.579656525695, 5636.802711905064, 5706.4864162225595, 5718.285214348207, 5758.1650660654805, 5682.715864206691, 5694.715264236689, 5708.200851880823, 5712.057510510719, 5712.11462223356, 5743.4543718346695, 5764.567657425626, 5812.970935145467, 5817.243758311392, 5825.912611310919, 5442.129259318648, 5482.17767334903, 5493.752781124939, 5531.861703457284, 5566.805161819479], "value": 5363.915048899644, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.2058936604705, 584.5528170949227, 585.1164741240727, 585.9267591551055, 617.8455386153462, 38524.61475385245, 42841.571584284146, 42907.92730181739, 43028.354574681405, 43208.56791432085, 43153.0, 44187.337189942176, 44328.0, 44374.0, 44405.77797111018, 8826.426282291663, 8885.822283554326, 8929.821403571925, 8934.0, 8963.238124759404, 8911.287097032222, 8957.19385255327, 8965.596548155349, 8966.968798588148, 9000.954995225047, 8958.0, 9047.864282035742, 9053.230475409599, 9058.365914385995, 9064.365494415393, 8885.777855553599, 8976.8653470198, 8996.775080623003, 9006.86489702655, 9057.456552606865, 8817.07420720828, 8842.690505832265, 8902.33232507558, 8922.0, 8927.107289271085, 41285.1742965139, 41375.793121034505, 41638.0, 41736.0, 41760.58239417628, 3547.7516573839844, 3641.308151451216, 3664.3770559005034, 3677.963220367789, 3790.3556395412847, 32613.347733045208, 33086.50370244448, 33562.0, 33674.49488257678, 33848.32303353944, 4302.0, 4372.27857403528, 4385.539518350559, 4436.64506839452, 4521.502634710212, 363634.0, 365415.0, 365505.0, 366668.0, 367075.0, 57871.0, 58155.41844581585, 58504.41495585075, 58585.70707146437, 58789.0, 60897.0, 61134.38865611376, 61225.0, 61614.38385616176, 61643.691781541704, 16538.6692266154, 16763.245653945356, 16892.324307027826, 16917.40789072401, 16928.83071169297, 12999.935000324938, 13039.674008149872, 13054.608361749162, 13132.621074787201, 13173.0, 15874.682506349809, 16002.67994640124, 16116.113613751357, 16219.35122595083, 16603.335866565445, 6524.608523488606, 6526.706298216592, 6549.380247900783, 6607.654282729562, 6733.326667333227, 890.528020149322, 991.1426615977127, 995.6216637677636, 1062.3254233561745, 1066.5627092891878, 32576.34847303088, 32697.346053078803, 32913.506297405555, 33314.0, 33420.331593368486, 1085.148158695436, 1126.9492872820742, 1130.6099395708632, 1170.53763763313, 1196.1268274159738, 16573.50279491593, 16899.662006759794, 17061.658766824596, 17588.736168957475, 18168.909155454403, 251296.0, 493955.0, 496666.0, 498041.0, 773606.0, 60237.0, 60388.0, 60621.69689151526, 61072.0, 61088.694556526934, 1323.3780123342015, 1329.6011196640968, 1343.267918984156, 1360.5782207515701, 1363.229775177002, 31638.841805790824, 33315.66684333223, 33829.3234135311, 33892.32215355728, 33917.660823392434, 51888.962220756126, 51976.740116299174, 52072.0, 52164.478355215964, 52321.47678523166, 434749.0, 436645.0, 437045.0, 438875.0, 443349.0, 28536.857315714118, 28566.285842854097, 28724.569131462627, 28865.278368040967, 28968.565471518366, 46618.76690616525, 47822.76088619535, 48504.27243591278, 48523.27215091706, 48875.755621221666, 40279.3958090623, 40821.79589102035, 41499.7925010373, 43359.56640433555, 45524.54475455335, 42989.14021719486, 43493.565064350216, 43562.564374355854, 43645.0, 44132.558674412845, 36271.63728362683, 41474.58525414828, 42264.577354226065, 42465.36301955411, 43226.0, 35084.64915350814, 37966.43050354192, 38221.42667859929, 38563.2287354257, 38835.805820971844, 28468.28829279202, 28837.42325153527, 29000.419991600473, 29022.27444313909, 29249.70750292555], "value": 20209.828485844722, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.96190380961906, 385.51810237203495, 392.4035466091541, 397.2901255614686, 405.0925925925925, 18782.43652690418, 19751.901240493815, 20261.696074558895, 20284.39146825594, 20472.69290960635, 10875.510602022909, 11091.0, 11095.945885140918, 19467.805321946777, 19798.30705925293, 5039.672421292605, 5131.050755610224, 5182.0, 5194.298769666103, 5201.843944681666, 5292.0, 5542.196381524676, 5554.472325129126, 5652.717364131798, 5681.744321505542, 5663.575231857607, 5676.574256930726, 6487.6756162191705, 6594.142761441006, 6670.166229221348, 6574.671266436707, 6611.471082313427, 6638.966805165992, 6644.235912870034, 6655.800325990228, 5755.856103597402, 5800.361960184377, 5894.616849904743, 5904.822855314347, 5911.142884281798, 12722.473303203675, 13031.804522932163, 21475.248366307103, 22120.115195392165, 22305.107795688153, 2254.1997590855176, 2312.7455979842202, 2367.6093444581625, 2600.8439493630444, 2709.823861449019, 9485.47829869357, 9851.704448866474, 9873.407595544219, 9909.554070066864, 10212.74468138295, 1847.4272975377676, 1898.4874083997381, 1966.488712934633, 2001.949951251216, 2022.1810166882435, 78624.60687696525, 80428.0, 81675.9999999994, 81700.0, 85583.57208213981, 9772.804543909082, 10126.54430550627, 10361.481925903674, 11070.28043177191, 11287.322760634388, 15282.541523754306, 15315.0, 15361.539153825403, 15409.152496612569, 15465.0, 7757.0, 8053.234942680436, 8065.6370463329295, 8279.54462504568, 8300.833983320299, 7803.570803605742, 7895.763127106196, 7969.481983671159, 8111.716089936942, 8167.183281671785, 4394.340848872695, 4459.531749166291, 4519.751413672214, 4560.612347950461, 4805.0, 1965.9803401965796, 1970.940871773849, 1990.8307793837396, 1999.3701983875033, 2069.368842503051, 883.4964070479894, 963.3401120232663, 1000.46475135802, 1021.4739409204266, 1035.5288343803552, 19723.901380493007, 19873.801261987195, 19995.0, 20047.097880595407, 20048.49878753043, 968.1722127580957, 986.4574484033752, 1003.3127307794184, 1011.595361855249, 1014.0467960117466, 10576.20678449104, 11102.944485277683, 11167.162462815322, 11238.0, 11317.547298107984, 458890.0, 461067.0, 466239.0, 489320.0, 499635.0, 71079.64460177666, 93111.0, 94653.52673236589, 97083.0, 98849.50575247078, 969.4425705219527, 1000.4747507558444, 1005.5977608956476, 1028.0644613401769, 1029.8197815382277, 13689.794653080411, 16971.660566788843, 17329.82670173282, 18379.356722514647, 18452.723209151605, 29844.85077574598, 31972.20069498281, 43099.784501077294, 43235.783821080695, 44026.559734402246, 54348.728256360046, 54801.45198547964, 58295.70852145712, 58651.4134858663, 59141.0, 8477.576121194039, 8534.146585341665, 8560.785980350292, 8639.87040194385, 9128.908710913072, 12826.166299190523, 13610.38753256086, 14090.647733806736, 14160.150390976574, 14342.211178385289, 11993.700157495783, 11995.340256285988, 12217.411736474201, 12239.143259971717, 12519.123661343618, 11830.231034983042, 11894.345810980132, 12146.39268036577, 12190.268583884996, 12486.0, 12251.264924104582, 12446.0, 12724.936375318064, 12866.742665146832, 13125.737485250433, 8573.74278771638, 8622.310215182644, 8820.338474614558, 8977.640894364413, 9067.254202141468, 10453.634122805664, 11648.41757912118, 12069.21550099276, 12212.75574488523, 12337.321447320484], "value": 9159.621140571073, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1446.146773403692, 1481.1631428243043, 1575.6454797670526, 1728.567858035491, 1733.2460379734816, 8179.100298967109, 8580.270676992455, 8748.081451447602, 9283.814323713521, 9290.117438843308, 8774.166454186841, 9044.23124034458, 9060.909390906088, 9062.229710474618, 9064.501452420114, 2347.1667558016916, 2371.9169829055986, 2382.5830479666074, 2393.8803059847023, 2402.0511897800448, 2333.894974726133, 2356.7878890899815, 2394.0782798622567, 2399.4241382068267, 2402.7116745990506, 2299.2642354446584, 2308.088305119477, 2326.2788535553946, 2332.47519308156, 2341.285907798121, 2282.2468585366955, 2305.469741959342, 2307.400075980249, 2310.376198426424, 2315.849469784467, 2282.783135602115, 2302.861828290308, 2304.585174668559, 2304.8501847379866, 2316.5366926614743, 9401.388909720914, 9465.148136667663, 9495.240380769523, 9499.097585729414, 9499.952500237523, 5112.41207261166, 5278.524932756032, 5377.623566350357, 5417.647852889589, 5418.431064738185, 3218.5815843940372, 3302.3065156317202, 3381.898543043713, 3392.287619599887, 3404.591449026108, 983.6999715086896, 997.9351342162736, 1005.1958433253368, 1026.7792424628667, 1051.7475805806628, 12877.420516076705, 12889.484420623165, 12938.611841644766, 13012.0, 13014.739705205842, 4575.816967321336, 4650.651201159926, 4834.105690447279, 4861.27080937855, 4870.732109733928, 10906.72733181661, 10925.562977480811, 10931.398773067558, 10935.17986151026, 10953.671389858317, 5411.431799661058, 5427.348718153768, 5427.810026649048, 5428.5385742211565, 5463.153211252183, 4446.73319600825, 4855.465898751135, 4963.60291176705, 4976.751162441863, 4985.152524070917, 4002.779847108379, 4088.5298190707854, 4118.341065429517, 4198.979005104955, 4214.4099826024385, 1250.156144602408, 1262.678017105632, 1271.5041133957764, 1287.7424515097018, 1306.2293246984325, 939.3002213351098, 952.4523399045577, 959.3764053365369, 967.1585720423277, 1010.4745532323151, 5831.2127862738835, 6057.727402266909, 6140.907886381708, 6166.568340216142, 6183.84540386494, 401.8714011516287, 414.30396933152593, 425.213355292706, 427.20113387964705, 427.8759159843673, 4136.131412403369, 4202.3696445533415, 4213.241616508996, 4220.2192594370135, 4239.957600424018, 10506.789864202674, 10695.251332406657, 10741.087007604285, 10763.19276054299, 10787.730306742395, 10686.465676716132, 10729.785404292026, 10795.730106747236, 10796.406197659204, 10801.891981080245, 8056.234657707626, 8189.71336003249, 8295.294899933453, 8359.665613375519, 8558.95720521406, 6253.687315634291, 6320.936790632219, 6437.871242575216, 6492.188476440445, 6552.705128269144, 10550.736231594272, 10685.732856678645, 10846.45767711627, 10937.45312734376, 10956.506957186786, 10654.680359589225, 10946.562137514411, 10975.945120274668, 10995.285306455055, 11048.61892263467, 7482.438817088849, 7910.841783164419, 8085.716999904975, 8340.582970851312, 8692.087330830425, 8628.439151455135, 8964.641414343614, 8975.102489750972, 9001.0, 9002.144796244347, 7473.364763995121, 7475.0656167979005, 7749.3413059890545, 8012.118666946748, 8044.396670249637, 7751.0311211098615, 7933.0, 7961.283484486424, 8061.556614386031, 8091.757247282591, 7367.410607151308, 7467.290607392289, 7510.286522780327, 7550.0, 7563.243675632392, 5321.813736519203, 5392.703401312965, 5398.703071331114, 5577.386487486292, 5643.068893632505, 5244.449332819999, 5340.732963351895, 5484.972575137258, 5528.55771538284, 5641.435856414326], "value": 4647.0979680738055, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.80451728962623, 332.48298895217926, 332.59589598637655, 332.6241347277576, 336.8652538984406, 5435.701036442994, 5520.861978450541, 5566.888662226753, 5596.237185286642, 5604.747786349614, 5461.508464238218, 5470.2888624478865, 5477.411550650307, 5485.204645326426, 5508.64193827401, 4070.0, 4209.758121354208, 4268.231718290706, 4295.484541854982, 4300.354946757996, 4277.379779931908, 4295.914081718363, 4309.892252693677, 4324.913501729963, 4326.891827704317, 4295.4201182840225, 4312.935305970413, 4319.69762116652, 4321.783910804463, 4325.718828276168, 4068.9796551017203, 4263.360495925605, 4274.850380236708, 4308.526062133163, 4311.563966359013, 3761.7554858934354, 3777.508923839883, 3780.092777733352, 3785.3754130568423, 3801.2967600993907, 5372.677639341652, 5373.963710503553, 5382.542483888874, 5388.7305634718105, 5411.756470958816, 4854.417469903634, 4872.6832755870755, 4912.803487860481, 4933.86521100149, 4976.502349765031, 5630.774769009235, 5689.288838895138, 5693.77224911003, 5704.572157088193, 5754.712264386764, 4201.243776120297, 4207.326827707552, 4210.642095421893, 4210.894727631803, 4222.641075508585, 5765.971170144165, 5868.882622347529, 5941.732622031976, 5981.162637230835, 5990.2212712347555, 4209.34755112958, 4213.641840443596, 4223.493180818322, 4224.831006759757, 4269.167512335065, 4303.074838909587, 4306.224879521654, 4307.6338511226895, 4314.676399270004, 4320.092780516064, 4636.744979026186, 4838.588719958843, 4873.731944743073, 4898.461169271377, 4927.926081108786, 5714.685692286964, 5715.857103572361, 5723.828285151452, 5742.913856292159, 5749.8787736391005, 1485.8959872809016, 1494.8579884910916, 1497.7044856199527, 1503.5639664497173, 1509.9622509437352, 938.4650749073099, 968.6367612145445, 988.2193067476757, 995.7751965082844, 1005.527402121002, 5430.375506816767, 5445.292112025411, 5456.454354564512, 5473.890522189534, 5477.890442191134, 5810.767569297265, 5823.767049318065, 5831.825045248649, 5841.4450627190345, 5852.297724273115, 5266.315379000705, 5375.715320988565, 5437.238786569884, 5491.203775452537, 5509.47659972302, 3055.801372910754, 3095.622448010659, 3097.7521798256084, 3105.891293804706, 3123.531470279431, 5843.444872737083, 6027.758889644453, 6034.39656034393, 6061.181740464981, 6062.514998800086, 5831.358550559435, 5855.590108692436, 5857.70711464425, 5870.618409803349, 6011.428914253226, 6025.0962355646125, 6058.0, 6058.27300723916, 6083.6045657032155, 6087.29996050451, 5597.216389705526, 5792.594518383673, 5910.822675319747, 5927.673977931255, 5933.02105152645, 5827.271591051119, 5861.912071319019, 5868.882622347614, 5886.146508756292, 5889.764409423747, 5828.300603927556, 6178.598391104564, 6238.844028899314, 6284.874302514016, 6340.7318536292005, 4110.34234522475, 4117.911566325256, 4126.339785634284, 4134.131832315247, 4154.563770804022, 5702.429757024431, 5925.0, 5965.313988891333, 5973.641581505123, 5987.592915664728, 5619.353774315842, 5727.971360143172, 5734.3978882218435, 5745.798897038583, 5760.481556659921, 5710.8572285691525, 5752.424757524214, 5759.481646651821, 5762.654240745401, 5775.451332123442, 5533.6403133796175, 5642.407547207648, 5669.0, 5706.0, 5742.1673857289625, 5722.5135863450405, 5725.312962444534, 5733.770649173986, 5758.827235182951, 5770.6241848519085, 5423.864403389947, 5622.578306626938, 5629.774809007594, 5650.85872853182, 5727.455891690282], "value": 4381.375794394186, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.5858255755268, 770.1566784371112, 774.1909704358944, 791.4380789639353, 873.5195642396682, 14440.277986100693, 14835.0, 14969.5509134726, 14986.400543978256, 15057.472988445406, 14139.646508837284, 14436.711265774704, 14551.3451894665, 14564.271786410663, 14607.123572585653, 806.7055524733474, 819.5205804604284, 822.116225058062, 823.127484866041, 823.4976664234812, 659.7525927777084, 800.0399520575304, 805.5972013993004, 819.5574389829485, 832.592029905345, 873.2228316798023, 873.6243415331405, 875.347865839947, 876.2508055612456, 878.661715239631, 871.2594294849359, 871.2594294849391, 872.4590753732663, 873.1922971251566, 874.2656168818191, 632.7975047984647, 634.3181080338609, 634.7524465458475, 636.4399328590856, 637.4167636612494, 14781.334839932122, 14827.77758333626, 14850.108993460426, 14913.2543372832, 14928.776068358984, 14578.343974521173, 14603.415863365453, 14641.121532707964, 14971.77542336855, 15028.0, 12338.259704417764, 12361.567345142967, 12462.626121216377, 12648.430820613094, 12929.48282068716, 3814.4850445189822, 3821.6179578166816, 3851.4222866569958, 3902.2195560887935, 3910.3808812546677, 80413.99999999942, 81840.18159818444, 82213.17786822114, 82795.17204827996, 82957.17042829616, 11326.490307936163, 11431.828522572168, 11467.999999999833, 11516.251443656136, 11714.297142171497, 22579.661305080437, 22922.186340868604, 22935.0, 22952.770472295397, 23062.65406018911, 7969.362451003905, 8005.239502247277, 8029.718959836495, 8050.315723163597, 8238.09380968093, 4393.824247030083, 4465.620422264144, 4489.0, 4498.752568608693, 4520.141173177086, 3589.10272431892, 3719.4420836874683, 3725.0, 3741.382671859167, 3760.811959402019, 610.7495926670133, 614.6250787019915, 628.23982980594, 629.4586655476287, 637.3753721353007, 661.454300202335, 670.3932940688685, 678.7386856060452, 685.85939882325, 708.0193931404938, 9639.614415423304, 10049.196064314838, 10174.287799854088, 10230.028147325993, 10413.739656508496, 577.206341280739, 680.877442060424, 714.1572943926217, 726.5023458930649, 759.2104211619853, 4901.823562345083, 4988.950110498921, 5024.221245706921, 5068.923966140511, 5085.338905942203, 77126.0, 93632.0, 95547.52226238964, 97147.0, 127213.36393317975, 91331.54334228419, 94077.5296123515, 94210.5289473562, 96580.51709741406, 99382.00617993872, 59095.99999999914, 61501.384986150464, 62505.0, 83422.58288708517, 90813.40430317089, 9114.982022371232, 9999.600015999278, 10271.589136434459, 10467.267291289536, 10470.842937356098, 52310.47689523208, 53738.0, 53936.0, 54382.0, 55663.721681392955, 80221.59889200516, 81384.59307703661, 82965.0, 83433.16566834497, 83884.0, 14310.642233944234, 14341.85658143447, 14470.348834302271, 14496.34766435534, 14740.041897276642, 14469.710605787615, 14513.419463221353, 14604.0, 15049.849501504845, 15369.231538423257, 13716.24560649134, 13748.450061997408, 13832.446702131801, 14197.290135493391, 14496.202708851115, 13621.727565448833, 13775.448982040607, 13920.164790112221, 13966.4413423466, 13972.510962116277, 13045.282509461691, 13434.731305373642, 13464.865351346753, 13538.661533461742, 13968.930155349159, 10969.670909872717, 11125.554977800797, 11403.705979626578, 11452.141089418494, 11524.539018439504, 10648.89351106479, 11325.660230193107, 12282.728875519295, 12403.565875194325, 12552.435140418886], "value": 7610.120271956213, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 107.0, 113.0, 112.0, 112.0, 112.0, 113.0, 112.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 122.0, 143.0, 187.0, 120.0, 151.0, 150.0, 127.0, 178.0, 119.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 165.0, 162.0, 166.0, 167.0, 166.0, 163.0, 162.0, 163.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 187.0, 76.0, 76.0, 76.0, 78.0, 163.0, 76.0], "value": 95.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 149.0, 86.0, 85.0, 85.0, 148.0, 85.0, 84.0, 145.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 118.0, 119.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 53.0, 52.0, 53.0, 51.0, 51.0, 52.0, 52.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 63.0, 64.0, 62.0, 63.0, 63.0, 62.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 76.0, 78.0, 76.0, 79.0, 77.0, 78.0, 78.0, 81.0, 77.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 134.0, 131.0, 138.0, 126.0, 126.0, 149.0, 125.0, 128.0, 129.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 161.0, 165.0, 165.0, 168.0, 159.0, 162.0, 161.0, 160.0], "value": 162.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 65.0, 66.0, 64.0, 65.0, 64.0, 64.0, 69.0, 64.0], "value": 65.6, "unit": "score"}]}]} 06:07:09 INFO - Return code: 0 06:07:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:07:09 ERROR - # TBPL SUCCESS # 06:07:09 INFO - Running post-action listener: _resource_record_post_action 06:07:09 INFO - [mozharness: 2016-08-07 13:07:09.786930Z] Finished run-tests step (success) 06:07:09 INFO - Running post-run listener: _resource_record_post_run 06:07:09 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 553168896; Read time: 168; Write time: 443652 06:07:09 INFO - TinderboxPrint: CPU usage
13.3% 06:07:09 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 168 06:07:09 INFO - TinderboxPrint: I/O write bytes / time
553,168,896 / 443,652 06:07:09 INFO - TinderboxPrint: CPU idle
8,234.7 (86.6%) 06:07:09 INFO - TinderboxPrint: CPU user
1,212.1 (12.8%) 06:07:09 INFO - TinderboxPrint: Swap in / out
0 / 0 06:07:09 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 258052096; Read time: 0; Write time: 256612 06:07:09 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295116800; Read time: 152; Write time: 187040 06:07:10 INFO - Running post-run listener: _upload_blobber_files 06:07:10 INFO - Blob upload gear active. 06:07:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:07:10 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:07:10 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:07:10 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:07:10 INFO - (blobuploader) - INFO - Open directory for files ... 06:07:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:07:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:07:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:13 INFO - (blobuploader) - INFO - Done attempting. 06:07:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:07:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:07:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:14 INFO - (blobuploader) - INFO - Done attempting. 06:07:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:07:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:07:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:15 INFO - (blobuploader) - INFO - Done attempting. 06:07:15 INFO - (blobuploader) - INFO - Iteration through files over. 06:07:15 INFO - Return code: 0 06:07:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:07:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:07:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a37235da0ef4ff5faf826cdf145268bd9d45dbf8e1c7c2adb2e28774cf7af98c001ee6f8e5861dae85caecf97beb280849d426df7636f2fb24ae095034f21d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a64d8ddeaa44571e601f1a4170e4b229c8a2d83832dc495954997fd0b9917fdb891b9943ae91227694db794176cb2eb62a98620669b63a5c7e1a7f858bff6ed7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecaf06768c40c6bb4fc5ccfb90212984b873f34c819a07bc2fdf3a262cd0eb00553bfae31faa12ed3c94540e3446a91e4edaf14f41eab652398682d2abd7aa02"} 06:07:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:07:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:07:15 INFO - Contents: 06:07:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a37235da0ef4ff5faf826cdf145268bd9d45dbf8e1c7c2adb2e28774cf7af98c001ee6f8e5861dae85caecf97beb280849d426df7636f2fb24ae095034f21d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a64d8ddeaa44571e601f1a4170e4b229c8a2d83832dc495954997fd0b9917fdb891b9943ae91227694db794176cb2eb62a98620669b63a5c7e1a7f858bff6ed7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecaf06768c40c6bb4fc5ccfb90212984b873f34c819a07bc2fdf3a262cd0eb00553bfae31faa12ed3c94540e3446a91e4edaf14f41eab652398682d2abd7aa02"} 06:07:15 INFO - Running post-run listener: copy_logs_to_upload_dir 06:07:15 INFO - Copying logs to upload dir... 06:07:15 INFO - mkdir: /builds/slave/test/build/upload/logs 06:07:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.956410 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-07 06:07:15.121483) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 06:07:15.124630) ========= 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=0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348 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/0a37235da0ef4ff5faf826cdf145268bd9d45dbf8e1c7c2adb2e28774cf7af98c001ee6f8e5861dae85caecf97beb280849d426df7636f2fb24ae095034f21d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a64d8ddeaa44571e601f1a4170e4b229c8a2d83832dc495954997fd0b9917fdb891b9943ae91227694db794176cb2eb62a98620669b63a5c7e1a7f858bff6ed7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecaf06768c40c6bb4fc5ccfb90212984b873f34c819a07bc2fdf3a262cd0eb00553bfae31faa12ed3c94540e3446a91e4edaf14f41eab652398682d2abd7aa02"} build_url:https://queue.taskcluster.net/v1/task/ekaZlwOmTUW3URQTgOTiAg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011244 build_url: 'https://queue.taskcluster.net/v1/task/ekaZlwOmTUW3URQTgOTiAg/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/0a37235da0ef4ff5faf826cdf145268bd9d45dbf8e1c7c2adb2e28774cf7af98c001ee6f8e5861dae85caecf97beb280849d426df7636f2fb24ae095034f21d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a64d8ddeaa44571e601f1a4170e4b229c8a2d83832dc495954997fd0b9917fdb891b9943ae91227694db794176cb2eb62a98620669b63a5c7e1a7f858bff6ed7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecaf06768c40c6bb4fc5ccfb90212984b873f34c819a07bc2fdf3a262cd0eb00553bfae31faa12ed3c94540e3446a91e4edaf14f41eab652398682d2abd7aa02"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 06:07:15.149679) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 06:07:15.149985) ========= 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=0e2a256762fed810e2f0f810000001b3-1470569681.723320-848621348 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 06:07:15.232178) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 06:07:15.232495) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 06:07:15.232768) ========= ========= Total master_lag: 0.20 =========