builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-069 starttime: 1501929870.52 results: success (0) revision: 933a04a91ce3bd44b230937083a835cb60637084 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-05 03:44:30.521926) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-05 03:44:30.522575) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-05 03:44:30.522871) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-05 03:44:30.593858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 03:44:30.594138) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-05 03:44:30-- 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% 53.8M=0s 2017-08-05 03:44:30 (53.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.245580 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 03:44:30.891372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 03:44:30.894681) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013706 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 03:44:30.944028) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-05 03:44:30.944337) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-05 03:44:30,972 truncating revision to first 12 chars 2017-08-05 03:44:30,972 Setting DEBUG logging. 2017-08-05 03:44:30,972 attempt 1/10 2017-08-05 03:44:30,972 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 03:44:32,069 unpacking tar archive at: mozilla-central-933a04a91ce3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.474383 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-05 03:44:32.436922) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-05 03:44:32.437237) ========= script_repo_revision: 933a04a91ce3bd44b230937083a835cb60637084 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-05 03:44:32.437633) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-05 03:44:32.437906) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-05 03:44:32.448419) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-08-05 03:44:32.448707) ========= /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=05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:44:32 INFO - MultiFileLogger online at 20170805 03:44:32 in /builds/slave/test 03:44: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 03:44:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:44:32 INFO - {'append_to_log': False, 03:44:32 INFO - 'base_work_dir': '/builds/slave/test', 03:44:32 INFO - 'blob_upload_branch': 'Firefox', 03:44:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:44:32 INFO - 'branch': 'Firefox', 03:44:32 INFO - 'buildbot_json_path': 'buildprops.json', 03:44:32 INFO - 'code_coverage': False, 03:44:32 INFO - 'config_files': ('talos/linux_config.py',), 03:44:32 INFO - 'default_actions': ('clobber', 03:44:32 INFO - 'read-buildbot-config', 03:44:32 INFO - 'download-and-extract', 03:44:32 INFO - 'populate-webroot', 03:44:32 INFO - 'create-virtualenv', 03:44:32 INFO - 'install', 03:44:32 INFO - 'setup-mitmproxy', 03:44:32 INFO - 'run-tests'), 03:44:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:44:32 INFO - 'disable_ccov_upload': False, 03:44:32 INFO - 'download_minidump_stackwalk': True, 03:44:32 INFO - 'download_symbols': 'ondemand', 03:44:32 INFO - 'enable_stylo': False, 03:44:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:44:32 INFO - 'tooltool.py': '/tools/tooltool.py', 03:44:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:44:32 INFO - '/tools/misc-python/virtualenv.py')}, 03:44:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:44:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:44:32 INFO - 'gecko_profile': False, 03:44:32 INFO - 'gecko_profile_interval': 0, 03:44:32 INFO - 'installer_path': 'installer.exe', 03:44:32 INFO - 'log_level': 'info', 03:44:32 INFO - 'log_name': 'talos', 03:44:32 INFO - 'log_to_console': True, 03:44:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:44:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:44:32 INFO - 'opt_config_files': (), 03:44:32 INFO - 'pip_index': False, 03:44:32 INFO - 'suite': 'dromaeojs-e10s', 03:44:32 INFO - 'system_bits': '32', 03:44:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:44:32 INFO - 'title': 'talos-linux64-ix-069', 03:44:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:44:32 INFO - 'use_talos_json': True, 03:44:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:44:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:44:32 INFO - 'work_dir': 'build'} 03:44:32 INFO - [mozharness: 2017-08-05 10:44:32.693885Z] Running clobber step. 03:44:32 INFO - Running pre-action listener: _resource_record_pre_action 03:44:32 INFO - Running main action method: clobber 03:44:32 INFO - rmtree: /builds/slave/test/build 03:44:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:44:33 INFO - Running post-action listener: _resource_record_post_action 03:44:33 INFO - [mozharness: 2017-08-05 10:44:33.676495Z] Finished clobber step (success) 03:44:33 INFO - [mozharness: 2017-08-05 10:44:33.676597Z] Running read-buildbot-config step. 03:44:33 INFO - Running pre-action listener: _resource_record_pre_action 03:44:33 INFO - Running main action method: read_buildbot_config 03:44:33 INFO - Using buildbot properties: 03:44:33 INFO - { 03:44:33 INFO - "project": "", 03:44:33 INFO - "product": "firefox", 03:44:33 INFO - "who": "archaeopteryx@coole-files.de", 03:44:33 INFO - "installer_path": "public/build/target.tar.bz2", 03:44:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 03:44:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:44:33 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 03:44:33 INFO - "stage_platform": "linux64-stylo", 03:44:33 INFO - "basedir": "/builds/slave/test", 03:44:33 INFO - "buildnumber": 66, 03:44:33 INFO - "platform": "ubuntu64_hw_stylo", 03:44:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:44:33 INFO - "slavebuilddir": "test", 03:44:33 INFO - "taskId": "FhQYsVpDSVqeQoN9gpDceQ", 03:44:33 INFO - "branch": "mozilla-central", 03:44:33 INFO - "script_repo_revision": "production", 03:44:33 INFO - "revision": "933a04a91ce3bd44b230937083a835cb60637084", 03:44:33 INFO - "slavename": "talos-linux64-ix-069", 03:44:33 INFO - "repo_path": "mozilla-central" 03:44:33 INFO - } 03:44:33 INFO - Finding installer, test and symbols from parent task. 03:44:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FhQYsVpDSVqeQoN9gpDceQ'}, attempt #1 03:44:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FhQYsVpDSVqeQoN9gpDceQ'}, attempt #1 03:44:34 INFO - Task dependencies: Q911ZqBrTOC1zmf7mcOWpQ 03:44:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ'}, attempt #1 03:44:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.tar.bz2 03:44:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.test_packages.json 03:44:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.crashreporter-symbols.zip 03:44:35 INFO - Running post-action listener: _resource_record_post_action 03:44:35 INFO - [mozharness: 2017-08-05 10:44:35.027300Z] Finished read-buildbot-config step (success) 03:44:35 INFO - [mozharness: 2017-08-05 10:44:35.027521Z] Running download-and-extract step. 03:44:35 INFO - Running pre-action listener: _resource_record_pre_action 03:44:35 INFO - Running main action method: download_and_extract 03:44:35 INFO - mkdir: /builds/slave/test/build/tests 03:44: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')]} 03:44:35 INFO - trying https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.test_packages.json 03:44:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:44:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:44:35 INFO - Downloaded 989 bytes. 03:44:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:44:35 INFO - Using the following test package requirements: 03:44:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:44:35 INFO - u'common': [u'target.common.tests.zip'], 03:44:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:44:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:44:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:44:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:44:35 INFO - u'mozbase': [u'target.common.tests.zip'], 03:44:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:44:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:44:35 INFO - u'web-platform': [u'target.common.tests.zip', 03:44:35 INFO - u'target.web-platform.tests.tar.gz'], 03:44:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:44:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:44:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.common.tests.zip 03:44:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:44:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.common.tests.zip into memory 03:44:37 INFO - Content-Length response header: 54284959 03:44:37 INFO - Bytes received: 54284959 03:44:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:44:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.common.tests.zip 03:44:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:44:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.common.tests.zip into memory 03:44:49 INFO - Content-Length response header: 54284959 03:44:49 INFO - Bytes received: 54284959 03:45:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.talos.tests.zip 03:45:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:45:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.talos.tests.zip into memory 03:45:06 INFO - Content-Length response header: 14496008 03:45:06 INFO - Bytes received: 14496008 03:45:06 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')]} 03:45:06 INFO - trying https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.tar.bz2 03:45:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:45:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:45:07 INFO - Downloaded 61901377 bytes. 03:45:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.tar.bz2 03:45:07 INFO - mkdir: /builds/slave/test/properties 03:45:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:45:07 INFO - Writing to file /builds/slave/test/properties/build_url 03:45:07 INFO - Contents: 03:45:07 INFO - build_url:https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.tar.bz2 03:45:07 INFO - Running post-action listener: _resource_record_post_action 03:45:07 INFO - Running post-action listener: set_extra_try_arguments 03:45:07 INFO - [mozharness: 2017-08-05 10:45:07.496594Z] Finished download-and-extract step (success) 03:45:07 INFO - [mozharness: 2017-08-05 10:45:07.496691Z] Running populate-webroot step. 03:45:07 INFO - Running pre-action listener: _resource_record_pre_action 03:45:07 INFO - Running main action method: populate_webroot 03:45:07 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:45:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:45:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:45:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:45:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:45:07 INFO - 'tests': ['damp', 'tps']}, 03:45:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:45:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:45:07 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:45:07 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:45:07 INFO - 'other-e10s': {'tests': ['a11yr', 03:45:07 INFO - 'ts_paint', 03:45:07 INFO - 'tpaint', 03:45:07 INFO - 'sessionrestore', 03:45:07 INFO - 'sessionrestore_many_windows', 03:45:07 INFO - 'sessionrestore_no_auto_restore', 03:45:07 INFO - 'tabpaint']}, 03:45:07 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:45:07 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:45:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:45:07 INFO - 'tsvgr_opacity', 03:45:07 INFO - 'tart', 03:45:07 INFO - 'tscrollx', 03:45:07 INFO - 'tsvg_static']}, 03:45:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:45:07 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:45:07 INFO - 'talos_options': ['--mitmproxy', 03:45:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:45:07 INFO - '--firstNonBlankPaint'], 03:45:07 INFO - 'tests': ['tp6_google', 03:45:07 INFO - 'tp6_youtube', 03:45:07 INFO - 'tp6_amazon', 03:45:07 INFO - 'tp6_facebook']}, 03:45:07 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:45:07 INFO - 'talos_options': ['--stylo', 03:45:07 INFO - '--mitmproxy', 03:45:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:45:07 INFO - '--firstNonBlankPaint'], 03:45:07 INFO - 'tests': ['tp6_google', 03:45:07 INFO - 'tp6_youtube', 03:45:07 INFO - 'tp6_amazon', 03:45:07 INFO - 'tp6_facebook']}, 03:45:07 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:45:07 INFO - 'talos_options': ['--stylo', 03:45:07 INFO - '--stylo-threads=1', 03:45:07 INFO - '--mitmproxy', 03:45:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:45:07 INFO - '--firstNonBlankPaint'], 03:45:07 INFO - 'tests': ['tp6_google', 03:45:07 INFO - 'tp6_youtube', 03:45:07 INFO - 'tp6_amazon', 03:45:07 INFO - 'tp6_facebook']}, 03:45:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:45:07 INFO - 'talos_options': ['--xperf_path', 03:45:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:45:07 INFO - 'tests': ['tp5n']}}} 03:45:07 INFO - Running post-action listener: _resource_record_post_action 03:45:07 INFO - [mozharness: 2017-08-05 10:45:07.505069Z] Finished populate-webroot step (success) 03:45:07 INFO - [mozharness: 2017-08-05 10:45:07.505170Z] Running create-virtualenv step. 03:45:07 INFO - Running pre-action listener: _resource_record_pre_action 03:45:07 INFO - Running main action method: create_virtualenv 03:45:07 INFO - Creating virtualenv /builds/slave/test/build/venv 03:45:07 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 03:45:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:45:07 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:45:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:45:07 INFO - Using real prefix '/usr' 03:45:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:45:08 INFO - Installing distribute.............................................................................................................................................................................................done. 03:45:10 INFO - Installing pip.................done. 03:45:10 INFO - Return code: 0 03:45:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:45:10 INFO - Reading from file tmpfile_stdout 03:45:10 INFO - Output received: 03:45:10 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) 03:45:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:45: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')]} 03:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45: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')]} 03:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1611d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160eeb0>, '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 0x160fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610240>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', '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 03:45: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', 'pip>=1.5'] in /builds/slave/test/build 03:45: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 pip>=1.5 03:45:10 INFO - Using env: {'DISPLAY': ':0', 03:45:10 INFO - 'HOME': '/home/cltbld', 03:45:10 INFO - 'LANG': 'en_US.UTF-8', 03:45:10 INFO - 'LANGUAGE': 'en_US:en', 03:45:10 INFO - 'LOGNAME': 'cltbld', 03:45:10 INFO - 'MAIL': '/var/mail/cltbld', 03:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:10 INFO - 'MOZ_NO_REMOTE': '1', 03:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:10 INFO - 'NO_EM_RESTART': '1', 03:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:10 INFO - 'PWD': '/builds/slave/test', 03:45:10 INFO - 'SHELL': '/bin/bash', 03:45:10 INFO - 'SHLVL': '1', 03:45:10 INFO - 'TERM': 'linux', 03:45:10 INFO - 'TMOUT': '86400', 03:45:10 INFO - 'USER': 'cltbld', 03:45:10 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', 03:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:10 INFO - '_': '/tools/buildbot/bin/python'} 03:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:10 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 03:45:10 INFO - Cleaning up... 03:45:10 INFO - Return code: 0 03:45:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:45: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')]} 03:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45: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')]} 03:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45: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', '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 0x12a21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1611d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160eeb0>, '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 0x160fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610240>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', '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 03:45: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:45: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 psutil>=3.1.1 03:45:10 INFO - Using env: {'DISPLAY': ':0', 03:45:10 INFO - 'HOME': '/home/cltbld', 03:45:10 INFO - 'LANG': 'en_US.UTF-8', 03:45:10 INFO - 'LANGUAGE': 'en_US:en', 03:45:10 INFO - 'LOGNAME': 'cltbld', 03:45:10 INFO - 'MAIL': '/var/mail/cltbld', 03:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:10 INFO - 'MOZ_NO_REMOTE': '1', 03:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:10 INFO - 'NO_EM_RESTART': '1', 03:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:10 INFO - 'PWD': '/builds/slave/test', 03:45:10 INFO - 'SHELL': '/bin/bash', 03:45:10 INFO - 'SHLVL': '1', 03:45:10 INFO - 'TERM': 'linux', 03:45:10 INFO - 'TMOUT': '86400', 03:45:10 INFO - 'USER': 'cltbld', 03:45:10 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', 03:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:10 INFO - '_': '/tools/buildbot/bin/python'} 03:45:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:11 INFO - Downloading/unpacking psutil>=3.1.1 03:45: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 03:45: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 03:45: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 03:45: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 03:45:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:45:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:45:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:45:12 INFO - Installing collected packages: psutil 03:45:12 INFO - Running setup.py install for psutil 03:45:12 INFO - building 'psutil._psutil_linux' extension 03:45:12 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 03:45:13 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 03:45:13 INFO - building 'psutil._psutil_posix' extension 03:45:13 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 03:45:13 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 03:45:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:45:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:45:13 INFO - Successfully installed psutil 03:45:13 INFO - Cleaning up... 03:45:13 INFO - Return code: 0 03:45:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:45:13 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')]} 03:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:13 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')]} 03:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:13 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 0x12a21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1611d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160eeb0>, '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 0x160fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610240>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', '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 03:45:13 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 03:45:13 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 03:45:13 INFO - Using env: {'DISPLAY': ':0', 03:45:13 INFO - 'HOME': '/home/cltbld', 03:45:13 INFO - 'LANG': 'en_US.UTF-8', 03:45:13 INFO - 'LANGUAGE': 'en_US:en', 03:45:13 INFO - 'LOGNAME': 'cltbld', 03:45:13 INFO - 'MAIL': '/var/mail/cltbld', 03:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:13 INFO - 'MOZ_NO_REMOTE': '1', 03:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:13 INFO - 'NO_EM_RESTART': '1', 03:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:13 INFO - 'PWD': '/builds/slave/test', 03:45:13 INFO - 'SHELL': '/bin/bash', 03:45:13 INFO - 'SHLVL': '1', 03:45:13 INFO - 'TERM': 'linux', 03:45:13 INFO - 'TMOUT': '86400', 03:45:13 INFO - 'USER': 'cltbld', 03:45:13 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', 03:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:13 INFO - '_': '/tools/buildbot/bin/python'} 03:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:45:13 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 03:45:13 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 03:45:13 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 03:45:13 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 03:45:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:45:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:45:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:45:14 INFO - Installing collected packages: mozsystemmonitor 03:45:14 INFO - Running setup.py install for mozsystemmonitor 03:45:14 INFO - Successfully installed mozsystemmonitor 03:45:14 INFO - Cleaning up... 03:45:15 INFO - Return code: 0 03:45:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:45: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')]} 03:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45: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')]} 03:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:15 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 0x12a21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1611d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160eeb0>, '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 0x160fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610240>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', '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 03:45:15 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 03:45:15 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 03:45:15 INFO - Using env: {'DISPLAY': ':0', 03:45:15 INFO - 'HOME': '/home/cltbld', 03:45:15 INFO - 'LANG': 'en_US.UTF-8', 03:45:15 INFO - 'LANGUAGE': 'en_US:en', 03:45:15 INFO - 'LOGNAME': 'cltbld', 03:45:15 INFO - 'MAIL': '/var/mail/cltbld', 03:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:15 INFO - 'MOZ_NO_REMOTE': '1', 03:45:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:15 INFO - 'NO_EM_RESTART': '1', 03:45:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:15 INFO - 'PWD': '/builds/slave/test', 03:45:15 INFO - 'SHELL': '/bin/bash', 03:45:15 INFO - 'SHLVL': '1', 03:45:15 INFO - 'TERM': 'linux', 03:45:15 INFO - 'TMOUT': '86400', 03:45:15 INFO - 'USER': 'cltbld', 03:45:15 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', 03:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:15 INFO - '_': '/tools/buildbot/bin/python'} 03:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:15 INFO - Downloading/unpacking jsonschema==2.5.1 03:45:15 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 03:45:15 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 03:45:15 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 03:45:15 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 03:45:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:45:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:45:16 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 03:45:16 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 03:45:16 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 03:45:16 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 03:45:16 INFO - Downloading functools32-3.2.3-2.tar.gz 03:45:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:45:16 INFO - warning: no files found matching '*.txt' 03:45:16 INFO - no previously-included directories found matching 'build' 03:45:16 INFO - no previously-included directories found matching 'dist' 03:45:16 INFO - no previously-included directories found matching '.git*' 03:45:16 INFO - Installing collected packages: jsonschema, functools32 03:45:16 INFO - Running setup.py install for functools32 03:45:16 INFO - warning: no files found matching '*.txt' 03:45:16 INFO - no previously-included directories found matching 'build' 03:45:16 INFO - no previously-included directories found matching 'dist' 03:45:16 INFO - no previously-included directories found matching '.git*' 03:45:16 INFO - Successfully installed jsonschema functools32 03:45:16 INFO - Cleaning up... 03:45:16 INFO - Return code: 0 03:45:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:45:16 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')]} 03:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:16 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')]} 03:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:16 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 0x12a21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1611d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160eeb0>, '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 0x160fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610240>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', '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 03:45:16 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 03:45:16 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 03:45:16 INFO - Using env: {'DISPLAY': ':0', 03:45:16 INFO - 'HOME': '/home/cltbld', 03:45:16 INFO - 'LANG': 'en_US.UTF-8', 03:45:16 INFO - 'LANGUAGE': 'en_US:en', 03:45:16 INFO - 'LOGNAME': 'cltbld', 03:45:16 INFO - 'MAIL': '/var/mail/cltbld', 03:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:16 INFO - 'MOZ_NO_REMOTE': '1', 03:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:16 INFO - 'NO_EM_RESTART': '1', 03:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:16 INFO - 'PWD': '/builds/slave/test', 03:45:16 INFO - 'SHELL': '/bin/bash', 03:45:16 INFO - 'SHLVL': '1', 03:45:16 INFO - 'TERM': 'linux', 03:45:16 INFO - 'TMOUT': '86400', 03:45:16 INFO - 'USER': 'cltbld', 03:45:16 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', 03:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:16 INFO - '_': '/tools/buildbot/bin/python'} 03:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:45:16 INFO - Cleaning up... 03:45:16 INFO - Return code: 0 03:45:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:45:16 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')]} 03:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:16 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')]} 03:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:16 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 0x12a21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1611d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160eeb0>, '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 0x160fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610240>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', '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 03:45:16 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 03:45:16 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 03:45:16 INFO - Using env: {'DISPLAY': ':0', 03:45:16 INFO - 'HOME': '/home/cltbld', 03:45:16 INFO - 'LANG': 'en_US.UTF-8', 03:45:16 INFO - 'LANGUAGE': 'en_US:en', 03:45:16 INFO - 'LOGNAME': 'cltbld', 03:45:16 INFO - 'MAIL': '/var/mail/cltbld', 03:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:16 INFO - 'MOZ_NO_REMOTE': '1', 03:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:16 INFO - 'NO_EM_RESTART': '1', 03:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:16 INFO - 'PWD': '/builds/slave/test', 03:45:16 INFO - 'SHELL': '/bin/bash', 03:45:16 INFO - 'SHLVL': '1', 03:45:16 INFO - 'TERM': 'linux', 03:45:16 INFO - 'TMOUT': '86400', 03:45:16 INFO - 'USER': 'cltbld', 03:45:16 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', 03:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:16 INFO - '_': '/tools/buildbot/bin/python'} 03:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:17 INFO - Downloading/unpacking blobuploader==1.2.4 03:45:17 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 03:45:17 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 03:45:17 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 03:45:17 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 03:45:18 INFO - Downloading blobuploader-1.2.4.tar.gz 03:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:45:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:45:18 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 03:45:18 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 03:45:18 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 03:45:18 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 03:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:45:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:45:18 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 03:45:18 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 03:45:18 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 03:45:18 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 03:45:18 INFO - Downloading docopt-0.6.1.tar.gz 03:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:45:18 INFO - Installing collected packages: blobuploader, requests, docopt 03:45:18 INFO - Running setup.py install for blobuploader 03:45:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:45:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:45:18 INFO - Running setup.py install for requests 03:45:19 INFO - Running setup.py install for docopt 03:45:19 INFO - Successfully installed blobuploader requests docopt 03:45:19 INFO - Cleaning up... 03:45:19 INFO - Return code: 0 03:45:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:19 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')]} 03:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:19 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')]} 03:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:19 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 0x12a21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1611d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160eeb0>, '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 0x160fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610240>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', '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 03:45:19 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 03:45:19 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 03:45:19 INFO - Using env: {'DISPLAY': ':0', 03:45:19 INFO - 'HOME': '/home/cltbld', 03:45:19 INFO - 'LANG': 'en_US.UTF-8', 03:45:19 INFO - 'LANGUAGE': 'en_US:en', 03:45:19 INFO - 'LOGNAME': 'cltbld', 03:45:19 INFO - 'MAIL': '/var/mail/cltbld', 03:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:19 INFO - 'MOZ_NO_REMOTE': '1', 03:45:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:19 INFO - 'NO_EM_RESTART': '1', 03:45:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:19 INFO - 'PWD': '/builds/slave/test', 03:45:19 INFO - 'SHELL': '/bin/bash', 03:45:19 INFO - 'SHLVL': '1', 03:45:19 INFO - 'TERM': 'linux', 03:45:19 INFO - 'TMOUT': '86400', 03:45:19 INFO - 'USER': 'cltbld', 03:45:19 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', 03:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:19 INFO - '_': '/tools/buildbot/bin/python'} 03:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:45:19 INFO - Running setup.py (path:/tmp/pip-TDuZOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:45:19 INFO - Running setup.py (path:/tmp/pip-bUU3Px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:45:19 INFO - Running setup.py (path:/tmp/pip-As01ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:45:19 INFO - Running setup.py (path:/tmp/pip-JLCLrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:45:19 INFO - Running setup.py (path:/tmp/pip-hphzGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:45:20 INFO - Running setup.py (path:/tmp/pip-iMmtmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:45:20 INFO - Running setup.py (path:/tmp/pip-Q2KeNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:45:20 INFO - Running setup.py (path:/tmp/pip-SrTk36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:45:20 INFO - Running setup.py (path:/tmp/pip-KicwZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:45:20 INFO - Running setup.py (path:/tmp/pip-VORQpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:45:20 INFO - Running setup.py (path:/tmp/pip-QC06od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:45:20 INFO - Running setup.py (path:/tmp/pip-ZHjyJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:45:20 INFO - Running setup.py (path:/tmp/pip-RE2kM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:45:20 INFO - Running setup.py (path:/tmp/pip-ktOA1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:20 INFO - Running setup.py (path:/tmp/pip-l3O17k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:45:20 INFO - Running setup.py (path:/tmp/pip-Hrml93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:45:20 INFO - Running setup.py (path:/tmp/pip-U9zBo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:45:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:45:20 INFO - Running setup.py install for manifestparser 03:45:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:45:20 INFO - Running setup.py install for mozcrash 03:45:21 INFO - Running setup.py install for mozdebug 03:45:21 INFO - Running setup.py install for mozdevice 03:45:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:45:21 INFO - Running setup.py install for mozfile 03:45:21 INFO - Running setup.py install for mozhttpd 03:45:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:45:21 INFO - Running setup.py install for mozinfo 03:45:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:45:21 INFO - Running setup.py install for mozInstall 03:45:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:45:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:45:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:45:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:45:21 INFO - Running setup.py install for mozleak 03:45:21 INFO - Running setup.py install for mozlog 03:45:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:45:21 INFO - Running setup.py install for moznetwork 03:45:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:45:21 INFO - Running setup.py install for mozprocess 03:45:22 INFO - Running setup.py install for mozprofile 03:45:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:45:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:45:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:45:22 INFO - Running setup.py install for mozrunner 03:45:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:45:22 INFO - Running setup.py install for mozscreenshot 03:45:22 INFO - Running setup.py install for moztest 03:45:22 INFO - Running setup.py install for mozversion 03:45:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:45:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:45:22 INFO - Cleaning up... 03:45:22 INFO - Return code: 0 03:45:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:22 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')]} 03:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:22 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')]} 03:45:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:22 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 0x12a21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1611d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160eeb0>, '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 0x160fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610240>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', '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 03:45:22 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 03:45:22 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 03:45:22 INFO - Using env: {'DISPLAY': ':0', 03:45:22 INFO - 'HOME': '/home/cltbld', 03:45:22 INFO - 'LANG': 'en_US.UTF-8', 03:45:22 INFO - 'LANGUAGE': 'en_US:en', 03:45:22 INFO - 'LOGNAME': 'cltbld', 03:45:22 INFO - 'MAIL': '/var/mail/cltbld', 03:45:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:22 INFO - 'MOZ_NO_REMOTE': '1', 03:45:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:22 INFO - 'NO_EM_RESTART': '1', 03:45:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:22 INFO - 'PWD': '/builds/slave/test', 03:45:22 INFO - 'SHELL': '/bin/bash', 03:45:22 INFO - 'SHLVL': '1', 03:45:22 INFO - 'TERM': 'linux', 03:45:22 INFO - 'TMOUT': '86400', 03:45:22 INFO - 'USER': 'cltbld', 03:45:22 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', 03:45:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:22 INFO - '_': '/tools/buildbot/bin/python'} 03:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:45:22 INFO - Running setup.py (path:/tmp/pip-eWUUqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:45:22 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)) 03:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:45:22 INFO - Running setup.py (path:/tmp/pip-tyUfCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:45:23 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)) 03:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:45:23 INFO - Running setup.py (path:/tmp/pip-WyCzEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:45:23 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)) 03:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:45:23 INFO - Running setup.py (path:/tmp/pip-IcxVE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:45:23 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)) 03:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:45:23 INFO - Running setup.py (path:/tmp/pip-eiWYGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:45:23 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)) 03:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:45:23 INFO - Running setup.py (path:/tmp/pip-Gw_CF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:45:23 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)) 03:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:45:23 INFO - Running setup.py (path:/tmp/pip-5O9FIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:45:23 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)) 03:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:45:23 INFO - Running setup.py (path:/tmp/pip-PvL9f1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:45:23 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)) 03:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:45:23 INFO - Running setup.py (path:/tmp/pip-gSG51u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:45:23 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)) 03:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:45:23 INFO - Running setup.py (path:/tmp/pip-vWf8ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:45:23 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)) 03:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:45:23 INFO - Running setup.py (path:/tmp/pip-xJBQrN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:45:23 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)) 03:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:45:23 INFO - Running setup.py (path:/tmp/pip-_v_fy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:45:23 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)) 03:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:45:23 INFO - Running setup.py (path:/tmp/pip-3QLk5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:45:23 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)) 03:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:45:23 INFO - Running setup.py (path:/tmp/pip-HY8Iif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:45:23 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)) 03:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:23 INFO - Running setup.py (path:/tmp/pip-P_IfWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:23 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)) 03:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:45:23 INFO - Running setup.py (path:/tmp/pip-9xNxqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:45:24 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)) 03:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:45:24 INFO - Running setup.py (path:/tmp/pip-5g1Zvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:45:24 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)) 03:45:24 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)) 03:45:24 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)) 03:45:24 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)) 03:45:24 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)) 03:45:24 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)) 03:45:24 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)) 03:45:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:45:24 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 03:45:24 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 03:45:24 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 03:45:24 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 03:45:25 INFO - Downloading blessings-1.6.tar.gz 03:45:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:45:25 INFO - Installing collected packages: blessings 03:45:25 INFO - Running setup.py install for blessings 03:45:25 INFO - Successfully installed blessings 03:45:25 INFO - Cleaning up... 03:45:25 INFO - Return code: 0 03:45:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:45:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:45:25 INFO - Reading from file tmpfile_stdout 03:45:25 INFO - Current package versions: 03:45:25 INFO - argparse == 1.2.1 03:45:25 INFO - blessings == 1.6 03:45:25 INFO - blobuploader == 1.2.4 03:45:25 INFO - docopt == 0.6.1 03:45:25 INFO - functools32 == 3.2.3-2 03:45:25 INFO - jsonschema == 2.5.1 03:45:25 INFO - manifestparser == 1.1 03:45:25 INFO - mozInstall == 1.13 03:45:25 INFO - mozcrash == 1.0 03:45:25 INFO - mozdebug == 0.1 03:45:25 INFO - mozdevice == 0.51 03:45:25 INFO - mozfile == 1.2 03:45:25 INFO - mozhttpd == 0.7 03:45:25 INFO - mozinfo == 0.10 03:45:25 INFO - mozleak == 0.1 03:45:25 INFO - mozlog == 3.5 03:45:25 INFO - moznetwork == 0.27 03:45:25 INFO - mozprocess == 0.25 03:45:25 INFO - mozprofile == 0.28 03:45:25 INFO - mozrunner == 6.13 03:45:25 INFO - mozscreenshot == 0.1 03:45:25 INFO - mozsystemmonitor == 0.3 03:45:25 INFO - moztest == 0.8 03:45:25 INFO - mozversion == 1.4 03:45:25 INFO - psutil == 3.1.1 03:45:25 INFO - requests == 1.2.3 03:45:25 INFO - wsgiref == 0.1.2 03:45:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:25 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')]} 03:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:25 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')]} 03:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:25 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 0x12a21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1611d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160eeb0>, '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 0x160fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610240>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', '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 03:45:25 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 03:45:25 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 03:45:25 INFO - Using env: {'DISPLAY': ':0', 03:45:25 INFO - 'HOME': '/home/cltbld', 03:45:25 INFO - 'LANG': 'en_US.UTF-8', 03:45:25 INFO - 'LANGUAGE': 'en_US:en', 03:45:25 INFO - 'LOGNAME': 'cltbld', 03:45:25 INFO - 'MAIL': '/var/mail/cltbld', 03:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:25 INFO - 'MOZ_NO_REMOTE': '1', 03:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:25 INFO - 'NO_EM_RESTART': '1', 03:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:25 INFO - 'PWD': '/builds/slave/test', 03:45:25 INFO - 'SHELL': '/bin/bash', 03:45:25 INFO - 'SHLVL': '1', 03:45:25 INFO - 'TERM': 'linux', 03:45:25 INFO - 'TMOUT': '86400', 03:45:25 INFO - 'USER': 'cltbld', 03:45:25 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', 03:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:25 INFO - '_': '/tools/buildbot/bin/python'} 03:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:25 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)) 03:45:25 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)) 03:45:25 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)) 03:45:25 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)) 03:45:25 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)) 03:45:25 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)) 03:45:25 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)) 03:45:25 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)) 03:45:25 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)) 03:45:25 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:45:25 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 03:45:25 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 03:45:25 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 03:45:25 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 03:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:45:27 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)) 03:45:27 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)) 03:45:27 INFO - Installing collected packages: simplejson 03:45:27 INFO - Running setup.py install for simplejson 03:45:27 INFO - building 'simplejson._speedups' extension 03:45:27 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 03:45:28 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 03:45:28 INFO - Successfully installed simplejson 03:45:28 INFO - Cleaning up... 03:45:28 INFO - Return code: 0 03:45:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:45:28 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')]} 03:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:28 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')]} 03:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:28 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 0x12a21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1611d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x160eeb0>, '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 0x160fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610240>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', '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 03:45:28 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 03:45:28 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 03:45:28 INFO - Using env: {'DISPLAY': ':0', 03:45:28 INFO - 'HOME': '/home/cltbld', 03:45:28 INFO - 'LANG': 'en_US.UTF-8', 03:45:28 INFO - 'LANGUAGE': 'en_US:en', 03:45:28 INFO - 'LOGNAME': 'cltbld', 03:45:28 INFO - 'MAIL': '/var/mail/cltbld', 03:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:28 INFO - 'MOZ_NO_REMOTE': '1', 03:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:28 INFO - 'NO_EM_RESTART': '1', 03:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:28 INFO - 'PWD': '/builds/slave/test', 03:45:28 INFO - 'SHELL': '/bin/bash', 03:45:28 INFO - 'SHLVL': '1', 03:45:28 INFO - 'TERM': 'linux', 03:45:28 INFO - 'TMOUT': '86400', 03:45:28 INFO - 'USER': 'cltbld', 03:45:28 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', 03:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:28 INFO - '_': '/tools/buildbot/bin/python'} 03:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:45:28 INFO - Cleaning up... 03:45:28 INFO - Return code: 0 03:45:28 INFO - Running post-action listener: _resource_record_post_action 03:45:28 INFO - Running post-action listener: _start_resource_monitoring 03:45:28 INFO - Starting resource monitoring. 03:45:28 INFO - [mozharness: 2017-08-05 10:45:28.405923Z] Finished create-virtualenv step (success) 03:45:28 INFO - [mozharness: 2017-08-05 10:45:28.406863Z] Running install step. 03:45:28 INFO - Running pre-action listener: _resource_record_pre_action 03:45:28 INFO - Running main action method: install 03:45:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:45:28 INFO - Reading from file tmpfile_stdout 03:45:28 INFO - Detecting whether we're running mozinstall >=1.0... 03:45:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:45:28 INFO - Reading from file tmpfile_stdout 03:45:28 INFO - Output received: 03:45:28 INFO - Usage: mozinstall [options] installer 03:45:28 INFO - Options: 03:45:28 INFO - -h, --help show this help message and exit 03:45:28 INFO - -d DEST, --destination=DEST 03:45:28 INFO - Directory to install application into. [default: 03:45:28 INFO - "/builds/slave/test"] 03:45:28 INFO - --app=APP Application being installed. [default: firefox] 03:45:28 INFO - mkdir: /builds/slave/test/build/application 03:45:28 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'] 03:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:45:46 INFO - Reading from file tmpfile_stdout 03:45:46 INFO - Output received: 03:45:46 INFO - /builds/slave/test/build/application/firefox/firefox 03:45:46 INFO - Running post-action listener: _resource_record_post_action 03:45:46 INFO - [mozharness: 2017-08-05 10:45:46.685178Z] Finished install step (success) 03:45:46 INFO - [mozharness: 2017-08-05 10:45:46.685467Z] Running setup-mitmproxy step. 03:45:46 INFO - Running pre-action listener: _resource_record_pre_action 03:45:46 INFO - Running main action method: setup_mitmproxy 03:45:46 INFO - Skipping: mitmproxy is not required 03:45:46 INFO - Running post-action listener: _resource_record_post_action 03:45:46 INFO - [mozharness: 2017-08-05 10:45:46.686620Z] Finished setup-mitmproxy step (success) 03:45:46 INFO - [mozharness: 2017-08-05 10:45:46.686841Z] Running run-tests step. 03:45:46 INFO - Running pre-action listener: _resource_record_pre_action 03:45:46 INFO - Running pre-action listener: _set_gcov_prefix 03:45:46 INFO - Running main action method: run_tests 03:45:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:45:46 INFO - Python 2.7.3 03:45:46 INFO - Return code: 0 03:45:46 INFO - grabbing minidump binary from tooltool 03:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:46 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 0x160eeb0>, '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 0x160fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1610240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:45:46 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 03:45:46 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 03:45:46 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 03:45:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:45:46 INFO - Return code: 0 03:45:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:45:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:45:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:45:46 INFO - ENV: RUST_BACKTRACE is now 1 03:45:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:45:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:45:46 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/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 03:45:46 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/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 03:45:46 INFO - Using env: {'DISPLAY': ':0', 03:45:46 INFO - 'HOME': '/home/cltbld', 03:45:46 INFO - 'LANG': 'en_US.UTF-8', 03:45:46 INFO - 'LANGUAGE': 'en_US:en', 03:45:46 INFO - 'LOGNAME': 'cltbld', 03:45:46 INFO - 'MAIL': '/var/mail/cltbld', 03:45:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:45:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:46 INFO - 'MOZ_NO_REMOTE': '1', 03:45:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:45:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:46 INFO - 'NO_EM_RESTART': '1', 03:45:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:46 INFO - 'PWD': '/builds/slave/test', 03:45:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:45:46 INFO - 'RUST_BACKTRACE': '1', 03:45:46 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:45:46 INFO - 'SHELL': '/bin/bash', 03:45:46 INFO - 'SHLVL': '1', 03:45:46 INFO - 'STYLO_FORCE_ENABLED': '1', 03:45:46 INFO - 'TERM': 'linux', 03:45:46 INFO - 'TMOUT': '86400', 03:45:46 INFO - 'USER': 'cltbld', 03:45:46 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525', 03:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:46 INFO - '_': '/tools/buildbot/bin/python'} 03:45:46 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/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 03:45:47 INFO - mozversion application_buildid: 20170805095548 03:45:47 INFO - mozversion application_changeset: 933a04a91ce3bd44b230937083a835cb60637084 03:45:47 INFO - mozversion application_display_name: Nightly 03:45:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:45:47 INFO - mozversion application_name: Firefox 03:45:47 INFO - mozversion application_remotingname: firefox 03:45:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:45:47 INFO - mozversion application_vendor: Mozilla 03:45:47 INFO - mozversion application_version: 57.0a1 03:45:47 INFO - mozversion platform_buildid: 20170805095548 03:45:47 INFO - mozversion platform_changeset: 933a04a91ce3bd44b230937083a835cb60637084 03:45:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:45:47 INFO - mozversion platform_version: 57.0a1 03:45:47 INFO - using testdate: 1501929947 03:45:47 INFO - actual date: 1501929947 03:45:47 INFO - starting webserver on 'localhost:43636' 03:45:47 INFO - SUITE-START | Running 2 tests 03:45:47 INFO - TEST-START | dromaeo_css 03:45:47 INFO - Initialising browser for dromaeo_css test... 03:45:47 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43636/getInfo.html -profile /tmp/tmpioTV7z/profile 03:45:47 INFO - TEST-INFO | started process 3310 (/builds/slave/test/build/application/firefox/firefox http://localhost:43636/getInfo.html) 03:45:57 INFO - TEST-INFO | 3310: exit 0 03:45:57 INFO - Browser initialized. 03:45:57 INFO - Running cycle 1/1 for dromaeo_css test... 03:45:57 INFO - TEST-INFO | started process 3541 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpioTV7z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:58 INFO - PID 3541 | 03:45:58 INFO - PID 3541 | (/builds/slave/test/build/application/firefox/firefox:3597): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:45:58 INFO - PID 3541 | 03:46:08 INFO - PID 3541 | RSS: Main: 173977600 03:46:08 INFO - PID 3541 | 03:49:08 INFO - PID 3541 | Cycle 1(1): loaded http://localhost:43636/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43636/tests/dromaeo/cssquery-ext.html) 03:49:10 INFO - PID 3541 | RSS: Main: 174923776 03:49:10 INFO - PID 3541 | 03:52:11 INFO - PID 3541 | Cycle 1(1): loaded http://localhost:43636/tests/dromaeo/cssquery-ext.html (next: http://localhost:43636/tests/dromaeo/cssquery-jquery.html) 03:52:12 INFO - PID 3541 | RSS: Main: 171220992 03:52:12 INFO - PID 3541 | 03:55:14 INFO - PID 3541 | Cycle 1(1): loaded http://localhost:43636/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43636/tests/dromaeo/cssquery-mootools.html) 03:55:15 INFO - PID 3541 | RSS: Main: 173539328 03:55:15 INFO - PID 3541 | 03:58:16 INFO - PID 3541 | Cycle 1(1): loaded http://localhost:43636/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43636/tests/dromaeo/cssquery-prototype.html) 03:58:17 INFO - PID 3541 | RSS: Main: 171163648 03:58:17 INFO - PID 3541 | 04:01:21 INFO - PID 3541 | Cycle 1(1): loaded http://localhost:43636/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43636/tests/dromaeo/cssquery-yui.html) 04:01:22 INFO - PID 3541 | RSS: Main: 174813184 04:01:22 INFO - PID 3541 | 04:04:23 INFO - PID 3541 | Cycle 1(1): loaded http://localhost:43636/tests/dromaeo/cssquery-yui.html (next: http://localhost:43636/tests/dromaeo/cssquery-dojo.html) 04:04:24 INFO - PID 3541 | RSS: Main: 177618944 04:04:24 INFO - PID 3541 | 04:04:24 INFO - PID 3541 | __start_tp_report 04:04:24 INFO - PID 3541 | _x_x_mozilla_page_load 04:04:24 INFO - PID 3541 | _x_x_mozilla_page_load_details 04:04:24 INFO - PID 3541 | |i|pagename|runs| 04:04:24 INFO - PID 3541 | |0;dojo.html;3153.2747468082357;3178.3643271345736;3190.377876314119;3196.0411876437065;3220.9194770130744;6295.559310848243;6308.053791931213;6381.26615439224;6392;6439.323870993549;6166.075088736692;6257;6261.686915654211;6273.68631568422;6279.215098112736;5749.856253593652;5766.481016708506;5793.942060579382;5795.507381872525;5802.071668533035;5734.770609175628;5786.537077033849;5787.536997040248;5790.7683692652245;5799.043157878945;5728.398518155596;5732.910746958086;5768.625039372449;5774.97112514439;5784.71076446176;5776.133579962997;5793;5829.912551311733;5834.591578589521;5847.736851841677;5723.255976723;5731.340895796953;5749.425057494259;5837.153612726173;5855.76576936922;5997.8800423991715;6121.9592669245885;6137.693115344215;6171.166892469504;6257.812265632038;6754.189497260311;6757.966210168966;6798;6806.387425131762;6825.283345248727;6794.252632210453;6810.046593476917;6891.552049116842;6903.309669033107;6913.170419549636;6254.061890716429;6287.654179020198;6304.905426418607;6368.331325210879;6386.744530218785;6961.547499412522;6977.51157418986;6985.755498557526;6987.580745155307;7021.22766495685;6608.8347791305605;6691.866162676719;6699.062131301622;6699.39705426514;6699.899501507482;6705.161854768154;6720.899186512206;6733.831654208684;6810.523263371616;6815.114035175396;6593.076969224312;6632;6714.932850671431;6717.462602991749;6787.762428314985;6725.293844146392;6743.258241593421;6744.291849355845;6748.392644661906;6749.932500675029;5323.920141197885;5400.432954539795;5401.081816091195;5404.243405923174;5410.107332290128;4663.440387153563;4681.040386720714;4692.296155576691;4696.788644511005;4697.671163018625;5816.389279125716;5837.6497410155525;5902.852428689317;5904.996150654399;5906;6778.593284402951;6872.1066261386695;6892.414144797748;6897.275786042494;6912.896306555405;5768.480836724715;5839.445252700986;5853;5855.3266374367495;5937.376575459601;5894.322152952465;5895.4399332063385;5898.64608123514;5919.733611987471;5928;6507.284198738135;6526.902096468557;6543.640099794557;6582.308857569982;6583.934160658428;6665;6669.4664426844765;6764.3573860483175;6765.526413151032;6772.390484856386;6568.146141001639;6569.24453687832;6607.834804129743;6631.568948018364;6666.699998499982;6552.967235163794;6565.671716414065;6626.635535045426;6635.402813746786;6636.27001029896;6757.121574195323;6816.7614133505085;6834.9316506836285;6859.176898772179;6893.241743408322;6463.741450342121;6529.542931994714;6569.80290591283;6601.141851559267;6619.106420633153;6429.903551446826;6536.640484773383;6543.770968016097;6547.770828020996;6567.408933195844;6351.364863513611;6413.1021656969;6446.613203207822;6528.053432252392;6529.020646902813;6527.412532872065;6564.277929427854;6593.637349945607;6643.501737369813;6668.766593169215;6432.099506069248;6439.356064393523;6456.483481321577;6464.967675161783;6467.126937863328 04:04:24 INFO - PID 3541 | |1;ext.html;795.7334293011841;840.945338552994;870.0516437083579;879.3361012435614;1166.7608140331233;30575.694243057562;40662.79668601657;42137.15725685484;42164.36753448693;42222.57777422225;42322;42666.360004599956;42746.7862660687;42755.572444275545;42804.35793463101;7130.928690713078;7627.046619172604;7632.7787553991375;7633.427492938024;7633.732819351324;7507.624618769067;7671.923280767204;7675.654595543186;7677.11713152989;7680.654370553339;7663.042119735033;7681.270279323456;7707.730229441971;7709.229077092302;7711.768646940601;7631.12242092161;7635.809104772369;7650.234976502361;7651.617419129049;7654.617269136521;7652.311291983692;7678.692852285902;7686.154523002465;7699.846003079907;7712.228777122299;38281.234375312335;38663.61336386628;39215.41176882349;39343.803280983695;39451.21097578033;3577.409727394977;3579.928401431983;3600.891973240807;3610.1877077657578;3618.855245790165;31041;31280.061598152093;31342.21644458884;31609.367812643617;31717.524237136462;4841.830535931261;5024.698518088926;5028.1200789862;5061.367329083864;5088.185890257541;191144;194020;194289;194335.0283248589;194564;48256;48318;48530.27204591934;50658;50754.23868641973;53591.19613205805;53729.46270537245;53751.46248537464;53774.46225537773;53913.46086539084;16132.75800862988;16385.262663180187;16585;16647.3341066356;16673.6665266694;13565.457381704819;13580.117292375964;13672.589822305346;13675.589732308046;13692.31538423075;14101.365438555289;14204.360803763855;14233.85766142346;14324.713505729827;14344.211068391338;5700.857478563069;5713;5780.71096445176;5815.098659707752;5862;1002.8545860850136;1023.2990401574945;1038.345842119475;1040.287403128859;1049.1158940561686;23174.53650926972;23901.402464938168;23933;24470.14354497584;29366.853165734035;1079.611339917629;1087.4127970895786;1100.0649447969163;1103.1836441033577;1118.6061827688752;12521;12646.30445325516;15946.28241729125;15966;16676.332946681996;240804;243626;244145;244771;245195;58064;58275.70862145662;58344;58561.4143858556;58949.70525147347;1420.879225265864;1454.0575460915245;1488.784126301702;1491.0308299605342;1492.276246020679;28087.595620219316;28198.577021345107;28215.71784282213;28722;28936.855315723285;38076.23847522979;38285;38353.616463835;38413.423798642485;51478.48521514887;213442;216188;216433;217170;217474;35973;36103.63896361003;36151.45772813463;36396.27207455889;36460;43396.34905476483;43857.122857543305;44783;44967.100657986004;45234.77382613066;33560.66439335576;35730;36499.81750091232;36571;36790.8160459196;36273.455898161024;36276.27447450983;36427.45358819673;36586.268274633825;36729.816350918074;37635.62364376321;38404.42393364046;38871.2225755489;38891.80554097211;39417;34027;34621.307573848884;34700.30599388049;35508.82245588755;35513.46729799107;23683;25100.62349064802;25273.368165796;26102.34744131412;26302.21093367202 04:04:24 INFO - PID 3541 | |2;jquery.html;568.8634727665361;572.1532132443983;579.7420148034121;580.3905898806254;587.1222522329118;21524.354269371906;22304;22349;22411.887940560297;22520.324390268277;26297.211083667473;26719.86640066802;26806.06178783738;26810;26830.463390732173;6557.3442655734525;6744.055832183498;6751.628660423675;6754;6756.628385438799;5916.822495325147;6208.534359923001;6461.418472337488;6579.144711187563;6666.466682665375;6426.196725409324;6467.482601391901;6467.611943283395;6467.870642587145;6471.773487927923;6432;6433.099366088752;6433.517486188554;6438.742450301982;6439.774607888725;6002.099685047234;6021.096835474714;6027.517798576104;6032.245969253843;6035.064564992434;28884.27789305284;29978.70021299803;29988.55017174744;30139.547906781416;30610.84694576513;1922.663533881579;1965.027311480812;1971.940841774749;1972.1716878910893;1972.7731310899287;19248.422547323604;19815.900920495304;19925.10337034837;20033.699494507593;20039.398818035483;2306.4349234437504;2381.3332266965276;2425.34515680767;2427.708674959016;2454.2882564056404;143381;147348;147763;149133;153241;14191.219482928538;14789.778153327708;15289;15309.15799631031;15766.290516926765;22701.708252303324;23512.764872351057;23636.17273395423;23804.88097559501;24097.156599518934;10481.318714283547;10496.317739346918;10533.57865685364;10625.628103016357;10759.462026898624;9711.757206069904;9815.852762208573;9898.208143348515;9939.50302484873;9950.35322704022;9169.128932751379;9173.81652366949;9483.810323793485;9561.330706850593;9618.615255389846;2640.2871224769206;2706.6887307959837;2779.5691667791525;2780.569011803174;2867.354845159822;972.9756756081155;986.8421052631544;989.2531138990016;999.3004896572428;1000.7698229407277;19147.521311967314;19679.60640787176;20027.198912043645;20496.38510844677;20607.690884636744;1035.5495359518634;1041.5937784264142;1045.8431235314763;1047.9423631700329;1050.4380156616173;11003.119750419946;11051.447427628586;11199.888001119885;11212.495437705324;11282.041026512674;476054;510136;511490;513206;516049;118043;118395.40802295934;119565.40217299032;121008;121699.39150304369;1213.5226744932859;1223.1621339382552;1232.8952039076778;1244.0420875925668;1248.8126780982925;17308.82691173072;17566.38517651876;17649.38227162043;17987.910060449613;18018.72971905396;55253.44746552483;55708.05021824217;55753;56162;56898;72085.6395718018;72139.63930180525;72502;72566.63716681383;72921.27078729145;14437.205953672648;14478.710425791636;14641.63395915068;14682.55952321432;14818.40726370933;22913.88543057274;22987.770122299233;22995;23069.65395519102;23130.537389251785;18023.639527209645;18154.72767908456;18172.45482635523;18421.815781842546;18462.907685461487;15743.842561574696;16801.579960500596;17118;17173.540249078967;17292.04893730857;17980.55048623795;18575.349862754738;18610.162542685342;18714.532136696693;18776.906115469334;14408.13551186932;14504.347304371118;14553.927230364205;14556;14561.708765824413;17087.145642718064;17261;17278.65442691114;17633.294668213126;18117 04:04:24 INFO - PID 3541 | |3;mootools.html;1354.383755391297;1406.0930699698695;1434.583970648512;1434.6198257461767;1440.971180576389;13692.315384230786;14229.075110117836;14251.50119745809;14288.499902503414;14331.211783351911;14578.854211457883;14827.110373377605;14833.925830370834;14834.035787673794;14835.703285934274;2637.3011152044724;2677.223605154503;2677.4377380750066;2679.9464010719776;2683.047518131055;2412.3124909400826;2552.52778236026;2565.8203925725206;2572.601246806748;2572.832765870222;2762.8618569071464;2764.1431156341496;2796.1751283371354;2796.3149028487946;2797.9720202798017;2591.0413147135587;2619.9607005894927;2664.933376665589;2669.0658269605483;2749.408877091425;2597.6623039005;2613.098481024044;2626.566616508274;2630.8421494710187;2637.3406648337914;13862.237576933265;14127.929360353133;14131.293435328193;14155.363008664532;14178.220197889112;7622.885656715153;7867.921320786776;7877.094134174586;7880.211978802074;7881.8029549261155;4993.600511959071;5065.214891691794;5128.179491281415;5251.737413129366;5301.098813201765;1625.6667383186418;1632.4659404618353;1646.5389690886452;1699.0400423760536;1701.7277235642239;23352.649710254358;23557.411064723346;23835.284941451784;23843.165489207793;23875.16436924699;6517.674116294166;6535.0850880876715;6607.603543787388;6641.86716265672;6666.266710661824;16090.919545402197;16157.272922718506;16164;16198.947068440513;16219.27013284405;7618.047744031996;7773.222677732181;7776.105747839071;7783.066032076187;7789.221077892165;6294;6969.860602788017;7035.753748618774;7128.607926564089;7268.527545709512;4809.9038019240115;4964.702117872867;5035.093683136997;5244.160934250502;5253.605979551549;1564.3742502998891;1565.1000674612144;1575.1100628145061;1595.369828917571;1597.3770229610461;859.1966511311944;888.9822203556022;917.554985831871;920.30516959695;927.2674587076134;7749.302562769378;7790.961045194737;7867.527948323119;7905.130435652074;7993.640286187136;971.3686104032295;983.8032393521181;1018.098982400566;1022.4734261855151;1043.0768769638923;5058;5233.947660523346;5336.839894803162;5349.919751203735;5408.756605952742;19151.616967660568;20006.49983750389;20057.598848022957;20064.59870802576;20074;19093.2362705493;19480.02599870029;19678.90160549188;19682;19761;10295.279330446796;10600;10717.142628589694;10760.677179684622;10777.730556735987;8064.475809072392;8224.958875205586;8416.452930559493;8508.106648801786;8543;17033.48899533016;17207.31170753206;17467;17793.466196014142;17864;17663.20515576828;18042;18151.001694906907;18427.631447371245;18708.812911870707;11459.828102578302;11628;11648.76702465929;11685.357305347947;11710.063194944554;11937.343446110548;12248.632541023784;13068.934655326662;13126.278054706701;13217.801732973821;10921.83617245726;11032.558697652325;11060;11179.105671546095;11338.886611133783;10726.892731072901;10863.293885897392;10863.728406789578;11033.337999720043;11120.499577518869;9396.483193424154;9466.2427005838;9479.336446448682;9571.952140239255;9583.520823958914;6940.236573976757;7043.084399028094;7053.153621565445;7086.362227399559;7234.457415693949;6918.654067296515;6919.411849992807;6974.79075627732;7079.1505019395945;7098.29017098286 04:04:24 INFO - PID 3541 | |4;prototype.html;509.4039973231319;510.08949025988574;528.8704267454474;530.1623434972742;531.8271561742433;6259.280182778982;6271.1533942917695;6305.274893387262;6332.7466901324005;6369.936300636992;6215.720292586833;6226.097215903691;6235.844103897405;6253.24961004679;6253.68672578759;5172.353455818032;5179.404368497614;5183.507566781169;5195.896082078356;5196.480351964811;4822.987172693738;4956.950430495703;5014.799408023675;5123.337762636002;5152.458991805863;4960.33035540201;4961.652684312099;4982.551570358667;4982.5764809991015;4995.600351971833;4959.8016079356785;4968.403791545002;4987.850364489035;4996.525330093636;5025.447200807908;4505.752183629899;4509.098180363941;4514.954850451519;4538.72767633943;4544.454665440136;6083.726232319556;6137.232845894263;6147.139400483936;6173.135760993465;6191.628502289877;5701.14482827575;5703;5771.653700777967;5775.682337471438;5789.131630255453;6502.187226596676;6513.316101809289;6528.800887565107;6550.508711846631;6577.539572229945;4876.683015603974;4877.975625118729;4887.780049897763;4911.165101932645;4916.852494425173;6566.93433065668;6671.799846004627;6773.525853190328;6892.276310987324;6974.51178417511;4887.340209071801;4943.555080042814;4949.628777841676;4960.280759289883;4961.8511444656715;4981.676191047571;4995.675281106716;5005.874853128628;5033.370828646419;5036.496350365008;5552.139418390156;5564.8330550083565;5618.747156377973;5628.296462942132;5663.1505274208375;6518.152640156844;6531;6588.538802283794;6611.20665520131;6635.867282654416;1779.359430605007;1791.9104044797707;1804.7096326126882;1806.1962426719983;1810.5383127302716;1189.881011898803;1218.7196944702591;1235.8208059831454;1256.7926292161692;1261.5458434963407;5732.254806875079;5805.448482394166;5821.924652743097;5830.7959221427045;5832;6762.3432259096835;6772.322767723188;6819.420349270268;6840.657967101724;6851.862962740717;5597;5721.799737009184;5728.914066289009;5748.838139023604;5813.883722325614;3570.8214589270433;3585.551806024247;3587.695045921126;3591.94612080819;3624.347617428888;6429.45349645276;6478.708458119396;6520.608763474112;6527;6553.2136143663065;6882.483813713991;6930.653467326714;6983.720651173896;6995.440364770908;7000.824979375557;5996.141196229183;6453.677316134174;6562.146920900253;6600.372964568358;6606.042123892009;6634.137562116894;6714.160729908762;6756.831079222862;6763.729450821912;6763.966180169067;6522.249941256816;6629.502787290876;6668.499862510234;6684.598924064571;6707.4969377297875;6532.8366790830605;6569.638669873203;6571.704273307617;6572.441342485942;6583.44040756541;5065.13892638245;5068.391792984866;5069.721165335942;5076.6446348755235;5080.898382032413;6597.472202223907;6638.269790322964;6676.9666151668935;6706.463482921452;6754.459643228628;6305.337939516285;6469.7412103515335;6490.350964903472;6521.413072823469;6571.342865713582;6483.157189565326;6517.674116294261;6542.378474044958;6566.540342176002;6576.572522786004;6373.506677792238;6379.585326953733;6421.935780642134;6441.710123044568;6448.097266382804;6536.575122617015;6578.342165783383;6585.901211481927;6605.471562275103;6613.603183808987;6357.4596159326975;6360.204974378203;6371.39471750183;6380.776672816615;6401.135846660827 04:04:24 INFO - PID 3541 | |5;yui.html;918.641729725407;928.0765638189998;945.7493764152497;949.7957939043105;951.3150531617235;18890.52773680657;19834;19946.501337466554;19972.101255443504;22200.555988880213;21859.453513662167;22262.332130036124;22273.888630556867;22390;22439.551208975812;1024.9897501025007;1065.7602039541118;1066.5094056733913;1066.632011955874;1066.8293073108305;947.1097168661471;1062.9893701063006;1067.3169171730099;1074.7528068544239;1075.070064394297;1040.2354269611828;1096.7313008312935;1097.8298363753631;1099.0218705352243;1099.1701265544502;1099.3019432660278;1101.3171833463264;1106.181425744951;1106.2919731371849;1106.634810512529;805.6656487557715;806.3468590441703;809.178683636104;809.9473534220257;812.7521106062649;19456.805431945642;19667.31164409253;19858.50353741168;19883.30408435698;19978.600427991358;21629.891850540804;22345.888270558542;22382.776172238395;22815;22836.429089272737;16619.41832035885;16709.248083836257;16723.163841807982;16727.749083763752;17219.913900430543;3675.44868269759;3677.5586929568353;3694.963050369489;3697;3697.574778900434;131162;132211.33894330467;132398;132856;135649.3217533916;16910.492685219462;17608.73586896172;17659.38192163268;17763;17767.378141764977;31778.205544861103;31899;32059.839700801815;32744.508832367534;32765.67234327674;7638.236176382317;7682.116556595951;7991.56046417441;8122.55325957078;8741.781455463664;4145.481814773153;4263.76549289792;4266.445362102907;4272.038791271939;4288.592583704543;5206.739663016834;5292;5352.759125839347;5354.732263386815;5399.4600539945695;1060.3584831177182;1060.3584831177182;1080.7406222506543;1082.1883587309517;1083.7615724540588;544.4065968094795;576.8096528145702;587.2277954489832;595.0776296740036;598.0610441606635;11715.472803723853;11880;12108.03135749138;12121.69695757613;12846.293453860128;547.1273319056099;572.2303501790086;599.4245524296637;599.6941559804444;606.6390497653977;5473.0969390050195;5495.422980587061;5496.5053145217125;5720.998825205573;5752.309722833287;103355;108098.45950770353;108638.45680771704;110190.44904775424;111239;93259;95334.5233273843;95941;96911.51544242234;97054;79314.20685793068;80455.17268963881;81665.59167204126;84390.57804710937;86177.13822861816;10734.946325268324;10767.407792571485;10811.243212975016;10856.728581785519;11119.83320250213;38474;38543.614563854004;38579.80710096432;38709.6129038706;39020.41469377905;48678.513214867395;48921.2661810066;49182.75408622934;49377.25934111063;49577.25634115419;16228.350865965702;16547.172641367644;16674.916625416794;16758.58103547421;16784.32862685479;18038.90980545089;18499.630007400046;18578.535536611693;18602.534936626693;18780.436586902415;16684.332626695283;16724.414645487348;16866.494005179375;16924.153792310088;17080.060596667303;15455.381784728484;15464.768028479357;15473.458428954933;15501.767473487682;15602.063876167465;16268.51194464168;16496.25766840519;16533.173341333128;16608;16744.33022679128;11592.884071159518;11646.475908584303;11657.417129143678;11956.820647690465;12102.939485302517;12345.259284442962;12451.315177665316;12638.2417054977;12677.87322126767;12966.935165324114 04:04:24 INFO - PID 3541 | __end_tp_report 04:04:24 INFO - PID 3541 | __start_cc_report 04:04:24 INFO - PID 3541 | _x_x_mozilla_cycle_collect,363 04:04:24 INFO - PID 3541 | __end_cc_report 04:04:24 INFO - PID 3541 | __startTimestamp1501931064061__endTimestamp 04:04:24 INFO - PID 3541 | 04:04:24 INFO - PID 3541 | ------- Summary: start ------- 04:04:24 INFO - PID 3541 | Number of tests: 6 04:04:24 INFO - PID 3541 | 04:04:24 INFO - PID 3541 | [#0] dojo.html Cycles:165 Average:6216.99 Median:6463.74 stddev:738.44 (11.4%) stddev-sans-first:700.50 04:04:24 INFO - PID 3541 | Values: 3153.3 3178.4 3190.4 3196.0 3220.9 6295.6 6308.1 6381.3 6392.0 6439.3 6166.1 6257.0 6261.7 6273.7 6279.2 5749.9 5766.5 5793.9 5795.5 5802.1 5734.8 5786.5 5787.5 5790.8 5799.0 5728.4 5732.9 5768.6 5775.0 5784.7 5776.1 5793.0 5829.9 5834.6 5847.7 5723.3 5731.3 5749.4 5837.2 5855.8 5997.9 6122.0 6137.7 6171.2 6257.8 6754.2 6758.0 6798.0 6806.4 6825.3 6794.3 6810.0 6891.6 6903.3 6913.2 6254.1 6287.7 6304.9 6368.3 6386.7 6961.5 6977.5 6985.8 6987.6 7021.2 6608.8 6691.9 6699.1 6699.4 6699.9 6705.2 6720.9 6733.8 6810.5 6815.1 6593.1 6632.0 6714.9 6717.5 6787.8 6725.3 6743.3 6744.3 6748.4 6749.9 5323.9 5400.4 5401.1 5404.2 5410.1 4663.4 4681.0 4692.3 4696.8 4697.7 5816.4 5837.6 5902.9 5905.0 5906.0 6778.6 6872.1 6892.4 6897.3 6912.9 5768.5 5839.4 5853.0 5855.3 5937.4 5894.3 5895.4 5898.6 5919.7 5928.0 6507.3 6526.9 6543.6 6582.3 6583.9 6665.0 6669.5 6764.4 6765.5 6772.4 6568.1 6569.2 6607.8 6631.6 6666.7 6553.0 6565.7 6626.6 6635.4 6636.3 6757.1 6816.8 6834.9 6859.2 6893.2 6463.7 6529.5 6569.8 6601.1 6619.1 6429.9 6536.6 6543.8 6547.8 6567.4 6351.4 6413.1 6446.6 6528.1 6529.0 6527.4 6564.3 6593.6 6643.5 6668.8 6432.1 6439.4 6456.5 6465.0 6467.1 04:04:24 INFO - PID 3541 | 04:04:24 INFO - PID 3541 | [#1] ext.html Cycles:180 Average:39719.59 Median:36443.73 stddev:56706.64 (155.6%) stddev-sans-first:56790.40 04:04:24 INFO - PID 3541 | Values: 795.7 840.9 870.1 879.3 1166.8 30575.7 40662.8 42137.2 42164.4 42222.6 42322.0 42666.4 42746.8 42755.6 42804.4 7130.9 7627.0 7632.8 7633.4 7633.7 7507.6 7671.9 7675.7 7677.1 7680.7 7663.0 7681.3 7707.7 7709.2 7711.8 7631.1 7635.8 7650.2 7651.6 7654.6 7652.3 7678.7 7686.2 7699.8 7712.2 38281.2 38663.6 39215.4 39343.8 39451.2 3577.4 3579.9 3600.9 3610.2 3618.9 31041.0 31280.1 31342.2 31609.4 31717.5 4841.8 5024.7 5028.1 5061.4 5088.2 191144.0 194020.0 194289.0 194335.0 194564.0 48256.0 48318.0 48530.3 50658.0 50754.2 53591.2 53729.5 53751.5 53774.5 53913.5 16132.8 16385.3 16585.0 16647.3 16673.7 13565.5 13580.1 13672.6 13675.6 13692.3 14101.4 14204.4 14233.9 14324.7 14344.2 5700.9 5713.0 5780.7 5815.1 5862.0 1002.9 1023.3 1038.3 1040.3 1049.1 23174.5 23901.4 23933.0 24470.1 29366.9 1079.6 1087.4 1100.1 1103.2 1118.6 12521.0 12646.3 15946.3 15966.0 16676.3 240804.0 243626.0 244145.0 244771.0 245195.0 58064.0 58275.7 58344.0 58561.4 58949.7 1420.9 1454.1 1488.8 1491.0 1492.3 28087.6 28198.6 28215.7 28722.0 28936.9 38076.2 38285.0 38353.6 38413.4 51478.5 213442.0 216188.0 216433.0 217170.0 217474.0 35973.0 36103.6 36151.5 36396.3 36460.0 43396.3 43857.1 44783.0 44967.1 45234.8 33560.7 35730.0 36499.8 36571.0 36790.8 36273.5 36276.3 36427.5 36586.3 36729.8 37635.6 38404.4 38871.2 38891.8 39417.0 34027.0 34621.3 34700.3 35508.8 35513.5 23683.0 25100.6 25273.4 26102.3 26302.2 04:04:24 INFO - PID 3541 | 04:04:24 INFO - PID 3541 | [#2] jquery.html Cycles:180 Average:35662.34 Median:22611.02 stddev:85448.75 (377.9%) stddev-sans-first:85647.83 04:04:24 INFO - PID 3541 | Values: 568.9 572.2 579.7 580.4 587.1 21524.4 22304.0 22349.0 22411.9 22520.3 26297.2 26719.9 26806.1 26810.0 26830.5 6557.3 6744.1 6751.6 6754.0 6756.6 5916.8 6208.5 6461.4 6579.1 6666.5 6426.2 6467.5 6467.6 6467.9 6471.8 6432.0 6433.1 6433.5 6438.7 6439.8 6002.1 6021.1 6027.5 6032.2 6035.1 28884.3 29978.7 29988.6 30139.5 30610.8 1922.7 1965.0 1971.9 1972.2 1972.8 19248.4 19815.9 19925.1 20033.7 20039.4 2306.4 2381.3 2425.3 2427.7 2454.3 143381.0 147348.0 147763.0 149133.0 153241.0 14191.2 14789.8 15289.0 15309.2 15766.3 22701.7 23512.8 23636.2 23804.9 24097.2 10481.3 10496.3 10533.6 10625.6 10759.5 9711.8 9815.9 9898.2 9939.5 9950.4 9169.1 9173.8 9483.8 9561.3 9618.6 2640.3 2706.7 2779.6 2780.6 2867.4 973.0 986.8 989.3 999.3 1000.8 19147.5 19679.6 20027.2 20496.4 20607.7 1035.5 1041.6 1045.8 1047.9 1050.4 11003.1 11051.4 11199.9 11212.5 11282.0 476054.0 510136.0 511490.0 513206.0 516049.0 118043.0 118395.4 119565.4 121008.0 121699.4 1213.5 1223.2 1232.9 1244.0 1248.8 17308.8 17566.4 17649.4 17987.9 18018.7 55253.4 55708.1 55753.0 56162.0 56898.0 72085.6 72139.6 72502.0 72566.6 72921.3 14437.2 14478.7 14641.6 14682.6 14818.4 22913.9 22987.8 22995.0 23069.7 23130.5 18023.6 18154.7 18172.5 18421.8 18462.9 15743.8 16801.6 17118.0 17173.5 17292.0 17980.6 18575.3 18610.2 18714.5 18776.9 14408.1 14504.3 14553.9 14556.0 14561.7 17087.1 17261.0 17278.7 17633.3 18117.0 04:04:24 INFO - PID 3541 | 04:04:24 INFO - PID 3541 | [#3] mootools.html Cycles:180 Average:8866.29 Median:2569.21 stddev:6106.74 (237.7%) stddev-sans-first:6097.79 04:04:24 INFO - PID 3541 | Values: 1354.4 1406.1 1434.6 1434.6 1441.0 13692.3 14229.1 14251.5 14288.5 14331.2 14578.9 14827.1 14833.9 14834.0 14835.7 2637.3 2677.2 2677.4 2679.9 2683.0 2412.3 2552.5 2565.8 2572.6 2572.8 2762.9 2764.1 2796.2 2796.3 2798.0 2591.0 2620.0 2664.9 2669.1 2749.4 2597.7 2613.1 2626.6 2630.8 2637.3 13862.2 14127.9 14131.3 14155.4 14178.2 7622.9 7867.9 7877.1 7880.2 7881.8 4993.6 5065.2 5128.2 5251.7 5301.1 1625.7 1632.5 1646.5 1699.0 1701.7 23352.6 23557.4 23835.3 23843.2 23875.2 6517.7 6535.1 6607.6 6641.9 6666.3 16090.9 16157.3 16164.0 16198.9 16219.3 7618.0 7773.2 7776.1 7783.1 7789.2 6294.0 6969.9 7035.8 7128.6 7268.5 4809.9 4964.7 5035.1 5244.2 5253.6 1564.4 1565.1 1575.1 1595.4 1597.4 859.2 889.0 917.6 920.3 927.3 7749.3 7791.0 7867.5 7905.1 7993.6 971.4 983.8 1018.1 1022.5 1043.1 5058.0 5233.9 5336.8 5349.9 5408.8 19151.6 20006.5 20057.6 20064.6 20074.0 19093.2 19480.0 19678.9 19682.0 19761.0 10295.3 10600.0 10717.1 10760.7 10777.7 8064.5 8225.0 8416.5 8508.1 8543.0 17033.5 17207.3 17467.0 17793.5 17864.0 17663.2 18042.0 18151.0 18427.6 18708.8 11459.8 11628.0 11648.8 11685.4 11710.1 11937.3 12248.6 13068.9 13126.3 13217.8 10921.8 11032.6 11060.0 11179.1 11338.9 10726.9 10863.3 10863.7 11033.3 11120.5 9396.5 9466.2 9479.3 9572.0 9583.5 6940.2 7043.1 7053.2 7086.4 7234.5 6918.7 6919.4 6974.8 7079.2 7098.3 04:04:24 INFO - PID 3541 | 04:04:24 INFO - PID 3541 | [#4] prototype.html Cycles:180 Average:5525.30 Median:6203.67 stddev:1540.09 (24.8%) stddev-sans-first:1497.69 04:04:24 INFO - PID 3541 | Values: 509.4 510.1 528.9 530.2 531.8 6259.3 6271.2 6305.3 6332.7 6369.9 6215.7 6226.1 6235.8 6253.2 6253.7 5172.4 5179.4 5183.5 5195.9 5196.5 4823.0 4957.0 5014.8 5123.3 5152.5 4960.3 4961.7 4982.6 4982.6 4995.6 4959.8 4968.4 4987.9 4996.5 5025.4 4505.8 4509.1 4515.0 4538.7 4544.5 6083.7 6137.2 6147.1 6173.1 6191.6 5701.1 5703.0 5771.7 5775.7 5789.1 6502.2 6513.3 6528.8 6550.5 6577.5 4876.7 4878.0 4887.8 4911.2 4916.9 6566.9 6671.8 6773.5 6892.3 6974.5 4887.3 4943.6 4949.6 4960.3 4961.9 4981.7 4995.7 5005.9 5033.4 5036.5 5552.1 5564.8 5618.7 5628.3 5663.2 6518.2 6531.0 6588.5 6611.2 6635.9 1779.4 1791.9 1804.7 1806.2 1810.5 1189.9 1218.7 1235.8 1256.8 1261.5 5732.3 5805.4 5821.9 5830.8 5832.0 6762.3 6772.3 6819.4 6840.7 6851.9 5597.0 5721.8 5728.9 5748.8 5813.9 3570.8 3585.6 3587.7 3591.9 3624.3 6429.5 6478.7 6520.6 6527.0 6553.2 6882.5 6930.7 6983.7 6995.4 7000.8 5996.1 6453.7 6562.1 6600.4 6606.0 6634.1 6714.2 6756.8 6763.7 6764.0 6522.2 6629.5 6668.5 6684.6 6707.5 6532.8 6569.6 6571.7 6572.4 6583.4 5065.1 5068.4 5069.7 5076.6 5080.9 6597.5 6638.3 6677.0 6706.5 6754.5 6305.3 6469.7 6490.4 6521.4 6571.3 6483.2 6517.7 6542.4 6566.5 6576.6 6373.5 6379.6 6421.9 6441.7 6448.1 6536.6 6578.3 6585.9 6605.5 6613.6 6357.5 6360.2 6371.4 6380.8 6401.1 04:04:24 INFO - PID 3541 | 04:04:24 INFO - PID 3541 | [#5] yui.html Cycles:180 Average:22910.91 Median:19562.06 stddev:31679.94 (161.9%) stddev-sans-first:31725.77 04:04:24 INFO - PID 3541 | Values: 918.6 928.1 945.7 949.8 951.3 18890.5 19834.0 19946.5 19972.1 22200.6 21859.5 22262.3 22273.9 22390.0 22439.6 1025.0 1065.8 1066.5 1066.6 1066.8 947.1 1063.0 1067.3 1074.8 1075.1 1040.2 1096.7 1097.8 1099.0 1099.2 1099.3 1101.3 1106.2 1106.3 1106.6 805.7 806.3 809.2 809.9 812.8 19456.8 19667.3 19858.5 19883.3 19978.6 21629.9 22345.9 22382.8 22815.0 22836.4 16619.4 16709.2 16723.2 16727.7 17219.9 3675.4 3677.6 3695.0 3697.0 3697.6 131162.0 132211.3 132398.0 132856.0 135649.3 16910.5 17608.7 17659.4 17763.0 17767.4 31778.2 31899.0 32059.8 32744.5 32765.7 7638.2 7682.1 7991.6 8122.6 8741.8 4145.5 4263.8 4266.4 4272.0 4288.6 5206.7 5292.0 5352.8 5354.7 5399.5 1060.4 1060.4 1080.7 1082.2 1083.8 544.4 576.8 587.2 595.1 598.1 11715.5 11880.0 12108.0 12121.7 12846.3 547.1 572.2 599.4 599.7 606.6 5473.1 5495.4 5496.5 5721.0 5752.3 103355.0 108098.5 108638.5 110190.4 111239.0 93259.0 95334.5 95941.0 96911.5 97054.0 79314.2 80455.2 81665.6 84390.6 86177.1 10734.9 10767.4 10811.2 10856.7 11119.8 38474.0 38543.6 38579.8 38709.6 39020.4 48678.5 48921.3 49182.8 49377.3 49577.3 16228.4 16547.2 16674.9 16758.6 16784.3 18038.9 18499.6 18578.5 18602.5 18780.4 16684.3 16724.4 16866.5 16924.2 17080.1 15455.4 15464.8 15473.5 15501.8 15602.1 16268.5 16496.3 16533.2 16608.0 16744.3 11592.9 11646.5 11657.4 11956.8 12102.9 12345.3 12451.3 12638.2 12677.9 12966.9 04:04:24 INFO - PID 3541 | -------- Summary: end -------- 04:04:24 INFO - PID 3541 | 04:04:24 INFO - TEST-INFO | 3541: exit 0 04:04:24 INFO - TEST-OK | dromaeo_css | took 1117584ms 04:04:24 INFO - TEST-START | kraken 04:04:24 INFO - Initialising browser for kraken test... 04:04:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43636/getInfo.html -profile /tmp/tmpG2naUA/profile 04:04:24 INFO - TEST-INFO | started process 3949 (/builds/slave/test/build/application/firefox/firefox http://localhost:43636/getInfo.html) 04:04:30 INFO - TEST-INFO | 3949: exit 0 04:04:30 INFO - Browser initialized. 04:04:30 INFO - Running cycle 1/1 for kraken test... 04:04:30 INFO - TEST-INFO | started process 4170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpG2naUA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:04:31 INFO - PID 4170 | 04:04:31 INFO - PID 4170 | (/builds/slave/test/build/application/firefox/firefox:4224): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:04:31 INFO - PID 4170 | 04:04:41 INFO - PID 4170 | RSS: Main: 173207552 04:04:41 INFO - PID 4170 | 04:04:44 INFO - PID 4170 | Cycle 1(1): loaded http://localhost:43636/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43636/tests/kraken/driver.html?testName=audio-beat-detection) 04:04:45 INFO - PID 4170 | RSS: Main: 178515968 04:04:45 INFO - PID 4170 | 04:04:48 INFO - PID 4170 | Cycle 1(1): loaded http://localhost:43636/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43636/tests/kraken/driver.html?testName=audio-dft) 04:04:49 INFO - PID 4170 | RSS: Main: 178790400 04:04:49 INFO - PID 4170 | 04:04:52 INFO - PID 4170 | Cycle 1(1): loaded http://localhost:43636/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43636/tests/kraken/driver.html?testName=audio-fft) 04:04:52 INFO - PID 4170 | RSS: Main: 173957120 04:04:52 INFO - PID 4170 | 04:04:54 INFO - PID 4170 | Cycle 1(1): loaded http://localhost:43636/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43636/tests/kraken/driver.html?testName=audio-oscillator) 04:04:55 INFO - PID 4170 | RSS: Main: 174460928 04:04:55 INFO - PID 4170 | 04:04:57 INFO - PID 4170 | Cycle 1(1): loaded http://localhost:43636/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43636/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:04:58 INFO - PID 4170 | RSS: Main: 174702592 04:04:58 INFO - PID 4170 | 04:05:01 INFO - PID 4170 | Cycle 1(1): loaded http://localhost:43636/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43636/tests/kraken/driver.html?testName=imaging-darkroom) 04:05:02 INFO - PID 4170 | RSS: Main: 177176576 04:05:02 INFO - PID 4170 | 04:05:05 INFO - PID 4170 | Cycle 1(1): loaded http://localhost:43636/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43636/tests/kraken/driver.html?testName=imaging-desaturate) 04:05:06 INFO - PID 4170 | RSS: Main: 176463872 04:05:06 INFO - PID 4170 | 04:05:09 INFO - PID 4170 | Cycle 1(1): loaded http://localhost:43636/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43636/tests/kraken/driver.html?testName=json-parse-financial) 04:05:09 INFO - PID 4170 | RSS: Main: 177471488 04:05:09 INFO - PID 4170 | 04:05:11 INFO - PID 4170 | Cycle 1(1): loaded http://localhost:43636/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43636/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:05:12 INFO - PID 4170 | RSS: Main: 177451008 04:05:12 INFO - PID 4170 | 04:05:14 INFO - PID 4170 | Cycle 1(1): loaded http://localhost:43636/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43636/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:05:14 INFO - PID 4170 | RSS: Main: 174198784 04:05:14 INFO - PID 4170 | 04:05:17 INFO - PID 4170 | Cycle 1(1): loaded http://localhost:43636/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43636/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:05:17 INFO - PID 4170 | RSS: Main: 174641152 04:05:17 INFO - PID 4170 | 04:05:20 INFO - PID 4170 | Cycle 1(1): loaded http://localhost:43636/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43636/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:05:21 INFO - PID 4170 | RSS: Main: 175435776 04:05:21 INFO - PID 4170 | 04:05:24 INFO - PID 4170 | Cycle 1(1): loaded http://localhost:43636/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43636/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:05:24 INFO - PID 4170 | RSS: Main: 175149056 04:05:24 INFO - PID 4170 | 04:05:26 INFO - PID 4170 | Cycle 1(1): loaded http://localhost:43636/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43636/tests/kraken/driver.html?testName=ai-astar) 04:05:26 INFO - PID 4170 | RSS: Main: 176668672 04:05:26 INFO - PID 4170 | 04:05:26 INFO - PID 4170 | __start_tp_report 04:05:26 INFO - PID 4170 | _x_x_mozilla_page_load 04:05:26 INFO - PID 4170 | _x_x_mozilla_page_load_details 04:05:26 INFO - PID 4170 | |i|pagename|runs| 04:05:26 INFO - PID 4170 | |0;ai-astar;99;108;100;109;106;109;114;98;107;108 04:05:26 INFO - PID 4170 | |1;audio-beat-detection;158;123;140;193;120;151;150;124;175;119 04:05:26 INFO - PID 4170 | |2;audio-dft;165;163;165;163;162;172;168;167;162;165 04:05:26 INFO - PID 4170 | |3;audio-fft;82;83;77;166;86;74;75;74;169;77 04:05:26 INFO - PID 4170 | |4;audio-oscillator;83;79;130;79;79;80;129;85;79;123 04:05:26 INFO - PID 4170 | |5;imaging-gaussian-blur;114;113;114;115;114;113;117;118;118;118 04:05:26 INFO - PID 4170 | |6;imaging-darkroom;151;152;154;153;151;151;151;150;151;150 04:05:26 INFO - PID 4170 | |7;imaging-desaturate;98;98;95;95;95;95;94;98;94;94 04:05:26 INFO - PID 4170 | |8;json-parse-financial;63;55;55;55;61;55;58;54;58;55 04:05:26 INFO - PID 4170 | |9;json-stringify-tinderbox;54;59;56;62;54;55;54;55;55;54 04:05:26 INFO - PID 4170 | |10;stanford-crypto-aes;84;90;78;76;77;89;82;104;88;79 04:05:26 INFO - PID 4170 | |11;stanford-crypto-ccm;130;130;132;123;126;130;124;130;127;177 04:05:26 INFO - PID 4170 | |12;stanford-crypto-pbkdf2;170;172;178;174;179;189;181;179;186;172 04:05:26 INFO - PID 4170 | |13;stanford-crypto-sha256-iterative;68;67;66;68;73;66;67;67;67;66 04:05:26 INFO - PID 4170 | __end_tp_report 04:05:26 INFO - PID 4170 | __start_cc_report 04:05:26 INFO - PID 4170 | _x_x_mozilla_cycle_collect,989 04:05:26 INFO - PID 4170 | __end_cc_report 04:05:26 INFO - PID 4170 | __startTimestamp1501931126982__endTimestamp 04:05:26 INFO - PID 4170 | 04:05:26 INFO - PID 4170 | ------- Summary: start ------- 04:05:26 INFO - PID 4170 | Number of tests: 14 04:05:26 INFO - PID 4170 | 04:05:26 INFO - PID 4170 | [#0] ai-astar Cycles:10 Average:105.80 Median:109.00 stddev:5.16 (4.7%) stddev-sans-first:4.85 04:05:26 INFO - PID 4170 | Values: 99.0 108.0 100.0 109.0 106.0 109.0 114.0 98.0 107.0 108.0 04:05:26 INFO - PID 4170 | 04:05:26 INFO - PID 4170 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:150.50 stddev:25.13 (16.7%) stddev-sans-first:26.23 04:05:26 INFO - PID 4170 | Values: 158.0 123.0 140.0 193.0 120.0 151.0 150.0 124.0 175.0 119.0 04:05:26 INFO - PID 4170 | 04:05:26 INFO - PID 4170 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.00 stddev:3.12 (1.9%) stddev-sans-first:3.31 04:05:26 INFO - PID 4170 | Values: 165.0 163.0 165.0 163.0 162.0 172.0 168.0 167.0 162.0 165.0 04:05:26 INFO - PID 4170 | 04:05:26 INFO - PID 4170 | [#3] audio-fft Cycles:10 Average:96.30 Median:77.00 stddev:37.75 (49.0%) stddev-sans-first:39.68 04:05:26 INFO - PID 4170 | Values: 82.0 83.0 77.0 166.0 86.0 74.0 75.0 74.0 169.0 77.0 04:05:26 INFO - PID 4170 | 04:05:26 INFO - PID 4170 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:79.00 stddev:22.75 (28.8%) stddev-sans-first:23.74 04:05:26 INFO - PID 4170 | Values: 83.0 79.0 130.0 79.0 79.0 80.0 129.0 85.0 79.0 123.0 04:05:26 INFO - PID 4170 | 04:05:26 INFO - PID 4170 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:116.00 stddev:2.12 (1.8%) stddev-sans-first:2.19 04:05:26 INFO - PID 4170 | Values: 114.0 113.0 114.0 115.0 114.0 113.0 117.0 118.0 118.0 118.0 04:05:26 INFO - PID 4170 | 04:05:26 INFO - PID 4170 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:151.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 04:05:26 INFO - PID 4170 | Values: 151.0 152.0 154.0 153.0 151.0 151.0 151.0 150.0 151.0 150.0 04:05:26 INFO - PID 4170 | 04:05:26 INFO - PID 4170 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.00 stddev:1.71 (1.8%) stddev-sans-first:1.58 04:05:26 INFO - PID 4170 | Values: 98.0 98.0 95.0 95.0 95.0 95.0 94.0 98.0 94.0 94.0 04:05:26 INFO - PID 4170 | 04:05:26 INFO - PID 4170 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:56.50 stddev:3.03 (5.4%) stddev-sans-first:2.28 04:05:26 INFO - PID 4170 | Values: 63.0 55.0 55.0 55.0 61.0 55.0 58.0 54.0 58.0 55.0 04:05:26 INFO - PID 4170 | 04:05:26 INFO - PID 4170 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:55.00 stddev:2.66 (4.8%) stddev-sans-first:2.74 04:05:26 INFO - PID 4170 | Values: 54.0 59.0 56.0 62.0 54.0 55.0 54.0 55.0 55.0 54.0 04:05:26 INFO - PID 4170 | 04:05:26 INFO - PID 4170 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:83.00 stddev:8.50 (10.2%) stddev-sans-first:9.01 04:05:26 INFO - PID 4170 | Values: 84.0 90.0 78.0 76.0 77.0 89.0 82.0 104.0 88.0 79.0 04:05:26 INFO - PID 4170 | 04:05:26 INFO - PID 4170 | [#11] stanford-crypto-ccm Cycles:10 Average:132.90 Median:130.00 stddev:15.77 (12.1%) stddev-sans-first:16.69 04:05:26 INFO - PID 4170 | Values: 130.0 130.0 132.0 123.0 126.0 130.0 124.0 130.0 127.0 177.0 04:05:26 INFO - PID 4170 | 04:05:26 INFO - PID 4170 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.00 Median:179.00 stddev:6.22 (3.5%) stddev-sans-first:5.88 04:05:26 INFO - PID 4170 | Values: 170.0 172.0 178.0 174.0 179.0 189.0 181.0 179.0 186.0 172.0 04:05:26 INFO - PID 4170 | 04:05:26 INFO - PID 4170 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.00 stddev:2.07 (3.1%) stddev-sans-first:2.19 04:05:27 INFO - PID 4170 | Values: 68.0 67.0 66.0 68.0 73.0 66.0 67.0 67.0 67.0 66.0 04:05:27 INFO - PID 4170 | -------- Summary: end -------- 04:05:27 INFO - PID 4170 | 04:05:27 INFO - PID 4170 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:05:27 INFO - TEST-INFO | 4170: exit 0 04:05:27 INFO - TEST-OK | kraken | took 62928ms 04:05:27 INFO - SUITE-END | took 1180s 04:05:28 INFO - Completed test suite (00:19:40) 04:05:28 INFO - javascript benchmark 04:05:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8540.296984842375, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3153.2747468082357, 3178.3643271345736, 3190.377876314119, 3196.0411876437065, 3220.9194770130744, 6295.559310848243, 6308.053791931213, 6381.26615439224, 6392.0, 6439.323870993549, 6166.075088736692, 6257.0, 6261.686915654211, 6273.68631568422, 6279.215098112736, 5749.856253593652, 5766.481016708506, 5793.942060579382, 5795.507381872525, 5802.071668533035, 5734.770609175628, 5786.537077033849, 5787.536997040248, 5790.7683692652245, 5799.043157878945, 5728.398518155596, 5732.910746958086, 5768.625039372449, 5774.97112514439, 5784.71076446176, 5776.133579962997, 5793.0, 5829.912551311733, 5834.591578589521, 5847.736851841677, 5723.255976723, 5731.340895796953, 5749.425057494259, 5837.153612726173, 5855.76576936922, 5997.8800423991715, 6121.9592669245885, 6137.693115344215, 6171.166892469504, 6257.812265632038, 6754.189497260311, 6757.966210168966, 6798.0, 6806.387425131762, 6825.283345248727, 6794.252632210453, 6810.046593476917, 6891.552049116842, 6903.309669033107, 6913.170419549636, 6254.061890716429, 6287.654179020198, 6304.905426418607, 6368.331325210879, 6386.744530218785, 6961.547499412522, 6977.51157418986, 6985.755498557526, 6987.580745155307, 7021.22766495685, 6608.8347791305605, 6691.866162676719, 6699.062131301622, 6699.39705426514, 6699.899501507482, 6705.161854768154, 6720.899186512206, 6733.831654208684, 6810.523263371616, 6815.114035175396, 6593.076969224312, 6632.0, 6714.932850671431, 6717.462602991749, 6787.762428314985, 6725.293844146392, 6743.258241593421, 6744.291849355845, 6748.392644661906, 6749.932500675029, 5323.920141197885, 5400.432954539795, 5401.081816091195, 5404.243405923174, 5410.107332290128, 4663.440387153563, 4681.040386720714, 4692.296155576691, 4696.788644511005, 4697.671163018625, 5816.389279125716, 5837.6497410155525, 5902.852428689317, 5904.996150654399, 5906.0, 6778.593284402951, 6872.1066261386695, 6892.414144797748, 6897.275786042494, 6912.896306555405, 5768.480836724715, 5839.445252700986, 5853.0, 5855.3266374367495, 5937.376575459601, 5894.322152952465, 5895.4399332063385, 5898.64608123514, 5919.733611987471, 5928.0, 6507.284198738135, 6526.902096468557, 6543.640099794557, 6582.308857569982, 6583.934160658428, 6665.0, 6669.4664426844765, 6764.3573860483175, 6765.526413151032, 6772.390484856386, 6568.146141001639, 6569.24453687832, 6607.834804129743, 6631.568948018364, 6666.699998499982, 6552.967235163794, 6565.671716414065, 6626.635535045426, 6635.402813746786, 6636.27001029896, 6757.121574195323, 6816.7614133505085, 6834.9316506836285, 6859.176898772179, 6893.241743408322, 6463.741450342121, 6529.542931994714, 6569.80290591283, 6601.141851559267, 6619.106420633153, 6429.903551446826, 6536.640484773383, 6543.770968016097, 6547.770828020996, 6567.408933195844, 6351.364863513611, 6413.1021656969, 6446.613203207822, 6528.053432252392, 6529.020646902813, 6527.412532872065, 6564.277929427854, 6593.637349945607, 6643.501737369813, 6668.766593169215, 6432.099506069248, 6439.356064393523, 6456.483481321577, 6464.967675161783, 6467.126937863328], "value": 6161.24510676507, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.7334293011841, 840.945338552994, 870.0516437083579, 879.3361012435614, 1166.7608140331233, 30575.694243057562, 40662.79668601657, 42137.15725685484, 42164.36753448693, 42222.57777422225, 42322.0, 42666.360004599956, 42746.7862660687, 42755.572444275545, 42804.35793463101, 7130.928690713078, 7627.046619172604, 7632.7787553991375, 7633.427492938024, 7633.732819351324, 7507.624618769067, 7671.923280767204, 7675.654595543186, 7677.11713152989, 7680.654370553339, 7663.042119735033, 7681.270279323456, 7707.730229441971, 7709.229077092302, 7711.768646940601, 7631.12242092161, 7635.809104772369, 7650.234976502361, 7651.617419129049, 7654.617269136521, 7652.311291983692, 7678.692852285902, 7686.154523002465, 7699.846003079907, 7712.228777122299, 38281.234375312335, 38663.61336386628, 39215.41176882349, 39343.803280983695, 39451.21097578033, 3577.409727394977, 3579.928401431983, 3600.891973240807, 3610.1877077657578, 3618.855245790165, 31041.0, 31280.061598152093, 31342.21644458884, 31609.367812643617, 31717.524237136462, 4841.830535931261, 5024.698518088926, 5028.1200789862, 5061.367329083864, 5088.185890257541, 191144.0, 194020.0, 194289.0, 194335.0283248589, 194564.0, 48256.0, 48318.0, 48530.27204591934, 50658.0, 50754.23868641973, 53591.19613205805, 53729.46270537245, 53751.46248537464, 53774.46225537773, 53913.46086539084, 16132.75800862988, 16385.262663180187, 16585.0, 16647.3341066356, 16673.6665266694, 13565.457381704819, 13580.117292375964, 13672.589822305346, 13675.589732308046, 13692.31538423075, 14101.365438555289, 14204.360803763855, 14233.85766142346, 14324.713505729827, 14344.211068391338, 5700.857478563069, 5713.0, 5780.71096445176, 5815.098659707752, 5862.0, 1002.8545860850136, 1023.2990401574945, 1038.345842119475, 1040.287403128859, 1049.1158940561686, 23174.53650926972, 23901.402464938168, 23933.0, 24470.14354497584, 29366.853165734035, 1079.611339917629, 1087.4127970895786, 1100.0649447969163, 1103.1836441033577, 1118.6061827688752, 12521.0, 12646.30445325516, 15946.28241729125, 15966.0, 16676.332946681996, 240804.0, 243626.0, 244145.0, 244771.0, 245195.0, 58064.0, 58275.70862145662, 58344.0, 58561.4143858556, 58949.70525147347, 1420.879225265864, 1454.0575460915245, 1488.784126301702, 1491.0308299605342, 1492.276246020679, 28087.595620219316, 28198.577021345107, 28215.71784282213, 28722.0, 28936.855315723285, 38076.23847522979, 38285.0, 38353.616463835, 38413.423798642485, 51478.48521514887, 213442.0, 216188.0, 216433.0, 217170.0, 217474.0, 35973.0, 36103.63896361003, 36151.45772813463, 36396.27207455889, 36460.0, 43396.34905476483, 43857.122857543305, 44783.0, 44967.100657986004, 45234.77382613066, 33560.66439335576, 35730.0, 36499.81750091232, 36571.0, 36790.8160459196, 36273.455898161024, 36276.27447450983, 36427.45358819673, 36586.268274633825, 36729.816350918074, 37635.62364376321, 38404.42393364046, 38871.2225755489, 38891.80554097211, 39417.0, 34027.0, 34621.307573848884, 34700.30599388049, 35508.82245588755, 35513.46729799107, 23683.0, 25100.62349064802, 25273.368165796, 26102.34744131412, 26302.21093367202], "value": 17920.70861021742, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.8634727665361, 572.1532132443983, 579.7420148034121, 580.3905898806254, 587.1222522329118, 21524.354269371906, 22304.0, 22349.0, 22411.887940560297, 22520.324390268277, 26297.211083667473, 26719.86640066802, 26806.06178783738, 26810.0, 26830.463390732173, 6557.3442655734525, 6744.055832183498, 6751.628660423675, 6754.0, 6756.628385438799, 5916.822495325147, 6208.534359923001, 6461.418472337488, 6579.144711187563, 6666.466682665375, 6426.196725409324, 6467.482601391901, 6467.611943283395, 6467.870642587145, 6471.773487927923, 6432.0, 6433.099366088752, 6433.517486188554, 6438.742450301982, 6439.774607888725, 6002.099685047234, 6021.096835474714, 6027.517798576104, 6032.245969253843, 6035.064564992434, 28884.27789305284, 29978.70021299803, 29988.55017174744, 30139.547906781416, 30610.84694576513, 1922.663533881579, 1965.027311480812, 1971.940841774749, 1972.1716878910893, 1972.7731310899287, 19248.422547323604, 19815.900920495304, 19925.10337034837, 20033.699494507593, 20039.398818035483, 2306.4349234437504, 2381.3332266965276, 2425.34515680767, 2427.708674959016, 2454.2882564056404, 143381.0, 147348.0, 147763.0, 149133.0, 153241.0, 14191.219482928538, 14789.778153327708, 15289.0, 15309.15799631031, 15766.290516926765, 22701.708252303324, 23512.764872351057, 23636.17273395423, 23804.88097559501, 24097.156599518934, 10481.318714283547, 10496.317739346918, 10533.57865685364, 10625.628103016357, 10759.462026898624, 9711.757206069904, 9815.852762208573, 9898.208143348515, 9939.50302484873, 9950.35322704022, 9169.128932751379, 9173.81652366949, 9483.810323793485, 9561.330706850593, 9618.615255389846, 2640.2871224769206, 2706.6887307959837, 2779.5691667791525, 2780.569011803174, 2867.354845159822, 972.9756756081155, 986.8421052631544, 989.2531138990016, 999.3004896572428, 1000.7698229407277, 19147.521311967314, 19679.60640787176, 20027.198912043645, 20496.38510844677, 20607.690884636744, 1035.5495359518634, 1041.5937784264142, 1045.8431235314763, 1047.9423631700329, 1050.4380156616173, 11003.119750419946, 11051.447427628586, 11199.888001119885, 11212.495437705324, 11282.041026512674, 476054.0, 510136.0, 511490.0, 513206.0, 516049.0, 118043.0, 118395.40802295934, 119565.40217299032, 121008.0, 121699.39150304369, 1213.5226744932859, 1223.1621339382552, 1232.8952039076778, 1244.0420875925668, 1248.8126780982925, 17308.82691173072, 17566.38517651876, 17649.38227162043, 17987.910060449613, 18018.72971905396, 55253.44746552483, 55708.05021824217, 55753.0, 56162.0, 56898.0, 72085.6395718018, 72139.63930180525, 72502.0, 72566.63716681383, 72921.27078729145, 14437.205953672648, 14478.710425791636, 14641.63395915068, 14682.55952321432, 14818.40726370933, 22913.88543057274, 22987.770122299233, 22995.0, 23069.65395519102, 23130.537389251785, 18023.639527209645, 18154.72767908456, 18172.45482635523, 18421.815781842546, 18462.907685461487, 15743.842561574696, 16801.579960500596, 17118.0, 17173.540249078967, 17292.04893730857, 17980.55048623795, 18575.349862754738, 18610.162542685342, 18714.532136696693, 18776.906115469334, 14408.13551186932, 14504.347304371118, 14553.927230364205, 14556.0, 14561.708765824413, 17087.145642718064, 17261.0, 17278.65442691114, 17633.294668213126, 18117.0], "value": 12070.196861528611, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.383755391297, 1406.0930699698695, 1434.583970648512, 1434.6198257461767, 1440.971180576389, 13692.315384230786, 14229.075110117836, 14251.50119745809, 14288.499902503414, 14331.211783351911, 14578.854211457883, 14827.110373377605, 14833.925830370834, 14834.035787673794, 14835.703285934274, 2637.3011152044724, 2677.223605154503, 2677.4377380750066, 2679.9464010719776, 2683.047518131055, 2412.3124909400826, 2552.52778236026, 2565.8203925725206, 2572.601246806748, 2572.832765870222, 2762.8618569071464, 2764.1431156341496, 2796.1751283371354, 2796.3149028487946, 2797.9720202798017, 2591.0413147135587, 2619.9607005894927, 2664.933376665589, 2669.0658269605483, 2749.408877091425, 2597.6623039005, 2613.098481024044, 2626.566616508274, 2630.8421494710187, 2637.3406648337914, 13862.237576933265, 14127.929360353133, 14131.293435328193, 14155.363008664532, 14178.220197889112, 7622.885656715153, 7867.921320786776, 7877.094134174586, 7880.211978802074, 7881.8029549261155, 4993.600511959071, 5065.214891691794, 5128.179491281415, 5251.737413129366, 5301.098813201765, 1625.6667383186418, 1632.4659404618353, 1646.5389690886452, 1699.0400423760536, 1701.7277235642239, 23352.649710254358, 23557.411064723346, 23835.284941451784, 23843.165489207793, 23875.16436924699, 6517.674116294166, 6535.0850880876715, 6607.603543787388, 6641.86716265672, 6666.266710661824, 16090.919545402197, 16157.272922718506, 16164.0, 16198.947068440513, 16219.27013284405, 7618.047744031996, 7773.222677732181, 7776.105747839071, 7783.066032076187, 7789.221077892165, 6294.0, 6969.860602788017, 7035.753748618774, 7128.607926564089, 7268.527545709512, 4809.9038019240115, 4964.702117872867, 5035.093683136997, 5244.160934250502, 5253.605979551549, 1564.3742502998891, 1565.1000674612144, 1575.1100628145061, 1595.369828917571, 1597.3770229610461, 859.1966511311944, 888.9822203556022, 917.554985831871, 920.30516959695, 927.2674587076134, 7749.302562769378, 7790.961045194737, 7867.527948323119, 7905.130435652074, 7993.640286187136, 971.3686104032295, 983.8032393521181, 1018.098982400566, 1022.4734261855151, 1043.0768769638923, 5058.0, 5233.947660523346, 5336.839894803162, 5349.919751203735, 5408.756605952742, 19151.616967660568, 20006.49983750389, 20057.598848022957, 20064.59870802576, 20074.0, 19093.2362705493, 19480.02599870029, 19678.90160549188, 19682.0, 19761.0, 10295.279330446796, 10600.0, 10717.142628589694, 10760.677179684622, 10777.730556735987, 8064.475809072392, 8224.958875205586, 8416.452930559493, 8508.106648801786, 8543.0, 17033.48899533016, 17207.31170753206, 17467.0, 17793.466196014142, 17864.0, 17663.20515576828, 18042.0, 18151.001694906907, 18427.631447371245, 18708.812911870707, 11459.828102578302, 11628.0, 11648.76702465929, 11685.357305347947, 11710.063194944554, 11937.343446110548, 12248.632541023784, 13068.934655326662, 13126.278054706701, 13217.801732973821, 10921.83617245726, 11032.558697652325, 11060.0, 11179.105671546095, 11338.886611133783, 10726.892731072901, 10863.293885897392, 10863.728406789578, 11033.337999720043, 11120.499577518869, 9396.483193424154, 9466.2427005838, 9479.336446448682, 9571.952140239255, 9583.520823958914, 6940.236573976757, 7043.084399028094, 7053.153621565445, 7086.362227399559, 7234.457415693949, 6918.654067296515, 6919.411849992807, 6974.79075627732, 7079.1505019395945, 7098.29017098286], "value": 6449.853595198077, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.4039973231319, 510.08949025988574, 528.8704267454474, 530.1623434972742, 531.8271561742433, 6259.280182778982, 6271.1533942917695, 6305.274893387262, 6332.7466901324005, 6369.936300636992, 6215.720292586833, 6226.097215903691, 6235.844103897405, 6253.24961004679, 6253.68672578759, 5172.353455818032, 5179.404368497614, 5183.507566781169, 5195.896082078356, 5196.480351964811, 4822.987172693738, 4956.950430495703, 5014.799408023675, 5123.337762636002, 5152.458991805863, 4960.33035540201, 4961.652684312099, 4982.551570358667, 4982.5764809991015, 4995.600351971833, 4959.8016079356785, 4968.403791545002, 4987.850364489035, 4996.525330093636, 5025.447200807908, 4505.752183629899, 4509.098180363941, 4514.954850451519, 4538.72767633943, 4544.454665440136, 6083.726232319556, 6137.232845894263, 6147.139400483936, 6173.135760993465, 6191.628502289877, 5701.14482827575, 5703.0, 5771.653700777967, 5775.682337471438, 5789.131630255453, 6502.187226596676, 6513.316101809289, 6528.800887565107, 6550.508711846631, 6577.539572229945, 4876.683015603974, 4877.975625118729, 4887.780049897763, 4911.165101932645, 4916.852494425173, 6566.93433065668, 6671.799846004627, 6773.525853190328, 6892.276310987324, 6974.51178417511, 4887.340209071801, 4943.555080042814, 4949.628777841676, 4960.280759289883, 4961.8511444656715, 4981.676191047571, 4995.675281106716, 5005.874853128628, 5033.370828646419, 5036.496350365008, 5552.139418390156, 5564.8330550083565, 5618.747156377973, 5628.296462942132, 5663.1505274208375, 6518.152640156844, 6531.0, 6588.538802283794, 6611.20665520131, 6635.867282654416, 1779.359430605007, 1791.9104044797707, 1804.7096326126882, 1806.1962426719983, 1810.5383127302716, 1189.881011898803, 1218.7196944702591, 1235.8208059831454, 1256.7926292161692, 1261.5458434963407, 5732.254806875079, 5805.448482394166, 5821.924652743097, 5830.7959221427045, 5832.0, 6762.3432259096835, 6772.322767723188, 6819.420349270268, 6840.657967101724, 6851.862962740717, 5597.0, 5721.799737009184, 5728.914066289009, 5748.838139023604, 5813.883722325614, 3570.8214589270433, 3585.551806024247, 3587.695045921126, 3591.94612080819, 3624.347617428888, 6429.45349645276, 6478.708458119396, 6520.608763474112, 6527.0, 6553.2136143663065, 6882.483813713991, 6930.653467326714, 6983.720651173896, 6995.440364770908, 7000.824979375557, 5996.141196229183, 6453.677316134174, 6562.146920900253, 6600.372964568358, 6606.042123892009, 6634.137562116894, 6714.160729908762, 6756.831079222862, 6763.729450821912, 6763.966180169067, 6522.249941256816, 6629.502787290876, 6668.499862510234, 6684.598924064571, 6707.4969377297875, 6532.8366790830605, 6569.638669873203, 6571.704273307617, 6572.441342485942, 6583.44040756541, 5065.13892638245, 5068.391792984866, 5069.721165335942, 5076.6446348755235, 5080.898382032413, 6597.472202223907, 6638.269790322964, 6676.9666151668935, 6706.463482921452, 6754.459643228628, 6305.337939516285, 6469.7412103515335, 6490.350964903472, 6521.413072823469, 6571.342865713582, 6483.157189565326, 6517.674116294261, 6542.378474044958, 6566.540342176002, 6576.572522786004, 6373.506677792238, 6379.585326953733, 6421.935780642134, 6441.710123044568, 6448.097266382804, 6536.575122617015, 6578.342165783383, 6585.901211481927, 6605.471562275103, 6613.603183808987, 6357.4596159326975, 6360.204974378203, 6371.39471750183, 6380.776672816615, 6401.135846660827], "value": 5075.261612567142, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [918.641729725407, 928.0765638189998, 945.7493764152497, 949.7957939043105, 951.3150531617235, 18890.52773680657, 19834.0, 19946.501337466554, 19972.101255443504, 22200.555988880213, 21859.453513662167, 22262.332130036124, 22273.888630556867, 22390.0, 22439.551208975812, 1024.9897501025007, 1065.7602039541118, 1066.5094056733913, 1066.632011955874, 1066.8293073108305, 947.1097168661471, 1062.9893701063006, 1067.3169171730099, 1074.7528068544239, 1075.070064394297, 1040.2354269611828, 1096.7313008312935, 1097.8298363753631, 1099.0218705352243, 1099.1701265544502, 1099.3019432660278, 1101.3171833463264, 1106.181425744951, 1106.2919731371849, 1106.634810512529, 805.6656487557715, 806.3468590441703, 809.178683636104, 809.9473534220257, 812.7521106062649, 19456.805431945642, 19667.31164409253, 19858.50353741168, 19883.30408435698, 19978.600427991358, 21629.891850540804, 22345.888270558542, 22382.776172238395, 22815.0, 22836.429089272737, 16619.41832035885, 16709.248083836257, 16723.163841807982, 16727.749083763752, 17219.913900430543, 3675.44868269759, 3677.5586929568353, 3694.963050369489, 3697.0, 3697.574778900434, 131162.0, 132211.33894330467, 132398.0, 132856.0, 135649.3217533916, 16910.492685219462, 17608.73586896172, 17659.38192163268, 17763.0, 17767.378141764977, 31778.205544861103, 31899.0, 32059.839700801815, 32744.508832367534, 32765.67234327674, 7638.236176382317, 7682.116556595951, 7991.56046417441, 8122.55325957078, 8741.781455463664, 4145.481814773153, 4263.76549289792, 4266.445362102907, 4272.038791271939, 4288.592583704543, 5206.739663016834, 5292.0, 5352.759125839347, 5354.732263386815, 5399.4600539945695, 1060.3584831177182, 1060.3584831177182, 1080.7406222506543, 1082.1883587309517, 1083.7615724540588, 544.4065968094795, 576.8096528145702, 587.2277954489832, 595.0776296740036, 598.0610441606635, 11715.472803723853, 11880.0, 12108.03135749138, 12121.69695757613, 12846.293453860128, 547.1273319056099, 572.2303501790086, 599.4245524296637, 599.6941559804444, 606.6390497653977, 5473.0969390050195, 5495.422980587061, 5496.5053145217125, 5720.998825205573, 5752.309722833287, 103355.0, 108098.45950770353, 108638.45680771704, 110190.44904775424, 111239.0, 93259.0, 95334.5233273843, 95941.0, 96911.51544242234, 97054.0, 79314.20685793068, 80455.17268963881, 81665.59167204126, 84390.57804710937, 86177.13822861816, 10734.946325268324, 10767.407792571485, 10811.243212975016, 10856.728581785519, 11119.83320250213, 38474.0, 38543.614563854004, 38579.80710096432, 38709.6129038706, 39020.41469377905, 48678.513214867395, 48921.2661810066, 49182.75408622934, 49377.25934111063, 49577.25634115419, 16228.350865965702, 16547.172641367644, 16674.916625416794, 16758.58103547421, 16784.32862685479, 18038.90980545089, 18499.630007400046, 18578.535536611693, 18602.534936626693, 18780.436586902415, 16684.332626695283, 16724.414645487348, 16866.494005179375, 16924.153792310088, 17080.060596667303, 15455.381784728484, 15464.768028479357, 15473.458428954933, 15501.767473487682, 15602.063876167465, 16268.51194464168, 16496.25766840519, 16533.173341333128, 16608.0, 16744.33022679128, 11592.884071159518, 11646.475908584303, 11657.417129143678, 11956.820647690465, 12102.939485302517, 12345.259284442962, 12451.315177665316, 12638.2417054977, 12677.87322126767, 12966.935165324114], "value": 8893.32596891237, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 108.0, 100.0, 109.0, 106.0, 109.0, 114.0, 98.0, 107.0, 108.0], "value": 105.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 123.0, 140.0, 193.0, 120.0, 151.0, 150.0, 124.0, 175.0, 119.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 165.0, 163.0, 162.0, 172.0, 168.0, 167.0, 162.0, 165.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 77.0, 166.0, 86.0, 74.0, 75.0, 74.0, 169.0, 77.0], "value": 96.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 79.0, 130.0, 79.0, 79.0, 80.0, 129.0, 85.0, 79.0, 123.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 115.0, 114.0, 113.0, 117.0, 118.0, 118.0, 118.0], "value": 115.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 154.0, 153.0, 151.0, 151.0, 151.0, 150.0, 151.0, 150.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 95.0, 95.0, 95.0, 95.0, 94.0, 98.0, 94.0, 94.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 55.0, 55.0, 55.0, 61.0, 55.0, 58.0, 54.0, 58.0, 55.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 56.0, 62.0, 54.0, 55.0, 54.0, 55.0, 55.0, 54.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 90.0, 78.0, 76.0, 77.0, 89.0, 82.0, 104.0, 88.0, 79.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 130.0, 132.0, 123.0, 126.0, 130.0, 124.0, 130.0, 127.0, 177.0], "value": 132.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 178.0, 174.0, 179.0, 189.0, 181.0, 179.0, 186.0, 172.0], "value": 178.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 68.0, 73.0, 66.0, 67.0, 67.0, 67.0, 66.0], "value": 67.5, "unit": "score"}]}]} 04:05:28 INFO - Return code: 0 04:05:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:05:28 INFO - # TBPL SUCCESS # 04:05:28 INFO - Running post-action listener: _package_coverage_data 04:05:28 INFO - Running post-action listener: _resource_record_post_action 04:05:28 INFO - [mozharness: 2017-08-05 11:05:28.267993Z] Finished run-tests step (success) 04:05:28 INFO - Running post-run listener: _resource_record_post_run 04:05:28 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 9629696; Write bytes: 440397824; Read time: 3104; Write time: 710840 04:05:28 INFO - TinderboxPrint: CPU usage
13.2% 04:05:28 INFO - TinderboxPrint: I/O read bytes / time
9,629,696 / 3,104 04:05:28 INFO - TinderboxPrint: I/O write bytes / time
440,397,824 / 710,840 04:05:28 INFO - TinderboxPrint: CPU idle
8,294.5 (86.8%) 04:05:28 INFO - TinderboxPrint: CPU user
1,206.1 (12.6%) 04:05:28 INFO - TinderboxPrint: Swap in / out
0 / 0 04:05:28 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 115539968; Read time: 112; Write time: 157980 04:05:28 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:05:28 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 7389184; Write bytes: 324857856; Read time: 2772; Write time: 552860 04:05:28 INFO - Running post-run listener: _upload_blobber_files 04:05:28 INFO - Blob upload gear active. 04:05:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:05:28 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:05:28 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:05:28 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:05:29 INFO - (blobuploader) - INFO - Open directory for files ... 04:05:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:05:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:05:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:30 INFO - (blobuploader) - INFO - Done attempting. 04:05:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:05:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:05:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:36 INFO - (blobuploader) - INFO - Done attempting. 04:05:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:05:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:05:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:37 INFO - (blobuploader) - INFO - Done attempting. 04:05:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:05:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:05:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:38 INFO - (blobuploader) - INFO - Done attempting. 04:05:38 INFO - (blobuploader) - INFO - Iteration through files over. 04:05:38 INFO - Return code: 0 04:05:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:05:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:05:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15d87d60dbf37f947204d803cc85d747632ecdf965878a7db2f4d87b44ce1cf6ff071170ea71c289f5f2bfe3b6e3204a52a8398c7b3f73898410520946f5498c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/109f63afda57fc8de656f440ff02a7a9904f18526654307532a93f7fb10d8ba1c2355ada8fe02db75b308b3be5bcdc818b7e3fc1e44cf75a4d3fc192c9544366", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/287319ad44dc94485905ebe92b56540eb207f98d7f5e2f82f459479a587596737750b7950b92c8f375afb9c67252a2983f0a6f5b22484b75fa0091e14ee9ba02", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/630738478718a000e8a78523f57040640ef7f0a570befd19f7360469621a308053dd75d6f47c7c5bf649bff25d9b8e055010a97eded4ef448a5cb11c3ee53d9a"} 04:05:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:05:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:05:38 INFO - Contents: 04:05:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15d87d60dbf37f947204d803cc85d747632ecdf965878a7db2f4d87b44ce1cf6ff071170ea71c289f5f2bfe3b6e3204a52a8398c7b3f73898410520946f5498c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/109f63afda57fc8de656f440ff02a7a9904f18526654307532a93f7fb10d8ba1c2355ada8fe02db75b308b3be5bcdc818b7e3fc1e44cf75a4d3fc192c9544366", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/287319ad44dc94485905ebe92b56540eb207f98d7f5e2f82f459479a587596737750b7950b92c8f375afb9c67252a2983f0a6f5b22484b75fa0091e14ee9ba02", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/630738478718a000e8a78523f57040640ef7f0a570befd19f7360469621a308053dd75d6f47c7c5bf649bff25d9b8e055010a97eded4ef448a5cb11c3ee53d9a"} 04:05:38 INFO - Running post-run listener: copy_logs_to_upload_dir 04:05:38 INFO - Copying logs to upload dir... 04:05:38 INFO - mkdir: /builds/slave/test/build/upload/logs 04:05:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.901800 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-08-05 04:05:38.372889) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-05 04:05:38.377862) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525 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/15d87d60dbf37f947204d803cc85d747632ecdf965878a7db2f4d87b44ce1cf6ff071170ea71c289f5f2bfe3b6e3204a52a8398c7b3f73898410520946f5498c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/109f63afda57fc8de656f440ff02a7a9904f18526654307532a93f7fb10d8ba1c2355ada8fe02db75b308b3be5bcdc818b7e3fc1e44cf75a4d3fc192c9544366", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/287319ad44dc94485905ebe92b56540eb207f98d7f5e2f82f459479a587596737750b7950b92c8f375afb9c67252a2983f0a6f5b22484b75fa0091e14ee9ba02", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/630738478718a000e8a78523f57040640ef7f0a570befd19f7360469621a308053dd75d6f47c7c5bf649bff25d9b8e055010a97eded4ef448a5cb11c3ee53d9a"} build_url:https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/Q911ZqBrTOC1zmf7mcOWpQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15d87d60dbf37f947204d803cc85d747632ecdf965878a7db2f4d87b44ce1cf6ff071170ea71c289f5f2bfe3b6e3204a52a8398c7b3f73898410520946f5498c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/109f63afda57fc8de656f440ff02a7a9904f18526654307532a93f7fb10d8ba1c2355ada8fe02db75b308b3be5bcdc818b7e3fc1e44cf75a4d3fc192c9544366", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/287319ad44dc94485905ebe92b56540eb207f98d7f5e2f82f459479a587596737750b7950b92c8f375afb9c67252a2983f0a6f5b22484b75fa0091e14ee9ba02", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/630738478718a000e8a78523f57040640ef7f0a570befd19f7360469621a308053dd75d6f47c7c5bf649bff25d9b8e055010a97eded4ef448a5cb11c3ee53d9a"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-05 04:05:38.448111) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 04:05:38.448472) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1501929733.164967-2078369525 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-05 04:05:38.532540) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-05 04:05:38.532849) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-05 04:05:38.533181) ========= ========= Total master_lag: 0.27 =========