builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-080 starttime: 1506799945.17 results: success (0) revision: 8873432294c4ae1431357410497676fbd3e1f855 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-30 12:32:25.173557) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-30 12:32:25.174007) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-30 12:32:25.174282) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-30 12:32:25.193826) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 12:32:25.194258) ========= 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=781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-30 12:32:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 77.9M=0s 2017-09-30 12:32:25 (77.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.176658 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 12:32:25.388312) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 12:32:25.391661) ========= 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=781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020311 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 12:32:25.444513) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 12:32:25.444868) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8873432294c4ae1431357410497676fbd3e1f855 --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 8873432294c4ae1431357410497676fbd3e1f855 --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=781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-30 12:32:25,552 truncating revision to first 12 chars 2017-09-30 12:32:25,552 Setting DEBUG logging. 2017-09-30 12:32:25,552 attempt 1/10 2017-09-30 12:32:25,552 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8873432294c4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-30 12:32:26,222 unpacking tar archive at: mozilla-central-8873432294c4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.975489 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 12:32:26.434191) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-30 12:32:26.437523) ========= script_repo_revision: 8873432294c4ae1431357410497676fbd3e1f855 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-30 12:32:26.437921) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-30 12:32:26.438219) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-30 12:32:26.455252) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-30 12:32:26.455567) ========= /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=781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:32:26 INFO - MultiFileLogger online at 20170930 12:32:26 in /builds/slave/test 12:32:26 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 12:32:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:32:26 INFO - {'append_to_log': False, 12:32:26 INFO - 'base_work_dir': '/builds/slave/test', 12:32:26 INFO - 'blob_upload_branch': 'Firefox', 12:32:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:32:26 INFO - 'branch': 'Firefox', 12:32:26 INFO - 'buildbot_json_path': 'buildprops.json', 12:32:26 INFO - 'code_coverage': False, 12:32:26 INFO - 'config_files': ('talos/linux_config.py',), 12:32:26 INFO - 'default_actions': ('clobber', 12:32:26 INFO - 'read-buildbot-config', 12:32:26 INFO - 'download-and-extract', 12:32:26 INFO - 'populate-webroot', 12:32:26 INFO - 'create-virtualenv', 12:32:26 INFO - 'install', 12:32:26 INFO - 'setup-mitmproxy', 12:32:26 INFO - 'run-tests'), 12:32:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:32:26 INFO - 'disable_ccov_upload': False, 12:32:26 INFO - 'disable_stylo': False, 12:32:26 INFO - 'download_minidump_stackwalk': True, 12:32:26 INFO - 'download_symbols': 'ondemand', 12:32:26 INFO - 'enable_stylo': False, 12:32:26 INFO - 'enable_webrender': False, 12:32:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 12:32:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:32:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:32:26 INFO - 'gecko_profile': False, 12:32:26 INFO - 'gecko_profile_interval': 0, 12:32:26 INFO - 'installer_path': 'installer.exe', 12:32:26 INFO - 'log_level': 'info', 12:32:26 INFO - 'log_name': 'talos', 12:32:26 INFO - 'log_to_console': True, 12:32:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:32:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:32:26 INFO - 'opt_config_files': (), 12:32:26 INFO - 'pip_index': False, 12:32:26 INFO - 'suite': 'dromaeojs-e10s', 12:32:26 INFO - 'system_bits': '32', 12:32:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:32:26 INFO - 'title': 'talos-linux64-ix-080', 12:32:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:32:26 INFO - 'use_talos_json': True, 12:32:26 INFO - 'verify': 'False', 12:32:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:32:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:32:26 INFO - 'work_dir': 'build'} 12:32:26 INFO - [mozharness: 2017-09-30 19:32:26.704208Z] Running clobber step. 12:32:26 INFO - Running pre-action listener: _resource_record_pre_action 12:32:26 INFO - Running main action method: clobber 12:32:26 INFO - rmtree: /builds/slave/test/build 12:32:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:32:28 INFO - Running post-action listener: _resource_record_post_action 12:32:28 INFO - [mozharness: 2017-09-30 19:32:28.217467Z] Finished clobber step (success) 12:32:28 INFO - [mozharness: 2017-09-30 19:32:28.217566Z] Running read-buildbot-config step. 12:32:28 INFO - Running pre-action listener: _resource_record_pre_action 12:32:28 INFO - Running main action method: read_buildbot_config 12:32:28 INFO - Using buildbot properties: 12:32:28 INFO - { 12:32:28 INFO - "project": "", 12:32:28 INFO - "product": "firefox", 12:32:28 INFO - "who": "ffxbld@noreply.mozilla.org", 12:32:28 INFO - "installer_path": "public/build/target.tar.bz2", 12:32:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 12:32:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 12:32:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 12:32:28 INFO - "stage_platform": "linux64-pgo", 12:32:28 INFO - "basedir": "/builds/slave/test", 12:32:28 INFO - "buildnumber": 223, 12:32:28 INFO - "platform": "ubuntu64_hw", 12:32:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:32:28 INFO - "slavebuilddir": "test", 12:32:28 INFO - "taskId": "Xs5m3mYwTI-mqoIqb0y5ug", 12:32:28 INFO - "branch": "mozilla-central", 12:32:28 INFO - "script_repo_revision": "production", 12:32:28 INFO - "revision": "8873432294c4ae1431357410497676fbd3e1f855", 12:32:28 INFO - "slavename": "talos-linux64-ix-080", 12:32:28 INFO - "repo_path": "mozilla-central" 12:32:28 INFO - } 12:32:28 INFO - Finding installer, test and symbols from parent task. 12:32:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xs5m3mYwTI-mqoIqb0y5ug'}, attempt #1 12:32:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xs5m3mYwTI-mqoIqb0y5ug'}, attempt #1 12:32:29 INFO - Task dependencies: ZaEM5yFfRGqkHoliHWWilg 12:32:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZaEM5yFfRGqkHoliHWWilg'}, attempt #1 12:32:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.tar.bz2 12:32:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.test_packages.json 12:32:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.crashreporter-symbols.zip 12:32:29 INFO - Running post-action listener: _resource_record_post_action 12:32:29 INFO - [mozharness: 2017-09-30 19:32:29.662110Z] Finished read-buildbot-config step (success) 12:32:29 INFO - [mozharness: 2017-09-30 19:32:29.662328Z] Running download-and-extract step. 12:32:29 INFO - Running pre-action listener: _resource_record_pre_action 12:32:29 INFO - Running main action method: download_and_extract 12:32:29 INFO - mkdir: /builds/slave/test/build/tests 12:32:29 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')]} 12:32:29 INFO - trying https://queue.taskcluster.net/v1/task/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.test_packages.json 12:32:29 INFO - Downloading https://queue.taskcluster.net/v1/task/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:32:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:32:30 INFO - Downloaded 989 bytes. 12:32:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:32:30 INFO - Using the following test package requirements: 12:32:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:32:30 INFO - u'common': [u'target.common.tests.zip'], 12:32:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:32:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:32:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:32:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:32:30 INFO - u'mozbase': [u'target.common.tests.zip'], 12:32:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:32:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:32:30 INFO - u'web-platform': [u'target.common.tests.zip', 12:32:30 INFO - u'target.web-platform.tests.tar.gz'], 12:32:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:32:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 12:32:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.common.tests.zip 12:32:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:32:30 INFO - Fetch https://queue.taskcluster.net/v1/task/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.common.tests.zip into memory 12:32:31 INFO - Content-Length response header: 55911698 12:32:31 INFO - Bytes received: 55911698 12:32:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.talos.tests.zip 12:32:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:32:42 INFO - Fetch https://queue.taskcluster.net/v1/task/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.talos.tests.zip into memory 12:32:42 INFO - Content-Length response header: 14522385 12:32:42 INFO - Bytes received: 14522385 12:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:43 INFO - trying https://queue.taskcluster.net/v1/task/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.tar.bz2 12:32:43 INFO - Downloading https://queue.taskcluster.net/v1/task/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:32:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:32:44 INFO - Downloaded 62392278 bytes. 12:32:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.tar.bz2 12:32:44 INFO - mkdir: /builds/slave/test/properties 12:32:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:32:44 INFO - Writing to file /builds/slave/test/properties/build_url 12:32:44 INFO - Contents: 12:32:44 INFO - build_url:https://queue.taskcluster.net/v1/task/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.tar.bz2 12:32:44 INFO - Running post-action listener: _resource_record_post_action 12:32:44 INFO - Running post-action listener: find_tests_for_verification 12:32:44 INFO - Running post-action listener: set_extra_try_arguments 12:32:44 INFO - [mozharness: 2017-09-30 19:32:44.875578Z] Finished download-and-extract step (success) 12:32:44 INFO - [mozharness: 2017-09-30 19:32:44.875680Z] Running populate-webroot step. 12:32:44 INFO - Running pre-action listener: _resource_record_pre_action 12:32:44 INFO - Running main action method: populate_webroot 12:32:44 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:32:44 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:32:44 INFO - 'tests': ['tresize', 12:32:44 INFO - 'tcanvasmark']}, 12:32:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:32:44 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:32:44 INFO - 'tests': ['dromaeo_css', 12:32:44 INFO - 'kraken']}, 12:32:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:32:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:32:44 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:32:44 INFO - 'talos_options': ['--disable-stylo'], 12:32:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:32:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:32:44 INFO - 'tests': ['damp', 'tps']}, 12:32:44 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:32:44 INFO - 'talos_options': ['--disable-stylo'], 12:32:44 INFO - 'tests': ['damp', 'tps']}, 12:32:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:32:44 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:32:44 INFO - 'tests': ['dromaeo_dom']}, 12:32:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:32:44 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:32:44 INFO - 'tests': ['basic_compositor_video', 12:32:44 INFO - 'glvideo']}, 12:32:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 12:32:44 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 12:32:44 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:32:44 INFO - 'talos_options': ['--disable-stylo'], 12:32:44 INFO - 'tests': ['ts_paint_webext', 12:32:44 INFO - 'tp5o_webext']}, 12:32:44 INFO - 'other-e10s': {'tests': ['a11yr', 12:32:44 INFO - 'ts_paint', 12:32:44 INFO - 'tpaint', 12:32:44 INFO - 'sessionrestore', 12:32:44 INFO - 'sessionrestore_many_windows', 12:32:44 INFO - 'sessionrestore_no_auto_restore', 12:32:44 INFO - 'tabpaint', 12:32:44 INFO - 'cpstartup']}, 12:32:44 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:32:44 INFO - 'tests': ['a11yr', 12:32:44 INFO - 'ts_paint', 12:32:44 INFO - 'tpaint', 12:32:44 INFO - 'sessionrestore', 12:32:44 INFO - 'sessionrestore_many_windows', 12:32:44 INFO - 'sessionrestore_no_auto_restore', 12:32:44 INFO - 'tabpaint', 12:32:44 INFO - 'cpstartup']}, 12:32:44 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 12:32:44 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 12:32:44 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:32:44 INFO - 'tests': ['perf_reftest_singletons']}, 12:32:44 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:32:44 INFO - 'tests': ['perf_reftest']}, 12:32:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:32:44 INFO - 'tsvgr_opacity', 12:32:44 INFO - 'tart', 12:32:44 INFO - 'tscrollx', 12:32:44 INFO - 'tsvg_static']}, 12:32:44 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 12:32:44 INFO - 'tests': ['tsvgx', 12:32:44 INFO - 'tsvgr_opacity', 12:32:44 INFO - 'tart', 12:32:44 INFO - 'tscrollx', 12:32:44 INFO - 'tsvg_static']}, 12:32:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:32:44 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:32:44 INFO - 'talos_options': ['--disable-stylo'], 12:32:44 INFO - 'tests': ['tp5o']}, 12:32:44 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:32:44 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:32:44 INFO - 'talos_options': ['--mitmproxy', 12:32:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:32:44 INFO - '--firstNonBlankPaint'], 12:32:44 INFO - 'tests': ['tp6_google', 12:32:44 INFO - 'tp6_youtube', 12:32:44 INFO - 'tp6_amazon', 12:32:44 INFO - 'tp6_facebook']}, 12:32:44 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:32:44 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:32:44 INFO - 'talos_options': ['--disable-stylo', 12:32:44 INFO - '--mitmproxy', 12:32:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:32:44 INFO - '--firstNonBlankPaint'], 12:32:44 INFO - 'tests': ['tp6_google', 12:32:44 INFO - 'tp6_youtube', 12:32:44 INFO - 'tp6_amazon', 12:32:44 INFO - 'tp6_facebook']}, 12:32:44 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 12:32:44 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 12:32:44 INFO - 'talos_options': ['--stylo-threads=1', 12:32:44 INFO - '--mitmproxy', 12:32:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 12:32:44 INFO - '--firstNonBlankPaint'], 12:32:44 INFO - 'tests': ['tp6_google', 12:32:44 INFO - 'tp6_youtube', 12:32:44 INFO - 'tp6_amazon', 12:32:44 INFO - 'tp6_facebook']}, 12:32:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:32:44 INFO - 'talos_options': ['--xperf_path', 12:32:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:32:44 INFO - 'tests': ['tp5n']}, 12:32:44 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 12:32:44 INFO - 'talos_options': ['--disable-stylo', 12:32:44 INFO - '--xperf_path', 12:32:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:32:44 INFO - 'tests': ['tp5n']}}} 12:32:44 INFO - Running post-action listener: _resource_record_post_action 12:32:44 INFO - [mozharness: 2017-09-30 19:32:44.893940Z] Finished populate-webroot step (success) 12:32:44 INFO - [mozharness: 2017-09-30 19:32:44.894030Z] Running create-virtualenv step. 12:32:44 INFO - Running pre-action listener: _resource_record_pre_action 12:32:44 INFO - Running main action method: create_virtualenv 12:32:44 INFO - Creating virtualenv /builds/slave/test/build/venv 12:32:44 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:32:44 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 12:32:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 12:32:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:32:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:32:45 INFO - Installing distribute.............................................................................................................................................................................................done. 12:32:45 INFO - Installing pip...............done. 12:32:45 INFO - Return code: 0 12:32:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:32:45 INFO - Reading from file tmpfile_stdout 12:32:45 INFO - Output received: 12:32:45 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 12:32:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548d60>, '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 0x2549a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549ef0>, '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': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', '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 12:32:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:32:45 INFO - Using env: {'DISPLAY': ':0', 12:32:45 INFO - 'HOME': '/home/cltbld', 12:32:45 INFO - 'LANG': 'en_US.UTF-8', 12:32:45 INFO - 'LANGUAGE': 'en_US:en', 12:32:45 INFO - 'LOGNAME': 'cltbld', 12:32:45 INFO - 'MAIL': '/var/mail/cltbld', 12:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:45 INFO - 'MOZ_NO_REMOTE': '1', 12:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:45 INFO - 'NO_EM_RESTART': '1', 12:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:45 INFO - 'PWD': '/builds/slave/test', 12:32:45 INFO - 'SHELL': '/bin/bash', 12:32:45 INFO - 'SHLVL': '1', 12:32:45 INFO - 'TERM': 'linux', 12:32:45 INFO - 'TMOUT': '86400', 12:32:45 INFO - 'USER': 'cltbld', 12:32:45 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', 12:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:45 INFO - '_': '/tools/buildbot/bin/python'} 12:32:47 INFO - Ignoring indexes: http://pypi.python.org/simple/ 12:32:47 INFO - Downloading/unpacking pip>=1.5 12:32:47 INFO - Running setup.py egg_info for package pip 12:32:47 INFO - warning: no files found matching 'pip/cacert.pem' 12:32:47 INFO - warning: no files found matching '*.html' under directory 'docs' 12:32:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:32:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:32:47 INFO - Installing collected packages: pip 12:32:47 INFO - Found existing installation: pip 1.1 12:32:47 INFO - Uninstalling pip: 12:32:47 INFO - Successfully uninstalled pip 12:32:47 INFO - Running setup.py install for pip 12:32:47 INFO - warning: no files found matching 'pip/cacert.pem' 12:32:47 INFO - warning: no files found matching '*.html' under directory 'docs' 12:32:47 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 12:32:47 INFO - no previously-included directories found matching 'docs/_build/_sources' 12:32:47 INFO - Installing pip script to /builds/slave/test/build/venv/bin 12:32:47 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 12:32:47 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 12:32:47 INFO - Successfully installed pip 12:32:47 INFO - Cleaning up... 12:32:47 INFO - Return code: 0 12:32:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:32:47 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')]} 12:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:47 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')]} 12:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:47 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 0x21de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548d60>, '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 0x2549a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549ef0>, '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': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', '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 12:32:47 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 12:32:47 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 12:32:47 INFO - Using env: {'DISPLAY': ':0', 12:32:47 INFO - 'HOME': '/home/cltbld', 12:32:47 INFO - 'LANG': 'en_US.UTF-8', 12:32:47 INFO - 'LANGUAGE': 'en_US:en', 12:32:47 INFO - 'LOGNAME': 'cltbld', 12:32:47 INFO - 'MAIL': '/var/mail/cltbld', 12:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:47 INFO - 'MOZ_NO_REMOTE': '1', 12:32:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:47 INFO - 'NO_EM_RESTART': '1', 12:32:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:47 INFO - 'PWD': '/builds/slave/test', 12:32:47 INFO - 'SHELL': '/bin/bash', 12:32:47 INFO - 'SHLVL': '1', 12:32:47 INFO - 'TERM': 'linux', 12:32:47 INFO - 'TMOUT': '86400', 12:32:47 INFO - 'USER': 'cltbld', 12:32:47 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', 12:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:47 INFO - '_': '/tools/buildbot/bin/python'} 12:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:47 INFO - Downloading/unpacking psutil>=3.1.1 12:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:32:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:32:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:32:48 INFO - Installing collected packages: psutil 12:32:48 INFO - Running setup.py install for psutil 12:32:48 INFO - building 'psutil._psutil_linux' extension 12:32:48 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 12:32:49 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 12:32:49 INFO - building 'psutil._psutil_posix' extension 12:32:49 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 12:32:49 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 12:32:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:32:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:32:49 INFO - Successfully installed psutil 12:32:49 INFO - Cleaning up... 12:32:49 INFO - Return code: 0 12:32:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:32:49 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')]} 12:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:49 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')]} 12:32:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:49 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 0x21de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548d60>, '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 0x2549a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549ef0>, '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': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', '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 12:32:49 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 12:32:49 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 12:32:49 INFO - Using env: {'DISPLAY': ':0', 12:32:49 INFO - 'HOME': '/home/cltbld', 12:32:49 INFO - 'LANG': 'en_US.UTF-8', 12:32:49 INFO - 'LANGUAGE': 'en_US:en', 12:32:49 INFO - 'LOGNAME': 'cltbld', 12:32:49 INFO - 'MAIL': '/var/mail/cltbld', 12:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:49 INFO - 'MOZ_NO_REMOTE': '1', 12:32:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:49 INFO - 'NO_EM_RESTART': '1', 12:32:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:49 INFO - 'PWD': '/builds/slave/test', 12:32:49 INFO - 'SHELL': '/bin/bash', 12:32:49 INFO - 'SHLVL': '1', 12:32:49 INFO - 'TERM': 'linux', 12:32:49 INFO - 'TMOUT': '86400', 12:32:49 INFO - 'USER': 'cltbld', 12:32:49 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', 12:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:49 INFO - '_': '/tools/buildbot/bin/python'} 12:32:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:32:51 INFO - Installing collected packages: mozsystemmonitor 12:32:51 INFO - Running setup.py install for mozsystemmonitor 12:32:52 INFO - Successfully installed mozsystemmonitor 12:32:52 INFO - Cleaning up... 12:32:53 INFO - Return code: 0 12:32:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:32:53 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')]} 12:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:53 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')]} 12:32:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:53 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 0x21de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548d60>, '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 0x2549a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549ef0>, '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': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', '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 12:32:53 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 12:32:53 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 12:32:53 INFO - Using env: {'DISPLAY': ':0', 12:32:53 INFO - 'HOME': '/home/cltbld', 12:32:53 INFO - 'LANG': 'en_US.UTF-8', 12:32:53 INFO - 'LANGUAGE': 'en_US:en', 12:32:53 INFO - 'LOGNAME': 'cltbld', 12:32:53 INFO - 'MAIL': '/var/mail/cltbld', 12:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:53 INFO - 'MOZ_NO_REMOTE': '1', 12:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:53 INFO - 'NO_EM_RESTART': '1', 12:32:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:53 INFO - 'PWD': '/builds/slave/test', 12:32:53 INFO - 'SHELL': '/bin/bash', 12:32:53 INFO - 'SHLVL': '1', 12:32:53 INFO - 'TERM': 'linux', 12:32:53 INFO - 'TMOUT': '86400', 12:32:53 INFO - 'USER': 'cltbld', 12:32:53 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', 12:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:53 INFO - '_': '/tools/buildbot/bin/python'} 12:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:54 INFO - Downloading/unpacking jsonschema==2.5.1 12:32:54 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 12:32:54 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 12:32:54 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 12:32:54 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 12:32:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:32:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:32:55 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 12:32:55 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 12:32:55 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 12:32:55 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 12:32:55 INFO - Downloading functools32-3.2.3-2.tar.gz 12:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:32:55 INFO - warning: no files found matching '*.txt' 12:32:55 INFO - no previously-included directories found matching 'build' 12:32:55 INFO - no previously-included directories found matching 'dist' 12:32:55 INFO - no previously-included directories found matching '.git*' 12:32:55 INFO - Installing collected packages: jsonschema, functools32 12:32:55 INFO - Running setup.py install for functools32 12:32:55 INFO - warning: no files found matching '*.txt' 12:32:55 INFO - no previously-included directories found matching 'build' 12:32:55 INFO - no previously-included directories found matching 'dist' 12:32:55 INFO - no previously-included directories found matching '.git*' 12:32:55 INFO - Successfully installed jsonschema functools32 12:32:55 INFO - Cleaning up... 12:32:55 INFO - Return code: 0 12:32:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:32:55 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')]} 12:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:55 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')]} 12:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x21de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548d60>, '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 0x2549a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549ef0>, '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': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', '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 12:32:55 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 12:32:55 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 12:32:55 INFO - Using env: {'DISPLAY': ':0', 12:32:55 INFO - 'HOME': '/home/cltbld', 12:32:55 INFO - 'LANG': 'en_US.UTF-8', 12:32:55 INFO - 'LANGUAGE': 'en_US:en', 12:32:55 INFO - 'LOGNAME': 'cltbld', 12:32:55 INFO - 'MAIL': '/var/mail/cltbld', 12:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:55 INFO - 'MOZ_NO_REMOTE': '1', 12:32:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:55 INFO - 'NO_EM_RESTART': '1', 12:32:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:55 INFO - 'PWD': '/builds/slave/test', 12:32:55 INFO - 'SHELL': '/bin/bash', 12:32:55 INFO - 'SHLVL': '1', 12:32:55 INFO - 'TERM': 'linux', 12:32:55 INFO - 'TMOUT': '86400', 12:32:55 INFO - 'USER': 'cltbld', 12:32:55 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', 12:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:55 INFO - '_': '/tools/buildbot/bin/python'} 12:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:32:56 INFO - Cleaning up... 12:32:56 INFO - Return code: 0 12:32:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:32:56 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')]} 12:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:56 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')]} 12:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x21de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548d60>, '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 0x2549a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549ef0>, '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': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', '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 12:32:56 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 12:32:56 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 12:32:56 INFO - Using env: {'DISPLAY': ':0', 12:32:56 INFO - 'HOME': '/home/cltbld', 12:32:56 INFO - 'LANG': 'en_US.UTF-8', 12:32:56 INFO - 'LANGUAGE': 'en_US:en', 12:32:56 INFO - 'LOGNAME': 'cltbld', 12:32:56 INFO - 'MAIL': '/var/mail/cltbld', 12:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:56 INFO - 'MOZ_NO_REMOTE': '1', 12:32:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:56 INFO - 'NO_EM_RESTART': '1', 12:32:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:56 INFO - 'PWD': '/builds/slave/test', 12:32:56 INFO - 'SHELL': '/bin/bash', 12:32:56 INFO - 'SHLVL': '1', 12:32:56 INFO - 'TERM': 'linux', 12:32:56 INFO - 'TMOUT': '86400', 12:32:56 INFO - 'USER': 'cltbld', 12:32:56 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', 12:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:56 INFO - '_': '/tools/buildbot/bin/python'} 12:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:56 INFO - Downloading/unpacking blobuploader==1.2.4 12:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:57 INFO - Downloading blobuploader-1.2.4.tar.gz 12:32:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:32:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:32:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:32:58 INFO - Downloading docopt-0.6.1.tar.gz 12:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:32:58 INFO - Installing collected packages: blobuploader, requests, docopt 12:32:58 INFO - Running setup.py install for blobuploader 12:32:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:32:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:32:58 INFO - Running setup.py install for requests 12:32:58 INFO - Running setup.py install for docopt 12:32:58 INFO - Successfully installed blobuploader requests docopt 12:32:58 INFO - Cleaning up... 12:32:58 INFO - Return code: 0 12:32:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:32:58 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')]} 12:32:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:32:58 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')]} 12:32:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:32:58 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 0x21de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548d60>, '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 0x2549a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549ef0>, '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': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', '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 12:32:58 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 12:32:58 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 12:32:58 INFO - Using env: {'DISPLAY': ':0', 12:32:58 INFO - 'HOME': '/home/cltbld', 12:32:58 INFO - 'LANG': 'en_US.UTF-8', 12:32:58 INFO - 'LANGUAGE': 'en_US:en', 12:32:58 INFO - 'LOGNAME': 'cltbld', 12:32:58 INFO - 'MAIL': '/var/mail/cltbld', 12:32:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:32:58 INFO - 'MOZ_NO_REMOTE': '1', 12:32:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:32:58 INFO - 'NO_EM_RESTART': '1', 12:32:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:32:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:32:58 INFO - 'PWD': '/builds/slave/test', 12:32:58 INFO - 'SHELL': '/bin/bash', 12:32:58 INFO - 'SHLVL': '1', 12:32:58 INFO - 'TERM': 'linux', 12:32:58 INFO - 'TMOUT': '86400', 12:32:58 INFO - 'USER': 'cltbld', 12:32:58 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', 12:32:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:32:58 INFO - '_': '/tools/buildbot/bin/python'} 12:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:32:58 INFO - Running setup.py (path:/tmp/pip-Lr5Ic2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:32:58 INFO - Running setup.py (path:/tmp/pip-DpgtJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:32:59 INFO - Running setup.py (path:/tmp/pip-diADUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:32:59 INFO - Running setup.py (path:/tmp/pip-LKIrbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:32:59 INFO - Running setup.py (path:/tmp/pip-0gKkDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:32:59 INFO - Running setup.py (path:/tmp/pip-UBONr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:32:59 INFO - Running setup.py (path:/tmp/pip-NCj6R8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:32:59 INFO - Running setup.py (path:/tmp/pip-umo7tD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:32:59 INFO - Running setup.py (path:/tmp/pip-9ZR27X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:32:59 INFO - Running setup.py (path:/tmp/pip-ztjqZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:32:59 INFO - Running setup.py (path:/tmp/pip-z9se7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:32:59 INFO - Running setup.py (path:/tmp/pip-hpjoBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:32:59 INFO - Running setup.py (path:/tmp/pip-v3827c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:32:59 INFO - Running setup.py (path:/tmp/pip-s8K9ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:32:59 INFO - Running setup.py (path:/tmp/pip-gyvSYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:32:59 INFO - Running setup.py (path:/tmp/pip-VjVpOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:33:00 INFO - Running setup.py (path:/tmp/pip-jEaX6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:33:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:33:00 INFO - Running setup.py install for manifestparser 12:33:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:33:00 INFO - Running setup.py install for mozcrash 12:33:00 INFO - Running setup.py install for mozdebug 12:33:00 INFO - Running setup.py install for mozdevice 12:33:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:33:00 INFO - Running setup.py install for mozfile 12:33:00 INFO - Running setup.py install for mozhttpd 12:33:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:33:00 INFO - Running setup.py install for mozinfo 12:33:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:33:00 INFO - Running setup.py install for mozInstall 12:33:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:33:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:33:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:33:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:33:00 INFO - Running setup.py install for mozleak 12:33:00 INFO - Running setup.py install for mozlog 12:33:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:33:01 INFO - Running setup.py install for moznetwork 12:33:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:33:01 INFO - Running setup.py install for mozprocess 12:33:01 INFO - Running setup.py install for mozprofile 12:33:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:33:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:33:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:33:01 INFO - Running setup.py install for mozrunner 12:33:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:33:01 INFO - Running setup.py install for mozscreenshot 12:33:01 INFO - Running setup.py install for moztest 12:33:01 INFO - Running setup.py install for mozversion 12:33:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:33:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:33:01 INFO - Cleaning up... 12:33:01 INFO - Return code: 0 12:33:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:33:01 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')]} 12:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:01 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')]} 12:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:01 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 0x21de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548d60>, '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 0x2549a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549ef0>, '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': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', '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 12:33:01 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 12:33:01 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 12:33:01 INFO - Using env: {'DISPLAY': ':0', 12:33:01 INFO - 'HOME': '/home/cltbld', 12:33:01 INFO - 'LANG': 'en_US.UTF-8', 12:33:01 INFO - 'LANGUAGE': 'en_US:en', 12:33:01 INFO - 'LOGNAME': 'cltbld', 12:33:01 INFO - 'MAIL': '/var/mail/cltbld', 12:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:01 INFO - 'MOZ_NO_REMOTE': '1', 12:33:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:01 INFO - 'NO_EM_RESTART': '1', 12:33:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:01 INFO - 'PWD': '/builds/slave/test', 12:33:01 INFO - 'SHELL': '/bin/bash', 12:33:01 INFO - 'SHLVL': '1', 12:33:01 INFO - 'TERM': 'linux', 12:33:01 INFO - 'TMOUT': '86400', 12:33:01 INFO - 'USER': 'cltbld', 12:33:01 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', 12:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:01 INFO - '_': '/tools/buildbot/bin/python'} 12:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:33:02 INFO - Running setup.py (path:/tmp/pip-W3pTcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:33:02 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)) 12:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:33:02 INFO - Running setup.py (path:/tmp/pip-SUuJIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:33:02 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)) 12:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:33:02 INFO - Running setup.py (path:/tmp/pip-TJZale-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:33:02 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)) 12:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:33:02 INFO - Running setup.py (path:/tmp/pip-hTRtBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:33:02 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)) 12:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:33:02 INFO - Running setup.py (path:/tmp/pip-JfIabD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:33:02 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)) 12:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:33:02 INFO - Running setup.py (path:/tmp/pip-0LiORZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:33:02 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)) 12:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:33:02 INFO - Running setup.py (path:/tmp/pip-C1626P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:33:02 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)) 12:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:33:02 INFO - Running setup.py (path:/tmp/pip-PdqENk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:33:02 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)) 12:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:33:02 INFO - Running setup.py (path:/tmp/pip-28XYS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:33:02 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)) 12:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:33:02 INFO - Running setup.py (path:/tmp/pip-7NRG_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:33:02 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)) 12:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:33:02 INFO - Running setup.py (path:/tmp/pip-qLcT4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:33:02 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)) 12:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:33:02 INFO - Running setup.py (path:/tmp/pip-0tCcUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:33:02 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)) 12:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:33:02 INFO - Running setup.py (path:/tmp/pip-Yq7Bza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:33:03 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)) 12:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:33:03 INFO - Running setup.py (path:/tmp/pip-MTyVqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:33:03 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)) 12:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:33:03 INFO - Running setup.py (path:/tmp/pip-SIC2Um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:33:03 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)) 12:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:33:03 INFO - Running setup.py (path:/tmp/pip-HCxlY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:33:03 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)) 12:33:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:33:03 INFO - Running setup.py (path:/tmp/pip-NorN_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:33:03 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)) 12:33:03 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)) 12:33:03 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)) 12:33:03 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)) 12:33:03 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)) 12:33:03 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)) 12:33:03 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)) 12:33:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:33:03 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 12:33:03 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 12:33:03 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 12:33:03 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 12:33:04 INFO - Downloading blessings-1.6.tar.gz 12:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:33:04 INFO - Installing collected packages: blessings 12:33:04 INFO - Running setup.py install for blessings 12:33:04 INFO - Successfully installed blessings 12:33:04 INFO - Cleaning up... 12:33:04 INFO - Return code: 0 12:33:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:33:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:33:04 INFO - Reading from file tmpfile_stdout 12:33:04 INFO - Current package versions: 12:33:04 INFO - argparse == 1.2.1 12:33:04 INFO - blessings == 1.6 12:33:04 INFO - blobuploader == 1.2.4 12:33:04 INFO - docopt == 0.6.1 12:33:04 INFO - functools32 == 3.2.3-2 12:33:04 INFO - jsonschema == 2.5.1 12:33:04 INFO - manifestparser == 1.1 12:33:04 INFO - mozInstall == 1.13 12:33:04 INFO - mozcrash == 1.0 12:33:04 INFO - mozdebug == 0.1 12:33:04 INFO - mozdevice == 0.51 12:33:04 INFO - mozfile == 1.2 12:33:04 INFO - mozhttpd == 0.7 12:33:04 INFO - mozinfo == 0.10 12:33:04 INFO - mozleak == 0.1 12:33:04 INFO - mozlog == 3.5 12:33:04 INFO - moznetwork == 0.27 12:33:04 INFO - mozprocess == 0.25 12:33:04 INFO - mozprofile == 0.28 12:33:04 INFO - mozrunner == 6.13 12:33:04 INFO - mozscreenshot == 0.1 12:33:04 INFO - mozsystemmonitor == 0.3 12:33:04 INFO - moztest == 0.8 12:33:04 INFO - mozversion == 1.4 12:33:04 INFO - psutil == 3.1.1 12:33:04 INFO - requests == 1.2.3 12:33:04 INFO - wsgiref == 0.1.2 12:33:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:33:04 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')]} 12:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:04 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')]} 12:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:04 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 0x21de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548d60>, '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 0x2549a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549ef0>, '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': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', '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 12:33:04 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 12:33:04 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 12:33:04 INFO - Using env: {'DISPLAY': ':0', 12:33:04 INFO - 'HOME': '/home/cltbld', 12:33:04 INFO - 'LANG': 'en_US.UTF-8', 12:33:04 INFO - 'LANGUAGE': 'en_US:en', 12:33:04 INFO - 'LOGNAME': 'cltbld', 12:33:04 INFO - 'MAIL': '/var/mail/cltbld', 12:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:04 INFO - 'MOZ_NO_REMOTE': '1', 12:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:04 INFO - 'NO_EM_RESTART': '1', 12:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:04 INFO - 'PWD': '/builds/slave/test', 12:33:04 INFO - 'SHELL': '/bin/bash', 12:33:04 INFO - 'SHLVL': '1', 12:33:04 INFO - 'TERM': 'linux', 12:33:04 INFO - 'TMOUT': '86400', 12:33:04 INFO - 'USER': 'cltbld', 12:33:04 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', 12:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:04 INFO - '_': '/tools/buildbot/bin/python'} 12:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:05 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)) 12:33:05 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)) 12:33:05 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)) 12:33:05 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)) 12:33:05 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)) 12:33:05 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)) 12:33:05 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)) 12:33:05 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)) 12:33:05 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)) 12:33:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 12:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:33:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 12:33:06 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)) 12:33:06 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)) 12:33:06 INFO - Installing collected packages: simplejson 12:33:06 INFO - Running setup.py install for simplejson 12:33:06 INFO - building 'simplejson._speedups' extension 12:33:06 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 12:33:07 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 12:33:07 INFO - Successfully installed simplejson 12:33:07 INFO - Cleaning up... 12:33:07 INFO - Return code: 0 12:33:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:33:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:33:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:33:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21de1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x254b9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2548d60>, '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 0x2549a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549ef0>, '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': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', '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 12:33:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:33:07 INFO - Using env: {'DISPLAY': ':0', 12:33:07 INFO - 'HOME': '/home/cltbld', 12:33:07 INFO - 'LANG': 'en_US.UTF-8', 12:33:07 INFO - 'LANGUAGE': 'en_US:en', 12:33:07 INFO - 'LOGNAME': 'cltbld', 12:33:07 INFO - 'MAIL': '/var/mail/cltbld', 12:33:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:07 INFO - 'MOZ_NO_REMOTE': '1', 12:33:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:07 INFO - 'NO_EM_RESTART': '1', 12:33:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:07 INFO - 'PWD': '/builds/slave/test', 12:33:07 INFO - 'SHELL': '/bin/bash', 12:33:07 INFO - 'SHLVL': '1', 12:33:07 INFO - 'TERM': 'linux', 12:33:07 INFO - 'TMOUT': '86400', 12:33:07 INFO - 'USER': 'cltbld', 12:33:07 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', 12:33:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:07 INFO - '_': '/tools/buildbot/bin/python'} 12:33:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:33:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:33:07 INFO - Cleaning up... 12:33:07 INFO - Return code: 0 12:33:07 INFO - Running post-action listener: _resource_record_post_action 12:33:07 INFO - Running post-action listener: _start_resource_monitoring 12:33:07 INFO - Starting resource monitoring. 12:33:07 INFO - [mozharness: 2017-09-30 19:33:07.591599Z] Finished create-virtualenv step (success) 12:33:07 INFO - [mozharness: 2017-09-30 19:33:07.592075Z] Running install step. 12:33:07 INFO - Running pre-action listener: _resource_record_pre_action 12:33:07 INFO - Running main action method: install 12:33:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:33:07 INFO - Reading from file tmpfile_stdout 12:33:07 INFO - Detecting whether we're running mozinstall >=1.0... 12:33:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:33:07 INFO - Reading from file tmpfile_stdout 12:33:07 INFO - Output received: 12:33:07 INFO - Usage: mozinstall [options] installer 12:33:07 INFO - Options: 12:33:07 INFO - -h, --help show this help message and exit 12:33:07 INFO - -d DEST, --destination=DEST 12:33:07 INFO - Directory to install application into. [default: 12:33:07 INFO - "/builds/slave/test"] 12:33:07 INFO - --app=APP Application being installed. [default: firefox] 12:33:07 INFO - mkdir: /builds/slave/test/build/application 12:33:07 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'] 12:33:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:33:25 INFO - Reading from file tmpfile_stdout 12:33:25 INFO - Output received: 12:33:25 INFO - /builds/slave/test/build/application/firefox/firefox 12:33:25 INFO - Running post-action listener: _resource_record_post_action 12:33:25 INFO - [mozharness: 2017-09-30 19:33:25.589357Z] Finished install step (success) 12:33:25 INFO - [mozharness: 2017-09-30 19:33:25.589609Z] Running setup-mitmproxy step. 12:33:25 INFO - Running pre-action listener: _resource_record_pre_action 12:33:25 INFO - Running main action method: setup_mitmproxy 12:33:25 INFO - Skipping: mitmproxy is not required 12:33:25 INFO - Running post-action listener: _resource_record_post_action 12:33:25 INFO - [mozharness: 2017-09-30 19:33:25.590741Z] Finished setup-mitmproxy step (success) 12:33:25 INFO - [mozharness: 2017-09-30 19:33:25.590977Z] Running run-tests step. 12:33:25 INFO - Running pre-action listener: _resource_record_pre_action 12:33:25 INFO - Running pre-action listener: _set_gcov_prefix 12:33:25 INFO - Running main action method: run_tests 12:33:25 WARNING - Try message not found. 12:33:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:33:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:33:25 INFO - Python 2.7.3 12:33:25 INFO - Return code: 0 12:33:25 INFO - grabbing minidump binary from tooltool 12:33: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')]} 12:33:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x2548d60>, '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 0x2549a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2549ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:33:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 12:33:25 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:33:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 12:33:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:33:25 INFO - Return code: 0 12:33:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:33:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:33:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:33:25 INFO - ENV: RUST_BACKTRACE is now full 12:33:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:33:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:33:25 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/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--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 12:33:25 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/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-080 --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 12:33:25 INFO - Using env: {'DISPLAY': ':0', 12:33:25 INFO - 'HOME': '/home/cltbld', 12:33:25 INFO - 'LANG': 'en_US.UTF-8', 12:33:25 INFO - 'LANGUAGE': 'en_US:en', 12:33:25 INFO - 'LOGNAME': 'cltbld', 12:33:25 INFO - 'MAIL': '/var/mail/cltbld', 12:33:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:33:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:25 INFO - 'MOZ_NO_REMOTE': '1', 12:33:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:25 INFO - 'NO_EM_RESTART': '1', 12:33:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:25 INFO - 'PWD': '/builds/slave/test', 12:33:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:33:25 INFO - 'RUST_BACKTRACE': 'full', 12:33:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:33:25 INFO - 'SHELL': '/bin/bash', 12:33:25 INFO - 'SHLVL': '1', 12:33:25 INFO - 'TERM': 'linux', 12:33:25 INFO - 'TMOUT': '86400', 12:33:25 INFO - 'USER': 'cltbld', 12:33:25 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', 12:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:25 INFO - '_': '/tools/buildbot/bin/python'} 12:33:25 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/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--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 12:33:25 INFO - mozversion application_buildid: 20170930180320 12:33:25 INFO - mozversion application_changeset: 8873432294c4ae1431357410497676fbd3e1f855 12:33:25 INFO - mozversion application_display_name: Nightly 12:33:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:33:25 INFO - mozversion application_name: Firefox 12:33:25 INFO - mozversion application_remotingname: firefox 12:33:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:33:25 INFO - mozversion application_vendor: Mozilla 12:33:25 INFO - mozversion application_version: 58.0a1 12:33:25 INFO - mozversion platform_buildid: 20170930180320 12:33:25 INFO - mozversion platform_changeset: 8873432294c4ae1431357410497676fbd3e1f855 12:33:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:33:25 INFO - mozversion platform_version: 58.0a1 12:33:25 INFO - using testdate: 1506800005 12:33:25 INFO - actual date: 1506800005 12:33:25 INFO - starting webserver on 'localhost:60633' 12:33:25 INFO - SUITE-START | Running 2 tests 12:33:25 INFO - TEST-START | dromaeo_css 12:33:25 INFO - Initialising browser for dromaeo_css test... 12:33:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60633/getInfo.html -profile /tmp/tmpqHKV7q/profile 12:33:25 INFO - TEST-INFO | started process 21827 (/builds/slave/test/build/application/firefox/firefox http://localhost:60633/getInfo.html) 12:33:31 INFO - TEST-INFO | 21827: exit 0 12:33:31 INFO - Browser initialized. 12:33:31 INFO - Running cycle 1/1 for dromaeo_css test... 12:33:31 INFO - Using env: {'DISPLAY': ':0', 12:33:31 INFO - 'HOME': '/home/cltbld', 12:33:31 INFO - 'JSGC_DISABLE_POISONING': '1', 12:33:31 INFO - 'LANG': 'en_US.UTF-8', 12:33:31 INFO - 'LANGUAGE': 'en_US:en', 12:33:31 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:33:31 INFO - 'LOGNAME': 'cltbld', 12:33:31 INFO - 'MAIL': '/var/mail/cltbld', 12:33:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:33:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:33:31 INFO - 'MOZ_CRASHREPORTER': '1', 12:33:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:33:31 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:33:31 INFO - 'MOZ_NO_REMOTE': '1', 12:33:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:33:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:33:31 INFO - 'NO_EM_RESTART': '1', 12:33:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:33:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:33:31 INFO - 'PWD': '/builds/slave/test', 12:33:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:33:31 INFO - 'RUST_BACKTRACE': 'full', 12:33:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:33:31 INFO - 'SHELL': '/bin/bash', 12:33:31 INFO - 'SHLVL': '1', 12:33:31 INFO - 'TERM': 'linux', 12:33:31 INFO - 'TMOUT': '86400', 12:33:31 INFO - 'USER': 'cltbld', 12:33:31 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', 12:33:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:33:31 INFO - '_': '/tools/buildbot/bin/python'} 12:33:31 INFO - TEST-INFO | started process 22066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqHKV7q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:33:32 INFO - PID 22066 | 12:33:32 INFO - PID 22066 | (/builds/slave/test/build/application/firefox/firefox:22115): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:33:32 INFO - PID 22066 | 12:33:43 INFO - PID 22066 | RSS: Main: 144523264 12:33:43 INFO - PID 22066 | 12:36:39 INFO - PID 22066 | Cycle 1(1): loaded http://localhost:60633/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60633/tests/dromaeo/cssquery-ext.html) 12:36:40 INFO - PID 22066 | RSS: Main: 143122432 12:36:40 INFO - PID 22066 | 12:39:42 INFO - PID 22066 | Cycle 1(1): loaded http://localhost:60633/tests/dromaeo/cssquery-ext.html (next: http://localhost:60633/tests/dromaeo/cssquery-jquery.html) 12:39:43 INFO - PID 22066 | RSS: Main: 143609856 12:39:43 INFO - PID 22066 | 12:42:44 INFO - PID 22066 | Cycle 1(1): loaded http://localhost:60633/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60633/tests/dromaeo/cssquery-mootools.html) 12:42:45 INFO - PID 22066 | RSS: Main: 144609280 12:42:45 INFO - PID 22066 | 12:45:46 INFO - PID 22066 | Cycle 1(1): loaded http://localhost:60633/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60633/tests/dromaeo/cssquery-prototype.html) 12:45:47 INFO - PID 22066 | RSS: Main: 144752640 12:45:47 INFO - PID 22066 | 12:48:50 INFO - PID 22066 | Cycle 1(1): loaded http://localhost:60633/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60633/tests/dromaeo/cssquery-yui.html) 12:48:51 INFO - PID 22066 | RSS: Main: 147546112 12:48:51 INFO - PID 22066 | 12:51:52 INFO - PID 22066 | Cycle 1(1): loaded http://localhost:60633/tests/dromaeo/cssquery-yui.html (next: http://localhost:60633/tests/dromaeo/cssquery-dojo.html) 12:51:52 INFO - PID 22066 | RSS: Main: 149049344 12:51:52 INFO - PID 22066 | 12:51:52 INFO - PID 22066 | __start_tp_report 12:51:52 INFO - PID 22066 | _x_x_mozilla_page_load 12:51:52 INFO - PID 22066 | _x_x_mozilla_page_load_details 12:51:52 INFO - PID 22066 | |i|pagename|runs| 12:51:52 INFO - PID 22066 | |0;dojo.html;3889.027743064234;3917.157811070619;3926.0577461409252;3928.3518219493776;3946.3291240489116;6288.308286088532;6321.431071203602;6334.081558174062;6395.904061439082;6428.32502587228;6372.076048972896;6374.139491168691;6441.549091563593;6477.740890364392;6491.12369830074;5697.971510142444;5814.534837213034;5817.069268916975;5821.097729851858;5844.386339434362;103.24171650362878;5450.5367043801325;5700.173474846145;5729.312482502106;5793.275840519935;5676.744546495418;5679.659220446786;5693.686847223401;5737.082066869322;5754.079347304432;5630.380658127603;5683.658980461186;5730.971345143289;5783.884322313572;5804.448577385142;5639.2668953036255;5679.006173919547;5697.544196464314;5715.714214289311;5752.8849423011725;6284.717187726564;6289.371062893674;6329.715162817684;6361.173047503795;6368.363163683641;6723.193216814014;6735.831604209934;6759.695813688396;6851.931480685179;6864.313568643096;6892.517523773338;6918.342757438086;6936;6949.44404447643;6961.79114626562;6379.585326953733;6440.162778838721;6458.38645328693;6464.127342808754;6466.708998095097;7053.365197132282;7107;7152.928470715278;7157.141143062866;7175.748848790372;6701.832454188684;6737.191537015589;6774.83062923421;6776.830579235559;6865.5537390069485;6782.253952065367;6875.656217189121;6882;6883.174019117738;6886.8622627547165;6815.965920170367;6837.521373503807;6850.828729281709;6856.554323968926;6891.448684105259;6899.965500172467;6936.410405115622;6958.965205174043;6959.582425054513;6960.37356637905;4949.678270912379;4994.200927851526;5020.7740651670765;5060;5069.264956581275;4502.347159661831;4553.749543775058;4573.0396616710195;4578.473475550354;4591.724496530219;6269.62382257066;6333.46165575922;6351.110844481776;6354.237491500957;6354.523410744213;6914.274001229798;6978.825529361807;6995.825104372431;7001.754938577125;7008.684609192598;6305.243370795442;6306.65313407767;6398.552101352953;6402.263739669997;6402.551821372459;5460.208269800856;5510.366307874566;5574.554035677136;5582.637128586629;5613.915791263134;7164.820879478055;7192.4246060315045;7210.242924492957;7225.2774722528375;7225.674844632004;6864.853804963439;6865.794026179223;6937.653117344113;6961.965190174118;6969.9303006969285;7110.786676399716;7125.786226413215;7132.714691412285;7247;7255.020572222682;6691.0967019451755;6782.491313151435;6831.45348372139;6865.794026179223;6882.7591034313555;6915.619640919797;6941.2364639888565;6963.721451141898;6978.162620485574;6987.406070484066;6668.099806526251;6688.83277918056;6748.966255168692;6750.729970801113;6772.356626120511;6458.547901647027;6552.934470655423;6647.567908085959;6649.667516624246;6739.797806065826;6560.606363618198;6586;6590.143281373391;6591.373819487141;6638.037484564615;6698.56459330142;6734.124563806674;6751.088603038724;6826.522143449911;6832.453403727789;6433.613983161025;6515.511336649865;6526.379993900572;6610.735570577315;6618.205815302002 12:51:52 INFO - PID 22066 | |1;ext.html;948.2698322291835;951.9809603807928;982.5725809272966;1000.1948431512634;1001.9248556358275;43368.566314336844;44226.778866105626;44277.33583996243;44277.55722442774;44300.778496107516;41057.38413923793;41198.79400603;41201;41244.17511649765;41431;7500.474966752329;7616.466847320662;7619.276168763959;7620.390368770485;7620.961895190516;7558.130814956268;7560.395168386516;7628;7645.46481746278;7650.923490765077;8400.285975692073;8624.35317351198;8627.3098152148;8627.439216450943;8629.05080441151;8479.152084791502;8501;8538.914610853873;8545.97448306201;8572.657093716243;8305.709300174465;8395.076541580422;8448.535330556817;8451.492910425393;8457.407981441302;40308;40444;40734.185316293806;40829.795851020855;40831.387529187086;3741.8690345837763;3795.221979494197;3795.449659799341;3801.8479260829536;3803.391457366808;33112.33775324504;33406.49890251648;33480.665193347995;33482.3303533928;33751.156221094425;5404.297441332641;5414.566834653218;5460.453954604547;5460.5085542301385;5463.098588732894;222962;224593;224641;225017;225209;53240.73379633077;53311.46688533143;53336.73331633317;53344.73327633415;53407;55201.44798552043;55248.17127743087;55408.72295638496;55465.722671386386;55512;15696.686066278839;16024.679506409806;16027.599310017109;16045.59886002836;16057.357705691875;12729.172603780724;12744.490220391266;12770.80843787344;12772;12779.744405111845;15338.846611533965;15597.532074037797;15667.529974100795;15726;15729.370825167094;6008.639481631116;6052.606580572248;6070.726817293233;6138.355472675394;6265.592736472115;1083.5070043130356;1100.2078503477483;1101.5373543111752;1106.6679996001167;1111.6776134920945;25721.485570288864;25943.481130377666;26121.608175877376;26152.738472615412;26263.73736262613;1189.881011898803;1202.8436303280519;1206.6561030106377;1224.5958833584896;1236.1347057060093;13640.522581709592;13809;13876.444942202199;13932.30338483092;14015.748814859417;273258;274273;285008;287346;287657;49131.50868491341;49795.751021244665;57197;57680.423195768344;58090;1509.5169545745257;1516.5601975427003;1518.6658935034495;1522.9314680839389;1538.7999560057121;30095.699043010165;30303.242418938822;30602.540961885144;30858.845705771328;31021.224469388446;41741.58258417377;41835.372469412374;41899.371509426775;41955;41970;239471;239476;239996;240188;240262;35156.82421587978;35398.646013540565;35795;35969.100772480895;35977.46033809547;42915;44855.77572112249;44998.550014500746;45307;45331.773341133085;33709.32581348409;34223.657763422045;34277.14307142242;34291;34501.30997379988;34255.14362140966;34300;34461.48307775335;34599;34848;38683;39618.40572391359;39636.60363396329;39795.20409591734;40257.79871100626;32591.869533923218;33347.166320842174;33391.33217335591;33402;33793.83103084469;24857.10580654122;25120.874395627903;25150;25540.48919021572;26074.86962565175 12:51:52 INFO - PID 22066 | |2;jquery.html;599.6791716431707;621.5835390288506;632.6646877155108;633.3792882974685;637.6524793987277;22640.43398915028;23351.883240583815;24012.51974960502;24042.278731638056;24078.398040049007;25531.74468255317;26369.736302636968;26473.470530589377;26489.602655960178;26501.734982650167;6647.135872336589;6794.762183323584;6808.5914845109455;6846.726130954781;6846.965765171167;6479.64361960092;6746.494012949024;6778.186617605894;6780.321967803229;6785.1518560179975;6736.292689267605;6736.29268926763;6747.224069232027;6751.9662401688165;6758.797236082901;6612.07430959666;6887.173539175331;6892.448604111659;6894.207166175879;6914.688839002257;6425.357464253584;6428.678566071678;6430.196225471816;6434.388733070351;6439.388258115471;29044;29506.262343441373;29511.409771804443;29538.409231815243;29589.26026849346;2078.147959336665;2193.638049721794;2248.033345661365;2274.0676322707777;2276.5446910617775;20012;20673.276435324842;20685.68971465429;20704.378868633965;20707.8964605176;2540.136353639753;2547.783438407738;2608.321836322551;2652.9602055969176;2664.786817054631;137448.31275843555;142719.28640356733;148778;154969;155625;15983.561479466904;16111.355545778271;16201;16326.673466530841;16718.58203544921;25815.612765808528;26145.607815882777;26207.21378358652;26210.86894565553;26237.212883613523;10590.629327973484;10620.681379558626;10800.45997700112;10920.672379828618;10972.780544389227;9731.513424328756;9773.657921972697;9839.311248212556;9843.606255749834;9911.405315681082;9719.222462203006;9807.803843923224;9831.901680983241;9948.403095814274;10110.747231319276;2813.383553295455;2838.758705510055;2866.1226896382905;2926.341573146025;2930.721581449759;1043.89561043895;1075.1452595186845;1078.757279612081;1079.7408621930838;1082.3668154129764;21442;21576.892115539635;21621.027053782618;21650.891745541485;21704.674429883566;1111.6539216957017;1125.58915995661;1130.8756036835941;1135.4209353229912;1138.1463902073444;11506.654800356002;11571.479283432265;11762.94118529402;11816.527338906519;11820.468078936468;616254;620000;623777;631253;652341;128402;131064.344678276;134205.3289733545;135798.32100839433;135809;1145.7192987718063;1189.3636904256355;1232.1498166265249;1257.352463481308;1292.8299888600832;21613.783862161177;22104.66842997324;22336.994835232777;22341.771202584016;22395;62170.68914655398;62398.68800656149;62996;64107;65062.67468662626;75980;78225;80126;80369.59815200887;80510.19489805026;14785.704285914437;14971.401143954556;15598.766018509958;16044.598885027968;16061.839381606034;23848.88075559611;23997.400064998514;24097.51804963856;24099.397515062265;24219.51560968806;18065.72901406454;18201.544961376072;19928.103235354152;20019.499512512302;20028.098735557225;16996.575085622462;17112.828871711125;17337.306507740053;17534.123293835;18090.90954545219;19078.42764717005;20045.298414555422;20165.294214702415;20322.89838550798;20342;15604.843951560339;15630;15846.524604261891;15861.762073568674;15915.124668143364;19456.902715486332;19477.415677529698;19618.411447656592;19638.705419418435;19652.705209422154 12:51:52 INFO - PID 22066 | |3;mootools.html;1395.9162450252982;1460.722462732081;1471.786590944313;1475.5204558518485;1477.8596033376825;16516.91741541292;17085;17837.910810445963;17856.64286714265;17871.642567148665;17724.734128988075;18002.81997180028;18008.4597462076;18008.549786255317;18044.909775451106;2729.5769155780886;2781.568856827195;2782.4574208029444;2785.5403858363347;2861.1273561563717;2788.539890917996;2811.63448751662;2811.9718802811913;2819.4361127774423;2821.619081424012;2553.4637726077544;2633.4074833162576;2637.630731697564;2637.9711912354196;2640.485105404447;2753.7934654900864;2784.025591043139;2787.0663327785214;2790.2047916343845;2796.706345833689;2701.8784154713085;2717.904873329424;2723.714010028958;2762.3646561290816;2818.957715634267;16789.66420671592;16830.07434591097;16882.915585422117;16979.49061528156;16980;8197.877031844528;8404.453710508797;8470;8505.702300419518;8531.701390451304;5307.734613269321;5424.864378390533;5591.608587398884;5625.915611265835;5631.5776316776;1910.570121722615;1932.9613407731767;1946.6204090202416;1988.0358026357205;1991.6415045291842;30712.8464357679;30886.536701949488;30989.690103098907;30997.22506937322;31039.22401939947;6689.13041304637;6807.489438292049;6981;6985.441164706913;6995.335443132894;20449.795502044788;20453.2841350552;20456.284030058876;20488.590228195353;20507.17971281162;8070.9192908071345;8092.635831387602;8170.632321545426;8186.304164146114;8191.8771218431775;7338.853222935511;7442.18136005039;7695.268949449794;7825.295723384923;7856.292933636;5689.231953686282;5842.444967728059;5910.852228694231;5930.55520835939;5933.2880054393745;1631.111044480761;1643.909584972814;1674.6818104560095;1749.816269291706;1785.6517978993973;943.193569498083;966.1690945786618;969.2924165359327;973.4597298499401;991.6975322526698;8727.91272087271;8896.288296936229;8923.776905577413;9057.637694492278;9059.094090590888;1035.5547114740584;1062.1927335225284;1063.4310643805682;1071.4803320389606;1080.346390433792;5455.8363249102595;5709.257796486513;5770.855728606818;5812.88374232513;6078.787242446493;25055.62416563753;25787;26010.21969340885;26051.08821191249;26132;24211.7578824213;25372.365690857507;25497.10760123424;25701.3574660635;25871.31836430626;11959.103067269989;12481.563145290052;12557.43491542901;12594.118411711275;12706.809397859039;8812.383133180872;8893.021767605429;8982.056884027344;9011.63953441855;9087.954560227157;20853.270135545183;20988.685169722772;21592;21719.565608688055;21954.560908782056;21894.45263868416;22033.77966220317;22039.449013774785;22077.448063798533;22089.116435342406;12435.626931192079;12464.626061218178;12482;12504.624491305767;12505;15606.765898511305;15773.68452630918;15783.131927743625;16015.599610009844;16028.358865645243;12061.035117190428;12195.695107622025;12459.314737689514;12553.309567973483;12683.80974285405;11565.306081635128;11893.405329733652;11901.464434100659;12025.098117641037;12177.086718495972;10343.689689309333;10522.21083418762;10524.52639631203;10549;10577.153827693612;7863.488873223222;7895.763127105966;7971.92028079735;7999.920000799918;8032.156623554676;7988.520688758693;8028.397870159878;8092.231238032377;8134.349252059939;8174.305184059422 12:51:52 INFO - PID 22066 | |4;prototype.html;548.9588280878935;562.606175677026;575.7610591604484;576.9278840144982;584.6170758153405;6123.418275263848;6151.169592105064;6308.432241098306;6370.904436433457;6417.711202995864;6159.907601385983;6227.688615569215;6248.969085047366;6258.0300053491665;6286.2456505219325;5085;5142.305788718522;5152.716600586966;5210.661307015051;5223.373195216579;4939.629527785431;5013.3482647255805;5021.698698078127;5070.112730272206;5083.593312535007;4987.650864439491;5010.398752149747;5019.996000799836;5032.723200224004;5042.520960508746;4953.529414705633;5004.199328107504;5022.874428139289;5042.84871453857;5065.392152941634;4591.632669386441;4600.194965880957;4609.492955774862;4612.331211974279;4633.4208223972;6174.8147555573405;6182.28903676074;6230.906536401958;6235.158253635746;6247.344028876993;5903.291605007384;5937.495312898409;5951.732172052268;5964.403559644044;5996.610220335664;6566.244881838554;6613.834654133637;6650.567713098681;6651.334866513358;6672.966635166842;5107.157319042353;5113.054084994288;5124.308218390507;5132.563732082777;5144.356955380577;6968.895466568006;7018.122734658168;7030.718771249144;7040.6127662978515;7061.5763054216395;5303.28405665238;5323.600729945269;5363.854458216667;5382.434844341366;5389.892202155935;5429.457054294539;5433.592480563973;5469.671819690831;5500.559955203574;5505.394406615269;5929.377415371324;5931.4958228550195;5932.199153114274;5972.522198224218;5976.850578735566;6448.967755161288;6570.1236270600575;6663.833404164935;6682.198136223684;6734.528582999143;1730.4598906972803;1856.5637075287298;1860;1860.7301941218448;1873.063468265867;1309.6968516326126;1311.8294621699117;1322.16703476809;1337.6321511584197;1363.4955066625412;6022.488088512438;6070.6357618543025;6130.63216207029;6163.568550201532;6253.74985000604;6799.218089919723;6848;6852.5203235773015;6859.142607174103;6900.482463815234;6130.233720784902;6148.754049838046;6212.9068063979075;6223.377662233831;6268.874622507525;3547.94678079829;3610.9097272568397;3626.818659067036;3627.836747346376;3660.816959152032;7000.61496617691;7101.431885449152;7104.554291168883;7159.534630249017;7183;6998.195207551095;7030.683619237045;7048.942658601149;7099.751508697274;7182.461315401261;6925;7030.296970303031;7033.261507541737;7066.611336376446;7138.535995160298;6545.574537655038;6558.245801732862;6642.169728783902;6728.831779205559;6775.559588626724;6544.869102618016;6571.474282057328;6652.234992975869;6732.293109223657;6738.036837399035;6862.416694581017;6952;6973.476989225727;6981.162260528769;7014.333638304353;5186.222066690027;5239.685618862881;5261.3686357637325;5300.1254792958725;5318.441563635763;6489.1888513935755;6721.697523611547;6795.694193761194;6816.386525212754;6862.142232220973;6318.589291696209;6544.574602650812;6615.17310336208;6639.734410623521;6658.167729033871;6571.34286571339;6603.141591593062;6620.702068406837;6629.210113269487;6685.498587605852;6511.902321465276;6555.410013098844;6560.343965603593;6620.536562440583;6622.569532980341;6649.069130321662;6670.166229221348;6718.664066796739;6759.898601521079;6800.625965571743;6401.583897046677;6428.260750013621;6451.548391612542;6470.38531339522;6495.837604059747 12:51:52 INFO - PID 22066 | |5;yui.html;965.6491972854197;985.9654912078078;990.2523594686011;990.3612170150253;1001.844714069319;20135.597288054247;20855.582888342244;21193.682094768592;21214.363569092915;21220.787792122075;19369.322073727424;19382.418527444162;19557.511062223453;19569.70645440316;19585;1033.7312298802328;1053.4574694032578;1057.4448414582366;1062.2511129653576;1062.3360399750156;1073.5920350266927;1077.5420446310286;1078.9946050269778;1083.7669900971289;1084.0189628386322;1086.8750093739202;1118.0943435816973;1134.2003887259461;1134.3080720760329;1135.818269076948;1110.317154949708;1129.6385156749843;1130.2596799096605;1130.491278924479;1132.8470656461395;799.1608810748749;812.3663542436909;814.5316443045273;820.335528222142;820.5856042698459;19003.90498047515;19291.710624340645;19302.32441864528;19363.515912102168;19375;22845.42886427836;22866.31401057971;23625.527489450287;23876.283711488508;23878.880605597034;18951.905240473847;19233.80766192348;19377.612447750966;19431.12559934792;19433.9028304859;3899.7075219358376;3965.543962444327;3970.940435893464;3971.6822654187595;3971.801409929521;140196;164815;164886.9999999988;165418;167886;18200.362987295382;18491.907540462213;18868.528286792665;18931.81068189328;19002.90498547526;34267.97196084121;34960.475592866125;36036.81981590075;36067.81966090153;36199.81900090535;9875.901240987641;9907.306488545733;9909.504524773733;9915.851262231072;9920.057594528509;4588.793504292248;4613.76931153441;4663.556962088596;4673.462551806518;4722.150012997625;6109.572329936951;6159.137720719103;6167.814965551041;6176.598521096114;6228.283747369111;1212.9150959432932;1242.6334231401759;1252.6743046807896;1255.171586752739;1260.7352455984346;687.4569090418513;705.181988892892;705.428602831708;715.4133610439494;719.1047146302886;13102.344882755824;13215.801762973562;13407.32963351848;13603.727925441435;13641.727165456636;715.2990069731692;722.2308241722549;727.756201672435;738.0221206900878;740.2264633457942;6215.906761398583;6259.812205633838;6315.400036996478;6317.305096439388;6373.1714877066615;158647.20676396543;159384;160610;160841;163229;134339.32830335785;134917.32541337426;135220;135472;140077.29961350333;116324.41837790757;116402;119454.40272798754;120529.58940821135;123519;12974.545890893773;13214.083957826253;13284.867151328363;13415.188949491694;13496;54481.72759136179;55912.44087559072;56063.43936560745;56159;58148.70925645345;94987.52506237425;96761.90476190476;97869.04261914865;97887;99108.50445747725;19734.210631574577;20249.79750202479;20253.69619455739;20342;20462.488437789176;21829;22283.77716222882;23459;23720.40698982539;23739.52520949606;19510.21959121619;19691.80308196957;19961.101750420974;20209.494762631053;20320.695189572463;20659;21082.578348433253;21343.46641333979;21664.675029874248;21778.237761678265;19621.215151393786;19636.705449417983;19652.606947861248;19846.106925188113;19962.201511939358;14752.852471475577;15015.32431040584;15021.699566008838;15217.086974781549;15289.923550382176;15203.467878624195;15204.655035725893;15452.84547154514;15459.690806184039;15531.378744850079 12:51:52 INFO - PID 22066 | __end_tp_report 12:51:52 INFO - PID 22066 | __start_cc_report 12:51:52 INFO - PID 22066 | _x_x_mozilla_cycle_collect,285 12:51:52 INFO - PID 22066 | __end_cc_report 12:51:52 INFO - PID 22066 | __startTimestamp1506801112795__endTimestamp 12:51:52 INFO - PID 22066 | 12:51:52 INFO - PID 22066 | ------- Summary: start ------- 12:51:52 INFO - PID 22066 | Number of tests: 6 12:51:52 INFO - PID 22066 | 12:51:52 INFO - PID 22066 | [#0] dojo.html Cycles:165 Average:6313.40 Median:6590.14 stddev:901.36 (13.7%) stddev-sans-first:883.83 12:51:52 INFO - PID 22066 | Values: 3889.0 3917.2 3926.1 3928.4 3946.3 6288.3 6321.4 6334.1 6395.9 6428.3 6372.1 6374.1 6441.5 6477.7 6491.1 5698.0 5814.5 5817.1 5821.1 5844.4 103.2 5450.5 5700.2 5729.3 5793.3 5676.7 5679.7 5693.7 5737.1 5754.1 5630.4 5683.7 5731.0 5783.9 5804.4 5639.3 5679.0 5697.5 5715.7 5752.9 6284.7 6289.4 6329.7 6361.2 6368.4 6723.2 6735.8 6759.7 6851.9 6864.3 6892.5 6918.3 6936.0 6949.4 6961.8 6379.6 6440.2 6458.4 6464.1 6466.7 7053.4 7107.0 7152.9 7157.1 7175.7 6701.8 6737.2 6774.8 6776.8 6865.6 6782.3 6875.7 6882.0 6883.2 6886.9 6816.0 6837.5 6850.8 6856.6 6891.4 6900.0 6936.4 6959.0 6959.6 6960.4 4949.7 4994.2 5020.8 5060.0 5069.3 4502.3 4553.7 4573.0 4578.5 4591.7 6269.6 6333.5 6351.1 6354.2 6354.5 6914.3 6978.8 6995.8 7001.8 7008.7 6305.2 6306.7 6398.6 6402.3 6402.6 5460.2 5510.4 5574.6 5582.6 5613.9 7164.8 7192.4 7210.2 7225.3 7225.7 6864.9 6865.8 6937.7 6962.0 6969.9 7110.8 7125.8 7132.7 7247.0 7255.0 6691.1 6782.5 6831.5 6865.8 6882.8 6915.6 6941.2 6963.7 6978.2 6987.4 6668.1 6688.8 6749.0 6750.7 6772.4 6458.5 6552.9 6647.6 6649.7 6739.8 6560.6 6586.0 6590.1 6591.4 6638.0 6698.6 6734.1 6751.1 6826.5 6832.5 6433.6 6515.5 6526.4 6610.7 6618.2 12:51:52 INFO - PID 22066 | 12:51:52 INFO - PID 22066 | [#1] ext.html Cycles:180 Average:42588.60 Median:35973.28 stddev:64904.91 (180.4%) stddev-sans-first:65011.67 12:51:52 INFO - PID 22066 | Values: 948.3 952.0 982.6 1000.2 1001.9 43368.6 44226.8 44277.3 44277.6 44300.8 41057.4 41198.8 41201.0 41244.2 41431.0 7500.5 7616.5 7619.3 7620.4 7621.0 7558.1 7560.4 7628.0 7645.5 7650.9 8400.3 8624.4 8627.3 8627.4 8629.1 8479.2 8501.0 8538.9 8546.0 8572.7 8305.7 8395.1 8448.5 8451.5 8457.4 40308.0 40444.0 40734.2 40829.8 40831.4 3741.9 3795.2 3795.4 3801.8 3803.4 33112.3 33406.5 33480.7 33482.3 33751.2 5404.3 5414.6 5460.5 5460.5 5463.1 222962.0 224593.0 224641.0 225017.0 225209.0 53240.7 53311.5 53336.7 53344.7 53407.0 55201.4 55248.2 55408.7 55465.7 55512.0 15696.7 16024.7 16027.6 16045.6 16057.4 12729.2 12744.5 12770.8 12772.0 12779.7 15338.8 15597.5 15667.5 15726.0 15729.4 6008.6 6052.6 6070.7 6138.4 6265.6 1083.5 1100.2 1101.5 1106.7 1111.7 25721.5 25943.5 26121.6 26152.7 26263.7 1189.9 1202.8 1206.7 1224.6 1236.1 13640.5 13809.0 13876.4 13932.3 14015.7 273258.0 274273.0 285008.0 287346.0 287657.0 49131.5 49795.8 57197.0 57680.4 58090.0 1509.5 1516.6 1518.7 1522.9 1538.8 30095.7 30303.2 30602.5 30858.8 31021.2 41741.6 41835.4 41899.4 41955.0 41970.0 239471.0 239476.0 239996.0 240188.0 240262.0 35156.8 35398.6 35795.0 35969.1 35977.5 42915.0 44855.8 44998.6 45307.0 45331.8 33709.3 34223.7 34277.1 34291.0 34501.3 34255.1 34300.0 34461.5 34599.0 34848.0 38683.0 39618.4 39636.6 39795.2 40257.8 32591.9 33347.2 33391.3 33402.0 33793.8 24857.1 25120.9 25150.0 25540.5 26074.9 12:51:52 INFO - PID 22066 | 12:51:52 INFO - PID 22066 | [#2] jquery.html Cycles:180 Average:40475.02 Median:2275.31 stddev:104914.23 (4611.0%) stddev-sans-first:105165.82 12:51:52 INFO - PID 22066 | Values: 599.7 621.6 632.7 633.4 637.7 22640.4 23351.9 24012.5 24042.3 24078.4 25531.7 26369.7 26473.5 26489.6 26501.7 6647.1 6794.8 6808.6 6846.7 6847.0 6479.6 6746.5 6778.2 6780.3 6785.2 6736.3 6736.3 6747.2 6752.0 6758.8 6612.1 6887.2 6892.4 6894.2 6914.7 6425.4 6428.7 6430.2 6434.4 6439.4 29044.0 29506.3 29511.4 29538.4 29589.3 2078.1 2193.6 2248.0 2274.1 2276.5 20012.0 20673.3 20685.7 20704.4 20707.9 2540.1 2547.8 2608.3 2653.0 2664.8 137448.3 142719.3 148778.0 154969.0 155625.0 15983.6 16111.4 16201.0 16326.7 16718.6 25815.6 26145.6 26207.2 26210.9 26237.2 10590.6 10620.7 10800.5 10920.7 10972.8 9731.5 9773.7 9839.3 9843.6 9911.4 9719.2 9807.8 9831.9 9948.4 10110.7 2813.4 2838.8 2866.1 2926.3 2930.7 1043.9 1075.1 1078.8 1079.7 1082.4 21442.0 21576.9 21621.0 21650.9 21704.7 1111.7 1125.6 1130.9 1135.4 1138.1 11506.7 11571.5 11762.9 11816.5 11820.5 616254.0 620000.0 623777.0 631253.0 652341.0 128402.0 131064.3 134205.3 135798.3 135809.0 1145.7 1189.4 1232.1 1257.4 1292.8 21613.8 22104.7 22337.0 22341.8 22395.0 62170.7 62398.7 62996.0 64107.0 65062.7 75980.0 78225.0 80126.0 80369.6 80510.2 14785.7 14971.4 15598.8 16044.6 16061.8 23848.9 23997.4 24097.5 24099.4 24219.5 18065.7 18201.5 19928.1 20019.5 20028.1 16996.6 17112.8 17337.3 17534.1 18090.9 19078.4 20045.3 20165.3 20322.9 20342.0 15604.8 15630.0 15846.5 15861.8 15915.1 19456.9 19477.4 19618.4 19638.7 19652.7 12:51:52 INFO - PID 22066 | 12:51:52 INFO - PID 22066 | [#3] mootools.html Cycles:180 Average:10469.31 Median:14382.70 stddev:7910.93 (55.0%) stddev-sans-first:7903.75 12:51:52 INFO - PID 22066 | Values: 1395.9 1460.7 1471.8 1475.5 1477.9 16516.9 17085.0 17837.9 17856.6 17871.6 17724.7 18002.8 18008.5 18008.5 18044.9 2729.6 2781.6 2782.5 2785.5 2861.1 2788.5 2811.6 2812.0 2819.4 2821.6 2553.5 2633.4 2637.6 2638.0 2640.5 2753.8 2784.0 2787.1 2790.2 2796.7 2701.9 2717.9 2723.7 2762.4 2819.0 16789.7 16830.1 16882.9 16979.5 16980.0 8197.9 8404.5 8470.0 8505.7 8531.7 5307.7 5424.9 5591.6 5625.9 5631.6 1910.6 1933.0 1946.6 1988.0 1991.6 30712.8 30886.5 30989.7 30997.2 31039.2 6689.1 6807.5 6981.0 6985.4 6995.3 20449.8 20453.3 20456.3 20488.6 20507.2 8070.9 8092.6 8170.6 8186.3 8191.9 7338.9 7442.2 7695.3 7825.3 7856.3 5689.2 5842.4 5910.9 5930.6 5933.3 1631.1 1643.9 1674.7 1749.8 1785.7 943.2 966.2 969.3 973.5 991.7 8727.9 8896.3 8923.8 9057.6 9059.1 1035.6 1062.2 1063.4 1071.5 1080.3 5455.8 5709.3 5770.9 5812.9 6078.8 25055.6 25787.0 26010.2 26051.1 26132.0 24211.8 25372.4 25497.1 25701.4 25871.3 11959.1 12481.6 12557.4 12594.1 12706.8 8812.4 8893.0 8982.1 9011.6 9088.0 20853.3 20988.7 21592.0 21719.6 21954.6 21894.5 22033.8 22039.4 22077.4 22089.1 12435.6 12464.6 12482.0 12504.6 12505.0 15606.8 15773.7 15783.1 16015.6 16028.4 12061.0 12195.7 12459.3 12553.3 12683.8 11565.3 11893.4 11901.5 12025.1 12177.1 10343.7 10522.2 10524.5 10549.0 10577.2 7863.5 7895.8 7971.9 7999.9 8032.2 7988.5 8028.4 8092.2 8134.3 8174.3 12:51:52 INFO - PID 22066 | 12:51:52 INFO - PID 22066 | [#4] prototype.html Cycles:180 Average:5683.28 Median:6241.25 stddev:1573.83 (25.2%) stddev-sans-first:1530.34 12:51:52 INFO - PID 22066 | Values: 549.0 562.6 575.8 576.9 584.6 6123.4 6151.2 6308.4 6370.9 6417.7 6159.9 6227.7 6249.0 6258.0 6286.2 5085.0 5142.3 5152.7 5210.7 5223.4 4939.6 5013.3 5021.7 5070.1 5083.6 4987.7 5010.4 5020.0 5032.7 5042.5 4953.5 5004.2 5022.9 5042.8 5065.4 4591.6 4600.2 4609.5 4612.3 4633.4 6174.8 6182.3 6230.9 6235.2 6247.3 5903.3 5937.5 5951.7 5964.4 5996.6 6566.2 6613.8 6650.6 6651.3 6673.0 5107.2 5113.1 5124.3 5132.6 5144.4 6968.9 7018.1 7030.7 7040.6 7061.6 5303.3 5323.6 5363.9 5382.4 5389.9 5429.5 5433.6 5469.7 5500.6 5505.4 5929.4 5931.5 5932.2 5972.5 5976.9 6449.0 6570.1 6663.8 6682.2 6734.5 1730.5 1856.6 1860.0 1860.7 1873.1 1309.7 1311.8 1322.2 1337.6 1363.5 6022.5 6070.6 6130.6 6163.6 6253.7 6799.2 6848.0 6852.5 6859.1 6900.5 6130.2 6148.8 6212.9 6223.4 6268.9 3547.9 3610.9 3626.8 3627.8 3660.8 7000.6 7101.4 7104.6 7159.5 7183.0 6998.2 7030.7 7048.9 7099.8 7182.5 6925.0 7030.3 7033.3 7066.6 7138.5 6545.6 6558.2 6642.2 6728.8 6775.6 6544.9 6571.5 6652.2 6732.3 6738.0 6862.4 6952.0 6973.5 6981.2 7014.3 5186.2 5239.7 5261.4 5300.1 5318.4 6489.2 6721.7 6795.7 6816.4 6862.1 6318.6 6544.6 6615.2 6639.7 6658.2 6571.3 6603.1 6620.7 6629.2 6685.5 6511.9 6555.4 6560.3 6620.5 6622.6 6649.1 6670.2 6718.7 6759.9 6800.6 6401.6 6428.3 6451.5 6470.4 6495.8 12:51:52 INFO - PID 22066 | 12:51:52 INFO - PID 22066 | [#5] yui.html Cycles:180 Average:30212.45 Median:19713.01 stddev:44572.90 (226.1%) stddev-sans-first:44643.84 12:51:52 INFO - PID 22066 | Values: 965.6 986.0 990.3 990.4 1001.8 20135.6 20855.6 21193.7 21214.4 21220.8 19369.3 19382.4 19557.5 19569.7 19585.0 1033.7 1053.5 1057.4 1062.3 1062.3 1073.6 1077.5 1079.0 1083.8 1084.0 1086.9 1118.1 1134.2 1134.3 1135.8 1110.3 1129.6 1130.3 1130.5 1132.8 799.2 812.4 814.5 820.3 820.6 19003.9 19291.7 19302.3 19363.5 19375.0 22845.4 22866.3 23625.5 23876.3 23878.9 18951.9 19233.8 19377.6 19431.1 19433.9 3899.7 3965.5 3970.9 3971.7 3971.8 140196.0 164815.0 164887.0 165418.0 167886.0 18200.4 18491.9 18868.5 18931.8 19002.9 34268.0 34960.5 36036.8 36067.8 36199.8 9875.9 9907.3 9909.5 9915.9 9920.1 4588.8 4613.8 4663.6 4673.5 4722.2 6109.6 6159.1 6167.8 6176.6 6228.3 1212.9 1242.6 1252.7 1255.2 1260.7 687.5 705.2 705.4 715.4 719.1 13102.3 13215.8 13407.3 13603.7 13641.7 715.3 722.2 727.8 738.0 740.2 6215.9 6259.8 6315.4 6317.3 6373.2 158647.2 159384.0 160610.0 160841.0 163229.0 134339.3 134917.3 135220.0 135472.0 140077.3 116324.4 116402.0 119454.4 120529.6 123519.0 12974.5 13214.1 13284.9 13415.2 13496.0 54481.7 55912.4 56063.4 56159.0 58148.7 94987.5 96761.9 97869.0 97887.0 99108.5 19734.2 20249.8 20253.7 20342.0 20462.5 21829.0 22283.8 23459.0 23720.4 23739.5 19510.2 19691.8 19961.1 20209.5 20320.7 20659.0 21082.6 21343.5 21664.7 21778.2 19621.2 19636.7 19652.6 19846.1 19962.2 14752.9 15015.3 15021.7 15217.1 15289.9 15203.5 15204.7 15452.8 15459.7 15531.4 12:51:52 INFO - PID 22066 | -------- Summary: end -------- 12:51:52 INFO - PID 22066 | 12:51:53 INFO - TEST-INFO | 22066: exit 0 12:51:53 INFO - TEST-OK | dromaeo_css | took 1107309ms 12:51:53 INFO - TEST-START | kraken 12:51:53 INFO - Initialising browser for kraken test... 12:51:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60633/getInfo.html -profile /tmp/tmpx9wf1G/profile 12:51:53 INFO - TEST-INFO | started process 22436 (/builds/slave/test/build/application/firefox/firefox http://localhost:60633/getInfo.html) 12:51:58 INFO - TEST-INFO | 22436: exit 0 12:51:58 INFO - Browser initialized. 12:51:58 INFO - Running cycle 1/1 for kraken test... 12:51:58 INFO - Using env: {'DISPLAY': ':0', 12:51:58 INFO - 'HOME': '/home/cltbld', 12:51:58 INFO - 'JSGC_DISABLE_POISONING': '1', 12:51:58 INFO - 'LANG': 'en_US.UTF-8', 12:51:58 INFO - 'LANGUAGE': 'en_US:en', 12:51:58 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 12:51:58 INFO - 'LOGNAME': 'cltbld', 12:51:58 INFO - 'MAIL': '/var/mail/cltbld', 12:51:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:51:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:51:58 INFO - 'MOZ_CRASHREPORTER': '1', 12:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:58 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 12:51:58 INFO - 'MOZ_NO_REMOTE': '1', 12:51:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:58 INFO - 'NO_EM_RESTART': '1', 12:51:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:51:58 INFO - 'PWD': '/builds/slave/test', 12:51:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:51:58 INFO - 'RUST_BACKTRACE': 'full', 12:51:58 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 12:51:58 INFO - 'SHELL': '/bin/bash', 12:51:58 INFO - 'SHLVL': '1', 12:51:58 INFO - 'TERM': 'linux', 12:51:58 INFO - 'TMOUT': '86400', 12:51:58 INFO - 'USER': 'cltbld', 12:51:58 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155', 12:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:58 INFO - '_': '/tools/buildbot/bin/python'} 12:51:58 INFO - TEST-INFO | started process 22673 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx9wf1G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:51:59 INFO - PID 22673 | 12:51:59 INFO - PID 22673 | (/builds/slave/test/build/application/firefox/firefox:22723): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:51:59 INFO - PID 22673 | 12:52:09 INFO - PID 22673 | RSS: Main: 145178624 12:52:09 INFO - PID 22673 | 12:52:12 INFO - PID 22673 | Cycle 1(1): loaded http://localhost:60633/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60633/tests/kraken/driver.html?testName=audio-beat-detection) 12:52:13 INFO - PID 22673 | RSS: Main: 151056384 12:52:13 INFO - PID 22673 | 12:52:15 INFO - PID 22673 | Cycle 1(1): loaded http://localhost:60633/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60633/tests/kraken/driver.html?testName=audio-dft) 12:52:16 INFO - PID 22673 | RSS: Main: 151465984 12:52:16 INFO - PID 22673 | 12:52:19 INFO - PID 22673 | Cycle 1(1): loaded http://localhost:60633/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60633/tests/kraken/driver.html?testName=audio-fft) 12:52:20 INFO - PID 22673 | RSS: Main: 147550208 12:52:20 INFO - PID 22673 | 12:52:22 INFO - PID 22673 | Cycle 1(1): loaded http://localhost:60633/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60633/tests/kraken/driver.html?testName=audio-oscillator) 12:52:22 INFO - PID 22673 | RSS: Main: 148254720 12:52:22 INFO - PID 22673 | 12:52:24 INFO - PID 22673 | Cycle 1(1): loaded http://localhost:60633/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60633/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:52:25 INFO - PID 22673 | RSS: Main: 148787200 12:52:25 INFO - PID 22673 | 12:52:28 INFO - PID 22673 | Cycle 1(1): loaded http://localhost:60633/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60633/tests/kraken/driver.html?testName=imaging-darkroom) 12:52:29 INFO - PID 22673 | RSS: Main: 148578304 12:52:29 INFO - PID 22673 | 12:52:32 INFO - PID 22673 | Cycle 1(1): loaded http://localhost:60633/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60633/tests/kraken/driver.html?testName=imaging-desaturate) 12:52:33 INFO - PID 22673 | RSS: Main: 149852160 12:52:33 INFO - PID 22673 | 12:52:36 INFO - PID 22673 | Cycle 1(1): loaded http://localhost:60633/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60633/tests/kraken/driver.html?testName=json-parse-financial) 12:52:36 INFO - PID 22673 | RSS: Main: 151212032 12:52:36 INFO - PID 22673 | 12:52:38 INFO - PID 22673 | Cycle 1(1): loaded http://localhost:60633/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60633/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:52:38 INFO - PID 22673 | RSS: Main: 151011328 12:52:38 INFO - PID 22673 | 12:52:40 INFO - PID 22673 | Cycle 1(1): loaded http://localhost:60633/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60633/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:52:41 INFO - PID 22673 | RSS: Main: 151273472 12:52:41 INFO - PID 22673 | 12:52:43 INFO - PID 22673 | Cycle 1(1): loaded http://localhost:60633/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60633/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:52:43 INFO - PID 22673 | RSS: Main: 147722240 12:52:43 INFO - PID 22673 | 12:52:46 INFO - PID 22673 | Cycle 1(1): loaded http://localhost:60633/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60633/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:52:46 INFO - PID 22673 | RSS: Main: 148111360 12:52:46 INFO - PID 22673 | 12:52:49 INFO - PID 22673 | Cycle 1(1): loaded http://localhost:60633/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60633/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:52:50 INFO - PID 22673 | RSS: Main: 148848640 12:52:50 INFO - PID 22673 | 12:52:51 INFO - PID 22673 | Cycle 1(1): loaded http://localhost:60633/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60633/tests/kraken/driver.html?testName=ai-astar) 12:52:51 INFO - PID 22673 | RSS: Main: 150278144 12:52:51 INFO - PID 22673 | 12:52:51 INFO - PID 22673 | __start_tp_report 12:52:51 INFO - PID 22673 | _x_x_mozilla_page_load 12:52:51 INFO - PID 22673 | _x_x_mozilla_page_load_details 12:52:51 INFO - PID 22673 | |i|pagename|runs| 12:52:51 INFO - PID 22673 | |0;ai-astar;106;104;103;104;106;107;108;107;105;105 12:52:51 INFO - PID 22673 | |1;audio-beat-detection;111;114;113;113;115;115;113;113;114;112 12:52:51 INFO - PID 22673 | |2;audio-dft;162;164;162;162;162;165;162;162;161;168 12:52:51 INFO - PID 22673 | |3;audio-fft;74;72;73;73;76;74;74;76;75;72 12:52:51 INFO - PID 22673 | |4;audio-oscillator;79;78;79;77;80;77;87;77;77;77 12:52:51 INFO - PID 22673 | |5;imaging-gaussian-blur;111;112;111;111;111;112;111;113;112;112 12:52:51 INFO - PID 22673 | |6;imaging-darkroom;150;150;152;151;148;153;149;149;148;149 12:52:51 INFO - PID 22673 | |7;imaging-desaturate;94;94;94;95;95;93;98;94;94;95 12:52:51 INFO - PID 22673 | |8;json-parse-financial;45;45;45;43;45;45;45;44;44;43 12:52:51 INFO - PID 22673 | |9;json-stringify-tinderbox;39;39;39;39;40;39;40;40;39;40 12:52:51 INFO - PID 22673 | |10;stanford-crypto-aes;69;70;70;72;75;75;72;71;72;72 12:52:51 INFO - PID 22673 | |11;stanford-crypto-ccm;107;113;107;108;104;113;104;109;105;102 12:52:51 INFO - PID 22673 | |12;stanford-crypto-pbkdf2;151;153;156;159;151;156;155;156;149;147 12:52:51 INFO - PID 22673 | |13;stanford-crypto-sha256-iterative;56;61;58;58;57;57;59;65;58;57 12:52:51 INFO - PID 22673 | __end_tp_report 12:52:51 INFO - PID 22673 | __start_cc_report 12:52:51 INFO - PID 22673 | _x_x_mozilla_cycle_collect,707 12:52:51 INFO - PID 22673 | __end_cc_report 12:52:51 INFO - PID 22673 | __startTimestamp1506801171904__endTimestamp 12:52:51 INFO - PID 22673 | 12:52:51 INFO - PID 22673 | ------- Summary: start ------- 12:52:51 INFO - PID 22673 | Number of tests: 14 12:52:51 INFO - PID 22673 | 12:52:51 INFO - PID 22673 | [#0] ai-astar Cycles:10 Average:105.50 Median:106.00 stddev:1.58 (1.5%) stddev-sans-first:1.67 12:52:51 INFO - PID 22673 | Values: 106.0 104.0 103.0 104.0 106.0 107.0 108.0 107.0 105.0 105.0 12:52:51 INFO - PID 22673 | 12:52:51 INFO - PID 22673 | [#1] audio-beat-detection Cycles:10 Average:113.30 Median:113.50 stddev:1.25 (1.1%) stddev-sans-first:1.01 12:52:51 INFO - PID 22673 | Values: 111.0 114.0 113.0 113.0 115.0 115.0 113.0 113.0 114.0 112.0 12:52:51 INFO - PID 22673 | 12:52:51 INFO - PID 22673 | [#2] audio-dft Cycles:10 Average:163.00 Median:162.00 stddev:2.11 (1.3%) stddev-sans-first:2.20 12:52:51 INFO - PID 22673 | Values: 162.0 164.0 162.0 162.0 162.0 165.0 162.0 162.0 161.0 168.0 12:52:51 INFO - PID 22673 | 12:52:51 INFO - PID 22673 | [#3] audio-fft Cycles:10 Average:73.90 Median:74.00 stddev:1.45 (2.0%) stddev-sans-first:1.54 12:52:51 INFO - PID 22673 | Values: 74.0 72.0 73.0 73.0 76.0 74.0 74.0 76.0 75.0 72.0 12:52:51 INFO - PID 22673 | 12:52:51 INFO - PID 22673 | [#4] audio-oscillator Cycles:10 Average:78.80 Median:78.50 stddev:3.08 (3.9%) stddev-sans-first:3.27 12:52:51 INFO - PID 22673 | Values: 79.0 78.0 79.0 77.0 80.0 77.0 87.0 77.0 77.0 77.0 12:52:51 INFO - PID 22673 | 12:52:51 INFO - PID 22673 | [#5] imaging-gaussian-blur Cycles:10 Average:111.60 Median:112.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 12:52:51 INFO - PID 22673 | Values: 111.0 112.0 111.0 111.0 111.0 112.0 111.0 113.0 112.0 112.0 12:52:51 INFO - PID 22673 | 12:52:51 INFO - PID 22673 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:1.66 (1.1%) stddev-sans-first:1.76 12:52:51 INFO - PID 22673 | Values: 150.0 150.0 152.0 151.0 148.0 153.0 149.0 149.0 148.0 149.0 12:52:51 INFO - PID 22673 | 12:52:51 INFO - PID 22673 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.50 stddev:1.35 (1.4%) stddev-sans-first:1.41 12:52:51 INFO - PID 22673 | Values: 94.0 94.0 94.0 95.0 95.0 93.0 98.0 94.0 94.0 95.0 12:52:51 INFO - PID 22673 | 12:52:51 INFO - PID 22673 | [#8] json-parse-financial Cycles:10 Average:44.40 Median:45.00 stddev:0.84 (1.9%) stddev-sans-first:0.87 12:52:51 INFO - PID 22673 | Values: 45.0 45.0 45.0 43.0 45.0 45.0 45.0 44.0 44.0 43.0 12:52:51 INFO - PID 22673 | 12:52:51 INFO - PID 22673 | [#9] json-stringify-tinderbox Cycles:10 Average:39.40 Median:39.50 stddev:0.52 (1.3%) stddev-sans-first:0.53 12:52:51 INFO - PID 22673 | Values: 39.0 39.0 39.0 39.0 40.0 39.0 40.0 40.0 39.0 40.0 12:52:51 INFO - PID 22673 | 12:52:51 INFO - PID 22673 | [#10] stanford-crypto-aes Cycles:10 Average:71.80 Median:72.00 stddev:1.99 (2.8%) stddev-sans-first:1.83 12:52:51 INFO - PID 22673 | Values: 69.0 70.0 70.0 72.0 75.0 75.0 72.0 71.0 72.0 72.0 12:52:51 INFO - PID 22673 | 12:52:51 INFO - PID 22673 | [#11] stanford-crypto-ccm Cycles:10 Average:107.20 Median:107.50 stddev:3.71 (3.4%) stddev-sans-first:3.93 12:52:51 INFO - PID 22673 | Values: 107.0 113.0 107.0 108.0 104.0 113.0 104.0 109.0 105.0 102.0 12:52:51 INFO - PID 22673 | 12:52:51 INFO - PID 22673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:155.50 stddev:3.74 (2.4%) stddev-sans-first:3.88 12:52:51 INFO - PID 22673 | Values: 151.0 153.0 156.0 159.0 151.0 156.0 155.0 156.0 149.0 147.0 12:52:51 INFO - PID 22673 | 12:52:51 INFO - PID 22673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.60 Median:58.00 stddev:2.63 (4.5%) stddev-sans-first:2.62 12:52:51 INFO - PID 22673 | Values: 56.0 61.0 58.0 58.0 57.0 57.0 59.0 65.0 58.0 57.0 12:52:51 INFO - PID 22673 | -------- Summary: end -------- 12:52:51 INFO - PID 22673 | 12:52:52 INFO - PID 22673 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:52:52 INFO - TEST-INFO | 22673: exit 0 12:52:52 INFO - TEST-OK | kraken | took 59280ms 12:52:52 INFO - SUITE-END | took 1166s 12:52:52 INFO - Completed test suite (00:19:26) 12:52:52 INFO - javascript benchmark 12:52:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9171.357898768885, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3889.027743064234, 3917.157811070619, 3926.0577461409252, 3928.3518219493776, 3946.3291240489116, 6288.308286088532, 6321.431071203602, 6334.081558174062, 6395.904061439082, 6428.32502587228, 6372.076048972896, 6374.139491168691, 6441.549091563593, 6477.740890364392, 6491.12369830074, 5697.971510142444, 5814.534837213034, 5817.069268916975, 5821.097729851858, 5844.386339434362, 103.24171650362878, 5450.5367043801325, 5700.173474846145, 5729.312482502106, 5793.275840519935, 5676.744546495418, 5679.659220446786, 5693.686847223401, 5737.082066869322, 5754.079347304432, 5630.380658127603, 5683.658980461186, 5730.971345143289, 5783.884322313572, 5804.448577385142, 5639.2668953036255, 5679.006173919547, 5697.544196464314, 5715.714214289311, 5752.8849423011725, 6284.717187726564, 6289.371062893674, 6329.715162817684, 6361.173047503795, 6368.363163683641, 6723.193216814014, 6735.831604209934, 6759.695813688396, 6851.931480685179, 6864.313568643096, 6892.517523773338, 6918.342757438086, 6936.0, 6949.44404447643, 6961.79114626562, 6379.585326953733, 6440.162778838721, 6458.38645328693, 6464.127342808754, 6466.708998095097, 7053.365197132282, 7107.0, 7152.928470715278, 7157.141143062866, 7175.748848790372, 6701.832454188684, 6737.191537015589, 6774.83062923421, 6776.830579235559, 6865.5537390069485, 6782.253952065367, 6875.656217189121, 6882.0, 6883.174019117738, 6886.8622627547165, 6815.965920170367, 6837.521373503807, 6850.828729281709, 6856.554323968926, 6891.448684105259, 6899.965500172467, 6936.410405115622, 6958.965205174043, 6959.582425054513, 6960.37356637905, 4949.678270912379, 4994.200927851526, 5020.7740651670765, 5060.0, 5069.264956581275, 4502.347159661831, 4553.749543775058, 4573.0396616710195, 4578.473475550354, 4591.724496530219, 6269.62382257066, 6333.46165575922, 6351.110844481776, 6354.237491500957, 6354.523410744213, 6914.274001229798, 6978.825529361807, 6995.825104372431, 7001.754938577125, 7008.684609192598, 6305.243370795442, 6306.65313407767, 6398.552101352953, 6402.263739669997, 6402.551821372459, 5460.208269800856, 5510.366307874566, 5574.554035677136, 5582.637128586629, 5613.915791263134, 7164.820879478055, 7192.4246060315045, 7210.242924492957, 7225.2774722528375, 7225.674844632004, 6864.853804963439, 6865.794026179223, 6937.653117344113, 6961.965190174118, 6969.9303006969285, 7110.786676399716, 7125.786226413215, 7132.714691412285, 7247.0, 7255.020572222682, 6691.0967019451755, 6782.491313151435, 6831.45348372139, 6865.794026179223, 6882.7591034313555, 6915.619640919797, 6941.2364639888565, 6963.721451141898, 6978.162620485574, 6987.406070484066, 6668.099806526251, 6688.83277918056, 6748.966255168692, 6750.729970801113, 6772.356626120511, 6458.547901647027, 6552.934470655423, 6647.567908085959, 6649.667516624246, 6739.797806065826, 6560.606363618198, 6586.0, 6590.143281373391, 6591.373819487141, 6638.037484564615, 6698.56459330142, 6734.124563806674, 6751.088603038724, 6826.522143449911, 6832.453403727789, 6433.613983161025, 6515.511336649865, 6526.379993900572, 6610.735570577315, 6618.205815302002], "value": 6253.411610200535, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [948.2698322291835, 951.9809603807928, 982.5725809272966, 1000.1948431512634, 1001.9248556358275, 43368.566314336844, 44226.778866105626, 44277.33583996243, 44277.55722442774, 44300.778496107516, 41057.38413923793, 41198.79400603, 41201.0, 41244.17511649765, 41431.0, 7500.474966752329, 7616.466847320662, 7619.276168763959, 7620.390368770485, 7620.961895190516, 7558.130814956268, 7560.395168386516, 7628.0, 7645.46481746278, 7650.923490765077, 8400.285975692073, 8624.35317351198, 8627.3098152148, 8627.439216450943, 8629.05080441151, 8479.152084791502, 8501.0, 8538.914610853873, 8545.97448306201, 8572.657093716243, 8305.709300174465, 8395.076541580422, 8448.535330556817, 8451.492910425393, 8457.407981441302, 40308.0, 40444.0, 40734.185316293806, 40829.795851020855, 40831.387529187086, 3741.8690345837763, 3795.221979494197, 3795.449659799341, 3801.8479260829536, 3803.391457366808, 33112.33775324504, 33406.49890251648, 33480.665193347995, 33482.3303533928, 33751.156221094425, 5404.297441332641, 5414.566834653218, 5460.453954604547, 5460.5085542301385, 5463.098588732894, 222962.0, 224593.0, 224641.0, 225017.0, 225209.0, 53240.73379633077, 53311.46688533143, 53336.73331633317, 53344.73327633415, 53407.0, 55201.44798552043, 55248.17127743087, 55408.72295638496, 55465.722671386386, 55512.0, 15696.686066278839, 16024.679506409806, 16027.599310017109, 16045.59886002836, 16057.357705691875, 12729.172603780724, 12744.490220391266, 12770.80843787344, 12772.0, 12779.744405111845, 15338.846611533965, 15597.532074037797, 15667.529974100795, 15726.0, 15729.370825167094, 6008.639481631116, 6052.606580572248, 6070.726817293233, 6138.355472675394, 6265.592736472115, 1083.5070043130356, 1100.2078503477483, 1101.5373543111752, 1106.6679996001167, 1111.6776134920945, 25721.485570288864, 25943.481130377666, 26121.608175877376, 26152.738472615412, 26263.73736262613, 1189.881011898803, 1202.8436303280519, 1206.6561030106377, 1224.5958833584896, 1236.1347057060093, 13640.522581709592, 13809.0, 13876.444942202199, 13932.30338483092, 14015.748814859417, 273258.0, 274273.0, 285008.0, 287346.0, 287657.0, 49131.50868491341, 49795.751021244665, 57197.0, 57680.423195768344, 58090.0, 1509.5169545745257, 1516.5601975427003, 1518.6658935034495, 1522.9314680839389, 1538.7999560057121, 30095.699043010165, 30303.242418938822, 30602.540961885144, 30858.845705771328, 31021.224469388446, 41741.58258417377, 41835.372469412374, 41899.371509426775, 41955.0, 41970.0, 239471.0, 239476.0, 239996.0, 240188.0, 240262.0, 35156.82421587978, 35398.646013540565, 35795.0, 35969.100772480895, 35977.46033809547, 42915.0, 44855.77572112249, 44998.550014500746, 45307.0, 45331.773341133085, 33709.32581348409, 34223.657763422045, 34277.14307142242, 34291.0, 34501.30997379988, 34255.14362140966, 34300.0, 34461.48307775335, 34599.0, 34848.0, 38683.0, 39618.40572391359, 39636.60363396329, 39795.20409591734, 40257.79871100626, 32591.869533923218, 33347.166320842174, 33391.33217335591, 33402.0, 33793.83103084469, 24857.10580654122, 25120.874395627903, 25150.0, 25540.48919021572, 26074.86962565175], "value": 18590.214876712565, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.6791716431707, 621.5835390288506, 632.6646877155108, 633.3792882974685, 637.6524793987277, 22640.43398915028, 23351.883240583815, 24012.51974960502, 24042.278731638056, 24078.398040049007, 25531.74468255317, 26369.736302636968, 26473.470530589377, 26489.602655960178, 26501.734982650167, 6647.135872336589, 6794.762183323584, 6808.5914845109455, 6846.726130954781, 6846.965765171167, 6479.64361960092, 6746.494012949024, 6778.186617605894, 6780.321967803229, 6785.1518560179975, 6736.292689267605, 6736.29268926763, 6747.224069232027, 6751.9662401688165, 6758.797236082901, 6612.07430959666, 6887.173539175331, 6892.448604111659, 6894.207166175879, 6914.688839002257, 6425.357464253584, 6428.678566071678, 6430.196225471816, 6434.388733070351, 6439.388258115471, 29044.0, 29506.262343441373, 29511.409771804443, 29538.409231815243, 29589.26026849346, 2078.147959336665, 2193.638049721794, 2248.033345661365, 2274.0676322707777, 2276.5446910617775, 20012.0, 20673.276435324842, 20685.68971465429, 20704.378868633965, 20707.8964605176, 2540.136353639753, 2547.783438407738, 2608.321836322551, 2652.9602055969176, 2664.786817054631, 137448.31275843555, 142719.28640356733, 148778.0, 154969.0, 155625.0, 15983.561479466904, 16111.355545778271, 16201.0, 16326.673466530841, 16718.58203544921, 25815.612765808528, 26145.607815882777, 26207.21378358652, 26210.86894565553, 26237.212883613523, 10590.629327973484, 10620.681379558626, 10800.45997700112, 10920.672379828618, 10972.780544389227, 9731.513424328756, 9773.657921972697, 9839.311248212556, 9843.606255749834, 9911.405315681082, 9719.222462203006, 9807.803843923224, 9831.901680983241, 9948.403095814274, 10110.747231319276, 2813.383553295455, 2838.758705510055, 2866.1226896382905, 2926.341573146025, 2930.721581449759, 1043.89561043895, 1075.1452595186845, 1078.757279612081, 1079.7408621930838, 1082.3668154129764, 21442.0, 21576.892115539635, 21621.027053782618, 21650.891745541485, 21704.674429883566, 1111.6539216957017, 1125.58915995661, 1130.8756036835941, 1135.4209353229912, 1138.1463902073444, 11506.654800356002, 11571.479283432265, 11762.94118529402, 11816.527338906519, 11820.468078936468, 616254.0, 620000.0, 623777.0, 631253.0, 652341.0, 128402.0, 131064.344678276, 134205.3289733545, 135798.32100839433, 135809.0, 1145.7192987718063, 1189.3636904256355, 1232.1498166265249, 1257.352463481308, 1292.8299888600832, 21613.783862161177, 22104.66842997324, 22336.994835232777, 22341.771202584016, 22395.0, 62170.68914655398, 62398.68800656149, 62996.0, 64107.0, 65062.67468662626, 75980.0, 78225.0, 80126.0, 80369.59815200887, 80510.19489805026, 14785.704285914437, 14971.401143954556, 15598.766018509958, 16044.598885027968, 16061.839381606034, 23848.88075559611, 23997.400064998514, 24097.51804963856, 24099.397515062265, 24219.51560968806, 18065.72901406454, 18201.544961376072, 19928.103235354152, 20019.499512512302, 20028.098735557225, 16996.575085622462, 17112.828871711125, 17337.306507740053, 17534.123293835, 18090.90954545219, 19078.42764717005, 20045.298414555422, 20165.294214702415, 20322.89838550798, 20342.0, 15604.843951560339, 15630.0, 15846.524604261891, 15861.762073568674, 15915.124668143364, 19456.902715486332, 19477.415677529698, 19618.411447656592, 19638.705419418435, 19652.705209422154], "value": 12889.324741134742, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.9162450252982, 1460.722462732081, 1471.786590944313, 1475.5204558518485, 1477.8596033376825, 16516.91741541292, 17085.0, 17837.910810445963, 17856.64286714265, 17871.642567148665, 17724.734128988075, 18002.81997180028, 18008.4597462076, 18008.549786255317, 18044.909775451106, 2729.5769155780886, 2781.568856827195, 2782.4574208029444, 2785.5403858363347, 2861.1273561563717, 2788.539890917996, 2811.63448751662, 2811.9718802811913, 2819.4361127774423, 2821.619081424012, 2553.4637726077544, 2633.4074833162576, 2637.630731697564, 2637.9711912354196, 2640.485105404447, 2753.7934654900864, 2784.025591043139, 2787.0663327785214, 2790.2047916343845, 2796.706345833689, 2701.8784154713085, 2717.904873329424, 2723.714010028958, 2762.3646561290816, 2818.957715634267, 16789.66420671592, 16830.07434591097, 16882.915585422117, 16979.49061528156, 16980.0, 8197.877031844528, 8404.453710508797, 8470.0, 8505.702300419518, 8531.701390451304, 5307.734613269321, 5424.864378390533, 5591.608587398884, 5625.915611265835, 5631.5776316776, 1910.570121722615, 1932.9613407731767, 1946.6204090202416, 1988.0358026357205, 1991.6415045291842, 30712.8464357679, 30886.536701949488, 30989.690103098907, 30997.22506937322, 31039.22401939947, 6689.13041304637, 6807.489438292049, 6981.0, 6985.441164706913, 6995.335443132894, 20449.795502044788, 20453.2841350552, 20456.284030058876, 20488.590228195353, 20507.17971281162, 8070.9192908071345, 8092.635831387602, 8170.632321545426, 8186.304164146114, 8191.8771218431775, 7338.853222935511, 7442.18136005039, 7695.268949449794, 7825.295723384923, 7856.292933636, 5689.231953686282, 5842.444967728059, 5910.852228694231, 5930.55520835939, 5933.2880054393745, 1631.111044480761, 1643.909584972814, 1674.6818104560095, 1749.816269291706, 1785.6517978993973, 943.193569498083, 966.1690945786618, 969.2924165359327, 973.4597298499401, 991.6975322526698, 8727.91272087271, 8896.288296936229, 8923.776905577413, 9057.637694492278, 9059.094090590888, 1035.5547114740584, 1062.1927335225284, 1063.4310643805682, 1071.4803320389606, 1080.346390433792, 5455.8363249102595, 5709.257796486513, 5770.855728606818, 5812.88374232513, 6078.787242446493, 25055.62416563753, 25787.0, 26010.21969340885, 26051.08821191249, 26132.0, 24211.7578824213, 25372.365690857507, 25497.10760123424, 25701.3574660635, 25871.31836430626, 11959.103067269989, 12481.563145290052, 12557.43491542901, 12594.118411711275, 12706.809397859039, 8812.383133180872, 8893.021767605429, 8982.056884027344, 9011.63953441855, 9087.954560227157, 20853.270135545183, 20988.685169722772, 21592.0, 21719.565608688055, 21954.560908782056, 21894.45263868416, 22033.77966220317, 22039.449013774785, 22077.448063798533, 22089.116435342406, 12435.626931192079, 12464.626061218178, 12482.0, 12504.624491305767, 12505.0, 15606.765898511305, 15773.68452630918, 15783.131927743625, 16015.599610009844, 16028.358865645243, 12061.035117190428, 12195.695107622025, 12459.314737689514, 12553.309567973483, 12683.80974285405, 11565.306081635128, 11893.405329733652, 11901.464434100659, 12025.098117641037, 12177.086718495972, 10343.689689309333, 10522.21083418762, 10524.52639631203, 10549.0, 10577.153827693612, 7863.488873223222, 7895.763127105966, 7971.92028079735, 7999.920000799918, 8032.156623554676, 7988.520688758693, 8028.397870159878, 8092.231238032377, 8134.349252059939, 8174.305184059422], "value": 7275.934293519502, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.9588280878935, 562.606175677026, 575.7610591604484, 576.9278840144982, 584.6170758153405, 6123.418275263848, 6151.169592105064, 6308.432241098306, 6370.904436433457, 6417.711202995864, 6159.907601385983, 6227.688615569215, 6248.969085047366, 6258.0300053491665, 6286.2456505219325, 5085.0, 5142.305788718522, 5152.716600586966, 5210.661307015051, 5223.373195216579, 4939.629527785431, 5013.3482647255805, 5021.698698078127, 5070.112730272206, 5083.593312535007, 4987.650864439491, 5010.398752149747, 5019.996000799836, 5032.723200224004, 5042.520960508746, 4953.529414705633, 5004.199328107504, 5022.874428139289, 5042.84871453857, 5065.392152941634, 4591.632669386441, 4600.194965880957, 4609.492955774862, 4612.331211974279, 4633.4208223972, 6174.8147555573405, 6182.28903676074, 6230.906536401958, 6235.158253635746, 6247.344028876993, 5903.291605007384, 5937.495312898409, 5951.732172052268, 5964.403559644044, 5996.610220335664, 6566.244881838554, 6613.834654133637, 6650.567713098681, 6651.334866513358, 6672.966635166842, 5107.157319042353, 5113.054084994288, 5124.308218390507, 5132.563732082777, 5144.356955380577, 6968.895466568006, 7018.122734658168, 7030.718771249144, 7040.6127662978515, 7061.5763054216395, 5303.28405665238, 5323.600729945269, 5363.854458216667, 5382.434844341366, 5389.892202155935, 5429.457054294539, 5433.592480563973, 5469.671819690831, 5500.559955203574, 5505.394406615269, 5929.377415371324, 5931.4958228550195, 5932.199153114274, 5972.522198224218, 5976.850578735566, 6448.967755161288, 6570.1236270600575, 6663.833404164935, 6682.198136223684, 6734.528582999143, 1730.4598906972803, 1856.5637075287298, 1860.0, 1860.7301941218448, 1873.063468265867, 1309.6968516326126, 1311.8294621699117, 1322.16703476809, 1337.6321511584197, 1363.4955066625412, 6022.488088512438, 6070.6357618543025, 6130.63216207029, 6163.568550201532, 6253.74985000604, 6799.218089919723, 6848.0, 6852.5203235773015, 6859.142607174103, 6900.482463815234, 6130.233720784902, 6148.754049838046, 6212.9068063979075, 6223.377662233831, 6268.874622507525, 3547.94678079829, 3610.9097272568397, 3626.818659067036, 3627.836747346376, 3660.816959152032, 7000.61496617691, 7101.431885449152, 7104.554291168883, 7159.534630249017, 7183.0, 6998.195207551095, 7030.683619237045, 7048.942658601149, 7099.751508697274, 7182.461315401261, 6925.0, 7030.296970303031, 7033.261507541737, 7066.611336376446, 7138.535995160298, 6545.574537655038, 6558.245801732862, 6642.169728783902, 6728.831779205559, 6775.559588626724, 6544.869102618016, 6571.474282057328, 6652.234992975869, 6732.293109223657, 6738.036837399035, 6862.416694581017, 6952.0, 6973.476989225727, 6981.162260528769, 7014.333638304353, 5186.222066690027, 5239.685618862881, 5261.3686357637325, 5300.1254792958725, 5318.441563635763, 6489.1888513935755, 6721.697523611547, 6795.694193761194, 6816.386525212754, 6862.142232220973, 6318.589291696209, 6544.574602650812, 6615.17310336208, 6639.734410623521, 6658.167729033871, 6571.34286571339, 6603.141591593062, 6620.702068406837, 6629.210113269487, 6685.498587605852, 6511.902321465276, 6555.410013098844, 6560.343965603593, 6620.536562440583, 6622.569532980341, 6649.069130321662, 6670.166229221348, 6718.664066796739, 6759.898601521079, 6800.625965571743, 6401.583897046677, 6428.260750013621, 6451.548391612542, 6470.38531339522, 6495.837604059747], "value": 5232.86054735366, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [965.6491972854197, 985.9654912078078, 990.2523594686011, 990.3612170150253, 1001.844714069319, 20135.597288054247, 20855.582888342244, 21193.682094768592, 21214.363569092915, 21220.787792122075, 19369.322073727424, 19382.418527444162, 19557.511062223453, 19569.70645440316, 19585.0, 1033.7312298802328, 1053.4574694032578, 1057.4448414582366, 1062.2511129653576, 1062.3360399750156, 1073.5920350266927, 1077.5420446310286, 1078.9946050269778, 1083.7669900971289, 1084.0189628386322, 1086.8750093739202, 1118.0943435816973, 1134.2003887259461, 1134.3080720760329, 1135.818269076948, 1110.317154949708, 1129.6385156749843, 1130.2596799096605, 1130.491278924479, 1132.8470656461395, 799.1608810748749, 812.3663542436909, 814.5316443045273, 820.335528222142, 820.5856042698459, 19003.90498047515, 19291.710624340645, 19302.32441864528, 19363.515912102168, 19375.0, 22845.42886427836, 22866.31401057971, 23625.527489450287, 23876.283711488508, 23878.880605597034, 18951.905240473847, 19233.80766192348, 19377.612447750966, 19431.12559934792, 19433.9028304859, 3899.7075219358376, 3965.543962444327, 3970.940435893464, 3971.6822654187595, 3971.801409929521, 140196.0, 164815.0, 164886.9999999988, 165418.0, 167886.0, 18200.362987295382, 18491.907540462213, 18868.528286792665, 18931.81068189328, 19002.90498547526, 34267.97196084121, 34960.475592866125, 36036.81981590075, 36067.81966090153, 36199.81900090535, 9875.901240987641, 9907.306488545733, 9909.504524773733, 9915.851262231072, 9920.057594528509, 4588.793504292248, 4613.76931153441, 4663.556962088596, 4673.462551806518, 4722.150012997625, 6109.572329936951, 6159.137720719103, 6167.814965551041, 6176.598521096114, 6228.283747369111, 1212.9150959432932, 1242.6334231401759, 1252.6743046807896, 1255.171586752739, 1260.7352455984346, 687.4569090418513, 705.181988892892, 705.428602831708, 715.4133610439494, 719.1047146302886, 13102.344882755824, 13215.801762973562, 13407.32963351848, 13603.727925441435, 13641.727165456636, 715.2990069731692, 722.2308241722549, 727.756201672435, 738.0221206900878, 740.2264633457942, 6215.906761398583, 6259.812205633838, 6315.400036996478, 6317.305096439388, 6373.1714877066615, 158647.20676396543, 159384.0, 160610.0, 160841.0, 163229.0, 134339.32830335785, 134917.32541337426, 135220.0, 135472.0, 140077.29961350333, 116324.41837790757, 116402.0, 119454.40272798754, 120529.58940821135, 123519.0, 12974.545890893773, 13214.083957826253, 13284.867151328363, 13415.188949491694, 13496.0, 54481.72759136179, 55912.44087559072, 56063.43936560745, 56159.0, 58148.70925645345, 94987.52506237425, 96761.90476190476, 97869.04261914865, 97887.0, 99108.50445747725, 19734.210631574577, 20249.79750202479, 20253.69619455739, 20342.0, 20462.488437789176, 21829.0, 22283.77716222882, 23459.0, 23720.40698982539, 23739.52520949606, 19510.21959121619, 19691.80308196957, 19961.101750420974, 20209.494762631053, 20320.695189572463, 20659.0, 21082.578348433253, 21343.46641333979, 21664.675029874248, 21778.237761678265, 19621.215151393786, 19636.705449417983, 19652.606947861248, 19846.106925188113, 19962.201511939358, 14752.852471475577, 15015.32431040584, 15021.699566008838, 15217.086974781549, 15289.923550382176, 15203.467878624195, 15204.655035725893, 15452.84547154514, 15459.690806184039, 15531.378744850079], "value": 10430.752263008035, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1365.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 104.0, 103.0, 104.0, 106.0, 107.0, 108.0, 107.0, 105.0, 105.0], "value": 105.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 113.0, 113.0, 115.0, 115.0, 113.0, 113.0, 114.0, 112.0], "value": 113.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 162.0, 162.0, 165.0, 162.0, 162.0, 161.0, 168.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 73.0, 73.0, 76.0, 74.0, 74.0, 76.0, 75.0, 72.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 77.0, 80.0, 77.0, 87.0, 77.0, 77.0, 77.0], "value": 78.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 111.0, 111.0, 111.0, 112.0, 111.0, 113.0, 112.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 152.0, 151.0, 148.0, 153.0, 149.0, 149.0, 148.0, 149.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 93.0, 98.0, 94.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 45.0, 45.0, 43.0, 45.0, 45.0, 45.0, 44.0, 44.0, 43.0], "value": 44.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 39.0, 39.0, 40.0, 39.0, 40.0, 40.0, 39.0, 40.0], "value": 39.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 72.0, 75.0, 75.0, 72.0, 71.0, 72.0, 72.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 107.0, 108.0, 104.0, 113.0, 104.0, 109.0, 105.0, 102.0], "value": 107.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 153.0, 156.0, 159.0, 151.0, 156.0, 155.0, 156.0, 149.0, 147.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 61.0, 58.0, 58.0, 57.0, 57.0, 59.0, 65.0, 58.0, 57.0], "value": 58.6, "unit": "score"}]}]} 12:52:52 INFO - Return code: 0 12:52:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:52:52 INFO - # TBPL SUCCESS # 12:52:52 INFO - Running post-action listener: _package_coverage_data 12:52:52 INFO - Running post-action listener: _resource_record_post_action 12:52:52 INFO - [mozharness: 2017-09-30 19:52:52.665758Z] Finished run-tests step (success) 12:52:52 INFO - Running post-run listener: _resource_record_post_run 12:52:52 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 322564096; Read time: 0; Write time: 215268 12:52:52 INFO - TinderboxPrint: CPU usage
13.1% 12:52:52 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:52:52 INFO - TinderboxPrint: I/O write bytes / time
322,564,096 / 215,268 12:52:52 INFO - TinderboxPrint: CPU idle
8,212.3 (86.9%) 12:52:52 INFO - TinderboxPrint: CPU user
1,186.1 (12.6%) 12:52:52 INFO - TinderboxPrint: Swap in / out
0 / 0 12:52:52 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13283328; Read time: 0; Write time: 5836 12:52:52 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:52:52 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 0; Write bytes: 309280768; Read time: 0; Write time: 209432 12:52:53 INFO - Running post-run listener: _upload_blobber_files 12:52:53 INFO - Blob upload gear active. 12:52:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:52:53 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 12:52:53 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'] 12:52:53 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 12:52:53 INFO - (blobuploader) - INFO - Open directory for files ... 12:52:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:52:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:52:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:52:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:52:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:52:54 INFO - (blobuploader) - INFO - Done attempting. 12:52:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:52:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:52:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:52:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:52:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:52:55 INFO - (blobuploader) - INFO - Done attempting. 12:52:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:52:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:52:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:52:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:52:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:52:56 INFO - (blobuploader) - INFO - Done attempting. 12:52:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:52:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:52:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:53:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:53:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:53:03 INFO - (blobuploader) - INFO - Done attempting. 12:53:03 INFO - (blobuploader) - INFO - Iteration through files over. 12:53:03 INFO - Return code: 0 12:53:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:53:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:53:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12e540bc2c902ef7cd93e5714c9275a02fe92b51f572752ea0624a74f58c6e59a9bce7e36406940f25972fc4527ec505c523faa8298f12805887475f0af3ae24", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef5eed5848feae18c575e091ea9b6c0c4ea527cbccf4f10392d0bda7fc9b2e555744bc4ebeb0183d60b1273031fb9dba85523c5b6c24f0714299fa88b005895a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86a182746098503ffac82a7684b8618511c06d6ccbc67b92fe6c8bfc8c6696fd15f7a18b4881db8044802ceae5037dcd48eafeccab88c57ec62f9c1cbd85b04d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b7194871b269a8867eacfa9a33866142ba34ec1507fd4aa5a3b7aa91366ca9715dce36d755731e375632faed56b4a86883f1b5aa21f7dcbaf0ff1366aa90033"} 12:53:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:53:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:53:03 INFO - Contents: 12:53:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12e540bc2c902ef7cd93e5714c9275a02fe92b51f572752ea0624a74f58c6e59a9bce7e36406940f25972fc4527ec505c523faa8298f12805887475f0af3ae24", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef5eed5848feae18c575e091ea9b6c0c4ea527cbccf4f10392d0bda7fc9b2e555744bc4ebeb0183d60b1273031fb9dba85523c5b6c24f0714299fa88b005895a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86a182746098503ffac82a7684b8618511c06d6ccbc67b92fe6c8bfc8c6696fd15f7a18b4881db8044802ceae5037dcd48eafeccab88c57ec62f9c1cbd85b04d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b7194871b269a8867eacfa9a33866142ba34ec1507fd4aa5a3b7aa91366ca9715dce36d755731e375632faed56b4a86883f1b5aa21f7dcbaf0ff1366aa90033"} 12:53:03 INFO - Running post-run listener: copy_logs_to_upload_dir 12:53:03 INFO - Copying logs to upload dir... 12:53:03 INFO - mkdir: /builds/slave/test/build/upload/logs 12:53:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.455746 ========= master_lag: -0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2017-09-30 12:53:03.710989) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-30 12:53:03.717954) ========= 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=781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12e540bc2c902ef7cd93e5714c9275a02fe92b51f572752ea0624a74f58c6e59a9bce7e36406940f25972fc4527ec505c523faa8298f12805887475f0af3ae24", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef5eed5848feae18c575e091ea9b6c0c4ea527cbccf4f10392d0bda7fc9b2e555744bc4ebeb0183d60b1273031fb9dba85523c5b6c24f0714299fa88b005895a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86a182746098503ffac82a7684b8618511c06d6ccbc67b92fe6c8bfc8c6696fd15f7a18b4881db8044802ceae5037dcd48eafeccab88c57ec62f9c1cbd85b04d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b7194871b269a8867eacfa9a33866142ba34ec1507fd4aa5a3b7aa91366ca9715dce36d755731e375632faed56b4a86883f1b5aa21f7dcbaf0ff1366aa90033"} build_url:https://queue.taskcluster.net/v1/task/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011258 build_url: 'https://queue.taskcluster.net/v1/task/ZaEM5yFfRGqkHoliHWWilg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12e540bc2c902ef7cd93e5714c9275a02fe92b51f572752ea0624a74f58c6e59a9bce7e36406940f25972fc4527ec505c523faa8298f12805887475f0af3ae24", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef5eed5848feae18c575e091ea9b6c0c4ea527cbccf4f10392d0bda7fc9b2e555744bc4ebeb0183d60b1273031fb9dba85523c5b6c24f0714299fa88b005895a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86a182746098503ffac82a7684b8618511c06d6ccbc67b92fe6c8bfc8c6696fd15f7a18b4881db8044802ceae5037dcd48eafeccab88c57ec62f9c1cbd85b04d", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b7194871b269a8867eacfa9a33866142ba34ec1507fd4aa5a3b7aa91366ca9715dce36d755731e375632faed56b4a86883f1b5aa21f7dcbaf0ff1366aa90033"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-30 12:53:03.746762) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 12:53:03.747110) ========= 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=781b77c4c33858b1f599d705000001c1-1506799070.544994-1789279155 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-30 12:53:03.830584) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-30 12:53:03.830896) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-30 12:53:03.831189) ========= ========= Total master_lag: -0.04 =========