builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1501931130.68 results: success (0) revision: 933a04a91ce3bd44b230937083a835cb60637084 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-05 04:05:30.683732) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-05 04:05:30.684203) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-05 04:05:30.684612) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-05 04:05:30.755326) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 04:05:30.755675) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-05 04:05:31-- 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% 30.5M=0s 2017-08-05 04:05:31 (30.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123692 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 04:05:30.917526) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 04:05:30.917812) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019149 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 04:05:30.967017) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 04:05:30.967309) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 933a04a91ce3bd44b230937083a835cb60637084 --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 933a04a91ce3bd44b230937083a835cb60637084 --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=9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-05 04:05:31,258 truncating revision to first 12 chars 2017-08-05 04:05:31,258 Setting DEBUG logging. 2017-08-05 04:05:31,258 attempt 1/10 2017-08-05 04:05:31,259 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/933a04a91ce3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-05 04:05:31,706 unpacking tar archive at: mozilla-central-933a04a91ce3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.787373 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 04:05:31.773505) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-05 04:05:31.773820) ========= script_repo_revision: 933a04a91ce3bd44b230937083a835cb60637084 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-05 04:05:31.774210) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-05 04:05:31.774486) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-05 04:05:31.784455) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-05 04:05:31.784787) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:05:32 INFO - MultiFileLogger online at 20170805 04:05:32 in /builds/slave/test 04:05:32 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:05:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:05:32 INFO - {'append_to_log': False, 04:05:32 INFO - 'base_work_dir': '/builds/slave/test', 04:05:32 INFO - 'blob_upload_branch': 'Firefox', 04:05:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:05:32 INFO - 'branch': 'Firefox', 04:05:32 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:32 INFO - 'code_coverage': False, 04:05:32 INFO - 'config_files': ('talos/linux_config.py',), 04:05:32 INFO - 'default_actions': ('clobber', 04:05:32 INFO - 'read-buildbot-config', 04:05:32 INFO - 'download-and-extract', 04:05:32 INFO - 'populate-webroot', 04:05:32 INFO - 'create-virtualenv', 04:05:32 INFO - 'install', 04:05:32 INFO - 'setup-mitmproxy', 04:05:32 INFO - 'run-tests'), 04:05:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:32 INFO - 'disable_ccov_upload': False, 04:05:32 INFO - 'download_minidump_stackwalk': True, 04:05:32 INFO - 'download_symbols': 'ondemand', 04:05:32 INFO - 'enable_stylo': False, 04:05:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:05:32 INFO - 'tooltool.py': '/tools/tooltool.py', 04:05:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:05:32 INFO - '/tools/misc-python/virtualenv.py')}, 04:05:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:32 INFO - 'gecko_profile': False, 04:05:32 INFO - 'gecko_profile_interval': 0, 04:05:32 INFO - 'installer_path': 'installer.exe', 04:05:32 INFO - 'log_level': 'info', 04:05:32 INFO - 'log_name': 'talos', 04:05:32 INFO - 'log_to_console': True, 04:05:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:05:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:05:32 INFO - 'opt_config_files': (), 04:05:32 INFO - 'pip_index': False, 04:05:32 INFO - 'suite': 'dromaeojs-e10s', 04:05:32 INFO - 'system_bits': '32', 04:05:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:32 INFO - 'title': 'talos-linux64-ix-013', 04:05:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:32 INFO - 'use_talos_json': True, 04:05:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:05:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:32 INFO - 'work_dir': 'build'} 04:05:32 INFO - [mozharness: 2017-08-05 11:05:32.180763Z] Running clobber step. 04:05:32 INFO - Running pre-action listener: _resource_record_pre_action 04:05:32 INFO - Running main action method: clobber 04:05:32 INFO - rmtree: /builds/slave/test/build 04:05:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:05:33 INFO - Running post-action listener: _resource_record_post_action 04:05:33 INFO - [mozharness: 2017-08-05 11:05:33.733448Z] Finished clobber step (success) 04:05:33 INFO - [mozharness: 2017-08-05 11:05:33.733551Z] Running read-buildbot-config step. 04:05:33 INFO - Running pre-action listener: _resource_record_pre_action 04:05:33 INFO - Running main action method: read_buildbot_config 04:05:33 INFO - Using buildbot properties: 04:05:33 INFO - { 04:05:33 INFO - "project": "", 04:05:33 INFO - "product": "firefox", 04:05:33 INFO - "who": "archaeopteryx@coole-files.de", 04:05:33 INFO - "installer_path": "public/build/target.tar.bz2", 04:05:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:05:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:05:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 04:05:33 INFO - "stage_platform": "linux64-pgo", 04:05:33 INFO - "basedir": "/builds/slave/test", 04:05:33 INFO - "buildnumber": 100, 04:05:33 INFO - "platform": "ubuntu64_hw", 04:05:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:05:33 INFO - "slavebuilddir": "test", 04:05:33 INFO - "taskId": "TKfr4SaLRhWh8OgvIsso7w", 04:05:33 INFO - "branch": "mozilla-central", 04:05:33 INFO - "script_repo_revision": "production", 04:05:33 INFO - "revision": "933a04a91ce3bd44b230937083a835cb60637084", 04:05:33 INFO - "slavename": "talos-linux64-ix-013", 04:05:33 INFO - "repo_path": "mozilla-central" 04:05:33 INFO - } 04:05:33 INFO - Finding installer, test and symbols from parent task. 04:05:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TKfr4SaLRhWh8OgvIsso7w'}, attempt #1 04:05:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TKfr4SaLRhWh8OgvIsso7w'}, attempt #1 04:05:34 INFO - Task dependencies: eQ05MNmUTf6ka9Q4eropRw 04:05:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw'}, attempt #1 04:05:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.tar.bz2 04:05:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.test_packages.json 04:05:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.crashreporter-symbols.zip 04:05:35 INFO - Running post-action listener: _resource_record_post_action 04:05:35 INFO - [mozharness: 2017-08-05 11:05:35.083137Z] Finished read-buildbot-config step (success) 04:05:35 INFO - [mozharness: 2017-08-05 11:05:35.083360Z] Running download-and-extract step. 04:05:35 INFO - Running pre-action listener: _resource_record_pre_action 04:05:35 INFO - Running main action method: download_and_extract 04:05:35 INFO - mkdir: /builds/slave/test/build/tests 04:05:35 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:05:35 INFO - trying https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.test_packages.json 04:05:35 INFO - Downloading https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:05:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:05:35 INFO - Downloaded 989 bytes. 04:05:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:05:35 INFO - Using the following test package requirements: 04:05:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:05:35 INFO - u'common': [u'target.common.tests.zip'], 04:05:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:05:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:05:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:05:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:05:35 INFO - u'mozbase': [u'target.common.tests.zip'], 04:05:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:05:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:05:35 INFO - u'web-platform': [u'target.common.tests.zip', 04:05:35 INFO - u'target.web-platform.tests.tar.gz'], 04:05:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:05:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:05:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.common.tests.zip 04:05:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:05:35 INFO - Fetch https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.common.tests.zip into memory 04:05:37 INFO - Content-Length response header: 54902435 04:05:37 INFO - Bytes received: 54902435 04:05:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:05:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.common.tests.zip 04:05:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:05:48 INFO - Fetch https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.common.tests.zip into memory 04:05:49 INFO - Content-Length response header: 54902435 04:05:49 INFO - Bytes received: 54902435 04:06:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.talos.tests.zip 04:06:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:06:01 INFO - Fetch https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.talos.tests.zip into memory 04:06:01 INFO - Content-Length response header: 14496008 04:06:01 INFO - Bytes received: 14496008 04:06:02 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:06:02 INFO - trying https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.tar.bz2 04:06:02 INFO - Downloading https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:06:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:06:04 INFO - Downloaded 62781846 bytes. 04:06:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.tar.bz2 04:06:04 INFO - mkdir: /builds/slave/test/properties 04:06:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:06:04 INFO - Writing to file /builds/slave/test/properties/build_url 04:06:04 INFO - Contents: 04:06:04 INFO - build_url:https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.tar.bz2 04:06:04 INFO - Running post-action listener: _resource_record_post_action 04:06:04 INFO - Running post-action listener: set_extra_try_arguments 04:06:04 INFO - [mozharness: 2017-08-05 11:06:04.440011Z] Finished download-and-extract step (success) 04:06:04 INFO - [mozharness: 2017-08-05 11:06:04.440110Z] Running populate-webroot step. 04:06:04 INFO - Running pre-action listener: _resource_record_pre_action 04:06:04 INFO - Running main action method: populate_webroot 04:06:04 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:06:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:06:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:06:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:06:04 INFO - 'tests': ['damp', 'tps']}, 04:06:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:06:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:06:04 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:06:04 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:06:04 INFO - 'other-e10s': {'tests': ['a11yr', 04:06:04 INFO - 'ts_paint', 04:06:04 INFO - 'tpaint', 04:06:04 INFO - 'sessionrestore', 04:06:04 INFO - 'sessionrestore_many_windows', 04:06:04 INFO - 'sessionrestore_no_auto_restore', 04:06:04 INFO - 'tabpaint']}, 04:06:04 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:06:04 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:06:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:06:04 INFO - 'tsvgr_opacity', 04:06:04 INFO - 'tart', 04:06:04 INFO - 'tscrollx', 04:06:04 INFO - 'tsvg_static']}, 04:06:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:06:04 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:06:04 INFO - 'talos_options': ['--mitmproxy', 04:06:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:06:04 INFO - '--firstNonBlankPaint'], 04:06:04 INFO - 'tests': ['tp6_google', 04:06:04 INFO - 'tp6_youtube', 04:06:04 INFO - 'tp6_amazon', 04:06:04 INFO - 'tp6_facebook']}, 04:06:04 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:06:04 INFO - 'talos_options': ['--stylo', 04:06:04 INFO - '--mitmproxy', 04:06:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:06:04 INFO - '--firstNonBlankPaint'], 04:06:04 INFO - 'tests': ['tp6_google', 04:06:04 INFO - 'tp6_youtube', 04:06:04 INFO - 'tp6_amazon', 04:06:04 INFO - 'tp6_facebook']}, 04:06:04 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:06:04 INFO - 'talos_options': ['--stylo', 04:06:04 INFO - '--stylo-threads=1', 04:06:04 INFO - '--mitmproxy', 04:06:04 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:06:04 INFO - '--firstNonBlankPaint'], 04:06:04 INFO - 'tests': ['tp6_google', 04:06:04 INFO - 'tp6_youtube', 04:06:04 INFO - 'tp6_amazon', 04:06:04 INFO - 'tp6_facebook']}, 04:06:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:06:04 INFO - 'talos_options': ['--xperf_path', 04:06:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:04 INFO - 'tests': ['tp5n']}}} 04:06:04 INFO - Running post-action listener: _resource_record_post_action 04:06:04 INFO - [mozharness: 2017-08-05 11:06:04.448636Z] Finished populate-webroot step (success) 04:06:04 INFO - [mozharness: 2017-08-05 11:06:04.448727Z] Running create-virtualenv step. 04:06:04 INFO - Running pre-action listener: _resource_record_pre_action 04:06:04 INFO - Running main action method: create_virtualenv 04:06:04 INFO - Creating virtualenv /builds/slave/test/build/venv 04:06:04 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:06:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:06:04 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:06:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:06:04 INFO - Using real prefix '/usr' 04:06:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:06:05 INFO - Installing distribute.............................................................................................................................................................................................done. 04:06:07 INFO - Installing pip.................done. 04:06:07 INFO - Return code: 0 04:06:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:06:07 INFO - Reading from file tmpfile_stdout 04:06:07 INFO - Output received: 04:06:07 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:06:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:06:07 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:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:07 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:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:07 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 0x1f901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ffd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fceb0>, '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 0x22fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', '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:06:07 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:06:07 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:06:07 INFO - Using env: {'DISPLAY': ':0', 04:06:07 INFO - 'HOME': '/home/cltbld', 04:06:07 INFO - 'LANG': 'en_US.UTF-8', 04:06:07 INFO - 'LANGUAGE': 'en_US:en', 04:06:07 INFO - 'LOGNAME': 'cltbld', 04:06:07 INFO - 'MAIL': '/var/mail/cltbld', 04:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:07 INFO - 'MOZ_NO_REMOTE': '1', 04:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:07 INFO - 'NO_EM_RESTART': '1', 04:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:07 INFO - 'PWD': '/builds/slave/test', 04:06:07 INFO - 'SHELL': '/bin/bash', 04:06:07 INFO - 'SHLVL': '1', 04:06:07 INFO - 'TERM': 'linux', 04:06:07 INFO - 'TMOUT': '86400', 04:06:07 INFO - 'USER': 'cltbld', 04:06:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', 04:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:07 INFO - '_': '/tools/buildbot/bin/python'} 04:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:07 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:06:07 INFO - Cleaning up... 04:06:07 INFO - Return code: 0 04:06:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:06:07 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:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:07 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:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:07 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 0x1f901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ffd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fceb0>, '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 0x22fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', '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:06:07 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:06:07 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:06:07 INFO - Using env: {'DISPLAY': ':0', 04:06:07 INFO - 'HOME': '/home/cltbld', 04:06:07 INFO - 'LANG': 'en_US.UTF-8', 04:06:07 INFO - 'LANGUAGE': 'en_US:en', 04:06:07 INFO - 'LOGNAME': 'cltbld', 04:06:07 INFO - 'MAIL': '/var/mail/cltbld', 04:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:07 INFO - 'MOZ_NO_REMOTE': '1', 04:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:07 INFO - 'NO_EM_RESTART': '1', 04:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:07 INFO - 'PWD': '/builds/slave/test', 04:06:07 INFO - 'SHELL': '/bin/bash', 04:06:07 INFO - 'SHLVL': '1', 04:06:07 INFO - 'TERM': 'linux', 04:06:07 INFO - 'TMOUT': '86400', 04:06:07 INFO - 'USER': 'cltbld', 04:06:07 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', 04:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:07 INFO - '_': '/tools/buildbot/bin/python'} 04:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:07 INFO - Downloading/unpacking psutil>=3.1.1 04:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:06:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:08 INFO - Installing collected packages: psutil 04:06:08 INFO - Running setup.py install for psutil 04:06:08 INFO - building 'psutil._psutil_linux' extension 04:06:08 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:06:09 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:06:09 INFO - building 'psutil._psutil_posix' extension 04:06:09 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:06:09 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:06:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:09 INFO - Successfully installed psutil 04:06:09 INFO - Cleaning up... 04:06:09 INFO - Return code: 0 04:06:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:06:09 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:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:09 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:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1f901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ffd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fceb0>, '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 0x22fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', '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:06:09 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:06:09 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:06:09 INFO - Using env: {'DISPLAY': ':0', 04:06:09 INFO - 'HOME': '/home/cltbld', 04:06:09 INFO - 'LANG': 'en_US.UTF-8', 04:06:09 INFO - 'LANGUAGE': 'en_US:en', 04:06:09 INFO - 'LOGNAME': 'cltbld', 04:06:09 INFO - 'MAIL': '/var/mail/cltbld', 04:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:09 INFO - 'MOZ_NO_REMOTE': '1', 04:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:09 INFO - 'NO_EM_RESTART': '1', 04:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:09 INFO - 'PWD': '/builds/slave/test', 04:06:09 INFO - 'SHELL': '/bin/bash', 04:06:09 INFO - 'SHLVL': '1', 04:06:09 INFO - 'TERM': 'linux', 04:06:09 INFO - 'TMOUT': '86400', 04:06:09 INFO - 'USER': 'cltbld', 04:06:09 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', 04:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:09 INFO - '_': '/tools/buildbot/bin/python'} 04:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:06:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:06:10 INFO - Installing collected packages: mozsystemmonitor 04:06:10 INFO - Running setup.py install for mozsystemmonitor 04:06:10 INFO - Successfully installed mozsystemmonitor 04:06:10 INFO - Cleaning up... 04:06:10 INFO - Return code: 0 04:06:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:06: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:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06: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:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:10 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 0x1f901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ffd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fceb0>, '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 0x22fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', '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:06:10 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:06:10 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:06:10 INFO - Using env: {'DISPLAY': ':0', 04:06:10 INFO - 'HOME': '/home/cltbld', 04:06:10 INFO - 'LANG': 'en_US.UTF-8', 04:06:10 INFO - 'LANGUAGE': 'en_US:en', 04:06:10 INFO - 'LOGNAME': 'cltbld', 04:06:10 INFO - 'MAIL': '/var/mail/cltbld', 04:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:10 INFO - 'MOZ_NO_REMOTE': '1', 04:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:10 INFO - 'NO_EM_RESTART': '1', 04:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:10 INFO - 'PWD': '/builds/slave/test', 04:06:10 INFO - 'SHELL': '/bin/bash', 04:06:10 INFO - 'SHLVL': '1', 04:06:10 INFO - 'TERM': 'linux', 04:06:10 INFO - 'TMOUT': '86400', 04:06:10 INFO - 'USER': 'cltbld', 04:06:10 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', 04:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:10 INFO - '_': '/tools/buildbot/bin/python'} 04:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:11 INFO - Downloading/unpacking jsonschema==2.5.1 04:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:06:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:12 INFO - Downloading functools32-3.2.3-2.tar.gz 04:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:06:12 INFO - warning: no files found matching '*.txt' 04:06:12 INFO - no previously-included directories found matching 'build' 04:06:12 INFO - no previously-included directories found matching 'dist' 04:06:12 INFO - no previously-included directories found matching '.git*' 04:06:12 INFO - Installing collected packages: jsonschema, functools32 04:06:12 INFO - Running setup.py install for functools32 04:06:12 INFO - warning: no files found matching '*.txt' 04:06:12 INFO - no previously-included directories found matching 'build' 04:06:12 INFO - no previously-included directories found matching 'dist' 04:06:12 INFO - no previously-included directories found matching '.git*' 04:06:12 INFO - Successfully installed jsonschema functools32 04:06:12 INFO - Cleaning up... 04:06:12 INFO - Return code: 0 04:06:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:06:12 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:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:12 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:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:12 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 0x1f901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ffd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fceb0>, '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 0x22fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', '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:06:12 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:06:12 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:06:12 INFO - Using env: {'DISPLAY': ':0', 04:06:12 INFO - 'HOME': '/home/cltbld', 04:06:12 INFO - 'LANG': 'en_US.UTF-8', 04:06:12 INFO - 'LANGUAGE': 'en_US:en', 04:06:12 INFO - 'LOGNAME': 'cltbld', 04:06:12 INFO - 'MAIL': '/var/mail/cltbld', 04:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:12 INFO - 'MOZ_NO_REMOTE': '1', 04:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:12 INFO - 'NO_EM_RESTART': '1', 04:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:12 INFO - 'PWD': '/builds/slave/test', 04:06:12 INFO - 'SHELL': '/bin/bash', 04:06:12 INFO - 'SHLVL': '1', 04:06:12 INFO - 'TERM': 'linux', 04:06:12 INFO - 'TMOUT': '86400', 04:06:12 INFO - 'USER': 'cltbld', 04:06:12 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', 04:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:12 INFO - '_': '/tools/buildbot/bin/python'} 04:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:06:12 INFO - Cleaning up... 04:06:12 INFO - Return code: 0 04:06:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:06:12 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:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:12 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:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:12 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 0x1f901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ffd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fceb0>, '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 0x22fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', '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:06:12 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:06:12 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:06:12 INFO - Using env: {'DISPLAY': ':0', 04:06:12 INFO - 'HOME': '/home/cltbld', 04:06:12 INFO - 'LANG': 'en_US.UTF-8', 04:06:12 INFO - 'LANGUAGE': 'en_US:en', 04:06:12 INFO - 'LOGNAME': 'cltbld', 04:06:12 INFO - 'MAIL': '/var/mail/cltbld', 04:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:12 INFO - 'MOZ_NO_REMOTE': '1', 04:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:12 INFO - 'NO_EM_RESTART': '1', 04:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:12 INFO - 'PWD': '/builds/slave/test', 04:06:12 INFO - 'SHELL': '/bin/bash', 04:06:12 INFO - 'SHLVL': '1', 04:06:12 INFO - 'TERM': 'linux', 04:06:12 INFO - 'TMOUT': '86400', 04:06:12 INFO - 'USER': 'cltbld', 04:06:12 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', 04:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:12 INFO - '_': '/tools/buildbot/bin/python'} 04:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:12 INFO - Downloading/unpacking blobuploader==1.2.4 04:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:14 INFO - Downloading blobuploader-1.2.4.tar.gz 04:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:06:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:06:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:14 INFO - Downloading docopt-0.6.1.tar.gz 04:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:06:14 INFO - Installing collected packages: blobuploader, requests, docopt 04:06:14 INFO - Running setup.py install for blobuploader 04:06:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:06:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:06:14 INFO - Running setup.py install for requests 04:06:15 INFO - Running setup.py install for docopt 04:06:15 INFO - Successfully installed blobuploader requests docopt 04:06:15 INFO - Cleaning up... 04:06:15 INFO - Return code: 0 04:06:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:15 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:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:15 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:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1f901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ffd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fceb0>, '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 0x22fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', '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:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:06:15 INFO - Using env: {'DISPLAY': ':0', 04:06:15 INFO - 'HOME': '/home/cltbld', 04:06:15 INFO - 'LANG': 'en_US.UTF-8', 04:06:15 INFO - 'LANGUAGE': 'en_US:en', 04:06:15 INFO - 'LOGNAME': 'cltbld', 04:06:15 INFO - 'MAIL': '/var/mail/cltbld', 04:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:15 INFO - 'MOZ_NO_REMOTE': '1', 04:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:15 INFO - 'NO_EM_RESTART': '1', 04:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:15 INFO - 'PWD': '/builds/slave/test', 04:06:15 INFO - 'SHELL': '/bin/bash', 04:06:15 INFO - 'SHLVL': '1', 04:06:15 INFO - 'TERM': 'linux', 04:06:15 INFO - 'TMOUT': '86400', 04:06:15 INFO - 'USER': 'cltbld', 04:06:15 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', 04:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:15 INFO - '_': '/tools/buildbot/bin/python'} 04:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:15 INFO - Running setup.py (path:/tmp/pip-c6Vkv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:15 INFO - Running setup.py (path:/tmp/pip-pFEeH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:15 INFO - Running setup.py (path:/tmp/pip-ZUHvsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:15 INFO - Running setup.py (path:/tmp/pip-ygmcyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:15 INFO - Running setup.py (path:/tmp/pip-DfP1_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:15 INFO - Running setup.py (path:/tmp/pip-NqtAzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:15 INFO - Running setup.py (path:/tmp/pip-A7Wm5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:15 INFO - Running setup.py (path:/tmp/pip-gCJgef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:16 INFO - Running setup.py (path:/tmp/pip-RVDqEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:16 INFO - Running setup.py (path:/tmp/pip-Y18QpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:16 INFO - Running setup.py (path:/tmp/pip-ruzTL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:16 INFO - Running setup.py (path:/tmp/pip-pHmhhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:16 INFO - Running setup.py (path:/tmp/pip-rjrILH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:16 INFO - Running setup.py (path:/tmp/pip-szobrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:16 INFO - Running setup.py (path:/tmp/pip-i4K6KG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:16 INFO - Running setup.py (path:/tmp/pip-qWdCo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:16 INFO - Running setup.py (path:/tmp/pip-42BsAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:06:16 INFO - Running setup.py install for manifestparser 04:06:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:06:16 INFO - Running setup.py install for mozcrash 04:06:16 INFO - Running setup.py install for mozdebug 04:06:17 INFO - Running setup.py install for mozdevice 04:06:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:06:17 INFO - Running setup.py install for mozfile 04:06:17 INFO - Running setup.py install for mozhttpd 04:06:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:06:17 INFO - Running setup.py install for mozinfo 04:06:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:06:17 INFO - Running setup.py install for mozInstall 04:06:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:06:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:06:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:06:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:06:17 INFO - Running setup.py install for mozleak 04:06:17 INFO - Running setup.py install for mozlog 04:06:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:06:17 INFO - Running setup.py install for moznetwork 04:06:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:06:17 INFO - Running setup.py install for mozprocess 04:06:17 INFO - Running setup.py install for mozprofile 04:06:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:06:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:06:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:06:18 INFO - Running setup.py install for mozrunner 04:06:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:06:18 INFO - Running setup.py install for mozscreenshot 04:06:18 INFO - Running setup.py install for moztest 04:06:18 INFO - Running setup.py install for mozversion 04:06:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:06:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:06:18 INFO - Cleaning up... 04:06:18 INFO - Return code: 0 04:06:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06: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:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06: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:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1f901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ffd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fceb0>, '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 0x22fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', '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:06:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:06:18 INFO - Using env: {'DISPLAY': ':0', 04:06:18 INFO - 'HOME': '/home/cltbld', 04:06:18 INFO - 'LANG': 'en_US.UTF-8', 04:06:18 INFO - 'LANGUAGE': 'en_US:en', 04:06:18 INFO - 'LOGNAME': 'cltbld', 04:06:18 INFO - 'MAIL': '/var/mail/cltbld', 04:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:18 INFO - 'MOZ_NO_REMOTE': '1', 04:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:18 INFO - 'NO_EM_RESTART': '1', 04:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:18 INFO - 'PWD': '/builds/slave/test', 04:06:18 INFO - 'SHELL': '/bin/bash', 04:06:18 INFO - 'SHLVL': '1', 04:06:18 INFO - 'TERM': 'linux', 04:06:18 INFO - 'TMOUT': '86400', 04:06:18 INFO - 'USER': 'cltbld', 04:06:18 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', 04:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:18 INFO - '_': '/tools/buildbot/bin/python'} 04:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:18 INFO - Running setup.py (path:/tmp/pip-8lH7eE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:18 INFO - Running setup.py (path:/tmp/pip-NTccQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:18 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:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:18 INFO - Running setup.py (path:/tmp/pip-sOhNb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:18 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:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:18 INFO - Running setup.py (path:/tmp/pip-XBiTva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:18 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:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:19 INFO - Running setup.py (path:/tmp/pip-8Go5Vz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:19 INFO - Running setup.py (path:/tmp/pip-7Eh0Mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:19 INFO - Running setup.py (path:/tmp/pip-_kufiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:19 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:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:19 INFO - Running setup.py (path:/tmp/pip-ERvm86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:19 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:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:19 INFO - Running setup.py (path:/tmp/pip-WK6BkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:19 INFO - Running setup.py (path:/tmp/pip-_CXZO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:19 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:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:19 INFO - Running setup.py (path:/tmp/pip-g2itz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:19 INFO - Running setup.py (path:/tmp/pip-ea5LZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:19 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:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:19 INFO - Running setup.py (path:/tmp/pip-Qkv2Rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:19 INFO - Running setup.py (path:/tmp/pip-RhUNGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:19 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:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:19 INFO - Running setup.py (path:/tmp/pip-bKLDS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:19 INFO - Running setup.py (path:/tmp/pip-iawqt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:19 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:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:19 INFO - Running setup.py (path:/tmp/pip-tvvCru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:19 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:06:19 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:06:19 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:06:19 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:06:19 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:06:19 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:06:19 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:06:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06:19 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:06:19 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:06:19 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:06:19 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:06:21 INFO - Downloading blessings-1.6.tar.gz 04:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:06:21 INFO - Installing collected packages: blessings 04:06:21 INFO - Running setup.py install for blessings 04:06:21 INFO - Successfully installed blessings 04:06:21 INFO - Cleaning up... 04:06:21 INFO - Return code: 0 04:06:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:06:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:21 INFO - Reading from file tmpfile_stdout 04:06:21 INFO - Current package versions: 04:06:21 INFO - argparse == 1.2.1 04:06:21 INFO - blessings == 1.6 04:06:21 INFO - blobuploader == 1.2.4 04:06:21 INFO - docopt == 0.6.1 04:06:21 INFO - functools32 == 3.2.3-2 04:06:21 INFO - jsonschema == 2.5.1 04:06:21 INFO - manifestparser == 1.1 04:06:21 INFO - mozInstall == 1.13 04:06:21 INFO - mozcrash == 1.0 04:06:21 INFO - mozdebug == 0.1 04:06:21 INFO - mozdevice == 0.51 04:06:21 INFO - mozfile == 1.2 04:06:21 INFO - mozhttpd == 0.7 04:06:21 INFO - mozinfo == 0.10 04:06:21 INFO - mozleak == 0.1 04:06:21 INFO - mozlog == 3.5 04:06:21 INFO - moznetwork == 0.27 04:06:21 INFO - mozprocess == 0.25 04:06:21 INFO - mozprofile == 0.28 04:06:21 INFO - mozrunner == 6.13 04:06:21 INFO - mozscreenshot == 0.1 04:06:21 INFO - mozsystemmonitor == 0.3 04:06:21 INFO - moztest == 0.8 04:06:21 INFO - mozversion == 1.4 04:06:21 INFO - psutil == 3.1.1 04:06:21 INFO - requests == 1.2.3 04:06:21 INFO - wsgiref == 0.1.2 04:06:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:21 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:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:21 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:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:21 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 0x1f901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ffd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fceb0>, '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 0x22fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', '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:06:21 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:06:21 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:06:21 INFO - Using env: {'DISPLAY': ':0', 04:06:21 INFO - 'HOME': '/home/cltbld', 04:06:21 INFO - 'LANG': 'en_US.UTF-8', 04:06:21 INFO - 'LANGUAGE': 'en_US:en', 04:06:21 INFO - 'LOGNAME': 'cltbld', 04:06:21 INFO - 'MAIL': '/var/mail/cltbld', 04:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:21 INFO - 'MOZ_NO_REMOTE': '1', 04:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:21 INFO - 'NO_EM_RESTART': '1', 04:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:21 INFO - 'PWD': '/builds/slave/test', 04:06:21 INFO - 'SHELL': '/bin/bash', 04:06:21 INFO - 'SHLVL': '1', 04:06:21 INFO - 'TERM': 'linux', 04:06:21 INFO - 'TMOUT': '86400', 04:06:21 INFO - 'USER': 'cltbld', 04:06:21 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', 04:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:21 INFO - '_': '/tools/buildbot/bin/python'} 04:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:21 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:06:21 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:06:21 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:06:21 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:06:21 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:06:21 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:06:21 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:06:21 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:06:21 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:06:21 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:06:21 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:06:21 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:06:21 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:06:21 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:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:06:22 INFO - Installing collected packages: simplejson 04:06:22 INFO - Running setup.py install for simplejson 04:06:22 INFO - building 'simplejson._speedups' extension 04:06:22 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:06:23 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:06:23 INFO - Successfully installed simplejson 04:06:23 INFO - Cleaning up... 04:06:23 INFO - Return code: 0 04:06:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:06:23 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:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:23 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:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:23 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 0x1f901f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22ffd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22fceb0>, '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 0x22fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', '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:06:23 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:06:23 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:06:23 INFO - Using env: {'DISPLAY': ':0', 04:06:23 INFO - 'HOME': '/home/cltbld', 04:06:23 INFO - 'LANG': 'en_US.UTF-8', 04:06:23 INFO - 'LANGUAGE': 'en_US:en', 04:06:23 INFO - 'LOGNAME': 'cltbld', 04:06:23 INFO - 'MAIL': '/var/mail/cltbld', 04:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:23 INFO - 'MOZ_NO_REMOTE': '1', 04:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:23 INFO - 'NO_EM_RESTART': '1', 04:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:23 INFO - 'PWD': '/builds/slave/test', 04:06:23 INFO - 'SHELL': '/bin/bash', 04:06:23 INFO - 'SHLVL': '1', 04:06:23 INFO - 'TERM': 'linux', 04:06:23 INFO - 'TMOUT': '86400', 04:06:23 INFO - 'USER': 'cltbld', 04:06:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', 04:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:23 INFO - '_': '/tools/buildbot/bin/python'} 04:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:06:24 INFO - Cleaning up... 04:06:24 INFO - Return code: 0 04:06:24 INFO - Running post-action listener: _resource_record_post_action 04:06:24 INFO - Running post-action listener: _start_resource_monitoring 04:06:24 INFO - Starting resource monitoring. 04:06:24 INFO - [mozharness: 2017-08-05 11:06:24.181813Z] Finished create-virtualenv step (success) 04:06:24 INFO - [mozharness: 2017-08-05 11:06:24.182331Z] Running install step. 04:06:24 INFO - Running pre-action listener: _resource_record_pre_action 04:06:24 INFO - Running main action method: install 04:06:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:24 INFO - Reading from file tmpfile_stdout 04:06:24 INFO - Detecting whether we're running mozinstall >=1.0... 04:06:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:06:24 INFO - Reading from file tmpfile_stdout 04:06:24 INFO - Output received: 04:06:24 INFO - Usage: mozinstall [options] installer 04:06:24 INFO - Options: 04:06:24 INFO - -h, --help show this help message and exit 04:06:24 INFO - -d DEST, --destination=DEST 04:06:24 INFO - Directory to install application into. [default: 04:06:24 INFO - "/builds/slave/test"] 04:06:24 INFO - --app=APP Application being installed. [default: firefox] 04:06:24 INFO - mkdir: /builds/slave/test/build/application 04:06:24 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:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:06:42 INFO - Reading from file tmpfile_stdout 04:06:42 INFO - Output received: 04:06:42 INFO - /builds/slave/test/build/application/firefox/firefox 04:06:42 INFO - Running post-action listener: _resource_record_post_action 04:06:42 INFO - [mozharness: 2017-08-05 11:06:42.317478Z] Finished install step (success) 04:06:42 INFO - [mozharness: 2017-08-05 11:06:42.317765Z] Running setup-mitmproxy step. 04:06:42 INFO - Running pre-action listener: _resource_record_pre_action 04:06:42 INFO - Running main action method: setup_mitmproxy 04:06:42 INFO - Skipping: mitmproxy is not required 04:06:42 INFO - Running post-action listener: _resource_record_post_action 04:06:42 INFO - [mozharness: 2017-08-05 11:06:42.318925Z] Finished setup-mitmproxy step (success) 04:06:42 INFO - [mozharness: 2017-08-05 11:06:42.319149Z] Running run-tests step. 04:06:42 INFO - Running pre-action listener: _resource_record_pre_action 04:06:42 INFO - Running pre-action listener: _set_gcov_prefix 04:06:42 INFO - Running main action method: run_tests 04:06:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:06:42 INFO - Python 2.7.3 04:06:42 INFO - Return code: 0 04:06:42 INFO - grabbing minidump binary from tooltool 04:06:42 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:06:42 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 0x22fceb0>, '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 0x22fddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22fe240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:06:42 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:06:42 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:06:42 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:06:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:06:42 INFO - Return code: 0 04:06:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:06:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:06:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:06:42 INFO - ENV: RUST_BACKTRACE is now 1 04:06:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:06:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:06:42 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/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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:06:42 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/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --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:06:42 INFO - Using env: {'DISPLAY': ':0', 04:06:42 INFO - 'HOME': '/home/cltbld', 04:06:42 INFO - 'LANG': 'en_US.UTF-8', 04:06:42 INFO - 'LANGUAGE': 'en_US:en', 04:06:42 INFO - 'LOGNAME': 'cltbld', 04:06:42 INFO - 'MAIL': '/var/mail/cltbld', 04:06:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:06:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:42 INFO - 'MOZ_NO_REMOTE': '1', 04:06:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:06:42 INFO - 'NO_EM_RESTART': '1', 04:06:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:42 INFO - 'PWD': '/builds/slave/test', 04:06:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:06:42 INFO - 'RUST_BACKTRACE': '1', 04:06:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:06:42 INFO - 'SHELL': '/bin/bash', 04:06:42 INFO - 'SHLVL': '1', 04:06:42 INFO - 'TERM': 'linux', 04:06:42 INFO - 'TMOUT': '86400', 04:06:42 INFO - 'USER': 'cltbld', 04:06:42 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419', 04:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:42 INFO - '_': '/tools/buildbot/bin/python'} 04:06:42 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/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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:06:42 INFO - mozversion application_buildid: 20170805095548 04:06:42 INFO - mozversion application_changeset: 933a04a91ce3bd44b230937083a835cb60637084 04:06:42 INFO - mozversion application_display_name: Nightly 04:06:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:06:42 INFO - mozversion application_name: Firefox 04:06:42 INFO - mozversion application_remotingname: firefox 04:06:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:06:42 INFO - mozversion application_vendor: Mozilla 04:06:42 INFO - mozversion application_version: 57.0a1 04:06:42 INFO - mozversion platform_buildid: 20170805095548 04:06:42 INFO - mozversion platform_changeset: 933a04a91ce3bd44b230937083a835cb60637084 04:06:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:06:42 INFO - mozversion platform_version: 57.0a1 04:06:42 INFO - using testdate: 1501931202 04:06:42 INFO - actual date: 1501931202 04:06:42 INFO - starting webserver on 'localhost:52715' 04:06:42 INFO - SUITE-START | Running 2 tests 04:06:42 INFO - TEST-START | dromaeo_css 04:06:42 INFO - Initialising browser for dromaeo_css test... 04:06:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52715/getInfo.html -profile /tmp/tmprqTQgr/profile 04:06:42 INFO - TEST-INFO | started process 30980 (/builds/slave/test/build/application/firefox/firefox http://localhost:52715/getInfo.html) 04:06:48 INFO - TEST-INFO | 30980: exit 0 04:06:48 INFO - Browser initialized. 04:06:48 INFO - Running cycle 1/1 for dromaeo_css test... 04:06:48 INFO - TEST-INFO | started process 31188 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprqTQgr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:49 INFO - PID 31188 | 04:06:49 INFO - PID 31188 | (/builds/slave/test/build/application/firefox/firefox:31236): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:06:49 INFO - PID 31188 | 04:06:59 INFO - PID 31188 | RSS: Main: 164589568 04:06:59 INFO - PID 31188 | 04:09:58 INFO - PID 31188 | Cycle 1(1): loaded http://localhost:52715/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52715/tests/dromaeo/cssquery-ext.html) 04:09:59 INFO - PID 31188 | RSS: Main: 166514688 04:09:59 INFO - PID 31188 | 04:13:00 INFO - PID 31188 | Cycle 1(1): loaded http://localhost:52715/tests/dromaeo/cssquery-ext.html (next: http://localhost:52715/tests/dromaeo/cssquery-jquery.html) 04:13:01 INFO - PID 31188 | RSS: Main: 163381248 04:13:01 INFO - PID 31188 | 04:16:03 INFO - PID 31188 | Cycle 1(1): loaded http://localhost:52715/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52715/tests/dromaeo/cssquery-mootools.html) 04:16:03 INFO - PID 31188 | RSS: Main: 165687296 04:16:03 INFO - PID 31188 | 04:19:05 INFO - PID 31188 | Cycle 1(1): loaded http://localhost:52715/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52715/tests/dromaeo/cssquery-prototype.html) 04:19:06 INFO - PID 31188 | RSS: Main: 164548608 04:19:06 INFO - PID 31188 | 04:22:09 INFO - PID 31188 | Cycle 1(1): loaded http://localhost:52715/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52715/tests/dromaeo/cssquery-yui.html) 04:22:10 INFO - PID 31188 | RSS: Main: 167510016 04:22:10 INFO - PID 31188 | 04:25:11 INFO - PID 31188 | Cycle 1(1): loaded http://localhost:52715/tests/dromaeo/cssquery-yui.html (next: http://localhost:52715/tests/dromaeo/cssquery-dojo.html) 04:25:11 INFO - PID 31188 | RSS: Main: 168427520 04:25:11 INFO - PID 31188 | 04:25:11 INFO - PID 31188 | __start_tp_report 04:25:11 INFO - PID 31188 | _x_x_mozilla_page_load 04:25:11 INFO - PID 31188 | _x_x_mozilla_page_load_details 04:25:11 INFO - PID 31188 | |i|pagename|runs| 04:25:11 INFO - PID 31188 | |0;dojo.html;3388.237646529531;3508.3860324443217;3518.173229291118;3537.8054207018604;3544.4328907374816;6202.78290259841;6297.874042519153;6314.116023756672;6321.209848768904;6353.809385718424;6293;6308.9684551577175;6326.367363263671;6378.138951241581;6383.04254361846;5425.267588875491;5448.618596698233;5508.6970216638065;5593.496585307332;5610.354809196954;5443.591730620219;5511.448855114497;5526.58550608706;5558.082916318823;5564.554835613141;5470.91793623096;5486.588505862056;5541.944580554204;5565.109582466806;5586.581006424514;5384.380796208447;5441.401445840955;5467.589930755209;5535.169724541351;5536.390996990328;5471.781128754845;5497.367802702701;5520.696361700105;5529.557635389199;5541.722913854291;6216.68916554175;6250.43746062852;6326.051092336141;6328.050792381134;6381;6652.600843949379;6787.287334829871;6801.557898736616;6875.140607424072;6890.31096890307;6819;6835.624040677761;6841.589504629738;6846.623435711034;6853.623050732208;6354.364563543655;6355.745770169187;6364.077208804697;6378.4578310843635;6385.2656944451055;6805.863882722318;6941.409980151642;6959.652017399109;7026.613536255555;7030.718771249195;6621.602703837785;6626.7017984190825;6634.966825165843;6643.534952553371;6649.867002659919;6747.763828265987;6749.561278516979;6756.83107922296;6760.1549806274215;6766.357196066366;6633.7346506140175;6694.330566943364;6716.899246511306;6723.831904202434;6727.29363416844;6724.29394913527;6763.222229443579;6803.829904252433;6839.62382068991;6845.110135682329;4948.727819969936;4966.428860680996;4992.900141997213;5004.299398084198;5005.374328208974;4380.51814300433;4389.648828093745;4414.293713005904;4449.332600109945;4464.995376040365;6381.521385896076;6413.3266007069515;6416.550841441148;6430.64631445275;6506.60960342381;6801.65991700413;6823.658817059128;6829.726810927507;6830.077939478207;6837.35045170708;6441.452476539546;6483.384078512534;6484.448821850101;6522.869542609121;6538.019297105472;5614.1859430382365;5630;5679.630823996427;5680.8863822723315;5709.229254050733;7043.859122817515;7086.964565177244;7129.073220481408;7171;7274.127104747464;6833.45332373399;6866.107406037183;6877.140357455318;6897.827554311182;6897.862042759217;7117.857642847218;7182.4613154014705;7198.352148306678;7199.460040497089;7258.165310989304;6728.932710672831;6803.93196068033;6813.3527314905;6834.179898412222;6836.794896153124;6866.965665171642;6879.449644028366;6884.449244060363;6970.442364610718;6975.616341101085;6447.967760161169;6513.609183448819;6517.315681853337;6521.771737989147;6542.247641521286;6554.082428460115;6612.305707900601;6618.900716489353;6627.204735431779;6654;6588.571742836701;6663.800085997428;6695;6700.095487109373;6701.1623547056615;6662.133922590032;6707.496937729592;6708.496862735412;6728.495362847708;6759.425448836904;6365.8726825464155;6423;6456.031595260749;6518.282988871315;6559.770408035696 04:25:11 INFO - PID 31188 | |1;ext.html;913.4473643445715;919.2829592917523;949.2548349545606;965;968.5157421289356;42690.14619707608;43220.78389608047;43583.564164358344;43627;43637.78181109094;39619.40570891439;39954.8002259989;40183.397249041285;40254.19491610166;40417.19165616686;6776.661166941645;6917.100776898996;6917.7578784742545;6938.236793952661;6944.062551555551;6786.694598743044;6864;6864.828379290508;6865.10753602031;6865.691043903036;6845.691943862514;7570.280823321776;7721.961390193042;7728.111267204287;7728.381729461629;7609.277118673717;7632.313091821735;7664.773636218234;7666.8466630667635;7674.769756907302;7243.601601911892;7489.962550187269;7511.136219334737;7514.173440921494;7547.094348678139;40287.39568906469;40470.79764601187;40529.392059119135;40539;40610.18779624421;3443.0359499340225;3450.9309813803584;3461.16931936336;3470.340635279289;3472.6700963408434;31448.685513145032;31605.525917111263;31677.8416107918;31689.683103168903;31717.682823171934;4936.901261974776;4991.101601711691;5019.874503137451;5019.899602007976;5025.7235852028125;205401;205452;206849;209172;215632;51595.48404515982;52101.218481722804;52123.47876521262;52208;52253;54171;54259.72870135624;54268.72865635646;54284;54298.72850635721;15690.9215453922;15886.285117169755;15901.363945442054;15907.920460397856;16108.838911610968;12930.935345323212;12935.353232338346;12940.547080852126;12942.094053416358;12946.805797913039;15124.168170750494;15150.772738408932;15159.924200378928;15195.544133676007;15272.16003119817;5799.3620701722775;5976.880462390728;6081.239845019372;6098.4996151578525;6116.3883611638485;1082.8917108289108;1083.615316562609;1088.1947358954476;1099.0932480703452;1102.6195962392962;24065;24211.273661790176;24350.94894879909;24429.14497992597;24640.630390544156;1150.263831148066;1167.3404526442532;1178.2459226095307;1182.8580570331615;1190.8511436070492;12703.936480317725;12734.299613521345;12889.03332250085;12923.095383323265;12943.741125177443;281159;284987;286042;286089;286498;54923;55023;55038;55218.171727423316;55339.16991245135;1501.369424841569;1516.3631274864583;1529.9541013769606;1534.4552683797315;1538.8691961183201;23974.52050959006;24005.759942400353;24028;24066.639000415358;24089.879550602134;39768.80115599519;39885.00287492836;39900.60099398969;39912.60087399205;40001.199975999734;246618;247532;248020;248089;248216;30372.696273036985;31032.844835775675;33668.83165584156;34026.829865851505;34119.82940085284;43255.351169731846;43512.78243608762;44254.55745442633;44464.33303500515;44794.77602611966;28536.286592835346;28746.281342966595;28835.56746648844;28851.5672264912;28935.131946041653;32635.510467342534;36308;36399.45400818937;36573.45139822958;36900.07749806276;41470;41712.37431438592;41931.7903410481;42502.57497424986;42599.148017040105;28359.716402835707;28612.42775144527;28629.856850715612;28953.56569651499;28976.42047159087;26214.34464138412;26234.93193131181;26298;26498.735012649628;27001.86499067492 04:25:11 INFO - PID 31188 | |2;jquery.html;572.5705720709467;587.797209962563;589.1045610671779;594.180031556452;595.702148925537;22806.429839254026;23199.420014499625;24108.75891241087;24125.396865078383;24191.879040604796;26994;27353.316167095832;27464.313392165204;27519.86240068802;27641.30896727583;6207.813765587029;6336.5881217720935;6346.5874718143405;6354.237491501003;6360.427561519462;5976.820695379124;6278.717457714414;6311.463525600329;6354.110424540568;6455.870882582346;6421.678916054202;6457.096006559085;6461.838454038663;6462.256840463337;6463.967680161616;6396.072569477446;6442.323556026597;6453.677316134174;6453.9354606454035;6461.612303261796;5996.280446346423;6011.368806275322;6015.308239552463;6021.307549631804;6021.63870167787;30476.085717428512;30590.235244118852;31029.689703102908;31060.223494412596;31565.684343156503;2260.615695331781;2299.0458959531775;2322.790948814598;2323.4772176260376;2323.814094872423;20356.592868142554;20939.58120837575;20942.581148376947;21054.684179737316;21068.367948961557;2437.6587277781123;2445.572024895654;2493.264486976328;2494.2641920633273;2494.787943024845;140513.2974335132;145548.27225863907;145695.27152364276;145894;145963;14572.854271457361;15252.771208431883;15680.215989200495;15813.762793558106;15981.44064957721;24465.021399143836;24507.50984980326;24854.87572562162;24865.751342486343;24872.12947546827;10860.837087443695;10927.235093543375;10934.56261749537;10950.561977520969;10952.561897524169;10097.394156350643;10176.694699158888;10210.948945255375;10349.68809980814;10384.688459346231;9693.757656058655;10797.676069717922;10894;12204.206726562923;12815.487380504675;3762.7930463824205;4142.937855932163;4151.4395556600075;4232.386303985966;4603.49361570227;1054.7890421915647;1057.2599180573475;1067.1942683274078;1074.333912973961;1076.160594736107;25216.117435889657;26270.86902021111;26292.86853565758;26392.60411093835;26678.5998210027;1105.4030823355458;1125.7973564758258;1125.831125331207;1126.6282126898104;1138.322697994692;11939.76120477603;12352.135350525377;12361.93819030899;12417.813732794015;12489.125761196628;551208;555126;559384;569758;599409;132756;133701;134932;135862;137755;1213.969650758738;1322.642886420661;1366.4397596985386;1376.0849035391352;1376.3462355381114;23274.53450931006;23430.414239644146;23491.647625285976;23689.881550592138;23876.641850372605;65167;66510;66644.33355666381;67041.99437008351;68582.31417685958;78052.60973695095;78417;78644;79024;79301.20698792938;15381.769273460683;15778.289976951295;15792.21038948071;15874;15897.364105436116;24283;24782.876085619457;24791.380215494755;24811;24963.251102466955;19835.60328793445;20164.596708065463;20514.897425512776;20594.38216853497;20650.58698825985;17551.561210969827;17678.204480798653;18345.908270458563;18380.724289135407;18987.145578448726;20538.897305513376;20968.68546971827;21150.365489035354;21215.257465988616;21244.150233990465;15357.769633455284;15421.768673469682;15547.222638868237;15552.30014649321;15593.68812623764;18912.621747564695;19204.807951920862;19681.21275148978;19707.60584788325;19890.60218795645 04:25:11 INFO - PID 31188 | |3;mootools.html;1452.33918567052;1473.7641977283636;1478.0688166455145;1501.3093976770685;1510.9622259443513;13491.730165396712;14944.626384340398;15473.45842895499;15501;15579.53261402157;15080.321385537649;15399.69200615987;15419;15439.305231264592;15441.922790386032;2718.116612101065;2776.694563598003;2776.819506732066;2776.9444611107765;2778.360976975297;2635.8286711363794;2691.636629055082;2730.549459339207;2788.5817127430946;2790.7627851632637;2750.0787236275773;2762.323230808455;2782.4296019315993;2784.791140664448;2788.5817127430846;2669.23926680895;2669.7196794336705;2674.1977406777987;2680.7319268073234;2687.207273854218;2565.961510577324;2573.700281357921;2591.663083799113;2596.1302963507246;2602.466494368669;14956.925215373962;15277.541673749805;15349.539513814603;15353.616159595987;15359.846401536066;8143.796405089861;8435.704750333709;8454.492730436194;8473.406861519696;8482.83034339316;5422.83731488052;5532.723363831792;5572.916406253909;5694.6867922264255;5698.7435565399655;1869.2896699254331;1881.9435416937513;1889.4803928919519;1922.8557858160555;1924.653562358775;25515.617265741028;25750.74249257502;25752.484950301077;26212;27300.863495682395;6853.280405557444;6974.79075627732;7071.328223818729;7163.42692584592;7210.67551960163;18456.538586535175;18511;18511.259549617866;18527.72208416848;18529.81470185281;7960.960195199103;8045.718399855977;8059.113497515269;8072.919270807334;8078.636461359253;7122.786316410516;7453;7531.246875312425;7548.4716069874585;7554.169041405441;5305.920411193758;5325.733713314319;5397.8110766123;5406.837794866082;5427.83716488506;1452.6949340638373;1508.6982603479348;1510.780936764163;1515.6968606278788;1521.0949485056374;937.2642475656713;963.937344072633;979.1432496565506;979.8291042204639;982.1946004276567;7874.763757087297;7885.1326354101;7919.366450683931;7958.403119766041;7962.2037796221075;742.5025233093841;750.4559194583992;754.4115589839934;767.7044337929825;771.074710347574;5178.948210517847;5517.944820551824;5567.498925096761;5669.291338582677;5715.913976344481;21545;21893;22271.777282227293;22545.0981960723;22666.773332266795;21339.25312614051;21817;22033;22214.22250221267;22381.88809055977;10610.151187904949;11143.498542565603;12069;12131.21147125434;12382.752344953231;7811.804704882424;8598.61306241233;9293.488858112869;9415.62337506492;9453.716388508356;19105.80894191096;19239.615207696046;19410.2235910562;19426.12582433822;19725.210991560176;19206.711899321243;19243.51891202731;19628.313009044614;20222.696659550413;20264.18943242254;12650.746985060432;12857.67855803575;12943;12943.805842912176;12951.158174718614;13294.335283235992;13432.798508022583;13565.253911034988;13572.1856688599;13592.252426116263;11534.769304614028;11643.068554515788;11662.76674466489;11857.40712964331;11947.402629868646;11257.910957706816;11395.544178232778;11457.885421145682;11698.181127321006;11925.4037298133;9748;9920.305578609428;9923;9924.851127232952;9924.900750992398;7091;7162.785116446515;7175.641217938978;7179.497435179696;7181.461390395637;7262.600556969417;7262.818429539092;7276.235995220637;7389.408847292097;7396.186419493743 04:25:11 INFO - PID 31188 | |4;prototype.html;505.5238702987277;513.4070148977929;517.5393899429507;537.1325309624955;538.8141091323492;6053.213082299306;6127.35662755411;6136.7545298188015;6139.877202455959;6149.323574406817;5916.171735956958;6025.7288422021;6055.939440605593;6106.572539922207;6107.450329470346;4735.479097299286;4767.380240568721;4772.260299653559;4810.172134588851;4829.092508459156;4638.304254361839;4799.13615549201;4829.855104346875;4834.30175915425;4836.975815120937;4690.132325519773;4738.597219236369;4741.478437371887;4769.712177712016;4807.206810876201;4750.4299484061785;4752.334673145762;4768.61851051915;4771.403574553181;4821.493743156988;4319.43847299849;4326.918270432392;4347.521772605042;4355.259605867011;4363.170997510463;5965.194698715704;5998.190244317005;6002.189704389895;6010.248718910137;6071.969640151771;5768.567357448208;5802.448767367094;5811.27359080115;5815.273090863642;5824.88350232993;6482.157319548475;6489.09152718615;6526.510511711641;6572.375624315682;6581.7367305307735;4862.270659401082;4902.632302577321;4931.556159945622;4965.975170124127;4973.42805577356;6845.349691779273;6859.828504287383;6939.167299924042;6944.4097251733665;6978.267281935375;5064.924026139611;5069.822556210515;5079.958608485252;5095.993363915233;5160.638755287169;5101.464346243665;5155.948440515622;5182.740862956837;5205.869853253699;5211.218317252443;5753.59724819267;5754.482096611325;5763.452472015152;5778.653280803165;5788.3343415506915;6526.67366631676;6547.517957222316;6580.835479112965;6625.370589793962;6678.7328506859185;1704.6079401737422;1749.7287920372107;1769.8761086724064;1782.2069179215125;1783.233209719833;1209.5343292832322;1258.7734207842493;1264.6395777203452;1280.1231156657718;1288.2141893444991;6304.495640348761;6316.368363163739;6320.5575609706875;6321.65230912295;6330.525210609223;6522.543421960512;6535.673216339164;6536.215654121441;6545.116409284781;6634.170728658918;6242.968785156045;6249.343818899041;6282.151909492251;6320.936790632035;6355.332690067568;3414.6756058174433;3500.982495087508;3550.91122721934;3561.3411518869093;3565.982170089133;7042.894356584656;7060.964695176594;7094.396976256973;7105.89341159883;7117.4306055515435;6873.656317184221;6874.106366172366;6875.518713689994;6900.309969003059;6962.199347075049;6970.51206415546;7018.7543435980515;7059.929400705927;7089.397401220851;7158.921663684666;6724.462043036643;6751.480916793682;6783.626900520519;6784.3894049535775;6806.693698783468;6547.770828020996;6616.206055273398;6681.665916704243;6695.899561506679;6696.990902729259;7063.788086357417;7079.044329015517;7116.857662846817;7121.501494895308;7121.893171602534;5041.899162016813;5059.291699162194;5069.112905241642;5097.6941383517105;5101.8724531887;6659.866802664016;6672.165979252593;6683.732650693918;6701.765438209834;6758.797236082925;6474.287828338973;6479.611223326616;6526.412622863965;6557.147570815763;6563.310852360624;6338;6392.872142557216;6417.647029413427;6458.451031662174;6460.224773027267;6207.782727604512;6305.180326557518;6333.904991425225;6403.903941440789;6439.935600644121;6360.950443177009;6422.389872962061;6423.839404014937;6473.741050357933;6564.80305590833;6266.530010249341;6270.216222972129;6275.811725648238;6319.304876463493;6332.588381755171 04:25:11 INFO - PID 31188 | |5;yui.html;918.0498184379169;942.0138162026376;942.4910548303916;948.8386974214383;958.9904100958993;17923.372681956134;18869.339573114943;18872.245110195574;18875.62248755024;18878.433646990594;18314.267429302847;19244;22290.665640015413;22320.21879234223;22513.437164070907;1053.2837670384135;1083.8157513222732;1084.4360932315192;1084.5499117866077;1086.0931122512711;975.6975337645317;1068.2522234435926;1072.0351683484887;1089.7221208591839;1097.8902109788996;1120.9159313051514;1121.3216004317394;1122.1247427006947;1122.9943850280738;1139.1627154041773;1104.6465131158034;1108.61198580497;1113.1651261553834;1113.6213687346342;1133.2463911498885;813.9267465928036;817.1215942861388;817.8037271054964;820.8809722590191;838.4591938199887;18405.07974601278;18681.719774203397;19583.804161958342;19678.212871485124;19912;21431.35705928809;21848.12607495698;21880.89059554708;22228.993905485193;22329.55340893173;15600.453984110614;15603.921980390025;15660.451884183998;15666.608334791608;15918.522444326689;3752.5121734174654;3778.149916268845;3779.640934111255;3780.7731536107644;3781;139875.21101091016;140642.593574065;141465;144242.27878860643;144494;17039;17303.91348043277;17313.82686173122;17570.209340579706;17640.823591763918;32333.51499727506;32525;32785;32846;32885.50671739926;8398;8649.956750216208;8714.085021072822;8813.515256660945;8828.602712877935;4584.61030812378;4690.7654617269;4703.294505824154;4708.599769019604;4712.764361781898;5325.893482130413;5419.376771671229;5534.695591742493;5557.44425557441;5590;978.5254151736402;985.2118305355687;993.4933184076173;994.9204063675033;1004.0712341084468;696.951213415056;715.9463040271896;717.3292971072065;719.4568101083753;730.2989130434842;12867.292298923649;13427.462901484027;14371.281435928371;15084.849151508344;15817.288222029807;693.3517161454057;698.0889938630035;713.8429545499981;714.2357677285255;721.6860665610476;6292.828974003961;6508.284088750233;6604.042413849965;6634.668266586747;6656.900146497806;123268;125293.37353313174;125730.37134814267;125993.37003315108;132874.33562832125;110927.44536277428;112471.43764281126;113764;115299.42350288363;115595.42202289103;98337.50831245941;99620;100203;100810;101715.49142254241;13661.18032918028;13731.725365492834;13904.37430315618;13939.930300348433;13955.860441395456;47615.52384476111;48279.27581086357;49343.74812713438;49413;49541.50458495369;62571;62926.68536657288;63663;65062.67468662626;66211;19317.8068219316;19664.311749088713;19769.40691779249;19980;20017.499562511053;21666.458338541663;21741.782582173975;21924.23265185711;22013.449663757892;22084.227052053102;17443;17597.208125634123;17649;17850.285988560314;18009.639807204043;18495.53761155982;18513.35203267879;18548.44354669362;18635.06824658789;18733.531661708566;19493.12280947389;19694.409167724993;19746.111424985622;19791.802081978996;19914.800851991295;12143.332116733665;12226.20529665569;12451.750964980469;12464.626061218178;12540.498380064695;15221.467248646244;15465.458708945132;15529.610913345088;15639.921800390925;15801.68396632038 04:25:11 INFO - PID 31188 | __end_tp_report 04:25:11 INFO - PID 31188 | __start_cc_report 04:25:11 INFO - PID 31188 | _x_x_mozilla_cycle_collect,336 04:25:11 INFO - PID 31188 | __end_cc_report 04:25:11 INFO - PID 31188 | __startTimestamp1501932311868__endTimestamp 04:25:11 INFO - PID 31188 | 04:25:11 INFO - PID 31188 | ------- Summary: start ------- 04:25:11 INFO - PID 31188 | Number of tests: 6 04:25:11 INFO - PID 31188 | 04:25:11 INFO - PID 31188 | [#0] dojo.html Cycles:165 Average:6258.96 Median:6538.02 stddev:811.84 (12.4%) stddev-sans-first:782.47 04:25:11 INFO - PID 31188 | Values: 3388.2 3508.4 3518.2 3537.8 3544.4 6202.8 6297.9 6314.1 6321.2 6353.8 6293.0 6309.0 6326.4 6378.1 6383.0 5425.3 5448.6 5508.7 5593.5 5610.4 5443.6 5511.4 5526.6 5558.1 5564.6 5470.9 5486.6 5541.9 5565.1 5586.6 5384.4 5441.4 5467.6 5535.2 5536.4 5471.8 5497.4 5520.7 5529.6 5541.7 6216.7 6250.4 6326.1 6328.1 6381.0 6652.6 6787.3 6801.6 6875.1 6890.3 6819.0 6835.6 6841.6 6846.6 6853.6 6354.4 6355.7 6364.1 6378.5 6385.3 6805.9 6941.4 6959.7 7026.6 7030.7 6621.6 6626.7 6635.0 6643.5 6649.9 6747.8 6749.6 6756.8 6760.2 6766.4 6633.7 6694.3 6716.9 6723.8 6727.3 6724.3 6763.2 6803.8 6839.6 6845.1 4948.7 4966.4 4992.9 5004.3 5005.4 4380.5 4389.6 4414.3 4449.3 4465.0 6381.5 6413.3 6416.6 6430.6 6506.6 6801.7 6823.7 6829.7 6830.1 6837.4 6441.5 6483.4 6484.4 6522.9 6538.0 5614.2 5630.0 5679.6 5680.9 5709.2 7043.9 7087.0 7129.1 7171.0 7274.1 6833.5 6866.1 6877.1 6897.8 6897.9 7117.9 7182.5 7198.4 7199.5 7258.2 6728.9 6803.9 6813.4 6834.2 6836.8 6867.0 6879.4 6884.4 6970.4 6975.6 6448.0 6513.6 6517.3 6521.8 6542.2 6554.1 6612.3 6618.9 6627.2 6654.0 6588.6 6663.8 6695.0 6700.1 6701.2 6662.1 6707.5 6708.5 6728.5 6759.4 6365.9 6423.0 6456.0 6518.3 6559.8 04:25:11 INFO - PID 31188 | 04:25:11 INFO - PID 31188 | [#1] ext.html Cycles:180 Average:41590.99 Median:19890.34 stddev:64927.87 (326.4%) stddev-sans-first:65038.17 04:25:11 INFO - PID 31188 | Values: 913.4 919.3 949.3 965.0 968.5 42690.1 43220.8 43583.6 43627.0 43637.8 39619.4 39954.8 40183.4 40254.2 40417.2 6776.7 6917.1 6917.8 6938.2 6944.1 6786.7 6864.0 6864.8 6865.1 6865.7 6845.7 7570.3 7722.0 7728.1 7728.4 7609.3 7632.3 7664.8 7666.8 7674.8 7243.6 7490.0 7511.1 7514.2 7547.1 40287.4 40470.8 40529.4 40539.0 40610.2 3443.0 3450.9 3461.2 3470.3 3472.7 31448.7 31605.5 31677.8 31689.7 31717.7 4936.9 4991.1 5019.9 5019.9 5025.7 205401.0 205452.0 206849.0 209172.0 215632.0 51595.5 52101.2 52123.5 52208.0 52253.0 54171.0 54259.7 54268.7 54284.0 54298.7 15690.9 15886.3 15901.4 15907.9 16108.8 12930.9 12935.4 12940.5 12942.1 12946.8 15124.2 15150.8 15159.9 15195.5 15272.2 5799.4 5976.9 6081.2 6098.5 6116.4 1082.9 1083.6 1088.2 1099.1 1102.6 24065.0 24211.3 24350.9 24429.1 24640.6 1150.3 1167.3 1178.2 1182.9 1190.9 12703.9 12734.3 12889.0 12923.1 12943.7 281159.0 284987.0 286042.0 286089.0 286498.0 54923.0 55023.0 55038.0 55218.2 55339.2 1501.4 1516.4 1530.0 1534.5 1538.9 23974.5 24005.8 24028.0 24066.6 24089.9 39768.8 39885.0 39900.6 39912.6 40001.2 246618.0 247532.0 248020.0 248089.0 248216.0 30372.7 31032.8 33668.8 34026.8 34119.8 43255.4 43512.8 44254.6 44464.3 44794.8 28536.3 28746.3 28835.6 28851.6 28935.1 32635.5 36308.0 36399.5 36573.5 36900.1 41470.0 41712.4 41931.8 42502.6 42599.1 28359.7 28612.4 28629.9 28953.6 28976.4 26214.3 26234.9 26298.0 26498.7 27001.9 04:25:11 INFO - PID 31188 | 04:25:11 INFO - PID 31188 | [#2] jquery.html Cycles:180 Average:39147.63 Median:12799.17 stddev:95224.32 (744.0%) stddev-sans-first:95447.40 04:25:11 INFO - PID 31188 | Values: 572.6 587.8 589.1 594.2 595.7 22806.4 23199.4 24108.8 24125.4 24191.9 26994.0 27353.3 27464.3 27519.9 27641.3 6207.8 6336.6 6346.6 6354.2 6360.4 5976.8 6278.7 6311.5 6354.1 6455.9 6421.7 6457.1 6461.8 6462.3 6464.0 6396.1 6442.3 6453.7 6453.9 6461.6 5996.3 6011.4 6015.3 6021.3 6021.6 30476.1 30590.2 31029.7 31060.2 31565.7 2260.6 2299.0 2322.8 2323.5 2323.8 20356.6 20939.6 20942.6 21054.7 21068.4 2437.7 2445.6 2493.3 2494.3 2494.8 140513.3 145548.3 145695.3 145894.0 145963.0 14572.9 15252.8 15680.2 15813.8 15981.4 24465.0 24507.5 24854.9 24865.8 24872.1 10860.8 10927.2 10934.6 10950.6 10952.6 10097.4 10176.7 10210.9 10349.7 10384.7 9693.8 10797.7 10894.0 12204.2 12815.5 3762.8 4142.9 4151.4 4232.4 4603.5 1054.8 1057.3 1067.2 1074.3 1076.2 25216.1 26270.9 26292.9 26392.6 26678.6 1105.4 1125.8 1125.8 1126.6 1138.3 11939.8 12352.1 12361.9 12417.8 12489.1 551208.0 555126.0 559384.0 569758.0 599409.0 132756.0 133701.0 134932.0 135862.0 137755.0 1214.0 1322.6 1366.4 1376.1 1376.3 23274.5 23430.4 23491.6 23689.9 23876.6 65167.0 66510.0 66644.3 67042.0 68582.3 78052.6 78417.0 78644.0 79024.0 79301.2 15381.8 15778.3 15792.2 15874.0 15897.4 24283.0 24782.9 24791.4 24811.0 24963.3 19835.6 20164.6 20514.9 20594.4 20650.6 17551.6 17678.2 18345.9 18380.7 18987.1 20538.9 20968.7 21150.4 21215.3 21244.2 15357.8 15421.8 15547.2 15552.3 15593.7 18912.6 19204.8 19681.2 19707.6 19890.6 04:25:11 INFO - PID 31188 | 04:25:11 INFO - PID 31188 | [#3] mootools.html Cycles:180 Average:9542.44 Median:2669.48 stddev:6804.15 (254.9%) stddev-sans-first:6796.09 04:25:11 INFO - PID 31188 | Values: 1452.3 1473.8 1478.1 1501.3 1511.0 13491.7 14944.6 15473.5 15501.0 15579.5 15080.3 15399.7 15419.0 15439.3 15441.9 2718.1 2776.7 2776.8 2776.9 2778.4 2635.8 2691.6 2730.5 2788.6 2790.8 2750.1 2762.3 2782.4 2784.8 2788.6 2669.2 2669.7 2674.2 2680.7 2687.2 2566.0 2573.7 2591.7 2596.1 2602.5 14956.9 15277.5 15349.5 15353.6 15359.8 8143.8 8435.7 8454.5 8473.4 8482.8 5422.8 5532.7 5572.9 5694.7 5698.7 1869.3 1881.9 1889.5 1922.9 1924.7 25515.6 25750.7 25752.5 26212.0 27300.9 6853.3 6974.8 7071.3 7163.4 7210.7 18456.5 18511.0 18511.3 18527.7 18529.8 7961.0 8045.7 8059.1 8072.9 8078.6 7122.8 7453.0 7531.2 7548.5 7554.2 5305.9 5325.7 5397.8 5406.8 5427.8 1452.7 1508.7 1510.8 1515.7 1521.1 937.3 963.9 979.1 979.8 982.2 7874.8 7885.1 7919.4 7958.4 7962.2 742.5 750.5 754.4 767.7 771.1 5178.9 5517.9 5567.5 5669.3 5715.9 21545.0 21893.0 22271.8 22545.1 22666.8 21339.3 21817.0 22033.0 22214.2 22381.9 10610.2 11143.5 12069.0 12131.2 12382.8 7811.8 8598.6 9293.5 9415.6 9453.7 19105.8 19239.6 19410.2 19426.1 19725.2 19206.7 19243.5 19628.3 20222.7 20264.2 12650.7 12857.7 12943.0 12943.8 12951.2 13294.3 13432.8 13565.3 13572.2 13592.3 11534.8 11643.1 11662.8 11857.4 11947.4 11257.9 11395.5 11457.9 11698.2 11925.4 9748.0 9920.3 9923.0 9924.9 9924.9 7091.0 7162.8 7175.6 7179.5 7181.5 7262.6 7262.8 7276.2 7389.4 7396.2 04:25:11 INFO - PID 31188 | 04:25:11 INFO - PID 31188 | [#4] prototype.html Cycles:180 Average:5554.85 Median:6225.38 stddev:1590.45 (25.5%) stddev-sans-first:1549.10 04:25:11 INFO - PID 31188 | Values: 505.5 513.4 517.5 537.1 538.8 6053.2 6127.4 6136.8 6139.9 6149.3 5916.2 6025.7 6055.9 6106.6 6107.5 4735.5 4767.4 4772.3 4810.2 4829.1 4638.3 4799.1 4829.9 4834.3 4837.0 4690.1 4738.6 4741.5 4769.7 4807.2 4750.4 4752.3 4768.6 4771.4 4821.5 4319.4 4326.9 4347.5 4355.3 4363.2 5965.2 5998.2 6002.2 6010.2 6072.0 5768.6 5802.4 5811.3 5815.3 5824.9 6482.2 6489.1 6526.5 6572.4 6581.7 4862.3 4902.6 4931.6 4966.0 4973.4 6845.3 6859.8 6939.2 6944.4 6978.3 5064.9 5069.8 5080.0 5096.0 5160.6 5101.5 5155.9 5182.7 5205.9 5211.2 5753.6 5754.5 5763.5 5778.7 5788.3 6526.7 6547.5 6580.8 6625.4 6678.7 1704.6 1749.7 1769.9 1782.2 1783.2 1209.5 1258.8 1264.6 1280.1 1288.2 6304.5 6316.4 6320.6 6321.7 6330.5 6522.5 6535.7 6536.2 6545.1 6634.2 6243.0 6249.3 6282.2 6320.9 6355.3 3414.7 3501.0 3550.9 3561.3 3566.0 7042.9 7061.0 7094.4 7105.9 7117.4 6873.7 6874.1 6875.5 6900.3 6962.2 6970.5 7018.8 7059.9 7089.4 7158.9 6724.5 6751.5 6783.6 6784.4 6806.7 6547.8 6616.2 6681.7 6695.9 6697.0 7063.8 7079.0 7116.9 7121.5 7121.9 5041.9 5059.3 5069.1 5097.7 5101.9 6659.9 6672.2 6683.7 6701.8 6758.8 6474.3 6479.6 6526.4 6557.1 6563.3 6338.0 6392.9 6417.6 6458.5 6460.2 6207.8 6305.2 6333.9 6403.9 6439.9 6361.0 6422.4 6423.8 6473.7 6564.8 6266.5 6270.2 6275.8 6319.3 6332.6 04:25:11 INFO - PID 31188 | 04:25:11 INFO - PID 31188 | [#5] yui.html Cycles:180 Average:25928.64 Median:19671.26 stddev:36481.96 (185.5%) stddev-sans-first:36535.96 04:25:11 INFO - PID 31188 | Values: 918.0 942.0 942.5 948.8 959.0 17923.4 18869.3 18872.2 18875.6 18878.4 18314.3 19244.0 22290.7 22320.2 22513.4 1053.3 1083.8 1084.4 1084.5 1086.1 975.7 1068.3 1072.0 1089.7 1097.9 1120.9 1121.3 1122.1 1123.0 1139.2 1104.6 1108.6 1113.2 1113.6 1133.2 813.9 817.1 817.8 820.9 838.5 18405.1 18681.7 19583.8 19678.2 19912.0 21431.4 21848.1 21880.9 22229.0 22329.6 15600.5 15603.9 15660.5 15666.6 15918.5 3752.5 3778.1 3779.6 3780.8 3781.0 139875.2 140642.6 141465.0 144242.3 144494.0 17039.0 17303.9 17313.8 17570.2 17640.8 32333.5 32525.0 32785.0 32846.0 32885.5 8398.0 8650.0 8714.1 8813.5 8828.6 4584.6 4690.8 4703.3 4708.6 4712.8 5325.9 5419.4 5534.7 5557.4 5590.0 978.5 985.2 993.5 994.9 1004.1 697.0 715.9 717.3 719.5 730.3 12867.3 13427.5 14371.3 15084.8 15817.3 693.4 698.1 713.8 714.2 721.7 6292.8 6508.3 6604.0 6634.7 6656.9 123268.0 125293.4 125730.4 125993.4 132874.3 110927.4 112471.4 113764.0 115299.4 115595.4 98337.5 99620.0 100203.0 100810.0 101715.5 13661.2 13731.7 13904.4 13939.9 13955.9 47615.5 48279.3 49343.7 49413.0 49541.5 62571.0 62926.7 63663.0 65062.7 66211.0 19317.8 19664.3 19769.4 19980.0 20017.5 21666.5 21741.8 21924.2 22013.4 22084.2 17443.0 17597.2 17649.0 17850.3 18009.6 18495.5 18513.4 18548.4 18635.1 18733.5 19493.1 19694.4 19746.1 19791.8 19914.8 12143.3 12226.2 12451.8 12464.6 12540.5 15221.5 15465.5 15529.6 15639.9 15801.7 04:25:11 INFO - PID 31188 | -------- Summary: end -------- 04:25:11 INFO - PID 31188 | 04:25:12 INFO - TEST-INFO | 31188: exit 0 04:25:12 INFO - TEST-OK | dromaeo_css | took 1109822ms 04:25:12 INFO - TEST-START | kraken 04:25:12 INFO - Initialising browser for kraken test... 04:25:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52715/getInfo.html -profile /tmp/tmp9pn9tL/profile 04:25:12 INFO - TEST-INFO | started process 31554 (/builds/slave/test/build/application/firefox/firefox http://localhost:52715/getInfo.html) 04:25:18 INFO - TEST-INFO | 31554: exit 0 04:25:18 INFO - Browser initialized. 04:25:18 INFO - Running cycle 1/1 for kraken test... 04:25:18 INFO - TEST-INFO | started process 31764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9pn9tL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:18 INFO - PID 31764 | 04:25:18 INFO - PID 31764 | (/builds/slave/test/build/application/firefox/firefox:31812): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:25:18 INFO - PID 31764 | 04:25:29 INFO - PID 31764 | RSS: Main: 163958784 04:25:29 INFO - PID 31764 | 04:25:31 INFO - PID 31764 | Cycle 1(1): loaded http://localhost:52715/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52715/tests/kraken/driver.html?testName=audio-beat-detection) 04:25:32 INFO - PID 31764 | RSS: Main: 168775680 04:25:32 INFO - PID 31764 | 04:25:35 INFO - PID 31764 | Cycle 1(1): loaded http://localhost:52715/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52715/tests/kraken/driver.html?testName=audio-dft) 04:25:35 INFO - PID 31764 | RSS: Main: 169275392 04:25:35 INFO - PID 31764 | 04:25:38 INFO - PID 31764 | Cycle 1(1): loaded http://localhost:52715/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52715/tests/kraken/driver.html?testName=audio-fft) 04:25:39 INFO - PID 31764 | RSS: Main: 164093952 04:25:39 INFO - PID 31764 | 04:25:41 INFO - PID 31764 | Cycle 1(1): loaded http://localhost:52715/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52715/tests/kraken/driver.html?testName=audio-oscillator) 04:25:42 INFO - PID 31764 | RSS: Main: 165040128 04:25:42 INFO - PID 31764 | 04:25:44 INFO - PID 31764 | Cycle 1(1): loaded http://localhost:52715/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52715/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:25:44 INFO - PID 31764 | RSS: Main: 165154816 04:25:44 INFO - PID 31764 | 04:25:47 INFO - PID 31764 | Cycle 1(1): loaded http://localhost:52715/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52715/tests/kraken/driver.html?testName=imaging-darkroom) 04:25:48 INFO - PID 31764 | RSS: Main: 168132608 04:25:48 INFO - PID 31764 | 04:25:51 INFO - PID 31764 | Cycle 1(1): loaded http://localhost:52715/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52715/tests/kraken/driver.html?testName=imaging-desaturate) 04:25:52 INFO - PID 31764 | RSS: Main: 170016768 04:25:52 INFO - PID 31764 | 04:25:55 INFO - PID 31764 | Cycle 1(1): loaded http://localhost:52715/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52715/tests/kraken/driver.html?testName=json-parse-financial) 04:25:55 INFO - PID 31764 | RSS: Main: 168415232 04:25:55 INFO - PID 31764 | 04:25:57 INFO - PID 31764 | Cycle 1(1): loaded http://localhost:52715/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52715/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:25:58 INFO - PID 31764 | RSS: Main: 168992768 04:25:58 INFO - PID 31764 | 04:25:59 INFO - PID 31764 | Cycle 1(1): loaded http://localhost:52715/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52715/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:26:00 INFO - PID 31764 | RSS: Main: 168353792 04:26:00 INFO - PID 31764 | 04:26:02 INFO - PID 31764 | Cycle 1(1): loaded http://localhost:52715/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52715/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:26:03 INFO - PID 31764 | RSS: Main: 165761024 04:26:03 INFO - PID 31764 | 04:26:05 INFO - PID 31764 | Cycle 1(1): loaded http://localhost:52715/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52715/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:26:06 INFO - PID 31764 | RSS: Main: 165675008 04:26:06 INFO - PID 31764 | 04:26:09 INFO - PID 31764 | Cycle 1(1): loaded http://localhost:52715/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52715/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:26:09 INFO - PID 31764 | RSS: Main: 166326272 04:26:09 INFO - PID 31764 | 04:26:11 INFO - PID 31764 | Cycle 1(1): loaded http://localhost:52715/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52715/tests/kraken/driver.html?testName=ai-astar) 04:26:11 INFO - PID 31764 | RSS: Main: 167751680 04:26:11 INFO - PID 31764 | 04:26:11 INFO - PID 31764 | __start_tp_report 04:26:11 INFO - PID 31764 | _x_x_mozilla_page_load 04:26:11 INFO - PID 31764 | _x_x_mozilla_page_load_details 04:26:11 INFO - PID 31764 | |i|pagename|runs| 04:26:11 INFO - PID 31764 | |0;ai-astar;96;106;99;105;106;107;106;98;118;109 04:26:11 INFO - PID 31764 | |1;audio-beat-detection;140;113;140;183;119;139;142;111;162;114 04:26:11 INFO - PID 31764 | |2;audio-dft;162;164;162;161;161;162;163;162;166;174 04:26:11 INFO - PID 31764 | |3;audio-fft;73;74;75;117;75;78;74;89;93;75 04:26:11 INFO - PID 31764 | |4;audio-oscillator;78;77;123;77;77;77;130;77;78;136 04:26:11 INFO - PID 31764 | |5;imaging-gaussian-blur;114;115;114;114;113;114;114;114;117;117 04:26:11 INFO - PID 31764 | |6;imaging-darkroom;148;150;147;148;149;148;150;148;149;148 04:26:11 INFO - PID 31764 | |7;imaging-desaturate;94;93;94;93;94;94;94;94;93;94 04:26:11 INFO - PID 31764 | |8;json-parse-financial;47;48;48;46;47;50;48;48;46;48 04:26:11 INFO - PID 31764 | |9;json-stringify-tinderbox;54;54;54;53;54;57;54;54;53;54 04:26:11 INFO - PID 31764 | |10;stanford-crypto-aes;75;74;75;78;75;73;74;74;76;74 04:26:11 INFO - PID 31764 | |11;stanford-crypto-ccm;123;126;122;121;116;128;124;115;118;159 04:26:11 INFO - PID 31764 | |12;stanford-crypto-pbkdf2;169;165;176;161;163;161;166;159;164;162 04:26:11 INFO - PID 31764 | |13;stanford-crypto-sha256-iterative;61;60;62;68;62;75;63;62;65;61 04:26:11 INFO - PID 31764 | __end_tp_report 04:26:11 INFO - PID 31764 | __start_cc_report 04:26:11 INFO - PID 31764 | _x_x_mozilla_cycle_collect,868 04:26:11 INFO - PID 31764 | __end_cc_report 04:26:11 INFO - PID 31764 | __startTimestamp1501932371870__endTimestamp 04:26:11 INFO - PID 31764 | 04:26:11 INFO - PID 31764 | ------- Summary: start ------- 04:26:11 INFO - PID 31764 | Number of tests: 14 04:26:11 INFO - PID 31764 | 04:26:11 INFO - PID 31764 | [#0] ai-astar Cycles:10 Average:105.00 Median:113.50 stddev:6.31 (5.6%) stddev-sans-first:5.79 04:26:11 INFO - PID 31764 | Values: 96.0 106.0 99.0 105.0 106.0 107.0 106.0 98.0 118.0 109.0 04:26:11 INFO - PID 31764 | 04:26:11 INFO - PID 31764 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:140.00 stddev:23.30 (16.6%) stddev-sans-first:24.68 04:26:11 INFO - PID 31764 | Values: 140.0 113.0 140.0 183.0 119.0 139.0 142.0 111.0 162.0 114.0 04:26:11 INFO - PID 31764 | 04:26:11 INFO - PID 31764 | [#2] audio-dft Cycles:10 Average:163.70 Median:162.50 stddev:3.92 (2.4%) stddev-sans-first:4.11 04:26:11 INFO - PID 31764 | Values: 162.0 164.0 162.0 161.0 161.0 162.0 163.0 162.0 166.0 174.0 04:26:11 INFO - PID 31764 | 04:26:11 INFO - PID 31764 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.00 stddev:14.01 (18.7%) stddev-sans-first:14.45 04:26:11 INFO - PID 31764 | Values: 73.0 74.0 75.0 117.0 75.0 78.0 74.0 89.0 93.0 75.0 04:26:11 INFO - PID 31764 | 04:26:11 INFO - PID 31764 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:77.00 stddev:25.49 (33.1%) stddev-sans-first:26.45 04:26:11 INFO - PID 31764 | Values: 78.0 77.0 123.0 77.0 77.0 77.0 130.0 77.0 78.0 136.0 04:26:11 INFO - PID 31764 | 04:26:11 INFO - PID 31764 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.00 stddev:1.35 (1.2%) stddev-sans-first:1.41 04:26:11 INFO - PID 31764 | Values: 114.0 115.0 114.0 114.0 113.0 114.0 114.0 114.0 117.0 117.0 04:26:11 INFO - PID 31764 | 04:26:11 INFO - PID 31764 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 04:26:11 INFO - PID 31764 | Values: 148.0 150.0 147.0 148.0 149.0 148.0 150.0 148.0 149.0 148.0 04:26:11 INFO - PID 31764 | 04:26:11 INFO - PID 31764 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 04:26:11 INFO - PID 31764 | Values: 94.0 93.0 94.0 93.0 94.0 94.0 94.0 94.0 93.0 94.0 04:26:11 INFO - PID 31764 | 04:26:11 INFO - PID 31764 | [#8] json-parse-financial Cycles:10 Average:47.60 Median:48.00 stddev:1.17 (2.4%) stddev-sans-first:1.22 04:26:11 INFO - PID 31764 | Values: 47.0 48.0 48.0 46.0 47.0 50.0 48.0 48.0 46.0 48.0 04:26:11 INFO - PID 31764 | 04:26:11 INFO - PID 31764 | [#9] json-stringify-tinderbox Cycles:10 Average:54.10 Median:54.00 stddev:1.10 (2.0%) stddev-sans-first:1.17 04:26:11 INFO - PID 31764 | Values: 54.0 54.0 54.0 53.0 54.0 57.0 54.0 54.0 53.0 54.0 04:26:11 INFO - PID 31764 | 04:26:11 INFO - PID 31764 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:75.00 stddev:1.40 (1.9%) stddev-sans-first:1.48 04:26:11 INFO - PID 31764 | Values: 75.0 74.0 75.0 78.0 75.0 73.0 74.0 74.0 76.0 74.0 04:26:11 INFO - PID 31764 | 04:26:11 INFO - PID 31764 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:123.50 stddev:12.59 (10.2%) stddev-sans-first:13.32 04:26:11 INFO - PID 31764 | Values: 123.0 126.0 122.0 121.0 116.0 128.0 124.0 115.0 118.0 159.0 04:26:11 INFO - PID 31764 | 04:26:11 INFO - PID 31764 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:164.50 stddev:4.93 (3.0%) stddev-sans-first:4.96 04:26:11 INFO - PID 31764 | Values: 169.0 165.0 176.0 161.0 163.0 161.0 166.0 159.0 164.0 162.0 04:26:11 INFO - PID 31764 | 04:26:11 INFO - PID 31764 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:62.50 stddev:4.53 (7.3%) stddev-sans-first:4.68 04:26:11 INFO - PID 31764 | Values: 61.0 60.0 62.0 68.0 62.0 75.0 63.0 62.0 65.0 61.0 04:26:11 INFO - PID 31764 | -------- Summary: end -------- 04:26:11 INFO - PID 31764 | 04:26:12 INFO - PID 31764 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:26:12 INFO - TEST-INFO | 31764: exit 0 04:26:12 INFO - TEST-OK | kraken | took 60036ms 04:26:12 INFO - SUITE-END | took 1169s 04:26:13 INFO - Completed test suite (00:19:30) 04:26:13 INFO - javascript benchmark 04:26:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8854.071526143583, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3388.237646529531, 3508.3860324443217, 3518.173229291118, 3537.8054207018604, 3544.4328907374816, 6202.78290259841, 6297.874042519153, 6314.116023756672, 6321.209848768904, 6353.809385718424, 6293.0, 6308.9684551577175, 6326.367363263671, 6378.138951241581, 6383.04254361846, 5425.267588875491, 5448.618596698233, 5508.6970216638065, 5593.496585307332, 5610.354809196954, 5443.591730620219, 5511.448855114497, 5526.58550608706, 5558.082916318823, 5564.554835613141, 5470.91793623096, 5486.588505862056, 5541.944580554204, 5565.109582466806, 5586.581006424514, 5384.380796208447, 5441.401445840955, 5467.589930755209, 5535.169724541351, 5536.390996990328, 5471.781128754845, 5497.367802702701, 5520.696361700105, 5529.557635389199, 5541.722913854291, 6216.68916554175, 6250.43746062852, 6326.051092336141, 6328.050792381134, 6381.0, 6652.600843949379, 6787.287334829871, 6801.557898736616, 6875.140607424072, 6890.31096890307, 6819.0, 6835.624040677761, 6841.589504629738, 6846.623435711034, 6853.623050732208, 6354.364563543655, 6355.745770169187, 6364.077208804697, 6378.4578310843635, 6385.2656944451055, 6805.863882722318, 6941.409980151642, 6959.652017399109, 7026.613536255555, 7030.718771249195, 6621.602703837785, 6626.7017984190825, 6634.966825165843, 6643.534952553371, 6649.867002659919, 6747.763828265987, 6749.561278516979, 6756.83107922296, 6760.1549806274215, 6766.357196066366, 6633.7346506140175, 6694.330566943364, 6716.899246511306, 6723.831904202434, 6727.29363416844, 6724.29394913527, 6763.222229443579, 6803.829904252433, 6839.62382068991, 6845.110135682329, 4948.727819969936, 4966.428860680996, 4992.900141997213, 5004.299398084198, 5005.374328208974, 4380.51814300433, 4389.648828093745, 4414.293713005904, 4449.332600109945, 4464.995376040365, 6381.521385896076, 6413.3266007069515, 6416.550841441148, 6430.64631445275, 6506.60960342381, 6801.65991700413, 6823.658817059128, 6829.726810927507, 6830.077939478207, 6837.35045170708, 6441.452476539546, 6483.384078512534, 6484.448821850101, 6522.869542609121, 6538.019297105472, 5614.1859430382365, 5630.0, 5679.630823996427, 5680.8863822723315, 5709.229254050733, 7043.859122817515, 7086.964565177244, 7129.073220481408, 7171.0, 7274.127104747464, 6833.45332373399, 6866.107406037183, 6877.140357455318, 6897.827554311182, 6897.862042759217, 7117.857642847218, 7182.4613154014705, 7198.352148306678, 7199.460040497089, 7258.165310989304, 6728.932710672831, 6803.93196068033, 6813.3527314905, 6834.179898412222, 6836.794896153124, 6866.965665171642, 6879.449644028366, 6884.449244060363, 6970.442364610718, 6975.616341101085, 6447.967760161169, 6513.609183448819, 6517.315681853337, 6521.771737989147, 6542.247641521286, 6554.082428460115, 6612.305707900601, 6618.900716489353, 6627.204735431779, 6654.0, 6588.571742836701, 6663.800085997428, 6695.0, 6700.095487109373, 6701.1623547056615, 6662.133922590032, 6707.496937729592, 6708.496862735412, 6728.495362847708, 6759.425448836904, 6365.8726825464155, 6423.0, 6456.031595260749, 6518.282988871315, 6559.770408035696], "value": 6196.432910793047, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [913.4473643445715, 919.2829592917523, 949.2548349545606, 965.0, 968.5157421289356, 42690.14619707608, 43220.78389608047, 43583.564164358344, 43627.0, 43637.78181109094, 39619.40570891439, 39954.8002259989, 40183.397249041285, 40254.19491610166, 40417.19165616686, 6776.661166941645, 6917.100776898996, 6917.7578784742545, 6938.236793952661, 6944.062551555551, 6786.694598743044, 6864.0, 6864.828379290508, 6865.10753602031, 6865.691043903036, 6845.691943862514, 7570.280823321776, 7721.961390193042, 7728.111267204287, 7728.381729461629, 7609.277118673717, 7632.313091821735, 7664.773636218234, 7666.8466630667635, 7674.769756907302, 7243.601601911892, 7489.962550187269, 7511.136219334737, 7514.173440921494, 7547.094348678139, 40287.39568906469, 40470.79764601187, 40529.392059119135, 40539.0, 40610.18779624421, 3443.0359499340225, 3450.9309813803584, 3461.16931936336, 3470.340635279289, 3472.6700963408434, 31448.685513145032, 31605.525917111263, 31677.8416107918, 31689.683103168903, 31717.682823171934, 4936.901261974776, 4991.101601711691, 5019.874503137451, 5019.899602007976, 5025.7235852028125, 205401.0, 205452.0, 206849.0, 209172.0, 215632.0, 51595.48404515982, 52101.218481722804, 52123.47876521262, 52208.0, 52253.0, 54171.0, 54259.72870135624, 54268.72865635646, 54284.0, 54298.72850635721, 15690.9215453922, 15886.285117169755, 15901.363945442054, 15907.920460397856, 16108.838911610968, 12930.935345323212, 12935.353232338346, 12940.547080852126, 12942.094053416358, 12946.805797913039, 15124.168170750494, 15150.772738408932, 15159.924200378928, 15195.544133676007, 15272.16003119817, 5799.3620701722775, 5976.880462390728, 6081.239845019372, 6098.4996151578525, 6116.3883611638485, 1082.8917108289108, 1083.615316562609, 1088.1947358954476, 1099.0932480703452, 1102.6195962392962, 24065.0, 24211.273661790176, 24350.94894879909, 24429.14497992597, 24640.630390544156, 1150.263831148066, 1167.3404526442532, 1178.2459226095307, 1182.8580570331615, 1190.8511436070492, 12703.936480317725, 12734.299613521345, 12889.03332250085, 12923.095383323265, 12943.741125177443, 281159.0, 284987.0, 286042.0, 286089.0, 286498.0, 54923.0, 55023.0, 55038.0, 55218.171727423316, 55339.16991245135, 1501.369424841569, 1516.3631274864583, 1529.9541013769606, 1534.4552683797315, 1538.8691961183201, 23974.52050959006, 24005.759942400353, 24028.0, 24066.639000415358, 24089.879550602134, 39768.80115599519, 39885.00287492836, 39900.60099398969, 39912.60087399205, 40001.199975999734, 246618.0, 247532.0, 248020.0, 248089.0, 248216.0, 30372.696273036985, 31032.844835775675, 33668.83165584156, 34026.829865851505, 34119.82940085284, 43255.351169731846, 43512.78243608762, 44254.55745442633, 44464.33303500515, 44794.77602611966, 28536.286592835346, 28746.281342966595, 28835.56746648844, 28851.5672264912, 28935.131946041653, 32635.510467342534, 36308.0, 36399.45400818937, 36573.45139822958, 36900.07749806276, 41470.0, 41712.37431438592, 41931.7903410481, 42502.57497424986, 42599.148017040105, 28359.716402835707, 28612.42775144527, 28629.856850715612, 28953.56569651499, 28976.42047159087, 26214.34464138412, 26234.93193131181, 26298.0, 26498.735012649628, 27001.86499067492], "value": 17718.89096462143, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.5705720709467, 587.797209962563, 589.1045610671779, 594.180031556452, 595.702148925537, 22806.429839254026, 23199.420014499625, 24108.75891241087, 24125.396865078383, 24191.879040604796, 26994.0, 27353.316167095832, 27464.313392165204, 27519.86240068802, 27641.30896727583, 6207.813765587029, 6336.5881217720935, 6346.5874718143405, 6354.237491501003, 6360.427561519462, 5976.820695379124, 6278.717457714414, 6311.463525600329, 6354.110424540568, 6455.870882582346, 6421.678916054202, 6457.096006559085, 6461.838454038663, 6462.256840463337, 6463.967680161616, 6396.072569477446, 6442.323556026597, 6453.677316134174, 6453.9354606454035, 6461.612303261796, 5996.280446346423, 6011.368806275322, 6015.308239552463, 6021.307549631804, 6021.63870167787, 30476.085717428512, 30590.235244118852, 31029.689703102908, 31060.223494412596, 31565.684343156503, 2260.615695331781, 2299.0458959531775, 2322.790948814598, 2323.4772176260376, 2323.814094872423, 20356.592868142554, 20939.58120837575, 20942.581148376947, 21054.684179737316, 21068.367948961557, 2437.6587277781123, 2445.572024895654, 2493.264486976328, 2494.2641920633273, 2494.787943024845, 140513.2974335132, 145548.27225863907, 145695.27152364276, 145894.0, 145963.0, 14572.854271457361, 15252.771208431883, 15680.215989200495, 15813.762793558106, 15981.44064957721, 24465.021399143836, 24507.50984980326, 24854.87572562162, 24865.751342486343, 24872.12947546827, 10860.837087443695, 10927.235093543375, 10934.56261749537, 10950.561977520969, 10952.561897524169, 10097.394156350643, 10176.694699158888, 10210.948945255375, 10349.68809980814, 10384.688459346231, 9693.757656058655, 10797.676069717922, 10894.0, 12204.206726562923, 12815.487380504675, 3762.7930463824205, 4142.937855932163, 4151.4395556600075, 4232.386303985966, 4603.49361570227, 1054.7890421915647, 1057.2599180573475, 1067.1942683274078, 1074.333912973961, 1076.160594736107, 25216.117435889657, 26270.86902021111, 26292.86853565758, 26392.60411093835, 26678.5998210027, 1105.4030823355458, 1125.7973564758258, 1125.831125331207, 1126.6282126898104, 1138.322697994692, 11939.76120477603, 12352.135350525377, 12361.93819030899, 12417.813732794015, 12489.125761196628, 551208.0, 555126.0, 559384.0, 569758.0, 599409.0, 132756.0, 133701.0, 134932.0, 135862.0, 137755.0, 1213.969650758738, 1322.642886420661, 1366.4397596985386, 1376.0849035391352, 1376.3462355381114, 23274.53450931006, 23430.414239644146, 23491.647625285976, 23689.881550592138, 23876.641850372605, 65167.0, 66510.0, 66644.33355666381, 67041.99437008351, 68582.31417685958, 78052.60973695095, 78417.0, 78644.0, 79024.0, 79301.20698792938, 15381.769273460683, 15778.289976951295, 15792.21038948071, 15874.0, 15897.364105436116, 24283.0, 24782.876085619457, 24791.380215494755, 24811.0, 24963.251102466955, 19835.60328793445, 20164.596708065463, 20514.897425512776, 20594.38216853497, 20650.58698825985, 17551.561210969827, 17678.204480798653, 18345.908270458563, 18380.724289135407, 18987.145578448726, 20538.897305513376, 20968.68546971827, 21150.365489035354, 21215.257465988616, 21244.150233990465, 15357.769633455284, 15421.768673469682, 15547.222638868237, 15552.30014649321, 15593.68812623764, 18912.621747564695, 19204.807951920862, 19681.21275148978, 19707.60584788325, 19890.60218795645], "value": 13131.777764894012, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1452.33918567052, 1473.7641977283636, 1478.0688166455145, 1501.3093976770685, 1510.9622259443513, 13491.730165396712, 14944.626384340398, 15473.45842895499, 15501.0, 15579.53261402157, 15080.321385537649, 15399.69200615987, 15419.0, 15439.305231264592, 15441.922790386032, 2718.116612101065, 2776.694563598003, 2776.819506732066, 2776.9444611107765, 2778.360976975297, 2635.8286711363794, 2691.636629055082, 2730.549459339207, 2788.5817127430946, 2790.7627851632637, 2750.0787236275773, 2762.323230808455, 2782.4296019315993, 2784.791140664448, 2788.5817127430846, 2669.23926680895, 2669.7196794336705, 2674.1977406777987, 2680.7319268073234, 2687.207273854218, 2565.961510577324, 2573.700281357921, 2591.663083799113, 2596.1302963507246, 2602.466494368669, 14956.925215373962, 15277.541673749805, 15349.539513814603, 15353.616159595987, 15359.846401536066, 8143.796405089861, 8435.704750333709, 8454.492730436194, 8473.406861519696, 8482.83034339316, 5422.83731488052, 5532.723363831792, 5572.916406253909, 5694.6867922264255, 5698.7435565399655, 1869.2896699254331, 1881.9435416937513, 1889.4803928919519, 1922.8557858160555, 1924.653562358775, 25515.617265741028, 25750.74249257502, 25752.484950301077, 26212.0, 27300.863495682395, 6853.280405557444, 6974.79075627732, 7071.328223818729, 7163.42692584592, 7210.67551960163, 18456.538586535175, 18511.0, 18511.259549617866, 18527.72208416848, 18529.81470185281, 7960.960195199103, 8045.718399855977, 8059.113497515269, 8072.919270807334, 8078.636461359253, 7122.786316410516, 7453.0, 7531.246875312425, 7548.4716069874585, 7554.169041405441, 5305.920411193758, 5325.733713314319, 5397.8110766123, 5406.837794866082, 5427.83716488506, 1452.6949340638373, 1508.6982603479348, 1510.780936764163, 1515.6968606278788, 1521.0949485056374, 937.2642475656713, 963.937344072633, 979.1432496565506, 979.8291042204639, 982.1946004276567, 7874.763757087297, 7885.1326354101, 7919.366450683931, 7958.403119766041, 7962.2037796221075, 742.5025233093841, 750.4559194583992, 754.4115589839934, 767.7044337929825, 771.074710347574, 5178.948210517847, 5517.944820551824, 5567.498925096761, 5669.291338582677, 5715.913976344481, 21545.0, 21893.0, 22271.777282227293, 22545.0981960723, 22666.773332266795, 21339.25312614051, 21817.0, 22033.0, 22214.22250221267, 22381.88809055977, 10610.151187904949, 11143.498542565603, 12069.0, 12131.21147125434, 12382.752344953231, 7811.804704882424, 8598.61306241233, 9293.488858112869, 9415.62337506492, 9453.716388508356, 19105.80894191096, 19239.615207696046, 19410.2235910562, 19426.12582433822, 19725.210991560176, 19206.711899321243, 19243.51891202731, 19628.313009044614, 20222.696659550413, 20264.18943242254, 12650.746985060432, 12857.67855803575, 12943.0, 12943.805842912176, 12951.158174718614, 13294.335283235992, 13432.798508022583, 13565.253911034988, 13572.1856688599, 13592.252426116263, 11534.769304614028, 11643.068554515788, 11662.76674466489, 11857.40712964331, 11947.402629868646, 11257.910957706816, 11395.544178232778, 11457.885421145682, 11698.181127321006, 11925.4037298133, 9748.0, 9920.305578609428, 9923.0, 9924.851127232952, 9924.900750992398, 7091.0, 7162.785116446515, 7175.641217938978, 7179.497435179696, 7181.461390395637, 7262.600556969417, 7262.818429539092, 7276.235995220637, 7389.408847292097, 7396.186419493743], "value": 6780.026209811369, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.5238702987277, 513.4070148977929, 517.5393899429507, 537.1325309624955, 538.8141091323492, 6053.213082299306, 6127.35662755411, 6136.7545298188015, 6139.877202455959, 6149.323574406817, 5916.171735956958, 6025.7288422021, 6055.939440605593, 6106.572539922207, 6107.450329470346, 4735.479097299286, 4767.380240568721, 4772.260299653559, 4810.172134588851, 4829.092508459156, 4638.304254361839, 4799.13615549201, 4829.855104346875, 4834.30175915425, 4836.975815120937, 4690.132325519773, 4738.597219236369, 4741.478437371887, 4769.712177712016, 4807.206810876201, 4750.4299484061785, 4752.334673145762, 4768.61851051915, 4771.403574553181, 4821.493743156988, 4319.43847299849, 4326.918270432392, 4347.521772605042, 4355.259605867011, 4363.170997510463, 5965.194698715704, 5998.190244317005, 6002.189704389895, 6010.248718910137, 6071.969640151771, 5768.567357448208, 5802.448767367094, 5811.27359080115, 5815.273090863642, 5824.88350232993, 6482.157319548475, 6489.09152718615, 6526.510511711641, 6572.375624315682, 6581.7367305307735, 4862.270659401082, 4902.632302577321, 4931.556159945622, 4965.975170124127, 4973.42805577356, 6845.349691779273, 6859.828504287383, 6939.167299924042, 6944.4097251733665, 6978.267281935375, 5064.924026139611, 5069.822556210515, 5079.958608485252, 5095.993363915233, 5160.638755287169, 5101.464346243665, 5155.948440515622, 5182.740862956837, 5205.869853253699, 5211.218317252443, 5753.59724819267, 5754.482096611325, 5763.452472015152, 5778.653280803165, 5788.3343415506915, 6526.67366631676, 6547.517957222316, 6580.835479112965, 6625.370589793962, 6678.7328506859185, 1704.6079401737422, 1749.7287920372107, 1769.8761086724064, 1782.2069179215125, 1783.233209719833, 1209.5343292832322, 1258.7734207842493, 1264.6395777203452, 1280.1231156657718, 1288.2141893444991, 6304.495640348761, 6316.368363163739, 6320.5575609706875, 6321.65230912295, 6330.525210609223, 6522.543421960512, 6535.673216339164, 6536.215654121441, 6545.116409284781, 6634.170728658918, 6242.968785156045, 6249.343818899041, 6282.151909492251, 6320.936790632035, 6355.332690067568, 3414.6756058174433, 3500.982495087508, 3550.91122721934, 3561.3411518869093, 3565.982170089133, 7042.894356584656, 7060.964695176594, 7094.396976256973, 7105.89341159883, 7117.4306055515435, 6873.656317184221, 6874.106366172366, 6875.518713689994, 6900.309969003059, 6962.199347075049, 6970.51206415546, 7018.7543435980515, 7059.929400705927, 7089.397401220851, 7158.921663684666, 6724.462043036643, 6751.480916793682, 6783.626900520519, 6784.3894049535775, 6806.693698783468, 6547.770828020996, 6616.206055273398, 6681.665916704243, 6695.899561506679, 6696.990902729259, 7063.788086357417, 7079.044329015517, 7116.857662846817, 7121.501494895308, 7121.893171602534, 5041.899162016813, 5059.291699162194, 5069.112905241642, 5097.6941383517105, 5101.8724531887, 6659.866802664016, 6672.165979252593, 6683.732650693918, 6701.765438209834, 6758.797236082925, 6474.287828338973, 6479.611223326616, 6526.412622863965, 6557.147570815763, 6563.310852360624, 6338.0, 6392.872142557216, 6417.647029413427, 6458.451031662174, 6460.224773027267, 6207.782727604512, 6305.180326557518, 6333.904991425225, 6403.903941440789, 6439.935600644121, 6360.950443177009, 6422.389872962061, 6423.839404014937, 6473.741050357933, 6564.80305590833, 6266.530010249341, 6270.216222972129, 6275.811725648238, 6319.304876463493, 6332.588381755171], "value": 5090.457200236668, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [918.0498184379169, 942.0138162026376, 942.4910548303916, 948.8386974214383, 958.9904100958993, 17923.372681956134, 18869.339573114943, 18872.245110195574, 18875.62248755024, 18878.433646990594, 18314.267429302847, 19244.0, 22290.665640015413, 22320.21879234223, 22513.437164070907, 1053.2837670384135, 1083.8157513222732, 1084.4360932315192, 1084.5499117866077, 1086.0931122512711, 975.6975337645317, 1068.2522234435926, 1072.0351683484887, 1089.7221208591839, 1097.8902109788996, 1120.9159313051514, 1121.3216004317394, 1122.1247427006947, 1122.9943850280738, 1139.1627154041773, 1104.6465131158034, 1108.61198580497, 1113.1651261553834, 1113.6213687346342, 1133.2463911498885, 813.9267465928036, 817.1215942861388, 817.8037271054964, 820.8809722590191, 838.4591938199887, 18405.07974601278, 18681.719774203397, 19583.804161958342, 19678.212871485124, 19912.0, 21431.35705928809, 21848.12607495698, 21880.89059554708, 22228.993905485193, 22329.55340893173, 15600.453984110614, 15603.921980390025, 15660.451884183998, 15666.608334791608, 15918.522444326689, 3752.5121734174654, 3778.149916268845, 3779.640934111255, 3780.7731536107644, 3781.0, 139875.21101091016, 140642.593574065, 141465.0, 144242.27878860643, 144494.0, 17039.0, 17303.91348043277, 17313.82686173122, 17570.209340579706, 17640.823591763918, 32333.51499727506, 32525.0, 32785.0, 32846.0, 32885.50671739926, 8398.0, 8649.956750216208, 8714.085021072822, 8813.515256660945, 8828.602712877935, 4584.61030812378, 4690.7654617269, 4703.294505824154, 4708.599769019604, 4712.764361781898, 5325.893482130413, 5419.376771671229, 5534.695591742493, 5557.44425557441, 5590.0, 978.5254151736402, 985.2118305355687, 993.4933184076173, 994.9204063675033, 1004.0712341084468, 696.951213415056, 715.9463040271896, 717.3292971072065, 719.4568101083753, 730.2989130434842, 12867.292298923649, 13427.462901484027, 14371.281435928371, 15084.849151508344, 15817.288222029807, 693.3517161454057, 698.0889938630035, 713.8429545499981, 714.2357677285255, 721.6860665610476, 6292.828974003961, 6508.284088750233, 6604.042413849965, 6634.668266586747, 6656.900146497806, 123268.0, 125293.37353313174, 125730.37134814267, 125993.37003315108, 132874.33562832125, 110927.44536277428, 112471.43764281126, 113764.0, 115299.42350288363, 115595.42202289103, 98337.50831245941, 99620.0, 100203.0, 100810.0, 101715.49142254241, 13661.18032918028, 13731.725365492834, 13904.37430315618, 13939.930300348433, 13955.860441395456, 47615.52384476111, 48279.27581086357, 49343.74812713438, 49413.0, 49541.50458495369, 62571.0, 62926.68536657288, 63663.0, 65062.67468662626, 66211.0, 19317.8068219316, 19664.311749088713, 19769.40691779249, 19980.0, 20017.499562511053, 21666.458338541663, 21741.782582173975, 21924.23265185711, 22013.449663757892, 22084.227052053102, 17443.0, 17597.208125634123, 17649.0, 17850.285988560314, 18009.639807204043, 18495.53761155982, 18513.35203267879, 18548.44354669362, 18635.06824658789, 18733.531661708566, 19493.12280947389, 19694.409167724993, 19746.111424985622, 19791.802081978996, 19914.800851991295, 12143.332116733665, 12226.20529665569, 12451.750964980469, 12464.626061218178, 12540.498380064695, 15221.467248646244, 15465.458708945132, 15529.610913345088, 15639.921800390925, 15801.68396632038], "value": 9681.454087773262, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1467.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 106.0, 99.0, 105.0, 106.0, 107.0, 106.0, 98.0, 118.0, 109.0], "value": 105.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 113.0, 140.0, 183.0, 119.0, 139.0, 142.0, 111.0, 162.0, 114.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 161.0, 161.0, 162.0, 163.0, 162.0, 166.0, 174.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 117.0, 75.0, 78.0, 74.0, 89.0, 93.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 123.0, 77.0, 77.0, 77.0, 130.0, 77.0, 78.0, 136.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 117.0, 117.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 147.0, 148.0, 149.0, 148.0, 150.0, 148.0, 149.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 48.0, 48.0, 46.0, 47.0, 50.0, 48.0, 48.0, 46.0, 48.0], "value": 47.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 53.0, 54.0, 57.0, 54.0, 54.0, 53.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 78.0, 75.0, 73.0, 74.0, 74.0, 76.0, 74.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 126.0, 122.0, 121.0, 116.0, 128.0, 124.0, 115.0, 118.0, 159.0], "value": 125.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 176.0, 161.0, 163.0, 161.0, 166.0, 159.0, 164.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 62.0, 68.0, 62.0, 75.0, 63.0, 62.0, 65.0, 61.0], "value": 63.9, "unit": "score"}]}]} 04:26:13 INFO - Return code: 0 04:26:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:26:13 INFO - # TBPL SUCCESS # 04:26:13 INFO - Running post-action listener: _package_coverage_data 04:26:13 INFO - Running post-action listener: _resource_record_post_action 04:26:13 INFO - [mozharness: 2017-08-05 11:26:13.184375Z] Finished run-tests step (success) 04:26:13 INFO - Running post-run listener: _resource_record_post_run 04:26:13 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 12288; Write bytes: 427765760; Read time: 332; Write time: 255296 04:26:13 INFO - TinderboxPrint: CPU usage
13.1% 04:26:13 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 332 04:26:13 INFO - TinderboxPrint: I/O write bytes / time
427,765,760 / 255,296 04:26:13 INFO - TinderboxPrint: CPU idle
8,234.5 (86.9%) 04:26:13 INFO - TinderboxPrint: CPU user
1,189.8 (12.6%) 04:26:13 INFO - TinderboxPrint: Swap in / out
0 / 0 04:26:13 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108212224; Read time: 0; Write time: 78936 04:26:13 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:26:13 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 8192; Write bytes: 319553536; Read time: 320; Write time: 176360 04:26:13 INFO - Running post-run listener: _upload_blobber_files 04:26:13 INFO - Blob upload gear active. 04:26:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:26:13 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:26:13 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:26:13 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:26:14 INFO - (blobuploader) - INFO - Open directory for files ... 04:26:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:26:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:26:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:14 INFO - (blobuploader) - INFO - Done attempting. 04:26:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:26:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:26:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:15 INFO - (blobuploader) - INFO - Done attempting. 04:26:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:26:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:26:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:22 INFO - (blobuploader) - INFO - Done attempting. 04:26:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:26:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:26:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:23 INFO - (blobuploader) - INFO - Done attempting. 04:26:23 INFO - (blobuploader) - INFO - Iteration through files over. 04:26:23 INFO - Return code: 0 04:26:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:26:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:26:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28697e2ee5392821f5dd94e6259d85b93791581fdeeee9c8ee8744299d30528bf62eb8a8765666f67485cc0d38c11e235f7d6edbe8082e398f9027ebd49d5b55", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c2fea20d805e01fda1e89437260b4028561eef53762182ef80e7020008a1644619e73ab9dc3bfc44210bd4474e4c17b40600553908385f9c084a9cf447d48ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c65a46dc04d5e08593038d86b54b26dfe78eac0dded688987d220d8c705ad4440c5caf7d3a7165855ab0084404dd4470da33baa4d4f164a70682d1f5b48d5585", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50d406b41e50bb510605a8cc9428230dccd0fb4a6434c4ce09e2b49e2aa7095994bc691dbed5e84cba6ac1f1a15c9874cc94268f9d725adf3f54084a1b1baf1f"} 04:26:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:26:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:26:23 INFO - Contents: 04:26:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28697e2ee5392821f5dd94e6259d85b93791581fdeeee9c8ee8744299d30528bf62eb8a8765666f67485cc0d38c11e235f7d6edbe8082e398f9027ebd49d5b55", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c2fea20d805e01fda1e89437260b4028561eef53762182ef80e7020008a1644619e73ab9dc3bfc44210bd4474e4c17b40600553908385f9c084a9cf447d48ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c65a46dc04d5e08593038d86b54b26dfe78eac0dded688987d220d8c705ad4440c5caf7d3a7165855ab0084404dd4470da33baa4d4f164a70682d1f5b48d5585", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50d406b41e50bb510605a8cc9428230dccd0fb4a6434c4ce09e2b49e2aa7095994bc691dbed5e84cba6ac1f1a15c9874cc94268f9d725adf3f54084a1b1baf1f"} 04:26:23 INFO - Running post-run listener: copy_logs_to_upload_dir 04:26:23 INFO - Copying logs to upload dir... 04:26:23 INFO - mkdir: /builds/slave/test/build/upload/logs 04:26:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.210889 ========= master_lag: -0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-05 04:26:22.877596) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-05 04:26:22.884828) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28697e2ee5392821f5dd94e6259d85b93791581fdeeee9c8ee8744299d30528bf62eb8a8765666f67485cc0d38c11e235f7d6edbe8082e398f9027ebd49d5b55", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c2fea20d805e01fda1e89437260b4028561eef53762182ef80e7020008a1644619e73ab9dc3bfc44210bd4474e4c17b40600553908385f9c084a9cf447d48ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c65a46dc04d5e08593038d86b54b26dfe78eac0dded688987d220d8c705ad4440c5caf7d3a7165855ab0084404dd4470da33baa4d4f164a70682d1f5b48d5585", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50d406b41e50bb510605a8cc9428230dccd0fb4a6434c4ce09e2b49e2aa7095994bc691dbed5e84cba6ac1f1a15c9874cc94268f9d725adf3f54084a1b1baf1f"} build_url:https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011311 build_url: 'https://queue.taskcluster.net/v1/task/eQ05MNmUTf6ka9Q4eropRw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/28697e2ee5392821f5dd94e6259d85b93791581fdeeee9c8ee8744299d30528bf62eb8a8765666f67485cc0d38c11e235f7d6edbe8082e398f9027ebd49d5b55", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c2fea20d805e01fda1e89437260b4028561eef53762182ef80e7020008a1644619e73ab9dc3bfc44210bd4474e4c17b40600553908385f9c084a9cf447d48ce", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c65a46dc04d5e08593038d86b54b26dfe78eac0dded688987d220d8c705ad4440c5caf7d3a7165855ab0084404dd4470da33baa4d4f164a70682d1f5b48d5585", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50d406b41e50bb510605a8cc9428230dccd0fb4a6434c4ce09e2b49e2aa7095994bc691dbed5e84cba6ac1f1a15c9874cc94268f9d725adf3f54084a1b1baf1f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-05 04:26:22.912159) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 04:26:22.912462) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1501930484.115819-1813349419 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 04:26:22.991980) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-05 04:26:22.992261) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-05 04:26:22.995611) ========= ========= Total master_lag: 0.06 =========