builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-005 starttime: 1503253017.77 results: success (0) revision: cab35526779367774b3ecea2f7a8a5c0993caa77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-20 11:16:57.774404) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-20 11:16:57.774823) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-20 11:16:57.775121) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-20 11:16:57.791944) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 11:16:57.792343) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-20 11:16:57-- 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% 68.7M=0s 2017-08-20 11:16:58 (68.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121868 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 11:16:57.930401) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 11:16:57.930710) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014737 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 11:16:57.980820) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 11:16:57.981133) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cab35526779367774b3ecea2f7a8a5c0993caa77 --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 cab35526779367774b3ecea2f7a8a5c0993caa77 --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=7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-20 11:16:58,141 truncating revision to first 12 chars 2017-08-20 11:16:58,141 Setting DEBUG logging. 2017-08-20 11:16:58,141 attempt 1/10 2017-08-20 11:16:58,141 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cab355267793?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-20 11:16:58,522 unpacking tar archive at: mozilla-central-cab355267793/testing/mozharness/ program finished with exit code 0 elapsedTime=0.727587 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 11:16:58.723432) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-20 11:16:58.723768) ========= script_repo_revision: cab35526779367774b3ecea2f7a8a5c0993caa77 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-20 11:16:58.724174) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-20 11:16:58.724452) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-20 11:16:58.735735) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-20 11:16:58.736074) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:16:59 INFO - MultiFileLogger online at 20170820 11:16:59 in /builds/slave/test 11:16:59 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 11:16:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:16:59 INFO - {'append_to_log': False, 11:16:59 INFO - 'base_work_dir': '/builds/slave/test', 11:16:59 INFO - 'blob_upload_branch': 'Firefox', 11:16:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:16:59 INFO - 'branch': 'Firefox', 11:16:59 INFO - 'buildbot_json_path': 'buildprops.json', 11:16:59 INFO - 'code_coverage': False, 11:16:59 INFO - 'config_files': ('talos/linux_config.py',), 11:16:59 INFO - 'default_actions': ('clobber', 11:16:59 INFO - 'read-buildbot-config', 11:16:59 INFO - 'download-and-extract', 11:16:59 INFO - 'populate-webroot', 11:16:59 INFO - 'create-virtualenv', 11:16:59 INFO - 'install', 11:16:59 INFO - 'setup-mitmproxy', 11:16:59 INFO - 'run-tests'), 11:16:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:16:59 INFO - 'disable_ccov_upload': False, 11:16:59 INFO - 'download_minidump_stackwalk': True, 11:16:59 INFO - 'download_symbols': 'ondemand', 11:16:59 INFO - 'enable_stylo': False, 11:16:59 INFO - 'enable_webrender': False, 11:16:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:16:59 INFO - 'tooltool.py': '/tools/tooltool.py', 11:16:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:16:59 INFO - '/tools/misc-python/virtualenv.py')}, 11:16:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:16:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:16:59 INFO - 'gecko_profile': False, 11:16:59 INFO - 'gecko_profile_interval': 0, 11:16:59 INFO - 'installer_path': 'installer.exe', 11:16:59 INFO - 'log_level': 'info', 11:16:59 INFO - 'log_name': 'talos', 11:16:59 INFO - 'log_to_console': True, 11:16:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:16:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:16:59 INFO - 'opt_config_files': (), 11:16:59 INFO - 'pip_index': False, 11:16:59 INFO - 'suite': 'dromaeojs-e10s', 11:16:59 INFO - 'system_bits': '32', 11:16:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:16:59 INFO - 'title': 'talos-linux64-ix-005', 11:16:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:16:59 INFO - 'use_talos_json': True, 11:16:59 INFO - 'verify': 'False', 11:16:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:16:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:16:59 INFO - 'work_dir': 'build'} 11:16:59 INFO - [mozharness: 2017-08-20 18:16:59.048100Z] Running clobber step. 11:16:59 INFO - Running pre-action listener: _resource_record_pre_action 11:16:59 INFO - Running main action method: clobber 11:16:59 INFO - rmtree: /builds/slave/test/build 11:16:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:17:00 INFO - Running post-action listener: _resource_record_post_action 11:17:00 INFO - [mozharness: 2017-08-20 18:17:00.067039Z] Finished clobber step (success) 11:17:00 INFO - [mozharness: 2017-08-20 18:17:00.067136Z] Running read-buildbot-config step. 11:17:00 INFO - Running pre-action listener: _resource_record_pre_action 11:17:00 INFO - Running main action method: read_buildbot_config 11:17:00 INFO - Using buildbot properties: 11:17:00 INFO - { 11:17:00 INFO - "project": "", 11:17:00 INFO - "product": "firefox", 11:17:00 INFO - "who": "ffxbld@noreply.mozilla.org", 11:17:00 INFO - "installer_path": "public/build/target.tar.bz2", 11:17:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:17:00 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:17:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:17:00 INFO - "stage_platform": "linux64-pgo", 11:17:00 INFO - "basedir": "/builds/slave/test", 11:17:00 INFO - "buildnumber": 132, 11:17:00 INFO - "platform": "ubuntu64_hw", 11:17:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:17:00 INFO - "slavebuilddir": "test", 11:17:00 INFO - "taskId": "MXs0oLTmQhe7owyPQMX2aQ", 11:17:00 INFO - "branch": "mozilla-central", 11:17:00 INFO - "script_repo_revision": "production", 11:17:00 INFO - "revision": "cab35526779367774b3ecea2f7a8a5c0993caa77", 11:17:00 INFO - "slavename": "talos-linux64-ix-005", 11:17:00 INFO - "repo_path": "mozilla-central" 11:17:00 INFO - } 11:17:00 INFO - Finding installer, test and symbols from parent task. 11:17:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MXs0oLTmQhe7owyPQMX2aQ'}, attempt #1 11:17:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MXs0oLTmQhe7owyPQMX2aQ'}, attempt #1 11:17:01 INFO - Task dependencies: TKk533FUQ-m7hsD9mpL7AQ 11:17:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ'}, attempt #1 11:17:01 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.tar.bz2 11:17:01 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.test_packages.json 11:17:01 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.crashreporter-symbols.zip 11:17:01 INFO - Running post-action listener: _resource_record_post_action 11:17:01 INFO - [mozharness: 2017-08-20 18:17:01.483282Z] Finished read-buildbot-config step (success) 11:17:01 INFO - [mozharness: 2017-08-20 18:17:01.483539Z] Running download-and-extract step. 11:17:01 INFO - Running pre-action listener: _resource_record_pre_action 11:17:01 INFO - Running main action method: download_and_extract 11:17:01 INFO - mkdir: /builds/slave/test/build/tests 11:17: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')]} 11:17:01 INFO - trying https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.test_packages.json 11:17:01 INFO - Downloading https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:17:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:17:02 INFO - Downloaded 989 bytes. 11:17:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:17:02 INFO - Using the following test package requirements: 11:17:02 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:17:02 INFO - u'common': [u'target.common.tests.zip'], 11:17:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:17:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:17:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:17:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:17:02 INFO - u'mozbase': [u'target.common.tests.zip'], 11:17:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:17:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:17:02 INFO - u'web-platform': [u'target.common.tests.zip', 11:17:02 INFO - u'target.web-platform.tests.tar.gz'], 11:17:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:17:02 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:17:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.common.tests.zip 11:17:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:17:02 INFO - Fetch https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.common.tests.zip into memory 11:17:03 INFO - Content-Length response header: 54624389 11:17:03 INFO - Bytes received: 54624389 11:17:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:17:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.common.tests.zip 11:17:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:17:14 INFO - Fetch https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.common.tests.zip into memory 11:17:16 INFO - Content-Length response header: 54624389 11:17:16 INFO - Bytes received: 54624389 11:17:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.talos.tests.zip 11:17:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:17:27 INFO - Fetch https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.talos.tests.zip into memory 11:17:28 INFO - Content-Length response header: 14496256 11:17:28 INFO - Bytes received: 14496256 11:17: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')]} 11:17:29 INFO - trying https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.tar.bz2 11:17:29 INFO - Downloading https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:17:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:17:31 INFO - Downloaded 63147187 bytes. 11:17:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.tar.bz2 11:17:31 INFO - mkdir: /builds/slave/test/properties 11:17:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:17:31 INFO - Writing to file /builds/slave/test/properties/build_url 11:17:31 INFO - Contents: 11:17:31 INFO - build_url:https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.tar.bz2 11:17:31 INFO - Running post-action listener: _resource_record_post_action 11:17:31 INFO - Running post-action listener: find_tests_for_verification 11:17:31 INFO - Running post-action listener: set_extra_try_arguments 11:17:31 INFO - [mozharness: 2017-08-20 18:17:31.414480Z] Finished download-and-extract step (success) 11:17:31 INFO - [mozharness: 2017-08-20 18:17:31.414577Z] Running populate-webroot step. 11:17:31 INFO - Running pre-action listener: _resource_record_pre_action 11:17:31 INFO - Running main action method: populate_webroot 11:17:31 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:17:31 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 11:17:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:17:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:17:31 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 11:17:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:17:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:17:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:17:31 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:17:31 INFO - 'talos_options': ['--stylo'], 11:17:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:17:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:17:31 INFO - 'tests': ['damp', 'tps']}, 11:17:31 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:17:31 INFO - 'talos_options': ['--stylo'], 11:17:31 INFO - 'tests': ['damp', 'tps']}, 11:17:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:17:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:17:31 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 11:17:31 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:17:31 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:17:31 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:17:31 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:17:31 INFO - 'talos_options': ['--stylo'], 11:17:31 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:17:31 INFO - 'other-e10s': {'tests': ['a11yr', 11:17:31 INFO - 'ts_paint', 11:17:31 INFO - 'tpaint', 11:17:31 INFO - 'sessionrestore', 11:17:31 INFO - 'sessionrestore_many_windows', 11:17:31 INFO - 'sessionrestore_no_auto_restore', 11:17:31 INFO - 'tabpaint']}, 11:17:31 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 11:17:31 INFO - 'tests': ['a11yr', 11:17:31 INFO - 'ts_paint', 11:17:31 INFO - 'tpaint', 11:17:31 INFO - 'sessionrestore', 11:17:31 INFO - 'sessionrestore_many_windows', 11:17:31 INFO - 'sessionrestore_no_auto_restore', 11:17:31 INFO - 'tabpaint']}, 11:17:31 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:17:31 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:17:31 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 11:17:31 INFO - 'tests': ['bloom_basic_singleton']}, 11:17:31 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 11:17:31 INFO - 'tests': ['bloom_basic']}, 11:17:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:17:31 INFO - 'tsvgr_opacity', 11:17:31 INFO - 'tart', 11:17:31 INFO - 'tscrollx', 11:17:31 INFO - 'tsvg_static']}, 11:17:31 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 11:17:31 INFO - 'tests': ['tsvgx', 11:17:31 INFO - 'tsvgr_opacity', 11:17:31 INFO - 'tart', 11:17:31 INFO - 'tscrollx', 11:17:31 INFO - 'tsvg_static']}, 11:17:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:17:31 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:17:31 INFO - 'talos_options': ['--stylo'], 11:17:31 INFO - 'tests': ['tp5o']}, 11:17:31 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:17:31 INFO - 'talos_options': ['--mitmproxy', 11:17:31 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:17:31 INFO - '--firstNonBlankPaint'], 11:17:31 INFO - 'tests': ['tp6_google', 11:17:31 INFO - 'tp6_youtube', 11:17:31 INFO - 'tp6_amazon', 11:17:31 INFO - 'tp6_facebook']}, 11:17:31 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:17:31 INFO - 'talos_options': ['--stylo', 11:17:31 INFO - '--mitmproxy', 11:17:31 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:17:31 INFO - '--firstNonBlankPaint'], 11:17:31 INFO - 'tests': ['tp6_google', 11:17:31 INFO - 'tp6_youtube', 11:17:31 INFO - 'tp6_amazon', 11:17:31 INFO - 'tp6_facebook']}, 11:17:31 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:17:31 INFO - 'talos_options': ['--stylo', 11:17:31 INFO - '--stylo-threads=1', 11:17:31 INFO - '--mitmproxy', 11:17:31 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:17:31 INFO - '--firstNonBlankPaint'], 11:17:31 INFO - 'tests': ['tp6_google', 11:17:31 INFO - 'tp6_youtube', 11:17:31 INFO - 'tp6_amazon', 11:17:31 INFO - 'tp6_facebook']}, 11:17:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:17:31 INFO - 'talos_options': ['--xperf_path', 11:17:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:17:31 INFO - 'tests': ['tp5n']}, 11:17:31 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:17:31 INFO - 'talos_options': ['--stylo', 11:17:31 INFO - '--xperf_path', 11:17:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:17:31 INFO - 'tests': ['tp5n']}}} 11:17:31 INFO - Running post-action listener: _resource_record_post_action 11:17:31 INFO - [mozharness: 2017-08-20 18:17:31.430429Z] Finished populate-webroot step (success) 11:17:31 INFO - [mozharness: 2017-08-20 18:17:31.430518Z] Running create-virtualenv step. 11:17:31 INFO - Running pre-action listener: _resource_record_pre_action 11:17:31 INFO - Running main action method: create_virtualenv 11:17:31 INFO - Creating virtualenv /builds/slave/test/build/venv 11:17:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:17:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:17:31 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:17:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:17:31 INFO - Using real prefix '/usr' 11:17:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:17:32 INFO - Installing distribute.............................................................................................................................................................................................done. 11:17:33 INFO - Installing pip.................done. 11:17:34 INFO - Return code: 0 11:17:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:17:34 INFO - Reading from file tmpfile_stdout 11:17:34 INFO - Output received: 11:17:34 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:17:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:17:34 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')]} 11:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:34 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')]} 11:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd36a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7130>, '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 0xed8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed84c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', '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 11:17:34 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 11:17:34 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 11:17:34 INFO - Using env: {'DISPLAY': ':0', 11:17:34 INFO - 'HOME': '/home/cltbld', 11:17:34 INFO - 'LANG': 'en_US.UTF-8', 11:17:34 INFO - 'LANGUAGE': 'en_US:en', 11:17:34 INFO - 'LOGNAME': 'cltbld', 11:17:34 INFO - 'MAIL': '/var/mail/cltbld', 11:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:34 INFO - 'MOZ_NO_REMOTE': '1', 11:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:34 INFO - 'NO_EM_RESTART': '1', 11:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:34 INFO - 'PWD': '/builds/slave/test', 11:17:34 INFO - 'SHELL': '/bin/bash', 11:17:34 INFO - 'SHLVL': '1', 11:17:34 INFO - 'TERM': 'linux', 11:17:34 INFO - 'TMOUT': '86400', 11:17:34 INFO - 'USER': 'cltbld', 11:17:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', 11:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:34 INFO - '_': '/tools/buildbot/bin/python'} 11:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:17:34 INFO - Cleaning up... 11:17:34 INFO - Return code: 0 11:17:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:17:34 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')]} 11:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:34 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')]} 11:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd36a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7130>, '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 0xed8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed84c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', '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 11:17:34 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 11:17:34 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 11:17:34 INFO - Using env: {'DISPLAY': ':0', 11:17:34 INFO - 'HOME': '/home/cltbld', 11:17:34 INFO - 'LANG': 'en_US.UTF-8', 11:17:34 INFO - 'LANGUAGE': 'en_US:en', 11:17:34 INFO - 'LOGNAME': 'cltbld', 11:17:34 INFO - 'MAIL': '/var/mail/cltbld', 11:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:34 INFO - 'MOZ_NO_REMOTE': '1', 11:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:34 INFO - 'NO_EM_RESTART': '1', 11:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:34 INFO - 'PWD': '/builds/slave/test', 11:17:34 INFO - 'SHELL': '/bin/bash', 11:17:34 INFO - 'SHLVL': '1', 11:17:34 INFO - 'TERM': 'linux', 11:17:34 INFO - 'TMOUT': '86400', 11:17:34 INFO - 'USER': 'cltbld', 11:17:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', 11:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:34 INFO - '_': '/tools/buildbot/bin/python'} 11:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:34 INFO - Downloading/unpacking psutil>=3.1.1 11:17:34 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 11:17:34 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 11:17:34 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 11:17:34 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 11:17:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:17:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:35 INFO - Installing collected packages: psutil 11:17:35 INFO - Running setup.py install for psutil 11:17:35 INFO - building 'psutil._psutil_linux' extension 11:17:35 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 11:17:36 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 11:17:36 INFO - building 'psutil._psutil_posix' extension 11:17:36 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 11:17:36 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 11:17:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:17:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:17:36 INFO - Successfully installed psutil 11:17:36 INFO - Cleaning up... 11:17:36 INFO - Return code: 0 11:17:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:17:36 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')]} 11:17:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:36 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')]} 11:17:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd36a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7130>, '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 0xed8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed84c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', '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 11:17:36 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 11:17:36 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 11:17:36 INFO - Using env: {'DISPLAY': ':0', 11:17:36 INFO - 'HOME': '/home/cltbld', 11:17:36 INFO - 'LANG': 'en_US.UTF-8', 11:17:36 INFO - 'LANGUAGE': 'en_US:en', 11:17:36 INFO - 'LOGNAME': 'cltbld', 11:17:36 INFO - 'MAIL': '/var/mail/cltbld', 11:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:36 INFO - 'MOZ_NO_REMOTE': '1', 11:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:36 INFO - 'NO_EM_RESTART': '1', 11:17:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:36 INFO - 'PWD': '/builds/slave/test', 11:17:36 INFO - 'SHELL': '/bin/bash', 11:17:36 INFO - 'SHLVL': '1', 11:17:36 INFO - 'TERM': 'linux', 11:17:36 INFO - 'TMOUT': '86400', 11:17:36 INFO - 'USER': 'cltbld', 11:17:36 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', 11:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:36 INFO - '_': '/tools/buildbot/bin/python'} 11:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:17:36 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 11:17:36 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 11:17:36 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 11:17:36 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 11:17:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:17:37 INFO - Installing collected packages: mozsystemmonitor 11:17:37 INFO - Running setup.py install for mozsystemmonitor 11:17:37 INFO - Successfully installed mozsystemmonitor 11:17:37 INFO - Cleaning up... 11:17:37 INFO - Return code: 0 11:17:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:17:37 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')]} 11:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:37 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')]} 11:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd36a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7130>, '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 0xed8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed84c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', '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 11:17:37 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 11:17:37 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 11:17:37 INFO - Using env: {'DISPLAY': ':0', 11:17:37 INFO - 'HOME': '/home/cltbld', 11:17:37 INFO - 'LANG': 'en_US.UTF-8', 11:17:37 INFO - 'LANGUAGE': 'en_US:en', 11:17:37 INFO - 'LOGNAME': 'cltbld', 11:17:37 INFO - 'MAIL': '/var/mail/cltbld', 11:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:37 INFO - 'MOZ_NO_REMOTE': '1', 11:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:37 INFO - 'NO_EM_RESTART': '1', 11:17:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:37 INFO - 'PWD': '/builds/slave/test', 11:17:37 INFO - 'SHELL': '/bin/bash', 11:17:37 INFO - 'SHLVL': '1', 11:17:37 INFO - 'TERM': 'linux', 11:17:37 INFO - 'TMOUT': '86400', 11:17:37 INFO - 'USER': 'cltbld', 11:17:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', 11:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:37 INFO - '_': '/tools/buildbot/bin/python'} 11:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:38 INFO - Downloading/unpacking jsonschema==2.5.1 11:17:38 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 11:17:38 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 11:17:38 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 11:17:38 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 11:17:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:17:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:17:39 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 11:17:39 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 11:17:39 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 11:17:39 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 11:17:39 INFO - Downloading functools32-3.2.3-2.tar.gz 11:17:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:17:39 INFO - warning: no files found matching '*.txt' 11:17:39 INFO - no previously-included directories found matching 'build' 11:17:39 INFO - no previously-included directories found matching 'dist' 11:17:39 INFO - no previously-included directories found matching '.git*' 11:17:39 INFO - Installing collected packages: jsonschema, functools32 11:17:39 INFO - Running setup.py install for functools32 11:17:39 INFO - warning: no files found matching '*.txt' 11:17:39 INFO - no previously-included directories found matching 'build' 11:17:39 INFO - no previously-included directories found matching 'dist' 11:17:39 INFO - no previously-included directories found matching '.git*' 11:17:39 INFO - Successfully installed jsonschema functools32 11:17:39 INFO - Cleaning up... 11:17:39 INFO - Return code: 0 11:17:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd36a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7130>, '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 0xed8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed84c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', '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 11:17:39 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 11:17:39 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 11:17:39 INFO - Using env: {'DISPLAY': ':0', 11:17:39 INFO - 'HOME': '/home/cltbld', 11:17:39 INFO - 'LANG': 'en_US.UTF-8', 11:17:39 INFO - 'LANGUAGE': 'en_US:en', 11:17:39 INFO - 'LOGNAME': 'cltbld', 11:17:39 INFO - 'MAIL': '/var/mail/cltbld', 11:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:39 INFO - 'MOZ_NO_REMOTE': '1', 11:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:39 INFO - 'NO_EM_RESTART': '1', 11:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:39 INFO - 'PWD': '/builds/slave/test', 11:17:39 INFO - 'SHELL': '/bin/bash', 11:17:39 INFO - 'SHLVL': '1', 11:17:39 INFO - 'TERM': 'linux', 11:17:39 INFO - 'TMOUT': '86400', 11:17:39 INFO - 'USER': 'cltbld', 11:17:39 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', 11:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:39 INFO - '_': '/tools/buildbot/bin/python'} 11:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:17:39 INFO - Cleaning up... 11:17:39 INFO - Return code: 0 11:17:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd36a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7130>, '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 0xed8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed84c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', '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 11:17:39 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 11:17:39 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 11:17:39 INFO - Using env: {'DISPLAY': ':0', 11:17:39 INFO - 'HOME': '/home/cltbld', 11:17:39 INFO - 'LANG': 'en_US.UTF-8', 11:17:39 INFO - 'LANGUAGE': 'en_US:en', 11:17:39 INFO - 'LOGNAME': 'cltbld', 11:17:39 INFO - 'MAIL': '/var/mail/cltbld', 11:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:39 INFO - 'MOZ_NO_REMOTE': '1', 11:17:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:39 INFO - 'NO_EM_RESTART': '1', 11:17:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:39 INFO - 'PWD': '/builds/slave/test', 11:17:39 INFO - 'SHELL': '/bin/bash', 11:17:39 INFO - 'SHLVL': '1', 11:17:39 INFO - 'TERM': 'linux', 11:17:39 INFO - 'TMOUT': '86400', 11:17:39 INFO - 'USER': 'cltbld', 11:17:39 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', 11:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:39 INFO - '_': '/tools/buildbot/bin/python'} 11:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:40 INFO - Downloading/unpacking blobuploader==1.2.4 11:17:40 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 11:17:40 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 11:17:40 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 11:17:40 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 11:17:41 INFO - Downloading blobuploader-1.2.4.tar.gz 11:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:17:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:17:41 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 11:17:41 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 11:17:41 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 11:17:41 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 11:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:17:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:17:41 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 11:17:41 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 11:17:41 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 11:17:41 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 11:17:41 INFO - Downloading docopt-0.6.1.tar.gz 11:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:17:41 INFO - Installing collected packages: blobuploader, requests, docopt 11:17:41 INFO - Running setup.py install for blobuploader 11:17:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:17:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:17:41 INFO - Running setup.py install for requests 11:17:42 INFO - Running setup.py install for docopt 11:17:42 INFO - Successfully installed blobuploader requests docopt 11:17:42 INFO - Cleaning up... 11:17:42 INFO - Return code: 0 11:17:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd36a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7130>, '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 0xed8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed84c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', '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 11:17:42 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 11:17:42 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 11:17:42 INFO - Using env: {'DISPLAY': ':0', 11:17:42 INFO - 'HOME': '/home/cltbld', 11:17:42 INFO - 'LANG': 'en_US.UTF-8', 11:17:42 INFO - 'LANGUAGE': 'en_US:en', 11:17:42 INFO - 'LOGNAME': 'cltbld', 11:17:42 INFO - 'MAIL': '/var/mail/cltbld', 11:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:42 INFO - 'MOZ_NO_REMOTE': '1', 11:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:42 INFO - 'NO_EM_RESTART': '1', 11:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:42 INFO - 'PWD': '/builds/slave/test', 11:17:42 INFO - 'SHELL': '/bin/bash', 11:17:42 INFO - 'SHLVL': '1', 11:17:42 INFO - 'TERM': 'linux', 11:17:42 INFO - 'TMOUT': '86400', 11:17:42 INFO - 'USER': 'cltbld', 11:17:42 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', 11:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:42 INFO - '_': '/tools/buildbot/bin/python'} 11:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:42 INFO - Running setup.py (path:/tmp/pip-NcNQgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:42 INFO - Running setup.py (path:/tmp/pip-hIIhfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:42 INFO - Running setup.py (path:/tmp/pip-WNRAOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:42 INFO - Running setup.py (path:/tmp/pip-bQcm9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:42 INFO - Running setup.py (path:/tmp/pip-u7JWVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:42 INFO - Running setup.py (path:/tmp/pip-DCdBFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:42 INFO - Running setup.py (path:/tmp/pip-mzOM26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:43 INFO - Running setup.py (path:/tmp/pip-1kRv2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:43 INFO - Running setup.py (path:/tmp/pip-iEcY5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:43 INFO - Running setup.py (path:/tmp/pip-IkJeED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:43 INFO - Running setup.py (path:/tmp/pip-aF6eYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:43 INFO - Running setup.py (path:/tmp/pip-X1vqht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:43 INFO - Running setup.py (path:/tmp/pip-rBoqps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:43 INFO - Running setup.py (path:/tmp/pip-Bi3dmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:43 INFO - Running setup.py (path:/tmp/pip-SJWDYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:43 INFO - Running setup.py (path:/tmp/pip-u7UwdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:43 INFO - Running setup.py (path:/tmp/pip-mo3wPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:17:43 INFO - Running setup.py install for manifestparser 11:17:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:17:43 INFO - Running setup.py install for mozcrash 11:17:43 INFO - Running setup.py install for mozdebug 11:17:44 INFO - Running setup.py install for mozdevice 11:17:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:17:44 INFO - Running setup.py install for mozfile 11:17:44 INFO - Running setup.py install for mozhttpd 11:17:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:17:44 INFO - Running setup.py install for mozinfo 11:17:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:17:44 INFO - Running setup.py install for mozInstall 11:17:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:17:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:17:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:17:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:17:44 INFO - Running setup.py install for mozleak 11:17:44 INFO - Running setup.py install for mozlog 11:17:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:17:44 INFO - Running setup.py install for moznetwork 11:17:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:17:44 INFO - Running setup.py install for mozprocess 11:17:44 INFO - Running setup.py install for mozprofile 11:17:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:17:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:17:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:17:45 INFO - Running setup.py install for mozrunner 11:17:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:17:45 INFO - Running setup.py install for mozscreenshot 11:17:45 INFO - Running setup.py install for moztest 11:17:45 INFO - Running setup.py install for mozversion 11:17:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:17:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:17:45 INFO - Cleaning up... 11:17:45 INFO - Return code: 0 11:17:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17: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')]} 11:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17: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')]} 11:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd36a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7130>, '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 0xed8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed84c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', '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 11:17:45 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 11:17:45 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 11:17:45 INFO - Using env: {'DISPLAY': ':0', 11:17:45 INFO - 'HOME': '/home/cltbld', 11:17:45 INFO - 'LANG': 'en_US.UTF-8', 11:17:45 INFO - 'LANGUAGE': 'en_US:en', 11:17:45 INFO - 'LOGNAME': 'cltbld', 11:17:45 INFO - 'MAIL': '/var/mail/cltbld', 11:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:45 INFO - 'MOZ_NO_REMOTE': '1', 11:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:45 INFO - 'NO_EM_RESTART': '1', 11:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:45 INFO - 'PWD': '/builds/slave/test', 11:17:45 INFO - 'SHELL': '/bin/bash', 11:17:45 INFO - 'SHLVL': '1', 11:17:45 INFO - 'TERM': 'linux', 11:17:45 INFO - 'TMOUT': '86400', 11:17:45 INFO - 'USER': 'cltbld', 11:17:45 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', 11:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:45 INFO - '_': '/tools/buildbot/bin/python'} 11:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:17:45 INFO - Running setup.py (path:/tmp/pip-VwabJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:17:45 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)) 11:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:17:45 INFO - Running setup.py (path:/tmp/pip-cfmRtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:17:45 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)) 11:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:17:45 INFO - Running setup.py (path:/tmp/pip-rZiVDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:17:45 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)) 11:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:17:45 INFO - Running setup.py (path:/tmp/pip-5s34um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:17:46 INFO - Running setup.py (path:/tmp/pip-Ubm9Ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:17:46 INFO - Running setup.py (path:/tmp/pip-gfg4No-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:17:46 INFO - Running setup.py (path:/tmp/pip-aoUL5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:17:46 INFO - Running setup.py (path:/tmp/pip-GUEH0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:17:46 INFO - Running setup.py (path:/tmp/pip-kmBx7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:17:46 INFO - Running setup.py (path:/tmp/pip-oeU0Nl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:17:46 INFO - Running setup.py (path:/tmp/pip-LM2unu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:17:46 INFO - Running setup.py (path:/tmp/pip-uv8eVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:17:46 INFO - Running setup.py (path:/tmp/pip-zknGmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:17:46 INFO - Running setup.py (path:/tmp/pip-zCdFlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:46 INFO - Running setup.py (path:/tmp/pip-5KComw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:17:46 INFO - Running setup.py (path:/tmp/pip-NKtocK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:17:46 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)) 11:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:17:46 INFO - Running setup.py (path:/tmp/pip-0uYSa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:17:46 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)) 11:17:46 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)) 11:17:46 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)) 11:17:46 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)) 11:17:46 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)) 11:17:46 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)) 11:17:46 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)) 11:17:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:17:46 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 11:17:46 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 11:17:46 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 11:17:46 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 11:17:48 INFO - Downloading blessings-1.6.tar.gz 11:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:17:48 INFO - Installing collected packages: blessings 11:17:48 INFO - Running setup.py install for blessings 11:17:48 INFO - Successfully installed blessings 11:17:48 INFO - Cleaning up... 11:17:48 INFO - Return code: 0 11:17:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:17:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:48 INFO - Reading from file tmpfile_stdout 11:17:48 INFO - Current package versions: 11:17:48 INFO - argparse == 1.2.1 11:17:48 INFO - blessings == 1.6 11:17:48 INFO - blobuploader == 1.2.4 11:17:48 INFO - docopt == 0.6.1 11:17:48 INFO - functools32 == 3.2.3-2 11:17:48 INFO - jsonschema == 2.5.1 11:17:48 INFO - manifestparser == 1.1 11:17:48 INFO - mozInstall == 1.13 11:17:48 INFO - mozcrash == 1.0 11:17:48 INFO - mozdebug == 0.1 11:17:48 INFO - mozdevice == 0.51 11:17:48 INFO - mozfile == 1.2 11:17:48 INFO - mozhttpd == 0.7 11:17:48 INFO - mozinfo == 0.10 11:17:48 INFO - mozleak == 0.1 11:17:48 INFO - mozlog == 3.5 11:17:48 INFO - moznetwork == 0.27 11:17:48 INFO - mozprocess == 0.25 11:17:48 INFO - mozprofile == 0.28 11:17:48 INFO - mozrunner == 6.13 11:17:48 INFO - mozscreenshot == 0.1 11:17:48 INFO - mozsystemmonitor == 0.3 11:17:48 INFO - moztest == 0.8 11:17:48 INFO - mozversion == 1.4 11:17:48 INFO - psutil == 3.1.1 11:17:48 INFO - requests == 1.2.3 11:17:48 INFO - wsgiref == 0.1.2 11:17:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd36a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7130>, '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 0xed8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed84c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', '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 11:17:48 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 11:17:48 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 11:17:48 INFO - Using env: {'DISPLAY': ':0', 11:17:48 INFO - 'HOME': '/home/cltbld', 11:17:48 INFO - 'LANG': 'en_US.UTF-8', 11:17:48 INFO - 'LANGUAGE': 'en_US:en', 11:17:48 INFO - 'LOGNAME': 'cltbld', 11:17:48 INFO - 'MAIL': '/var/mail/cltbld', 11:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:48 INFO - 'MOZ_NO_REMOTE': '1', 11:17:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:48 INFO - 'NO_EM_RESTART': '1', 11:17:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:48 INFO - 'PWD': '/builds/slave/test', 11:17:48 INFO - 'SHELL': '/bin/bash', 11:17:48 INFO - 'SHLVL': '1', 11:17:48 INFO - 'TERM': 'linux', 11:17:48 INFO - 'TMOUT': '86400', 11:17:48 INFO - 'USER': 'cltbld', 11:17:48 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', 11:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:48 INFO - '_': '/tools/buildbot/bin/python'} 11:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:48 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)) 11:17:48 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)) 11:17:48 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)) 11:17:48 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)) 11:17:48 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)) 11:17:48 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)) 11:17:48 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)) 11:17:48 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)) 11:17:48 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)) 11:17:48 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:17:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:17:49 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)) 11:17:49 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)) 11:17:49 INFO - Installing collected packages: simplejson 11:17:49 INFO - Running setup.py install for simplejson 11:17:50 INFO - building 'simplejson._speedups' extension 11:17:50 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 11:17:50 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 11:17:50 INFO - Successfully installed simplejson 11:17:50 INFO - Cleaning up... 11:17:50 INFO - Return code: 0 11:17:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:17:50 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')]} 11:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:17:50 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')]} 11:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:17:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd36a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed9f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7130>, '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 0xed8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed84c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', '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 11:17:50 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 11:17:50 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 11:17:50 INFO - Using env: {'DISPLAY': ':0', 11:17:50 INFO - 'HOME': '/home/cltbld', 11:17:50 INFO - 'LANG': 'en_US.UTF-8', 11:17:50 INFO - 'LANGUAGE': 'en_US:en', 11:17:50 INFO - 'LOGNAME': 'cltbld', 11:17:50 INFO - 'MAIL': '/var/mail/cltbld', 11:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:17:50 INFO - 'MOZ_NO_REMOTE': '1', 11:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:17:50 INFO - 'NO_EM_RESTART': '1', 11:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:17:50 INFO - 'PWD': '/builds/slave/test', 11:17:50 INFO - 'SHELL': '/bin/bash', 11:17:50 INFO - 'SHLVL': '1', 11:17:50 INFO - 'TERM': 'linux', 11:17:50 INFO - 'TMOUT': '86400', 11:17:50 INFO - 'USER': 'cltbld', 11:17:50 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', 11:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:17:50 INFO - '_': '/tools/buildbot/bin/python'} 11:17:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:17:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:17:51 INFO - Cleaning up... 11:17:51 INFO - Return code: 0 11:17:51 INFO - Running post-action listener: _resource_record_post_action 11:17:51 INFO - Running post-action listener: _start_resource_monitoring 11:17:51 INFO - Starting resource monitoring. 11:17:51 INFO - [mozharness: 2017-08-20 18:17:51.235911Z] Finished create-virtualenv step (success) 11:17:51 INFO - [mozharness: 2017-08-20 18:17:51.236379Z] Running install step. 11:17:51 INFO - Running pre-action listener: _resource_record_pre_action 11:17:51 INFO - Running main action method: install 11:17:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:17:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:17:51 INFO - Reading from file tmpfile_stdout 11:17:51 INFO - Detecting whether we're running mozinstall >=1.0... 11:17:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:17:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:17:51 INFO - Reading from file tmpfile_stdout 11:17:51 INFO - Output received: 11:17:51 INFO - Usage: mozinstall [options] installer 11:17:51 INFO - Options: 11:17:51 INFO - -h, --help show this help message and exit 11:17:51 INFO - -d DEST, --destination=DEST 11:17:51 INFO - Directory to install application into. [default: 11:17:51 INFO - "/builds/slave/test"] 11:17:51 INFO - --app=APP Application being installed. [default: firefox] 11:17:51 INFO - mkdir: /builds/slave/test/build/application 11:17:51 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'] 11:17:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:18:09 INFO - Reading from file tmpfile_stdout 11:18:09 INFO - Output received: 11:18:09 INFO - /builds/slave/test/build/application/firefox/firefox 11:18:09 INFO - Running post-action listener: _resource_record_post_action 11:18:09 INFO - [mozharness: 2017-08-20 18:18:09.434393Z] Finished install step (success) 11:18:09 INFO - [mozharness: 2017-08-20 18:18:09.434547Z] Running setup-mitmproxy step. 11:18:09 INFO - Running pre-action listener: _resource_record_pre_action 11:18:09 INFO - Running main action method: setup_mitmproxy 11:18:09 INFO - Skipping: mitmproxy is not required 11:18:09 INFO - Running post-action listener: _resource_record_post_action 11:18:09 INFO - [mozharness: 2017-08-20 18:18:09.435081Z] Finished setup-mitmproxy step (success) 11:18:09 INFO - [mozharness: 2017-08-20 18:18:09.435183Z] Running run-tests step. 11:18:09 INFO - Running pre-action listener: _resource_record_pre_action 11:18:09 INFO - Running pre-action listener: _set_gcov_prefix 11:18:09 INFO - Running main action method: run_tests 11:18:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:18:09 INFO - Python 2.7.3 11:18:09 INFO - Return code: 0 11:18:09 INFO - grabbing minidump binary from tooltool 11:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:18:09 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed7130>, '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 0xed8030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed84c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:18:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:18:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:18:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:18:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:18:09 INFO - Return code: 0 11:18:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:18:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:18:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:18:09 INFO - ENV: RUST_BACKTRACE is now full 11:18:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:18:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:18:09 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/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 11:18:09 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/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 11:18:09 INFO - Using env: {'DISPLAY': ':0', 11:18:09 INFO - 'HOME': '/home/cltbld', 11:18:09 INFO - 'LANG': 'en_US.UTF-8', 11:18:09 INFO - 'LANGUAGE': 'en_US:en', 11:18:09 INFO - 'LOGNAME': 'cltbld', 11:18:09 INFO - 'MAIL': '/var/mail/cltbld', 11:18:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:18:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:09 INFO - 'MOZ_NO_REMOTE': '1', 11:18:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:18:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:18:09 INFO - 'NO_EM_RESTART': '1', 11:18:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:09 INFO - 'PWD': '/builds/slave/test', 11:18:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:18:09 INFO - 'RUST_BACKTRACE': 'full', 11:18:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:18:09 INFO - 'SHELL': '/bin/bash', 11:18:09 INFO - 'SHLVL': '1', 11:18:09 INFO - 'TERM': 'linux', 11:18:09 INFO - 'TMOUT': '86400', 11:18:09 INFO - 'USER': 'cltbld', 11:18:09 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200', 11:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:09 INFO - '_': '/tools/buildbot/bin/python'} 11:18:09 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/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 11:18:09 INFO - mozversion application_buildid: 20170820170949 11:18:09 INFO - mozversion application_changeset: cab35526779367774b3ecea2f7a8a5c0993caa77 11:18:09 INFO - mozversion application_display_name: Nightly 11:18:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:18:09 INFO - mozversion application_name: Firefox 11:18:09 INFO - mozversion application_remotingname: firefox 11:18:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:18:09 INFO - mozversion application_vendor: Mozilla 11:18:09 INFO - mozversion application_version: 57.0a1 11:18:09 INFO - mozversion platform_buildid: 20170820170949 11:18:09 INFO - mozversion platform_changeset: cab35526779367774b3ecea2f7a8a5c0993caa77 11:18:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:18:09 INFO - mozversion platform_version: 57.0a1 11:18:09 INFO - using testdate: 1503253089 11:18:09 INFO - actual date: 1503253089 11:18:09 INFO - starting webserver on 'localhost:59930' 11:18:09 INFO - SUITE-START | Running 2 tests 11:18:09 INFO - TEST-START | dromaeo_css 11:18:09 INFO - Initialising browser for dromaeo_css test... 11:18:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59930/getInfo.html -profile /tmp/tmpzXDF5r/profile 11:18:09 INFO - TEST-INFO | started process 1081 (/builds/slave/test/build/application/firefox/firefox http://localhost:59930/getInfo.html) 11:18:15 INFO - TEST-INFO | 1081: exit 0 11:18:15 INFO - Browser initialized. 11:18:15 INFO - Running cycle 1/1 for dromaeo_css test... 11:18:15 INFO - TEST-INFO | started process 1329 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzXDF5r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:18:16 INFO - PID 1329 | 11:18:16 INFO - PID 1329 | (/builds/slave/test/build/application/firefox/firefox:1380): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:18:16 INFO - PID 1329 | 11:18:16 INFO - PID 1329 | 11:18:16 INFO - PID 1329 | (/builds/slave/test/build/application/firefox/firefox:1436): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:18:16 INFO - PID 1329 | 11:18:16 INFO - PID 1329 | __metrics Screen width/height:1600/1200 11:18:16 INFO - PID 1329 | colorDepth:24 11:18:16 INFO - PID 1329 | Browser inner width/height: 1024/768 11:18:16 INFO - PID 1329 | __metrics 11:18:26 INFO - PID 1329 | RSS: Main: 165208064 11:18:26 INFO - PID 1329 | 11:21:24 INFO - PID 1329 | Cycle 1(1): loaded http://localhost:59930/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59930/tests/dromaeo/cssquery-ext.html) 11:21:25 INFO - PID 1329 | RSS: Main: 169934848 11:21:25 INFO - PID 1329 | 11:24:27 INFO - PID 1329 | Cycle 1(1): loaded http://localhost:59930/tests/dromaeo/cssquery-ext.html (next: http://localhost:59930/tests/dromaeo/cssquery-jquery.html) 11:24:28 INFO - PID 1329 | RSS: Main: 166481920 11:24:28 INFO - PID 1329 | 11:27:29 INFO - PID 1329 | Cycle 1(1): loaded http://localhost:59930/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59930/tests/dromaeo/cssquery-mootools.html) 11:27:30 INFO - PID 1329 | RSS: Main: 168734720 11:27:30 INFO - PID 1329 | 11:30:31 INFO - PID 1329 | Cycle 1(1): loaded http://localhost:59930/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59930/tests/dromaeo/cssquery-prototype.html) 11:30:32 INFO - PID 1329 | RSS: Main: 166760448 11:30:32 INFO - PID 1329 | 11:33:35 INFO - PID 1329 | Cycle 1(1): loaded http://localhost:59930/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59930/tests/dromaeo/cssquery-yui.html) 11:33:36 INFO - PID 1329 | RSS: Main: 170741760 11:33:36 INFO - PID 1329 | 11:36:37 INFO - PID 1329 | Cycle 1(1): loaded http://localhost:59930/tests/dromaeo/cssquery-yui.html (next: http://localhost:59930/tests/dromaeo/cssquery-dojo.html) 11:36:38 INFO - PID 1329 | RSS: Main: 171081728 11:36:38 INFO - PID 1329 | 11:36:38 INFO - PID 1329 | __start_tp_report 11:36:38 INFO - PID 1329 | _x_x_mozilla_page_load 11:36:38 INFO - PID 1329 | _x_x_mozilla_page_load_details 11:36:38 INFO - PID 1329 | |i|pagename|runs| 11:36:38 INFO - PID 1329 | |0;dojo.html;3493.056874643847;3510.069831494656;3535.4873543336216;3552.626974167714;3567.2687099144678;6192.473639740628;6274.686265686714;6301.936980630192;6327.019312006641;6336.144620476234;6113.7860174893885;6181.227346581677;6188.133661287412;6199.00815869461;6206.875862482759;5409.9459005410035;5473.589480788937;5476;5489.258950041753;5500.724963751816;5478.424765399635;5484.012877682016;5546.251256080418;5565.332160140789;5576.86057848553;5005.674631148963;5355.116405793039;5381.0583147948955;5427.565794736412;5443.5100840924115;5422.105352616813;5467.4532546745;5503.972480137613;5522.254495643077;5531.557475401958;5335.706536140511;5426.647267927611;5489.258950041733;5506.146547285177;5507.834764957058;6139.815805525842;6156.846078848064;6177.7837775677635;6191.380861913818;6201.6899155042065;6760.0535924970545;6790.694418751168;6807.829804254933;6818.386345228953;6825.385715285598;6765.594064356105;6779.457643388517;6779.898301525481;6863.2793556676825;6869.896951545681;6141.140240366352;6204.751809927552;6221.377862213742;6312.210973628296;6377.8405539861415;6886.345797149263;6907.516473846883;6920.619365934922;6921.031055652213;6934.930650693529;6565.80302590923;6625.039369291522;6642.1033160523675;6644.800655980328;6648.202215734143;6849.623270720158;6860.828479287958;6867.931320686829;6877.105976223159;6885.690143943534;6663.267040625527;6666.866662666719;6752.493562982796;6754.493412994045;6761.898571521431;6757.966210169016;6773.153355830521;6844.657767111724;6848.657567121624;6857.657117144123;4810.134175848311;4863.635227357962;4908.214685650279;4918.262260660929;4920.803167873317;4353.390525326457;4375.824967001348;4383.671224658164;4428.047969686533;4434.733915965053;6436.227652681615;6440.484761219185;6450.451711604566;6514.088027676129;6528.608283503005;6787.5588086774205;6799.11611490503;6805;6842.4183944364295;6877.552959057645;6446.323136070645;6468.5472016958365;6479.481641468766;6494.123293355431;6494.805155845333;5428.321459817523;5467.808626698126;5490.203920431515;5495.587830912697;5517.724113794295;7037.753678621224;7104.325089116525;7145.821354466076;7234.059572255573;7251.1298644163035;6562.146920900253;6701.597904125768;6704.7988560343265;6705.497087718538;6707.765228216989;7090.539114957512;7128.28717128283;7139.2503787101605;7140.357367836919;7144.535605185646;6697.497687673346;6721.899171512334;6762.391384775394;6788.796336109925;6793;6808.421284190899;6811.8978215325815;6906.343897329745;6913.5506192097355;6913.827154321182;6410.967945160244;6500.057491663777;6510.283868774526;6514.967425162844;6569.737210511526;6563.803085907431;6580.407763301326;6590.637514936724;6617.669116544057;6640.269570347161;6655.966720166368;6675.899861502178;6718.294579069127;6722.697478613572;6727.764528241488;6651.833704157435;6661.733530658719;6701.8324541884895;6747.966260168668;6762.323767623395;6433.453156481752;6447.742090316522;6502.349765023459;6503.089567460464;6505.154329937078 11:36:38 INFO - PID 1329 | |1;ext.html;885.182128394847;886.6302108099544;911.1708345405682;945.5603144537788;948.9525523723812;42058;42875.785621071926;42966.7851660742;43024.13951720964;43121.78439107804;40231.39652905209;40236.798816005954;40510.59489405105;40560.594394056054;40584.39123413151;6951.131108611424;7036.366726994569;7038.296170382972;7050.083489146429;7050.541714788548;7056.153261608614;7140;7144.464165187605;7154.8569028619395;7158.570485770871;7101.04135941649;7106.680199391014;7123.180834204081;7126.180489243726;7130.144382674086;7113.1464224292895;7123.821904452404;7128.0377149084725;7128.750493732695;7145.464090193256;6469.35306469354;6502.479801615859;6512.023196520559;6519.3154718754795;6522.249941256721;36150.276994459964;36275.27449450996;36371.272574548624;36427.271454571026;36497.817510912544;3311.8840840570706;3326.4012477753995;3326.966730332714;3329.500574913758;3335.4329763940186;29107.708922910922;29193.56209656857;29203.56194657082;29222.56166157488;29225;4603.240465323218;4639.9536004640195;4643.048175124091;4672.602828759559;4677.789499472532;197865;200404;202276;202659;205799;50787.23819142716;51062.74468627633;51099;51112;51178.74410627923;53397.73301133547;53561;53568.46431535713;53681;53739.73130134324;16161;16211;16261.593460163354;16290.674186516204;16430.589235269214;13432.731345373038;13468.797968030487;13473;13480;13482.730345393038;13610.319484025758;13653.931730341483;13692.931535342259;13710.24593647359;13758;5244.790208391698;5261.421243663194;5313.681179129265;5361.070014794671;5383.5962302826665;1058.513083981362;1060.2737125069352;1071.2929466552039;1088.7659153282082;1101.7631209290041;23467.7653223469;23687.881560592432;23780.405489862893;24014.27957161288;24049.158279460135;1187.5962172861268;1189.6133756529164;1200.447794014763;1209.0992210803008;1211.5759484180467;12564.497420103093;12616.243025418504;12654.81017784734;12681.429335679917;12757.617271481871;249675;250301;250547;250878;251641;52389.7380513095;52459.47540524622;52622.736886315324;52631.47368526342;52832.73583632057;1485.094092603511;1502.902311349737;1534.9309281082378;1552.5031989763168;1557.6573153906122;23154.421139471648;23339.76660233376;23361.182358617367;23400.297991060295;23737.16919907795;37791;37830.243395131394;37874;37896.62103379041;37933.24133517259;220651;221743;222007;222314;222891;32338;32601.510977334885;34286.48570271398;34365.484517731755;35451.29097417986;44590.67176297288;45085.77457112693;45172.096558068;45598.54401456076;48456.7577162126;33954.49068264027;34800.30399391947;35001;35037.299254014266;35045.47431788474;34569.827150865094;34683.65316346804;34789.47815782714;34935.30129397347;35542.46686299759;40755.59244407518;40851.7957410211;41131.383029253986;41177.588224117375;41302;34132;34375.48436773501;34481;34629;34894.476582851785;25304.74695253024;25500.872495637403;25974.480510390065;26051.75004617832;26515 11:36:38 INFO - PID 1329 | |2;jquery.html;569.4191924237275;579.8173575323772;580.9970950145249;584.777784441912;593.2762030323006;22896.771032289693;23675.881620591874;23846.165384211556;23932.282031539038;23985.880070599665;27250.45499090017;27712.584311235347;27798.30504237395;27829.304267393327;27876.442471150614;6448.871022579546;6602.8679426411445;6603.834904127387;6606.207255129391;6607.867842643144;6224.159738435299;6404.775832845851;6446.774362897299;6456.677166141698;6458.999999999976;6401.135846660688;6409.679516024204;6411.134496842913;6415.294317625057;6440.388163124496;6406.679666016727;6417.486601071903;6418.261899881527;6422.646754428528;6427.003814408774;5976.103584462322;5980.940190598082;5982.46157845796;5990.430909063632;5994.880102397971;30121.698783012107;30726.23184420385;30782.076537703906;31434.37131257385;31842.840785796154;2195.9890200549053;2213.1368766181204;2213.955720885573;2216.612092883739;2217.81148602369;18846.81153188478;19316.613667726706;19376.612467750565;19378.61242775151;19382.515437114045;2378.6669866218745;2470.1601455505215;2495.238952119603;2514.836535625197;2515.597504399287;147182;152786;153759.2312038444;153959;154232.22883885508;15111.244437778067;15670.373185072469;15845;15960.521184364488;16254.837451625568;24432;24509.754902451103;24530.632040519406;24535.63196552053;24650.137245196333;10683.732906677395;10703.304285221435;10764.892351076389;10771.138308935266;10849.783004340026;9076.092390761003;9441.480718560546;9800.166985806143;9852.113309802153;9974.850377244347;9085.863712044325;9576.808463830825;9682.467464289392;9751.463669498246;9863.80272394548;2715.9592606110923;2749.9725002750115;2751.4222013377016;2757.1177223288355;2852.957205641917;1039.6880935719405;1040.7398150462384;1041.0838462153408;1050.9421981790922;1056.366180291834;21429.357119286447;21684.674729879065;21934;22157.556848862932;22170.667439988414;1087.7171935296722;1116.7933932222566;1127.002602696603;1128.6839684888243;1129.249049382168;11577.305361678325;11957.342346171044;12036.578719744766;12072.879271207352;12077.758444831054;576724;590055;598856;600165;617317;143273;144617.27691361686;145276;148251.25874370776;148365.2581737106;1298.733759579284;1329.5678904356123;1331.0549509848117;1337.2845527642664;1350.4800651748951;19213.903930480257;19660.01699915027;22680.1244713952;23875.403114922265;24384.390390240387;64897.67551162214;66623.66688166528;67840.6607966957;68353.6582317105;68992;80835.19164808276;81240.59379703064;81428;81684.59157704173;82301.58849205716;13354.532591359644;13869.237191954539;15108.169050701877;15332.923335383251;15781.526554203392;25254;25338.873305633355;25395.492090157724;25460.49079018372;25490;19693.803061969196;20242.79757202409;20492.59014819725;20526.38420847377;20624.27815026467;17577.824221758132;17914.10429478495;18277.634447310713;18349.81650183481;18511.629767404847;20809.583808324052;20997.265095721577;21076.894615526824;21256.25603103884;21339.14643414246;15252;15459.381624734884;15559.144247066068;15560.144192069545;15569.532914012598;19231;19239.03804809726;19272.518187045436;19448.611027779647;19826.306079287155 11:36:38 INFO - PID 1329 | |3;mootools.html;1460.7370673278808;1472.9189894555795;1486.7918491411203;1493.4623535527214;1516.2797671106225;15712.13583252922;16293.429729959455;16362.590935226624;16365.672686546277;16399.918000410013;15665.92167039166;16797.16014199288;16853.41013064543;16864.83135168648;16898.324067037334;2264.399934017483;2290.278562252885;2294.0594356313914;2294.919677811277;2295.2196253273883;2558.897644094234;2627.605859121128;2631.8682966324473;2682.088090049383;2682.28919336376;2643.2466746977116;2663.6270922070926;2673.1579552441017;2724.3870129220963;2726.0322585482168;2576.5748651472577;2602.947941041178;2606.7653911147995;2614.2810727050023;2618.751218634227;2594.6237795519733;2605.387733882536;2622.5148347555764;2622.6983896851916;2623.7245089265734;15630.296636651377;15706.764398534031;15843.524694259191;15856;15866.286017129258;7901.841963160705;8176.427650064498;8186.099529051799;8205.302549283319;8209.958950205271;4915.9754201229125;4968.378952630921;5049.267856160836;5125.82059627915;5139.383274007106;1913.167772019176;1931.3143833938889;1936.1674479973606;1974.8222659960672;1978.7526559180103;28061.298467538272;28090.438191236266;28117.718822811716;28247.15258542247;28268;6462.127612772216;6598.934010659832;6676.365745254193;6785.762498312535;6811.25076241613;19156.23375064982;19163.61672766565;19169;19169.904150479157;19195.712064319046;7766.495177813424;7894.210578942175;7972.083210430758;7976.920230797734;7983.68065277394;6345.302016778151;7324.890126648104;7361.595112268769;7364.22675619063;7388.039554857834;5047.268146118792;5296.973515132399;5298.443663415363;5300.3639563252655;5305.045091883498;1301.1152416356779;1303.4199781097511;1312.0880987713447;1319.736052789446;1328.6479083043002;923.0677016213539;930.6696122876417;931.9580618872031;941.6092321686424;948.1514044929887;7761.5731134787;7780.533168009937;7782.610869456617;7803.336716379058;7882.566458844703;737.5353527277888;746.1941103608091;746.6490749347798;751.3200553499092;753.2542782645252;4741.83403580873;4819.1566475867285;4841.3222148899185;4913.975430122898;4914.361133052752;21736.456588585414;22090.226842060772;22924.19765308206;23005.309840704806;23190.1883434079;22330.44173895633;22930.885345573166;22995.88502057479;23043.423914402276;23131.653025204636;12084.697882553006;12448.190867593577;12546.686332841751;12549.87450125487;12569.93715031419;8520.36097292718;8597.312215022657;8667.826643467222;8670.0896405879;8773.780655483664;19285;19924;20012.399628011182;20293.898530507253;20345;20427.79572204259;20495.4876128098;20613.484662883548;20752.48118797042;21013;10752.784944301227;11104.44477776124;11333.886661133283;11548.884511154782;11561.30632162073;14946.925265374039;15155.545333640008;15175.544733658007;15180.848191517944;15196.772048419503;12068.577599783965;12095.697607559881;12177.147599667938;12251.816222756488;12330.691732706755;11785.705357366134;11843.170978031456;11943.462544185706;12019.75960480768;12057.336846473529;10078.661505805969;10158.796824063329;10285.382877027403;10301.587936482456;10304.845427318745;7949.443538952449;8020.799480013046;8023.959880200561;8079.232472915299;8103.635336409758;8064.758057258292;8080.2727754502375;8094.190580941859;8112.83774324522;8248.216419440143 11:36:38 INFO - PID 1329 | |4;prototype.html;513.9691618502887;522.5532169994653;536.3831593667283;539.2019810680191;540.5837505121057;6145.846353841156;6190.7214175362105;6221.346758590351;6243.71903264353;6250;6107.908381374272;6131.509479241661;6132.110843927628;6175.240056583874;6225.750969961207;4890.193118135503;4891.14404979129;4921.286413470045;4938.703677779326;4966;4662.743549104798;4805.212976473636;4811.735354555498;4865.68373055752;4881.389141583269;4766.952330476685;4768.356271903283;4772.689775164603;4778.139934811733;4780.067886762083;4779.856604301876;4789.37738094049;4804;4822.228443449067;4836.758162091916;4226.387173859804;4323.351497275403;4326.740395576244;4338.934915976231;4353.978230108829;5944.978707239559;5976.432238937294;5986.760529578812;5994.7602095916545;6011.5190784737115;5705;5711.7715291388295;5737.196792449061;5738.196652468658;5765.855853603652;6544.607323560602;6557.377049180321;6561.835954101138;6569;6580.80257592273;4945.554900059012;4953.405591329028;4960.627952903511;4962.21360310288;4967.428745694219;6616.735330586771;6622.768203112868;6706.53054286205;6724.226713927912;6751.932480675179;5060.822871199564;5063.038022775734;5064.442911279756;5099.623101762503;5108;5084.796608135707;5102.132637451642;5142.228665700175;5156.613254005964;5190.169572868398;5686.658800471985;5713.428807078087;5723.54211663066;5729.427057294321;5742.339630942495;6532.281449040602;6564.343565643398;6581.835454113685;6609.405153536205;6646.933530664632;1763.4709587123812;1769.504538729158;1781.6169523552499;1786.0890945617828;1791.6864548703925;1200.1359021504502;1230.9536893640334;1241.0071942446189;1263.860975292717;1276.6361586947676;6210.161628180228;6223.408776166257;6282.842928926813;6293.905591416133;6322.146510221153;6548.8035358939305;6560.179977502812;6670.4997125215805;6726.932730672631;6764.188297404343;6294;6306.148669929501;6315.431611154926;6321.557490975588;6379.703306809545;3471.2189757304404;3489.7208223342072;3490.1798077451776;3551.3074950384944;3582.5163602913794;7018.263082376379;7022;7047.660944420646;7175.138983322035;7222.566646001257;6307;6801.829954251084;6831.829204269834;6918.481113916376;6936.826579335456;6898.447574397505;6975.8604827903155;7021.5787052777;7063.999999999897;7064.364207221375;6461.741530338733;6590.47276217911;6613.900791488228;6620.205575330799;6721.731130754715;6540;6584.8353791155605;6622.63575503352;6706.463482921452;6743.35938085881;7052.506324557232;7098.964505177441;7114.336116899697;7118.537295075804;7196.712131514681;4937.481564435682;5000.274960130688;5107.591392688651;5129.820456284012;5140.357455318085;6423.935760642334;6530.346965303432;6558.475321974135;6778.373190434162;6839.418649414855;6401.743930242738;6554.4756419487285;6597.439217666552;6621.702023408862;6646.335366463315;6464.252692605718;6484.513661475503;6545.901811472927;6558.344165583403;6567.704453299709;6495.188101487314;6586.2755096940255;6617.966910165418;6627.469802415699;6633.270340262664;6575.539712220098;6588.40704336612;6597.1423714916755;6683.3984941353565;6710.664466776544;6348.77779277723;6357.777477788255;6411.3909178627955;6452.419282264619;6456.903146452713 11:36:38 INFO - PID 1329 | |5;yui.html;943.876786623918;950.9239260859131;970.9998701337615;974.6588693957116;988.8862780780208;16481.175941202953;16721;19900.60198796025;20422.6936595951;21464.356069317906;21011.684824727643;21692.566148677055;21750;21846.235381761642;21927.12291508342;1005.8239808033583;1037.289456722144;1041.5625437316307;1042.8592140061107;1044.7805960748215;1042.7810159866438;1093.568040623953;1101.6860194844471;1106.0764261841332;1107.307932542161;1153.8269259611084;1157.866845312787;1158.3281696615984;1161.639891633592;1171.7246447084972;1156.6240971684194;1158.9594364197255;1161.488944864257;1165.0737663557493;1165.213480900389;844.3118858130604;844.7465760271893;844.7465760271893;845.045099038083;846.191886748154;18995.240190392367;19152.712709309373;19163.425097247105;19833.404997850088;20477.180912763473;20342.28801991938;21210.575788484297;21364.572708545744;21623.783762162333;21656.783432165634;17099.82900170995;17135.82864171355;17142.571435714206;17220.56948576283;17669.028203448805;3806.1055651921774;3820.9235815283537;3822.8661996830256;3824.1204522959597;3826.6364695354177;146738;147866;148307;148701;149809.25095374562;16305.266263018193;17028.318867245172;17060.488185354458;17119.400820971205;17122.229499672543;32409.67590324114;32851;33447.83276083604;33569.832150839575;33600.327993440485;8678.435901666498;8787.692430764893;8800.515971621495;8805.823883522293;8816.471011739188;4565.680402371802;4610.907781844345;4653.744044077541;4663.883402914954;4676.321933319649;4938.358013458227;5352.4915133062295;5402.945970540244;5405.729713514387;5413.2150838128255;1005.2410430125209;1032.9638462653922;1036.5905467340358;1045.1586472889396;1045.4406892312577;698.2842586348931;705.9541129826545;714.3356678289241;717.1573401253611;717.9461540384492;12711.936440317739;14521.273936303143;14694.412223511154;14796.48212312564;15553.22233888301;650.2814390098872;654.257417830756;657.4444594317794;660.6399512265826;666.4035688059257;6483.384078512534;6565.212174539086;6651.434628056572;6716.764913228014;6729.0915726376315;138231;138683;141604.29197853946;144291;144834.2758286202;120333;121103;121195;122185.38907305406;122414;99339.50330248447;100351.49824250978;100411.49794250981;105096.47451762845;106507;10936.289141205796;11133.387663678575;11134.164937629872;11153.219274650697;11238.381888996184;49305;49680.25479617881;50135;50549.49450505448;51313.48686513087;62854;64247;65702.67148664226;67780;67944.32055679578;16448;16656.16719164013;16798;16924.830751692818;16980.915095424443;17713.114344282993;17751.289948402435;17897.552561186076;17963.640727185644;17978.5505362367;17345.653086938444;17440.86634368762;17488.387906423213;17495.125243738017;17584.824151758832;15787.605309867346;15874.444394446138;15890.60273493172;19358.128884200527;19751.11119999632;18669;18846.151923163765;19215.32746353927;19216.807831921502;19267.421977340702;13751.518696845962;13855.099418537762;13878.444862205399;13927.860721392657;14726.1900595464;14704.338304776526;14855.702885942004;15319;15383.923080384526;15392.846071539141 11:36:38 INFO - PID 1329 | __end_tp_report 11:36:38 INFO - PID 1329 | __start_cc_report 11:36:38 INFO - PID 1329 | _x_x_mozilla_cycle_collect,332 11:36:38 INFO - PID 1329 | __end_cc_report 11:36:38 INFO - PID 1329 | __startTimestamp1503254198120__endTimestamp 11:36:38 INFO - PID 1329 | 11:36:38 INFO - PID 1329 | ------- Summary: start ------- 11:36:38 INFO - PID 1329 | Number of tests: 6 11:36:38 INFO - PID 1329 | 11:36:38 INFO - PID 1329 | [#0] dojo.html Cycles:165 Average:6222.45 Median:6514.97 stddev:822.09 (12.6%) stddev-sans-first:796.24 11:36:38 INFO - PID 1329 | Values: 3493.1 3510.1 3535.5 3552.6 3567.3 6192.5 6274.7 6301.9 6327.0 6336.1 6113.8 6181.2 6188.1 6199.0 6206.9 5409.9 5473.6 5476.0 5489.3 5500.7 5478.4 5484.0 5546.3 5565.3 5576.9 5005.7 5355.1 5381.1 5427.6 5443.5 5422.1 5467.5 5504.0 5522.3 5531.6 5335.7 5426.6 5489.3 5506.1 5507.8 6139.8 6156.8 6177.8 6191.4 6201.7 6760.1 6790.7 6807.8 6818.4 6825.4 6765.6 6779.5 6779.9 6863.3 6869.9 6141.1 6204.8 6221.4 6312.2 6377.8 6886.3 6907.5 6920.6 6921.0 6934.9 6565.8 6625.0 6642.1 6644.8 6648.2 6849.6 6860.8 6867.9 6877.1 6885.7 6663.3 6666.9 6752.5 6754.5 6761.9 6758.0 6773.2 6844.7 6848.7 6857.7 4810.1 4863.6 4908.2 4918.3 4920.8 4353.4 4375.8 4383.7 4428.0 4434.7 6436.2 6440.5 6450.5 6514.1 6528.6 6787.6 6799.1 6805.0 6842.4 6877.6 6446.3 6468.5 6479.5 6494.1 6494.8 5428.3 5467.8 5490.2 5495.6 5517.7 7037.8 7104.3 7145.8 7234.1 7251.1 6562.1 6701.6 6704.8 6705.5 6707.8 7090.5 7128.3 7139.3 7140.4 7144.5 6697.5 6721.9 6762.4 6788.8 6793.0 6808.4 6811.9 6906.3 6913.6 6913.8 6411.0 6500.1 6510.3 6515.0 6569.7 6563.8 6580.4 6590.6 6617.7 6640.3 6656.0 6675.9 6718.3 6722.7 6727.8 6651.8 6661.7 6701.8 6748.0 6762.3 6433.5 6447.7 6502.3 6503.1 6505.2 11:36:38 INFO - PID 1329 | 11:36:38 INFO - PID 1329 | [#1] ext.html Cycles:180 Average:39584.81 Median:35019.15 stddev:58644.77 (167.5%) stddev-sans-first:58737.30 11:36:38 INFO - PID 1329 | Values: 885.2 886.6 911.2 945.6 949.0 42058.0 42875.8 42966.8 43024.1 43121.8 40231.4 40236.8 40510.6 40560.6 40584.4 6951.1 7036.4 7038.3 7050.1 7050.5 7056.2 7140.0 7144.5 7154.9 7158.6 7101.0 7106.7 7123.2 7126.2 7130.1 7113.1 7123.8 7128.0 7128.8 7145.5 6469.4 6502.5 6512.0 6519.3 6522.2 36150.3 36275.3 36371.3 36427.3 36497.8 3311.9 3326.4 3327.0 3329.5 3335.4 29107.7 29193.6 29203.6 29222.6 29225.0 4603.2 4640.0 4643.0 4672.6 4677.8 197865.0 200404.0 202276.0 202659.0 205799.0 50787.2 51062.7 51099.0 51112.0 51178.7 53397.7 53561.0 53568.5 53681.0 53739.7 16161.0 16211.0 16261.6 16290.7 16430.6 13432.7 13468.8 13473.0 13480.0 13482.7 13610.3 13653.9 13692.9 13710.2 13758.0 5244.8 5261.4 5313.7 5361.1 5383.6 1058.5 1060.3 1071.3 1088.8 1101.8 23467.8 23687.9 23780.4 24014.3 24049.2 1187.6 1189.6 1200.4 1209.1 1211.6 12564.5 12616.2 12654.8 12681.4 12757.6 249675.0 250301.0 250547.0 250878.0 251641.0 52389.7 52459.5 52622.7 52631.5 52832.7 1485.1 1502.9 1534.9 1552.5 1557.7 23154.4 23339.8 23361.2 23400.3 23737.2 37791.0 37830.2 37874.0 37896.6 37933.2 220651.0 221743.0 222007.0 222314.0 222891.0 32338.0 32601.5 34286.5 34365.5 35451.3 44590.7 45085.8 45172.1 45598.5 48456.8 33954.5 34800.3 35001.0 35037.3 35045.5 34569.8 34683.7 34789.5 34935.3 35542.5 40755.6 40851.8 41131.4 41177.6 41302.0 34132.0 34375.5 34481.0 34629.0 34894.5 25304.7 25500.9 25974.5 26051.8 26515.0 11:36:38 INFO - PID 1329 | 11:36:38 INFO - PID 1329 | [#2] jquery.html Cycles:180 Average:40257.78 Median:13112.42 stddev:100461.69 (766.2%) stddev-sans-first:100699.32 11:36:38 INFO - PID 1329 | Values: 569.4 579.8 581.0 584.8 593.3 22896.8 23675.9 23846.2 23932.3 23985.9 27250.5 27712.6 27798.3 27829.3 27876.4 6448.9 6602.9 6603.8 6606.2 6607.9 6224.2 6404.8 6446.8 6456.7 6459.0 6401.1 6409.7 6411.1 6415.3 6440.4 6406.7 6417.5 6418.3 6422.6 6427.0 5976.1 5980.9 5982.5 5990.4 5994.9 30121.7 30726.2 30782.1 31434.4 31842.8 2196.0 2213.1 2214.0 2216.6 2217.8 18846.8 19316.6 19376.6 19378.6 19382.5 2378.7 2470.2 2495.2 2514.8 2515.6 147182.0 152786.0 153759.2 153959.0 154232.2 15111.2 15670.4 15845.0 15960.5 16254.8 24432.0 24509.8 24530.6 24535.6 24650.1 10683.7 10703.3 10764.9 10771.1 10849.8 9076.1 9441.5 9800.2 9852.1 9974.9 9085.9 9576.8 9682.5 9751.5 9863.8 2716.0 2750.0 2751.4 2757.1 2853.0 1039.7 1040.7 1041.1 1050.9 1056.4 21429.4 21684.7 21934.0 22157.6 22170.7 1087.7 1116.8 1127.0 1128.7 1129.2 11577.3 11957.3 12036.6 12072.9 12077.8 576724.0 590055.0 598856.0 600165.0 617317.0 143273.0 144617.3 145276.0 148251.3 148365.3 1298.7 1329.6 1331.1 1337.3 1350.5 19213.9 19660.0 22680.1 23875.4 24384.4 64897.7 66623.7 67840.7 68353.7 68992.0 80835.2 81240.6 81428.0 81684.6 82301.6 13354.5 13869.2 15108.2 15332.9 15781.5 25254.0 25338.9 25395.5 25460.5 25490.0 19693.8 20242.8 20492.6 20526.4 20624.3 17577.8 17914.1 18277.6 18349.8 18511.6 20809.6 20997.3 21076.9 21256.3 21339.1 15252.0 15459.4 15559.1 15560.1 15569.5 19231.0 19239.0 19272.5 19448.6 19826.3 11:36:38 INFO - PID 1329 | 11:36:38 INFO - PID 1329 | [#3] mootools.html Cycles:180 Average:9780.68 Median:2567.74 stddev:7248.98 (282.3%) stddev-sans-first:7242.37 11:36:38 INFO - PID 1329 | Values: 1460.7 1472.9 1486.8 1493.5 1516.3 15712.1 16293.4 16362.6 16365.7 16399.9 15665.9 16797.2 16853.4 16864.8 16898.3 2264.4 2290.3 2294.1 2294.9 2295.2 2558.9 2627.6 2631.9 2682.1 2682.3 2643.2 2663.6 2673.2 2724.4 2726.0 2576.6 2602.9 2606.8 2614.3 2618.8 2594.6 2605.4 2622.5 2622.7 2623.7 15630.3 15706.8 15843.5 15856.0 15866.3 7901.8 8176.4 8186.1 8205.3 8210.0 4916.0 4968.4 5049.3 5125.8 5139.4 1913.2 1931.3 1936.2 1974.8 1978.8 28061.3 28090.4 28117.7 28247.2 28268.0 6462.1 6598.9 6676.4 6785.8 6811.3 19156.2 19163.6 19169.0 19169.9 19195.7 7766.5 7894.2 7972.1 7976.9 7983.7 6345.3 7324.9 7361.6 7364.2 7388.0 5047.3 5297.0 5298.4 5300.4 5305.0 1301.1 1303.4 1312.1 1319.7 1328.6 923.1 930.7 932.0 941.6 948.2 7761.6 7780.5 7782.6 7803.3 7882.6 737.5 746.2 746.6 751.3 753.3 4741.8 4819.2 4841.3 4914.0 4914.4 21736.5 22090.2 22924.2 23005.3 23190.2 22330.4 22930.9 22995.9 23043.4 23131.7 12084.7 12448.2 12546.7 12549.9 12569.9 8520.4 8597.3 8667.8 8670.1 8773.8 19285.0 19924.0 20012.4 20293.9 20345.0 20427.8 20495.5 20613.5 20752.5 21013.0 10752.8 11104.4 11333.9 11548.9 11561.3 14946.9 15155.5 15175.5 15180.8 15196.8 12068.6 12095.7 12177.1 12251.8 12330.7 11785.7 11843.2 11943.5 12019.8 12057.3 10078.7 10158.8 10285.4 10301.6 10304.8 7949.4 8020.8 8024.0 8079.2 8103.6 8064.8 8080.3 8094.2 8112.8 8248.2 11:36:38 INFO - PID 1329 | 11:36:38 INFO - PID 1329 | [#4] prototype.html Cycles:180 Average:5565.62 Median:6246.86 stddev:1589.80 (25.4%) stddev-sans-first:1548.39 11:36:38 INFO - PID 1329 | Values: 514.0 522.6 536.4 539.2 540.6 6145.8 6190.7 6221.3 6243.7 6250.0 6107.9 6131.5 6132.1 6175.2 6225.8 4890.2 4891.1 4921.3 4938.7 4966.0 4662.7 4805.2 4811.7 4865.7 4881.4 4767.0 4768.4 4772.7 4778.1 4780.1 4779.9 4789.4 4804.0 4822.2 4836.8 4226.4 4323.4 4326.7 4338.9 4354.0 5945.0 5976.4 5986.8 5994.8 6011.5 5705.0 5711.8 5737.2 5738.2 5765.9 6544.6 6557.4 6561.8 6569.0 6580.8 4945.6 4953.4 4960.6 4962.2 4967.4 6616.7 6622.8 6706.5 6724.2 6751.9 5060.8 5063.0 5064.4 5099.6 5108.0 5084.8 5102.1 5142.2 5156.6 5190.2 5686.7 5713.4 5723.5 5729.4 5742.3 6532.3 6564.3 6581.8 6609.4 6646.9 1763.5 1769.5 1781.6 1786.1 1791.7 1200.1 1231.0 1241.0 1263.9 1276.6 6210.2 6223.4 6282.8 6293.9 6322.1 6548.8 6560.2 6670.5 6726.9 6764.2 6294.0 6306.1 6315.4 6321.6 6379.7 3471.2 3489.7 3490.2 3551.3 3582.5 7018.3 7022.0 7047.7 7175.1 7222.6 6307.0 6801.8 6831.8 6918.5 6936.8 6898.4 6975.9 7021.6 7064.0 7064.4 6461.7 6590.5 6613.9 6620.2 6721.7 6540.0 6584.8 6622.6 6706.5 6743.4 7052.5 7099.0 7114.3 7118.5 7196.7 4937.5 5000.3 5107.6 5129.8 5140.4 6423.9 6530.3 6558.5 6778.4 6839.4 6401.7 6554.5 6597.4 6621.7 6646.3 6464.3 6484.5 6545.9 6558.3 6567.7 6495.2 6586.3 6618.0 6627.5 6633.3 6575.5 6588.4 6597.1 6683.4 6710.7 6348.8 6357.8 6411.4 6452.4 6456.9 11:36:38 INFO - PID 1329 | 11:36:38 INFO - PID 1329 | [#5] yui.html Cycles:180 Average:26646.99 Median:17824.42 stddev:38986.69 (218.7%) stddev-sans-first:39048.28 11:36:38 INFO - PID 1329 | Values: 943.9 950.9 971.0 974.7 988.9 16481.2 16721.0 19900.6 20422.7 21464.4 21011.7 21692.6 21750.0 21846.2 21927.1 1005.8 1037.3 1041.6 1042.9 1044.8 1042.8 1093.6 1101.7 1106.1 1107.3 1153.8 1157.9 1158.3 1161.6 1171.7 1156.6 1159.0 1161.5 1165.1 1165.2 844.3 844.7 844.7 845.0 846.2 18995.2 19152.7 19163.4 19833.4 20477.2 20342.3 21210.6 21364.6 21623.8 21656.8 17099.8 17135.8 17142.6 17220.6 17669.0 3806.1 3820.9 3822.9 3824.1 3826.6 146738.0 147866.0 148307.0 148701.0 149809.3 16305.3 17028.3 17060.5 17119.4 17122.2 32409.7 32851.0 33447.8 33569.8 33600.3 8678.4 8787.7 8800.5 8805.8 8816.5 4565.7 4610.9 4653.7 4663.9 4676.3 4938.4 5352.5 5402.9 5405.7 5413.2 1005.2 1033.0 1036.6 1045.2 1045.4 698.3 706.0 714.3 717.2 717.9 12711.9 14521.3 14694.4 14796.5 15553.2 650.3 654.3 657.4 660.6 666.4 6483.4 6565.2 6651.4 6716.8 6729.1 138231.0 138683.0 141604.3 144291.0 144834.3 120333.0 121103.0 121195.0 122185.4 122414.0 99339.5 100351.5 100411.5 105096.5 106507.0 10936.3 11133.4 11134.2 11153.2 11238.4 49305.0 49680.3 50135.0 50549.5 51313.5 62854.0 64247.0 65702.7 67780.0 67944.3 16448.0 16656.2 16798.0 16924.8 16980.9 17713.1 17751.3 17897.6 17963.6 17978.6 17345.7 17440.9 17488.4 17495.1 17584.8 15787.6 15874.4 15890.6 19358.1 19751.1 18669.0 18846.2 19215.3 19216.8 19267.4 13751.5 13855.1 13878.4 13927.9 14726.2 14704.3 14855.7 15319.0 15383.9 15392.8 11:36:38 INFO - PID 1329 | -------- Summary: end -------- 11:36:38 INFO - PID 1329 | 11:36:38 INFO - TEST-INFO | 1329: exit 0 11:36:38 INFO - TEST-OK | dromaeo_css | took 1109082ms 11:36:38 INFO - TEST-START | kraken 11:36:38 INFO - Initialising browser for kraken test... 11:36:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59930/getInfo.html -profile /tmp/tmpV4Pj1D/profile 11:36:38 INFO - TEST-INFO | started process 1738 (/builds/slave/test/build/application/firefox/firefox http://localhost:59930/getInfo.html) 11:36:44 INFO - TEST-INFO | 1738: exit 0 11:36:44 INFO - Browser initialized. 11:36:44 INFO - Running cycle 1/1 for kraken test... 11:36:44 INFO - TEST-INFO | started process 1912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV4Pj1D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:36:45 INFO - PID 1912 | 11:36:45 INFO - PID 1912 | (/builds/slave/test/build/application/firefox/firefox:1961): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:36:45 INFO - PID 1912 | 11:36:45 INFO - PID 1912 | 11:36:45 INFO - PID 1912 | (/builds/slave/test/build/application/firefox/firefox:2016): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:36:45 INFO - PID 1912 | 11:36:45 INFO - PID 1912 | __metrics Screen width/height:1600/1200 11:36:45 INFO - PID 1912 | colorDepth:24 11:36:45 INFO - PID 1912 | Browser inner width/height: 1024/768 11:36:45 INFO - PID 1912 | __metrics 11:36:55 INFO - PID 1912 | RSS: Main: 165867520 11:36:55 INFO - PID 1912 | 11:36:57 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:59930/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59930/tests/kraken/driver.html?testName=audio-beat-detection) 11:36:58 INFO - PID 1912 | RSS: Main: 169246720 11:36:58 INFO - PID 1912 | 11:37:01 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:59930/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59930/tests/kraken/driver.html?testName=audio-dft) 11:37:02 INFO - PID 1912 | RSS: Main: 171991040 11:37:02 INFO - PID 1912 | 11:37:04 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:59930/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59930/tests/kraken/driver.html?testName=audio-fft) 11:37:05 INFO - PID 1912 | RSS: Main: 164601856 11:37:05 INFO - PID 1912 | 11:37:07 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:59930/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59930/tests/kraken/driver.html?testName=audio-oscillator) 11:37:08 INFO - PID 1912 | RSS: Main: 166498304 11:37:08 INFO - PID 1912 | 11:37:10 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:59930/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59930/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:37:10 INFO - PID 1912 | RSS: Main: 166268928 11:37:10 INFO - PID 1912 | 11:37:13 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:59930/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59930/tests/kraken/driver.html?testName=imaging-darkroom) 11:37:14 INFO - PID 1912 | RSS: Main: 166584320 11:37:14 INFO - PID 1912 | 11:37:18 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:59930/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59930/tests/kraken/driver.html?testName=imaging-desaturate) 11:37:18 INFO - PID 1912 | RSS: Main: 167604224 11:37:18 INFO - PID 1912 | 11:37:21 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:59930/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59930/tests/kraken/driver.html?testName=json-parse-financial) 11:37:22 INFO - PID 1912 | RSS: Main: 168763392 11:37:22 INFO - PID 1912 | 11:37:23 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:59930/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59930/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:37:24 INFO - PID 1912 | RSS: Main: 168361984 11:37:24 INFO - PID 1912 | 11:37:25 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:59930/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59930/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:37:26 INFO - PID 1912 | RSS: Main: 168882176 11:37:26 INFO - PID 1912 | 11:37:28 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:59930/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59930/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:37:29 INFO - PID 1912 | RSS: Main: 168464384 11:37:29 INFO - PID 1912 | 11:37:31 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:59930/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59930/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:37:32 INFO - PID 1912 | RSS: Main: 168308736 11:37:32 INFO - PID 1912 | 11:37:35 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:59930/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59930/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:37:35 INFO - PID 1912 | RSS: Main: 168480768 11:37:35 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | Cycle 1(1): loaded http://localhost:59930/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59930/tests/kraken/driver.html?testName=ai-astar) 11:37:37 INFO - PID 1912 | RSS: Main: 170184704 11:37:37 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | __start_tp_report 11:37:37 INFO - PID 1912 | _x_x_mozilla_page_load 11:37:37 INFO - PID 1912 | _x_x_mozilla_page_load_details 11:37:37 INFO - PID 1912 | |i|pagename|runs| 11:37:37 INFO - PID 1912 | |0;ai-astar;98;106;100;107;107;106;108;98;108;109 11:37:37 INFO - PID 1912 | |1;audio-beat-detection;140;114;149;169;112;142;143;115;171;114 11:37:37 INFO - PID 1912 | |2;audio-dft;163;164;162;163;161;168;162;161;167;168 11:37:37 INFO - PID 1912 | |3;audio-fft;76;74;74;162;74;74;74;88;104;75 11:37:37 INFO - PID 1912 | |4;audio-oscillator;80;79;133;79;79;78;134;78;78;123 11:37:37 INFO - PID 1912 | |5;imaging-gaussian-blur;113;114;113;115;114;114;114;113;114;113 11:37:37 INFO - PID 1912 | |6;imaging-darkroom;149;150;150;148;150;149;147;149;148;148 11:37:37 INFO - PID 1912 | |7;imaging-desaturate;94;96;94;95;93;94;93;94;94;95 11:37:37 INFO - PID 1912 | |8;json-parse-financial;58;50;47;48;53;50;49;46;48;49 11:37:37 INFO - PID 1912 | |9;json-stringify-tinderbox;54;54;54;54;54;54;54;54;54;54 11:37:37 INFO - PID 1912 | |10;stanford-crypto-aes;72;72;73;80;73;73;72;73;72;71 11:37:37 INFO - PID 1912 | |11;stanford-crypto-ccm;119;121;111;114;118;117;113;114;111;151 11:37:37 INFO - PID 1912 | |12;stanford-crypto-pbkdf2;170;173;173;165;173;164;171;163;165;168 11:37:37 INFO - PID 1912 | |13;stanford-crypto-sha256-iterative;65;64;61;62;64;64;63;68;61;63 11:37:37 INFO - PID 1912 | __end_tp_report 11:37:37 INFO - PID 1912 | __start_cc_report 11:37:37 INFO - PID 1912 | _x_x_mozilla_cycle_collect,851 11:37:37 INFO - PID 1912 | __end_cc_report 11:37:37 INFO - PID 1912 | __startTimestamp1503254257802__endTimestamp 11:37:37 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | ------- Summary: start ------- 11:37:37 INFO - PID 1912 | Number of tests: 14 11:37:37 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | [#0] ai-astar Cycles:10 Average:104.70 Median:108.00 stddev:4.30 (4.0%) stddev-sans-first:3.81 11:37:37 INFO - PID 1912 | Values: 98.0 106.0 100.0 107.0 107.0 106.0 108.0 98.0 108.0 109.0 11:37:37 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | [#1] audio-beat-detection Cycles:10 Average:136.90 Median:142.50 stddev:22.51 (15.8%) stddev-sans-first:23.85 11:37:37 INFO - PID 1912 | Values: 140.0 114.0 149.0 169.0 112.0 142.0 143.0 115.0 171.0 114.0 11:37:37 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:2.77 (1.7%) stddev-sans-first:2.92 11:37:37 INFO - PID 1912 | Values: 163.0 164.0 162.0 163.0 161.0 168.0 162.0 161.0 167.0 168.0 11:37:37 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | [#3] audio-fft Cycles:10 Average:87.50 Median:74.00 stddev:27.93 (37.7%) stddev-sans-first:29.32 11:37:37 INFO - PID 1912 | Values: 76.0 74.0 74.0 162.0 74.0 74.0 74.0 88.0 104.0 75.0 11:37:37 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:78.50 stddev:24.95 (31.8%) stddev-sans-first:25.93 11:37:37 INFO - PID 1912 | Values: 80.0 79.0 133.0 79.0 79.0 78.0 134.0 78.0 78.0 123.0 11:37:37 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 11:37:37 INFO - PID 1912 | Values: 113.0 114.0 113.0 115.0 114.0 114.0 114.0 113.0 114.0 113.0 11:37:37 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 11:37:37 INFO - PID 1912 | Values: 149.0 150.0 150.0 148.0 150.0 149.0 147.0 149.0 148.0 148.0 11:37:37 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 11:37:37 INFO - PID 1912 | Values: 94.0 96.0 94.0 95.0 93.0 94.0 93.0 94.0 94.0 95.0 11:37:37 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | [#8] json-parse-financial Cycles:10 Average:49.80 Median:49.50 stddev:3.46 (7.0%) stddev-sans-first:2.03 11:37:37 INFO - PID 1912 | Values: 58.0 50.0 47.0 48.0 53.0 50.0 49.0 46.0 48.0 49.0 11:37:37 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:37:37 INFO - PID 1912 | Values: 54.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 11:37:37 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | [#10] stanford-crypto-aes Cycles:10 Average:73.10 Median:73.00 stddev:2.51 (3.4%) stddev-sans-first:2.64 11:37:37 INFO - PID 1912 | Values: 72.0 72.0 73.0 80.0 73.0 73.0 72.0 73.0 72.0 71.0 11:37:37 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | [#11] stanford-crypto-ccm Cycles:10 Average:118.90 Median:117.50 stddev:11.77 (10.0%) stddev-sans-first:12.48 11:37:37 INFO - PID 1912 | Values: 119.0 121.0 111.0 114.0 118.0 117.0 113.0 114.0 111.0 151.0 11:37:37 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.50 Median:170.50 stddev:4.01 (2.4%) stddev-sans-first:4.21 11:37:37 INFO - PID 1912 | Values: 170.0 173.0 173.0 165.0 173.0 164.0 171.0 163.0 165.0 168.0 11:37:37 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:2.07 (3.2%) stddev-sans-first:2.12 11:37:37 INFO - PID 1912 | Values: 65.0 64.0 61.0 62.0 64.0 64.0 63.0 68.0 61.0 63.0 11:37:37 INFO - PID 1912 | -------- Summary: end -------- 11:37:37 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 11:37:37 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | 11:37:37 INFO - PID 1912 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 11:37:37 INFO - PID 1912 | 11:37:38 INFO - PID 1912 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:37:38 INFO - TEST-INFO | 1912: exit 0 11:37:38 INFO - TEST-OK | kraken | took 59673ms 11:37:38 INFO - SUITE-END | took 1168s 11:37:38 INFO - Completed test suite (00:19:29) 11:37:38 INFO - javascript benchmark 11:37:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8774.233565587569, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3493.056874643847, 3510.069831494656, 3535.4873543336216, 3552.626974167714, 3567.2687099144678, 6192.473639740628, 6274.686265686714, 6301.936980630192, 6327.019312006641, 6336.144620476234, 6113.7860174893885, 6181.227346581677, 6188.133661287412, 6199.00815869461, 6206.875862482759, 5409.9459005410035, 5473.589480788937, 5476.0, 5489.258950041753, 5500.724963751816, 5478.424765399635, 5484.012877682016, 5546.251256080418, 5565.332160140789, 5576.86057848553, 5005.674631148963, 5355.116405793039, 5381.0583147948955, 5427.565794736412, 5443.5100840924115, 5422.105352616813, 5467.4532546745, 5503.972480137613, 5522.254495643077, 5531.557475401958, 5335.706536140511, 5426.647267927611, 5489.258950041733, 5506.146547285177, 5507.834764957058, 6139.815805525842, 6156.846078848064, 6177.7837775677635, 6191.380861913818, 6201.6899155042065, 6760.0535924970545, 6790.694418751168, 6807.829804254933, 6818.386345228953, 6825.385715285598, 6765.594064356105, 6779.457643388517, 6779.898301525481, 6863.2793556676825, 6869.896951545681, 6141.140240366352, 6204.751809927552, 6221.377862213742, 6312.210973628296, 6377.8405539861415, 6886.345797149263, 6907.516473846883, 6920.619365934922, 6921.031055652213, 6934.930650693529, 6565.80302590923, 6625.039369291522, 6642.1033160523675, 6644.800655980328, 6648.202215734143, 6849.623270720158, 6860.828479287958, 6867.931320686829, 6877.105976223159, 6885.690143943534, 6663.267040625527, 6666.866662666719, 6752.493562982796, 6754.493412994045, 6761.898571521431, 6757.966210169016, 6773.153355830521, 6844.657767111724, 6848.657567121624, 6857.657117144123, 4810.134175848311, 4863.635227357962, 4908.214685650279, 4918.262260660929, 4920.803167873317, 4353.390525326457, 4375.824967001348, 4383.671224658164, 4428.047969686533, 4434.733915965053, 6436.227652681615, 6440.484761219185, 6450.451711604566, 6514.088027676129, 6528.608283503005, 6787.5588086774205, 6799.11611490503, 6805.0, 6842.4183944364295, 6877.552959057645, 6446.323136070645, 6468.5472016958365, 6479.481641468766, 6494.123293355431, 6494.805155845333, 5428.321459817523, 5467.808626698126, 5490.203920431515, 5495.587830912697, 5517.724113794295, 7037.753678621224, 7104.325089116525, 7145.821354466076, 7234.059572255573, 7251.1298644163035, 6562.146920900253, 6701.597904125768, 6704.7988560343265, 6705.497087718538, 6707.765228216989, 7090.539114957512, 7128.28717128283, 7139.2503787101605, 7140.357367836919, 7144.535605185646, 6697.497687673346, 6721.899171512334, 6762.391384775394, 6788.796336109925, 6793.0, 6808.421284190899, 6811.8978215325815, 6906.343897329745, 6913.5506192097355, 6913.827154321182, 6410.967945160244, 6500.057491663777, 6510.283868774526, 6514.967425162844, 6569.737210511526, 6563.803085907431, 6580.407763301326, 6590.637514936724, 6617.669116544057, 6640.269570347161, 6655.966720166368, 6675.899861502178, 6718.294579069127, 6722.697478613572, 6727.764528241488, 6651.833704157435, 6661.733530658719, 6701.8324541884895, 6747.966260168668, 6762.323767623395, 6433.453156481752, 6447.742090316522, 6502.349765023459, 6503.089567460464, 6505.154329937078], "value": 6158.75839651585, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [885.182128394847, 886.6302108099544, 911.1708345405682, 945.5603144537788, 948.9525523723812, 42058.0, 42875.785621071926, 42966.7851660742, 43024.13951720964, 43121.78439107804, 40231.39652905209, 40236.798816005954, 40510.59489405105, 40560.594394056054, 40584.39123413151, 6951.131108611424, 7036.366726994569, 7038.296170382972, 7050.083489146429, 7050.541714788548, 7056.153261608614, 7140.0, 7144.464165187605, 7154.8569028619395, 7158.570485770871, 7101.04135941649, 7106.680199391014, 7123.180834204081, 7126.180489243726, 7130.144382674086, 7113.1464224292895, 7123.821904452404, 7128.0377149084725, 7128.750493732695, 7145.464090193256, 6469.35306469354, 6502.479801615859, 6512.023196520559, 6519.3154718754795, 6522.249941256721, 36150.276994459964, 36275.27449450996, 36371.272574548624, 36427.271454571026, 36497.817510912544, 3311.8840840570706, 3326.4012477753995, 3326.966730332714, 3329.500574913758, 3335.4329763940186, 29107.708922910922, 29193.56209656857, 29203.56194657082, 29222.56166157488, 29225.0, 4603.240465323218, 4639.9536004640195, 4643.048175124091, 4672.602828759559, 4677.789499472532, 197865.0, 200404.0, 202276.0, 202659.0, 205799.0, 50787.23819142716, 51062.74468627633, 51099.0, 51112.0, 51178.74410627923, 53397.73301133547, 53561.0, 53568.46431535713, 53681.0, 53739.73130134324, 16161.0, 16211.0, 16261.593460163354, 16290.674186516204, 16430.589235269214, 13432.731345373038, 13468.797968030487, 13473.0, 13480.0, 13482.730345393038, 13610.319484025758, 13653.931730341483, 13692.931535342259, 13710.24593647359, 13758.0, 5244.790208391698, 5261.421243663194, 5313.681179129265, 5361.070014794671, 5383.5962302826665, 1058.513083981362, 1060.2737125069352, 1071.2929466552039, 1088.7659153282082, 1101.7631209290041, 23467.7653223469, 23687.881560592432, 23780.405489862893, 24014.27957161288, 24049.158279460135, 1187.5962172861268, 1189.6133756529164, 1200.447794014763, 1209.0992210803008, 1211.5759484180467, 12564.497420103093, 12616.243025418504, 12654.81017784734, 12681.429335679917, 12757.617271481871, 249675.0, 250301.0, 250547.0, 250878.0, 251641.0, 52389.7380513095, 52459.47540524622, 52622.736886315324, 52631.47368526342, 52832.73583632057, 1485.094092603511, 1502.902311349737, 1534.9309281082378, 1552.5031989763168, 1557.6573153906122, 23154.421139471648, 23339.76660233376, 23361.182358617367, 23400.297991060295, 23737.16919907795, 37791.0, 37830.243395131394, 37874.0, 37896.62103379041, 37933.24133517259, 220651.0, 221743.0, 222007.0, 222314.0, 222891.0, 32338.0, 32601.510977334885, 34286.48570271398, 34365.484517731755, 35451.29097417986, 44590.67176297288, 45085.77457112693, 45172.096558068, 45598.54401456076, 48456.7577162126, 33954.49068264027, 34800.30399391947, 35001.0, 35037.299254014266, 35045.47431788474, 34569.827150865094, 34683.65316346804, 34789.47815782714, 34935.30129397347, 35542.46686299759, 40755.59244407518, 40851.7957410211, 41131.383029253986, 41177.588224117375, 41302.0, 34132.0, 34375.48436773501, 34481.0, 34629.0, 34894.476582851785, 25304.74695253024, 25500.872495637403, 25974.480510390065, 26051.75004617832, 26515.0], "value": 17337.442773012463, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.4191924237275, 579.8173575323772, 580.9970950145249, 584.777784441912, 593.2762030323006, 22896.771032289693, 23675.881620591874, 23846.165384211556, 23932.282031539038, 23985.880070599665, 27250.45499090017, 27712.584311235347, 27798.30504237395, 27829.304267393327, 27876.442471150614, 6448.871022579546, 6602.8679426411445, 6603.834904127387, 6606.207255129391, 6607.867842643144, 6224.159738435299, 6404.775832845851, 6446.774362897299, 6456.677166141698, 6458.999999999976, 6401.135846660688, 6409.679516024204, 6411.134496842913, 6415.294317625057, 6440.388163124496, 6406.679666016727, 6417.486601071903, 6418.261899881527, 6422.646754428528, 6427.003814408774, 5976.103584462322, 5980.940190598082, 5982.46157845796, 5990.430909063632, 5994.880102397971, 30121.698783012107, 30726.23184420385, 30782.076537703906, 31434.37131257385, 31842.840785796154, 2195.9890200549053, 2213.1368766181204, 2213.955720885573, 2216.612092883739, 2217.81148602369, 18846.81153188478, 19316.613667726706, 19376.612467750565, 19378.61242775151, 19382.515437114045, 2378.6669866218745, 2470.1601455505215, 2495.238952119603, 2514.836535625197, 2515.597504399287, 147182.0, 152786.0, 153759.2312038444, 153959.0, 154232.22883885508, 15111.244437778067, 15670.373185072469, 15845.0, 15960.521184364488, 16254.837451625568, 24432.0, 24509.754902451103, 24530.632040519406, 24535.63196552053, 24650.137245196333, 10683.732906677395, 10703.304285221435, 10764.892351076389, 10771.138308935266, 10849.783004340026, 9076.092390761003, 9441.480718560546, 9800.166985806143, 9852.113309802153, 9974.850377244347, 9085.863712044325, 9576.808463830825, 9682.467464289392, 9751.463669498246, 9863.80272394548, 2715.9592606110923, 2749.9725002750115, 2751.4222013377016, 2757.1177223288355, 2852.957205641917, 1039.6880935719405, 1040.7398150462384, 1041.0838462153408, 1050.9421981790922, 1056.366180291834, 21429.357119286447, 21684.674729879065, 21934.0, 22157.556848862932, 22170.667439988414, 1087.7171935296722, 1116.7933932222566, 1127.002602696603, 1128.6839684888243, 1129.249049382168, 11577.305361678325, 11957.342346171044, 12036.578719744766, 12072.879271207352, 12077.758444831054, 576724.0, 590055.0, 598856.0, 600165.0, 617317.0, 143273.0, 144617.27691361686, 145276.0, 148251.25874370776, 148365.2581737106, 1298.733759579284, 1329.5678904356123, 1331.0549509848117, 1337.2845527642664, 1350.4800651748951, 19213.903930480257, 19660.01699915027, 22680.1244713952, 23875.403114922265, 24384.390390240387, 64897.67551162214, 66623.66688166528, 67840.6607966957, 68353.6582317105, 68992.0, 80835.19164808276, 81240.59379703064, 81428.0, 81684.59157704173, 82301.58849205716, 13354.532591359644, 13869.237191954539, 15108.169050701877, 15332.923335383251, 15781.526554203392, 25254.0, 25338.873305633355, 25395.492090157724, 25460.49079018372, 25490.0, 19693.803061969196, 20242.79757202409, 20492.59014819725, 20526.38420847377, 20624.27815026467, 17577.824221758132, 17914.10429478495, 18277.634447310713, 18349.81650183481, 18511.629767404847, 20809.583808324052, 20997.265095721577, 21076.894615526824, 21256.25603103884, 21339.14643414246, 15252.0, 15459.381624734884, 15559.144247066068, 15560.144192069545, 15569.532914012598, 19231.0, 19239.03804809726, 19272.518187045436, 19448.611027779647, 19826.306079287155], "value": 12826.114008670413, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1460.7370673278808, 1472.9189894555795, 1486.7918491411203, 1493.4623535527214, 1516.2797671106225, 15712.13583252922, 16293.429729959455, 16362.590935226624, 16365.672686546277, 16399.918000410013, 15665.92167039166, 16797.16014199288, 16853.41013064543, 16864.83135168648, 16898.324067037334, 2264.399934017483, 2290.278562252885, 2294.0594356313914, 2294.919677811277, 2295.2196253273883, 2558.897644094234, 2627.605859121128, 2631.8682966324473, 2682.088090049383, 2682.28919336376, 2643.2466746977116, 2663.6270922070926, 2673.1579552441017, 2724.3870129220963, 2726.0322585482168, 2576.5748651472577, 2602.947941041178, 2606.7653911147995, 2614.2810727050023, 2618.751218634227, 2594.6237795519733, 2605.387733882536, 2622.5148347555764, 2622.6983896851916, 2623.7245089265734, 15630.296636651377, 15706.764398534031, 15843.524694259191, 15856.0, 15866.286017129258, 7901.841963160705, 8176.427650064498, 8186.099529051799, 8205.302549283319, 8209.958950205271, 4915.9754201229125, 4968.378952630921, 5049.267856160836, 5125.82059627915, 5139.383274007106, 1913.167772019176, 1931.3143833938889, 1936.1674479973606, 1974.8222659960672, 1978.7526559180103, 28061.298467538272, 28090.438191236266, 28117.718822811716, 28247.15258542247, 28268.0, 6462.127612772216, 6598.934010659832, 6676.365745254193, 6785.762498312535, 6811.25076241613, 19156.23375064982, 19163.61672766565, 19169.0, 19169.904150479157, 19195.712064319046, 7766.495177813424, 7894.210578942175, 7972.083210430758, 7976.920230797734, 7983.68065277394, 6345.302016778151, 7324.890126648104, 7361.595112268769, 7364.22675619063, 7388.039554857834, 5047.268146118792, 5296.973515132399, 5298.443663415363, 5300.3639563252655, 5305.045091883498, 1301.1152416356779, 1303.4199781097511, 1312.0880987713447, 1319.736052789446, 1328.6479083043002, 923.0677016213539, 930.6696122876417, 931.9580618872031, 941.6092321686424, 948.1514044929887, 7761.5731134787, 7780.533168009937, 7782.610869456617, 7803.336716379058, 7882.566458844703, 737.5353527277888, 746.1941103608091, 746.6490749347798, 751.3200553499092, 753.2542782645252, 4741.83403580873, 4819.1566475867285, 4841.3222148899185, 4913.975430122898, 4914.361133052752, 21736.456588585414, 22090.226842060772, 22924.19765308206, 23005.309840704806, 23190.1883434079, 22330.44173895633, 22930.885345573166, 22995.88502057479, 23043.423914402276, 23131.653025204636, 12084.697882553006, 12448.190867593577, 12546.686332841751, 12549.87450125487, 12569.93715031419, 8520.36097292718, 8597.312215022657, 8667.826643467222, 8670.0896405879, 8773.780655483664, 19285.0, 19924.0, 20012.399628011182, 20293.898530507253, 20345.0, 20427.79572204259, 20495.4876128098, 20613.484662883548, 20752.48118797042, 21013.0, 10752.784944301227, 11104.44477776124, 11333.886661133283, 11548.884511154782, 11561.30632162073, 14946.925265374039, 15155.545333640008, 15175.544733658007, 15180.848191517944, 15196.772048419503, 12068.577599783965, 12095.697607559881, 12177.147599667938, 12251.816222756488, 12330.691732706755, 11785.705357366134, 11843.170978031456, 11943.462544185706, 12019.75960480768, 12057.336846473529, 10078.661505805969, 10158.796824063329, 10285.382877027403, 10301.587936482456, 10304.845427318745, 7949.443538952449, 8020.799480013046, 8023.959880200561, 8079.232472915299, 8103.635336409758, 8064.758057258292, 8080.2727754502375, 8094.190580941859, 8112.83774324522, 8248.216419440143], "value": 6767.566357003325, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.9691618502887, 522.5532169994653, 536.3831593667283, 539.2019810680191, 540.5837505121057, 6145.846353841156, 6190.7214175362105, 6221.346758590351, 6243.71903264353, 6250.0, 6107.908381374272, 6131.509479241661, 6132.110843927628, 6175.240056583874, 6225.750969961207, 4890.193118135503, 4891.14404979129, 4921.286413470045, 4938.703677779326, 4966.0, 4662.743549104798, 4805.212976473636, 4811.735354555498, 4865.68373055752, 4881.389141583269, 4766.952330476685, 4768.356271903283, 4772.689775164603, 4778.139934811733, 4780.067886762083, 4779.856604301876, 4789.37738094049, 4804.0, 4822.228443449067, 4836.758162091916, 4226.387173859804, 4323.351497275403, 4326.740395576244, 4338.934915976231, 4353.978230108829, 5944.978707239559, 5976.432238937294, 5986.760529578812, 5994.7602095916545, 6011.5190784737115, 5705.0, 5711.7715291388295, 5737.196792449061, 5738.196652468658, 5765.855853603652, 6544.607323560602, 6557.377049180321, 6561.835954101138, 6569.0, 6580.80257592273, 4945.554900059012, 4953.405591329028, 4960.627952903511, 4962.21360310288, 4967.428745694219, 6616.735330586771, 6622.768203112868, 6706.53054286205, 6724.226713927912, 6751.932480675179, 5060.822871199564, 5063.038022775734, 5064.442911279756, 5099.623101762503, 5108.0, 5084.796608135707, 5102.132637451642, 5142.228665700175, 5156.613254005964, 5190.169572868398, 5686.658800471985, 5713.428807078087, 5723.54211663066, 5729.427057294321, 5742.339630942495, 6532.281449040602, 6564.343565643398, 6581.835454113685, 6609.405153536205, 6646.933530664632, 1763.4709587123812, 1769.504538729158, 1781.6169523552499, 1786.0890945617828, 1791.6864548703925, 1200.1359021504502, 1230.9536893640334, 1241.0071942446189, 1263.860975292717, 1276.6361586947676, 6210.161628180228, 6223.408776166257, 6282.842928926813, 6293.905591416133, 6322.146510221153, 6548.8035358939305, 6560.179977502812, 6670.4997125215805, 6726.932730672631, 6764.188297404343, 6294.0, 6306.148669929501, 6315.431611154926, 6321.557490975588, 6379.703306809545, 3471.2189757304404, 3489.7208223342072, 3490.1798077451776, 3551.3074950384944, 3582.5163602913794, 7018.263082376379, 7022.0, 7047.660944420646, 7175.138983322035, 7222.566646001257, 6307.0, 6801.829954251084, 6831.829204269834, 6918.481113916376, 6936.826579335456, 6898.447574397505, 6975.8604827903155, 7021.5787052777, 7063.999999999897, 7064.364207221375, 6461.741530338733, 6590.47276217911, 6613.900791488228, 6620.205575330799, 6721.731130754715, 6540.0, 6584.8353791155605, 6622.63575503352, 6706.463482921452, 6743.35938085881, 7052.506324557232, 7098.964505177441, 7114.336116899697, 7118.537295075804, 7196.712131514681, 4937.481564435682, 5000.274960130688, 5107.591392688651, 5129.820456284012, 5140.357455318085, 6423.935760642334, 6530.346965303432, 6558.475321974135, 6778.373190434162, 6839.418649414855, 6401.743930242738, 6554.4756419487285, 6597.439217666552, 6621.702023408862, 6646.335366463315, 6464.252692605718, 6484.513661475503, 6545.901811472927, 6558.344165583403, 6567.704453299709, 6495.188101487314, 6586.2755096940255, 6617.966910165418, 6627.469802415699, 6633.270340262664, 6575.539712220098, 6588.40704336612, 6597.1423714916755, 6683.3984941353565, 6710.664466776544, 6348.77779277723, 6357.777477788255, 6411.3909178627955, 6452.419282264619, 6456.903146452713], "value": 5102.011005646281, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [943.876786623918, 950.9239260859131, 970.9998701337615, 974.6588693957116, 988.8862780780208, 16481.175941202953, 16721.0, 19900.60198796025, 20422.6936595951, 21464.356069317906, 21011.684824727643, 21692.566148677055, 21750.0, 21846.235381761642, 21927.12291508342, 1005.8239808033583, 1037.289456722144, 1041.5625437316307, 1042.8592140061107, 1044.7805960748215, 1042.7810159866438, 1093.568040623953, 1101.6860194844471, 1106.0764261841332, 1107.307932542161, 1153.8269259611084, 1157.866845312787, 1158.3281696615984, 1161.639891633592, 1171.7246447084972, 1156.6240971684194, 1158.9594364197255, 1161.488944864257, 1165.0737663557493, 1165.213480900389, 844.3118858130604, 844.7465760271893, 844.7465760271893, 845.045099038083, 846.191886748154, 18995.240190392367, 19152.712709309373, 19163.425097247105, 19833.404997850088, 20477.180912763473, 20342.28801991938, 21210.575788484297, 21364.572708545744, 21623.783762162333, 21656.783432165634, 17099.82900170995, 17135.82864171355, 17142.571435714206, 17220.56948576283, 17669.028203448805, 3806.1055651921774, 3820.9235815283537, 3822.8661996830256, 3824.1204522959597, 3826.6364695354177, 146738.0, 147866.0, 148307.0, 148701.0, 149809.25095374562, 16305.266263018193, 17028.318867245172, 17060.488185354458, 17119.400820971205, 17122.229499672543, 32409.67590324114, 32851.0, 33447.83276083604, 33569.832150839575, 33600.327993440485, 8678.435901666498, 8787.692430764893, 8800.515971621495, 8805.823883522293, 8816.471011739188, 4565.680402371802, 4610.907781844345, 4653.744044077541, 4663.883402914954, 4676.321933319649, 4938.358013458227, 5352.4915133062295, 5402.945970540244, 5405.729713514387, 5413.2150838128255, 1005.2410430125209, 1032.9638462653922, 1036.5905467340358, 1045.1586472889396, 1045.4406892312577, 698.2842586348931, 705.9541129826545, 714.3356678289241, 717.1573401253611, 717.9461540384492, 12711.936440317739, 14521.273936303143, 14694.412223511154, 14796.48212312564, 15553.22233888301, 650.2814390098872, 654.257417830756, 657.4444594317794, 660.6399512265826, 666.4035688059257, 6483.384078512534, 6565.212174539086, 6651.434628056572, 6716.764913228014, 6729.0915726376315, 138231.0, 138683.0, 141604.29197853946, 144291.0, 144834.2758286202, 120333.0, 121103.0, 121195.0, 122185.38907305406, 122414.0, 99339.50330248447, 100351.49824250978, 100411.49794250981, 105096.47451762845, 106507.0, 10936.289141205796, 11133.387663678575, 11134.164937629872, 11153.219274650697, 11238.381888996184, 49305.0, 49680.25479617881, 50135.0, 50549.49450505448, 51313.48686513087, 62854.0, 64247.0, 65702.67148664226, 67780.0, 67944.32055679578, 16448.0, 16656.16719164013, 16798.0, 16924.830751692818, 16980.915095424443, 17713.114344282993, 17751.289948402435, 17897.552561186076, 17963.640727185644, 17978.5505362367, 17345.653086938444, 17440.86634368762, 17488.387906423213, 17495.125243738017, 17584.824151758832, 15787.605309867346, 15874.444394446138, 15890.60273493172, 19358.128884200527, 19751.11119999632, 18669.0, 18846.151923163765, 19215.32746353927, 19216.807831921502, 19267.421977340702, 13751.518696845962, 13855.099418537762, 13878.444862205399, 13927.860721392657, 14726.1900595464, 14704.338304776526, 14855.702885942004, 15319.0, 15383.923080384526, 15392.846071539141], "value": 9648.975032559267, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1471.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 106.0, 100.0, 107.0, 107.0, 106.0, 108.0, 98.0, 108.0, 109.0], "value": 104.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 114.0, 149.0, 169.0, 112.0, 142.0, 143.0, 115.0, 171.0, 114.0], "value": 136.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 163.0, 161.0, 168.0, 162.0, 161.0, 167.0, 168.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 162.0, 74.0, 74.0, 74.0, 88.0, 104.0, 75.0], "value": 87.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 133.0, 79.0, 79.0, 78.0, 134.0, 78.0, 78.0, 123.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 115.0, 114.0, 114.0, 114.0, 113.0, 114.0, 113.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 150.0, 148.0, 150.0, 149.0, 147.0, 149.0, 148.0, 148.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 95.0, 93.0, 94.0, 93.0, 94.0, 94.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 50.0, 47.0, 48.0, 53.0, 50.0, 49.0, 46.0, 48.0, 49.0], "value": 49.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 73.0, 80.0, 73.0, 73.0, 72.0, 73.0, 72.0, 71.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 121.0, 111.0, 114.0, 118.0, 117.0, 113.0, 114.0, 111.0, 151.0], "value": 118.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 173.0, 173.0, 165.0, 173.0, 164.0, 171.0, 163.0, 165.0, 168.0], "value": 168.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 61.0, 62.0, 64.0, 64.0, 63.0, 68.0, 61.0, 63.0], "value": 63.5, "unit": "score"}]}]} 11:37:39 INFO - Return code: 0 11:37:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:37:39 INFO - # TBPL SUCCESS # 11:37:39 INFO - Running post-action listener: _package_coverage_data 11:37:39 INFO - Running post-action listener: _resource_record_post_action 11:37:39 INFO - [mozharness: 2017-08-20 18:37:39.105325Z] Finished run-tests step (success) 11:37:39 INFO - Running post-run listener: _resource_record_post_run 11:37:39 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 8192; Write bytes: 432201728; Read time: 228; Write time: 263812 11:37:39 INFO - TinderboxPrint: CPU usage
13.0% 11:37:39 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 228 11:37:39 INFO - TinderboxPrint: I/O write bytes / time
432,201,728 / 263,812 11:37:39 INFO - TinderboxPrint: CPU idle
8,229.5 (86.9%) 11:37:39 INFO - TinderboxPrint: CPU user
1,188.6 (12.6%) 11:37:39 INFO - TinderboxPrint: Swap in / out
0 / 0 11:37:39 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108503040; Read time: 0; Write time: 84516 11:37:39 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:37:39 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 8192; Write bytes: 323698688; Read time: 228; Write time: 179296 11:37:39 INFO - Running post-run listener: _upload_blobber_files 11:37:39 INFO - Blob upload gear active. 11:37:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:37:39 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 11:37:39 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'] 11:37:39 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 11:37:40 INFO - (blobuploader) - INFO - Open directory for files ... 11:37:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:37:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:37:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:40 INFO - (blobuploader) - INFO - Done attempting. 11:37:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:37:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:37:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:41 INFO - (blobuploader) - INFO - Done attempting. 11:37:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:37:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:37:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:48 INFO - (blobuploader) - INFO - Done attempting. 11:37:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:37:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:37:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:37:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:37:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:37:48 INFO - (blobuploader) - INFO - Done attempting. 11:37:48 INFO - (blobuploader) - INFO - Iteration through files over. 11:37:48 INFO - Return code: 0 11:37:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:37:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:37:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7f4c1379694a0fea8c5dae16a5052baaa8f6adbfb8b5f699ab5a15107baa8d1f3f72b5fd415b079e192fdede0251a5d64785d6b119250c23dd3dfc556c80793", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a705f70d7cd702e150fdaf2ffc147b1197bb099170d254c3ac0ba70fd225d7ce50c8ca7010dc24110ba898e6c667c11be9e87acf5725b46ad870cd457c1f9bd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9f3b11badc1047e9be22a427bfede4ffa785d4a73e305aa6c46a1e3cf346708b46c1bc42cb05cbb8aef45a93df5b2d51d868aac19592ca3c197805b9e2ed00c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26c94334e06ae0f24f30339c3122da402a0171974799145954d294edf3d95ad409ed3d2d0ab17ab52cd88fd6a0dc25398c1454434f867990d485793a7d8e6b53"} 11:37:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:37:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:37:48 INFO - Contents: 11:37:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7f4c1379694a0fea8c5dae16a5052baaa8f6adbfb8b5f699ab5a15107baa8d1f3f72b5fd415b079e192fdede0251a5d64785d6b119250c23dd3dfc556c80793", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a705f70d7cd702e150fdaf2ffc147b1197bb099170d254c3ac0ba70fd225d7ce50c8ca7010dc24110ba898e6c667c11be9e87acf5725b46ad870cd457c1f9bd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9f3b11badc1047e9be22a427bfede4ffa785d4a73e305aa6c46a1e3cf346708b46c1bc42cb05cbb8aef45a93df5b2d51d868aac19592ca3c197805b9e2ed00c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26c94334e06ae0f24f30339c3122da402a0171974799145954d294edf3d95ad409ed3d2d0ab17ab52cd88fd6a0dc25398c1454434f867990d485793a7d8e6b53"} 11:37:48 INFO - Running post-run listener: copy_logs_to_upload_dir 11:37:48 INFO - Copying logs to upload dir... 11:37:48 INFO - mkdir: /builds/slave/test/build/upload/logs 11:37:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.182220 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-20 11:37:48.933477) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-20 11:37:48.937206) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7f4c1379694a0fea8c5dae16a5052baaa8f6adbfb8b5f699ab5a15107baa8d1f3f72b5fd415b079e192fdede0251a5d64785d6b119250c23dd3dfc556c80793", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a705f70d7cd702e150fdaf2ffc147b1197bb099170d254c3ac0ba70fd225d7ce50c8ca7010dc24110ba898e6c667c11be9e87acf5725b46ad870cd457c1f9bd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9f3b11badc1047e9be22a427bfede4ffa785d4a73e305aa6c46a1e3cf346708b46c1bc42cb05cbb8aef45a93df5b2d51d868aac19592ca3c197805b9e2ed00c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26c94334e06ae0f24f30339c3122da402a0171974799145954d294edf3d95ad409ed3d2d0ab17ab52cd88fd6a0dc25398c1454434f867990d485793a7d8e6b53"} build_url:https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011488 build_url: 'https://queue.taskcluster.net/v1/task/TKk533FUQ-m7hsD9mpL7AQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e7f4c1379694a0fea8c5dae16a5052baaa8f6adbfb8b5f699ab5a15107baa8d1f3f72b5fd415b079e192fdede0251a5d64785d6b119250c23dd3dfc556c80793", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a705f70d7cd702e150fdaf2ffc147b1197bb099170d254c3ac0ba70fd225d7ce50c8ca7010dc24110ba898e6c667c11be9e87acf5725b46ad870cd457c1f9bd4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9f3b11badc1047e9be22a427bfede4ffa785d4a73e305aa6c46a1e3cf346708b46c1bc42cb05cbb8aef45a93df5b2d51d868aac19592ca3c197805b9e2ed00c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26c94334e06ae0f24f30339c3122da402a0171974799145954d294edf3d95ad409ed3d2d0ab17ab52cd88fd6a0dc25398c1454434f867990d485793a7d8e6b53"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-20 11:37:48.964075) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 11:37:48.964479) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1503252310.132392-1059591200 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004790 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-20 11:37:49.048929) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-20 11:37:49.049245) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-20 11:37:49.049565) ========= ========= Total master_lag: 0.18 =========