builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-022 starttime: 1502450406.89 results: success (0) revision: 65826179c86e2a3538bcffd969556937e15688cd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-11 04:20:06.891038) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-11 04:20:06.891548) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-11 04:20:06.891839) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-11 04:20:06.926473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 04:20:06.926852) ========= 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=930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-11 04:20:07-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.6M=0s 2017-08-11 04:20:07 (67.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137307 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 04:20:07.079999) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 04:20:07.080393) ========= 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=930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017496 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 04:20:07.130368) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 04:20:07.130701) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 65826179c86e2a3538bcffd969556937e15688cd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 65826179c86e2a3538bcffd969556937e15688cd --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=930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-11 04:20:07,321 truncating revision to first 12 chars 2017-08-11 04:20:07,321 Setting DEBUG logging. 2017-08-11 04:20:07,321 attempt 1/10 2017-08-11 04:20:07,321 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/65826179c86e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-11 04:20:07,634 unpacking tar archive at: mozilla-central-65826179c86e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.610043 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 04:20:07.754118) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-11 04:20:07.754485) ========= script_repo_revision: 65826179c86e2a3538bcffd969556937e15688cd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-11 04:20:07.754887) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-11 04:20:07.755153) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-11 04:20:07.766056) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-11 04:20:07.766514) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:20:08 INFO - MultiFileLogger online at 20170811 04:20:08 in /builds/slave/test 04:20:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:20:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:20:08 INFO - {'append_to_log': False, 04:20:08 INFO - 'base_work_dir': '/builds/slave/test', 04:20:08 INFO - 'blob_upload_branch': 'Firefox', 04:20:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:20:08 INFO - 'branch': 'Firefox', 04:20:08 INFO - 'buildbot_json_path': 'buildprops.json', 04:20:08 INFO - 'code_coverage': False, 04:20:08 INFO - 'config_files': ('talos/linux_config.py',), 04:20:08 INFO - 'default_actions': ('clobber', 04:20:08 INFO - 'read-buildbot-config', 04:20:08 INFO - 'download-and-extract', 04:20:08 INFO - 'populate-webroot', 04:20:08 INFO - 'create-virtualenv', 04:20:08 INFO - 'install', 04:20:08 INFO - 'setup-mitmproxy', 04:20:08 INFO - 'run-tests'), 04:20:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:20:08 INFO - 'disable_ccov_upload': False, 04:20:08 INFO - 'download_minidump_stackwalk': True, 04:20:08 INFO - 'download_symbols': 'ondemand', 04:20:08 INFO - 'enable_stylo': False, 04:20:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:20:08 INFO - 'tooltool.py': '/tools/tooltool.py', 04:20:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:20:08 INFO - '/tools/misc-python/virtualenv.py')}, 04:20:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:20:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:20:08 INFO - 'gecko_profile': False, 04:20:08 INFO - 'gecko_profile_interval': 0, 04:20:08 INFO - 'installer_path': 'installer.exe', 04:20:08 INFO - 'log_level': 'info', 04:20:08 INFO - 'log_name': 'talos', 04:20:08 INFO - 'log_to_console': True, 04:20:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:20:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:20:08 INFO - 'opt_config_files': (), 04:20:08 INFO - 'pip_index': False, 04:20:08 INFO - 'suite': 'dromaeojs-e10s', 04:20:08 INFO - 'system_bits': '32', 04:20:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:20:08 INFO - 'title': 'talos-linux64-ix-022', 04:20:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:20:08 INFO - 'use_talos_json': True, 04:20:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:20:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:20:08 INFO - 'work_dir': 'build'} 04:20:08 INFO - [mozharness: 2017-08-11 11:20:08.066136Z] Running clobber step. 04:20:08 INFO - Running pre-action listener: _resource_record_pre_action 04:20:08 INFO - Running main action method: clobber 04:20:08 INFO - rmtree: /builds/slave/test/build 04:20:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:20:09 INFO - Running post-action listener: _resource_record_post_action 04:20:09 INFO - [mozharness: 2017-08-11 11:20:09.093430Z] Finished clobber step (success) 04:20:09 INFO - [mozharness: 2017-08-11 11:20:09.093533Z] Running read-buildbot-config step. 04:20:09 INFO - Running pre-action listener: _resource_record_pre_action 04:20:09 INFO - Running main action method: read_buildbot_config 04:20:09 INFO - Using buildbot properties: 04:20:09 INFO - { 04:20:09 INFO - "project": "", 04:20:09 INFO - "product": "firefox", 04:20:09 INFO - "who": "archaeopteryx@coole-files.de", 04:20:09 INFO - "installer_path": "public/build/target.tar.bz2", 04:20:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 04:20:09 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:20:09 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 04:20:09 INFO - "stage_platform": "linux64-stylosequential", 04:20:09 INFO - "basedir": "/builds/slave/test", 04:20:09 INFO - "buildnumber": 181, 04:20:09 INFO - "platform": "ubuntu64_hw_styloseq", 04:20:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:20:09 INFO - "slavebuilddir": "test", 04:20:09 INFO - "taskId": "dmedCv1mQySzHBoP7gYnFQ", 04:20:09 INFO - "branch": "mozilla-central", 04:20:09 INFO - "script_repo_revision": "production", 04:20:09 INFO - "revision": "65826179c86e2a3538bcffd969556937e15688cd", 04:20:09 INFO - "slavename": "talos-linux64-ix-022", 04:20:09 INFO - "repo_path": "mozilla-central" 04:20:09 INFO - } 04:20:09 INFO - Finding installer, test and symbols from parent task. 04:20:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dmedCv1mQySzHBoP7gYnFQ'}, attempt #1 04:20:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dmedCv1mQySzHBoP7gYnFQ'}, attempt #1 04:20:10 INFO - Task dependencies: B9z7C-sPS86eeKbhbIEBpQ 04:20:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ'}, attempt #1 04:20:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.tar.bz2 04:20:10 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.test_packages.json 04:20:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.crashreporter-symbols.zip 04:20:10 INFO - Running post-action listener: _resource_record_post_action 04:20:10 INFO - [mozharness: 2017-08-11 11:20:10.476914Z] Finished read-buildbot-config step (success) 04:20:10 INFO - [mozharness: 2017-08-11 11:20:10.477138Z] Running download-and-extract step. 04:20:10 INFO - Running pre-action listener: _resource_record_pre_action 04:20:10 INFO - Running main action method: download_and_extract 04:20:10 INFO - mkdir: /builds/slave/test/build/tests 04:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:20:10 INFO - trying https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.test_packages.json 04:20:10 INFO - Downloading https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:20:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:20:11 INFO - Downloaded 989 bytes. 04:20:11 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:20:11 INFO - Using the following test package requirements: 04:20:11 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:20:11 INFO - u'common': [u'target.common.tests.zip'], 04:20:11 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:20:11 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:20:11 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:20:11 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:20:11 INFO - u'mozbase': [u'target.common.tests.zip'], 04:20:11 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:20:11 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:20:11 INFO - u'web-platform': [u'target.common.tests.zip', 04:20:11 INFO - u'target.web-platform.tests.tar.gz'], 04:20:11 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:20:11 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:20:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.common.tests.zip 04:20:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:20:11 INFO - Fetch https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.common.tests.zip into memory 04:20:12 INFO - Content-Length response header: 54036727 04:20:12 INFO - Bytes received: 54036727 04:20:23 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:20:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.common.tests.zip 04:20:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:20:23 INFO - Fetch https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.common.tests.zip into memory 04:20:24 INFO - Content-Length response header: 54036727 04:20:24 INFO - Bytes received: 54036727 04:20:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.talos.tests.zip 04:20:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:20:38 INFO - Fetch https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.talos.tests.zip into memory 04:20:39 INFO - Content-Length response header: 14496050 04:20:39 INFO - Bytes received: 14496050 04:20:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:20:39 INFO - trying https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.tar.bz2 04:20:39 INFO - Downloading https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:20:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:20:40 INFO - Downloaded 61834239 bytes. 04:20:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.tar.bz2 04:20:40 INFO - mkdir: /builds/slave/test/properties 04:20:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:20:40 INFO - Writing to file /builds/slave/test/properties/build_url 04:20:40 INFO - Contents: 04:20:40 INFO - build_url:https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.tar.bz2 04:20:40 INFO - Running post-action listener: _resource_record_post_action 04:20:40 INFO - Running post-action listener: set_extra_try_arguments 04:20:40 INFO - [mozharness: 2017-08-11 11:20:40.442969Z] Finished download-and-extract step (success) 04:20:40 INFO - [mozharness: 2017-08-11 11:20:40.443068Z] Running populate-webroot step. 04:20:40 INFO - Running pre-action listener: _resource_record_pre_action 04:20:40 INFO - Running main action method: populate_webroot 04:20:40 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:20:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:20:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:20:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:20:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:20:40 INFO - 'tests': ['damp', 'tps']}, 04:20:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:20:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:20:40 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:20:40 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:20:40 INFO - 'other-e10s': {'tests': ['a11yr', 04:20:40 INFO - 'ts_paint', 04:20:40 INFO - 'tpaint', 04:20:40 INFO - 'sessionrestore', 04:20:40 INFO - 'sessionrestore_many_windows', 04:20:40 INFO - 'sessionrestore_no_auto_restore', 04:20:40 INFO - 'tabpaint']}, 04:20:40 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:20:40 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:20:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:20:40 INFO - 'tsvgr_opacity', 04:20:40 INFO - 'tart', 04:20:40 INFO - 'tscrollx', 04:20:40 INFO - 'tsvg_static']}, 04:20:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:20:40 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:20:40 INFO - 'talos_options': ['--mitmproxy', 04:20:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:20:40 INFO - '--firstNonBlankPaint'], 04:20:40 INFO - 'tests': ['tp6_google', 04:20:40 INFO - 'tp6_youtube', 04:20:40 INFO - 'tp6_amazon', 04:20:40 INFO - 'tp6_facebook']}, 04:20:40 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:20:40 INFO - 'talos_options': ['--stylo', 04:20:40 INFO - '--mitmproxy', 04:20:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:20:40 INFO - '--firstNonBlankPaint'], 04:20:40 INFO - 'tests': ['tp6_google', 04:20:40 INFO - 'tp6_youtube', 04:20:40 INFO - 'tp6_amazon', 04:20:40 INFO - 'tp6_facebook']}, 04:20:40 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:20:40 INFO - 'talos_options': ['--stylo', 04:20:40 INFO - '--stylo-threads=1', 04:20:40 INFO - '--mitmproxy', 04:20:40 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:20:40 INFO - '--firstNonBlankPaint'], 04:20:40 INFO - 'tests': ['tp6_google', 04:20:40 INFO - 'tp6_youtube', 04:20:40 INFO - 'tp6_amazon', 04:20:40 INFO - 'tp6_facebook']}, 04:20:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:20:40 INFO - 'talos_options': ['--xperf_path', 04:20:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:20:40 INFO - 'tests': ['tp5n']}}} 04:20:40 INFO - Running post-action listener: _resource_record_post_action 04:20:40 INFO - [mozharness: 2017-08-11 11:20:40.451549Z] Finished populate-webroot step (success) 04:20:40 INFO - [mozharness: 2017-08-11 11:20:40.451640Z] Running create-virtualenv step. 04:20:40 INFO - Running pre-action listener: _resource_record_pre_action 04:20:40 INFO - Running main action method: create_virtualenv 04:20:40 INFO - Creating virtualenv /builds/slave/test/build/venv 04:20:40 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 04:20:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:20:40 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:20:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:20:40 INFO - Using real prefix '/usr' 04:20:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:20:41 INFO - Installing distribute.............................................................................................................................................................................................done. 04:20:43 INFO - Installing pip.................done. 04:20:43 INFO - Return code: 0 04:20:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:20:43 INFO - Reading from file tmpfile_stdout 04:20:43 INFO - Output received: 04:20:43 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:20:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:43 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/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 0xb6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeda700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed78a0>, '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 0xed87a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed8c30>, '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': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', '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 04:20:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 04:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:20:43 INFO - Using env: {'DISPLAY': ':0', 04:20:43 INFO - 'HOME': '/home/cltbld', 04:20:43 INFO - 'LANG': 'en_US.UTF-8', 04:20:43 INFO - 'LANGUAGE': 'en_US:en', 04:20:43 INFO - 'LOGNAME': 'cltbld', 04:20:43 INFO - 'MAIL': '/var/mail/cltbld', 04:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:43 INFO - 'MOZ_NO_REMOTE': '1', 04:20:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:43 INFO - 'NO_EM_RESTART': '1', 04:20:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:43 INFO - 'PWD': '/builds/slave/test', 04:20:43 INFO - 'SHELL': '/bin/bash', 04:20:43 INFO - 'SHLVL': '1', 04:20:43 INFO - 'TERM': 'linux', 04:20:43 INFO - 'TMOUT': '86400', 04:20:43 INFO - 'USER': 'cltbld', 04:20:43 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', 04:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:43 INFO - '_': '/tools/buildbot/bin/python'} 04:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:43 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 04:20:43 INFO - Cleaning up... 04:20:43 INFO - Return code: 0 04:20:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:43 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/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 0xb6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeda700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed78a0>, '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 0xed87a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed8c30>, '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': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', '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 04:20:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 04:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:20:43 INFO - Using env: {'DISPLAY': ':0', 04:20:43 INFO - 'HOME': '/home/cltbld', 04:20:43 INFO - 'LANG': 'en_US.UTF-8', 04:20:43 INFO - 'LANGUAGE': 'en_US:en', 04:20:43 INFO - 'LOGNAME': 'cltbld', 04:20:43 INFO - 'MAIL': '/var/mail/cltbld', 04:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:43 INFO - 'MOZ_NO_REMOTE': '1', 04:20:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:43 INFO - 'NO_EM_RESTART': '1', 04:20:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:43 INFO - 'PWD': '/builds/slave/test', 04:20:43 INFO - 'SHELL': '/bin/bash', 04:20:43 INFO - 'SHLVL': '1', 04:20:43 INFO - 'TERM': 'linux', 04:20:43 INFO - 'TMOUT': '86400', 04:20:43 INFO - 'USER': 'cltbld', 04:20:43 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', 04:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:43 INFO - '_': '/tools/buildbot/bin/python'} 04:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:43 INFO - Downloading/unpacking psutil>=3.1.1 04:20:43 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 04:20:43 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 04:20:43 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 04:20:43 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 04:20:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:20:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:44 INFO - Installing collected packages: psutil 04:20:44 INFO - Running setup.py install for psutil 04:20:44 INFO - building 'psutil._psutil_linux' extension 04:20:44 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 04:20:45 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 04:20:45 INFO - building 'psutil._psutil_posix' extension 04:20:45 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 04:20:45 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 04:20:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:45 INFO - Successfully installed psutil 04:20:45 INFO - Cleaning up... 04:20:45 INFO - Return code: 0 04:20:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:20:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:45 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/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 0xb6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeda700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed78a0>, '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 0xed87a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed8c30>, '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': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', '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 04:20:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 04:20:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:20:45 INFO - Using env: {'DISPLAY': ':0', 04:20:45 INFO - 'HOME': '/home/cltbld', 04:20:45 INFO - 'LANG': 'en_US.UTF-8', 04:20:45 INFO - 'LANGUAGE': 'en_US:en', 04:20:45 INFO - 'LOGNAME': 'cltbld', 04:20:45 INFO - 'MAIL': '/var/mail/cltbld', 04:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:45 INFO - 'MOZ_NO_REMOTE': '1', 04:20:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:45 INFO - 'NO_EM_RESTART': '1', 04:20:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:45 INFO - 'PWD': '/builds/slave/test', 04:20:45 INFO - 'SHELL': '/bin/bash', 04:20:45 INFO - 'SHLVL': '1', 04:20:45 INFO - 'TERM': 'linux', 04:20:45 INFO - 'TMOUT': '86400', 04:20:45 INFO - 'USER': 'cltbld', 04:20:45 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', 04:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:45 INFO - '_': '/tools/buildbot/bin/python'} 04:20:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:20:45 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 04:20:45 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 04:20:45 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 04:20:45 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 04:20:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:20:46 INFO - Installing collected packages: mozsystemmonitor 04:20:46 INFO - Running setup.py install for mozsystemmonitor 04:20:46 INFO - Successfully installed mozsystemmonitor 04:20:46 INFO - Cleaning up... 04:20:46 INFO - Return code: 0 04:20:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xb6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeda700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed78a0>, '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 0xed87a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed8c30>, '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': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', '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 04:20:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 04:20:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:20:46 INFO - Using env: {'DISPLAY': ':0', 04:20:46 INFO - 'HOME': '/home/cltbld', 04:20:46 INFO - 'LANG': 'en_US.UTF-8', 04:20:46 INFO - 'LANGUAGE': 'en_US:en', 04:20:46 INFO - 'LOGNAME': 'cltbld', 04:20:46 INFO - 'MAIL': '/var/mail/cltbld', 04:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:46 INFO - 'MOZ_NO_REMOTE': '1', 04:20:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:46 INFO - 'NO_EM_RESTART': '1', 04:20:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:46 INFO - 'PWD': '/builds/slave/test', 04:20:46 INFO - 'SHELL': '/bin/bash', 04:20:46 INFO - 'SHLVL': '1', 04:20:46 INFO - 'TERM': 'linux', 04:20:46 INFO - 'TMOUT': '86400', 04:20:46 INFO - 'USER': 'cltbld', 04:20:46 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', 04:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:46 INFO - '_': '/tools/buildbot/bin/python'} 04:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:47 INFO - Downloading/unpacking jsonschema==2.5.1 04:20:47 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 04:20:47 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 04:20:47 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 04:20:47 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 04:20:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:20:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:48 INFO - Downloading functools32-3.2.3-2.tar.gz 04:20:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:20:48 INFO - warning: no files found matching '*.txt' 04:20:48 INFO - no previously-included directories found matching 'build' 04:20:48 INFO - no previously-included directories found matching 'dist' 04:20:48 INFO - no previously-included directories found matching '.git*' 04:20:48 INFO - Installing collected packages: jsonschema, functools32 04:20:48 INFO - Running setup.py install for functools32 04:20:48 INFO - warning: no files found matching '*.txt' 04:20:48 INFO - no previously-included directories found matching 'build' 04:20:48 INFO - no previously-included directories found matching 'dist' 04:20:48 INFO - no previously-included directories found matching '.git*' 04:20:48 INFO - Successfully installed jsonschema functools32 04:20:48 INFO - Cleaning up... 04:20:48 INFO - Return code: 0 04:20:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xb6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeda700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed78a0>, '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 0xed87a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed8c30>, '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': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', '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 04:20:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 04:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:20:48 INFO - Using env: {'DISPLAY': ':0', 04:20:48 INFO - 'HOME': '/home/cltbld', 04:20:48 INFO - 'LANG': 'en_US.UTF-8', 04:20:48 INFO - 'LANGUAGE': 'en_US:en', 04:20:48 INFO - 'LOGNAME': 'cltbld', 04:20:48 INFO - 'MAIL': '/var/mail/cltbld', 04:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:48 INFO - 'MOZ_NO_REMOTE': '1', 04:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:48 INFO - 'NO_EM_RESTART': '1', 04:20:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:48 INFO - 'PWD': '/builds/slave/test', 04:20:48 INFO - 'SHELL': '/bin/bash', 04:20:48 INFO - 'SHLVL': '1', 04:20:48 INFO - 'TERM': 'linux', 04:20:48 INFO - 'TMOUT': '86400', 04:20:48 INFO - 'USER': 'cltbld', 04:20:48 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', 04:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:48 INFO - '_': '/tools/buildbot/bin/python'} 04:20:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:20:48 INFO - Cleaning up... 04:20:48 INFO - Return code: 0 04:20:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xb6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeda700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed78a0>, '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 0xed87a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed8c30>, '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': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', '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 04:20:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 04:20:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:20:48 INFO - Using env: {'DISPLAY': ':0', 04:20:48 INFO - 'HOME': '/home/cltbld', 04:20:48 INFO - 'LANG': 'en_US.UTF-8', 04:20:48 INFO - 'LANGUAGE': 'en_US:en', 04:20:48 INFO - 'LOGNAME': 'cltbld', 04:20:48 INFO - 'MAIL': '/var/mail/cltbld', 04:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:48 INFO - 'MOZ_NO_REMOTE': '1', 04:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:48 INFO - 'NO_EM_RESTART': '1', 04:20:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:48 INFO - 'PWD': '/builds/slave/test', 04:20:48 INFO - 'SHELL': '/bin/bash', 04:20:48 INFO - 'SHLVL': '1', 04:20:48 INFO - 'TERM': 'linux', 04:20:48 INFO - 'TMOUT': '86400', 04:20:48 INFO - 'USER': 'cltbld', 04:20:48 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', 04:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:48 INFO - '_': '/tools/buildbot/bin/python'} 04:20:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:49 INFO - Downloading/unpacking blobuploader==1.2.4 04:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:50 INFO - Downloading blobuploader-1.2.4.tar.gz 04:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:20:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:20:50 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 04:20:50 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 04:20:50 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 04:20:50 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 04:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:20:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:20:50 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 04:20:50 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 04:20:50 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 04:20:50 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 04:20:50 INFO - Downloading docopt-0.6.1.tar.gz 04:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:20:50 INFO - Installing collected packages: blobuploader, requests, docopt 04:20:50 INFO - Running setup.py install for blobuploader 04:20:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:20:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:20:50 INFO - Running setup.py install for requests 04:20:51 INFO - Running setup.py install for docopt 04:20:51 INFO - Successfully installed blobuploader requests docopt 04:20:51 INFO - Cleaning up... 04:20:51 INFO - Return code: 0 04:20:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:51 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/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 0xb6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeda700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed78a0>, '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 0xed87a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed8c30>, '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': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', '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 04:20:51 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:20:51 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:20:51 INFO - Using env: {'DISPLAY': ':0', 04:20:51 INFO - 'HOME': '/home/cltbld', 04:20:51 INFO - 'LANG': 'en_US.UTF-8', 04:20:51 INFO - 'LANGUAGE': 'en_US:en', 04:20:51 INFO - 'LOGNAME': 'cltbld', 04:20:51 INFO - 'MAIL': '/var/mail/cltbld', 04:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:51 INFO - 'MOZ_NO_REMOTE': '1', 04:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:51 INFO - 'NO_EM_RESTART': '1', 04:20:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:51 INFO - 'PWD': '/builds/slave/test', 04:20:51 INFO - 'SHELL': '/bin/bash', 04:20:51 INFO - 'SHLVL': '1', 04:20:51 INFO - 'TERM': 'linux', 04:20:51 INFO - 'TMOUT': '86400', 04:20:51 INFO - 'USER': 'cltbld', 04:20:51 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', 04:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:51 INFO - '_': '/tools/buildbot/bin/python'} 04:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:51 INFO - Running setup.py (path:/tmp/pip-_THRdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:51 INFO - Running setup.py (path:/tmp/pip-qwSqPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:51 INFO - Running setup.py (path:/tmp/pip-QoAn6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:51 INFO - Running setup.py (path:/tmp/pip-eMmy_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:51 INFO - Running setup.py (path:/tmp/pip-mU54LK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:51 INFO - Running setup.py (path:/tmp/pip-EBXJQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:52 INFO - Running setup.py (path:/tmp/pip-wZeOY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:52 INFO - Running setup.py (path:/tmp/pip-cCcSxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:52 INFO - Running setup.py (path:/tmp/pip-ud1fHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:52 INFO - Running setup.py (path:/tmp/pip-wREf9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:52 INFO - Running setup.py (path:/tmp/pip-5Co6Sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:52 INFO - Running setup.py (path:/tmp/pip-_vTUl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:52 INFO - Running setup.py (path:/tmp/pip-7WNoIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:52 INFO - Running setup.py (path:/tmp/pip-RQKh3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:52 INFO - Running setup.py (path:/tmp/pip-CwZhut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:52 INFO - Running setup.py (path:/tmp/pip-l8_uCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:52 INFO - Running setup.py (path:/tmp/pip-GthkJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:20:52 INFO - Running setup.py install for manifestparser 04:20:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:20:52 INFO - Running setup.py install for mozcrash 04:20:53 INFO - Running setup.py install for mozdebug 04:20:53 INFO - Running setup.py install for mozdevice 04:20:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:20:53 INFO - Running setup.py install for mozfile 04:20:53 INFO - Running setup.py install for mozhttpd 04:20:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:20:53 INFO - Running setup.py install for mozinfo 04:20:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:20:53 INFO - Running setup.py install for mozInstall 04:20:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:20:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:20:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:20:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:20:53 INFO - Running setup.py install for mozleak 04:20:53 INFO - Running setup.py install for mozlog 04:20:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:20:53 INFO - Running setup.py install for moznetwork 04:20:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:20:53 INFO - Running setup.py install for mozprocess 04:20:54 INFO - Running setup.py install for mozprofile 04:20:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:20:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:20:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:20:54 INFO - Running setup.py install for mozrunner 04:20:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:20:54 INFO - Running setup.py install for mozscreenshot 04:20:54 INFO - Running setup.py install for moztest 04:20:54 INFO - Running setup.py install for mozversion 04:20:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:20:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:20:54 INFO - Cleaning up... 04:20:54 INFO - Return code: 0 04:20:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:54 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/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 0xb6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeda700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed78a0>, '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 0xed87a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed8c30>, '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': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', '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 04:20:54 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:20:54 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:20:54 INFO - Using env: {'DISPLAY': ':0', 04:20:54 INFO - 'HOME': '/home/cltbld', 04:20:54 INFO - 'LANG': 'en_US.UTF-8', 04:20:54 INFO - 'LANGUAGE': 'en_US:en', 04:20:54 INFO - 'LOGNAME': 'cltbld', 04:20:54 INFO - 'MAIL': '/var/mail/cltbld', 04:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:54 INFO - 'MOZ_NO_REMOTE': '1', 04:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:54 INFO - 'NO_EM_RESTART': '1', 04:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:54 INFO - 'PWD': '/builds/slave/test', 04:20:54 INFO - 'SHELL': '/bin/bash', 04:20:54 INFO - 'SHLVL': '1', 04:20:54 INFO - 'TERM': 'linux', 04:20:54 INFO - 'TMOUT': '86400', 04:20:54 INFO - 'USER': 'cltbld', 04:20:54 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', 04:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:54 INFO - '_': '/tools/buildbot/bin/python'} 04:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:54 INFO - Running setup.py (path:/tmp/pip-SFhwCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:54 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)) 04:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:54 INFO - Running setup.py (path:/tmp/pip-MX_2S6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 04:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:54 INFO - Running setup.py (path:/tmp/pip-cxD0VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:55 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)) 04:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:55 INFO - Running setup.py (path:/tmp/pip-gR92ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 04:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:55 INFO - Running setup.py (path:/tmp/pip-v4Kgds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:55 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)) 04:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:55 INFO - Running setup.py (path:/tmp/pip-julxT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:55 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)) 04:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:55 INFO - Running setup.py (path:/tmp/pip-1Wsjjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 04:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:55 INFO - Running setup.py (path:/tmp/pip-9jjrJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 04:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:55 INFO - Running setup.py (path:/tmp/pip-lpAHrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:55 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)) 04:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:55 INFO - Running setup.py (path:/tmp/pip-z8LULS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 04:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:55 INFO - Running setup.py (path:/tmp/pip-L500jK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:55 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)) 04:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:55 INFO - Running setup.py (path:/tmp/pip-RhEyET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 04:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:55 INFO - Running setup.py (path:/tmp/pip-hI23LB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:55 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)) 04:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:55 INFO - Running setup.py (path:/tmp/pip-13FLlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 04:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:55 INFO - Running setup.py (path:/tmp/pip-czBXSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:55 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)) 04:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:55 INFO - Running setup.py (path:/tmp/pip-ep2y28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 04:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:56 INFO - Running setup.py (path:/tmp/pip-GaIUis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:56 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)) 04:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:20:56 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)) 04:20:56 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:20:56 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:20:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:57 INFO - Downloading blessings-1.6.tar.gz 04:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:20:57 INFO - Installing collected packages: blessings 04:20:57 INFO - Running setup.py install for blessings 04:20:57 INFO - Successfully installed blessings 04:20:57 INFO - Cleaning up... 04:20:57 INFO - Return code: 0 04:20:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:20:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:57 INFO - Reading from file tmpfile_stdout 04:20:57 INFO - Current package versions: 04:20:57 INFO - argparse == 1.2.1 04:20:57 INFO - blessings == 1.6 04:20:57 INFO - blobuploader == 1.2.4 04:20:57 INFO - docopt == 0.6.1 04:20:57 INFO - functools32 == 3.2.3-2 04:20:57 INFO - jsonschema == 2.5.1 04:20:57 INFO - manifestparser == 1.1 04:20:57 INFO - mozInstall == 1.13 04:20:57 INFO - mozcrash == 1.0 04:20:57 INFO - mozdebug == 0.1 04:20:57 INFO - mozdevice == 0.51 04:20:57 INFO - mozfile == 1.2 04:20:57 INFO - mozhttpd == 0.7 04:20:57 INFO - mozinfo == 0.10 04:20:57 INFO - mozleak == 0.1 04:20:57 INFO - mozlog == 3.5 04:20:57 INFO - moznetwork == 0.27 04:20:57 INFO - mozprocess == 0.25 04:20:57 INFO - mozprofile == 0.28 04:20:57 INFO - mozrunner == 6.13 04:20:57 INFO - mozscreenshot == 0.1 04:20:57 INFO - mozsystemmonitor == 0.3 04:20:57 INFO - moztest == 0.8 04:20:57 INFO - mozversion == 1.4 04:20:57 INFO - psutil == 3.1.1 04:20:57 INFO - requests == 1.2.3 04:20:57 INFO - wsgiref == 0.1.2 04:20:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:20:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:57 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/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 0xb6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeda700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed78a0>, '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 0xed87a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed8c30>, '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': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', '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 04:20:57 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:20:57 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:20:57 INFO - Using env: {'DISPLAY': ':0', 04:20:57 INFO - 'HOME': '/home/cltbld', 04:20:57 INFO - 'LANG': 'en_US.UTF-8', 04:20:57 INFO - 'LANGUAGE': 'en_US:en', 04:20:57 INFO - 'LOGNAME': 'cltbld', 04:20:57 INFO - 'MAIL': '/var/mail/cltbld', 04:20:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:57 INFO - 'MOZ_NO_REMOTE': '1', 04:20:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:57 INFO - 'NO_EM_RESTART': '1', 04:20:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:57 INFO - 'PWD': '/builds/slave/test', 04:20:57 INFO - 'SHELL': '/bin/bash', 04:20:57 INFO - 'SHLVL': '1', 04:20:57 INFO - 'TERM': 'linux', 04:20:57 INFO - 'TMOUT': '86400', 04:20:57 INFO - 'USER': 'cltbld', 04:20:57 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', 04:20:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:57 INFO - '_': '/tools/buildbot/bin/python'} 04:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:57 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)) 04:20:57 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)) 04:20:57 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)) 04:20:57 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)) 04:20:57 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)) 04:20:57 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)) 04:20:57 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)) 04:20:57 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)) 04:20:57 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)) 04:20:57 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:20:59 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)) 04:20:59 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)) 04:20:59 INFO - Installing collected packages: simplejson 04:20:59 INFO - Running setup.py install for simplejson 04:20:59 INFO - building 'simplejson._speedups' extension 04:20:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 04:20:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 04:21:00 INFO - Successfully installed simplejson 04:21:00 INFO - Cleaning up... 04:21:00 INFO - Return code: 0 04:21:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:00 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/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 0xb6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeda700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed78a0>, '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 0xed87a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed8c30>, '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': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', '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 04:21:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:21:00 INFO - Using env: {'DISPLAY': ':0', 04:21:00 INFO - 'HOME': '/home/cltbld', 04:21:00 INFO - 'LANG': 'en_US.UTF-8', 04:21:00 INFO - 'LANGUAGE': 'en_US:en', 04:21:00 INFO - 'LOGNAME': 'cltbld', 04:21:00 INFO - 'MAIL': '/var/mail/cltbld', 04:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:00 INFO - 'MOZ_NO_REMOTE': '1', 04:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:00 INFO - 'NO_EM_RESTART': '1', 04:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:00 INFO - 'PWD': '/builds/slave/test', 04:21:00 INFO - 'SHELL': '/bin/bash', 04:21:00 INFO - 'SHLVL': '1', 04:21:00 INFO - 'TERM': 'linux', 04:21:00 INFO - 'TMOUT': '86400', 04:21:00 INFO - 'USER': 'cltbld', 04:21:00 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', 04:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:00 INFO - '_': '/tools/buildbot/bin/python'} 04:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:21:00 INFO - Cleaning up... 04:21:00 INFO - Return code: 0 04:21:00 INFO - Running post-action listener: _resource_record_post_action 04:21:00 INFO - Running post-action listener: _start_resource_monitoring 04:21:00 INFO - Starting resource monitoring. 04:21:00 INFO - [mozharness: 2017-08-11 11:21:00.337884Z] Finished create-virtualenv step (success) 04:21:00 INFO - [mozharness: 2017-08-11 11:21:00.338400Z] Running install step. 04:21:00 INFO - Running pre-action listener: _resource_record_pre_action 04:21:00 INFO - Running main action method: install 04:21:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:21:00 INFO - Reading from file tmpfile_stdout 04:21:00 INFO - Detecting whether we're running mozinstall >=1.0... 04:21:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:21:00 INFO - Reading from file tmpfile_stdout 04:21:00 INFO - Output received: 04:21:00 INFO - Usage: mozinstall [options] installer 04:21:00 INFO - Options: 04:21:00 INFO - -h, --help show this help message and exit 04:21:00 INFO - -d DEST, --destination=DEST 04:21:00 INFO - Directory to install application into. [default: 04:21:00 INFO - "/builds/slave/test"] 04:21:00 INFO - --app=APP Application being installed. [default: firefox] 04:21:00 INFO - mkdir: /builds/slave/test/build/application 04:21:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:21:18 INFO - Reading from file tmpfile_stdout 04:21:18 INFO - Output received: 04:21:18 INFO - /builds/slave/test/build/application/firefox/firefox 04:21:18 INFO - Running post-action listener: _resource_record_post_action 04:21:18 INFO - [mozharness: 2017-08-11 11:21:18.675521Z] Finished install step (success) 04:21:18 INFO - [mozharness: 2017-08-11 11:21:18.675775Z] Running setup-mitmproxy step. 04:21:18 INFO - Running pre-action listener: _resource_record_pre_action 04:21:18 INFO - Running main action method: setup_mitmproxy 04:21:18 INFO - Skipping: mitmproxy is not required 04:21:18 INFO - Running post-action listener: _resource_record_post_action 04:21:18 INFO - [mozharness: 2017-08-11 11:21:18.677003Z] Finished setup-mitmproxy step (success) 04:21:18 INFO - [mozharness: 2017-08-11 11:21:18.677225Z] Running run-tests step. 04:21:18 INFO - Running pre-action listener: _resource_record_pre_action 04:21:18 INFO - Running pre-action listener: _set_gcov_prefix 04:21:18 INFO - Running main action method: run_tests 04:21:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:21:18 INFO - Python 2.7.3 04:21:18 INFO - Return code: 0 04:21:18 INFO - grabbing minidump binary from tooltool 04:21:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 04:21:18 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 0xed78a0>, '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 0xed87a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed8c30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:21:18 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 04:21:18 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 04:21:18 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 04:21:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:21:18 INFO - Return code: 0 04:21:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:21:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:21:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:21:18 INFO - ENV: RUST_BACKTRACE is now full 04:21:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:21:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:21:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 04:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 04:21:18 INFO - Using env: {'DISPLAY': ':0', 04:21:18 INFO - 'HOME': '/home/cltbld', 04:21:18 INFO - 'LANG': 'en_US.UTF-8', 04:21:18 INFO - 'LANGUAGE': 'en_US:en', 04:21:18 INFO - 'LOGNAME': 'cltbld', 04:21:18 INFO - 'MAIL': '/var/mail/cltbld', 04:21:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:21:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:18 INFO - 'MOZ_NO_REMOTE': '1', 04:21:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:21:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:18 INFO - 'NO_EM_RESTART': '1', 04:21:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:18 INFO - 'PWD': '/builds/slave/test', 04:21:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:21:18 INFO - 'RUST_BACKTRACE': 'full', 04:21:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:21:18 INFO - 'SHELL': '/bin/bash', 04:21:18 INFO - 'SHLVL': '1', 04:21:18 INFO - 'STYLO_FORCE_ENABLED': '1', 04:21:18 INFO - 'TERM': 'linux', 04:21:18 INFO - 'TMOUT': '86400', 04:21:18 INFO - 'USER': 'cltbld', 04:21:18 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323', 04:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:18 INFO - '_': '/tools/buildbot/bin/python'} 04:21:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 04:21:19 INFO - mozversion application_buildid: 20170811103911 04:21:19 INFO - mozversion application_changeset: 65826179c86e2a3538bcffd969556937e15688cd 04:21:19 INFO - mozversion application_display_name: Nightly 04:21:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:21:19 INFO - mozversion application_name: Firefox 04:21:19 INFO - mozversion application_remotingname: firefox 04:21:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:21:19 INFO - mozversion application_vendor: Mozilla 04:21:19 INFO - mozversion application_version: 57.0a1 04:21:19 INFO - mozversion platform_buildid: 20170811103911 04:21:19 INFO - mozversion platform_changeset: 65826179c86e2a3538bcffd969556937e15688cd 04:21:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:21:19 INFO - mozversion platform_version: 57.0a1 04:21:19 INFO - using testdate: 1502450479 04:21:19 INFO - actual date: 1502450479 04:21:19 INFO - starting webserver on 'localhost:49389' 04:21:19 INFO - SUITE-START | Running 2 tests 04:21:19 INFO - TEST-START | dromaeo_css 04:21:19 INFO - Initialising browser for dromaeo_css test... 04:21:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49389/getInfo.html -profile /tmp/tmpW30n4N/profile 04:21:19 INFO - TEST-INFO | started process 27492 (/builds/slave/test/build/application/firefox/firefox http://localhost:49389/getInfo.html) 04:21:25 INFO - TEST-INFO | 27492: exit 0 04:21:25 INFO - Browser initialized. 04:21:25 INFO - Running cycle 1/1 for dromaeo_css test... 04:21:25 INFO - TEST-INFO | started process 27730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW30n4N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:26 INFO - PID 27730 | 04:21:26 INFO - PID 27730 | (/builds/slave/test/build/application/firefox/firefox:27785): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:21:26 INFO - PID 27730 | 04:21:37 INFO - PID 27730 | RSS: Main: 167469056 04:21:37 INFO - PID 27730 | 04:24:37 INFO - PID 27730 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49389/tests/dromaeo/cssquery-ext.html) 04:24:38 INFO - PID 27730 | RSS: Main: 175476736 04:24:38 INFO - PID 27730 | 04:27:40 INFO - PID 27730 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-ext.html (next: http://localhost:49389/tests/dromaeo/cssquery-jquery.html) 04:27:40 INFO - PID 27730 | RSS: Main: 171245568 04:27:40 INFO - PID 27730 | 04:30:42 INFO - PID 27730 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49389/tests/dromaeo/cssquery-mootools.html) 04:30:43 INFO - PID 27730 | RSS: Main: 174649344 04:30:43 INFO - PID 27730 | 04:33:44 INFO - PID 27730 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49389/tests/dromaeo/cssquery-prototype.html) 04:33:45 INFO - PID 27730 | RSS: Main: 173125632 04:33:45 INFO - PID 27730 | 04:36:49 INFO - PID 27730 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49389/tests/dromaeo/cssquery-yui.html) 04:36:49 INFO - PID 27730 | RSS: Main: 176283648 04:36:49 INFO - PID 27730 | 04:39:51 INFO - PID 27730 | Cycle 1(1): loaded http://localhost:49389/tests/dromaeo/cssquery-yui.html (next: http://localhost:49389/tests/dromaeo/cssquery-dojo.html) 04:39:51 INFO - PID 27730 | RSS: Main: 176984064 04:39:51 INFO - PID 27730 | 04:39:51 INFO - PID 27730 | __start_tp_report 04:39:51 INFO - PID 27730 | _x_x_mozilla_page_load 04:39:51 INFO - PID 27730 | _x_x_mozilla_page_load_details 04:39:51 INFO - PID 27730 | |i|pagename|runs| 04:39:51 INFO - PID 27730 | |0;dojo.html;3143.7642176836744;3163.066895265896;3183.8726450941963;3186.745060395169;3204.7275981541566;6140.539459540536;6204.193454850874;6218.626882387049;6223.315435302113;6247.625142491448;6192.814215573529;6238.688065596724;6244.687765611724;6246.437820596146;6267.37326267373;5581.832545023656;5638.154276858463;5720.427957204278;5729.28383952006;5755.769769209227;5582.302212223472;5636.04187288162;5693.202951586761;5706.714664266791;5762.6254293471;5719.056355701305;5752.712364381764;5774;5787.913181302284;5795.681237531934;5707.1153971134545;5723.484886360247;5771.249737534135;5795.942040579583;5833.766649334021;5493.148561972901;5547.084731019377;5607.046802043662;5619.4942455178825;5709.0865461525955;6083.908741368883;6194.876102477971;6195.96902015487;6198.721057552421;6224.377562243784;6711.094002309675;6794.626295553742;6800.387965083117;6804.6257455840405;6811.795646130624;6756.729730810762;6765.695543700545;6778.898316525256;6833.6241506717115;6861.622610756406;6152.446279834747;6171.691415429255;6236.282827474854;6289.7169627366875;6328;6810.62541560219;6877.690503927335;6912.965435172792;6962.860742785218;6972.1981972072845;6550.737970481127;6581.572197807127;6646.202455705346;6656.7004484797335;6667.833304167338;6536.640484773383;6583.374579414948;6641.701123449457;6698.39714425704;6718.395344419026;6526.64103474304;6550.574212676161;6616.503762217853;6670.0661907333015;6742.865142697118;6770.221424536143;6784.219814721271;6794.116764820542;6806.149231346082;6809.285025072296;5449.536789372868;5475.890482190413;5544.500994910478;5548.167774833726;5573.108302671553;4673.649476289292;4678.6491013174145;4711.740854253049;4723.551262630044;4736.621070314367;5715.8856822864145;5802.187693722883;5818.76724930998;5842.883142337129;5883.735231914574;6824.522283440211;6825.35159159879;6859.965700171467;6868.038474613558;6912.619805910723;5769;5854.665033206488;5917.5857689961285;5920.141579470953;5936.22829032223;5813.88372232553;5966.791162309385;6026.216591843032;6028.216331876828;6079.726412311456;6488.870222595521;6492.64290464029;6548.934510654928;6549.508786840911;6559.8032059038305;6771;6795.660216989229;6803.149606299213;6825.590464572141;6853.554518956252;6493.415592596689;6524.282328943717;6592.571482853599;6615.073889655356;6620.3710647488415;6632.635205063768;6638.17022872141;6639.7012134455035;6734.427573656294;6772.11962444879;6594.274629790815;6696.330366963265;6760.18877734675;6811.557248778813;6814.965925170342;6443.516736244706;6515.674216289071;6519.185101862267;6526.412622863965;6530.346965303432;6578.243501997332;6613.801585952237;6636.2368327642935;6639.966800165968;6657.234418041987;6453.838654033687;6498.610083395011;6554.901676474952;6559.983202603604;6573.3098024706715;6471.158749362553;6572.868542629025;6678.632675202911;6697.497687673346;6707.228668703162;6378.712957916998;6389.137466441971;6392.4246817786625;6427.646479443489;6473.514486413444 04:39:51 INFO - PID 27730 | |1;ext.html;810.623060276971;842.5408152556856;848.5163456829607;880.70936590925;883.9690610828618;40424.393634095475;41283;41381.17237655245;41425.17149657005;41530.58469415305;36034.45948310778;36170.638293617056;36179.27641447169;36267.81866090673;36295.4555681665;6779.42374898133;6907;6913.5506192097355;6914.239433662293;6919.031335613018;6800.863982720342;6867.450603951672;6878.449724022066;6883.724651013953;6884.931150688504;7534.284242996907;7682.1549629540705;7682.270184332508;7685.692572297129;7687.0391201099865;7538.9246107538775;7578.204288549678;7585.279398457165;7594.050743657043;7635.083789945214;7407.18520962699;7519.962400187964;7536.434767392468;7581.772546823604;7590.24097590242;36939.4459083114;37346.813265933495;37452.62547374546;37453.81273093617;37554;3250.3986762448785;3279.950800737991;3281.9343613127603;3283.8850640227715;3294.4234758917332;31071.533926991113;31098.844505777553;31282.374352512823;31496.527552086736;31555.684443155504;4900.534449227318;4903.730294833783;4917.631177661654;4920.434150072716;4932.284818701304;188305;192683;195212;197522;205108;49676.75161624169;49746.75126624416;49813.25280120801;49929.50070499321;49989;51611.741941290056;51716.74141629268;51723.48276517262;51775.22337164945;51822.48177518252;16423.91788041052;16543.09013004296;16582.50252492427;16584.17079146062;16817.495475135765;13819.447222111003;13860.514881979083;13900.304984750723;13919.373628186755;13957.162570245615;14241.928790356189;14348.282585870666;14375.353109109907;14527.709445811235;14665.706685866224;5724.255846739898;5726.427357264323;5732.856678583069;5797.681127538026;5927.881442371215;957.9808403831885;998.9300748947504;1013.6046941692746;1014.6905193915926;1017.7150397888603;22419.43951401228;22469.213577525035;22541.323760287218;22562.435939101655;22697.886510567343;1088.9401082940356;1094.5348227003492;1095.7041598768446;1096.4791723931228;1128.7347473343757;12150.392480376122;12185.573504927284;12189;12203.69490762738;12332.136750427564;237883;238356;238901;239227;239427;51633;51971.48028519667;52010.219846702326;52060;52159.47840521622;1435.7846323051626;1489.2628149066281;1491.4108926973784;1503.4437258214311;1507.5100592307545;22460.550788984456;22623.20818771335;22781.658275126218;22828.771712282665;22845.31464056081;37228.62771372252;37277.62722372742;37308;37328;37392;201760;201870;202349;202917;203034;33592.66407335895;33863.83068084742;35782.64217357793;35905.46141807927;35919.461208081375;45189.774051129534;45920;46130.53869461397;46658;46666.300005499266;33821;33999;34023.65976340205;34035;34355.82822085873;33377;33397.666023340425;34060.489092664124;34174.65825341715;34414.48378274278;37012.259754805295;37293.81353093217;37317;37349.25301493901;37792.43311350277;33584.66415335913;33736.97578145319;33755.83122084374;33939.624226304906;33990.15024624305;23992.880035599712;24318.27045188647;24417.51164976726;25081.602299837352;25185.622215667147 04:39:51 INFO - PID 27730 | |2;jquery.html;562.977480900764;565.9405762394946;568.3265330583259;581.3169525807177;586.3960121075293;22492.10031598736;22974.195903143394;23202.18792342266;23223.535529289424;23279.068837246534;25009.49981000379;26939.191824245303;27095.458090838172;27120.5931911021;27220.183394498148;6362.522810789198;6498.44763195129;6500.219973603174;6500.252470965828;6502.284748677642;6112.174856394397;6378.266499352588;6401.455876250524;6471.676416179196;6812.114425124727;6758.324167583227;6804.149481314836;6810.659467026654;6814.591124532544;6817.352351526597;6770.289119642441;6776.322367763233;6779.220389655204;6789.694463749143;6792.15098112731;6611.272759996396;6613.14029176204;6640.369164929324;6695.698693558801;6711.161104861892;32116;32196.356072878647;32848.6715132848;33267;33562.32875342504;1959.9216031358728;2008.829249513793;2022.393282015404;2023.9392818215476;2030.7563092428854;20503.69244461334;20519.5896082079;20947.790522094736;21574.784252157435;21744.238951636777;2378.108209421467;2403.6154215325464;2463.5935070713313;2470.629405589158;2474.05985725425;147154;151948;152258;152845;153910.23044884927;20206.696899546518;21262.92651246428;22274.331770046923;22709.772902271096;23774.88112559426;45064.774676126406;45073.54926450693;45113.54886451159;45242.54757452384;45392.77303613461;11967.76064478723;11969.144782558717;12125.93937030327;12413.627591172279;12428.813567796491;10102.19182465401;10256.692299231036;10269.897301027044;10351.896481035245;10490.790184196274;8477.364197685198;9487.102579483993;9530.094641009093;10949.288296260718;11596.362200079077;2596.4417650205296;2598.4673142005845;2598.8180827341903;2730.877110529991;2730.975884043484;922.8707980882682;923.8752768376318;971.1211353724749;978.1587834462357;989.4508547756064;19472.318468853522;19729.605407891762;19902.50243743918;20272;20476.18095276202;1017.4709151241314;1033.1270076785104;1036.6630844975414;1045.9372437653765;1050.1388861133796;11202.439878006067;13616.591502254949;14213.218272995084;14350.425982960773;14848.109113453227;457663;469300;470273;474306;479355;121953;123770.38114809369;126847;126895;128147.35926320495;1256.5790460195938;1267.33464930912;1289.432649634158;1291.9728815591627;1292.3006246785446;21141.6828747572;21294.25470108539;21431.892840535696;21441.356759297247;22001.449963751034;58551.70724146352;60377.39622603718;60555;61375;61543.6922815401;69280.65359673169;72110;72143.27856721576;72408.63795680988;73203.63398182976;12573.685657858627;13114.73770524565;14594.781078284046;15274.541763747106;15300.158491283086;24142.63786043246;24550.386240344134;24842.378940526633;24842.627360589966;25137.87431062833;19011.239550417828;19065.42803715891;19219.615607688047;19310.227590896207;19415.902920485307;17068.146592670564;17175.828241717423;17678.823211767718;18007;18105;19029;20350.694739578623;20489;20685.379438616867;20711.482212944193;14803.481878134213;14976.925115374353;15274.847251527786;15296.082235065931;15307.540773776804;17790.199441024924;17938.103094845468;17962.371317003843;18681.906590466962;19283.132259048096 04:39:51 INFO - PID 27730 | |3;mootools.html;1358.1783021272129;1429.7855321701743;1431;1436.6408397900525;1442.192372271528;13891.791623125648;14531.200783956878;14561.344739486722;14568.562943111698;14600.415983360654;14258.64353391163;14716.190609516472;14717.116972981628;14729.116253024826;14753.188574628419;2661.7870570354376;2702.162329677796;2708.9841309508934;2711.823731457459;2712.2541301142146;2548.069954466625;2568.614707793827;2600.8699565021675;2602.1933200707745;2604.257786530839;2544.5165418570505;2663.1611042521545;2691.8923243070353;2701.1221353060237;2707.7021527631946;2611.725768794278;2615.3592369869407;2619.4499155177436;2621.279148234232;2626.711061783212;2583.3799888026924;2583.5866261398273;2611.151375802872;2616.5682662360687;2616.6859976802716;13939.372728227254;14164.15015099087;14166.220857852813;14174.858251417458;14187.78718319226;7588.962055189689;7815.765527034198;7846.333061689763;7873.409494287894;7880.2513761192595;5158.200478925773;5258.81594144207;5291.576673866081;5357.4106848246665;5386.542143917772;1839.2275244397385;1846.243040353462;1861.6928206845855;1892.176903047179;1902.8507819558652;20558;20730.689039664416;20843.895780521;20914.790852091435;20999.580008399746;6072.028475443908;6299.496040316855;6334.954732469091;6506.60960342381;6554.082428460019;15233.847661523465;15236.542903712907;15254.08475491474;15282.617934551503;15297.694046119237;7484;7545.6981720730555;7594.240575942472;7661.080670319598;7666.3866890648615;5781.739821708034;6171.56799024064;6279.654618995908;6280.591761535486;7090.92909070913;5049.091163590516;5129;5275.261463395128;5275.868103297448;5287.259783630295;1453.4840131753076;1503.150719843285;1514.6680493787758;1517.5143953934635;1543.1744016950877;905.8460061789511;918.820829938169;922.1792604581927;935.209747763139;939.0937745076035;7468.3278504934815;7525.285097915689;7538.396928245727;7552.66013029415;7577.621118944031;712.1240873725243;726.8400951790597;727.5452841973766;733.7028503456108;737.0786516853933;4866.537678920497;5300.496452836975;5333;5343.919841202307;5785.450382213683;20047.799522004883;20211.494712632302;20322.695159572617;20538.281160159324;20551.075201615964;20021.899890500747;20161.899190504246;20301.086451109735;20312;20337.898310508353;10640.46797660114;10818.621348252773;11047.116230701524;11051.99999999984;11056;8236.588170591327;8649.437786543855;8771.517566533646;8978.10218978097;8995.910040899507;17117.914410427868;17680.292788288323;17691.911540442215;17747.378841740476;17906.462806115836;17361.13194340303;17951.281948721906;17965.640687186446;18000.459986200436;18392.26430942747;12847.421866016239;13420.39608217613;13461;13462.124961877447;13517.526886558922;13383.933080334536;13399.598012059654;13536.390862411019;13544.86455135436;13576.456941722616;10865.619703310345;10945.813445353146;11205.943970280096;11285.266457680225;11486.655400338002;10474.4239066849;10623.681289561326;10640.680779576625;10689.786204276026;10892.40091794959;9622.230221582116;9834.852477212704;9854.655087071918;9860.309778315735;9862.063104005108;7055.294470553109;7059.611721355374;7083.82290442743;7134.108236470442;7139.535930164523;7536.284053014955;7560.848783024198;7597.696092156473;7604.353629941295;7631 04:39:51 INFO - PID 27730 | |4;prototype.html;500.3520441028866;503.63234838567865;519.6881870877471;522.5323335614625;524.1691918309477;6223.222097237845;6278.874422511547;6288.842778930529;6305.936940630592;6310.337414571472;6188.319284878659;6190.504759619231;6193.1020002099785;6212.502999760009;6239.875202495948;4893.681910675795;5084.872878178038;5106.719130447815;5107.438181799999;5130.204818253158;4974.23414687786;4979.377577802775;4995.100881841267;5025.748712564376;5035.345405097332;4893.2170852663585;4936.605071594282;4943.797771893897;4979.950200498003;4995.275685025669;4916.1732004097785;4936.876578085541;4945.480724523945;4968.30443737877;5004.049230646184;4437.689361744679;4487.41663583732;4489.685721999462;4494.5617402431235;4504.93242601358;5955.970220148872;6073.757049718006;6125.5712100153005;6185.4330452862005;6205.255369355661;5674.829755107354;5676.829695109153;5715.828525144252;5732;5777.942220577783;6527.281998980108;6548.93451065488;6555.737770489175;6637.800865974028;6646.501512386542;4811.206150985084;4853.762290615906;4863.440704319013;4872.269159626049;4919;6506.186726659168;6730.899036514456;6795.538959123812;6801.897971530431;6843.247242803288;4880.658353915192;4933.840547471342;4995.25071239317;5006;5021.297018417425;5010.298558201855;5016.698998060128;5042.445331013586;5089.9745501272255;5098.9490105098475;5687.118496633028;5689.516391106802;5691.345495268097;5721.313442386941;5756.827295181151;6606.240282367493;6662.300458451889;6681.33186681328;6720.6639668016405;6721.6975236114495;1724.3275122701905;1734.8698847586481;1745.790505139366;1755.5698853780905;1772.9024903630425;1142.3774043146338;1196.4795314038422;1205.879412058787;1206.5716670581992;1207.402335843763;5765.336986246635;5775.5090817281;5810.62230954995;5816.098504731774;5820.505257053198;6624.96687516569;6713;6740.6966686498245;6797.116374871334;6813.488988325896;5659.18905950092;5695.629784064023;5698.629589076697;5743.822516384132;5809.448102430262;3553.378158822196;3573.160307327776;3580.337637537064;3584.4802503637347;3627.3108109459117;6427.2929977702415;6466.256380516207;6468.54720169593;6478.2873883872735;6593.571417857824;6797.830054248683;6823.488238382141;6832.829179270459;6894.172699276019;6979.371856532936;6396.872062558723;6458.935410645928;6487.286398496161;6569.770058047945;6590.077389165616;6608.325591152874;6632.767853125118;6642.269350371359;6660.433863121689;6765.323467653392;6626.90059649096;6660.733570657119;6716.227633821977;6767.35710107539;6780;5847.298324200953;6443.484521238383;6532.864225171849;6571.488557631676;6587.341265873374;4998.625103117208;5005.649604527648;5016.623753218596;5019.52314530119;5028.806707740684;6545.705443254969;6619.735210591715;6679.76620818269;6779.915213565806;6789.388954994074;6255.46828519581;6526.738930442729;6531.183602049744;6574.145361103026;6596.60420374779;6548.705308261235;6584.637844918576;6624;6652.933470665232;6661.300563440769;6464.02654778807;6483.513736469689;6493.22081350241;6610.8347291318105;6614.503912206507;6532.150820393318;6536.6731663415685;6597.60414375139;6661.16735408074;6701.430378417694;6312.274088479883;6314.62112273265;6343.55595108338;6354.714037868214;6424.903626445701 04:39:51 INFO - PID 27730 | |5;yui.html;902.6028547439126;915.3501014279861;929.586334081334;932.8041111366613;937.4937533731783;18795.62408751824;19832.305869294578;19923.800761992377;19938.202471901106;22305.665415018786;21906.23328183514;22473.887630561865;22521.887390563024;22706;22706.205282815106;1025.697419261318;1051.0435503691642;1053.1732589916917;1053.8419237114456;1057.3867157048894;972.6838777397375;1035.9015893490107;1046.6284469013506;1050.5850189175271;1051.1118105201092;1078.6386560502242;1095.5672509358799;1097.023648952433;1097.2154909239891;1097.4293367448922;1081.3457857995877;1094.9069329107076;1095.1622009162998;1095.5453486803008;1095.9342439453658;789.2423273657296;797.6530209358947;800.7637746864631;800.7677773445752;801.0187520287659;19941.40175794714;20512.179512819468;20612.484687882774;20721.8963905181;20754.896225518925;21239.893800531052;21536;21688.891555542123;21794.673079903656;21991.120355185933;16572.254248558846;16649.83350166495;16829.41097061597;17088.743668844978;17648.205830737646;3732.3841566141828;3745.550533935945;3749.1189570450924;3750.79370634615;3766.39737641976;128992;129973.35013324967;130001;133279.4112507427;134109;16489.587760306087;17105.82894171067;17224.913875430542;17341;17355.21901514435;31360.21599459986;32235.194120147185;32265.193370165933;32320.515192272134;32777;7766.106897706723;8074.636641351153;8329.292010179202;8385.245327920395;8514.616842242114;4247.957520424818;4321.6974811762875;4332.783360831946;4343.587359200871;4349.739015659071;5237.135872581058;5303.708296043755;5327.493888080626;5336.4129945705945;5346.331708536433;1025.3181634213313;1044.0290529807353;1055.2613170780485;1057.2916146182076;1058.5077938758513;690.1200968764765;707.345705222667;716.813628456605;720;723.5043994863536;11495.885041149482;11694.52142718529;11939;12024.338661373533;12303.015758739279;703.4513079797664;713.3009650542498;714.4784307455586;717.8600172966326;722.7831650504828;5274.393444753902;5303.973480132575;5330.413654498002;5347.786088556414;5449.209864569615;116077.4196129014;116100;116582.41708791572;120165;123900;102687.48656256672;103438;105172;109463.45268273608;109977.45011274892;82346.58826705828;87402.56298718466;90026;91957.08042919618;94767.0523294772;12267.938660306641;12425.689357766129;13029.478820847438;13128.474861005452;13322;40173.799131004154;40283;40490.39264410977;41222.9694257646;41228.969275768344;69617;69685;71704.64147679228;72154.27845721475;76659.61670191614;17522.9123854385;18060.187291572172;19211.90394048021;19460.12429440707;19702.1134048971;21449.249276275255;21549.138034478445;21581.13675452964;21831.126754929624;22167.44581385478;18939;19241;19457.221711131395;19988.20047198096;19990.20039198416;16319.18404079815;16838.158092095593;18135.637287254445;18169.636607268047;18172.45482635523;16790.412335568195;16821;16920.407785727934;17412.39056633012;18692.34576789806;14332.426702932184;14525.201113938834;14540.85459145395;14827.110373377633;14865.554033379016;14664.633384165054;15238.847611524187;15362.769558456408;15384.692306154038;15634.9218253908 04:39:51 INFO - PID 27730 | __end_tp_report 04:39:51 INFO - PID 27730 | __start_cc_report 04:39:51 INFO - PID 27730 | _x_x_mozilla_cycle_collect,412 04:39:51 INFO - PID 27730 | __end_cc_report 04:39:51 INFO - PID 27730 | __startTimestamp1502451591928__endTimestamp 04:39:51 INFO - PID 27730 | 04:39:51 INFO - PID 27730 | ------- Summary: start ------- 04:39:51 INFO - PID 27730 | Number of tests: 6 04:39:51 INFO - PID 27730 | 04:39:51 INFO - PID 27730 | [#0] dojo.html Cycles:165 Average:6195.96 Median:6473.51 stddev:736.54 (11.4%) stddev-sans-first:698.79 04:39:51 INFO - PID 27730 | Values: 3143.8 3163.1 3183.9 3186.7 3204.7 6140.5 6204.2 6218.6 6223.3 6247.6 6192.8 6238.7 6244.7 6246.4 6267.4 5581.8 5638.2 5720.4 5729.3 5755.8 5582.3 5636.0 5693.2 5706.7 5762.6 5719.1 5752.7 5774.0 5787.9 5795.7 5707.1 5723.5 5771.2 5795.9 5833.8 5493.1 5547.1 5607.0 5619.5 5709.1 6083.9 6194.9 6196.0 6198.7 6224.4 6711.1 6794.6 6800.4 6804.6 6811.8 6756.7 6765.7 6778.9 6833.6 6861.6 6152.4 6171.7 6236.3 6289.7 6328.0 6810.6 6877.7 6913.0 6962.9 6972.2 6550.7 6581.6 6646.2 6656.7 6667.8 6536.6 6583.4 6641.7 6698.4 6718.4 6526.6 6550.6 6616.5 6670.1 6742.9 6770.2 6784.2 6794.1 6806.1 6809.3 5449.5 5475.9 5544.5 5548.2 5573.1 4673.6 4678.6 4711.7 4723.6 4736.6 5715.9 5802.2 5818.8 5842.9 5883.7 6824.5 6825.4 6860.0 6868.0 6912.6 5769.0 5854.7 5917.6 5920.1 5936.2 5813.9 5966.8 6026.2 6028.2 6079.7 6488.9 6492.6 6548.9 6549.5 6559.8 6771.0 6795.7 6803.1 6825.6 6853.6 6493.4 6524.3 6592.6 6615.1 6620.4 6632.6 6638.2 6639.7 6734.4 6772.1 6594.3 6696.3 6760.2 6811.6 6815.0 6443.5 6515.7 6519.2 6526.4 6530.3 6578.2 6613.8 6636.2 6640.0 6657.2 6453.8 6498.6 6554.9 6560.0 6573.3 6471.2 6572.9 6678.6 6697.5 6707.2 6378.7 6389.1 6392.4 6427.6 6473.5 04:39:51 INFO - PID 27730 | 04:39:51 INFO - PID 27730 | [#1] ext.html Cycles:180 Average:38219.70 Median:35844.05 stddev:55270.81 (154.2%) stddev-sans-first:55354.48 04:39:51 INFO - PID 27730 | Values: 810.6 842.5 848.5 880.7 884.0 40424.4 41283.0 41381.2 41425.2 41530.6 36034.5 36170.6 36179.3 36267.8 36295.5 6779.4 6907.0 6913.6 6914.2 6919.0 6800.9 6867.5 6878.4 6883.7 6884.9 7534.3 7682.2 7682.3 7685.7 7687.0 7538.9 7578.2 7585.3 7594.1 7635.1 7407.2 7520.0 7536.4 7581.8 7590.2 36939.4 37346.8 37452.6 37453.8 37554.0 3250.4 3280.0 3281.9 3283.9 3294.4 31071.5 31098.8 31282.4 31496.5 31555.7 4900.5 4903.7 4917.6 4920.4 4932.3 188305.0 192683.0 195212.0 197522.0 205108.0 49676.8 49746.8 49813.3 49929.5 49989.0 51611.7 51716.7 51723.5 51775.2 51822.5 16423.9 16543.1 16582.5 16584.2 16817.5 13819.4 13860.5 13900.3 13919.4 13957.2 14241.9 14348.3 14375.4 14527.7 14665.7 5724.3 5726.4 5732.9 5797.7 5927.9 958.0 998.9 1013.6 1014.7 1017.7 22419.4 22469.2 22541.3 22562.4 22697.9 1088.9 1094.5 1095.7 1096.5 1128.7 12150.4 12185.6 12189.0 12203.7 12332.1 237883.0 238356.0 238901.0 239227.0 239427.0 51633.0 51971.5 52010.2 52060.0 52159.5 1435.8 1489.3 1491.4 1503.4 1507.5 22460.6 22623.2 22781.7 22828.8 22845.3 37228.6 37277.6 37308.0 37328.0 37392.0 201760.0 201870.0 202349.0 202917.0 203034.0 33592.7 33863.8 35782.6 35905.5 35919.5 45189.8 45920.0 46130.5 46658.0 46666.3 33821.0 33999.0 34023.7 34035.0 34355.8 33377.0 33397.7 34060.5 34174.7 34414.5 37012.3 37293.8 37317.0 37349.3 37792.4 33584.7 33737.0 33755.8 33939.6 33990.2 23992.9 24318.3 24417.5 25081.6 25185.6 04:39:51 INFO - PID 27730 | 04:39:51 INFO - PID 27730 | [#2] jquery.html Cycles:180 Average:36429.97 Median:22600.94 stddev:80209.68 (354.9%) stddev-sans-first:80389.48 04:39:51 INFO - PID 27730 | Values: 563.0 565.9 568.3 581.3 586.4 22492.1 22974.2 23202.2 23223.5 23279.1 25009.5 26939.2 27095.5 27120.6 27220.2 6362.5 6498.4 6500.2 6500.3 6502.3 6112.2 6378.3 6401.5 6471.7 6812.1 6758.3 6804.1 6810.7 6814.6 6817.4 6770.3 6776.3 6779.2 6789.7 6792.2 6611.3 6613.1 6640.4 6695.7 6711.2 32116.0 32196.4 32848.7 33267.0 33562.3 1959.9 2008.8 2022.4 2023.9 2030.8 20503.7 20519.6 20947.8 21574.8 21744.2 2378.1 2403.6 2463.6 2470.6 2474.1 147154.0 151948.0 152258.0 152845.0 153910.2 20206.7 21262.9 22274.3 22709.8 23774.9 45064.8 45073.5 45113.5 45242.5 45392.8 11967.8 11969.1 12125.9 12413.6 12428.8 10102.2 10256.7 10269.9 10351.9 10490.8 8477.4 9487.1 9530.1 10949.3 11596.4 2596.4 2598.5 2598.8 2730.9 2731.0 922.9 923.9 971.1 978.2 989.5 19472.3 19729.6 19902.5 20272.0 20476.2 1017.5 1033.1 1036.7 1045.9 1050.1 11202.4 13616.6 14213.2 14350.4 14848.1 457663.0 469300.0 470273.0 474306.0 479355.0 121953.0 123770.4 126847.0 126895.0 128147.4 1256.6 1267.3 1289.4 1292.0 1292.3 21141.7 21294.3 21431.9 21441.4 22001.4 58551.7 60377.4 60555.0 61375.0 61543.7 69280.7 72110.0 72143.3 72408.6 73203.6 12573.7 13114.7 14594.8 15274.5 15300.2 24142.6 24550.4 24842.4 24842.6 25137.9 19011.2 19065.4 19219.6 19310.2 19415.9 17068.1 17175.8 17678.8 18007.0 18105.0 19029.0 20350.7 20489.0 20685.4 20711.5 14803.5 14976.9 15274.8 15296.1 15307.5 17790.2 17938.1 17962.4 18681.9 19283.1 04:39:51 INFO - PID 27730 | 04:39:51 INFO - PID 27730 | [#3] mootools.html Cycles:180 Average:8866.83 Median:2601.53 stddev:6012.12 (231.1%) stddev-sans-first:6002.51 04:39:51 INFO - PID 27730 | Values: 1358.2 1429.8 1431.0 1436.6 1442.2 13891.8 14531.2 14561.3 14568.6 14600.4 14258.6 14716.2 14717.1 14729.1 14753.2 2661.8 2702.2 2709.0 2711.8 2712.3 2548.1 2568.6 2600.9 2602.2 2604.3 2544.5 2663.2 2691.9 2701.1 2707.7 2611.7 2615.4 2619.4 2621.3 2626.7 2583.4 2583.6 2611.2 2616.6 2616.7 13939.4 14164.2 14166.2 14174.9 14187.8 7589.0 7815.8 7846.3 7873.4 7880.3 5158.2 5258.8 5291.6 5357.4 5386.5 1839.2 1846.2 1861.7 1892.2 1902.9 20558.0 20730.7 20843.9 20914.8 20999.6 6072.0 6299.5 6335.0 6506.6 6554.1 15233.8 15236.5 15254.1 15282.6 15297.7 7484.0 7545.7 7594.2 7661.1 7666.4 5781.7 6171.6 6279.7 6280.6 7090.9 5049.1 5129.0 5275.3 5275.9 5287.3 1453.5 1503.2 1514.7 1517.5 1543.2 905.8 918.8 922.2 935.2 939.1 7468.3 7525.3 7538.4 7552.7 7577.6 712.1 726.8 727.5 733.7 737.1 4866.5 5300.5 5333.0 5343.9 5785.5 20047.8 20211.5 20322.7 20538.3 20551.1 20021.9 20161.9 20301.1 20312.0 20337.9 10640.5 10818.6 11047.1 11052.0 11056.0 8236.6 8649.4 8771.5 8978.1 8995.9 17117.9 17680.3 17691.9 17747.4 17906.5 17361.1 17951.3 17965.6 18000.5 18392.3 12847.4 13420.4 13461.0 13462.1 13517.5 13383.9 13399.6 13536.4 13544.9 13576.5 10865.6 10945.8 11205.9 11285.3 11486.7 10474.4 10623.7 10640.7 10689.8 10892.4 9622.2 9834.9 9854.7 9860.3 9862.1 7055.3 7059.6 7083.8 7134.1 7139.5 7536.3 7560.8 7597.7 7604.4 7631.0 04:39:51 INFO - PID 27730 | 04:39:51 INFO - PID 27730 | [#4] prototype.html Cycles:180 Average:5515.70 Median:6189.41 stddev:1549.83 (25.0%) stddev-sans-first:1507.77 04:39:51 INFO - PID 27730 | Values: 500.4 503.6 519.7 522.5 524.2 6223.2 6278.9 6288.8 6305.9 6310.3 6188.3 6190.5 6193.1 6212.5 6239.9 4893.7 5084.9 5106.7 5107.4 5130.2 4974.2 4979.4 4995.1 5025.7 5035.3 4893.2 4936.6 4943.8 4980.0 4995.3 4916.2 4936.9 4945.5 4968.3 5004.0 4437.7 4487.4 4489.7 4494.6 4504.9 5956.0 6073.8 6125.6 6185.4 6205.3 5674.8 5676.8 5715.8 5732.0 5777.9 6527.3 6548.9 6555.7 6637.8 6646.5 4811.2 4853.8 4863.4 4872.3 4919.0 6506.2 6730.9 6795.5 6801.9 6843.2 4880.7 4933.8 4995.3 5006.0 5021.3 5010.3 5016.7 5042.4 5090.0 5098.9 5687.1 5689.5 5691.3 5721.3 5756.8 6606.2 6662.3 6681.3 6720.7 6721.7 1724.3 1734.9 1745.8 1755.6 1772.9 1142.4 1196.5 1205.9 1206.6 1207.4 5765.3 5775.5 5810.6 5816.1 5820.5 6625.0 6713.0 6740.7 6797.1 6813.5 5659.2 5695.6 5698.6 5743.8 5809.4 3553.4 3573.2 3580.3 3584.5 3627.3 6427.3 6466.3 6468.5 6478.3 6593.6 6797.8 6823.5 6832.8 6894.2 6979.4 6396.9 6458.9 6487.3 6569.8 6590.1 6608.3 6632.8 6642.3 6660.4 6765.3 6626.9 6660.7 6716.2 6767.4 6780.0 5847.3 6443.5 6532.9 6571.5 6587.3 4998.6 5005.6 5016.6 5019.5 5028.8 6545.7 6619.7 6679.8 6779.9 6789.4 6255.5 6526.7 6531.2 6574.1 6596.6 6548.7 6584.6 6624.0 6652.9 6661.3 6464.0 6483.5 6493.2 6610.8 6614.5 6532.2 6536.7 6597.6 6661.2 6701.4 6312.3 6314.6 6343.6 6354.7 6424.9 04:39:51 INFO - PID 27730 | 04:39:51 INFO - PID 27730 | [#5] yui.html Cycles:180 Average:24828.91 Median:19939.80 stddev:33994.63 (170.5%) stddev-sans-first:34042.52 04:39:51 INFO - PID 27730 | Values: 902.6 915.4 929.6 932.8 937.5 18795.6 19832.3 19923.8 19938.2 22305.7 21906.2 22473.9 22521.9 22706.0 22706.2 1025.7 1051.0 1053.2 1053.8 1057.4 972.7 1035.9 1046.6 1050.6 1051.1 1078.6 1095.6 1097.0 1097.2 1097.4 1081.3 1094.9 1095.2 1095.5 1095.9 789.2 797.7 800.8 800.8 801.0 19941.4 20512.2 20612.5 20721.9 20754.9 21239.9 21536.0 21688.9 21794.7 21991.1 16572.3 16649.8 16829.4 17088.7 17648.2 3732.4 3745.6 3749.1 3750.8 3766.4 128992.0 129973.4 130001.0 133279.4 134109.0 16489.6 17105.8 17224.9 17341.0 17355.2 31360.2 32235.2 32265.2 32320.5 32777.0 7766.1 8074.6 8329.3 8385.2 8514.6 4248.0 4321.7 4332.8 4343.6 4349.7 5237.1 5303.7 5327.5 5336.4 5346.3 1025.3 1044.0 1055.3 1057.3 1058.5 690.1 707.3 716.8 720.0 723.5 11495.9 11694.5 11939.0 12024.3 12303.0 703.5 713.3 714.5 717.9 722.8 5274.4 5304.0 5330.4 5347.8 5449.2 116077.4 116100.0 116582.4 120165.0 123900.0 102687.5 103438.0 105172.0 109463.5 109977.5 82346.6 87402.6 90026.0 91957.1 94767.1 12267.9 12425.7 13029.5 13128.5 13322.0 40173.8 40283.0 40490.4 41223.0 41229.0 69617.0 69685.0 71704.6 72154.3 76659.6 17522.9 18060.2 19211.9 19460.1 19702.1 21449.2 21549.1 21581.1 21831.1 22167.4 18939.0 19241.0 19457.2 19988.2 19990.2 16319.2 16838.2 18135.6 18169.6 18172.5 16790.4 16821.0 16920.4 17412.4 18692.3 14332.4 14525.2 14540.9 14827.1 14865.6 14664.6 15238.8 15362.8 15384.7 15634.9 04:39:51 INFO - PID 27730 | -------- Summary: end -------- 04:39:51 INFO - PID 27730 | 04:39:52 INFO - TEST-INFO | 27730: exit 0 04:39:52 INFO - TEST-OK | dromaeo_css | took 1113631ms 04:39:52 INFO - TEST-START | kraken 04:39:52 INFO - Initialising browser for kraken test... 04:39:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49389/getInfo.html -profile /tmp/tmp8SYFul/profile 04:39:52 INFO - TEST-INFO | started process 28105 (/builds/slave/test/build/application/firefox/firefox http://localhost:49389/getInfo.html) 04:39:59 INFO - TEST-INFO | 28105: exit 0 04:39:59 INFO - Browser initialized. 04:39:59 INFO - Running cycle 1/1 for kraken test... 04:39:59 INFO - TEST-INFO | started process 28342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8SYFul/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:00 INFO - PID 28342 | 04:40:00 INFO - PID 28342 | (/builds/slave/test/build/application/firefox/firefox:28397): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:40:00 INFO - PID 28342 | 04:40:10 INFO - PID 28342 | RSS: Main: 167940096 04:40:10 INFO - PID 28342 | 04:40:13 INFO - PID 28342 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49389/tests/kraken/driver.html?testName=audio-beat-detection) 04:40:14 INFO - PID 28342 | RSS: Main: 174387200 04:40:14 INFO - PID 28342 | 04:40:16 INFO - PID 28342 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49389/tests/kraken/driver.html?testName=audio-dft) 04:40:17 INFO - PID 28342 | RSS: Main: 174854144 04:40:17 INFO - PID 28342 | 04:40:20 INFO - PID 28342 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49389/tests/kraken/driver.html?testName=audio-fft) 04:40:21 INFO - PID 28342 | RSS: Main: 169500672 04:40:21 INFO - PID 28342 | 04:40:23 INFO - PID 28342 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49389/tests/kraken/driver.html?testName=audio-oscillator) 04:40:23 INFO - PID 28342 | RSS: Main: 170491904 04:40:23 INFO - PID 28342 | 04:40:26 INFO - PID 28342 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49389/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:40:26 INFO - PID 28342 | RSS: Main: 170827776 04:40:26 INFO - PID 28342 | 04:40:29 INFO - PID 28342 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49389/tests/kraken/driver.html?testName=imaging-darkroom) 04:40:30 INFO - PID 28342 | RSS: Main: 173367296 04:40:30 INFO - PID 28342 | 04:40:34 INFO - PID 28342 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49389/tests/kraken/driver.html?testName=imaging-desaturate) 04:40:34 INFO - PID 28342 | RSS: Main: 172810240 04:40:34 INFO - PID 28342 | 04:40:37 INFO - PID 28342 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49389/tests/kraken/driver.html?testName=json-parse-financial) 04:40:38 INFO - PID 28342 | RSS: Main: 173350912 04:40:38 INFO - PID 28342 | 04:40:39 INFO - PID 28342 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49389/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:40:40 INFO - PID 28342 | RSS: Main: 173502464 04:40:40 INFO - PID 28342 | 04:40:42 INFO - PID 28342 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:40:43 INFO - PID 28342 | RSS: Main: 173445120 04:40:43 INFO - PID 28342 | 04:40:45 INFO - PID 28342 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:40:45 INFO - PID 28342 | RSS: Main: 173502464 04:40:45 INFO - PID 28342 | 04:40:48 INFO - PID 28342 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:40:49 INFO - PID 28342 | RSS: Main: 174354432 04:40:49 INFO - PID 28342 | 04:40:52 INFO - PID 28342 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:40:53 INFO - PID 28342 | RSS: Main: 174280704 04:40:53 INFO - PID 28342 | 04:40:54 INFO - PID 28342 | Cycle 1(1): loaded http://localhost:49389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49389/tests/kraken/driver.html?testName=ai-astar) 04:40:55 INFO - PID 28342 | RSS: Main: 175636480 04:40:55 INFO - PID 28342 | 04:40:55 INFO - PID 28342 | __start_tp_report 04:40:55 INFO - PID 28342 | _x_x_mozilla_page_load 04:40:55 INFO - PID 28342 | _x_x_mozilla_page_load_details 04:40:55 INFO - PID 28342 | |i|pagename|runs| 04:40:55 INFO - PID 28342 | |0;ai-astar;102;108;105;109;108;111;108;100;113;107 04:40:55 INFO - PID 28342 | |1;audio-beat-detection;144;117;141;180;118;141;150;118;178;124 04:40:55 INFO - PID 28342 | |2;audio-dft;164;164;163;166;166;172;170;167;165;166 04:40:55 INFO - PID 28342 | |3;audio-fft;76;77;77;178;75;74;74;73;159;77 04:40:55 INFO - PID 28342 | |4;audio-oscillator;78;78;134;88;80;79;130;78;79;128 04:40:55 INFO - PID 28342 | |5;imaging-gaussian-blur;113;115;114;115;115;115;114;115;117;114 04:40:55 INFO - PID 28342 | |6;imaging-darkroom;151;151;156;157;150;152;152;150;151;152 04:40:55 INFO - PID 28342 | |7;imaging-desaturate;94;94;94;94;102;104;94;94;95;96 04:40:55 INFO - PID 28342 | |8;json-parse-financial;53;53;67;63;53;60;53;62;57;60 04:40:55 INFO - PID 28342 | |9;json-stringify-tinderbox;58;55;55;57;54;54;54;60;55;56 04:40:55 INFO - PID 28342 | |10;stanford-crypto-aes;78;78;79;78;82;81;86;83;78;78 04:40:55 INFO - PID 28342 | |11;stanford-crypto-ccm;129;129;139;127;123;132;133;123;124;179 04:40:55 INFO - PID 28342 | |12;stanford-crypto-pbkdf2;180;176;177;183;181;176;183;181;190;174 04:40:55 INFO - PID 28342 | |13;stanford-crypto-sha256-iterative;69;70;67;69;73;68;67;70;74;74 04:40:55 INFO - PID 28342 | __end_tp_report 04:40:55 INFO - PID 28342 | __start_cc_report 04:40:55 INFO - PID 28342 | _x_x_mozilla_cycle_collect,971 04:40:55 INFO - PID 28342 | __end_cc_report 04:40:55 INFO - PID 28342 | __startTimestamp1502451655230__endTimestamp 04:40:55 INFO - PID 28342 | 04:40:55 INFO - PID 28342 | ------- Summary: start ------- 04:40:55 INFO - PID 28342 | Number of tests: 14 04:40:55 INFO - PID 28342 | 04:40:55 INFO - PID 28342 | [#0] ai-astar Cycles:10 Average:107.10 Median:108.00 stddev:3.90 (3.6%) stddev-sans-first:3.67 04:40:55 INFO - PID 28342 | Values: 102.0 108.0 105.0 109.0 108.0 111.0 108.0 100.0 113.0 107.0 04:40:55 INFO - PID 28342 | 04:40:55 INFO - PID 28342 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:142.50 stddev:23.34 (16.4%) stddev-sans-first:24.73 04:40:55 INFO - PID 28342 | Values: 144.0 117.0 141.0 180.0 118.0 141.0 150.0 118.0 178.0 124.0 04:40:55 INFO - PID 28342 | 04:40:55 INFO - PID 28342 | [#2] audio-dft Cycles:10 Average:166.30 Median:166.00 stddev:2.79 (1.7%) stddev-sans-first:2.83 04:40:55 INFO - PID 28342 | Values: 164.0 164.0 163.0 166.0 166.0 172.0 170.0 167.0 165.0 166.0 04:40:55 INFO - PID 28342 | 04:40:55 INFO - PID 28342 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.50 stddev:39.54 (52.4%) stddev-sans-first:41.40 04:40:55 INFO - PID 28342 | Values: 76.0 77.0 77.0 178.0 75.0 74.0 74.0 73.0 159.0 77.0 04:40:55 INFO - PID 28342 | 04:40:55 INFO - PID 28342 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:78.50 stddev:24.69 (31.5%) stddev-sans-first:25.39 04:40:55 INFO - PID 28342 | Values: 78.0 78.0 134.0 88.0 80.0 79.0 130.0 78.0 79.0 128.0 04:40:55 INFO - PID 28342 | 04:40:55 INFO - PID 28342 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:115.00 stddev:1.06 (0.9%) stddev-sans-first:0.93 04:40:55 INFO - PID 28342 | Values: 113.0 115.0 114.0 115.0 115.0 115.0 114.0 115.0 117.0 114.0 04:40:55 INFO - PID 28342 | 04:40:55 INFO - PID 28342 | [#6] imaging-darkroom Cycles:10 Average:152.20 Median:152.00 stddev:2.39 (1.6%) stddev-sans-first:2.50 04:40:55 INFO - PID 28342 | Values: 151.0 151.0 156.0 157.0 150.0 152.0 152.0 150.0 151.0 152.0 04:40:55 INFO - PID 28342 | 04:40:55 INFO - PID 28342 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:94.00 stddev:3.73 (4.0%) stddev-sans-first:3.87 04:40:55 INFO - PID 28342 | Values: 94.0 94.0 94.0 94.0 102.0 104.0 94.0 94.0 95.0 96.0 04:40:55 INFO - PID 28342 | 04:40:55 INFO - PID 28342 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:60.00 stddev:5.07 (8.4%) stddev-sans-first:5.02 04:40:55 INFO - PID 28342 | Values: 53.0 53.0 67.0 63.0 53.0 60.0 53.0 62.0 57.0 60.0 04:40:55 INFO - PID 28342 | 04:40:55 INFO - PID 28342 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:55.50 stddev:1.99 (3.6%) stddev-sans-first:1.94 04:40:55 INFO - PID 28342 | Values: 58.0 55.0 55.0 57.0 54.0 54.0 54.0 60.0 55.0 56.0 04:40:55 INFO - PID 28342 | 04:40:55 INFO - PID 28342 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:2.81 (3.5%) stddev-sans-first:2.87 04:40:55 INFO - PID 28342 | Values: 78.0 78.0 79.0 78.0 82.0 81.0 86.0 83.0 78.0 78.0 04:40:55 INFO - PID 28342 | 04:40:55 INFO - PID 28342 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:130.50 stddev:16.65 (12.8%) stddev-sans-first:17.57 04:40:55 INFO - PID 28342 | Values: 129.0 129.0 139.0 127.0 123.0 132.0 133.0 123.0 124.0 179.0 04:40:55 INFO - PID 28342 | 04:40:55 INFO - PID 28342 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.10 Median:181.00 stddev:4.68 (2.6%) stddev-sans-first:4.96 04:40:55 INFO - PID 28342 | Values: 180.0 176.0 177.0 183.0 181.0 176.0 183.0 181.0 190.0 174.0 04:40:55 INFO - PID 28342 | 04:40:55 INFO - PID 28342 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:2.69 (3.8%) stddev-sans-first:2.82 04:40:55 INFO - PID 28342 | Values: 69.0 70.0 67.0 69.0 73.0 68.0 67.0 70.0 74.0 74.0 04:40:55 INFO - PID 28342 | -------- Summary: end -------- 04:40:55 INFO - PID 28342 | 04:40:55 INFO - PID 28342 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:40:55 INFO - TEST-INFO | 28342: exit 0 04:40:55 INFO - TEST-OK | kraken | took 63270ms 04:40:55 INFO - SUITE-END | took 1176s 04:40:56 INFO - Completed test suite (00:19:37) 04:40:56 INFO - javascript benchmark 04:40:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8642.828901449344, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3143.7642176836744, 3163.066895265896, 3183.8726450941963, 3186.745060395169, 3204.7275981541566, 6140.539459540536, 6204.193454850874, 6218.626882387049, 6223.315435302113, 6247.625142491448, 6192.814215573529, 6238.688065596724, 6244.687765611724, 6246.437820596146, 6267.37326267373, 5581.832545023656, 5638.154276858463, 5720.427957204278, 5729.28383952006, 5755.769769209227, 5582.302212223472, 5636.04187288162, 5693.202951586761, 5706.714664266791, 5762.6254293471, 5719.056355701305, 5752.712364381764, 5774.0, 5787.913181302284, 5795.681237531934, 5707.1153971134545, 5723.484886360247, 5771.249737534135, 5795.942040579583, 5833.766649334021, 5493.148561972901, 5547.084731019377, 5607.046802043662, 5619.4942455178825, 5709.0865461525955, 6083.908741368883, 6194.876102477971, 6195.96902015487, 6198.721057552421, 6224.377562243784, 6711.094002309675, 6794.626295553742, 6800.387965083117, 6804.6257455840405, 6811.795646130624, 6756.729730810762, 6765.695543700545, 6778.898316525256, 6833.6241506717115, 6861.622610756406, 6152.446279834747, 6171.691415429255, 6236.282827474854, 6289.7169627366875, 6328.0, 6810.62541560219, 6877.690503927335, 6912.965435172792, 6962.860742785218, 6972.1981972072845, 6550.737970481127, 6581.572197807127, 6646.202455705346, 6656.7004484797335, 6667.833304167338, 6536.640484773383, 6583.374579414948, 6641.701123449457, 6698.39714425704, 6718.395344419026, 6526.64103474304, 6550.574212676161, 6616.503762217853, 6670.0661907333015, 6742.865142697118, 6770.221424536143, 6784.219814721271, 6794.116764820542, 6806.149231346082, 6809.285025072296, 5449.536789372868, 5475.890482190413, 5544.500994910478, 5548.167774833726, 5573.108302671553, 4673.649476289292, 4678.6491013174145, 4711.740854253049, 4723.551262630044, 4736.621070314367, 5715.8856822864145, 5802.187693722883, 5818.76724930998, 5842.883142337129, 5883.735231914574, 6824.522283440211, 6825.35159159879, 6859.965700171467, 6868.038474613558, 6912.619805910723, 5769.0, 5854.665033206488, 5917.5857689961285, 5920.141579470953, 5936.22829032223, 5813.88372232553, 5966.791162309385, 6026.216591843032, 6028.216331876828, 6079.726412311456, 6488.870222595521, 6492.64290464029, 6548.934510654928, 6549.508786840911, 6559.8032059038305, 6771.0, 6795.660216989229, 6803.149606299213, 6825.590464572141, 6853.554518956252, 6493.415592596689, 6524.282328943717, 6592.571482853599, 6615.073889655356, 6620.3710647488415, 6632.635205063768, 6638.17022872141, 6639.7012134455035, 6734.427573656294, 6772.11962444879, 6594.274629790815, 6696.330366963265, 6760.18877734675, 6811.557248778813, 6814.965925170342, 6443.516736244706, 6515.674216289071, 6519.185101862267, 6526.412622863965, 6530.346965303432, 6578.243501997332, 6613.801585952237, 6636.2368327642935, 6639.966800165968, 6657.234418041987, 6453.838654033687, 6498.610083395011, 6554.901676474952, 6559.983202603604, 6573.3098024706715, 6471.158749362553, 6572.868542629025, 6678.632675202911, 6697.497687673346, 6707.228668703162, 6378.712957916998, 6389.137466441971, 6392.4246817786625, 6427.646479443489, 6473.514486413444], "value": 6140.501593977317, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.623060276971, 842.5408152556856, 848.5163456829607, 880.70936590925, 883.9690610828618, 40424.393634095475, 41283.0, 41381.17237655245, 41425.17149657005, 41530.58469415305, 36034.45948310778, 36170.638293617056, 36179.27641447169, 36267.81866090673, 36295.4555681665, 6779.42374898133, 6907.0, 6913.5506192097355, 6914.239433662293, 6919.031335613018, 6800.863982720342, 6867.450603951672, 6878.449724022066, 6883.724651013953, 6884.931150688504, 7534.284242996907, 7682.1549629540705, 7682.270184332508, 7685.692572297129, 7687.0391201099865, 7538.9246107538775, 7578.204288549678, 7585.279398457165, 7594.050743657043, 7635.083789945214, 7407.18520962699, 7519.962400187964, 7536.434767392468, 7581.772546823604, 7590.24097590242, 36939.4459083114, 37346.813265933495, 37452.62547374546, 37453.81273093617, 37554.0, 3250.3986762448785, 3279.950800737991, 3281.9343613127603, 3283.8850640227715, 3294.4234758917332, 31071.533926991113, 31098.844505777553, 31282.374352512823, 31496.527552086736, 31555.684443155504, 4900.534449227318, 4903.730294833783, 4917.631177661654, 4920.434150072716, 4932.284818701304, 188305.0, 192683.0, 195212.0, 197522.0, 205108.0, 49676.75161624169, 49746.75126624416, 49813.25280120801, 49929.50070499321, 49989.0, 51611.741941290056, 51716.74141629268, 51723.48276517262, 51775.22337164945, 51822.48177518252, 16423.91788041052, 16543.09013004296, 16582.50252492427, 16584.17079146062, 16817.495475135765, 13819.447222111003, 13860.514881979083, 13900.304984750723, 13919.373628186755, 13957.162570245615, 14241.928790356189, 14348.282585870666, 14375.353109109907, 14527.709445811235, 14665.706685866224, 5724.255846739898, 5726.427357264323, 5732.856678583069, 5797.681127538026, 5927.881442371215, 957.9808403831885, 998.9300748947504, 1013.6046941692746, 1014.6905193915926, 1017.7150397888603, 22419.43951401228, 22469.213577525035, 22541.323760287218, 22562.435939101655, 22697.886510567343, 1088.9401082940356, 1094.5348227003492, 1095.7041598768446, 1096.4791723931228, 1128.7347473343757, 12150.392480376122, 12185.573504927284, 12189.0, 12203.69490762738, 12332.136750427564, 237883.0, 238356.0, 238901.0, 239227.0, 239427.0, 51633.0, 51971.48028519667, 52010.219846702326, 52060.0, 52159.47840521622, 1435.7846323051626, 1489.2628149066281, 1491.4108926973784, 1503.4437258214311, 1507.5100592307545, 22460.550788984456, 22623.20818771335, 22781.658275126218, 22828.771712282665, 22845.31464056081, 37228.62771372252, 37277.62722372742, 37308.0, 37328.0, 37392.0, 201760.0, 201870.0, 202349.0, 202917.0, 203034.0, 33592.66407335895, 33863.83068084742, 35782.64217357793, 35905.46141807927, 35919.461208081375, 45189.774051129534, 45920.0, 46130.53869461397, 46658.0, 46666.300005499266, 33821.0, 33999.0, 34023.65976340205, 34035.0, 34355.82822085873, 33377.0, 33397.666023340425, 34060.489092664124, 34174.65825341715, 34414.48378274278, 37012.259754805295, 37293.81353093217, 37317.0, 37349.25301493901, 37792.43311350277, 33584.66415335913, 33736.97578145319, 33755.83122084374, 33939.624226304906, 33990.15024624305, 23992.880035599712, 24318.27045188647, 24417.51164976726, 25081.602299837352, 25185.622215667147], "value": 17142.933066135563, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.977480900764, 565.9405762394946, 568.3265330583259, 581.3169525807177, 586.3960121075293, 22492.10031598736, 22974.195903143394, 23202.18792342266, 23223.535529289424, 23279.068837246534, 25009.49981000379, 26939.191824245303, 27095.458090838172, 27120.5931911021, 27220.183394498148, 6362.522810789198, 6498.44763195129, 6500.219973603174, 6500.252470965828, 6502.284748677642, 6112.174856394397, 6378.266499352588, 6401.455876250524, 6471.676416179196, 6812.114425124727, 6758.324167583227, 6804.149481314836, 6810.659467026654, 6814.591124532544, 6817.352351526597, 6770.289119642441, 6776.322367763233, 6779.220389655204, 6789.694463749143, 6792.15098112731, 6611.272759996396, 6613.14029176204, 6640.369164929324, 6695.698693558801, 6711.161104861892, 32116.0, 32196.356072878647, 32848.6715132848, 33267.0, 33562.32875342504, 1959.9216031358728, 2008.829249513793, 2022.393282015404, 2023.9392818215476, 2030.7563092428854, 20503.69244461334, 20519.5896082079, 20947.790522094736, 21574.784252157435, 21744.238951636777, 2378.108209421467, 2403.6154215325464, 2463.5935070713313, 2470.629405589158, 2474.05985725425, 147154.0, 151948.0, 152258.0, 152845.0, 153910.23044884927, 20206.696899546518, 21262.92651246428, 22274.331770046923, 22709.772902271096, 23774.88112559426, 45064.774676126406, 45073.54926450693, 45113.54886451159, 45242.54757452384, 45392.77303613461, 11967.76064478723, 11969.144782558717, 12125.93937030327, 12413.627591172279, 12428.813567796491, 10102.19182465401, 10256.692299231036, 10269.897301027044, 10351.896481035245, 10490.790184196274, 8477.364197685198, 9487.102579483993, 9530.094641009093, 10949.288296260718, 11596.362200079077, 2596.4417650205296, 2598.4673142005845, 2598.8180827341903, 2730.877110529991, 2730.975884043484, 922.8707980882682, 923.8752768376318, 971.1211353724749, 978.1587834462357, 989.4508547756064, 19472.318468853522, 19729.605407891762, 19902.50243743918, 20272.0, 20476.18095276202, 1017.4709151241314, 1033.1270076785104, 1036.6630844975414, 1045.9372437653765, 1050.1388861133796, 11202.439878006067, 13616.591502254949, 14213.218272995084, 14350.425982960773, 14848.109113453227, 457663.0, 469300.0, 470273.0, 474306.0, 479355.0, 121953.0, 123770.38114809369, 126847.0, 126895.0, 128147.35926320495, 1256.5790460195938, 1267.33464930912, 1289.432649634158, 1291.9728815591627, 1292.3006246785446, 21141.6828747572, 21294.25470108539, 21431.892840535696, 21441.356759297247, 22001.449963751034, 58551.70724146352, 60377.39622603718, 60555.0, 61375.0, 61543.6922815401, 69280.65359673169, 72110.0, 72143.27856721576, 72408.63795680988, 73203.63398182976, 12573.685657858627, 13114.73770524565, 14594.781078284046, 15274.541763747106, 15300.158491283086, 24142.63786043246, 24550.386240344134, 24842.378940526633, 24842.627360589966, 25137.87431062833, 19011.239550417828, 19065.42803715891, 19219.615607688047, 19310.227590896207, 19415.902920485307, 17068.146592670564, 17175.828241717423, 17678.823211767718, 18007.0, 18105.0, 19029.0, 20350.694739578623, 20489.0, 20685.379438616867, 20711.482212944193, 14803.481878134213, 14976.925115374353, 15274.847251527786, 15296.082235065931, 15307.540773776804, 17790.199441024924, 17938.103094845468, 17962.371317003843, 18681.906590466962, 19283.132259048096], "value": 12905.811160110381, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.1783021272129, 1429.7855321701743, 1431.0, 1436.6408397900525, 1442.192372271528, 13891.791623125648, 14531.200783956878, 14561.344739486722, 14568.562943111698, 14600.415983360654, 14258.64353391163, 14716.190609516472, 14717.116972981628, 14729.116253024826, 14753.188574628419, 2661.7870570354376, 2702.162329677796, 2708.9841309508934, 2711.823731457459, 2712.2541301142146, 2548.069954466625, 2568.614707793827, 2600.8699565021675, 2602.1933200707745, 2604.257786530839, 2544.5165418570505, 2663.1611042521545, 2691.8923243070353, 2701.1221353060237, 2707.7021527631946, 2611.725768794278, 2615.3592369869407, 2619.4499155177436, 2621.279148234232, 2626.711061783212, 2583.3799888026924, 2583.5866261398273, 2611.151375802872, 2616.5682662360687, 2616.6859976802716, 13939.372728227254, 14164.15015099087, 14166.220857852813, 14174.858251417458, 14187.78718319226, 7588.962055189689, 7815.765527034198, 7846.333061689763, 7873.409494287894, 7880.2513761192595, 5158.200478925773, 5258.81594144207, 5291.576673866081, 5357.4106848246665, 5386.542143917772, 1839.2275244397385, 1846.243040353462, 1861.6928206845855, 1892.176903047179, 1902.8507819558652, 20558.0, 20730.689039664416, 20843.895780521, 20914.790852091435, 20999.580008399746, 6072.028475443908, 6299.496040316855, 6334.954732469091, 6506.60960342381, 6554.082428460019, 15233.847661523465, 15236.542903712907, 15254.08475491474, 15282.617934551503, 15297.694046119237, 7484.0, 7545.6981720730555, 7594.240575942472, 7661.080670319598, 7666.3866890648615, 5781.739821708034, 6171.56799024064, 6279.654618995908, 6280.591761535486, 7090.92909070913, 5049.091163590516, 5129.0, 5275.261463395128, 5275.868103297448, 5287.259783630295, 1453.4840131753076, 1503.150719843285, 1514.6680493787758, 1517.5143953934635, 1543.1744016950877, 905.8460061789511, 918.820829938169, 922.1792604581927, 935.209747763139, 939.0937745076035, 7468.3278504934815, 7525.285097915689, 7538.396928245727, 7552.66013029415, 7577.621118944031, 712.1240873725243, 726.8400951790597, 727.5452841973766, 733.7028503456108, 737.0786516853933, 4866.537678920497, 5300.496452836975, 5333.0, 5343.919841202307, 5785.450382213683, 20047.799522004883, 20211.494712632302, 20322.695159572617, 20538.281160159324, 20551.075201615964, 20021.899890500747, 20161.899190504246, 20301.086451109735, 20312.0, 20337.898310508353, 10640.46797660114, 10818.621348252773, 11047.116230701524, 11051.99999999984, 11056.0, 8236.588170591327, 8649.437786543855, 8771.517566533646, 8978.10218978097, 8995.910040899507, 17117.914410427868, 17680.292788288323, 17691.911540442215, 17747.378841740476, 17906.462806115836, 17361.13194340303, 17951.281948721906, 17965.640687186446, 18000.459986200436, 18392.26430942747, 12847.421866016239, 13420.39608217613, 13461.0, 13462.124961877447, 13517.526886558922, 13383.933080334536, 13399.598012059654, 13536.390862411019, 13544.86455135436, 13576.456941722616, 10865.619703310345, 10945.813445353146, 11205.943970280096, 11285.266457680225, 11486.655400338002, 10474.4239066849, 10623.681289561326, 10640.680779576625, 10689.786204276026, 10892.40091794959, 9622.230221582116, 9834.852477212704, 9854.655087071918, 9860.309778315735, 9862.063104005108, 7055.294470553109, 7059.611721355374, 7083.82290442743, 7134.108236470442, 7139.535930164523, 7536.284053014955, 7560.848783024198, 7597.696092156473, 7604.353629941295, 7631.0], "value": 6421.6024918227295, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.3520441028866, 503.63234838567865, 519.6881870877471, 522.5323335614625, 524.1691918309477, 6223.222097237845, 6278.874422511547, 6288.842778930529, 6305.936940630592, 6310.337414571472, 6188.319284878659, 6190.504759619231, 6193.1020002099785, 6212.502999760009, 6239.875202495948, 4893.681910675795, 5084.872878178038, 5106.719130447815, 5107.438181799999, 5130.204818253158, 4974.23414687786, 4979.377577802775, 4995.100881841267, 5025.748712564376, 5035.345405097332, 4893.2170852663585, 4936.605071594282, 4943.797771893897, 4979.950200498003, 4995.275685025669, 4916.1732004097785, 4936.876578085541, 4945.480724523945, 4968.30443737877, 5004.049230646184, 4437.689361744679, 4487.41663583732, 4489.685721999462, 4494.5617402431235, 4504.93242601358, 5955.970220148872, 6073.757049718006, 6125.5712100153005, 6185.4330452862005, 6205.255369355661, 5674.829755107354, 5676.829695109153, 5715.828525144252, 5732.0, 5777.942220577783, 6527.281998980108, 6548.93451065488, 6555.737770489175, 6637.800865974028, 6646.501512386542, 4811.206150985084, 4853.762290615906, 4863.440704319013, 4872.269159626049, 4919.0, 6506.186726659168, 6730.899036514456, 6795.538959123812, 6801.897971530431, 6843.247242803288, 4880.658353915192, 4933.840547471342, 4995.25071239317, 5006.0, 5021.297018417425, 5010.298558201855, 5016.698998060128, 5042.445331013586, 5089.9745501272255, 5098.9490105098475, 5687.118496633028, 5689.516391106802, 5691.345495268097, 5721.313442386941, 5756.827295181151, 6606.240282367493, 6662.300458451889, 6681.33186681328, 6720.6639668016405, 6721.6975236114495, 1724.3275122701905, 1734.8698847586481, 1745.790505139366, 1755.5698853780905, 1772.9024903630425, 1142.3774043146338, 1196.4795314038422, 1205.879412058787, 1206.5716670581992, 1207.402335843763, 5765.336986246635, 5775.5090817281, 5810.62230954995, 5816.098504731774, 5820.505257053198, 6624.96687516569, 6713.0, 6740.6966686498245, 6797.116374871334, 6813.488988325896, 5659.18905950092, 5695.629784064023, 5698.629589076697, 5743.822516384132, 5809.448102430262, 3553.378158822196, 3573.160307327776, 3580.337637537064, 3584.4802503637347, 3627.3108109459117, 6427.2929977702415, 6466.256380516207, 6468.54720169593, 6478.2873883872735, 6593.571417857824, 6797.830054248683, 6823.488238382141, 6832.829179270459, 6894.172699276019, 6979.371856532936, 6396.872062558723, 6458.935410645928, 6487.286398496161, 6569.770058047945, 6590.077389165616, 6608.325591152874, 6632.767853125118, 6642.269350371359, 6660.433863121689, 6765.323467653392, 6626.90059649096, 6660.733570657119, 6716.227633821977, 6767.35710107539, 6780.0, 5847.298324200953, 6443.484521238383, 6532.864225171849, 6571.488557631676, 6587.341265873374, 4998.625103117208, 5005.649604527648, 5016.623753218596, 5019.52314530119, 5028.806707740684, 6545.705443254969, 6619.735210591715, 6679.76620818269, 6779.915213565806, 6789.388954994074, 6255.46828519581, 6526.738930442729, 6531.183602049744, 6574.145361103026, 6596.60420374779, 6548.705308261235, 6584.637844918576, 6624.0, 6652.933470665232, 6661.300563440769, 6464.02654778807, 6483.513736469689, 6493.22081350241, 6610.8347291318105, 6614.503912206507, 6532.150820393318, 6536.6731663415685, 6597.60414375139, 6661.16735408074, 6701.430378417694, 6312.274088479883, 6314.62112273265, 6343.55595108338, 6354.714037868214, 6424.903626445701], "value": 5057.341031756558, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [902.6028547439126, 915.3501014279861, 929.586334081334, 932.8041111366613, 937.4937533731783, 18795.62408751824, 19832.305869294578, 19923.800761992377, 19938.202471901106, 22305.665415018786, 21906.23328183514, 22473.887630561865, 22521.887390563024, 22706.0, 22706.205282815106, 1025.697419261318, 1051.0435503691642, 1053.1732589916917, 1053.8419237114456, 1057.3867157048894, 972.6838777397375, 1035.9015893490107, 1046.6284469013506, 1050.5850189175271, 1051.1118105201092, 1078.6386560502242, 1095.5672509358799, 1097.023648952433, 1097.2154909239891, 1097.4293367448922, 1081.3457857995877, 1094.9069329107076, 1095.1622009162998, 1095.5453486803008, 1095.9342439453658, 789.2423273657296, 797.6530209358947, 800.7637746864631, 800.7677773445752, 801.0187520287659, 19941.40175794714, 20512.179512819468, 20612.484687882774, 20721.8963905181, 20754.896225518925, 21239.893800531052, 21536.0, 21688.891555542123, 21794.673079903656, 21991.120355185933, 16572.254248558846, 16649.83350166495, 16829.41097061597, 17088.743668844978, 17648.205830737646, 3732.3841566141828, 3745.550533935945, 3749.1189570450924, 3750.79370634615, 3766.39737641976, 128992.0, 129973.35013324967, 130001.0, 133279.4112507427, 134109.0, 16489.587760306087, 17105.82894171067, 17224.913875430542, 17341.0, 17355.21901514435, 31360.21599459986, 32235.194120147185, 32265.193370165933, 32320.515192272134, 32777.0, 7766.106897706723, 8074.636641351153, 8329.292010179202, 8385.245327920395, 8514.616842242114, 4247.957520424818, 4321.6974811762875, 4332.783360831946, 4343.587359200871, 4349.739015659071, 5237.135872581058, 5303.708296043755, 5327.493888080626, 5336.4129945705945, 5346.331708536433, 1025.3181634213313, 1044.0290529807353, 1055.2613170780485, 1057.2916146182076, 1058.5077938758513, 690.1200968764765, 707.345705222667, 716.813628456605, 720.0, 723.5043994863536, 11495.885041149482, 11694.52142718529, 11939.0, 12024.338661373533, 12303.015758739279, 703.4513079797664, 713.3009650542498, 714.4784307455586, 717.8600172966326, 722.7831650504828, 5274.393444753902, 5303.973480132575, 5330.413654498002, 5347.786088556414, 5449.209864569615, 116077.4196129014, 116100.0, 116582.41708791572, 120165.0, 123900.0, 102687.48656256672, 103438.0, 105172.0, 109463.45268273608, 109977.45011274892, 82346.58826705828, 87402.56298718466, 90026.0, 91957.08042919618, 94767.0523294772, 12267.938660306641, 12425.689357766129, 13029.478820847438, 13128.474861005452, 13322.0, 40173.799131004154, 40283.0, 40490.39264410977, 41222.9694257646, 41228.969275768344, 69617.0, 69685.0, 71704.64147679228, 72154.27845721475, 76659.61670191614, 17522.9123854385, 18060.187291572172, 19211.90394048021, 19460.12429440707, 19702.1134048971, 21449.249276275255, 21549.138034478445, 21581.13675452964, 21831.126754929624, 22167.44581385478, 18939.0, 19241.0, 19457.221711131395, 19988.20047198096, 19990.20039198416, 16319.18404079815, 16838.158092095593, 18135.637287254445, 18169.636607268047, 18172.45482635523, 16790.412335568195, 16821.0, 16920.407785727934, 17412.39056633012, 18692.34576789806, 14332.426702932184, 14525.201113938834, 14540.85459145395, 14827.110373377633, 14865.554033379016, 14664.633384165054, 15238.847611524187, 15362.769558456408, 15384.692306154038, 15634.9218253908], "value": 9446.4332843588, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 108.0, 105.0, 109.0, 108.0, 111.0, 108.0, 100.0, 113.0, 107.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 141.0, 180.0, 118.0, 141.0, 150.0, 118.0, 178.0, 124.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 166.0, 166.0, 172.0, 170.0, 167.0, 165.0, 166.0], "value": 166.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 178.0, 75.0, 74.0, 74.0, 73.0, 159.0, 77.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 134.0, 88.0, 80.0, 79.0, 130.0, 78.0, 79.0, 128.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 115.0, 115.0, 115.0, 114.0, 115.0, 117.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 156.0, 157.0, 150.0, 152.0, 152.0, 150.0, 151.0, 152.0], "value": 152.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 102.0, 104.0, 94.0, 94.0, 95.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 67.0, 63.0, 53.0, 60.0, 53.0, 62.0, 57.0, 60.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 55.0, 57.0, 54.0, 54.0, 54.0, 60.0, 55.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 79.0, 78.0, 82.0, 81.0, 86.0, 83.0, 78.0, 78.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 129.0, 139.0, 127.0, 123.0, 132.0, 133.0, 123.0, 124.0, 179.0], "value": 133.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 176.0, 177.0, 183.0, 181.0, 176.0, 183.0, 181.0, 190.0, 174.0], "value": 180.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 67.0, 69.0, 73.0, 68.0, 67.0, 70.0, 74.0, 74.0], "value": 70.1, "unit": "score"}]}]} 04:40:56 INFO - Return code: 0 04:40:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:40:56 INFO - # TBPL SUCCESS # 04:40:56 INFO - Running post-action listener: _package_coverage_data 04:40:56 INFO - Running post-action listener: _resource_record_post_action 04:40:56 INFO - [mozharness: 2017-08-11 11:40:56.514817Z] Finished run-tests step (success) 04:40:56 INFO - Running post-run listener: _resource_record_post_run 04:40:56 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 429355008; Read time: 60; Write time: 434880 04:40:56 INFO - TinderboxPrint: CPU usage
13.2% 04:40:56 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 60 04:40:56 INFO - TinderboxPrint: I/O write bytes / time
429,355,008 / 434,880 04:40:56 INFO - TinderboxPrint: CPU idle
8,278.1 (86.8%) 04:40:56 INFO - TinderboxPrint: CPU user
1,203.9 (12.6%) 04:40:56 INFO - TinderboxPrint: Swap in / out
0 / 0 04:40:56 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107302912; Read time: 0; Write time: 153208 04:40:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:40:56 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 4096; Write bytes: 322052096; Read time: 48; Write time: 281672 04:40:57 INFO - Running post-run listener: _upload_blobber_files 04:40:57 INFO - Blob upload gear active. 04:40:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:40:57 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 04:40:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:40:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:40:57 INFO - (blobuploader) - INFO - Open directory for files ... 04:40:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:40:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:40:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:40:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:40:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:40:58 INFO - (blobuploader) - INFO - Done attempting. 04:40:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:40:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:40:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:41:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:04 INFO - (blobuploader) - INFO - Done attempting. 04:41:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:41:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:41:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:05 INFO - (blobuploader) - INFO - Done attempting. 04:41:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:41:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:41:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:06 INFO - (blobuploader) - INFO - Done attempting. 04:41:06 INFO - (blobuploader) - INFO - Iteration through files over. 04:41:06 INFO - Return code: 0 04:41:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:41:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:41:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7fa31dc6b7d9ed7661ebc3855c764834ad02e7ab08e1c2f8310df61c264e41272b68ff6b82a577095d40335c2e59d6e7c07a4029a91bb6ece1d8ce2ba889695", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c7065279592af65099070a61a84a3e5b52f01ded25054969795a7392a1c3079ba1ae102a591c34c764ad6830da08c774286a4b4d5edc8a9a431ba284b67a71f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25a7c1f1940f1a227515c09452279f4f3a0055f78e0384595b1c8be92476b2218f6187e2103676bc1b636f381c44a9515c93a5467321845311b6ec62a941afc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfa8a0a1a2bff429db0f9de95908fec910927d7498895ef15ea64a2923d42ab61a69edbc81f4395f1b905b7ce338f1a80ff8fdc0efa9fcb9773c46ebfcbefa9c"} 04:41:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:41:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:41:06 INFO - Contents: 04:41:06 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7fa31dc6b7d9ed7661ebc3855c764834ad02e7ab08e1c2f8310df61c264e41272b68ff6b82a577095d40335c2e59d6e7c07a4029a91bb6ece1d8ce2ba889695", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c7065279592af65099070a61a84a3e5b52f01ded25054969795a7392a1c3079ba1ae102a591c34c764ad6830da08c774286a4b4d5edc8a9a431ba284b67a71f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25a7c1f1940f1a227515c09452279f4f3a0055f78e0384595b1c8be92476b2218f6187e2103676bc1b636f381c44a9515c93a5467321845311b6ec62a941afc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfa8a0a1a2bff429db0f9de95908fec910927d7498895ef15ea64a2923d42ab61a69edbc81f4395f1b905b7ce338f1a80ff8fdc0efa9fcb9773c46ebfcbefa9c"} 04:41:06 INFO - Running post-run listener: copy_logs_to_upload_dir 04:41:06 INFO - Copying logs to upload dir... 04:41:06 INFO - mkdir: /builds/slave/test/build/upload/logs 04:41:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.615948 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-11 04:41:06.388646) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-11 04:41:06.391760) ========= 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=930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7fa31dc6b7d9ed7661ebc3855c764834ad02e7ab08e1c2f8310df61c264e41272b68ff6b82a577095d40335c2e59d6e7c07a4029a91bb6ece1d8ce2ba889695", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c7065279592af65099070a61a84a3e5b52f01ded25054969795a7392a1c3079ba1ae102a591c34c764ad6830da08c774286a4b4d5edc8a9a431ba284b67a71f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25a7c1f1940f1a227515c09452279f4f3a0055f78e0384595b1c8be92476b2218f6187e2103676bc1b636f381c44a9515c93a5467321845311b6ec62a941afc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfa8a0a1a2bff429db0f9de95908fec910927d7498895ef15ea64a2923d42ab61a69edbc81f4395f1b905b7ce338f1a80ff8fdc0efa9fcb9773c46ebfcbefa9c"} build_url:https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011418 build_url: 'https://queue.taskcluster.net/v1/task/B9z7C-sPS86eeKbhbIEBpQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7fa31dc6b7d9ed7661ebc3855c764834ad02e7ab08e1c2f8310df61c264e41272b68ff6b82a577095d40335c2e59d6e7c07a4029a91bb6ece1d8ce2ba889695", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c7065279592af65099070a61a84a3e5b52f01ded25054969795a7392a1c3079ba1ae102a591c34c764ad6830da08c774286a4b4d5edc8a9a431ba284b67a71f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25a7c1f1940f1a227515c09452279f4f3a0055f78e0384595b1c8be92476b2218f6187e2103676bc1b636f381c44a9515c93a5467321845311b6ec62a941afc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfa8a0a1a2bff429db0f9de95908fec910927d7498895ef15ea64a2923d42ab61a69edbc81f4395f1b905b7ce338f1a80ff8fdc0efa9fcb9773c46ebfcbefa9c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-11 04:41:06.416375) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 04:41:06.416687) ========= 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=930c87414c89fc706ee2024c000001c6-1502449635.349495-2021614323 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 04:41:06.499502) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-11 04:41:06.499814) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-11 04:41:06.500110) ========= ========= Total master_lag: 0.16 =========