builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1470744291.01 results: success (0) buildid: 20160809034720 builduid: e2d8351070ad481e992fd1e945e58a10 revision: 5179814c12b173f8126279665c48dfdef099b13f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 05:04:51.010333) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 05:04:51.011019) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 05:04:51.011341) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 05:04:51.046462) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:04:51.046753) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-09 05:04:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 39.5M=0s 2016-08-09 05:04:51 (39.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.320353 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:04:51.381781) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:04:51.382134) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013974 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:04:51.432844) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:04:51.433230) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 5179814c12b173f8126279665c48dfdef099b13f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 5179814c12b173f8126279665c48dfdef099b13f --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=2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-09 05:04:51,799 truncating revision to first 12 chars 2016-08-09 05:04:51,799 Setting DEBUG logging. 2016-08-09 05:04:51,799 attempt 1/10 2016-08-09 05:04:51,800 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/5179814c12b1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 05:04:52,136 unpacking tar archive at: autoland-5179814c12b1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.680420 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:04:52.127223) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 05:04:52.127541) ========= script_repo_revision: 5179814c12b173f8126279665c48dfdef099b13f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 05:04:52.127950) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 05:04:52.128282) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 05:04:52.137614) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-09 05:04:52.137928) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:04:52 INFO - MultiFileLogger online at 20160809 05:04:52 in /builds/slave/test 05:04:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 05:04:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:04:52 INFO - {'append_to_log': False, 05:04:52 INFO - 'base_work_dir': '/builds/slave/test', 05:04:52 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 05:04:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:04:52 INFO - 'branch': 'Autoland-Non-PGO', 05:04:52 INFO - 'buildbot_json_path': 'buildprops.json', 05:04:52 INFO - 'config_files': ('talos/linux_config.py',), 05:04:52 INFO - 'default_actions': ('clobber', 05:04:52 INFO - 'read-buildbot-config', 05:04:52 INFO - 'download-and-extract', 05:04:52 INFO - 'populate-webroot', 05:04:52 INFO - 'create-virtualenv', 05:04:52 INFO - 'install', 05:04:52 INFO - 'run-tests'), 05:04:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:04:52 INFO - 'download_minidump_stackwalk': True, 05:04:52 INFO - 'download_symbols': 'ondemand', 05:04:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:04:52 INFO - 'tooltool.py': '/tools/tooltool.py', 05:04:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:04:52 INFO - '/tools/misc-python/virtualenv.py')}, 05:04:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:04:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:04:52 INFO - 'installer_path': 'installer.exe', 05:04:52 INFO - 'log_level': 'info', 05:04:52 INFO - 'log_name': 'talos', 05:04:52 INFO - 'log_to_console': True, 05:04:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:04:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:04:52 INFO - 'opt_config_files': (), 05:04:52 INFO - 'pip_index': False, 05:04:52 INFO - 'sps_profile': False, 05:04:52 INFO - 'sps_profile_interval': 0, 05:04:52 INFO - 'suite': 'dromaeojs-e10s', 05:04:52 INFO - 'system_bits': '32', 05:04:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:04:52 INFO - 'title': 'talos-linux64-ix-012', 05:04:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:04:52 INFO - 'use_talos_json': True, 05:04:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:04:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:04:52 INFO - 'work_dir': 'build'} 05:04:52 INFO - [mozharness: 2016-08-09 12:04:52.594606Z] Running clobber step. 05:04:52 INFO - Running pre-action listener: _resource_record_pre_action 05:04:52 INFO - Running main action method: clobber 05:04:52 INFO - rmtree: /builds/slave/test/build 05:04:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:04:53 INFO - Running post-action listener: _resource_record_post_action 05:04:53 INFO - [mozharness: 2016-08-09 12:04:53.565096Z] Finished clobber step (success) 05:04:53 INFO - [mozharness: 2016-08-09 12:04:53.565197Z] Running read-buildbot-config step. 05:04:53 INFO - Running pre-action listener: _resource_record_pre_action 05:04:53 INFO - Running main action method: read_buildbot_config 05:04:53 INFO - Using buildbot properties: 05:04:53 INFO - { 05:04:53 INFO - "project": "", 05:04:53 INFO - "product": "firefox", 05:04:53 INFO - "script_repo_revision": "production", 05:04:53 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 05:04:53 INFO - "repository": "", 05:04:53 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 05:04:53 INFO - "buildid": "20160809034720", 05:04:53 INFO - "pgo_build": "False", 05:04:53 INFO - "basedir": "/builds/slave/test", 05:04:53 INFO - "buildnumber": 260, 05:04:53 INFO - "slavename": "talos-linux64-ix-012", 05:04:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:04:53 INFO - "platform": "ubuntu64_hw", 05:04:53 INFO - "scheduler": "tests-autoland-linux64-talos", 05:04:53 INFO - "branch": "autoland", 05:04:53 INFO - "repo_path": "integration/autoland", 05:04:53 INFO - "revision": "5179814c12b173f8126279665c48dfdef099b13f", 05:04:53 INFO - "stage_platform": "linux64", 05:04:53 INFO - "builduid": "e2d8351070ad481e992fd1e945e58a10", 05:04:53 INFO - "slavebuilddir": "test" 05:04:53 INFO - } 05:04:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 05:04:53 INFO - Running post-action listener: _resource_record_post_action 05:04:53 INFO - [mozharness: 2016-08-09 12:04:53.568076Z] Finished read-buildbot-config step (success) 05:04:53 INFO - [mozharness: 2016-08-09 12:04:53.568166Z] Running download-and-extract step. 05:04:53 INFO - Running pre-action listener: _resource_record_pre_action 05:04:53 INFO - Running main action method: download_and_extract 05:04:53 INFO - mkdir: /builds/slave/test/build/tests 05:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:53 INFO - trying https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:04:53 INFO - Downloading https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/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:04:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/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:04:54 INFO - Downloaded 1361 bytes. 05:04:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 05:04:54 INFO - Using the following test package requirements: 05:04:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:04:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:04:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:04:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:54 INFO - u'jsshell-linux-x86_64.zip'], 05:04:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:04:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 05:04:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:04:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:04:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:04:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 05:04:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:04:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:04:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:54 INFO - trying https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:04:54 INFO - Downloading https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/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:04:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/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:04:54 INFO - Downloaded 20258329 bytes. 05:04:54 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:04:54 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:04:56 INFO - Return code: 0 05:04:56 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:04: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:04:56 INFO - trying https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 05:04:56 INFO - Downloading https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/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:04:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/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:04:56 INFO - Downloaded 20258329 bytes. 05:04:56 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:04:56 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:04:58 INFO - Return code: 0 05:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:58 INFO - trying https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 05:04:58 INFO - Downloading https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/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:04:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/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:04:58 INFO - Downloaded 14413723 bytes. 05:04:58 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:04:58 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:04:59 INFO - Return code: 0 05:04: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:04:59 INFO - trying https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:04:59 INFO - Downloading https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/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:04:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/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:05:00 INFO - Downloaded 56138574 bytes. 05:05:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:05:00 INFO - mkdir: /builds/slave/test/properties 05:05:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:05:00 INFO - Writing to file /builds/slave/test/properties/build_url 05:05:00 INFO - Contents: 05:05:00 INFO - build_url:https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 05:05:01 INFO - Running post-action listener: _resource_record_post_action 05:05:01 INFO - Running post-action listener: set_extra_try_arguments 05:05:01 INFO - [mozharness: 2016-08-09 12:05:01.226751Z] Finished download-and-extract step (success) 05:05:01 INFO - [mozharness: 2016-08-09 12:05:01.226983Z] Running populate-webroot step. 05:05:01 INFO - Running pre-action listener: _resource_record_pre_action 05:05:01 INFO - Running main action method: populate_webroot 05:05:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:05:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:05:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:05:01 INFO - '--tppagecycles', 05:05:01 INFO - '7'], 05:05:01 INFO - 'tests': ['tsvgm']}}, 05:05:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:05:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:05:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:05:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:05:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:05:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:05:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:01 INFO - 'talos_options': ['--disable-e10s'], 05:05:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:05:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:01 INFO - 'talos_options': ['--disable-e10s'], 05:05:01 INFO - 'tests': ['damp', 'tps']}, 05:05:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:01 INFO - 'tests': ['damp', 'tps']}, 05:05:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:05:01 INFO - 'tests': ['dromaeo_dom']}, 05:05:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:05:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:05:01 INFO - 'tests': ['basic_compositor_video']}, 05:05:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:05:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:05:01 INFO - 'tests': ['a11yr', 05:05:01 INFO - 'ts_paint', 05:05:01 INFO - 'tpaint', 05:05:01 INFO - 'sessionrestore', 05:05:01 INFO - 'sessionrestore_no_auto_restore', 05:05:01 INFO - 'tabpaint']}, 05:05:01 INFO - 'other-e10s': {'tests': ['a11yr', 05:05:01 INFO - 'ts_paint', 05:05:01 INFO - 'tpaint', 05:05:01 INFO - 'sessionrestore', 05:05:01 INFO - 'sessionrestore_no_auto_restore', 05:05:01 INFO - 'tabpaint']}, 05:05:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:05:01 INFO - 'ts_paint', 05:05:01 INFO - 'tpaint', 05:05:01 INFO - 'sessionrestore', 05:05:01 INFO - 'sessionrestore_no_auto_restore', 05:05:01 INFO - 'tabpaint']}, 05:05:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:05:01 INFO - 'ts_paint', 05:05:01 INFO - 'tpaint', 05:05:01 INFO - 'sessionrestore', 05:05:01 INFO - 'sessionrestore_no_auto_restore', 05:05:01 INFO - 'tabpaint']}, 05:05:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:05:01 INFO - 'tests': ['a11yr', 05:05:01 INFO - 'ts_paint', 05:05:01 INFO - 'tpaint', 05:05:01 INFO - 'sessionrestore', 05:05:01 INFO - 'sessionrestore_no_auto_restore', 05:05:01 INFO - 'tabpaint']}, 05:05:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:05:01 INFO - 'tests': ['a11yr', 05:05:01 INFO - 'ts_paint', 05:05:01 INFO - 'tpaint', 05:05:01 INFO - 'sessionrestore', 05:05:01 INFO - 'sessionrestore_no_auto_restore', 05:05:01 INFO - 'tabpaint']}, 05:05:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:05:01 INFO - 'tests': ['tsvgx', 05:05:01 INFO - 'tsvgr_opacity', 05:05:01 INFO - 'tart', 05:05:01 INFO - 'tscrollx', 05:05:01 INFO - 'cart']}, 05:05:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:05:01 INFO - 'tsvgr_opacity', 05:05:01 INFO - 'tart', 05:05:01 INFO - 'tscrollx', 05:05:01 INFO - 'cart']}, 05:05:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:01 INFO - 'talos_options': ['--disable-e10s'], 05:05:01 INFO - 'tests': ['tp5o']}, 05:05:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:01 INFO - 'tests': ['tp5o']}, 05:05:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:01 INFO - 'talos_options': ['--disable-e10s', 05:05:01 INFO - '--xperf_path', 05:05:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:01 INFO - 'tests': ['tp5n']}, 05:05:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:05:01 INFO - 'talos_options': ['--xperf_path', 05:05:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:05:01 INFO - 'tests': ['tp5n']}}, 05:05:01 INFO - 'talos.zip': {'path': '', 05:05:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:05:01 INFO - Running post-action listener: _resource_record_post_action 05:05:01 INFO - [mozharness: 2016-08-09 12:05:01.244614Z] Finished populate-webroot step (success) 05:05:01 INFO - [mozharness: 2016-08-09 12:05:01.244702Z] Running create-virtualenv step. 05:05:01 INFO - Running pre-action listener: _resource_record_pre_action 05:05:01 INFO - Running main action method: create_virtualenv 05:05:01 INFO - Creating virtualenv /builds/slave/test/build/venv 05:05:01 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:05:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:05:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:05:01 INFO - Using real prefix '/usr' 05:05:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:05:01 INFO - Installing distribute.............................................................................................................................................................................................done. 05:05:03 INFO - Installing pip.................done. 05:05:03 INFO - Return code: 0 05:05:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:03 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 0x1dde030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209c570>, '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 0x209d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209d900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', '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:05:03 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:05:03 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:05:03 INFO - Using env: {'DISPLAY': ':0', 05:05:03 INFO - 'HOME': '/home/cltbld', 05:05:03 INFO - 'LANG': 'en_US.UTF-8', 05:05:03 INFO - 'LANGUAGE': 'en_US:en', 05:05:03 INFO - 'LOGNAME': 'cltbld', 05:05:03 INFO - 'MAIL': '/var/mail/cltbld', 05:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:03 INFO - 'MOZ_NO_REMOTE': '1', 05:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:03 INFO - 'NO_EM_RESTART': '1', 05:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:03 INFO - 'PWD': '/builds/slave/test', 05:05:03 INFO - 'SHELL': '/bin/bash', 05:05:03 INFO - 'SHLVL': '1', 05:05:03 INFO - 'TERM': 'linux', 05:05:03 INFO - 'TMOUT': '86400', 05:05:03 INFO - 'USER': 'cltbld', 05:05:03 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', 05:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:03 INFO - '_': '/tools/buildbot/bin/python'} 05:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:04 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:05:04 INFO - Cleaning up... 05:05:04 INFO - Return code: 0 05:05:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:05:04 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:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:04 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:05:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:04 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 0x1dde030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209c570>, '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 0x209d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209d900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', '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:05:04 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:05:04 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:05:04 INFO - Using env: {'DISPLAY': ':0', 05:05:04 INFO - 'HOME': '/home/cltbld', 05:05:04 INFO - 'LANG': 'en_US.UTF-8', 05:05:04 INFO - 'LANGUAGE': 'en_US:en', 05:05:04 INFO - 'LOGNAME': 'cltbld', 05:05:04 INFO - 'MAIL': '/var/mail/cltbld', 05:05:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:04 INFO - 'MOZ_NO_REMOTE': '1', 05:05:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:04 INFO - 'NO_EM_RESTART': '1', 05:05:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:04 INFO - 'PWD': '/builds/slave/test', 05:05:04 INFO - 'SHELL': '/bin/bash', 05:05:04 INFO - 'SHLVL': '1', 05:05:04 INFO - 'TERM': 'linux', 05:05:04 INFO - 'TMOUT': '86400', 05:05:04 INFO - 'USER': 'cltbld', 05:05:04 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', 05:05:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:04 INFO - '_': '/tools/buildbot/bin/python'} 05:05:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:04 INFO - Downloading/unpacking psutil>=3.1.1 05:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:05:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:06 INFO - Installing collected packages: psutil 05:05:06 INFO - Running setup.py install for psutil 05:05:06 INFO - building 'psutil._psutil_linux' extension 05:05:06 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:05:06 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:05:06 INFO - building 'psutil._psutil_posix' extension 05:05:06 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:05:06 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:05:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:05:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:05:06 INFO - Successfully installed psutil 05:05:06 INFO - Cleaning up... 05:05:06 INFO - Return code: 0 05:05:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:05: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:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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:05:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dde030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209c570>, '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 0x209d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209d900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', '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:05: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:05: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 mozsystemmonitor==0.3 05:05:06 INFO - Using env: {'DISPLAY': ':0', 05:05:06 INFO - 'HOME': '/home/cltbld', 05:05:06 INFO - 'LANG': 'en_US.UTF-8', 05:05:06 INFO - 'LANGUAGE': 'en_US:en', 05:05:06 INFO - 'LOGNAME': 'cltbld', 05:05:06 INFO - 'MAIL': '/var/mail/cltbld', 05:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:06 INFO - 'MOZ_NO_REMOTE': '1', 05:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:06 INFO - 'NO_EM_RESTART': '1', 05:05:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:06 INFO - 'PWD': '/builds/slave/test', 05:05:06 INFO - 'SHELL': '/bin/bash', 05:05:06 INFO - 'SHLVL': '1', 05:05:06 INFO - 'TERM': 'linux', 05:05:06 INFO - 'TMOUT': '86400', 05:05:06 INFO - 'USER': 'cltbld', 05:05:06 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', 05:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:06 INFO - '_': '/tools/buildbot/bin/python'} 05:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:05:07 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:05:07 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:05:07 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:05:07 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:05:07 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:05:07 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:05:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:05:09 INFO - Installing collected packages: mozsystemmonitor 05:05:09 INFO - Running setup.py install for mozsystemmonitor 05:05:09 INFO - Successfully installed mozsystemmonitor 05:05:09 INFO - Cleaning up... 05:05:09 INFO - Return code: 0 05:05:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:05:09 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:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:09 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:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:09 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 0x1dde030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209c570>, '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 0x209d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209d900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', '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:05:09 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:05:09 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:05:09 INFO - Using env: {'DISPLAY': ':0', 05:05:09 INFO - 'HOME': '/home/cltbld', 05:05:09 INFO - 'LANG': 'en_US.UTF-8', 05:05:09 INFO - 'LANGUAGE': 'en_US:en', 05:05:09 INFO - 'LOGNAME': 'cltbld', 05:05:09 INFO - 'MAIL': '/var/mail/cltbld', 05:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:09 INFO - 'MOZ_NO_REMOTE': '1', 05:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:09 INFO - 'NO_EM_RESTART': '1', 05:05:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:09 INFO - 'PWD': '/builds/slave/test', 05:05:09 INFO - 'SHELL': '/bin/bash', 05:05:09 INFO - 'SHLVL': '1', 05:05:09 INFO - 'TERM': 'linux', 05:05:09 INFO - 'TMOUT': '86400', 05:05:09 INFO - 'USER': 'cltbld', 05:05:09 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', 05:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:09 INFO - '_': '/tools/buildbot/bin/python'} 05:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:09 INFO - Downloading/unpacking jsonschema==2.5.1 05:05: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:05: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:05: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:05: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:05: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:05: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:05:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:05:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:05:11 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:05:11 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:05:11 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:05:11 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:05:11 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:05:11 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:05:11 INFO - Downloading functools32-3.2.3-2.tar.gz 05:05:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:05:11 INFO - warning: no files found matching '*.txt' 05:05:11 INFO - no previously-included directories found matching 'build' 05:05:11 INFO - no previously-included directories found matching 'dist' 05:05:11 INFO - no previously-included directories found matching '.git*' 05:05:11 INFO - Installing collected packages: jsonschema, functools32 05:05:11 INFO - Running setup.py install for functools32 05:05:11 INFO - warning: no files found matching '*.txt' 05:05:11 INFO - no previously-included directories found matching 'build' 05:05:11 INFO - no previously-included directories found matching 'dist' 05:05:11 INFO - no previously-included directories found matching '.git*' 05:05:11 INFO - Successfully installed jsonschema functools32 05:05:11 INFO - Cleaning up... 05:05:11 INFO - Return code: 0 05:05:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:05:11 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:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:11 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:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:11 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 0x1dde030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209c570>, '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 0x209d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209d900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', '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:05:11 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:05:11 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:05:11 INFO - Using env: {'DISPLAY': ':0', 05:05:11 INFO - 'HOME': '/home/cltbld', 05:05:11 INFO - 'LANG': 'en_US.UTF-8', 05:05:11 INFO - 'LANGUAGE': 'en_US:en', 05:05:11 INFO - 'LOGNAME': 'cltbld', 05:05:11 INFO - 'MAIL': '/var/mail/cltbld', 05:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:11 INFO - 'MOZ_NO_REMOTE': '1', 05:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:11 INFO - 'NO_EM_RESTART': '1', 05:05:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:11 INFO - 'PWD': '/builds/slave/test', 05:05:11 INFO - 'SHELL': '/bin/bash', 05:05:11 INFO - 'SHLVL': '1', 05:05:11 INFO - 'TERM': 'linux', 05:05:11 INFO - 'TMOUT': '86400', 05:05:11 INFO - 'USER': 'cltbld', 05:05:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', 05:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:11 INFO - '_': '/tools/buildbot/bin/python'} 05:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:05:11 INFO - Cleaning up... 05:05:11 INFO - Return code: 0 05:05:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:05:11 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:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:11 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:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:11 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 0x1dde030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209c570>, '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 0x209d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209d900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', '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:05:11 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:05:11 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:05:11 INFO - Using env: {'DISPLAY': ':0', 05:05:11 INFO - 'HOME': '/home/cltbld', 05:05:11 INFO - 'LANG': 'en_US.UTF-8', 05:05:11 INFO - 'LANGUAGE': 'en_US:en', 05:05:11 INFO - 'LOGNAME': 'cltbld', 05:05:11 INFO - 'MAIL': '/var/mail/cltbld', 05:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:11 INFO - 'MOZ_NO_REMOTE': '1', 05:05:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:11 INFO - 'NO_EM_RESTART': '1', 05:05:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:11 INFO - 'PWD': '/builds/slave/test', 05:05:11 INFO - 'SHELL': '/bin/bash', 05:05:11 INFO - 'SHLVL': '1', 05:05:11 INFO - 'TERM': 'linux', 05:05:11 INFO - 'TMOUT': '86400', 05:05:11 INFO - 'USER': 'cltbld', 05:05:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', 05:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:11 INFO - '_': '/tools/buildbot/bin/python'} 05:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:12 INFO - Downloading/unpacking blobuploader==1.2.4 05:05:12 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:05:12 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:05:12 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:05:12 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:05:12 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:05:12 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:05:14 INFO - Downloading blobuploader-1.2.4.tar.gz 05:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:05:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:05: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:05: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:05: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:05: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:05: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:05: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:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:05:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:05: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:05: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:05: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:05: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:05: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:05: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:05:14 INFO - Downloading docopt-0.6.1.tar.gz 05:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:05:14 INFO - Installing collected packages: blobuploader, requests, docopt 05:05:14 INFO - Running setup.py install for blobuploader 05:05:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:05:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:05:14 INFO - Running setup.py install for requests 05:05:15 INFO - Running setup.py install for docopt 05:05:15 INFO - Successfully installed blobuploader requests docopt 05:05:15 INFO - Cleaning up... 05:05:15 INFO - Return code: 0 05:05:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:15 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 0x1dde030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209c570>, '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 0x209d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209d900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', '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:05:15 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:05:15 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:05:15 INFO - Using env: {'DISPLAY': ':0', 05:05:15 INFO - 'HOME': '/home/cltbld', 05:05:15 INFO - 'LANG': 'en_US.UTF-8', 05:05:15 INFO - 'LANGUAGE': 'en_US:en', 05:05:15 INFO - 'LOGNAME': 'cltbld', 05:05:15 INFO - 'MAIL': '/var/mail/cltbld', 05:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:15 INFO - 'MOZ_NO_REMOTE': '1', 05:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:15 INFO - 'NO_EM_RESTART': '1', 05:05:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:15 INFO - 'PWD': '/builds/slave/test', 05:05:15 INFO - 'SHELL': '/bin/bash', 05:05:15 INFO - 'SHLVL': '1', 05:05:15 INFO - 'TERM': 'linux', 05:05:15 INFO - 'TMOUT': '86400', 05:05:15 INFO - 'USER': 'cltbld', 05:05:15 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', 05:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:15 INFO - '_': '/tools/buildbot/bin/python'} 05:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:15 INFO - Running setup.py (path:/tmp/pip-WicePz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:15 INFO - Running setup.py (path:/tmp/pip-DSfO_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:15 INFO - Running setup.py (path:/tmp/pip-Eya6M_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:15 INFO - Running setup.py (path:/tmp/pip-GXFwYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:15 INFO - Running setup.py (path:/tmp/pip-4EcKde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:16 INFO - Running setup.py (path:/tmp/pip-zis4cI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:16 INFO - Running setup.py (path:/tmp/pip-YA1e_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:16 INFO - Running setup.py (path:/tmp/pip-SWBL2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:16 INFO - Running setup.py (path:/tmp/pip-zd3Chi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:16 INFO - Running setup.py (path:/tmp/pip-cT5Ulq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:16 INFO - Running setup.py (path:/tmp/pip-dsMWTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:16 INFO - Running setup.py (path:/tmp/pip-MyF_x_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:16 INFO - Running setup.py (path:/tmp/pip-tJdnFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:16 INFO - Running setup.py (path:/tmp/pip-VZvCrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:16 INFO - Running setup.py (path:/tmp/pip-Wj83G1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:16 INFO - Running setup.py (path:/tmp/pip-NJKM77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:16 INFO - Running setup.py (path:/tmp/pip-HbrcMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:05:16 INFO - Running setup.py install for manifestparser 05:05:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:05:16 INFO - Running setup.py install for mozcrash 05:05:17 INFO - Running setup.py install for mozdebug 05:05:17 INFO - Running setup.py install for mozdevice 05:05:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:05:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:05:17 INFO - Running setup.py install for mozfile 05:05:17 INFO - Running setup.py install for mozhttpd 05:05:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:05:17 INFO - Running setup.py install for mozinfo 05:05:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:05:17 INFO - Running setup.py install for mozInstall 05:05:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:05:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:05:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:05:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:05:17 INFO - Running setup.py install for mozleak 05:05:17 INFO - Running setup.py install for mozlog 05:05:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:05:17 INFO - Running setup.py install for moznetwork 05:05:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:05:18 INFO - Running setup.py install for mozprocess 05:05:18 INFO - Running setup.py install for mozprofile 05:05:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:05:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:05:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:05:18 INFO - Running setup.py install for mozrunner 05:05:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:05:18 INFO - Running setup.py install for mozscreenshot 05:05:18 INFO - Running setup.py install for moztest 05:05:18 INFO - Running setup.py install for mozversion 05:05:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:05:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:05:18 INFO - Cleaning up... 05:05:18 INFO - Return code: 0 05:05:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:18 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 0x1dde030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209c570>, '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 0x209d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209d900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', '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:05:18 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:05:18 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:05:18 INFO - Using env: {'DISPLAY': ':0', 05:05:18 INFO - 'HOME': '/home/cltbld', 05:05:18 INFO - 'LANG': 'en_US.UTF-8', 05:05:18 INFO - 'LANGUAGE': 'en_US:en', 05:05:18 INFO - 'LOGNAME': 'cltbld', 05:05:18 INFO - 'MAIL': '/var/mail/cltbld', 05:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:18 INFO - 'MOZ_NO_REMOTE': '1', 05:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:18 INFO - 'NO_EM_RESTART': '1', 05:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:18 INFO - 'PWD': '/builds/slave/test', 05:05:18 INFO - 'SHELL': '/bin/bash', 05:05:18 INFO - 'SHLVL': '1', 05:05:18 INFO - 'TERM': 'linux', 05:05:18 INFO - 'TMOUT': '86400', 05:05:18 INFO - 'USER': 'cltbld', 05:05:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', 05:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:18 INFO - '_': '/tools/buildbot/bin/python'} 05:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:18 INFO - Running setup.py (path:/tmp/pip-PONN1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:18 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:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:18 INFO - Running setup.py (path:/tmp/pip-JEBzEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:19 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:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:19 INFO - Running setup.py (path:/tmp/pip-5VhgZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:19 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:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:19 INFO - Running setup.py (path:/tmp/pip-1FtE61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:19 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:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:19 INFO - Running setup.py (path:/tmp/pip-YqNROO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:19 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:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:19 INFO - Running setup.py (path:/tmp/pip-NJFQS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:19 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:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:19 INFO - Running setup.py (path:/tmp/pip-29OLzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:19 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:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:19 INFO - Running setup.py (path:/tmp/pip-3j7VOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:19 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:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:19 INFO - Running setup.py (path:/tmp/pip-DuLSKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:19 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:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:19 INFO - Running setup.py (path:/tmp/pip-bXmYLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:19 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:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:19 INFO - Running setup.py (path:/tmp/pip-cZI_26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:19 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:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:19 INFO - Running setup.py (path:/tmp/pip-wpRu2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:19 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:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:19 INFO - Running setup.py (path:/tmp/pip-zD27sE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:19 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:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:19 INFO - Running setup.py (path:/tmp/pip-2Sh3E7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:19 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:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:19 INFO - Running setup.py (path:/tmp/pip-ZklAve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:19 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:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:19 INFO - Running setup.py (path:/tmp/pip-k0Z0F2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:20 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:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:20 INFO - Running setup.py (path:/tmp/pip-7OKrnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:20 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:05:20 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:05:20 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:05:20 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:05:20 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:05:20 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:05:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:22 INFO - Downloading blessings-1.6.tar.gz 05:05:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:05:22 INFO - Installing collected packages: blessings 05:05:22 INFO - Running setup.py install for blessings 05:05:22 INFO - Successfully installed blessings 05:05:22 INFO - Cleaning up... 05:05:22 INFO - Return code: 0 05:05:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:05:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:22 INFO - Reading from file tmpfile_stdout 05:05:22 INFO - Current package versions: 05:05:22 INFO - argparse == 1.2.1 05:05:22 INFO - blessings == 1.6 05:05:22 INFO - blobuploader == 1.2.4 05:05:22 INFO - docopt == 0.6.1 05:05:22 INFO - functools32 == 3.2.3-2 05:05:22 INFO - jsonschema == 2.5.1 05:05:22 INFO - manifestparser == 1.1 05:05:22 INFO - mozInstall == 1.12 05:05:22 INFO - mozcrash == 0.17 05:05:22 INFO - mozdebug == 0.1 05:05:22 INFO - mozdevice == 0.48 05:05:22 INFO - mozfile == 1.2 05:05:22 INFO - mozhttpd == 0.7 05:05:22 INFO - mozinfo == 0.9 05:05:22 INFO - mozleak == 0.1 05:05:22 INFO - mozlog == 3.3 05:05:22 INFO - moznetwork == 0.27 05:05:22 INFO - mozprocess == 0.23 05:05:22 INFO - mozprofile == 0.28 05:05:22 INFO - mozrunner == 6.12 05:05:22 INFO - mozscreenshot == 0.1 05:05:22 INFO - mozsystemmonitor == 0.3 05:05:22 INFO - moztest == 0.7 05:05:22 INFO - mozversion == 1.4 05:05:22 INFO - psutil == 3.1.1 05:05:22 INFO - requests == 1.2.3 05:05:22 INFO - wsgiref == 0.1.2 05:05:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:22 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 0x1dde030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209c570>, '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 0x209d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209d900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', '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:05:22 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:05:22 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:05:22 INFO - Using env: {'DISPLAY': ':0', 05:05:22 INFO - 'HOME': '/home/cltbld', 05:05:22 INFO - 'LANG': 'en_US.UTF-8', 05:05:22 INFO - 'LANGUAGE': 'en_US:en', 05:05:22 INFO - 'LOGNAME': 'cltbld', 05:05:22 INFO - 'MAIL': '/var/mail/cltbld', 05:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:22 INFO - 'MOZ_NO_REMOTE': '1', 05:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:22 INFO - 'NO_EM_RESTART': '1', 05:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:22 INFO - 'PWD': '/builds/slave/test', 05:05:22 INFO - 'SHELL': '/bin/bash', 05:05:22 INFO - 'SHLVL': '1', 05:05:22 INFO - 'TERM': 'linux', 05:05:22 INFO - 'TMOUT': '86400', 05:05:22 INFO - 'USER': 'cltbld', 05:05:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', 05:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:22 INFO - '_': '/tools/buildbot/bin/python'} 05:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:22 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:05:22 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:05:22 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:05:22 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:05:22 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:05:22 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:05:22 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:05:22 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:05:22 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:05:22 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:05:22 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:05:22 INFO - Cleaning up... 05:05:22 INFO - Return code: 0 05:05:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:22 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 0x1dde030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x200d400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209c570>, '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 0x209d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209d900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', '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:05:22 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:05:22 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:05:22 INFO - Using env: {'DISPLAY': ':0', 05:05:22 INFO - 'HOME': '/home/cltbld', 05:05:22 INFO - 'LANG': 'en_US.UTF-8', 05:05:22 INFO - 'LANGUAGE': 'en_US:en', 05:05:22 INFO - 'LOGNAME': 'cltbld', 05:05:22 INFO - 'MAIL': '/var/mail/cltbld', 05:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:22 INFO - 'MOZ_NO_REMOTE': '1', 05:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:22 INFO - 'NO_EM_RESTART': '1', 05:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:22 INFO - 'PWD': '/builds/slave/test', 05:05:22 INFO - 'SHELL': '/bin/bash', 05:05:22 INFO - 'SHLVL': '1', 05:05:22 INFO - 'TERM': 'linux', 05:05:22 INFO - 'TMOUT': '86400', 05:05:22 INFO - 'USER': 'cltbld', 05:05:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', 05:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:22 INFO - '_': '/tools/buildbot/bin/python'} 05:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:05:22 INFO - Cleaning up... 05:05:22 INFO - Return code: 0 05:05:22 INFO - Running post-action listener: _resource_record_post_action 05:05:22 INFO - Running post-action listener: _start_resource_monitoring 05:05:22 INFO - Starting resource monitoring. 05:05:22 INFO - [mozharness: 2016-08-09 12:05:22.966420Z] Finished create-virtualenv step (success) 05:05:22 INFO - [mozharness: 2016-08-09 12:05:22.966905Z] Running install step. 05:05:22 INFO - Running pre-action listener: _resource_record_pre_action 05:05:22 INFO - Running main action method: install 05:05:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:23 INFO - Reading from file tmpfile_stdout 05:05:23 INFO - Detecting whether we're running mozinstall >=1.0... 05:05:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:05:23 INFO - Reading from file tmpfile_stdout 05:05:23 INFO - Output received: 05:05:23 INFO - Usage: mozinstall [options] installer 05:05:23 INFO - Options: 05:05:23 INFO - -h, --help show this help message and exit 05:05:23 INFO - -d DEST, --destination=DEST 05:05:23 INFO - Directory to install application into. [default: 05:05:23 INFO - "/builds/slave/test"] 05:05:23 INFO - --app=APP Application being installed. [default: firefox] 05:05:23 INFO - mkdir: /builds/slave/test/build/application 05:05:23 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:05:23 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:05:39 INFO - Reading from file tmpfile_stdout 05:05:39 INFO - Output received: 05:05:39 INFO - /builds/slave/test/build/application/firefox/firefox 05:05:39 INFO - Running post-action listener: _resource_record_post_action 05:05:39 INFO - [mozharness: 2016-08-09 12:05:39.505616Z] Finished install step (success) 05:05:39 INFO - [mozharness: 2016-08-09 12:05:39.505867Z] Running run-tests step. 05:05:39 INFO - Running pre-action listener: _resource_record_pre_action 05:05:39 INFO - Running main action method: run_tests 05:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:05:39 INFO - Python 2.7.3 05:05:39 INFO - Return code: 0 05:05:39 INFO - grabbing minidump binary from tooltool 05:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:39 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 0x209c570>, '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 0x209d470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x209d900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:05:39 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:05:39 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:05:39 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:05:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:05:39 INFO - Return code: 0 05:05:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:05:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:05:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:05:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:05:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:05:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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:05:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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:05:39 INFO - Using env: {'DISPLAY': ':0', 05:05:39 INFO - 'HOME': '/home/cltbld', 05:05:39 INFO - 'LANG': 'en_US.UTF-8', 05:05:39 INFO - 'LANGUAGE': 'en_US:en', 05:05:39 INFO - 'LOGNAME': 'cltbld', 05:05:39 INFO - 'MAIL': '/var/mail/cltbld', 05:05:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:05:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:05:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:39 INFO - 'MOZ_NO_REMOTE': '1', 05:05:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:05:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:39 INFO - 'NO_EM_RESTART': '1', 05:05:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:39 INFO - 'PWD': '/builds/slave/test', 05:05:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:05:39 INFO - 'SHELL': '/bin/bash', 05:05:39 INFO - 'SHLVL': '1', 05:05:39 INFO - 'TERM': 'linux', 05:05:39 INFO - 'TMOUT': '86400', 05:05:39 INFO - 'USER': 'cltbld', 05:05:39 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667', 05:05:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:39 INFO - '_': '/tools/buildbot/bin/python'} 05:05:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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:05:39 INFO - mozversion application_buildid: 20160809034720 05:05:39 INFO - mozversion application_changeset: 5179814c12b173f8126279665c48dfdef099b13f 05:05:39 INFO - mozversion application_display_name: Nightly 05:05:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:05:39 INFO - mozversion application_name: Firefox 05:05:39 INFO - mozversion application_remotingname: firefox 05:05:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 05:05:39 INFO - mozversion application_vendor: Mozilla 05:05:39 INFO - mozversion application_version: 51.0a1 05:05:39 INFO - mozversion platform_buildid: 20160809034720 05:05:39 INFO - mozversion platform_changeset: 5179814c12b173f8126279665c48dfdef099b13f 05:05:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 05:05:39 INFO - mozversion platform_version: 51.0a1 05:05:39 INFO - using testdate: 1470744339 05:05:39 INFO - actual date: 1470744339 05:05:39 INFO - starting webserver on 'localhost:41435' 05:05:39 INFO - SUITE-START | Running 2 tests 05:05:39 INFO - TEST-START | dromaeo_css 05:05:39 INFO - operating with platform_type : linux_ 05:05:39 INFO - Initialising browser for dromaeo_css test... 05:05:39 INFO - TEST-INFO | started process 22929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNWvwrV/profile http://localhost:41435/getInfo.html) 05:05:44 INFO - PROCESS | 22929 | __metrics Screen width/height:1600/1200 05:05:44 INFO - PROCESS | 22929 | colorDepth:24 05:05:44 INFO - PROCESS | 22929 | Browser inner width/height: 1024/697 05:05:44 INFO - PROCESS | 22929 | __metrics 05:05:44 ERROR - PROCESS | 22929 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:05:45 INFO - TEST-INFO | 22929: exit 0 05:05:45 INFO - Browser initialized. 05:05:45 INFO - Running cycle 1/1 for dromaeo_css test... 05:05:45 INFO - TEST-INFO | started process 23049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNWvwrV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:57 INFO - PROCESS | 23049 | RSS: Main: 165216256 05:05:57 INFO - PROCESS | 23049 | 05:06:47 INFO - PROCESS | 23049 | 1470744407229 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:08:59 INFO - PROCESS | 23049 | Cycle 1(1): loaded http://localhost:41435/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41435/tests/dromaeo/cssquery-ext.html) 05:09:01 INFO - PROCESS | 23049 | RSS: Main: 168468480 05:09:01 INFO - PROCESS | 23049 | 05:12:03 INFO - PROCESS | 23049 | Cycle 1(1): loaded http://localhost:41435/tests/dromaeo/cssquery-ext.html (next: http://localhost:41435/tests/dromaeo/cssquery-jquery.html) 05:12:04 INFO - PROCESS | 23049 | RSS: Main: 166862848 05:12:04 INFO - PROCESS | 23049 | 05:15:06 INFO - PROCESS | 23049 | Cycle 1(1): loaded http://localhost:41435/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41435/tests/dromaeo/cssquery-mootools.html) 05:15:06 INFO - PROCESS | 23049 | RSS: Main: 169832448 05:15:06 INFO - PROCESS | 23049 | 05:18:08 INFO - PROCESS | 23049 | Cycle 1(1): loaded http://localhost:41435/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41435/tests/dromaeo/cssquery-prototype.html) 05:18:09 INFO - PROCESS | 23049 | RSS: Main: 164278272 05:18:09 INFO - PROCESS | 23049 | 05:21:12 INFO - PROCESS | 23049 | Cycle 1(1): loaded http://localhost:41435/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41435/tests/dromaeo/cssquery-yui.html) 05:21:12 INFO - PROCESS | 23049 | RSS: Main: 166805504 05:21:12 INFO - PROCESS | 23049 | 05:24:15 INFO - PROCESS | 23049 | Cycle 1(1): loaded http://localhost:41435/tests/dromaeo/cssquery-yui.html (next: http://localhost:41435/tests/dromaeo/cssquery-dojo.html) 05:24:15 INFO - PROCESS | 23049 | RSS: Main: 169558016 05:24:15 INFO - PROCESS | 23049 | 05:24:15 INFO - PROCESS | 23049 | __start_tp_report 05:24:15 INFO - PROCESS | 23049 | _x_x_mozilla_page_load 05:24:15 INFO - PROCESS | 23049 | _x_x_mozilla_page_load_details 05:24:15 INFO - PROCESS | 23049 | |i|pagename|runs| 05:24:15 INFO - PROCESS | 23049 | |0;dojo.html;2693.757561819436;2698.1231099892534;2710.986445067774;2724.6457960465136;2740.7122252163535;4691.953080469194;4835.830745923893;4855.5872750816225;4872.610191184705;4921.311016457695;4802.111609352272;4826.638002149835;4867.853964381065;4870.220764677652;4903.215485522317;4421.867343979678;4500.212462818994;4511.8646440606835;4597.563231493003;4628.861134165981;4594.58648721615;4603.769811509428;4614.607758340545;4625.098105869357;4635.976820115911;4332.155229730172;4428.645708343325;4457.175422546807;4536.54634536547;4546.909061818778;4527.207738645724;4550;4557.589816916494;4568.611668008223;4573.359729637853;4420.182266280748;4457.420535330386;4494.37078808967;4495.527969563182;4513.7743112844555;4669.88325291867;4766.404199475066;4781.306710526954;4867.367242258484;4900.803967841318;5202.609804264695;5202.791888324463;5229.895402091937;5239.240310155044;5258.92111618326;5232.895342093175;5243.4232234454175;5244.5279924806955;5266.315379000744;5283.920741188886;4705;4849.078675051729;4856.150173719656;4891.608671306287;4929.901401971941;5441.755121019563;5445.346558412936;5453.372862120827;5486.670799752028;5498.780048798003;5225.085610018232;5232.529072383428;5232.973835130876;5246.0557099721655;5288;5042.899142017139;5151;5224.634275600672;5296.947030529723;5304.973475132677;5200.869978250498;5209.47905209476;5214.661047031931;5215.713135777492;5260.421353651095;5152.4847515248175;5174.870628234325;5189.195674670432;5196.038732834438;5216.321878155815;4245.172191422705;4301.247281725686;4327.913441731148;4333.869983900425;4365.9126817463475;3800.201957588882;3801.6388443097862;3809.580946095927;3822.808859557011;3845.5577608575372;4501.909961800746;4524.932126018112;4528.660350473728;4554.931676024862;4559.088182363541;5080.49195080489;5194.68831870089;5199.584033277329;5238.292830467838;5256.973715131477;4561.110583436264;4585;4589.288660257599;4608.078384323148;4624.260118381043;4712.5758681718125;4718.504557021532;4724.740139292303;4741.857744267678;4778.689385189951;4807.735574543363;4873.926891096566;4942.604591632733;4951.925721114114;5022.723750193774;5283.630145889751;5292.153255479105;5293.894122117459;5300.734963251745;5330.520253177233;4972.701637901738;4994.625403094709;4994.825181118788;5003.249512573143;5030.547250747451;4979.278004689372;5115.309433226466;5129.74351282427;5186.559142472932;5192.480751924928;5286.788528458818;5289.233061206027;5289.2330612061805;5296.258523806593;5325.068113080118;5104.897902042013;5106.387233532;5113.309703190171;5115.079285728604;5165.767540460613;4889.853304400874;5013.548780609617;5097.903950650628;5106.157484015096;5107.182850743863;5010;5056.140456122542;5056.241563765465;5082.567981721595;5116.692998420107;5067.746612669425;5118.257852611425;5154.845354639367;5158.561522270649;5207.869803254949;4788.880277993078;5019.874503137451;5030.245463180552;5091.87270318245;5101.336826212569 05:24:15 INFO - PROCESS | 23049 | |1;ext.html;550.4935459377373;559.9636023658462;575.5079407106923;580.4282781460261;593.187333353306;34758.30483390334;39419.40870886939;39437.40843887344;39441.408378874265;39548.60451395485;39876.601233987654;40270.39594406086;40335;40444.393334100016;40453.79773101138;7567.810804729885;7782.105057918327;7788.260115289038;7799.220077992212;7802.102758182797;7722.189170137139;7803.765887023398;7812.257835505618;7820.217978202191;7831.804204894895;7773.1449540550775;7780.8832867507035;7817.687292508293;7839.333656639164;7841.843163136734;7767.184445633212;7780.299773020399;7787.260210280015;7791.844163116706;7795.9220407795765;7696.345810606105;7750.651220695082;7767.805804854924;7814.218578142197;7843.37253019757;36850.81574592137;37060.44409333862;37477.62522374769;37489.25021499555;37516.06209844748;2619.2796980830235;3001.9699803002127;3036.4686179918426;3060.3573249617607;3082.799618024821;27760.583591246148;27941.720582794114;28243.717562824313;28340.29149271264;28461.430771384457;3360.1599600099976;3361.462166053444;3408.522806807049;3505.6319086495805;3513.2270900401872;226342;226573;227063.8646806772;227209;227836;32066.83966580199;32190.67809321877;32211.35577288441;32248;32255;32931.34137317288;33908.660913391046;34057.48913766295;35215.29569408597;35525;14584.270786460847;14701.55895323142;14703.338349774285;14734.484293049905;14809.555713328617;11014.889851101387;11229.831552526719;11238;11240;11240.887591124148;18008.279668813102;18055.923568789494;18061.90969045173;18170.727439088423;18326.816731832776;6707.770649759156;6966.651667416711;7009.158900931819;7037.753678621224;7060.717571297193;715.7029832619509;720.7405334079727;747.3759410891857;816.9918300816915;856.1267507142679;23507.88246058759;24333.36996593185;24592.877035615064;24606.876965615058;24715.134970275954;830.6594296338473;866.2550206822128;905.2667339455063;918.2286879021653;939.96710115147;12627.494900204072;13103.344832758325;13191.274479903506;13196.406161722745;13298.468061277634;406986;413665;415464;418140;418575;51368;51914.48085519097;52090.73954630203;52241.7387913058;52249;1167.1129941244715;1196.5811965811897;1218.6100447856777;1222.0895432902544;1226.3929354969348;23547.411314716584;24307;24706.629400558646;24717.887695053407;24889.128880489097;42633.36049959315;43492;43545;43610.34584481299;43695.78152109219;380165;380347;381578;381654;382353;23028.53942921099;23506.882465588245;23676;25301.114460993776;25722.742772572034;42107.36838947357;42407.151856963304;42565.787171063945;43153;43555.56444435515;36449.45325820062;36483.452748209325;36598;36869;37335.25329493449;34768;34921.12697182591;35074.82462587773;35234;35334.823325883204;30231.244218894702;30504.84747576248;30680.846595766878;31063.534046989764;31570.684293156773;30722.23194420068;32675.183120422178;33308;33760.49359259564;33881.66118338884;22561.435964100372;22821.88589057044;22903.427414314774;23142.42143946415;23351.532969340857 05:24:15 INFO - PROCESS | 23049 | |2;jquery.html;356.68077071021435;366.364357839149;370.7997681252124;379.66779068315225;380.2565983502253;15853.52439426816;17296.91351543242;17567.560810979718;17807.82192178078;17860.196291166896;16969.745453818203;17202;17715.91142044288;17867.28530858764;17877.91061044696;4985.252212168177;5168.9224661630105;5174.172132458807;5181.6113791465605;5199.064168449678;3797.221569578244;5183.248428977796;5707.315122185343;5954.047352423613;5988.251468566429;6004.969975150118;6027.698615069251;6028.306744724369;6036.396360363972;6059.484943779784;5935;6028;6071.4839238664545;6075.605085669462;6102.481289090389;5239.973800130975;5274.604404669665;5284.497972692588;5290.920636190422;5299.73501324936;20699.79300206994;21191.25830595937;21329.146834126615;21357.252496162717;21450.78549214519;2007.718919351292;2197.9890100549555;2198.912043518257;2315.2012555668266;2408.2654790288957;13555.96660500923;13722.313884305844;13802.723945521033;13868.722625547534;14053.859461405358;1684.5872761173468;1702.9829701702947;1724.1465474590034;1730.3251731824598;1732.826717328257;43251;43424.78287608573;65706.67146664285;66887.33112668908;68455.65772171157;9043.819123617492;9298.674546390845;9384.57769400365;9463;9801.099450274862;12768.425420856083;12771.169873958162;12779.105462617528;12802.743945121232;12818.487260509663;7208.35124838767;7258.0927384076995;7271.963640181765;7394.519356241827;7513.323800857949;6952.513324067267;7060.505764596429;7139.607321597362;7154.284571542804;7388.261173882569;5940.287165540163;5949.613275137102;6027.427394397525;6057.697115144225;6129.908051379233;1564.3507944203257;1632.71427500187;1736.9392071277698;1758.0113806528952;1776.1474492243794;668.4418510543751;745.9477836551498;775.3835700618022;775.9534427934342;794.7734895554739;15956.680866382607;16328.510144695678;16339.836601633831;16396.50810475664;16627.584310392336;739.3863093632273;739.7928579997609;745.02401853572;765.1927216786344;783.3145997252404;8006.359491240687;9317.394369366106;9372.39079459833;9433.858492122486;9578.521073946275;404520;406742;408466;409092;422363;71829.64085179541;71910;72575.27424725791;74988.62505687437;75857.24142758612;918.1828172926234;929.7303781903307;958.5255298627225;961.9038096190465;963.7397902566267;12162;13229;14448.855511444752;14743.262836858328;15115.168665723051;35730.821345893106;36698.44952325664;37237.44143837791;37436.62563374441;37951.05122371963;49139.508604914925;49420;49441.25838112503;49542.50457495379;49702.25446618231;7276.527025743309;7312.926870731225;7328.633568321669;7373.262673732584;7897.68409263623;10991.890081099407;11050.171237157407;11599.594014209462;11606.361650108987;11666.125040622157;9014.098590140933;9037.593308301273;9350.719478415658;9358.344915855825;9444.338896277195;10099.848502272325;10429.165666746794;10445.373277603368;10470.424126673106;10560.947195264282;9453.101955314234;9484.95257523708;9806.451612903225;9830.705078847646;10189.592416303562;7455.9627201865815;7471.701131954661;7608.543487390774;7614.961925190339;7717.803740420244;9356.111169438893;9527.809443811224;9760.170385517311;9796.85304720444;10022.899771002489 05:24:15 INFO - PROCESS | 23049 | |3;mootools.html;1372.794080887867;1403.6561042544577;1478.2682572126791;1681.2182335214138;1703.667784781968;6531.2489063757685;7171.605561694105;7456.925430745691;7846.99901525111;7864.095629002666;7478.102627684685;7675.501092428988;7833.764987050384;7861.921380786191;7894.3289820365335;2084.7810979847127;2140.2081229944865;2152.1714140056115;2152.6448136057534;2153.321703663341;2096.2348742708878;2134.583756167548;2184.3010236724253;2194.6378847490146;2207.845450818443;2133.264023911748;2138.112683236463;2154.859934104286;2163;2197.2090047582938;2081.9687704684443;2086.634838903201;2092.184048221195;2092.7070210170587;2094.350751267112;2044.3253726270295;2109.4093653776968;2121.140937920145;2124.2246579998346;2133.25336132354;7868.0558332999835;7881.448298619041;7882.763517094439;7897.447178697494;7906.80232994174;4478.977605111986;4545.931811022837;4621.3299071634765;4622.1911165546235;4624.237000894848;2799.174243598143;2883.0774152271283;2927.6486821581548;2932.5014747492764;2937.089502254308;863.9179277968583;920.5581320965907;926.8053708721177;928.215657769184;975.0590679993769;10470.110040646554;10731.731706707316;10746.570137194503;10755.51600177986;10766.4616769162;3998.5601583825755;4128.896777580585;4172.937405938914;4259.318509038539;4260.020195355086;9118.270538356915;9171.44971301724;9173;9200.447973121634;9221.354505184572;4446.133004064176;4486.304622783408;4503.527129651405;4513.7066090704;4524.117797029548;3346.9330613387597;4033.092554175287;4033.2135233629747;4049.8785036448953;4124.587541245912;3548.30807992439;3549.680528752425;3625.818709064536;3687.11509237781;3694.058015206105;1113.6603335982604;1133.4559411482535;1150.4765331774022;1151.424287856072;1151.9366434845997;745.6420917959301;758.3440324119707;813.0852790610563;813.7151996801073;826.9586520673943;4849.199882019498;4915.778789954461;4953.851384458472;5001.299818025479;5093.567046801063;397.3149042629576;399.5684660566581;403.8041549848321;405.9675225981914;429.6648614081022;3413.8122403268057;3415.624281329052;3449.9655003449643;3461.1866211440292;3570.2145527983803;9229.723108306762;9509.096635819586;9520.761980950532;9592.95203523978;9617.903820961841;9559.426434413957;9572.56923438447;9574.808503829885;9582.472963987047;9626.807463850684;7379.225181355988;7455.515391499535;7457.7016919323705;7459.552426854515;7465.365443937326;4886.926696099633;4890.217565189552;4972.303877457087;5004.924926126184;5165.845024649267;8703;8724.214820666171;8800.779980500538;8849.69026084084;8895.644174232959;8878.422902511316;8882.911170888467;8890.911090889267;8953.373263871466;9037.141471560455;6763.12079429671;6807.489438292247;7069.717211311696;7130.42956563484;7163.462740294603;7121.038659780863;7327.670254838438;7374.373178279906;7379.040724705968;7389.630518473948;6463.967680161569;6724.4284235840505;6760.932390676227;6767.39093481589;6867.004284378837;6274.152989346379;6462.063000864942;6500.089987401673;6632.734690612321;6751.696173672099;5884.470397664059;6017.247844019497;6032.245969253843;6038.064100064497;6048.909266361096;4286.657067434536;4476.373307736984;4477.306017567283;4485.887852803706;4512.323151527297;4387.780610969375;4467.396901418397;4470.731756094515;4615.953840461687;4709.458412282632 05:24:15 INFO - PROCESS | 23049 | |4;prototype.html;286.4700304436792;296.6114390148905;297.4912898942809;301.32352867811767;303.74030204175415;5014.272930425091;5076.720780357079;5081.542661160494;5092.847214583564;5103.668261562996;4997.850064498062;5002.924956125652;5006.421692828197;5019.799208031674;5026.572741316983;3683.5763887152984;3795.2219794942107;3858.7298889077774;3908.687305015592;3909.824057917386;3898.434726964588;3899.083715326896;3905.964919296389;3911.8630847920326;3915.6280153385383;3880.8835734927998;3888.4361767543687;3896.5713771485116;3898.2203559288114;3899.181171953893;3768.246350729865;3843.7693738375788;3869.555001174873;3879.72841901067;3895.5520115186832;3386.4412371958597;3396;3399.5750531183603;3402.404579198655;3409.147713071732;4865.245886887538;4881.5606595406225;4886.193778026622;4888.973315603692;4892.529272717255;4316.589923957219;4420.977895110536;4424.292113261863;4433.179861725559;4437.245668236407;5216.504432078947;5227;5234.7120908350025;5238.68567885928;5239.502247286502;3709.1283548366114;3712.6472985066375;3712.981435092834;3715.8327875245677;3721.5162028936065;5472.5621950243885;5483.287172667568;5486.561075113981;5497.697626630534;5506.80726174586;3591.982040089783;3797.5632802227547;3815.7138214634015;3820.9617903821163;3828.9617103829164;3836.462895194675;3838;3893.96106038936;3896.123372241223;3897.317969355408;4432.15789000089;4439.534953465413;4448.5551444855255;4449.777511124431;4477.3731677565165;5067.366579177603;5217.000224870639;5285.947140528546;5289.3652761668845;5290.249070483327;1340.2695530935664;1358.8980826438058;1361.06766864696;1365.2491129878526;1366.5558693424678;831.9916800831915;860.7476122242123;864.4640322999654;866.4541338956543;870.8519551676103;4378.255696531597;4529.932051019237;4659.904922343247;4675.625949923998;4681.414823147106;5404.83785486436;5440.238366628675;5440.422277539548;5440.863978400493;5458.563314934796;4596.862094137181;4642.117997580449;4670.12787135909;4680.251159814414;4682.508336624674;2707.5667893137;2867.5125228711167;2888.5378339466006;2892.8139462820563;2895.218291061444;5179.326687530597;5186.896262074737;5199.6880187188135;5201.323827902348;5207.739613019334;5283.445238250005;5595.468430499096;5624.465675760796;5630.915536266959;5638;5156.92264616031;5168.896622067613;5174.689518628819;5178.197379406198;5182.948170518322;5437.429069947757;5444.292242008513;5458.699771512446;5466.3986961435;5477;5157.638965272545;5328.350080195079;5352.5450336721815;5359.758810853443;5365.3293338332705;5145.742712864267;5151;5153.922691159561;5166.689998600096;5168.638195326291;3739.6073412291316;3762.548494180606;3769.4157405602177;3774.414965680324;3787.886363409102;5315.6279060465395;5456.263404440509;5462.945370546403;5474.39781624029;5476.589255805751;5276.234945932895;5277.2875661785165;5279.260903473593;5291.682499050069;5302.950803288048;5280.656757310762;5280.84157475261;5284.973575132253;5293.570735901362;5315.574754019746;5026.899462010812;5150.587952963829;5176.223566465061;5206.479352064915;5230.293910322058;5069.290299358019;5205.843824685266;5251.396089449762;5273.815416460406;5326.36083669962;5185.637005409736;5193;5204.609654275869;5210.557102646166;5212.609054321017 05:24:15 INFO - PROCESS | 23049 | |5;yui.html;603.6436325492564;620.2587907450599;624.378743150565;626.2141013028647;659.4032400677389;11846.703832404195;12762.617121486346;12833.743325133491;12833.743325133504;12846.357682115904;12018.819717704242;12125.454354554044;12127.75744485112;12133.514659413613;12159.27044377338;744.4491076603315;750.8610906982199;764.6711913877031;777.1024466740923;781.488125277941;767.87330090535;771.1363273134069;771.9343855772266;773.246085067058;776.6854423958306;819.1317203764029;820.5035953248289;822.9300509456704;823.283743143466;826.0417915218347;808.0505406147753;810.4165001199127;813.4143416739968;815.1888870573817;816.7263966571176;596.749365266589;597.6503745309;597.692188522911;598.0670154558902;598.141666708275;12618.621441356774;12629.87370126296;12632.30522321272;12646.74706505874;12652.68368290791;12917.87082129176;13055.151415157985;13290.867091329059;13635.318234088256;13723.725525489433;10074.395536267773;10173.287869849113;10433.16534677224;10667.83998240027;10690.839637405368;3185.2673885006348;3210.293735378213;3285.917852053694;3301.5212794144954;3347;59912;61268;61718.38281617171;62097;62938.68530657318;9796.706098816905;10187.796244075076;10190;10226.59093636261;10317.535710893027;17618.559536011446;17921;17925.193366298547;18009.7298540522;18181.909090454465;6408.455281301141;6454.6449945252525;6535.803925882231;6554.8361290968105;6632.1046658701425;3564.7682900611376;3603.657652523006;3689.6494832990825;3708.4622729704042;3735.7789069277483;2958.556216567532;3090.891818786332;3101.937961240808;3103.875844966176;3104.037748298035;567.1549391406857;594.4709208804168;600.7476859718929;616.5868867858545;620.6679426506797;471.37778132864975;521.1531261699738;533.5304931660114;542.8941356435536;554.8973439913628;7363.374113200438;8095.55474448911;8166.877496837552;8417.989841219092;8451.830963380698;463.3975831419209;503.9521245481673;515.3231691878474;581.2937281203274;583.6527266276559;3855.4216867470104;3941.4481972523868;3992.5807790182193;3999.300122478555;4248.129133527619;85365;98421.50789246008;100602;100625;101315.49342253241;85588.14411855926;85714;86356.13643863481;86819.65901705016;87614.56192718996;73914;76477;76757.6162119197;77940.22059779442;79658;7960.4825686330205;7969.242921922408;8193.13972032928;8228.629711663109;8289.253967142986;43287.56712432835;45116;45367;45544.40594579174;45894.77052614716;58024;58660.706696466244;64246;66128.33871661221;66135;9839.803203935739;9891.950540247253;9922.801543969224;9925.156361709336;10131.240156988108;10480.895191047992;10726.785464290826;10874.293170943864;10877;10945.83581246298;9540.904590954002;9828.213742900407;9835.21318294549;9840.212782977487;9887.209023278265;9746.707598772047;9952.452615106238;10044;10106.949465252626;10407.167426606005;9978.401295922267;10134.695959121238;10135.087842094246;10404.115650169517;10583.682489525327;8493.278071364004;8502.659893604186;8625.827483450421;8724.65101395937;9076.909230907871;8138.813474357214;8243.381746368927;8625.180607842245;8660.39377243587;8744.125587441205 05:24:15 INFO - PROCESS | 23049 | __end_tp_report 05:24:15 INFO - PROCESS | 23049 | __start_cc_report 05:24:15 INFO - PROCESS | 23049 | _x_x_mozilla_cycle_collect,385 05:24:15 INFO - PROCESS | 23049 | __end_cc_report 05:24:15 INFO - PROCESS | 23049 | __startTimestamp1470745455678__endTimestamp 05:24:15 INFO - PROCESS | 23049 | 05:24:15 INFO - PROCESS | 23049 | ------- Summary: start ------- 05:24:15 INFO - PROCESS | 23049 | Number of tests: 6 05:24:15 INFO - PROCESS | 23049 | 05:24:15 INFO - PROCESS | 23049 | [#0] dojo.html Cycles:165 Average:4839.01 Median:4979.28 stddev:518.66 (10.4%) stddev-sans-first:492.19 05:24:15 INFO - PROCESS | 23049 | Values: 2693.8 2698.1 2711.0 2724.6 2740.7 4692.0 4835.8 4855.6 4872.6 4921.3 4802.1 4826.6 4867.9 4870.2 4903.2 4421.9 4500.2 4511.9 4597.6 4628.9 4594.6 4603.8 4614.6 4625.1 4636.0 4332.2 4428.6 4457.2 4536.5 4546.9 4527.2 4550.0 4557.6 4568.6 4573.4 4420.2 4457.4 4494.4 4495.5 4513.8 4669.9 4766.4 4781.3 4867.4 4900.8 5202.6 5202.8 5229.9 5239.2 5258.9 5232.9 5243.4 5244.5 5266.3 5283.9 4705.0 4849.1 4856.2 4891.6 4929.9 5441.8 5445.3 5453.4 5486.7 5498.8 5225.1 5232.5 5233.0 5246.1 5288.0 5042.9 5151.0 5224.6 5296.9 5305.0 5200.9 5209.5 5214.7 5215.7 5260.4 5152.5 5174.9 5189.2 5196.0 5216.3 4245.2 4301.2 4327.9 4333.9 4365.9 3800.2 3801.6 3809.6 3822.8 3845.6 4501.9 4524.9 4528.7 4554.9 4559.1 5080.5 5194.7 5199.6 5238.3 5257.0 4561.1 4585.0 4589.3 4608.1 4624.3 4712.6 4718.5 4724.7 4741.9 4778.7 4807.7 4873.9 4942.6 4951.9 5022.7 5283.6 5292.2 5293.9 5300.7 5330.5 4972.7 4994.6 4994.8 5003.2 5030.5 4979.3 5115.3 5129.7 5186.6 5192.5 5286.8 5289.2 5289.2 5296.3 5325.1 5104.9 5106.4 5113.3 5115.1 5165.8 4889.9 5013.5 5097.9 5106.2 5107.2 5010.0 5056.1 5056.2 5082.6 5116.7 5067.7 5118.3 5154.8 5158.6 5207.9 4788.9 5019.9 5030.2 5091.9 5101.3 05:24:15 INFO - PROCESS | 23049 | 05:24:15 INFO - PROCESS | 23049 | [#1] ext.html Cycles:180 Average:47665.44 Median:35987.23 stddev:92905.63 (258.2%) stddev-sans-first:93098.91 05:24:15 INFO - PROCESS | 23049 | Values: 550.5 560.0 575.5 580.4 593.2 34758.3 39419.4 39437.4 39441.4 39548.6 39876.6 40270.4 40335.0 40444.4 40453.8 7567.8 7782.1 7788.3 7799.2 7802.1 7722.2 7803.8 7812.3 7820.2 7831.8 7773.1 7780.9 7817.7 7839.3 7841.8 7767.2 7780.3 7787.3 7791.8 7795.9 7696.3 7750.7 7767.8 7814.2 7843.4 36850.8 37060.4 37477.6 37489.3 37516.1 2619.3 3002.0 3036.5 3060.4 3082.8 27760.6 27941.7 28243.7 28340.3 28461.4 3360.2 3361.5 3408.5 3505.6 3513.2 226342.0 226573.0 227063.9 227209.0 227836.0 32066.8 32190.7 32211.4 32248.0 32255.0 32931.3 33908.7 34057.5 35215.3 35525.0 14584.3 14701.6 14703.3 14734.5 14809.6 11014.9 11229.8 11238.0 11240.0 11240.9 18008.3 18055.9 18061.9 18170.7 18326.8 6707.8 6966.7 7009.2 7037.8 7060.7 715.7 720.7 747.4 817.0 856.1 23507.9 24333.4 24592.9 24606.9 24715.1 830.7 866.3 905.3 918.2 940.0 12627.5 13103.3 13191.3 13196.4 13298.5 406986.0 413665.0 415464.0 418140.0 418575.0 51368.0 51914.5 52090.7 52241.7 52249.0 1167.1 1196.6 1218.6 1222.1 1226.4 23547.4 24307.0 24706.6 24717.9 24889.1 42633.4 43492.0 43545.0 43610.3 43695.8 380165.0 380347.0 381578.0 381654.0 382353.0 23028.5 23506.9 23676.0 25301.1 25722.7 42107.4 42407.2 42565.8 43153.0 43555.6 36449.5 36483.5 36598.0 36869.0 37335.3 34768.0 34921.1 35074.8 35234.0 35334.8 30231.2 30504.8 30680.8 31063.5 31570.7 30722.2 32675.2 33308.0 33760.5 33881.7 22561.4 22821.9 22903.4 23142.4 23351.5 05:24:15 INFO - PROCESS | 23049 | 05:24:15 INFO - PROCESS | 23049 | [#2] jquery.html Cycles:180 Average:24481.41 Median:5219.52 stddev:67351.04 (1290.4%) stddev-sans-first:67515.62 05:24:15 INFO - PROCESS | 23049 | Values: 356.7 366.4 370.8 379.7 380.3 15853.5 17296.9 17567.6 17807.8 17860.2 16969.7 17202.0 17715.9 17867.3 17877.9 4985.3 5168.9 5174.2 5181.6 5199.1 3797.2 5183.2 5707.3 5954.0 5988.3 6005.0 6027.7 6028.3 6036.4 6059.5 5935.0 6028.0 6071.5 6075.6 6102.5 5240.0 5274.6 5284.5 5290.9 5299.7 20699.8 21191.3 21329.1 21357.3 21450.8 2007.7 2198.0 2198.9 2315.2 2408.3 13556.0 13722.3 13802.7 13868.7 14053.9 1684.6 1703.0 1724.1 1730.3 1732.8 43251.0 43424.8 65706.7 66887.3 68455.7 9043.8 9298.7 9384.6 9463.0 9801.1 12768.4 12771.2 12779.1 12802.7 12818.5 7208.4 7258.1 7272.0 7394.5 7513.3 6952.5 7060.5 7139.6 7154.3 7388.3 5940.3 5949.6 6027.4 6057.7 6129.9 1564.4 1632.7 1736.9 1758.0 1776.1 668.4 745.9 775.4 776.0 794.8 15956.7 16328.5 16339.8 16396.5 16627.6 739.4 739.8 745.0 765.2 783.3 8006.4 9317.4 9372.4 9433.9 9578.5 404520.0 406742.0 408466.0 409092.0 422363.0 71829.6 71910.0 72575.3 74988.6 75857.2 918.2 929.7 958.5 961.9 963.7 12162.0 13229.0 14448.9 14743.3 15115.2 35730.8 36698.4 37237.4 37436.6 37951.1 49139.5 49420.0 49441.3 49542.5 49702.3 7276.5 7312.9 7328.6 7373.3 7897.7 10991.9 11050.2 11599.6 11606.4 11666.1 9014.1 9037.6 9350.7 9358.3 9444.3 10099.8 10429.2 10445.4 10470.4 10560.9 9453.1 9485.0 9806.5 9830.7 10189.6 7456.0 7471.7 7608.5 7615.0 7717.8 9356.1 9527.8 9760.2 9796.9 10022.9 05:24:15 INFO - PROCESS | 23049 | 05:24:15 INFO - PROCESS | 23049 | [#3] mootools.html Cycles:180 Average:5060.48 Median:4868.06 stddev:2892.46 (59.4%) stddev-sans-first:2887.30 05:24:15 INFO - PROCESS | 23049 | Values: 1372.8 1403.7 1478.3 1681.2 1703.7 6531.2 7171.6 7456.9 7847.0 7864.1 7478.1 7675.5 7833.8 7861.9 7894.3 2084.8 2140.2 2152.2 2152.6 2153.3 2096.2 2134.6 2184.3 2194.6 2207.8 2133.3 2138.1 2154.9 2163.0 2197.2 2082.0 2086.6 2092.2 2092.7 2094.4 2044.3 2109.4 2121.1 2124.2 2133.3 7868.1 7881.4 7882.8 7897.4 7906.8 4479.0 4545.9 4621.3 4622.2 4624.2 2799.2 2883.1 2927.6 2932.5 2937.1 863.9 920.6 926.8 928.2 975.1 10470.1 10731.7 10746.6 10755.5 10766.5 3998.6 4128.9 4172.9 4259.3 4260.0 9118.3 9171.4 9173.0 9200.4 9221.4 4446.1 4486.3 4503.5 4513.7 4524.1 3346.9 4033.1 4033.2 4049.9 4124.6 3548.3 3549.7 3625.8 3687.1 3694.1 1113.7 1133.5 1150.5 1151.4 1151.9 745.6 758.3 813.1 813.7 827.0 4849.2 4915.8 4953.9 5001.3 5093.6 397.3 399.6 403.8 406.0 429.7 3413.8 3415.6 3450.0 3461.2 3570.2 9229.7 9509.1 9520.8 9593.0 9617.9 9559.4 9572.6 9574.8 9582.5 9626.8 7379.2 7455.5 7457.7 7459.6 7465.4 4886.9 4890.2 4972.3 5004.9 5165.8 8703.0 8724.2 8800.8 8849.7 8895.6 8878.4 8882.9 8890.9 8953.4 9037.1 6763.1 6807.5 7069.7 7130.4 7163.5 7121.0 7327.7 7374.4 7379.0 7389.6 6464.0 6724.4 6760.9 6767.4 6867.0 6274.2 6462.1 6500.1 6632.7 6751.7 5884.5 6017.2 6032.2 6038.1 6048.9 4286.7 4476.4 4477.3 4485.9 4512.3 4387.8 4467.4 4470.7 4616.0 4709.5 05:24:15 INFO - PROCESS | 23049 | 05:24:15 INFO - PROCESS | 23049 | [#4] prototype.html Cycles:180 Average:4368.52 Median:5026.74 stddev:1285.89 (25.6%) stddev-sans-first:1252.46 05:24:15 INFO - PROCESS | 23049 | Values: 286.5 296.6 297.5 301.3 303.7 5014.3 5076.7 5081.5 5092.8 5103.7 4997.9 5002.9 5006.4 5019.8 5026.6 3683.6 3795.2 3858.7 3908.7 3909.8 3898.4 3899.1 3906.0 3911.9 3915.6 3880.9 3888.4 3896.6 3898.2 3899.2 3768.2 3843.8 3869.6 3879.7 3895.6 3386.4 3396.0 3399.6 3402.4 3409.1 4865.2 4881.6 4886.2 4889.0 4892.5 4316.6 4421.0 4424.3 4433.2 4437.2 5216.5 5227.0 5234.7 5238.7 5239.5 3709.1 3712.6 3713.0 3715.8 3721.5 5472.6 5483.3 5486.6 5497.7 5506.8 3592.0 3797.6 3815.7 3821.0 3829.0 3836.5 3838.0 3894.0 3896.1 3897.3 4432.2 4439.5 4448.6 4449.8 4477.4 5067.4 5217.0 5285.9 5289.4 5290.2 1340.3 1358.9 1361.1 1365.2 1366.6 832.0 860.7 864.5 866.5 870.9 4378.3 4529.9 4659.9 4675.6 4681.4 5404.8 5440.2 5440.4 5440.9 5458.6 4596.9 4642.1 4670.1 4680.3 4682.5 2707.6 2867.5 2888.5 2892.8 2895.2 5179.3 5186.9 5199.7 5201.3 5207.7 5283.4 5595.5 5624.5 5630.9 5638.0 5156.9 5168.9 5174.7 5178.2 5182.9 5437.4 5444.3 5458.7 5466.4 5477.0 5157.6 5328.4 5352.5 5359.8 5365.3 5145.7 5151.0 5153.9 5166.7 5168.6 3739.6 3762.5 3769.4 3774.4 3787.9 5315.6 5456.3 5462.9 5474.4 5476.6 5276.2 5277.3 5279.3 5291.7 5303.0 5280.7 5280.8 5285.0 5293.6 5315.6 5026.9 5150.6 5176.2 5206.5 5230.3 5069.3 5205.8 5251.4 5273.8 5326.4 5185.6 5193.0 5204.6 5210.6 5212.6 05:24:15 INFO - PROCESS | 23049 | 05:24:15 INFO - PROCESS | 23049 | [#5] yui.html Cycles:180 Average:17496.04 Median:597.67 stddev:25729.31 (4304.9%) stddev-sans-first:25770.22 05:24:15 INFO - PROCESS | 23049 | Values: 603.6 620.3 624.4 626.2 659.4 11846.7 12762.6 12833.7 12833.7 12846.4 12018.8 12125.5 12127.8 12133.5 12159.3 744.4 750.9 764.7 777.1 781.5 767.9 771.1 771.9 773.2 776.7 819.1 820.5 822.9 823.3 826.0 808.1 810.4 813.4 815.2 816.7 596.7 597.7 597.7 598.1 598.1 12618.6 12629.9 12632.3 12646.7 12652.7 12917.9 13055.2 13290.9 13635.3 13723.7 10074.4 10173.3 10433.2 10667.8 10690.8 3185.3 3210.3 3285.9 3301.5 3347.0 59912.0 61268.0 61718.4 62097.0 62938.7 9796.7 10187.8 10190.0 10226.6 10317.5 17618.6 17921.0 17925.2 18009.7 18181.9 6408.5 6454.6 6535.8 6554.8 6632.1 3564.8 3603.7 3689.6 3708.5 3735.8 2958.6 3090.9 3101.9 3103.9 3104.0 567.2 594.5 600.7 616.6 620.7 471.4 521.2 533.5 542.9 554.9 7363.4 8095.6 8166.9 8418.0 8451.8 463.4 504.0 515.3 581.3 583.7 3855.4 3941.4 3992.6 3999.3 4248.1 85365.0 98421.5 100602.0 100625.0 101315.5 85588.1 85714.0 86356.1 86819.7 87614.6 73914.0 76477.0 76757.6 77940.2 79658.0 7960.5 7969.2 8193.1 8228.6 8289.3 43287.6 45116.0 45367.0 45544.4 45894.8 58024.0 58660.7 64246.0 66128.3 66135.0 9839.8 9892.0 9922.8 9925.2 10131.2 10480.9 10726.8 10874.3 10877.0 10945.8 9540.9 9828.2 9835.2 9840.2 9887.2 9746.7 9952.5 10044.0 10106.9 10407.2 9978.4 10134.7 10135.1 10404.1 10583.7 8493.3 8502.7 8625.8 8724.7 9076.9 8138.8 8243.4 8625.2 8660.4 8744.1 05:24:15 INFO - PROCESS | 23049 | -------- Summary: end -------- 05:24:15 INFO - PROCESS | 23049 | 05:24:16 INFO - TEST-INFO | 23049: exit 0 05:24:16 INFO - TEST-OK | dromaeo_css | took 1116687ms 05:24:16 INFO - TEST-START | kraken 05:24:16 INFO - operating with platform_type : linux_ 05:24:16 INFO - Initialising browser for kraken test... 05:24:16 INFO - TEST-INFO | started process 23295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe2ilxR/profile http://localhost:41435/getInfo.html) 05:24:20 INFO - PROCESS | 23295 | __metrics Screen width/height:1600/1200 05:24:20 INFO - PROCESS | 23295 | colorDepth:24 05:24:20 INFO - PROCESS | 23295 | Browser inner width/height: 1024/697 05:24:20 INFO - PROCESS | 23295 | __metrics 05:24:21 ERROR - PROCESS | 23295 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 05:24:21 INFO - TEST-INFO | 23295: exit 0 05:24:21 INFO - Browser initialized. 05:24:21 INFO - Running cycle 1/1 for kraken test... 05:24:21 INFO - TEST-INFO | started process 23413 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe2ilxR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:33 INFO - PROCESS | 23413 | RSS: Main: 164810752 05:24:33 INFO - PROCESS | 23413 | 05:24:36 INFO - PROCESS | 23413 | Cycle 1(1): loaded http://localhost:41435/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41435/tests/kraken/driver.html?testName=audio-beat-detection) 05:24:37 INFO - PROCESS | 23413 | RSS: Main: 169873408 05:24:37 INFO - PROCESS | 23413 | 05:24:40 INFO - PROCESS | 23413 | Cycle 1(1): loaded http://localhost:41435/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41435/tests/kraken/driver.html?testName=audio-dft) 05:24:41 INFO - PROCESS | 23413 | RSS: Main: 168472576 05:24:41 INFO - PROCESS | 23413 | 05:24:43 INFO - PROCESS | 23413 | Cycle 1(1): loaded http://localhost:41435/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41435/tests/kraken/driver.html?testName=audio-fft) 05:24:44 INFO - PROCESS | 23413 | RSS: Main: 165031936 05:24:44 INFO - PROCESS | 23413 | 05:24:46 INFO - PROCESS | 23413 | Cycle 1(1): loaded http://localhost:41435/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41435/tests/kraken/driver.html?testName=audio-oscillator) 05:24:47 INFO - PROCESS | 23413 | RSS: Main: 165347328 05:24:47 INFO - PROCESS | 23413 | 05:24:49 INFO - PROCESS | 23413 | Cycle 1(1): loaded http://localhost:41435/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41435/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:24:50 INFO - PROCESS | 23413 | RSS: Main: 165687296 05:24:50 INFO - PROCESS | 23413 | 05:24:53 INFO - PROCESS | 23413 | Cycle 1(1): loaded http://localhost:41435/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41435/tests/kraken/driver.html?testName=imaging-darkroom) 05:24:54 INFO - PROCESS | 23413 | RSS: Main: 165552128 05:24:54 INFO - PROCESS | 23413 | 05:24:57 INFO - PROCESS | 23413 | Cycle 1(1): loaded http://localhost:41435/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41435/tests/kraken/driver.html?testName=imaging-desaturate) 05:24:58 INFO - PROCESS | 23413 | RSS: Main: 162725888 05:24:58 INFO - PROCESS | 23413 | 05:25:01 INFO - PROCESS | 23413 | Cycle 1(1): loaded http://localhost:41435/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41435/tests/kraken/driver.html?testName=json-parse-financial) 05:25:01 INFO - PROCESS | 23413 | RSS: Main: 165093376 05:25:01 INFO - PROCESS | 23413 | 05:25:03 INFO - PROCESS | 23413 | Cycle 1(1): loaded http://localhost:41435/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41435/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:25:04 INFO - PROCESS | 23413 | RSS: Main: 165216256 05:25:04 INFO - PROCESS | 23413 | 05:25:06 INFO - PROCESS | 23413 | Cycle 1(1): loaded http://localhost:41435/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41435/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:25:06 INFO - PROCESS | 23413 | RSS: Main: 165437440 05:25:06 INFO - PROCESS | 23413 | 05:25:09 INFO - PROCESS | 23413 | Cycle 1(1): loaded http://localhost:41435/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41435/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:25:09 INFO - PROCESS | 23413 | RSS: Main: 166170624 05:25:09 INFO - PROCESS | 23413 | 05:25:12 INFO - PROCESS | 23413 | Cycle 1(1): loaded http://localhost:41435/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:25:13 INFO - PROCESS | 23413 | RSS: Main: 166293504 05:25:13 INFO - PROCESS | 23413 | 05:25:16 INFO - PROCESS | 23413 | Cycle 1(1): loaded http://localhost:41435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:25:16 INFO - PROCESS | 23413 | RSS: Main: 166371328 05:25:16 INFO - PROCESS | 23413 | 05:25:18 INFO - PROCESS | 23413 | Cycle 1(1): loaded http://localhost:41435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41435/tests/kraken/driver.html?testName=ai-astar) 05:25:18 INFO - PROCESS | 23413 | RSS: Main: 167100416 05:25:18 INFO - PROCESS | 23413 | 05:25:18 INFO - PROCESS | 23413 | __start_tp_report 05:25:18 INFO - PROCESS | 23413 | _x_x_mozilla_page_load 05:25:18 INFO - PROCESS | 23413 | _x_x_mozilla_page_load_details 05:25:18 INFO - PROCESS | 23413 | |i|pagename|runs| 05:25:18 INFO - PROCESS | 23413 | |0;ai-astar;106;115;111;115;117;114;118;114;114;115 05:25:18 INFO - PROCESS | 23413 | |1;audio-beat-detection;155;126;150;177;126;154;155;125;198;124 05:25:18 INFO - PROCESS | 23413 | |2;audio-dft;165;163;164;172;164;164;163;164;164;164 05:25:18 INFO - PROCESS | 23413 | |3;audio-fft;76;76;76;171;77;76;75;77;162;76 05:25:18 INFO - PROCESS | 23413 | |4;audio-oscillator;86;86;157;88;86;86;129;87;85;132 05:25:18 INFO - PROCESS | 23413 | |5;imaging-gaussian-blur;118;118;119;119;118;117;118;118;117;118 05:25:18 INFO - PROCESS | 23413 | |6;imaging-darkroom;148;149;148;147;147;148;148;150;149;149 05:25:18 INFO - PROCESS | 23413 | |7;imaging-desaturate;96;96;95;97;96;97;96;100;96;95 05:25:18 INFO - PROCESS | 23413 | |8;json-parse-financial;64;74;65;65;67;63;70;63;69;65 05:25:18 INFO - PROCESS | 23413 | |9;json-stringify-tinderbox;65;65;66;66;66;66;65;66;66;65 05:25:18 INFO - PROCESS | 23413 | |10;stanford-crypto-aes;82;84;82;80;80;80;79;83;87;82 05:25:18 INFO - PROCESS | 23413 | |11;stanford-crypto-ccm;143;156;135;148;136;131;135;138;156;133 05:25:18 INFO - PROCESS | 23413 | |12;stanford-crypto-pbkdf2;168;169;173;173;172;171;172;171;169;171 05:25:18 INFO - PROCESS | 23413 | |13;stanford-crypto-sha256-iterative;70;73;71;70;69;69;69;68;68;69 05:25:18 INFO - PROCESS | 23413 | __end_tp_report 05:25:18 INFO - PROCESS | 23413 | __start_cc_report 05:25:18 INFO - PROCESS | 23413 | _x_x_mozilla_cycle_collect,979 05:25:18 INFO - PROCESS | 23413 | __end_cc_report 05:25:18 INFO - PROCESS | 23413 | __startTimestamp1470745518862__endTimestamp 05:25:18 INFO - PROCESS | 23413 | 05:25:18 INFO - PROCESS | 23413 | ------- Summary: start ------- 05:25:18 INFO - PROCESS | 23413 | Number of tests: 14 05:25:18 INFO - PROCESS | 23413 | 05:25:18 INFO - PROCESS | 23413 | [#0] ai-astar Cycles:10 Average:113.90 Median:115.00 stddev:3.35 (2.9%) stddev-sans-first:1.99 05:25:18 INFO - PROCESS | 23413 | Values: 106.0 115.0 111.0 115.0 117.0 114.0 118.0 114.0 114.0 115.0 05:25:18 INFO - PROCESS | 23413 | 05:25:18 INFO - PROCESS | 23413 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:154.50 stddev:24.81 (16.1%) stddev-sans-first:26.22 05:25:18 INFO - PROCESS | 23413 | Values: 155.0 126.0 150.0 177.0 126.0 154.0 155.0 125.0 198.0 124.0 05:25:18 INFO - PROCESS | 23413 | 05:25:18 INFO - PROCESS | 23413 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:2.63 (1.6%) stddev-sans-first:2.78 05:25:18 INFO - PROCESS | 23413 | Values: 165.0 163.0 164.0 172.0 164.0 164.0 163.0 164.0 164.0 164.0 05:25:18 INFO - PROCESS | 23413 | 05:25:18 INFO - PROCESS | 23413 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.00 stddev:38.17 (50.2%) stddev-sans-first:39.91 05:25:18 INFO - PROCESS | 23413 | Values: 76.0 76.0 76.0 171.0 77.0 76.0 75.0 77.0 162.0 76.0 05:25:18 INFO - PROCESS | 23413 | 05:25:18 INFO - PROCESS | 23413 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:86.00 stddev:26.64 (31.0%) stddev-sans-first:27.60 05:25:18 INFO - PROCESS | 23413 | Values: 86.0 86.0 157.0 88.0 86.0 86.0 129.0 87.0 85.0 132.0 05:25:18 INFO - PROCESS | 23413 | 05:25:18 INFO - PROCESS | 23413 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 05:25:18 INFO - PROCESS | 23413 | Values: 118.0 118.0 119.0 119.0 118.0 117.0 118.0 118.0 117.0 118.0 05:25:18 INFO - PROCESS | 23413 | 05:25:18 INFO - PROCESS | 23413 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 05:25:18 INFO - PROCESS | 23413 | Values: 148.0 149.0 148.0 147.0 147.0 148.0 148.0 150.0 149.0 149.0 05:25:18 INFO - PROCESS | 23413 | 05:25:18 INFO - PROCESS | 23413 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.43 (1.5%) stddev-sans-first:1.51 05:25:18 INFO - PROCESS | 23413 | Values: 96.0 96.0 95.0 97.0 96.0 97.0 96.0 100.0 96.0 95.0 05:25:18 INFO - PROCESS | 23413 | 05:25:18 INFO - PROCESS | 23413 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:66.00 stddev:3.54 (5.4%) stddev-sans-first:3.63 05:25:18 INFO - PROCESS | 23413 | Values: 64.0 74.0 65.0 65.0 67.0 63.0 70.0 63.0 69.0 65.0 05:25:18 INFO - PROCESS | 23413 | 05:25:18 INFO - PROCESS | 23413 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 05:25:18 INFO - PROCESS | 23413 | Values: 65.0 65.0 66.0 66.0 66.0 66.0 65.0 66.0 66.0 65.0 05:25:18 INFO - PROCESS | 23413 | 05:25:18 INFO - PROCESS | 23413 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:2.38 (2.9%) stddev-sans-first:2.52 05:25:18 INFO - PROCESS | 23413 | Values: 82.0 84.0 82.0 80.0 80.0 80.0 79.0 83.0 87.0 82.0 05:25:18 INFO - PROCESS | 23413 | 05:25:18 INFO - PROCESS | 23413 | [#11] stanford-crypto-ccm Cycles:10 Average:141.10 Median:140.50 stddev:9.27 (6.6%) stddev-sans-first:9.80 05:25:18 INFO - PROCESS | 23413 | Values: 143.0 156.0 135.0 148.0 136.0 131.0 135.0 138.0 156.0 133.0 05:25:18 INFO - PROCESS | 23413 | 05:25:18 INFO - PROCESS | 23413 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.90 Median:171.50 stddev:1.73 (1.0%) stddev-sans-first:1.48 05:25:18 INFO - PROCESS | 23413 | Values: 168.0 169.0 173.0 173.0 172.0 171.0 172.0 171.0 169.0 171.0 05:25:18 INFO - PROCESS | 23413 | 05:25:18 INFO - PROCESS | 23413 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.50 stddev:1.51 (2.2%) stddev-sans-first:1.59 05:25:18 INFO - PROCESS | 23413 | Values: 70.0 73.0 71.0 70.0 69.0 69.0 69.0 68.0 68.0 69.0 05:25:18 INFO - PROCESS | 23413 | -------- Summary: end -------- 05:25:18 INFO - PROCESS | 23413 | 05:25:19 INFO - TEST-INFO | 23413: exit 0 05:25:19 INFO - TEST-OK | kraken | took 63476ms 05:25:19 INFO - SUITE-END | took 1180s 05:25:20 INFO - Completed test suite (00:19:40) 05:25:20 INFO - javascript benchmark 05:25:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6354.445330184914, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2693.757561819436, 2698.1231099892534, 2710.986445067774, 2724.6457960465136, 2740.7122252163535, 4691.953080469194, 4835.830745923893, 4855.5872750816225, 4872.610191184705, 4921.311016457695, 4802.111609352272, 4826.638002149835, 4867.853964381065, 4870.220764677652, 4903.215485522317, 4421.867343979678, 4500.212462818994, 4511.8646440606835, 4597.563231493003, 4628.861134165981, 4594.58648721615, 4603.769811509428, 4614.607758340545, 4625.098105869357, 4635.976820115911, 4332.155229730172, 4428.645708343325, 4457.175422546807, 4536.54634536547, 4546.909061818778, 4527.207738645724, 4550.0, 4557.589816916494, 4568.611668008223, 4573.359729637853, 4420.182266280748, 4457.420535330386, 4494.37078808967, 4495.527969563182, 4513.7743112844555, 4669.88325291867, 4766.404199475066, 4781.306710526954, 4867.367242258484, 4900.803967841318, 5202.609804264695, 5202.791888324463, 5229.895402091937, 5239.240310155044, 5258.92111618326, 5232.895342093175, 5243.4232234454175, 5244.5279924806955, 5266.315379000744, 5283.920741188886, 4705.0, 4849.078675051729, 4856.150173719656, 4891.608671306287, 4929.901401971941, 5441.755121019563, 5445.346558412936, 5453.372862120827, 5486.670799752028, 5498.780048798003, 5225.085610018232, 5232.529072383428, 5232.973835130876, 5246.0557099721655, 5288.0, 5042.899142017139, 5151.0, 5224.634275600672, 5296.947030529723, 5304.973475132677, 5200.869978250498, 5209.47905209476, 5214.661047031931, 5215.713135777492, 5260.421353651095, 5152.4847515248175, 5174.870628234325, 5189.195674670432, 5196.038732834438, 5216.321878155815, 4245.172191422705, 4301.247281725686, 4327.913441731148, 4333.869983900425, 4365.9126817463475, 3800.201957588882, 3801.6388443097862, 3809.580946095927, 3822.808859557011, 3845.5577608575372, 4501.909961800746, 4524.932126018112, 4528.660350473728, 4554.931676024862, 4559.088182363541, 5080.49195080489, 5194.68831870089, 5199.584033277329, 5238.292830467838, 5256.973715131477, 4561.110583436264, 4585.0, 4589.288660257599, 4608.078384323148, 4624.260118381043, 4712.5758681718125, 4718.504557021532, 4724.740139292303, 4741.857744267678, 4778.689385189951, 4807.735574543363, 4873.926891096566, 4942.604591632733, 4951.925721114114, 5022.723750193774, 5283.630145889751, 5292.153255479105, 5293.894122117459, 5300.734963251745, 5330.520253177233, 4972.701637901738, 4994.625403094709, 4994.825181118788, 5003.249512573143, 5030.547250747451, 4979.278004689372, 5115.309433226466, 5129.74351282427, 5186.559142472932, 5192.480751924928, 5286.788528458818, 5289.233061206027, 5289.2330612061805, 5296.258523806593, 5325.068113080118, 5104.897902042013, 5106.387233532, 5113.309703190171, 5115.079285728604, 5165.767540460613, 4889.853304400874, 5013.548780609617, 5097.903950650628, 5106.157484015096, 5107.182850743863, 5010.0, 5056.140456122542, 5056.241563765465, 5082.567981721595, 5116.692998420107, 5067.746612669425, 5118.257852611425, 5154.845354639367, 5158.561522270649, 5207.869803254949, 4788.880277993078, 5019.874503137451, 5030.245463180552, 5091.87270318245, 5101.336826212569], "value": 4805.184196194689, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.4935459377373, 559.9636023658462, 575.5079407106923, 580.4282781460261, 593.187333353306, 34758.30483390334, 39419.40870886939, 39437.40843887344, 39441.408378874265, 39548.60451395485, 39876.601233987654, 40270.39594406086, 40335.0, 40444.393334100016, 40453.79773101138, 7567.810804729885, 7782.105057918327, 7788.260115289038, 7799.220077992212, 7802.102758182797, 7722.189170137139, 7803.765887023398, 7812.257835505618, 7820.217978202191, 7831.804204894895, 7773.1449540550775, 7780.8832867507035, 7817.687292508293, 7839.333656639164, 7841.843163136734, 7767.184445633212, 7780.299773020399, 7787.260210280015, 7791.844163116706, 7795.9220407795765, 7696.345810606105, 7750.651220695082, 7767.805804854924, 7814.218578142197, 7843.37253019757, 36850.81574592137, 37060.44409333862, 37477.62522374769, 37489.25021499555, 37516.06209844748, 2619.2796980830235, 3001.9699803002127, 3036.4686179918426, 3060.3573249617607, 3082.799618024821, 27760.583591246148, 27941.720582794114, 28243.717562824313, 28340.29149271264, 28461.430771384457, 3360.1599600099976, 3361.462166053444, 3408.522806807049, 3505.6319086495805, 3513.2270900401872, 226342.0, 226573.0, 227063.8646806772, 227209.0, 227836.0, 32066.83966580199, 32190.67809321877, 32211.35577288441, 32248.0, 32255.0, 32931.34137317288, 33908.660913391046, 34057.48913766295, 35215.29569408597, 35525.0, 14584.270786460847, 14701.55895323142, 14703.338349774285, 14734.484293049905, 14809.555713328617, 11014.889851101387, 11229.831552526719, 11238.0, 11240.0, 11240.887591124148, 18008.279668813102, 18055.923568789494, 18061.90969045173, 18170.727439088423, 18326.816731832776, 6707.770649759156, 6966.651667416711, 7009.158900931819, 7037.753678621224, 7060.717571297193, 715.7029832619509, 720.7405334079727, 747.3759410891857, 816.9918300816915, 856.1267507142679, 23507.88246058759, 24333.36996593185, 24592.877035615064, 24606.876965615058, 24715.134970275954, 830.6594296338473, 866.2550206822128, 905.2667339455063, 918.2286879021653, 939.96710115147, 12627.494900204072, 13103.344832758325, 13191.274479903506, 13196.406161722745, 13298.468061277634, 406986.0, 413665.0, 415464.0, 418140.0, 418575.0, 51368.0, 51914.48085519097, 52090.73954630203, 52241.7387913058, 52249.0, 1167.1129941244715, 1196.5811965811897, 1218.6100447856777, 1222.0895432902544, 1226.3929354969348, 23547.411314716584, 24307.0, 24706.629400558646, 24717.887695053407, 24889.128880489097, 42633.36049959315, 43492.0, 43545.0, 43610.34584481299, 43695.78152109219, 380165.0, 380347.0, 381578.0, 381654.0, 382353.0, 23028.53942921099, 23506.882465588245, 23676.0, 25301.114460993776, 25722.742772572034, 42107.36838947357, 42407.151856963304, 42565.787171063945, 43153.0, 43555.56444435515, 36449.45325820062, 36483.452748209325, 36598.0, 36869.0, 37335.25329493449, 34768.0, 34921.12697182591, 35074.82462587773, 35234.0, 35334.823325883204, 30231.244218894702, 30504.84747576248, 30680.846595766878, 31063.534046989764, 31570.684293156773, 30722.23194420068, 32675.183120422178, 33308.0, 33760.49359259564, 33881.66118338884, 22561.435964100372, 22821.88589057044, 22903.427414314774, 23142.42143946415, 23351.532969340857], "value": 16685.903552516622, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.68077071021435, 366.364357839149, 370.7997681252124, 379.66779068315225, 380.2565983502253, 15853.52439426816, 17296.91351543242, 17567.560810979718, 17807.82192178078, 17860.196291166896, 16969.745453818203, 17202.0, 17715.91142044288, 17867.28530858764, 17877.91061044696, 4985.252212168177, 5168.9224661630105, 5174.172132458807, 5181.6113791465605, 5199.064168449678, 3797.221569578244, 5183.248428977796, 5707.315122185343, 5954.047352423613, 5988.251468566429, 6004.969975150118, 6027.698615069251, 6028.306744724369, 6036.396360363972, 6059.484943779784, 5935.0, 6028.0, 6071.4839238664545, 6075.605085669462, 6102.481289090389, 5239.973800130975, 5274.604404669665, 5284.497972692588, 5290.920636190422, 5299.73501324936, 20699.79300206994, 21191.25830595937, 21329.146834126615, 21357.252496162717, 21450.78549214519, 2007.718919351292, 2197.9890100549555, 2198.912043518257, 2315.2012555668266, 2408.2654790288957, 13555.96660500923, 13722.313884305844, 13802.723945521033, 13868.722625547534, 14053.859461405358, 1684.5872761173468, 1702.9829701702947, 1724.1465474590034, 1730.3251731824598, 1732.826717328257, 43251.0, 43424.78287608573, 65706.67146664285, 66887.33112668908, 68455.65772171157, 9043.819123617492, 9298.674546390845, 9384.57769400365, 9463.0, 9801.099450274862, 12768.425420856083, 12771.169873958162, 12779.105462617528, 12802.743945121232, 12818.487260509663, 7208.35124838767, 7258.0927384076995, 7271.963640181765, 7394.519356241827, 7513.323800857949, 6952.513324067267, 7060.505764596429, 7139.607321597362, 7154.284571542804, 7388.261173882569, 5940.287165540163, 5949.613275137102, 6027.427394397525, 6057.697115144225, 6129.908051379233, 1564.3507944203257, 1632.71427500187, 1736.9392071277698, 1758.0113806528952, 1776.1474492243794, 668.4418510543751, 745.9477836551498, 775.3835700618022, 775.9534427934342, 794.7734895554739, 15956.680866382607, 16328.510144695678, 16339.836601633831, 16396.50810475664, 16627.584310392336, 739.3863093632273, 739.7928579997609, 745.02401853572, 765.1927216786344, 783.3145997252404, 8006.359491240687, 9317.394369366106, 9372.39079459833, 9433.858492122486, 9578.521073946275, 404520.0, 406742.0, 408466.0, 409092.0, 422363.0, 71829.64085179541, 71910.0, 72575.27424725791, 74988.62505687437, 75857.24142758612, 918.1828172926234, 929.7303781903307, 958.5255298627225, 961.9038096190465, 963.7397902566267, 12162.0, 13229.0, 14448.855511444752, 14743.262836858328, 15115.168665723051, 35730.821345893106, 36698.44952325664, 37237.44143837791, 37436.62563374441, 37951.05122371963, 49139.508604914925, 49420.0, 49441.25838112503, 49542.50457495379, 49702.25446618231, 7276.527025743309, 7312.926870731225, 7328.633568321669, 7373.262673732584, 7897.68409263623, 10991.890081099407, 11050.171237157407, 11599.594014209462, 11606.361650108987, 11666.125040622157, 9014.098590140933, 9037.593308301273, 9350.719478415658, 9358.344915855825, 9444.338896277195, 10099.848502272325, 10429.165666746794, 10445.373277603368, 10470.424126673106, 10560.947195264282, 9453.101955314234, 9484.95257523708, 9806.451612903225, 9830.705078847646, 10189.592416303562, 7455.9627201865815, 7471.701131954661, 7608.543487390774, 7614.961925190339, 7717.803740420244, 9356.111169438893, 9527.809443811224, 9760.170385517311, 9796.85304720444, 10022.899771002489], "value": 8225.006340099622, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.794080887867, 1403.6561042544577, 1478.2682572126791, 1681.2182335214138, 1703.667784781968, 6531.2489063757685, 7171.605561694105, 7456.925430745691, 7846.99901525111, 7864.095629002666, 7478.102627684685, 7675.501092428988, 7833.764987050384, 7861.921380786191, 7894.3289820365335, 2084.7810979847127, 2140.2081229944865, 2152.1714140056115, 2152.6448136057534, 2153.321703663341, 2096.2348742708878, 2134.583756167548, 2184.3010236724253, 2194.6378847490146, 2207.845450818443, 2133.264023911748, 2138.112683236463, 2154.859934104286, 2163.0, 2197.2090047582938, 2081.9687704684443, 2086.634838903201, 2092.184048221195, 2092.7070210170587, 2094.350751267112, 2044.3253726270295, 2109.4093653776968, 2121.140937920145, 2124.2246579998346, 2133.25336132354, 7868.0558332999835, 7881.448298619041, 7882.763517094439, 7897.447178697494, 7906.80232994174, 4478.977605111986, 4545.931811022837, 4621.3299071634765, 4622.1911165546235, 4624.237000894848, 2799.174243598143, 2883.0774152271283, 2927.6486821581548, 2932.5014747492764, 2937.089502254308, 863.9179277968583, 920.5581320965907, 926.8053708721177, 928.215657769184, 975.0590679993769, 10470.110040646554, 10731.731706707316, 10746.570137194503, 10755.51600177986, 10766.4616769162, 3998.5601583825755, 4128.896777580585, 4172.937405938914, 4259.318509038539, 4260.020195355086, 9118.270538356915, 9171.44971301724, 9173.0, 9200.447973121634, 9221.354505184572, 4446.133004064176, 4486.304622783408, 4503.527129651405, 4513.7066090704, 4524.117797029548, 3346.9330613387597, 4033.092554175287, 4033.2135233629747, 4049.8785036448953, 4124.587541245912, 3548.30807992439, 3549.680528752425, 3625.818709064536, 3687.11509237781, 3694.058015206105, 1113.6603335982604, 1133.4559411482535, 1150.4765331774022, 1151.424287856072, 1151.9366434845997, 745.6420917959301, 758.3440324119707, 813.0852790610563, 813.7151996801073, 826.9586520673943, 4849.199882019498, 4915.778789954461, 4953.851384458472, 5001.299818025479, 5093.567046801063, 397.3149042629576, 399.5684660566581, 403.8041549848321, 405.9675225981914, 429.6648614081022, 3413.8122403268057, 3415.624281329052, 3449.9655003449643, 3461.1866211440292, 3570.2145527983803, 9229.723108306762, 9509.096635819586, 9520.761980950532, 9592.95203523978, 9617.903820961841, 9559.426434413957, 9572.56923438447, 9574.808503829885, 9582.472963987047, 9626.807463850684, 7379.225181355988, 7455.515391499535, 7457.7016919323705, 7459.552426854515, 7465.365443937326, 4886.926696099633, 4890.217565189552, 4972.303877457087, 5004.924926126184, 5165.845024649267, 8703.0, 8724.214820666171, 8800.779980500538, 8849.69026084084, 8895.644174232959, 8878.422902511316, 8882.911170888467, 8890.911090889267, 8953.373263871466, 9037.141471560455, 6763.12079429671, 6807.489438292247, 7069.717211311696, 7130.42956563484, 7163.462740294603, 7121.038659780863, 7327.670254838438, 7374.373178279906, 7379.040724705968, 7389.630518473948, 6463.967680161569, 6724.4284235840505, 6760.932390676227, 6767.39093481589, 6867.004284378837, 6274.152989346379, 6462.063000864942, 6500.089987401673, 6632.734690612321, 6751.696173672099, 5884.470397664059, 6017.247844019497, 6032.245969253843, 6038.064100064497, 6048.909266361096, 4286.657067434536, 4476.373307736984, 4477.306017567283, 4485.887852803706, 4512.323151527297, 4387.780610969375, 4467.396901418397, 4470.731756094515, 4615.953840461687, 4709.458412282632], "value": 3991.936534251863, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.4700304436792, 296.6114390148905, 297.4912898942809, 301.32352867811767, 303.74030204175415, 5014.272930425091, 5076.720780357079, 5081.542661160494, 5092.847214583564, 5103.668261562996, 4997.850064498062, 5002.924956125652, 5006.421692828197, 5019.799208031674, 5026.572741316983, 3683.5763887152984, 3795.2219794942107, 3858.7298889077774, 3908.687305015592, 3909.824057917386, 3898.434726964588, 3899.083715326896, 3905.964919296389, 3911.8630847920326, 3915.6280153385383, 3880.8835734927998, 3888.4361767543687, 3896.5713771485116, 3898.2203559288114, 3899.181171953893, 3768.246350729865, 3843.7693738375788, 3869.555001174873, 3879.72841901067, 3895.5520115186832, 3386.4412371958597, 3396.0, 3399.5750531183603, 3402.404579198655, 3409.147713071732, 4865.245886887538, 4881.5606595406225, 4886.193778026622, 4888.973315603692, 4892.529272717255, 4316.589923957219, 4420.977895110536, 4424.292113261863, 4433.179861725559, 4437.245668236407, 5216.504432078947, 5227.0, 5234.7120908350025, 5238.68567885928, 5239.502247286502, 3709.1283548366114, 3712.6472985066375, 3712.981435092834, 3715.8327875245677, 3721.5162028936065, 5472.5621950243885, 5483.287172667568, 5486.561075113981, 5497.697626630534, 5506.80726174586, 3591.982040089783, 3797.5632802227547, 3815.7138214634015, 3820.9617903821163, 3828.9617103829164, 3836.462895194675, 3838.0, 3893.96106038936, 3896.123372241223, 3897.317969355408, 4432.15789000089, 4439.534953465413, 4448.5551444855255, 4449.777511124431, 4477.3731677565165, 5067.366579177603, 5217.000224870639, 5285.947140528546, 5289.3652761668845, 5290.249070483327, 1340.2695530935664, 1358.8980826438058, 1361.06766864696, 1365.2491129878526, 1366.5558693424678, 831.9916800831915, 860.7476122242123, 864.4640322999654, 866.4541338956543, 870.8519551676103, 4378.255696531597, 4529.932051019237, 4659.904922343247, 4675.625949923998, 4681.414823147106, 5404.83785486436, 5440.238366628675, 5440.422277539548, 5440.863978400493, 5458.563314934796, 4596.862094137181, 4642.117997580449, 4670.12787135909, 4680.251159814414, 4682.508336624674, 2707.5667893137, 2867.5125228711167, 2888.5378339466006, 2892.8139462820563, 2895.218291061444, 5179.326687530597, 5186.896262074737, 5199.6880187188135, 5201.323827902348, 5207.739613019334, 5283.445238250005, 5595.468430499096, 5624.465675760796, 5630.915536266959, 5638.0, 5156.92264616031, 5168.896622067613, 5174.689518628819, 5178.197379406198, 5182.948170518322, 5437.429069947757, 5444.292242008513, 5458.699771512446, 5466.3986961435, 5477.0, 5157.638965272545, 5328.350080195079, 5352.5450336721815, 5359.758810853443, 5365.3293338332705, 5145.742712864267, 5151.0, 5153.922691159561, 5166.689998600096, 5168.638195326291, 3739.6073412291316, 3762.548494180606, 3769.4157405602177, 3774.414965680324, 3787.886363409102, 5315.6279060465395, 5456.263404440509, 5462.945370546403, 5474.39781624029, 5476.589255805751, 5276.234945932895, 5277.2875661785165, 5279.260903473593, 5291.682499050069, 5302.950803288048, 5280.656757310762, 5280.84157475261, 5284.973575132253, 5293.570735901362, 5315.574754019746, 5026.899462010812, 5150.587952963829, 5176.223566465061, 5206.479352064915, 5230.293910322058, 5069.290299358019, 5205.843824685266, 5251.396089449762, 5273.815416460406, 5326.36083669962, 5185.637005409736, 5193.0, 5204.609654275869, 5210.557102646166, 5212.609054321017], "value": 3954.084611072102, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.6436325492564, 620.2587907450599, 624.378743150565, 626.2141013028647, 659.4032400677389, 11846.703832404195, 12762.617121486346, 12833.743325133491, 12833.743325133504, 12846.357682115904, 12018.819717704242, 12125.454354554044, 12127.75744485112, 12133.514659413613, 12159.27044377338, 744.4491076603315, 750.8610906982199, 764.6711913877031, 777.1024466740923, 781.488125277941, 767.87330090535, 771.1363273134069, 771.9343855772266, 773.246085067058, 776.6854423958306, 819.1317203764029, 820.5035953248289, 822.9300509456704, 823.283743143466, 826.0417915218347, 808.0505406147753, 810.4165001199127, 813.4143416739968, 815.1888870573817, 816.7263966571176, 596.749365266589, 597.6503745309, 597.692188522911, 598.0670154558902, 598.141666708275, 12618.621441356774, 12629.87370126296, 12632.30522321272, 12646.74706505874, 12652.68368290791, 12917.87082129176, 13055.151415157985, 13290.867091329059, 13635.318234088256, 13723.725525489433, 10074.395536267773, 10173.287869849113, 10433.16534677224, 10667.83998240027, 10690.839637405368, 3185.2673885006348, 3210.293735378213, 3285.917852053694, 3301.5212794144954, 3347.0, 59912.0, 61268.0, 61718.38281617171, 62097.0, 62938.68530657318, 9796.706098816905, 10187.796244075076, 10190.0, 10226.59093636261, 10317.535710893027, 17618.559536011446, 17921.0, 17925.193366298547, 18009.7298540522, 18181.909090454465, 6408.455281301141, 6454.6449945252525, 6535.803925882231, 6554.8361290968105, 6632.1046658701425, 3564.7682900611376, 3603.657652523006, 3689.6494832990825, 3708.4622729704042, 3735.7789069277483, 2958.556216567532, 3090.891818786332, 3101.937961240808, 3103.875844966176, 3104.037748298035, 567.1549391406857, 594.4709208804168, 600.7476859718929, 616.5868867858545, 620.6679426506797, 471.37778132864975, 521.1531261699738, 533.5304931660114, 542.8941356435536, 554.8973439913628, 7363.374113200438, 8095.55474448911, 8166.877496837552, 8417.989841219092, 8451.830963380698, 463.3975831419209, 503.9521245481673, 515.3231691878474, 581.2937281203274, 583.6527266276559, 3855.4216867470104, 3941.4481972523868, 3992.5807790182193, 3999.300122478555, 4248.129133527619, 85365.0, 98421.50789246008, 100602.0, 100625.0, 101315.49342253241, 85588.14411855926, 85714.0, 86356.13643863481, 86819.65901705016, 87614.56192718996, 73914.0, 76477.0, 76757.6162119197, 77940.22059779442, 79658.0, 7960.4825686330205, 7969.242921922408, 8193.13972032928, 8228.629711663109, 8289.253967142986, 43287.56712432835, 45116.0, 45367.0, 45544.40594579174, 45894.77052614716, 58024.0, 58660.706696466244, 64246.0, 66128.33871661221, 66135.0, 9839.803203935739, 9891.950540247253, 9922.801543969224, 9925.156361709336, 10131.240156988108, 10480.895191047992, 10726.785464290826, 10874.293170943864, 10877.0, 10945.83581246298, 9540.904590954002, 9828.213742900407, 9835.21318294549, 9840.212782977487, 9887.209023278265, 9746.707598772047, 9952.452615106238, 10044.0, 10106.949465252626, 10407.167426606005, 9978.401295922267, 10134.695959121238, 10135.087842094246, 10404.115650169517, 10583.682489525327, 8493.278071364004, 8502.659893604186, 8625.827483450421, 8724.65101395937, 9076.909230907871, 8138.813474357214, 8243.381746368927, 8625.180607842245, 8660.39377243587, 8744.125587441205], "value": 6324.029139028683, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1582.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 111.0, 115.0, 117.0, 114.0, 118.0, 114.0, 114.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 126.0, 150.0, 177.0, 126.0, 154.0, 155.0, 125.0, 198.0, 124.0], "value": 149.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 164.0, 172.0, 164.0, 164.0, 163.0, 164.0, 164.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 171.0, 77.0, 76.0, 75.0, 77.0, 162.0, 76.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 157.0, 88.0, 86.0, 86.0, 129.0, 87.0, 85.0, 132.0], "value": 102.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 119.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 147.0, 147.0, 148.0, 148.0, 150.0, 149.0, 149.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 97.0, 96.0, 97.0, 96.0, 100.0, 96.0, 95.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 74.0, 65.0, 65.0, 67.0, 63.0, 70.0, 63.0, 69.0, 65.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 82.0, 80.0, 80.0, 80.0, 79.0, 83.0, 87.0, 82.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 156.0, 135.0, 148.0, 136.0, 131.0, 135.0, 138.0, 156.0, 133.0], "value": 141.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 173.0, 173.0, 172.0, 171.0, 172.0, 171.0, 169.0, 171.0], "value": 170.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 71.0, 70.0, 69.0, 69.0, 69.0, 68.0, 68.0, 69.0], "value": 69.6, "unit": "score"}]}]} 05:25:20 INFO - Return code: 0 05:25:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:25:20 ERROR - # TBPL SUCCESS # 05:25:20 INFO - Running post-action listener: _resource_record_post_action 05:25:20 INFO - [mozharness: 2016-08-09 12:25:20.196695Z] Finished run-tests step (success) 05:25:20 INFO - Running post-run listener: _resource_record_post_run 05:25:20 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 541749248; Read time: 12; Write time: 446384 05:25:20 INFO - TinderboxPrint: CPU usage
13.3% 05:25:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:25:20 INFO - TinderboxPrint: I/O write bytes / time
541,749,248 / 446,384 05:25:20 INFO - TinderboxPrint: CPU idle
8,279.8 (86.7%) 05:25:20 INFO - TinderboxPrint: CPU user
1,217.2 (12.7%) 05:25:20 INFO - TinderboxPrint: Swap in / out
0 / 0 05:25:20 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254128128; Read time: 0; Write time: 243892 05:25:20 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 287621120; Read time: 0; Write time: 202492 05:25:20 INFO - Running post-run listener: _upload_blobber_files 05:25:20 INFO - Blob upload gear active. 05:25:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:25:20 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 05:25:20 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:25:20 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:25:21 INFO - (blobuploader) - INFO - Open directory for files ... 05:25:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:25:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:25:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:21 INFO - (blobuploader) - INFO - Done attempting. 05:25:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:25:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:25:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:27 INFO - (blobuploader) - INFO - Done attempting. 05:25:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:25:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:25:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:30 INFO - (blobuploader) - INFO - Done attempting. 05:25:30 INFO - (blobuploader) - INFO - Iteration through files over. 05:25:30 INFO - Return code: 0 05:25:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:25:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:25:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/17b852473ee0ba53b4ce40f03c27d896847b1bd492f37cd11b1b8978110d78b29360974a39b7cda8fb4ef2b92ac71fa6baa85cc1e20af0cee27f5cee75cb5898", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8ea0a9ef9a197b16863353f3666d70c0f209fabc6c09fe89d8d1c6bf1fec11cd88290cdbd1539b70a5729184ce02faab6ccf19965776a49ba226abc4d7cf6e63", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7425694b63921fbf598a40fd5f63b56b2037f67811289ccbba392d0fcc8d54fd710eefbb705b0a03c54816f5cadc65bfc0055ed850ef5707f7115b4d34da6002"} 05:25:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:25:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:25:30 INFO - Contents: 05:25:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/17b852473ee0ba53b4ce40f03c27d896847b1bd492f37cd11b1b8978110d78b29360974a39b7cda8fb4ef2b92ac71fa6baa85cc1e20af0cee27f5cee75cb5898", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8ea0a9ef9a197b16863353f3666d70c0f209fabc6c09fe89d8d1c6bf1fec11cd88290cdbd1539b70a5729184ce02faab6ccf19965776a49ba226abc4d7cf6e63", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7425694b63921fbf598a40fd5f63b56b2037f67811289ccbba392d0fcc8d54fd710eefbb705b0a03c54816f5cadc65bfc0055ed850ef5707f7115b4d34da6002"} 05:25:30 INFO - Running post-run listener: copy_logs_to_upload_dir 05:25:30 INFO - Copying logs to upload dir... 05:25:30 INFO - mkdir: /builds/slave/test/build/upload/logs 05:25:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.775364 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-09 05:25:29.933110) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 05:25:29.936608) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667 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/Autoland-Non-PGO/sha512/17b852473ee0ba53b4ce40f03c27d896847b1bd492f37cd11b1b8978110d78b29360974a39b7cda8fb4ef2b92ac71fa6baa85cc1e20af0cee27f5cee75cb5898", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8ea0a9ef9a197b16863353f3666d70c0f209fabc6c09fe89d8d1c6bf1fec11cd88290cdbd1539b70a5729184ce02faab6ccf19965776a49ba226abc4d7cf6e63", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7425694b63921fbf598a40fd5f63b56b2037f67811289ccbba392d0fcc8d54fd710eefbb705b0a03c54816f5cadc65bfc0055ed850ef5707f7115b4d34da6002"} build_url:https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011326 build_url: 'https://queue.taskcluster.net/v1/task/eRVumpkIQgm2rJfQaC9TfA/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/Autoland-Non-PGO/sha512/17b852473ee0ba53b4ce40f03c27d896847b1bd492f37cd11b1b8978110d78b29360974a39b7cda8fb4ef2b92ac71fa6baa85cc1e20af0cee27f5cee75cb5898", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8ea0a9ef9a197b16863353f3666d70c0f209fabc6c09fe89d8d1c6bf1fec11cd88290cdbd1539b70a5729184ce02faab6ccf19965776a49ba226abc4d7cf6e63", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7425694b63921fbf598a40fd5f63b56b2037f67811289ccbba392d0fcc8d54fd710eefbb705b0a03c54816f5cadc65bfc0055ed850ef5707f7115b4d34da6002"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 05:25:29.965890) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:25:29.966522) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1470742434.979720-1101791667 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 05:25:30.051633) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 05:25:30.052283) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 05:25:30.052904) ========= ========= Total master_lag: 0.18 =========