builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-007 starttime: 1502931020.36 results: success (0) revision: 63ca686c3f1e870649b6d9c559973d100573aec2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:20.358565) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:20.359116) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:20.359451) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:20.478223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:20.478545) ========= 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=923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-16 17:50:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 122M=0s 2017-08-16 17:50:20 (122 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094563 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:20.625078) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:20.625443) ========= 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=923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016715 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:20.684227) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:20.684633) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 63ca686c3f1e870649b6d9c559973d100573aec2 --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 63ca686c3f1e870649b6d9c559973d100573aec2 --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=923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-16 17:50:20,940 truncating revision to first 12 chars 2017-08-16 17:50:20,940 Setting DEBUG logging. 2017-08-16 17:50:20,940 attempt 1/10 2017-08-16 17:50:20,940 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/63ca686c3f1e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-16 17:50:21,517 unpacking tar archive at: mozilla-central-63ca686c3f1e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.896609 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:21.606787) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:21.607383) ========= script_repo_revision: 63ca686c3f1e870649b6d9c559973d100573aec2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:21.608063) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:21.608719) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 17:50:21.622305) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-16 17:50:21.622708) ========= /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=923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:50:21 INFO - MultiFileLogger online at 20170816 17:50:21 in /builds/slave/test 17:50:21 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 17:50:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:50:21 INFO - {'append_to_log': False, 17:50:21 INFO - 'base_work_dir': '/builds/slave/test', 17:50:21 INFO - 'blob_upload_branch': 'Firefox', 17:50:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:50:21 INFO - 'branch': 'Firefox', 17:50:21 INFO - 'buildbot_json_path': 'buildprops.json', 17:50:21 INFO - 'code_coverage': False, 17:50:21 INFO - 'config_files': ('talos/linux_config.py',), 17:50:21 INFO - 'default_actions': ('clobber', 17:50:21 INFO - 'read-buildbot-config', 17:50:21 INFO - 'download-and-extract', 17:50:21 INFO - 'populate-webroot', 17:50:21 INFO - 'create-virtualenv', 17:50:21 INFO - 'install', 17:50:21 INFO - 'setup-mitmproxy', 17:50:21 INFO - 'run-tests'), 17:50:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:50:21 INFO - 'disable_ccov_upload': False, 17:50:21 INFO - 'download_minidump_stackwalk': True, 17:50:21 INFO - 'download_symbols': 'ondemand', 17:50:21 INFO - 'enable_stylo': False, 17:50:21 INFO - 'enable_webrender': False, 17:50:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:50:21 INFO - 'tooltool.py': '/tools/tooltool.py', 17:50:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:50:21 INFO - '/tools/misc-python/virtualenv.py')}, 17:50:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:50:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:50:21 INFO - 'gecko_profile': False, 17:50:21 INFO - 'gecko_profile_interval': 0, 17:50:21 INFO - 'installer_path': 'installer.exe', 17:50:21 INFO - 'log_level': 'info', 17:50:21 INFO - 'log_name': 'talos', 17:50:21 INFO - 'log_to_console': True, 17:50:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:50:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:50:21 INFO - 'opt_config_files': (), 17:50:21 INFO - 'pip_index': False, 17:50:21 INFO - 'suite': 'dromaeojs-e10s', 17:50:21 INFO - 'system_bits': '32', 17:50:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:50:21 INFO - 'title': 'talos-linux64-ix-007', 17:50:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:50:21 INFO - 'use_talos_json': True, 17:50:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:50:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:50:21 INFO - 'work_dir': 'build'} 17:50:21 INFO - [mozharness: 2017-08-17 00:50:21.966843Z] Running clobber step. 17:50:21 INFO - Running pre-action listener: _resource_record_pre_action 17:50:21 INFO - Running main action method: clobber 17:50:21 INFO - rmtree: /builds/slave/test/build 17:50:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:50:23 INFO - Running post-action listener: _resource_record_post_action 17:50:23 INFO - [mozharness: 2017-08-17 00:50:23.005886Z] Finished clobber step (success) 17:50:23 INFO - [mozharness: 2017-08-17 00:50:23.005989Z] Running read-buildbot-config step. 17:50:23 INFO - Running pre-action listener: _resource_record_pre_action 17:50:23 INFO - Running main action method: read_buildbot_config 17:50:23 INFO - Using buildbot properties: 17:50:23 INFO - { 17:50:23 INFO - "project": "", 17:50:23 INFO - "product": "firefox", 17:50:23 INFO - "who": "kwierso@gmail.com", 17:50:23 INFO - "installer_path": "public/build/target.tar.bz2", 17:50:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 17:50:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:50:23 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 17:50:23 INFO - "stage_platform": "linux64-stylo", 17:50:23 INFO - "basedir": "/builds/slave/test", 17:50:23 INFO - "buildnumber": 272, 17:50:23 INFO - "platform": "ubuntu64_hw_stylo", 17:50:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:50:23 INFO - "slavebuilddir": "test", 17:50:23 INFO - "taskId": "HMKuZzUPS5KaeFs5fi1NCA", 17:50:23 INFO - "branch": "mozilla-central", 17:50:23 INFO - "script_repo_revision": "production", 17:50:23 INFO - "revision": "63ca686c3f1e870649b6d9c559973d100573aec2", 17:50:23 INFO - "slavename": "talos-linux64-ix-007", 17:50:23 INFO - "repo_path": "mozilla-central" 17:50:23 INFO - } 17:50:23 INFO - Finding installer, test and symbols from parent task. 17:50:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HMKuZzUPS5KaeFs5fi1NCA'}, attempt #1 17:50:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HMKuZzUPS5KaeFs5fi1NCA'}, attempt #1 17:50:23 INFO - Task dependencies: VGVatiFiSBqe2fkjUp-Rdg 17:50:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg'}, attempt #1 17:50:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.tar.bz2 17:50:24 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.test_packages.json 17:50:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.crashreporter-symbols.zip 17:50:24 INFO - Running post-action listener: _resource_record_post_action 17:50:24 INFO - [mozharness: 2017-08-17 00:50:24.374358Z] Finished read-buildbot-config step (success) 17:50:24 INFO - [mozharness: 2017-08-17 00:50:24.374579Z] Running download-and-extract step. 17:50:24 INFO - Running pre-action listener: _resource_record_pre_action 17:50:24 INFO - Running main action method: download_and_extract 17:50:24 INFO - mkdir: /builds/slave/test/build/tests 17:50:24 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')]} 17:50:24 INFO - trying https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.test_packages.json 17:50:24 INFO - Downloading https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:50:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:50:24 INFO - Downloaded 989 bytes. 17:50:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:50:24 INFO - Using the following test package requirements: 17:50:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:50:24 INFO - u'common': [u'target.common.tests.zip'], 17:50:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:50:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:50:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:50:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:50:24 INFO - u'mozbase': [u'target.common.tests.zip'], 17:50:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:50:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:50:24 INFO - u'web-platform': [u'target.common.tests.zip', 17:50:24 INFO - u'target.web-platform.tests.tar.gz'], 17:50:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:50:24 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:50:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.common.tests.zip 17:50:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:50:24 INFO - Fetch https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.common.tests.zip into memory 17:50:25 INFO - Content-Length response header: 53999262 17:50:26 INFO - Bytes received: 53999262 17:50:36 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:50:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.common.tests.zip 17:50:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:50:36 INFO - Fetch https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.common.tests.zip into memory 17:50:37 INFO - Content-Length response header: 53999262 17:50:37 INFO - Bytes received: 53999262 17:50:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.talos.tests.zip 17:50:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:50:50 INFO - Fetch https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.talos.tests.zip into memory 17:50:50 INFO - Content-Length response header: 14496161 17:50:50 INFO - Bytes received: 14496161 17:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:51 INFO - trying https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.tar.bz2 17:50:51 INFO - Downloading https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:50:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:50:52 INFO - Downloaded 61844620 bytes. 17:50:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.tar.bz2 17:50:52 INFO - mkdir: /builds/slave/test/properties 17:50:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:50:52 INFO - Writing to file /builds/slave/test/properties/build_url 17:50:52 INFO - Contents: 17:50:52 INFO - build_url:https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.tar.bz2 17:50:52 INFO - Running post-action listener: _resource_record_post_action 17:50:52 INFO - Running post-action listener: set_extra_try_arguments 17:50:52 INFO - [mozharness: 2017-08-17 00:50:52.107608Z] Finished download-and-extract step (success) 17:50:52 INFO - [mozharness: 2017-08-17 00:50:52.107707Z] Running populate-webroot step. 17:50:52 INFO - Running pre-action listener: _resource_record_pre_action 17:50:52 INFO - Running main action method: populate_webroot 17:50:52 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:50:52 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 17:50:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:50:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:50:52 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 17:50:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:50:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:50:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:50:52 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:50:52 INFO - 'talos_options': ['--stylo'], 17:50:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:50:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:50:52 INFO - 'tests': ['damp', 'tps']}, 17:50:52 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:50:52 INFO - 'talos_options': ['--stylo'], 17:50:52 INFO - 'tests': ['damp', 'tps']}, 17:50:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:50:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:50:52 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 17:50:52 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:50:52 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:50:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:50:52 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:50:52 INFO - 'talos_options': ['--stylo'], 17:50:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:50:52 INFO - 'other-e10s': {'tests': ['a11yr', 17:50:52 INFO - 'ts_paint', 17:50:52 INFO - 'tpaint', 17:50:52 INFO - 'sessionrestore', 17:50:52 INFO - 'sessionrestore_many_windows', 17:50:52 INFO - 'sessionrestore_no_auto_restore', 17:50:52 INFO - 'tabpaint']}, 17:50:52 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 17:50:52 INFO - 'tests': ['a11yr', 17:50:52 INFO - 'ts_paint', 17:50:52 INFO - 'tpaint', 17:50:52 INFO - 'sessionrestore', 17:50:52 INFO - 'sessionrestore_many_windows', 17:50:52 INFO - 'sessionrestore_no_auto_restore', 17:50:52 INFO - 'tabpaint']}, 17:50:52 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:50:52 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:50:52 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 17:50:52 INFO - 'tests': ['bloom_basic_singleton']}, 17:50:52 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 17:50:52 INFO - 'tests': ['bloom_basic']}, 17:50:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:50:52 INFO - 'tsvgr_opacity', 17:50:52 INFO - 'tart', 17:50:52 INFO - 'tscrollx', 17:50:52 INFO - 'tsvg_static']}, 17:50:52 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 17:50:52 INFO - 'tests': ['tsvgx', 17:50:52 INFO - 'tsvgr_opacity', 17:50:52 INFO - 'tart', 17:50:52 INFO - 'tscrollx', 17:50:52 INFO - 'tsvg_static']}, 17:50:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:50:52 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:50:52 INFO - 'talos_options': ['--stylo'], 17:50:52 INFO - 'tests': ['tp5o']}, 17:50:52 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:50:52 INFO - 'talos_options': ['--mitmproxy', 17:50:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:50:52 INFO - '--firstNonBlankPaint'], 17:50:52 INFO - 'tests': ['tp6_google', 17:50:52 INFO - 'tp6_youtube', 17:50:52 INFO - 'tp6_amazon', 17:50:52 INFO - 'tp6_facebook']}, 17:50:52 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:50:52 INFO - 'talos_options': ['--stylo', 17:50:52 INFO - '--mitmproxy', 17:50:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:50:52 INFO - '--firstNonBlankPaint'], 17:50:52 INFO - 'tests': ['tp6_google', 17:50:52 INFO - 'tp6_youtube', 17:50:52 INFO - 'tp6_amazon', 17:50:52 INFO - 'tp6_facebook']}, 17:50:52 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:50:52 INFO - 'talos_options': ['--stylo', 17:50:52 INFO - '--stylo-threads=1', 17:50:52 INFO - '--mitmproxy', 17:50:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:50:52 INFO - '--firstNonBlankPaint'], 17:50:52 INFO - 'tests': ['tp6_google', 17:50:52 INFO - 'tp6_youtube', 17:50:52 INFO - 'tp6_amazon', 17:50:52 INFO - 'tp6_facebook']}, 17:50:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:50:52 INFO - 'talos_options': ['--xperf_path', 17:50:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:50:52 INFO - 'tests': ['tp5n']}, 17:50:52 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 17:50:52 INFO - 'talos_options': ['--stylo', 17:50:52 INFO - '--xperf_path', 17:50:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:50:52 INFO - 'tests': ['tp5n']}}} 17:50:52 INFO - Running post-action listener: _resource_record_post_action 17:50:52 INFO - [mozharness: 2017-08-17 00:50:52.122082Z] Finished populate-webroot step (success) 17:50:52 INFO - [mozharness: 2017-08-17 00:50:52.122173Z] Running create-virtualenv step. 17:50:52 INFO - Running pre-action listener: _resource_record_pre_action 17:50:52 INFO - Running main action method: create_virtualenv 17:50:52 INFO - Creating virtualenv /builds/slave/test/build/venv 17:50:52 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 17:50:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:50:52 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:50:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:50:52 INFO - Using real prefix '/usr' 17:50:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:50:52 INFO - Installing distribute.............................................................................................................................................................................................done. 17:50:54 INFO - Installing pip.................done. 17:50:54 INFO - Return code: 0 17:50:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:50:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:50:54 INFO - Reading from file tmpfile_stdout 17:50:54 INFO - Output received: 17:50:54 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) 17:50:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:54 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 0x29441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a48a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bebef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be90b0>, '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 0x2be9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bea440>, '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': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', '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 17:50:54 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 17:50:54 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 17:50:54 INFO - Using env: {'DISPLAY': ':0', 17:50:54 INFO - 'HOME': '/home/cltbld', 17:50:54 INFO - 'LANG': 'en_US.UTF-8', 17:50:54 INFO - 'LANGUAGE': 'en_US:en', 17:50:54 INFO - 'LOGNAME': 'cltbld', 17:50:54 INFO - 'MAIL': '/var/mail/cltbld', 17:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:54 INFO - 'MOZ_NO_REMOTE': '1', 17:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:54 INFO - 'NO_EM_RESTART': '1', 17:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:54 INFO - 'PWD': '/builds/slave/test', 17:50:54 INFO - 'SHELL': '/bin/bash', 17:50:54 INFO - 'SHLVL': '1', 17:50:54 INFO - 'TERM': 'linux', 17:50:54 INFO - 'TMOUT': '86400', 17:50:54 INFO - 'USER': 'cltbld', 17:50:54 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', 17:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:54 INFO - '_': '/tools/buildbot/bin/python'} 17:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:55 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 17:50:55 INFO - Cleaning up... 17:50:55 INFO - Return code: 0 17:50:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a48a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bebef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be90b0>, '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 0x2be9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bea440>, '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': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', '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 17:50:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:50:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:50:55 INFO - Using env: {'DISPLAY': ':0', 17:50:55 INFO - 'HOME': '/home/cltbld', 17:50:55 INFO - 'LANG': 'en_US.UTF-8', 17:50:55 INFO - 'LANGUAGE': 'en_US:en', 17:50:55 INFO - 'LOGNAME': 'cltbld', 17:50:55 INFO - 'MAIL': '/var/mail/cltbld', 17:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:55 INFO - 'MOZ_NO_REMOTE': '1', 17:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:55 INFO - 'NO_EM_RESTART': '1', 17:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:55 INFO - 'PWD': '/builds/slave/test', 17:50:55 INFO - 'SHELL': '/bin/bash', 17:50:55 INFO - 'SHLVL': '1', 17:50:55 INFO - 'TERM': 'linux', 17:50:55 INFO - 'TMOUT': '86400', 17:50:55 INFO - 'USER': 'cltbld', 17:50:55 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', 17:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:55 INFO - '_': '/tools/buildbot/bin/python'} 17:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:55 INFO - Downloading/unpacking psutil>=3.1.1 17:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:50:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:50:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:50:56 INFO - Installing collected packages: psutil 17:50:56 INFO - Running setup.py install for psutil 17:50:56 INFO - building 'psutil._psutil_linux' extension 17:50:56 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 17:50:56 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 17:50:56 INFO - building 'psutil._psutil_posix' extension 17:50:56 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 17:50:56 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 17:50:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:50:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:50:57 INFO - Successfully installed psutil 17:50:57 INFO - Cleaning up... 17:50:57 INFO - Return code: 0 17:50:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:57 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 0x29441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a48a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bebef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be90b0>, '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 0x2be9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bea440>, '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': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', '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 17:50:57 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 17:50:57 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 17:50:57 INFO - Using env: {'DISPLAY': ':0', 17:50:57 INFO - 'HOME': '/home/cltbld', 17:50:57 INFO - 'LANG': 'en_US.UTF-8', 17:50:57 INFO - 'LANGUAGE': 'en_US:en', 17:50:57 INFO - 'LOGNAME': 'cltbld', 17:50:57 INFO - 'MAIL': '/var/mail/cltbld', 17:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:57 INFO - 'MOZ_NO_REMOTE': '1', 17:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:57 INFO - 'NO_EM_RESTART': '1', 17:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:57 INFO - 'PWD': '/builds/slave/test', 17:50:57 INFO - 'SHELL': '/bin/bash', 17:50:57 INFO - 'SHLVL': '1', 17:50:57 INFO - 'TERM': 'linux', 17:50:57 INFO - 'TMOUT': '86400', 17:50:57 INFO - 'USER': 'cltbld', 17:50:57 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', 17:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:57 INFO - '_': '/tools/buildbot/bin/python'} 17:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:50:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:50:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:50:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:50:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:50:58 INFO - Installing collected packages: mozsystemmonitor 17:50:58 INFO - Running setup.py install for mozsystemmonitor 17:50:58 INFO - Successfully installed mozsystemmonitor 17:50:58 INFO - Cleaning up... 17:50:58 INFO - Return code: 0 17:50:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:50:58 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 0x29441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a48a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bebef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be90b0>, '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 0x2be9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bea440>, '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': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', '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 17:50:58 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 17:50:58 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 17:50:58 INFO - Using env: {'DISPLAY': ':0', 17:50:58 INFO - 'HOME': '/home/cltbld', 17:50:58 INFO - 'LANG': 'en_US.UTF-8', 17:50:58 INFO - 'LANGUAGE': 'en_US:en', 17:50:58 INFO - 'LOGNAME': 'cltbld', 17:50:58 INFO - 'MAIL': '/var/mail/cltbld', 17:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:50:58 INFO - 'MOZ_NO_REMOTE': '1', 17:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:50:58 INFO - 'NO_EM_RESTART': '1', 17:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:50:58 INFO - 'PWD': '/builds/slave/test', 17:50:58 INFO - 'SHELL': '/bin/bash', 17:50:58 INFO - 'SHLVL': '1', 17:50:58 INFO - 'TERM': 'linux', 17:50:58 INFO - 'TMOUT': '86400', 17:50:58 INFO - 'USER': 'cltbld', 17:50:58 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', 17:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:50:58 INFO - '_': '/tools/buildbot/bin/python'} 17:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:50:58 INFO - Downloading/unpacking jsonschema==2.5.1 17:50:58 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 17:50:58 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 17:50:58 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 17:50:58 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 17:50:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:50:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:50:59 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 17:50:59 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 17:50:59 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 17:50:59 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 17:51:00 INFO - Downloading functools32-3.2.3-2.tar.gz 17:51:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:51:00 INFO - warning: no files found matching '*.txt' 17:51:00 INFO - no previously-included directories found matching 'build' 17:51:00 INFO - no previously-included directories found matching 'dist' 17:51:00 INFO - no previously-included directories found matching '.git*' 17:51:00 INFO - Installing collected packages: jsonschema, functools32 17:51:00 INFO - Running setup.py install for functools32 17:51:00 INFO - warning: no files found matching '*.txt' 17:51:00 INFO - no previously-included directories found matching 'build' 17:51:00 INFO - no previously-included directories found matching 'dist' 17:51:00 INFO - no previously-included directories found matching '.git*' 17:51:00 INFO - Successfully installed jsonschema functools32 17:51:00 INFO - Cleaning up... 17:51:00 INFO - Return code: 0 17:51:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a48a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bebef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be90b0>, '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 0x2be9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bea440>, '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': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', '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 17:51:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:51:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:51:00 INFO - Using env: {'DISPLAY': ':0', 17:51:00 INFO - 'HOME': '/home/cltbld', 17:51:00 INFO - 'LANG': 'en_US.UTF-8', 17:51:00 INFO - 'LANGUAGE': 'en_US:en', 17:51:00 INFO - 'LOGNAME': 'cltbld', 17:51:00 INFO - 'MAIL': '/var/mail/cltbld', 17:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:00 INFO - 'MOZ_NO_REMOTE': '1', 17:51:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:00 INFO - 'NO_EM_RESTART': '1', 17:51:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:00 INFO - 'PWD': '/builds/slave/test', 17:51:00 INFO - 'SHELL': '/bin/bash', 17:51:00 INFO - 'SHLVL': '1', 17:51:00 INFO - 'TERM': 'linux', 17:51:00 INFO - 'TMOUT': '86400', 17:51:00 INFO - 'USER': 'cltbld', 17:51:00 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', 17:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:00 INFO - '_': '/tools/buildbot/bin/python'} 17:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:51:00 INFO - Cleaning up... 17:51:00 INFO - Return code: 0 17:51:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a48a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bebef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be90b0>, '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 0x2be9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bea440>, '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': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', '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 17:51:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:51:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:51:00 INFO - Using env: {'DISPLAY': ':0', 17:51:00 INFO - 'HOME': '/home/cltbld', 17:51:00 INFO - 'LANG': 'en_US.UTF-8', 17:51:00 INFO - 'LANGUAGE': 'en_US:en', 17:51:00 INFO - 'LOGNAME': 'cltbld', 17:51:00 INFO - 'MAIL': '/var/mail/cltbld', 17:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:00 INFO - 'MOZ_NO_REMOTE': '1', 17:51:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:00 INFO - 'NO_EM_RESTART': '1', 17:51:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:00 INFO - 'PWD': '/builds/slave/test', 17:51:00 INFO - 'SHELL': '/bin/bash', 17:51:00 INFO - 'SHLVL': '1', 17:51:00 INFO - 'TERM': 'linux', 17:51:00 INFO - 'TMOUT': '86400', 17:51:00 INFO - 'USER': 'cltbld', 17:51:00 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', 17:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:00 INFO - '_': '/tools/buildbot/bin/python'} 17:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:00 INFO - Downloading/unpacking blobuploader==1.2.4 17:51:00 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 17:51:00 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 17:51:00 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 17:51:00 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 17:51:01 INFO - Downloading blobuploader-1.2.4.tar.gz 17:51:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:51:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:51:01 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 17:51:01 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 17:51:01 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 17:51:01 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 17:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:51:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:51:02 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 17:51:02 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 17:51:02 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 17:51:02 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 17:51:02 INFO - Downloading docopt-0.6.1.tar.gz 17:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:51:02 INFO - Installing collected packages: blobuploader, requests, docopt 17:51:02 INFO - Running setup.py install for blobuploader 17:51:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:51:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:51:02 INFO - Running setup.py install for requests 17:51:02 INFO - Running setup.py install for docopt 17:51:02 INFO - Successfully installed blobuploader requests docopt 17:51:02 INFO - Cleaning up... 17:51:02 INFO - Return code: 0 17:51:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:02 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 0x29441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a48a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bebef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be90b0>, '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 0x2be9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bea440>, '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': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', '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 17:51:02 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 17:51:02 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 17:51:02 INFO - Using env: {'DISPLAY': ':0', 17:51:02 INFO - 'HOME': '/home/cltbld', 17:51:02 INFO - 'LANG': 'en_US.UTF-8', 17:51:02 INFO - 'LANGUAGE': 'en_US:en', 17:51:02 INFO - 'LOGNAME': 'cltbld', 17:51:02 INFO - 'MAIL': '/var/mail/cltbld', 17:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:02 INFO - 'MOZ_NO_REMOTE': '1', 17:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:03 INFO - 'NO_EM_RESTART': '1', 17:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:03 INFO - 'PWD': '/builds/slave/test', 17:51:03 INFO - 'SHELL': '/bin/bash', 17:51:03 INFO - 'SHLVL': '1', 17:51:03 INFO - 'TERM': 'linux', 17:51:03 INFO - 'TMOUT': '86400', 17:51:03 INFO - 'USER': 'cltbld', 17:51:03 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', 17:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:03 INFO - '_': '/tools/buildbot/bin/python'} 17:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:51:03 INFO - Running setup.py (path:/tmp/pip-0haGI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:51:03 INFO - Running setup.py (path:/tmp/pip-nvHJ5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:51:03 INFO - Running setup.py (path:/tmp/pip-DNrcJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:51:03 INFO - Running setup.py (path:/tmp/pip-6femDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:51:03 INFO - Running setup.py (path:/tmp/pip-SQdtv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:51:03 INFO - Running setup.py (path:/tmp/pip-aH1c1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:51:03 INFO - Running setup.py (path:/tmp/pip-yPaJQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:51:03 INFO - Running setup.py (path:/tmp/pip-PE7BKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:51:03 INFO - Running setup.py (path:/tmp/pip-DZCSTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:51:03 INFO - Running setup.py (path:/tmp/pip-m_HrTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:51:03 INFO - Running setup.py (path:/tmp/pip-J6PhGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:51:03 INFO - Running setup.py (path:/tmp/pip-NgaFkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:51:04 INFO - Running setup.py (path:/tmp/pip-UDnoZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:51:04 INFO - Running setup.py (path:/tmp/pip-FE0pNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:04 INFO - Running setup.py (path:/tmp/pip-FkGdMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:51:04 INFO - Running setup.py (path:/tmp/pip-tXwMvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:51:04 INFO - Running setup.py (path:/tmp/pip-aIKatx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:51:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:51:04 INFO - Running setup.py install for manifestparser 17:51:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:51:04 INFO - Running setup.py install for mozcrash 17:51:04 INFO - Running setup.py install for mozdebug 17:51:04 INFO - Running setup.py install for mozdevice 17:51:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:51:04 INFO - Running setup.py install for mozfile 17:51:04 INFO - Running setup.py install for mozhttpd 17:51:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:51:04 INFO - Running setup.py install for mozinfo 17:51:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:51:05 INFO - Running setup.py install for mozInstall 17:51:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:51:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:51:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:51:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:51:05 INFO - Running setup.py install for mozleak 17:51:05 INFO - Running setup.py install for mozlog 17:51:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:51:05 INFO - Running setup.py install for moznetwork 17:51:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:51:05 INFO - Running setup.py install for mozprocess 17:51:05 INFO - Running setup.py install for mozprofile 17:51:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:51:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:51:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:51:05 INFO - Running setup.py install for mozrunner 17:51:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:51:05 INFO - Running setup.py install for mozscreenshot 17:51:05 INFO - Running setup.py install for moztest 17:51:06 INFO - Running setup.py install for mozversion 17:51:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:51:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:51:06 INFO - Cleaning up... 17:51:06 INFO - Return code: 0 17:51:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:06 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 0x29441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a48a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bebef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be90b0>, '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 0x2be9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bea440>, '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': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', '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 17:51:06 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 17:51:06 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 17:51:06 INFO - Using env: {'DISPLAY': ':0', 17:51:06 INFO - 'HOME': '/home/cltbld', 17:51:06 INFO - 'LANG': 'en_US.UTF-8', 17:51:06 INFO - 'LANGUAGE': 'en_US:en', 17:51:06 INFO - 'LOGNAME': 'cltbld', 17:51:06 INFO - 'MAIL': '/var/mail/cltbld', 17:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:06 INFO - 'MOZ_NO_REMOTE': '1', 17:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:06 INFO - 'NO_EM_RESTART': '1', 17:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:06 INFO - 'PWD': '/builds/slave/test', 17:51:06 INFO - 'SHELL': '/bin/bash', 17:51:06 INFO - 'SHLVL': '1', 17:51:06 INFO - 'TERM': 'linux', 17:51:06 INFO - 'TMOUT': '86400', 17:51:06 INFO - 'USER': 'cltbld', 17:51:06 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', 17:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:06 INFO - '_': '/tools/buildbot/bin/python'} 17:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:51:06 INFO - Running setup.py (path:/tmp/pip-d7ngwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:51:06 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)) 17:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:51:06 INFO - Running setup.py (path:/tmp/pip-8YgZy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:51:06 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)) 17:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:51:06 INFO - Running setup.py (path:/tmp/pip-tDC3B7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:51:06 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)) 17:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:51:06 INFO - Running setup.py (path:/tmp/pip-cvYThz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:51:06 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)) 17:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:51:06 INFO - Running setup.py (path:/tmp/pip-jTuFmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:51:06 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)) 17:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:51:06 INFO - Running setup.py (path:/tmp/pip-qQPvku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:51:06 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)) 17:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:51:06 INFO - Running setup.py (path:/tmp/pip-twAzuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:51:06 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)) 17:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:51:06 INFO - Running setup.py (path:/tmp/pip-qsJ8VP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:51:06 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)) 17:51:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:51:06 INFO - Running setup.py (path:/tmp/pip-pqgxSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:51:07 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)) 17:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:51:07 INFO - Running setup.py (path:/tmp/pip-5j1LbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:51:07 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)) 17:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:51:07 INFO - Running setup.py (path:/tmp/pip-5bdZLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:51:07 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)) 17:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:51:07 INFO - Running setup.py (path:/tmp/pip-8lsDLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:51:07 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)) 17:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:51:07 INFO - Running setup.py (path:/tmp/pip-9Ew8yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:51:07 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)) 17:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:51:07 INFO - Running setup.py (path:/tmp/pip-0ry0k2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:51:07 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)) 17:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:07 INFO - Running setup.py (path:/tmp/pip-fnUERA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:51:07 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)) 17:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:51:07 INFO - Running setup.py (path:/tmp/pip-CuIPjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:51:07 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)) 17:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:51:07 INFO - Running setup.py (path:/tmp/pip-DvhQGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:51:07 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)) 17:51:07 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)) 17:51:07 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)) 17:51:07 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)) 17:51:07 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)) 17:51:07 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)) 17:51:07 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)) 17:51:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:08 INFO - Downloading blessings-1.6.tar.gz 17:51:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:51:08 INFO - Installing collected packages: blessings 17:51:08 INFO - Running setup.py install for blessings 17:51:08 INFO - Successfully installed blessings 17:51:08 INFO - Cleaning up... 17:51:08 INFO - Return code: 0 17:51:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:51:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:51:09 INFO - Reading from file tmpfile_stdout 17:51:09 INFO - Current package versions: 17:51:09 INFO - argparse == 1.2.1 17:51:09 INFO - blessings == 1.6 17:51:09 INFO - blobuploader == 1.2.4 17:51:09 INFO - docopt == 0.6.1 17:51:09 INFO - functools32 == 3.2.3-2 17:51:09 INFO - jsonschema == 2.5.1 17:51:09 INFO - manifestparser == 1.1 17:51:09 INFO - mozInstall == 1.13 17:51:09 INFO - mozcrash == 1.0 17:51:09 INFO - mozdebug == 0.1 17:51:09 INFO - mozdevice == 0.51 17:51:09 INFO - mozfile == 1.2 17:51:09 INFO - mozhttpd == 0.7 17:51:09 INFO - mozinfo == 0.10 17:51:09 INFO - mozleak == 0.1 17:51:09 INFO - mozlog == 3.5 17:51:09 INFO - moznetwork == 0.27 17:51:09 INFO - mozprocess == 0.25 17:51:09 INFO - mozprofile == 0.28 17:51:09 INFO - mozrunner == 6.13 17:51:09 INFO - mozscreenshot == 0.1 17:51:09 INFO - mozsystemmonitor == 0.3 17:51:09 INFO - moztest == 0.8 17:51:09 INFO - mozversion == 1.4 17:51:09 INFO - psutil == 3.1.1 17:51:09 INFO - requests == 1.2.3 17:51:09 INFO - wsgiref == 0.1.2 17:51:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:51: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')]} 17:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51: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')]} 17:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:09 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 0x29441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a48a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bebef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be90b0>, '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 0x2be9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bea440>, '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': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', '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 17:51:09 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 17:51:09 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 17:51:09 INFO - Using env: {'DISPLAY': ':0', 17:51:09 INFO - 'HOME': '/home/cltbld', 17:51:09 INFO - 'LANG': 'en_US.UTF-8', 17:51:09 INFO - 'LANGUAGE': 'en_US:en', 17:51:09 INFO - 'LOGNAME': 'cltbld', 17:51:09 INFO - 'MAIL': '/var/mail/cltbld', 17:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:09 INFO - 'MOZ_NO_REMOTE': '1', 17:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:09 INFO - 'NO_EM_RESTART': '1', 17:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:09 INFO - 'PWD': '/builds/slave/test', 17:51:09 INFO - 'SHELL': '/bin/bash', 17:51:09 INFO - 'SHLVL': '1', 17:51:09 INFO - 'TERM': 'linux', 17:51:09 INFO - 'TMOUT': '86400', 17:51:09 INFO - 'USER': 'cltbld', 17:51:09 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', 17:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:09 INFO - '_': '/tools/buildbot/bin/python'} 17:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:09 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)) 17:51:09 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)) 17:51:09 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)) 17:51:09 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)) 17:51:09 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)) 17:51:09 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)) 17:51:09 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)) 17:51:09 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)) 17:51:09 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)) 17:51:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:51:10 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)) 17:51:10 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)) 17:51:10 INFO - Installing collected packages: simplejson 17:51:10 INFO - Running setup.py install for simplejson 17:51:10 INFO - building 'simplejson._speedups' extension 17:51:10 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 17:51:11 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 17:51:11 INFO - Successfully installed simplejson 17:51:11 INFO - Cleaning up... 17:51:11 INFO - Return code: 0 17:51:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:51:11 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')]} 17:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:51:11 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')]} 17:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:51:11 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 0x29441f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a48a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bebef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be90b0>, '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 0x2be9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bea440>, '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': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', '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 17:51:11 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 17:51:11 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 17:51:11 INFO - Using env: {'DISPLAY': ':0', 17:51:11 INFO - 'HOME': '/home/cltbld', 17:51:11 INFO - 'LANG': 'en_US.UTF-8', 17:51:11 INFO - 'LANGUAGE': 'en_US:en', 17:51:11 INFO - 'LOGNAME': 'cltbld', 17:51:11 INFO - 'MAIL': '/var/mail/cltbld', 17:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:11 INFO - 'MOZ_NO_REMOTE': '1', 17:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:11 INFO - 'NO_EM_RESTART': '1', 17:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:11 INFO - 'PWD': '/builds/slave/test', 17:51:11 INFO - 'SHELL': '/bin/bash', 17:51:11 INFO - 'SHLVL': '1', 17:51:11 INFO - 'TERM': 'linux', 17:51:11 INFO - 'TMOUT': '86400', 17:51:11 INFO - 'USER': 'cltbld', 17:51:11 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', 17:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:11 INFO - '_': '/tools/buildbot/bin/python'} 17:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:51:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:51:11 INFO - Cleaning up... 17:51:11 INFO - Return code: 0 17:51:11 INFO - Running post-action listener: _resource_record_post_action 17:51:11 INFO - Running post-action listener: _start_resource_monitoring 17:51:11 INFO - Starting resource monitoring. 17:51:11 INFO - [mozharness: 2017-08-17 00:51:11.973023Z] Finished create-virtualenv step (success) 17:51:11 INFO - [mozharness: 2017-08-17 00:51:11.973626Z] Running install step. 17:51:11 INFO - Running pre-action listener: _resource_record_pre_action 17:51:11 INFO - Running main action method: install 17:51:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:51:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:51:12 INFO - Reading from file tmpfile_stdout 17:51:12 INFO - Detecting whether we're running mozinstall >=1.0... 17:51:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:51:12 INFO - Reading from file tmpfile_stdout 17:51:12 INFO - Output received: 17:51:12 INFO - Usage: mozinstall [options] installer 17:51:12 INFO - Options: 17:51:12 INFO - -h, --help show this help message and exit 17:51:12 INFO - -d DEST, --destination=DEST 17:51:12 INFO - Directory to install application into. [default: 17:51:12 INFO - "/builds/slave/test"] 17:51:12 INFO - --app=APP Application being installed. [default: firefox] 17:51:12 INFO - mkdir: /builds/slave/test/build/application 17:51:12 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'] 17:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:51:30 INFO - Reading from file tmpfile_stdout 17:51:30 INFO - Output received: 17:51:30 INFO - /builds/slave/test/build/application/firefox/firefox 17:51:30 INFO - Running post-action listener: _resource_record_post_action 17:51:30 INFO - [mozharness: 2017-08-17 00:51:30.266126Z] Finished install step (success) 17:51:30 INFO - [mozharness: 2017-08-17 00:51:30.266410Z] Running setup-mitmproxy step. 17:51:30 INFO - Running pre-action listener: _resource_record_pre_action 17:51:30 INFO - Running main action method: setup_mitmproxy 17:51:30 INFO - Skipping: mitmproxy is not required 17:51:30 INFO - Running post-action listener: _resource_record_post_action 17:51:30 INFO - [mozharness: 2017-08-17 00:51:30.267559Z] Finished setup-mitmproxy step (success) 17:51:30 INFO - [mozharness: 2017-08-17 00:51:30.267779Z] Running run-tests step. 17:51:30 INFO - Running pre-action listener: _resource_record_pre_action 17:51:30 INFO - Running pre-action listener: _set_gcov_prefix 17:51:30 INFO - Running main action method: run_tests 17:51:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:51:30 INFO - Python 2.7.3 17:51:30 INFO - Return code: 0 17:51:30 INFO - grabbing minidump binary from tooltool 17:51:30 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')]} 17:51:30 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 0x2be90b0>, '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 0x2be9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bea440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:51:30 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 17:51:30 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 17:51:30 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 17:51:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:51:30 INFO - Return code: 0 17:51:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:51:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:51:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:51:30 INFO - ENV: RUST_BACKTRACE is now full 17:51:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:51:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:51:30 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/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 17:51:30 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/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 17:51:30 INFO - Using env: {'DISPLAY': ':0', 17:51:30 INFO - 'HOME': '/home/cltbld', 17:51:30 INFO - 'LANG': 'en_US.UTF-8', 17:51:30 INFO - 'LANGUAGE': 'en_US:en', 17:51:30 INFO - 'LOGNAME': 'cltbld', 17:51:30 INFO - 'MAIL': '/var/mail/cltbld', 17:51:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:51:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:51:30 INFO - 'MOZ_NO_REMOTE': '1', 17:51:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:51:30 INFO - 'NO_EM_RESTART': '1', 17:51:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:51:30 INFO - 'PWD': '/builds/slave/test', 17:51:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:51:30 INFO - 'RUST_BACKTRACE': 'full', 17:51:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:51:30 INFO - 'SHELL': '/bin/bash', 17:51:30 INFO - 'SHLVL': '1', 17:51:30 INFO - 'STYLO_FORCE_ENABLED': '1', 17:51:30 INFO - 'TERM': 'linux', 17:51:30 INFO - 'TMOUT': '86400', 17:51:30 INFO - 'USER': 'cltbld', 17:51:30 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330', 17:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:51:30 INFO - '_': '/tools/buildbot/bin/python'} 17:51:30 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/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 17:51:30 INFO - mozversion application_buildid: 20170816235940 17:51:30 INFO - mozversion application_changeset: 63ca686c3f1e870649b6d9c559973d100573aec2 17:51:30 INFO - mozversion application_display_name: Nightly 17:51:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:51:30 INFO - mozversion application_name: Firefox 17:51:30 INFO - mozversion application_remotingname: firefox 17:51:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:51:30 INFO - mozversion application_vendor: Mozilla 17:51:30 INFO - mozversion application_version: 57.0a1 17:51:30 INFO - mozversion platform_buildid: 20170816235940 17:51:30 INFO - mozversion platform_changeset: 63ca686c3f1e870649b6d9c559973d100573aec2 17:51:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:51:30 INFO - mozversion platform_version: 57.0a1 17:51:30 INFO - using testdate: 1502931090 17:51:30 INFO - actual date: 1502931090 17:51:30 INFO - starting webserver on 'localhost:58693' 17:51:30 INFO - SUITE-START | Running 2 tests 17:51:30 INFO - TEST-START | dromaeo_css 17:51:30 INFO - Initialising browser for dromaeo_css test... 17:51:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58693/getInfo.html -profile /tmp/tmpETVDvk/profile 17:51:30 INFO - TEST-INFO | started process 4578 (/builds/slave/test/build/application/firefox/firefox http://localhost:58693/getInfo.html) 17:51:35 INFO - TEST-INFO | 4578: exit 0 17:51:35 INFO - Browser initialized. 17:51:35 INFO - Running cycle 1/1 for dromaeo_css test... 17:51:35 INFO - TEST-INFO | started process 4772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpETVDvk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:51:36 INFO - PID 4772 | 17:51:36 INFO - PID 4772 | (/builds/slave/test/build/application/firefox/firefox:4826): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:51:36 INFO - PID 4772 | 17:51:47 INFO - PID 4772 | RSS: Main: 166764544 17:51:47 INFO - PID 4772 | 17:54:45 INFO - PID 4772 | Cycle 1(1): loaded http://localhost:58693/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58693/tests/dromaeo/cssquery-ext.html) 17:54:47 INFO - PID 4772 | RSS: Main: 172474368 17:54:47 INFO - PID 4772 | 17:57:49 INFO - PID 4772 | Cycle 1(1): loaded http://localhost:58693/tests/dromaeo/cssquery-ext.html (next: http://localhost:58693/tests/dromaeo/cssquery-jquery.html) 17:57:50 INFO - PID 4772 | RSS: Main: 171765760 17:57:50 INFO - PID 4772 | 18:00:51 INFO - PID 4772 | Cycle 1(1): loaded http://localhost:58693/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58693/tests/dromaeo/cssquery-mootools.html) 18:00:52 INFO - PID 4772 | RSS: Main: 173207552 18:00:52 INFO - PID 4772 | 18:03:54 INFO - PID 4772 | Cycle 1(1): loaded http://localhost:58693/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58693/tests/dromaeo/cssquery-prototype.html) 18:03:54 INFO - PID 4772 | RSS: Main: 172199936 18:03:54 INFO - PID 4772 | 18:06:58 INFO - PID 4772 | Cycle 1(1): loaded http://localhost:58693/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58693/tests/dromaeo/cssquery-yui.html) 18:06:58 INFO - PID 4772 | RSS: Main: 175845376 18:06:58 INFO - PID 4772 | 18:10:00 INFO - PID 4772 | Cycle 1(1): loaded http://localhost:58693/tests/dromaeo/cssquery-yui.html (next: http://localhost:58693/tests/dromaeo/cssquery-dojo.html) 18:10:00 INFO - PID 4772 | RSS: Main: 174481408 18:10:00 INFO - PID 4772 | 18:10:00 INFO - PID 4772 | __start_tp_report 18:10:00 INFO - PID 4772 | _x_x_mozilla_page_load 18:10:00 INFO - PID 4772 | _x_x_mozilla_page_load_details 18:10:00 INFO - PID 4772 | |i|pagename|runs| 18:10:00 INFO - PID 4772 | |0;dojo.html;3157.289609837787;3199.296154845934;3204.4392231359516;3217.8230197339135;3218.388506183825;6187.102870083835;6253.624782513052;6279.937200627993;6311.053341998697;6316.684165791704;6146.078088286759;6262.561620686553;6271.027990661443;6279.277883043452;6288.559800813945;5723.141528770676;5743.741531631076;5765.711714414283;5768.307803063638;5834.241548598677;5745.770169193227;5748.942510574903;5822.534197264209;5837.09525023622;5843.678597677147;5634.521065709419;5786.884262314772;5794.449527294901;5835.183074369592;5865.970670146643;5699.173619825102;5707.172459993278;5736.684482353469;5795.565332600029;5805.796797112123;5672.773089076432;5707.5148612368;5744.540436765049;5764.682942438164;5776.682282474462;6052.485538729214;6127.111568822495;6148.477379422754;6172.69136543171;6240.344763799781;6666.233383160901;6674.866502669968;6728.39444449997;6766.796996090076;6779.762708305186;6841.555298905605;6867.141607299088;6870.381665650116;6913.274106218875;6915.757948471779;6279.120923070774;6292.685365731741;6351.142595749607;6367.968160159216;6384.329645387167;6857.965710171417;6979.1973922999505;7034.296570343027;7039.788806335818;7040.155181378165;6547.312532184147;6548.8035358939305;6631.1379520662;6659.4006539411685;6665.233498147678;6714.026466162477;6800.489963252776;6810.455163586901;6819.5908245505425;6844.28135045823;6614.404703576605;6725.024871393718;6735.764248251287;6811.421029212573;6812.1144251248015;6622.801315960529;6655.0682904393425;6730.899036514456;6741.494387920926;6819.863602728017;5441.673499589958;5462.590305727086;5463.562914966793;5473.31583552056;5474.945250547523;4656.930146047812;4667.533246675373;4668.603168730628;4673.836415725434;4708.105459962665;5744.167095771173;5755.625884317506;5757.712114394348;5828.79599214034;5838.795642152504;6595.307492713292;6690.29751876046;6726.428253598401;6739.224989126215;6836.418904393083;5721.084626459747;5729.197912292282;5735.8852822944145;5747.166660834239;5748.683822389725;5889.705514724246;5892.234009578813;5893.852653683606;5897.292324921037;5903.616264942765;6406.743730250831;6561.967190164114;6563.409293163638;6564.934350656527;6567.704453299613;6792.626405547742;6806.217285012287;6812.1144251248015;6825.1127353443735;6861.416779573792;6463.127477790438;6479.7408103675325;6539.051837483634;6567.211934567882;6571.178602674666;6429.421352078335;6594.769183078569;6613.074169616354;6717.899231511629;6718.764843230463;6502.122213501117;6564.245111812012;6566.9014964774615;6581.638009909501;6679.432248258952;6523.347665233438;6523.67381630907;6544.705488253136;6545;6559.180102487189;6415.422611964946;6513.511486638616;6596.472282217507;6598.439132673777;6605;6398.776042838478;6403.359664033559;6405.167328247298;6407.711652975534;6415.550911436155;6543.247526534509;6560.671966401756;6579.901301480578;6716.361945615159;6728.125343705483;6263.62418254888;6391.904121438275;6467.482601391784;6468.482521398371;6471.805845824632 18:10:00 INFO - PID 4772 | |1;ext.html;834.7078522517118;854.1586537260797;1145.209805234388;1197.8682344942056;1245.1470742541355;36958.815205923966;41041.794791026005;41273.38089928646;41287.58712412875;41288.17423651529;39292.214155716865;39608.405873911914;39619.20761584766;39740;39751;7125.928740712604;7328;7550.320471157622;7683.57740324282;7692.153863075086;7617.390608751314;7734.961325193366;7736.729214477495;7739.9613001935195;7743.18696536864;7682.078150621933;7725.768226953172;7736.419768517356;7742.574158421285;7744.922550774505;7708.460407771458;7726.188750181206;7756.457048006641;7758.650860711282;7762.844743105163;7642.847143057108;7706.344960678293;7712.922870771276;7715.305622493946;7720.266574675396;39857.206425710916;40011;40253.194936101114;40268.39597406041;40315.19369612591;3532.152283451953;3555.5022296878456;3557.0929412999776;3572.07126147201;3577.5170352002665;31452.21369465759;31489.8425507871;31543.684563154304;31618.683813161802;31695.84152079248;4914.262860570907;5101.744912754384;5159.587233021387;5165.1219292720325;5169.327987361657;185851;186802;186960;188857;188990;43294.567054329054;44264.3360349595;49976;50166.49833501691;50376.74811625919;49589;50317.74841125771;50366;50450.74774626103;50480.74759626252;16360.509184724477;16386.508404747878;16400.425985090464;16484.752728709078;16487.505374838773;13504.459821607026;13519.797203041962;13557.457701691821;13588.524401645895;13589;13289.20264784116;13356.5325213619;13362.997775166707;13372.33138343079;13529.1206071607;5445.237666726662;5470.589705772083;5488.670679759227;5514.531264842533;5557.472040156179;1004.8894621591619;1010.959561617527;1020.0921180149672;1027.3733022856052;1031.7730099378125;23095.538089238456;23350.18274360389;23363.883180583987;23380.18169364064;23401.648975265383;1106.0764261841452;1113.0983903038402;1123.224974767408;1124.1119515582598;1136.4374634555948;12044.75910481803;12363.32001739913;12367.381630918419;12513.749725005631;12517.56188533397;227853;232476;232661;232968;233129;54328.72835635796;54440;54447;54465.45534544604;54517;1475.845036271176;1477.18754684925;1504.9924750376397;1515.121229686779;1525.9008164469496;22777.88611056934;22805.31584052481;22844.200452984067;23097.65353519665;23349.299521014396;38080.23839523138;38381.424278636405;38424.80787596044;38450.230995379374;38458.23083538369;183697.08151459158;184793;184795;185778;185872;33674.83162584171;33734;35592.64407355997;37629.62370376261;37762.62237377701;46447.53552464432;48486;48547;48902.51097489122;49062.26406603975;34244.48633270453;34890.82554587211;34947;34949.30101398009;34991.65008349986;34141.658583413846;34516.65483345235;34520;34631.82684086564;34682.82658586691;38171.42742858915;38435.42346864855;38608;38632;38637.42043869288;32911;33075.66924330726;33170.5024424629;33179.17052073718;33462.330753385286;24821.379465513506;24907.83571278728;25051.87474062618;25133;25173.24480265595 18:10:00 INFO - PID 4772 | |2;jquery.html;566.7789562070793;576.1012820000799;577.6274303074514;578.4042436290621;602.6143268308283;22998.19506317277;23258.88370558149;23786.405339866513;23826.404339891513;23840.76159238407;27900.16299511018;28736.712632873667;28770;28781.56827647587;28803.423931521356;7109.6089715065655;7310.707571697126;7315.231900650435;7315.5244909081;7320.707171713125;6615;7086;7112.4665650076195;7152.570845749246;7221.205667376585;7074.434045276391;7079.256678048808;7100.183478899915;7105.32499412555;7108.147022357324;7081.822954426129;7103.325184107502;7103.396211322044;7113.075300210965;7114.18186908507;6896.20693620235;6918.757843475454;6936.167659880796;6947.583145011265;6958.79123626292;31429.05712828596;31659.20851978696;31913.202169945704;32159.83920080408;32219.6778032219;1978.782333943265;2021.5956808638332;2022.1608032666427;2024.4533975826444;2025.8480613953866;20810.27164049251;21618.459538511506;21633.891830540746;21633.891830540902;21639;2538.657281267024;2541.3900663840545;2641.4849104424643;2645.1667724666668;2654.8539830309323;129682;135305.323473382;135856;135915;136528.31735841357;19420.514487137934;20999.790002099784;22205.891909996702;22315.888420557792;23161.884190578938;23124.65313020306;24481.38796530101;24500.509989800103;44558.77720611376;44634.55365446304;10327.948360258151;10414.947925260476;10527.105196058421;10537.051665350155;10654.307470014424;9526.285528585384;9603.03969603048;9618.711438656852;9682.75793105178;9685.70942871715;9282.164605185566;9424.246060315158;9474;9577;9737.659181928599;2780.8309518575543;2793.3156376687843;2801.4117035422382;2851.957220641692;2962.4371369439737;959.7168835193635;979.1090108001684;992.8212921674024;993.3642468819961;998.3909815012836;19766.209351625774;19843.801561984485;20378.69431958522;24350.512989740106;26018.479630407284;1030.8866024737272;1050.8003479338902;1051.1380667852288;1058.8358804385332;1074.4198133008244;11351.60269390584;11391.373474458818;11482.885171148182;11501.194916355775;11526.193166478266;523566;528518;528913;539987;540677;118108;118175.40912295383;120098;120375;120745;1279.7312564361403;1299.1620404838825;1334.126147373472;1335.6527302901509;1335.7194989052214;18502;18611.90694046521;18697.06514674288;21233.256836011282;22626.321210363716;60309.39690603213;60343.39656603378;60345.698271508365;61248.38751612427;63008;70753;70923;71013.28986710274;72099.63950180216;72325.6383718078;14657.48698795537;14860.62848428798;14896;14907.627309317353;15008.47470338533;23424.6486302709;23979;24058.759412405652;24470.75529244756;24674.259772206864;18419.171137299123;18637.161327740014;18675.813241867952;18680.159392827627;18712.625747485246;16886.493405197863;17250.482485525456;17363.47909562715;17762.46712598624;17768.200430980894;19317.61364772725;19332.613347732684;19541.31605393861;19695.80304196997;19716;14848.777268340767;14881.627959301104;14906.776398353817;14955.775663365275;14973.850261497246;18621.627567448304;18783.530411739815;18856.52858678544;18906.14922328526;18976.335828246498 18:10:00 INFO - PID 4772 | |3;mootools.html;1313.2973858985442;1321.4383886848093;1321.5176460591888;1325.9270740109303;1337.9464821407144;14069.507567235149;14694.926525367386;14744.926275368609;14756.188409637465;14775.556733298004;12785.680357991056;13070.73858522829;13839.30803459828;13858.168509889414;13865.168089914612;2694.8383097014143;2731.4400547887735;2734.3300891281665;2735.9042433514833;2743.670759508862;2626.3828000419885;2644.219955113246;2694.582339737334;2695.989004123454;2818.2249881282605;2760.806743527954;2781.0961437532783;2784.1230012546084;2784.192584150594;2790.7069757675354;2668.5997100434897;2682.5037368086964;2695.908157196339;2697.109953715289;2699.136276391546;2681.9865900670566;2682.7719643830296;2706.3640044589506;2729.0448343079765;2732.8496932668695;14319.85680143206;14452.566423007327;14475.78286325706;14479.203643799587;14484.34820433083;7680.155182929873;7887.802804929923;7917.406194535433;7919.406044546625;7924.9301344318355;5180.171172612401;5316.069687804657;5455.672659640394;5490.450954904518;5491.341039075336;1875.287390791504;1896.5163883209832;1920.4142736465371;1967.4294454608146;1972.2111155537757;24199.637005444933;24461.87769061161;24506.754932450625;24529.63205551918;24609.26172214854;6689.1972963244725;6712.731490740316;6726.764563240263;6836.897446538306;6885.690143943534;16359;16418.83581164197;16542.172891355625;16578.917105414395;16602.58493537647;7280.817979550554;7552.39580833532;7556.546607203475;7564.848703025908;7576.545407275581;6926.307369263134;6989.545679530815;7076.504644674823;7088.0785497884945;7133.464990125762;5009.34691551787;5197.714125723046;5213.765380557884;5252.737363131828;5259.789608415697;1378.5381897064394;1432.5272660022167;1503.8872084593481;1537.7847101405812;1546.6210778359373;860.2172023458747;860.2515811244133;862.0775769926245;881.0132651430439;886.8093359927647;7965.207144319364;8458.027326857367;8521.53131577769;8540.316774658013;8593.82812343762;941.580996456584;951.2342564235856;952.0764858087643;962.1052421248306;968.2039816140957;4337.392765012901;4411.316245981814;4418.867433976986;4446.133004064176;4535.954640453553;19515.219391224477;20386.388408347775;20414.08136633855;20470.897645511974;20600.793992059887;19342.452603791662;20108.296209632594;20142.093605787773;20359.592808143756;20465.48836279075;10534.631287904887;10747.946260268805;10768.56925722978;10781.083607893417;10793.406362649972;7304;8466.85697430839;8558.78603034929;8863.468191908249;8912.108789121035;17498.212580433657;17672.55818604494;17696.646067078327;17883.105844707454;17980.190891409657;17550.648987019933;17899.642007159524;17975.280988760827;18120.909395452938;18225.90887045556;13021.348932553145;13214.612465690963;13249.403776830259;13440.193588384729;13444.529441469502;12264.202826816228;13501.392437340146;13633.25017124028;13634.045616807125;13640.658983525094;9786.853197201905;9802.068803463659;9927.156191723496;10011.349262297927;10135.493225338556;10355.792884142425;10555.683329500127;10560.577576896838;10588.788224235319;10720.946395267974;9492.810143797224;9706.805863882824;9760.511974401394;9763.365381250196;9798;7365.079365079365;7446.553206807609;7461.626918653937;7462.701491940479;7463.029806125386;7372.520786148883;7447.180810110992;7468.290512401313;7525.096988361432;7542.811429714301 18:10:00 INFO - PID 4772 | |4;prototype.html;507.78419171851954;508.605830481377;527.4751622135975;528.6378830501108;534.2493796216318;6249.31257561669;6276.435120839124;6278.654673992928;6314.431701146896;6334.841628959279;6218.502519798417;6267.623942563449;6294.6223226606435;6295.401936816007;6320.589161704486;5184.248283998809;5195.688258704471;5197.532222100011;5212.739363031852;5228.032813929416;4838.709677419349;5164.664296820713;5165.586753059765;5185;5212.5308722214995;4909.484504127051;4928.23612340086;4959.553640172402;4972.080165169437;4977.427595826472;4920.434150072734;4970.776315065831;4999.8500044998345;5030.937315700545;5052.595792336604;4474.7091439056685;4511.939694171867;4673.299005149255;4787.6648634595595;4892.559669629715;6037.577369584087;6052.909206361864;6105.938940610581;6153.4154255345675;6216.844578885519;6005.969970150165;6043.335233124353;6049.153118563405;6069.332373438918;6129.049997250433;6680.298568650271;6721.462283017347;6734.191896972346;6773.288804675537;6831.521793474459;5346.518813306821;5365.141577347645;5367.677939323614;5399.785048364126;5434.701091439969;6736.360045795691;6769.356911093439;6785.9660701696175;6896.965515172392;6934.353982831515;5494.972525137428;5506.201600767866;5541;5558.916616250759;5560.026995275811;5543.695096769636;5607.859803504945;5635.520980716603;5639.154126881001;5654.773809047674;6028.457438830438;6043.184170136975;6059.39446038199;6062.211912451353;6071.635701857903;6712.228093769181;6732.360425759545;6733.3939945405145;6734.629595372204;6747.595144291358;1971.2410721872182;1973.2501649373146;1984.5633960528949;1986.7218589397496;1987.224982256921;1376.593904798087;1450.3111022264552;1453.1063396011589;1475.4762059468735;1475.9926200369143;5729.9713501432225;5733.541316694655;5741.110127930177;5743.9425605744245;5792.913106303409;6648.368405001614;6698.196216454056;6760.560563563353;6803.897941530881;6865.897011544831;5677.858053548612;5710.457506536873;5736.254286942671;5766.942330576724;5789.1605717171615;3655.360311945452;3659.1218107654504;3659.9634003660153;3660.682154424405;3671.908202294964;6488.410339466766;6581.656106969377;6587.63767992765;6599.208095028627;6650.900236496456;6888.622275544911;6945.2707465715375;7008.404285635676;7012.964935175393;7050.717971281194;6551.377619126175;6569.770058047945;6642.734290628321;6675.532712710161;6697.933020669731;6706.295838937037;6738.090357801634;6796.2524122347495;6815.318468153145;6886.173659160932;6637.137172167587;6647.268800432045;6724.327567243236;6757.189137303555;6792.456603471809;6527.869442611026;6600.570962887397;6609.801705948829;6620.337966203341;6658.5671931324305;5538.778448862;5561.221428999862;5570.275864137636;5578.804741834017;5607.607467477237;6509.902351464826;6746.9325306746305;6819.89770153458;6836.213835408992;6859.314068593101;6337.461315788025;6491.350864913471;6507.819880340139;6530.738770449128;6546.312637173029;6541.901871471837;6602.075709400592;6604.768833090819;6676.432503237279;6706.966465167643;6306.117143599991;6516.250631177286;6540.967295163494;6545.70544325516;6558.8360290991195;6647.534672572873;6648.5346025777735;6656.2345330287635;6705.362990515893;6710.899336509859;6314.011086507919;6355.332690067661;6412.358764123737;6417.550771445954;6476 18:10:00 INFO - PID 4772 | |5;yui.html;910.6038873090206;914.3234006834944;921.2399770189587;928.4197376639603;929.8372784762669;18539.72190417143;19290;19480.123394447266;19503.804961950376;21230.89384553079;21480.355589332306;21990.45023874404;22104.447388815286;22187.66718499224;22195.223167189153;1026.4764969865366;1049.695588279398;1057.5346847387164;1058.253930978662;1063.8829728729834;1010.5301035018715;1043.9217058720587;1044.634377967713;1050.8266136087575;1054.3884546962781;1085.9239853210279;1087.40736298717;1087.4182312462833;1088.3252383522226;1089.2266490791546;1069.7058308965059;1073.1682945717055;1078.5577913055608;1081.2755453845941;1083.56657337065;782.2685788787445;783.725696006399;790.8615992201342;791.3787676673841;794.9364050875973;19837.702434463496;19843.90078049615;20105.698414523795;20249.696254556195;20279.29022484206;21246.46883827917;21960.121595136174;22208.11167553296;22371.217007404826;22410.887945560167;17195.484135475956;17223.052732099728;17294.56763580908;17380.913095434567;17501.299948002066;3659.176685245825;3677;3681.1349332906743;3685.1155722626645;3685.981570092159;130256;130844;132056;132584.33707831494;134442.3277883614;16660.833391666172;16926.32294708198;17027.063511506738;17376;17467.47597572075;31106.377872442423;31863;31912.202194945312;32091.518627220612;32132.35735285281;7787.532748035136;8068.556229407322;8985.955070224738;8999.415038022507;9343;4387.122575484916;4466.419365482531;4468.374427580141;4472.552744725502;4494.640428765691;5148.9485105149215;5215.322008138917;5232.764525596357;5237.869053273623;5245.947540524622;1061.5010944855906;1075.295681328731;1086.9619563315246;1091.5033659684825;1094.8576685031055;700.6811900585324;710.3748701143064;713.7394850879392;715.7637979466764;736.5359823311279;12051.457684404222;12328.75342493145;12378.44297006637;12608.369581520887;12639.684007899876;686.3513979289523;689.1729924091111;700.2542292458515;714.4427346669606;715.2168375628678;5497.39528651848;5554.972225138848;5574.498295153456;5576.33084029919;5759.424057594207;111223.44388278006;113253;114998;115070;120876.3956180231;99833;102996.48501757593;103309;105853;106914.46542767236;88119.55940220386;90636.5468172655;90649.54675226714;91518.54240728621;93541.5322923381;10256.230782691178;10523.579056837641;10527.736806579896;10598.223967937338;10731.785364292826;40854.387184192856;41580.37629435621;41664;42335.153296934506;42614.5738542623;51701;51846.74076629593;51857.481425185266;52766.47233527616;54681.72659136679;15260.160691162093;15381.692366152838;15392.692146157238;15453.690926181638;16365.754513682066;18357.3574924877;18552.628947420704;18592.814071859648;18606.255749769858;18611.720824187378;16249.025058496529;16325.83674163243;16335.10156941332;16377.508674739776;16417.91791041037;17986.91006544959;18167.909160454114;18196;18221.088945552405;18375.63248734991;16742.1628918556;17128.143592820557;17182.484525464257;18906.52733681669;19487.51281217924;13611.931940340235;13671.589852304447;13979.650508737363;14019.937203300717;14520.63698407506;14780.852191477947;15267.160306183267;15435.69128617399;15660.530184094496;15744.212789360716 18:10:00 INFO - PID 4772 | __end_tp_report 18:10:00 INFO - PID 4772 | __start_cc_report 18:10:00 INFO - PID 4772 | _x_x_mozilla_cycle_collect,352 18:10:00 INFO - PID 4772 | __end_cc_report 18:10:00 INFO - PID 4772 | __startTimestamp1502932200946__endTimestamp 18:10:00 INFO - PID 4772 | 18:10:00 INFO - PID 4772 | ------- Summary: start ------- 18:10:00 INFO - PID 4772 | Number of tests: 6 18:10:00 INFO - PID 4772 | 18:10:00 INFO - PID 4772 | [#0] dojo.html Cycles:165 Average:6192.82 Median:6415.42 stddev:731.40 (11.4%) stddev-sans-first:693.79 18:10:00 INFO - PID 4772 | Values: 3157.3 3199.3 3204.4 3217.8 3218.4 6187.1 6253.6 6279.9 6311.1 6316.7 6146.1 6262.6 6271.0 6279.3 6288.6 5723.1 5743.7 5765.7 5768.3 5834.2 5745.8 5748.9 5822.5 5837.1 5843.7 5634.5 5786.9 5794.4 5835.2 5866.0 5699.2 5707.2 5736.7 5795.6 5805.8 5672.8 5707.5 5744.5 5764.7 5776.7 6052.5 6127.1 6148.5 6172.7 6240.3 6666.2 6674.9 6728.4 6766.8 6779.8 6841.6 6867.1 6870.4 6913.3 6915.8 6279.1 6292.7 6351.1 6368.0 6384.3 6858.0 6979.2 7034.3 7039.8 7040.2 6547.3 6548.8 6631.1 6659.4 6665.2 6714.0 6800.5 6810.5 6819.6 6844.3 6614.4 6725.0 6735.8 6811.4 6812.1 6622.8 6655.1 6730.9 6741.5 6819.9 5441.7 5462.6 5463.6 5473.3 5474.9 4656.9 4667.5 4668.6 4673.8 4708.1 5744.2 5755.6 5757.7 5828.8 5838.8 6595.3 6690.3 6726.4 6739.2 6836.4 5721.1 5729.2 5735.9 5747.2 5748.7 5889.7 5892.2 5893.9 5897.3 5903.6 6406.7 6562.0 6563.4 6564.9 6567.7 6792.6 6806.2 6812.1 6825.1 6861.4 6463.1 6479.7 6539.1 6567.2 6571.2 6429.4 6594.8 6613.1 6717.9 6718.8 6502.1 6564.2 6566.9 6581.6 6679.4 6523.3 6523.7 6544.7 6545.0 6559.2 6415.4 6513.5 6596.5 6598.4 6605.0 6398.8 6403.4 6405.2 6407.7 6415.6 6543.2 6560.7 6579.9 6716.4 6728.1 6263.6 6391.9 6467.5 6468.5 6471.8 18:10:00 INFO - PID 4772 | 18:10:00 INFO - PID 4772 | [#1] ext.html Cycles:180 Average:37660.89 Median:3543.83 stddev:52466.39 (1480.5%) stddev-sans-first:52540.70 18:10:00 INFO - PID 4772 | Values: 834.7 854.2 1145.2 1197.9 1245.1 36958.8 41041.8 41273.4 41287.6 41288.2 39292.2 39608.4 39619.2 39740.0 39751.0 7125.9 7328.0 7550.3 7683.6 7692.2 7617.4 7735.0 7736.7 7740.0 7743.2 7682.1 7725.8 7736.4 7742.6 7744.9 7708.5 7726.2 7756.5 7758.7 7762.8 7642.8 7706.3 7712.9 7715.3 7720.3 39857.2 40011.0 40253.2 40268.4 40315.2 3532.2 3555.5 3557.1 3572.1 3577.5 31452.2 31489.8 31543.7 31618.7 31695.8 4914.3 5101.7 5159.6 5165.1 5169.3 185851.0 186802.0 186960.0 188857.0 188990.0 43294.6 44264.3 49976.0 50166.5 50376.7 49589.0 50317.7 50366.0 50450.7 50480.7 16360.5 16386.5 16400.4 16484.8 16487.5 13504.5 13519.8 13557.5 13588.5 13589.0 13289.2 13356.5 13363.0 13372.3 13529.1 5445.2 5470.6 5488.7 5514.5 5557.5 1004.9 1011.0 1020.1 1027.4 1031.8 23095.5 23350.2 23363.9 23380.2 23401.6 1106.1 1113.1 1123.2 1124.1 1136.4 12044.8 12363.3 12367.4 12513.7 12517.6 227853.0 232476.0 232661.0 232968.0 233129.0 54328.7 54440.0 54447.0 54465.5 54517.0 1475.8 1477.2 1505.0 1515.1 1525.9 22777.9 22805.3 22844.2 23097.7 23349.3 38080.2 38381.4 38424.8 38450.2 38458.2 183697.1 184793.0 184795.0 185778.0 185872.0 33674.8 33734.0 35592.6 37629.6 37762.6 46447.5 48486.0 48547.0 48902.5 49062.3 34244.5 34890.8 34947.0 34949.3 34991.7 34141.7 34516.7 34520.0 34631.8 34682.8 38171.4 38435.4 38608.0 38632.0 38637.4 32911.0 33075.7 33170.5 33179.2 33462.3 24821.4 24907.8 25051.9 25133.0 25173.2 18:10:00 INFO - PID 4772 | 18:10:00 INFO - PID 4772 | [#2] jquery.html Cycles:180 Average:37125.35 Median:24018.88 stddev:88991.96 (370.5%) stddev-sans-first:89199.27 18:10:00 INFO - PID 4772 | Values: 566.8 576.1 577.6 578.4 602.6 22998.2 23258.9 23786.4 23826.4 23840.8 27900.2 28736.7 28770.0 28781.6 28803.4 7109.6 7310.7 7315.2 7315.5 7320.7 6615.0 7086.0 7112.5 7152.6 7221.2 7074.4 7079.3 7100.2 7105.3 7108.1 7081.8 7103.3 7103.4 7113.1 7114.2 6896.2 6918.8 6936.2 6947.6 6958.8 31429.1 31659.2 31913.2 32159.8 32219.7 1978.8 2021.6 2022.2 2024.5 2025.8 20810.3 21618.5 21633.9 21633.9 21639.0 2538.7 2541.4 2641.5 2645.2 2654.9 129682.0 135305.3 135856.0 135915.0 136528.3 19420.5 20999.8 22205.9 22315.9 23161.9 23124.7 24481.4 24500.5 44558.8 44634.6 10327.9 10414.9 10527.1 10537.1 10654.3 9526.3 9603.0 9618.7 9682.8 9685.7 9282.2 9424.2 9474.0 9577.0 9737.7 2780.8 2793.3 2801.4 2852.0 2962.4 959.7 979.1 992.8 993.4 998.4 19766.2 19843.8 20378.7 24350.5 26018.5 1030.9 1050.8 1051.1 1058.8 1074.4 11351.6 11391.4 11482.9 11501.2 11526.2 523566.0 528518.0 528913.0 539987.0 540677.0 118108.0 118175.4 120098.0 120375.0 120745.0 1279.7 1299.2 1334.1 1335.7 1335.7 18502.0 18611.9 18697.1 21233.3 22626.3 60309.4 60343.4 60345.7 61248.4 63008.0 70753.0 70923.0 71013.3 72099.6 72325.6 14657.5 14860.6 14896.0 14907.6 15008.5 23424.6 23979.0 24058.8 24470.8 24674.3 18419.2 18637.2 18675.8 18680.2 18712.6 16886.5 17250.5 17363.5 17762.5 17768.2 19317.6 19332.6 19541.3 19695.8 19716.0 14848.8 14881.6 14906.8 14955.8 14973.9 18621.6 18783.5 18856.5 18906.1 18976.3 18:10:00 INFO - PID 4772 | 18:10:00 INFO - PID 4772 | [#3] mootools.html Cycles:180 Average:8977.11 Median:2695.95 stddev:6227.35 (231.0%) stddev-sans-first:6218.20 18:10:00 INFO - PID 4772 | Values: 1313.3 1321.4 1321.5 1325.9 1337.9 14069.5 14694.9 14744.9 14756.2 14775.6 12785.7 13070.7 13839.3 13858.2 13865.2 2694.8 2731.4 2734.3 2735.9 2743.7 2626.4 2644.2 2694.6 2696.0 2818.2 2760.8 2781.1 2784.1 2784.2 2790.7 2668.6 2682.5 2695.9 2697.1 2699.1 2682.0 2682.8 2706.4 2729.0 2732.8 14319.9 14452.6 14475.8 14479.2 14484.3 7680.2 7887.8 7917.4 7919.4 7924.9 5180.2 5316.1 5455.7 5490.5 5491.3 1875.3 1896.5 1920.4 1967.4 1972.2 24199.6 24461.9 24506.8 24529.6 24609.3 6689.2 6712.7 6726.8 6836.9 6885.7 16359.0 16418.8 16542.2 16578.9 16602.6 7280.8 7552.4 7556.5 7564.8 7576.5 6926.3 6989.5 7076.5 7088.1 7133.5 5009.3 5197.7 5213.8 5252.7 5259.8 1378.5 1432.5 1503.9 1537.8 1546.6 860.2 860.3 862.1 881.0 886.8 7965.2 8458.0 8521.5 8540.3 8593.8 941.6 951.2 952.1 962.1 968.2 4337.4 4411.3 4418.9 4446.1 4536.0 19515.2 20386.4 20414.1 20470.9 20600.8 19342.5 20108.3 20142.1 20359.6 20465.5 10534.6 10747.9 10768.6 10781.1 10793.4 7304.0 8466.9 8558.8 8863.5 8912.1 17498.2 17672.6 17696.6 17883.1 17980.2 17550.6 17899.6 17975.3 18120.9 18225.9 13021.3 13214.6 13249.4 13440.2 13444.5 12264.2 13501.4 13633.3 13634.0 13640.7 9786.9 9802.1 9927.2 10011.3 10135.5 10355.8 10555.7 10560.6 10588.8 10720.9 9492.8 9706.8 9760.5 9763.4 9798.0 7365.1 7446.6 7461.6 7462.7 7463.0 7372.5 7447.2 7468.3 7525.1 7542.8 18:10:00 INFO - PID 4772 | 18:10:00 INFO - PID 4772 | [#4] prototype.html Cycles:180 Average:5658.38 Median:6233.91 stddev:1517.54 (24.3%) stddev-sans-first:1471.74 18:10:00 INFO - PID 4772 | Values: 507.8 508.6 527.5 528.6 534.2 6249.3 6276.4 6278.7 6314.4 6334.8 6218.5 6267.6 6294.6 6295.4 6320.6 5184.2 5195.7 5197.5 5212.7 5228.0 4838.7 5164.7 5165.6 5185.0 5212.5 4909.5 4928.2 4959.6 4972.1 4977.4 4920.4 4970.8 4999.9 5030.9 5052.6 4474.7 4511.9 4673.3 4787.7 4892.6 6037.6 6052.9 6105.9 6153.4 6216.8 6006.0 6043.3 6049.2 6069.3 6129.0 6680.3 6721.5 6734.2 6773.3 6831.5 5346.5 5365.1 5367.7 5399.8 5434.7 6736.4 6769.4 6786.0 6897.0 6934.4 5495.0 5506.2 5541.0 5558.9 5560.0 5543.7 5607.9 5635.5 5639.2 5654.8 6028.5 6043.2 6059.4 6062.2 6071.6 6712.2 6732.4 6733.4 6734.6 6747.6 1971.2 1973.3 1984.6 1986.7 1987.2 1376.6 1450.3 1453.1 1475.5 1476.0 5730.0 5733.5 5741.1 5743.9 5792.9 6648.4 6698.2 6760.6 6803.9 6865.9 5677.9 5710.5 5736.3 5766.9 5789.2 3655.4 3659.1 3660.0 3660.7 3671.9 6488.4 6581.7 6587.6 6599.2 6650.9 6888.6 6945.3 7008.4 7013.0 7050.7 6551.4 6569.8 6642.7 6675.5 6697.9 6706.3 6738.1 6796.3 6815.3 6886.2 6637.1 6647.3 6724.3 6757.2 6792.5 6527.9 6600.6 6609.8 6620.3 6658.6 5538.8 5561.2 5570.3 5578.8 5607.6 6509.9 6746.9 6819.9 6836.2 6859.3 6337.5 6491.4 6507.8 6530.7 6546.3 6541.9 6602.1 6604.8 6676.4 6707.0 6306.1 6516.3 6541.0 6545.7 6558.8 6647.5 6648.5 6656.2 6705.4 6710.9 6314.0 6355.3 6412.4 6417.6 6476.0 18:10:00 INFO - PID 4772 | 18:10:00 INFO - PID 4772 | [#5] yui.html Cycles:180 Average:23915.52 Median:18599.53 stddev:33172.22 (178.3%) stddev-sans-first:33220.30 18:10:00 INFO - PID 4772 | Values: 910.6 914.3 921.2 928.4 929.8 18539.7 19290.0 19480.1 19503.8 21230.9 21480.4 21990.5 22104.4 22187.7 22195.2 1026.5 1049.7 1057.5 1058.3 1063.9 1010.5 1043.9 1044.6 1050.8 1054.4 1085.9 1087.4 1087.4 1088.3 1089.2 1069.7 1073.2 1078.6 1081.3 1083.6 782.3 783.7 790.9 791.4 794.9 19837.7 19843.9 20105.7 20249.7 20279.3 21246.5 21960.1 22208.1 22371.2 22410.9 17195.5 17223.1 17294.6 17380.9 17501.3 3659.2 3677.0 3681.1 3685.1 3686.0 130256.0 130844.0 132056.0 132584.3 134442.3 16660.8 16926.3 17027.1 17376.0 17467.5 31106.4 31863.0 31912.2 32091.5 32132.4 7787.5 8068.6 8986.0 8999.4 9343.0 4387.1 4466.4 4468.4 4472.6 4494.6 5148.9 5215.3 5232.8 5237.9 5245.9 1061.5 1075.3 1087.0 1091.5 1094.9 700.7 710.4 713.7 715.8 736.5 12051.5 12328.8 12378.4 12608.4 12639.7 686.4 689.2 700.3 714.4 715.2 5497.4 5555.0 5574.5 5576.3 5759.4 111223.4 113253.0 114998.0 115070.0 120876.4 99833.0 102996.5 103309.0 105853.0 106914.5 88119.6 90636.5 90649.5 91518.5 93541.5 10256.2 10523.6 10527.7 10598.2 10731.8 40854.4 41580.4 41664.0 42335.2 42614.6 51701.0 51846.7 51857.5 52766.5 54681.7 15260.2 15381.7 15392.7 15453.7 16365.8 18357.4 18552.6 18592.8 18606.3 18611.7 16249.0 16325.8 16335.1 16377.5 16417.9 17986.9 18167.9 18196.0 18221.1 18375.6 16742.2 17128.1 17182.5 18906.5 19487.5 13611.9 13671.6 13979.7 14019.9 14520.6 14780.9 15267.2 15435.7 15660.5 15744.2 18:10:00 INFO - PID 4772 | -------- Summary: end -------- 18:10:00 INFO - PID 4772 | 18:10:01 INFO - TEST-INFO | 4772: exit 0 18:10:01 INFO - TEST-OK | dromaeo_css | took 1110976ms 18:10:01 INFO - TEST-START | kraken 18:10:01 INFO - Initialising browser for kraken test... 18:10:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58693/getInfo.html -profile /tmp/tmpXShtWP/profile 18:10:01 INFO - TEST-INFO | started process 5150 (/builds/slave/test/build/application/firefox/firefox http://localhost:58693/getInfo.html) 18:10:07 INFO - TEST-INFO | 5150: exit 0 18:10:07 INFO - Browser initialized. 18:10:07 INFO - Running cycle 1/1 for kraken test... 18:10:07 INFO - TEST-INFO | started process 5344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXShtWP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:10:08 INFO - PID 5344 | 18:10:08 INFO - PID 5344 | (/builds/slave/test/build/application/firefox/firefox:5398): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:10:08 INFO - PID 5344 | 18:10:18 INFO - PID 5344 | RSS: Main: 167124992 18:10:18 INFO - PID 5344 | 18:10:21 INFO - PID 5344 | Cycle 1(1): loaded http://localhost:58693/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58693/tests/kraken/driver.html?testName=audio-beat-detection) 18:10:22 INFO - PID 5344 | RSS: Main: 173203456 18:10:22 INFO - PID 5344 | 18:10:24 INFO - PID 5344 | Cycle 1(1): loaded http://localhost:58693/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58693/tests/kraken/driver.html?testName=audio-dft) 18:10:25 INFO - PID 5344 | RSS: Main: 177516544 18:10:25 INFO - PID 5344 | 18:10:28 INFO - PID 5344 | Cycle 1(1): loaded http://localhost:58693/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58693/tests/kraken/driver.html?testName=audio-fft) 18:10:29 INFO - PID 5344 | RSS: Main: 171249664 18:10:29 INFO - PID 5344 | 18:10:31 INFO - PID 5344 | Cycle 1(1): loaded http://localhost:58693/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58693/tests/kraken/driver.html?testName=audio-oscillator) 18:10:31 INFO - PID 5344 | RSS: Main: 171700224 18:10:31 INFO - PID 5344 | 18:10:34 INFO - PID 5344 | Cycle 1(1): loaded http://localhost:58693/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58693/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:10:34 INFO - PID 5344 | RSS: Main: 171421696 18:10:34 INFO - PID 5344 | 18:10:37 INFO - PID 5344 | Cycle 1(1): loaded http://localhost:58693/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58693/tests/kraken/driver.html?testName=imaging-darkroom) 18:10:38 INFO - PID 5344 | RSS: Main: 173043712 18:10:38 INFO - PID 5344 | 18:10:42 INFO - PID 5344 | Cycle 1(1): loaded http://localhost:58693/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58693/tests/kraken/driver.html?testName=imaging-desaturate) 18:10:42 INFO - PID 5344 | RSS: Main: 172834816 18:10:42 INFO - PID 5344 | 18:10:45 INFO - PID 5344 | Cycle 1(1): loaded http://localhost:58693/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58693/tests/kraken/driver.html?testName=json-parse-financial) 18:10:46 INFO - PID 5344 | RSS: Main: 173473792 18:10:46 INFO - PID 5344 | 18:10:47 INFO - PID 5344 | Cycle 1(1): loaded http://localhost:58693/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58693/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:10:48 INFO - PID 5344 | RSS: Main: 173584384 18:10:48 INFO - PID 5344 | 18:10:50 INFO - PID 5344 | Cycle 1(1): loaded http://localhost:58693/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58693/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:10:51 INFO - PID 5344 | RSS: Main: 173494272 18:10:51 INFO - PID 5344 | 18:10:53 INFO - PID 5344 | Cycle 1(1): loaded http://localhost:58693/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58693/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:10:53 INFO - PID 5344 | RSS: Main: 173600768 18:10:53 INFO - PID 5344 | 18:10:56 INFO - PID 5344 | Cycle 1(1): loaded http://localhost:58693/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58693/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:10:57 INFO - PID 5344 | RSS: Main: 173547520 18:10:57 INFO - PID 5344 | 18:11:00 INFO - PID 5344 | Cycle 1(1): loaded http://localhost:58693/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58693/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:11:01 INFO - PID 5344 | RSS: Main: 173731840 18:11:01 INFO - PID 5344 | 18:11:02 INFO - PID 5344 | Cycle 1(1): loaded http://localhost:58693/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58693/tests/kraken/driver.html?testName=ai-astar) 18:11:03 INFO - PID 5344 | RSS: Main: 175099904 18:11:03 INFO - PID 5344 | 18:11:03 INFO - PID 5344 | __start_tp_report 18:11:03 INFO - PID 5344 | _x_x_mozilla_page_load 18:11:03 INFO - PID 5344 | _x_x_mozilla_page_load_details 18:11:03 INFO - PID 5344 | |i|pagename|runs| 18:11:03 INFO - PID 5344 | |0;ai-astar;100;115;101;106;112;108;109;101;113;106 18:11:03 INFO - PID 5344 | |1;audio-beat-detection;145;117;155;179;122;149;150;119;174;120 18:11:03 INFO - PID 5344 | |2;audio-dft;164;165;163;163;163;166;164;170;162;165 18:11:03 INFO - PID 5344 | |3;audio-fft;76;75;77;175;75;76;78;76;171;75 18:11:03 INFO - PID 5344 | |4;audio-oscillator;79;86;139;78;79;78;130;80;78;126 18:11:03 INFO - PID 5344 | |5;imaging-gaussian-blur;122;115;114;114;114;117;114;114;119;118 18:11:03 INFO - PID 5344 | |6;imaging-darkroom;150;152;154;151;151;153;151;151;150;155 18:11:03 INFO - PID 5344 | |7;imaging-desaturate;96;95;99;98;93;94;95;94;94;97 18:11:03 INFO - PID 5344 | |8;json-parse-financial;55;55;53;52;53;61;54;58;54;63 18:11:03 INFO - PID 5344 | |9;json-stringify-tinderbox;55;53;54;54;66;58;57;53;54;53 18:11:03 INFO - PID 5344 | |10;stanford-crypto-aes;83;77;76;78;77;77;76;82;76;79 18:11:03 INFO - PID 5344 | |11;stanford-crypto-ccm;132;121;123;127;129;124;119;121;122;177 18:11:03 INFO - PID 5344 | |12;stanford-crypto-pbkdf2;176;172;174;175;174;178;183;186;172;178 18:11:03 INFO - PID 5344 | |13;stanford-crypto-sha256-iterative;67;71;71;66;73;66;66;68;70;80 18:11:03 INFO - PID 5344 | __end_tp_report 18:11:03 INFO - PID 5344 | __start_cc_report 18:11:03 INFO - PID 5344 | _x_x_mozilla_cycle_collect,922 18:11:03 INFO - PID 5344 | __end_cc_report 18:11:03 INFO - PID 5344 | __startTimestamp1502932263079__endTimestamp 18:11:03 INFO - PID 5344 | 18:11:03 INFO - PID 5344 | ------- Summary: start ------- 18:11:03 INFO - PID 5344 | Number of tests: 14 18:11:03 INFO - PID 5344 | 18:11:03 INFO - PID 5344 | [#0] ai-astar Cycles:10 Average:107.10 Median:108.50 stddev:5.30 (4.9%) stddev-sans-first:4.96 18:11:03 INFO - PID 5344 | Values: 100.0 115.0 101.0 106.0 112.0 108.0 109.0 101.0 113.0 106.0 18:11:03 INFO - PID 5344 | 18:11:03 INFO - PID 5344 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:149.50 stddev:22.88 (15.3%) stddev-sans-first:24.26 18:11:03 INFO - PID 5344 | Values: 145.0 117.0 155.0 179.0 122.0 149.0 150.0 119.0 174.0 120.0 18:11:03 INFO - PID 5344 | 18:11:03 INFO - PID 5344 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:2.27 (1.4%) stddev-sans-first:2.40 18:11:03 INFO - PID 5344 | Values: 164.0 165.0 163.0 163.0 163.0 166.0 164.0 170.0 162.0 165.0 18:11:03 INFO - PID 5344 | 18:11:03 INFO - PID 5344 | [#3] audio-fft Cycles:10 Average:95.40 Median:76.00 stddev:40.92 (53.8%) stddev-sans-first:42.80 18:11:03 INFO - PID 5344 | Values: 76.0 75.0 77.0 175.0 75.0 76.0 78.0 76.0 171.0 75.0 18:11:03 INFO - PID 5344 | 18:11:03 INFO - PID 5344 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:78.50 stddev:25.40 (32.4%) stddev-sans-first:26.25 18:11:03 INFO - PID 5344 | Values: 79.0 86.0 139.0 78.0 79.0 78.0 130.0 80.0 78.0 126.0 18:11:03 INFO - PID 5344 | 18:11:03 INFO - PID 5344 | [#5] imaging-gaussian-blur Cycles:10 Average:116.10 Median:116.00 stddev:2.81 (2.4%) stddev-sans-first:2.01 18:11:03 INFO - PID 5344 | Values: 122.0 115.0 114.0 114.0 114.0 117.0 114.0 114.0 119.0 118.0 18:11:03 INFO - PID 5344 | 18:11:03 INFO - PID 5344 | [#6] imaging-darkroom Cycles:10 Average:151.80 Median:151.50 stddev:1.69 (1.1%) stddev-sans-first:1.66 18:11:03 INFO - PID 5344 | Values: 150.0 152.0 154.0 151.0 151.0 153.0 151.0 151.0 150.0 155.0 18:11:03 INFO - PID 5344 | 18:11:03 INFO - PID 5344 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.50 stddev:1.96 (2.1%) stddev-sans-first:2.07 18:11:03 INFO - PID 5344 | Values: 96.0 95.0 99.0 98.0 93.0 94.0 95.0 94.0 94.0 97.0 18:11:03 INFO - PID 5344 | 18:11:03 INFO - PID 5344 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.00 stddev:3.68 (6.7%) stddev-sans-first:3.89 18:11:03 INFO - PID 5344 | Values: 55.0 55.0 53.0 52.0 53.0 61.0 54.0 58.0 54.0 63.0 18:11:03 INFO - PID 5344 | 18:11:03 INFO - PID 5344 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:54.50 stddev:4.00 (7.3%) stddev-sans-first:4.24 18:11:03 INFO - PID 5344 | Values: 55.0 53.0 54.0 54.0 66.0 58.0 57.0 53.0 54.0 53.0 18:11:03 INFO - PID 5344 | 18:11:03 INFO - PID 5344 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:77.50 stddev:2.51 (3.2%) stddev-sans-first:1.94 18:11:03 INFO - PID 5344 | Values: 83.0 77.0 76.0 78.0 77.0 77.0 76.0 82.0 76.0 79.0 18:11:03 INFO - PID 5344 | 18:11:03 INFO - PID 5344 | [#11] stanford-crypto-ccm Cycles:10 Average:129.50 Median:125.50 stddev:17.17 (13.7%) stddev-sans-first:18.19 18:11:03 INFO - PID 5344 | Values: 132.0 121.0 123.0 127.0 129.0 124.0 119.0 121.0 122.0 177.0 18:11:03 INFO - PID 5344 | 18:11:03 INFO - PID 5344 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:177.00 stddev:4.61 (2.6%) stddev-sans-first:4.88 18:11:03 INFO - PID 5344 | Values: 176.0 172.0 174.0 175.0 174.0 178.0 183.0 186.0 172.0 178.0 18:11:03 INFO - PID 5344 | 18:11:03 INFO - PID 5344 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.50 stddev:4.37 (6.2%) stddev-sans-first:4.51 18:11:03 INFO - PID 5344 | Values: 67.0 71.0 71.0 66.0 73.0 66.0 66.0 68.0 70.0 80.0 18:11:03 INFO - PID 5344 | -------- Summary: end -------- 18:11:03 INFO - PID 5344 | 18:11:03 INFO - PID 5344 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:11:03 INFO - TEST-INFO | 5344: exit 0 18:11:03 INFO - TEST-OK | kraken | took 62182ms 18:11:03 INFO - SUITE-END | took 1173s 18:11:04 INFO - Completed test suite (00:19:33) 18:11:04 INFO - javascript benchmark 18:11:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8687.137690606363, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3157.289609837787, 3199.296154845934, 3204.4392231359516, 3217.8230197339135, 3218.388506183825, 6187.102870083835, 6253.624782513052, 6279.937200627993, 6311.053341998697, 6316.684165791704, 6146.078088286759, 6262.561620686553, 6271.027990661443, 6279.277883043452, 6288.559800813945, 5723.141528770676, 5743.741531631076, 5765.711714414283, 5768.307803063638, 5834.241548598677, 5745.770169193227, 5748.942510574903, 5822.534197264209, 5837.09525023622, 5843.678597677147, 5634.521065709419, 5786.884262314772, 5794.449527294901, 5835.183074369592, 5865.970670146643, 5699.173619825102, 5707.172459993278, 5736.684482353469, 5795.565332600029, 5805.796797112123, 5672.773089076432, 5707.5148612368, 5744.540436765049, 5764.682942438164, 5776.682282474462, 6052.485538729214, 6127.111568822495, 6148.477379422754, 6172.69136543171, 6240.344763799781, 6666.233383160901, 6674.866502669968, 6728.39444449997, 6766.796996090076, 6779.762708305186, 6841.555298905605, 6867.141607299088, 6870.381665650116, 6913.274106218875, 6915.757948471779, 6279.120923070774, 6292.685365731741, 6351.142595749607, 6367.968160159216, 6384.329645387167, 6857.965710171417, 6979.1973922999505, 7034.296570343027, 7039.788806335818, 7040.155181378165, 6547.312532184147, 6548.8035358939305, 6631.1379520662, 6659.4006539411685, 6665.233498147678, 6714.026466162477, 6800.489963252776, 6810.455163586901, 6819.5908245505425, 6844.28135045823, 6614.404703576605, 6725.024871393718, 6735.764248251287, 6811.421029212573, 6812.1144251248015, 6622.801315960529, 6655.0682904393425, 6730.899036514456, 6741.494387920926, 6819.863602728017, 5441.673499589958, 5462.590305727086, 5463.562914966793, 5473.31583552056, 5474.945250547523, 4656.930146047812, 4667.533246675373, 4668.603168730628, 4673.836415725434, 4708.105459962665, 5744.167095771173, 5755.625884317506, 5757.712114394348, 5828.79599214034, 5838.795642152504, 6595.307492713292, 6690.29751876046, 6726.428253598401, 6739.224989126215, 6836.418904393083, 5721.084626459747, 5729.197912292282, 5735.8852822944145, 5747.166660834239, 5748.683822389725, 5889.705514724246, 5892.234009578813, 5893.852653683606, 5897.292324921037, 5903.616264942765, 6406.743730250831, 6561.967190164114, 6563.409293163638, 6564.934350656527, 6567.704453299613, 6792.626405547742, 6806.217285012287, 6812.1144251248015, 6825.1127353443735, 6861.416779573792, 6463.127477790438, 6479.7408103675325, 6539.051837483634, 6567.211934567882, 6571.178602674666, 6429.421352078335, 6594.769183078569, 6613.074169616354, 6717.899231511629, 6718.764843230463, 6502.122213501117, 6564.245111812012, 6566.9014964774615, 6581.638009909501, 6679.432248258952, 6523.347665233438, 6523.67381630907, 6544.705488253136, 6545.0, 6559.180102487189, 6415.422611964946, 6513.511486638616, 6596.472282217507, 6598.439132673777, 6605.0, 6398.776042838478, 6403.359664033559, 6405.167328247298, 6407.711652975534, 6415.550911436155, 6543.247526534509, 6560.671966401756, 6579.901301480578, 6716.361945615159, 6728.125343705483, 6263.62418254888, 6391.904121438275, 6467.482601391784, 6468.482521398371, 6471.805845824632], "value": 6138.2529973071405, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [834.7078522517118, 854.1586537260797, 1145.209805234388, 1197.8682344942056, 1245.1470742541355, 36958.815205923966, 41041.794791026005, 41273.38089928646, 41287.58712412875, 41288.17423651529, 39292.214155716865, 39608.405873911914, 39619.20761584766, 39740.0, 39751.0, 7125.928740712604, 7328.0, 7550.320471157622, 7683.57740324282, 7692.153863075086, 7617.390608751314, 7734.961325193366, 7736.729214477495, 7739.9613001935195, 7743.18696536864, 7682.078150621933, 7725.768226953172, 7736.419768517356, 7742.574158421285, 7744.922550774505, 7708.460407771458, 7726.188750181206, 7756.457048006641, 7758.650860711282, 7762.844743105163, 7642.847143057108, 7706.344960678293, 7712.922870771276, 7715.305622493946, 7720.266574675396, 39857.206425710916, 40011.0, 40253.194936101114, 40268.39597406041, 40315.19369612591, 3532.152283451953, 3555.5022296878456, 3557.0929412999776, 3572.07126147201, 3577.5170352002665, 31452.21369465759, 31489.8425507871, 31543.684563154304, 31618.683813161802, 31695.84152079248, 4914.262860570907, 5101.744912754384, 5159.587233021387, 5165.1219292720325, 5169.327987361657, 185851.0, 186802.0, 186960.0, 188857.0, 188990.0, 43294.567054329054, 44264.3360349595, 49976.0, 50166.49833501691, 50376.74811625919, 49589.0, 50317.74841125771, 50366.0, 50450.74774626103, 50480.74759626252, 16360.509184724477, 16386.508404747878, 16400.425985090464, 16484.752728709078, 16487.505374838773, 13504.459821607026, 13519.797203041962, 13557.457701691821, 13588.524401645895, 13589.0, 13289.20264784116, 13356.5325213619, 13362.997775166707, 13372.33138343079, 13529.1206071607, 5445.237666726662, 5470.589705772083, 5488.670679759227, 5514.531264842533, 5557.472040156179, 1004.8894621591619, 1010.959561617527, 1020.0921180149672, 1027.3733022856052, 1031.7730099378125, 23095.538089238456, 23350.18274360389, 23363.883180583987, 23380.18169364064, 23401.648975265383, 1106.0764261841452, 1113.0983903038402, 1123.224974767408, 1124.1119515582598, 1136.4374634555948, 12044.75910481803, 12363.32001739913, 12367.381630918419, 12513.749725005631, 12517.56188533397, 227853.0, 232476.0, 232661.0, 232968.0, 233129.0, 54328.72835635796, 54440.0, 54447.0, 54465.45534544604, 54517.0, 1475.845036271176, 1477.18754684925, 1504.9924750376397, 1515.121229686779, 1525.9008164469496, 22777.88611056934, 22805.31584052481, 22844.200452984067, 23097.65353519665, 23349.299521014396, 38080.23839523138, 38381.424278636405, 38424.80787596044, 38450.230995379374, 38458.23083538369, 183697.08151459158, 184793.0, 184795.0, 185778.0, 185872.0, 33674.83162584171, 33734.0, 35592.64407355997, 37629.62370376261, 37762.62237377701, 46447.53552464432, 48486.0, 48547.0, 48902.51097489122, 49062.26406603975, 34244.48633270453, 34890.82554587211, 34947.0, 34949.30101398009, 34991.65008349986, 34141.658583413846, 34516.65483345235, 34520.0, 34631.82684086564, 34682.82658586691, 38171.42742858915, 38435.42346864855, 38608.0, 38632.0, 38637.42043869288, 32911.0, 33075.66924330726, 33170.5024424629, 33179.17052073718, 33462.330753385286, 24821.379465513506, 24907.83571278728, 25051.87474062618, 25133.0, 25173.24480265595], "value": 17452.985558683737, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.7789562070793, 576.1012820000799, 577.6274303074514, 578.4042436290621, 602.6143268308283, 22998.19506317277, 23258.88370558149, 23786.405339866513, 23826.404339891513, 23840.76159238407, 27900.16299511018, 28736.712632873667, 28770.0, 28781.56827647587, 28803.423931521356, 7109.6089715065655, 7310.707571697126, 7315.231900650435, 7315.5244909081, 7320.707171713125, 6615.0, 7086.0, 7112.4665650076195, 7152.570845749246, 7221.205667376585, 7074.434045276391, 7079.256678048808, 7100.183478899915, 7105.32499412555, 7108.147022357324, 7081.822954426129, 7103.325184107502, 7103.396211322044, 7113.075300210965, 7114.18186908507, 6896.20693620235, 6918.757843475454, 6936.167659880796, 6947.583145011265, 6958.79123626292, 31429.05712828596, 31659.20851978696, 31913.202169945704, 32159.83920080408, 32219.6778032219, 1978.782333943265, 2021.5956808638332, 2022.1608032666427, 2024.4533975826444, 2025.8480613953866, 20810.27164049251, 21618.459538511506, 21633.891830540746, 21633.891830540902, 21639.0, 2538.657281267024, 2541.3900663840545, 2641.4849104424643, 2645.1667724666668, 2654.8539830309323, 129682.0, 135305.323473382, 135856.0, 135915.0, 136528.31735841357, 19420.514487137934, 20999.790002099784, 22205.891909996702, 22315.888420557792, 23161.884190578938, 23124.65313020306, 24481.38796530101, 24500.509989800103, 44558.77720611376, 44634.55365446304, 10327.948360258151, 10414.947925260476, 10527.105196058421, 10537.051665350155, 10654.307470014424, 9526.285528585384, 9603.03969603048, 9618.711438656852, 9682.75793105178, 9685.70942871715, 9282.164605185566, 9424.246060315158, 9474.0, 9577.0, 9737.659181928599, 2780.8309518575543, 2793.3156376687843, 2801.4117035422382, 2851.957220641692, 2962.4371369439737, 959.7168835193635, 979.1090108001684, 992.8212921674024, 993.3642468819961, 998.3909815012836, 19766.209351625774, 19843.801561984485, 20378.69431958522, 24350.512989740106, 26018.479630407284, 1030.8866024737272, 1050.8003479338902, 1051.1380667852288, 1058.8358804385332, 1074.4198133008244, 11351.60269390584, 11391.373474458818, 11482.885171148182, 11501.194916355775, 11526.193166478266, 523566.0, 528518.0, 528913.0, 539987.0, 540677.0, 118108.0, 118175.40912295383, 120098.0, 120375.0, 120745.0, 1279.7312564361403, 1299.1620404838825, 1334.126147373472, 1335.6527302901509, 1335.7194989052214, 18502.0, 18611.90694046521, 18697.06514674288, 21233.256836011282, 22626.321210363716, 60309.39690603213, 60343.39656603378, 60345.698271508365, 61248.38751612427, 63008.0, 70753.0, 70923.0, 71013.28986710274, 72099.63950180216, 72325.6383718078, 14657.48698795537, 14860.62848428798, 14896.0, 14907.627309317353, 15008.47470338533, 23424.6486302709, 23979.0, 24058.759412405652, 24470.75529244756, 24674.259772206864, 18419.171137299123, 18637.161327740014, 18675.813241867952, 18680.159392827627, 18712.625747485246, 16886.493405197863, 17250.482485525456, 17363.47909562715, 17762.46712598624, 17768.200430980894, 19317.61364772725, 19332.613347732684, 19541.31605393861, 19695.80304196997, 19716.0, 14848.777268340767, 14881.627959301104, 14906.776398353817, 14955.775663365275, 14973.850261497246, 18621.627567448304, 18783.530411739815, 18856.52858678544, 18906.14922328526, 18976.335828246498], "value": 12828.231827801666, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.2973858985442, 1321.4383886848093, 1321.5176460591888, 1325.9270740109303, 1337.9464821407144, 14069.507567235149, 14694.926525367386, 14744.926275368609, 14756.188409637465, 14775.556733298004, 12785.680357991056, 13070.73858522829, 13839.30803459828, 13858.168509889414, 13865.168089914612, 2694.8383097014143, 2731.4400547887735, 2734.3300891281665, 2735.9042433514833, 2743.670759508862, 2626.3828000419885, 2644.219955113246, 2694.582339737334, 2695.989004123454, 2818.2249881282605, 2760.806743527954, 2781.0961437532783, 2784.1230012546084, 2784.192584150594, 2790.7069757675354, 2668.5997100434897, 2682.5037368086964, 2695.908157196339, 2697.109953715289, 2699.136276391546, 2681.9865900670566, 2682.7719643830296, 2706.3640044589506, 2729.0448343079765, 2732.8496932668695, 14319.85680143206, 14452.566423007327, 14475.78286325706, 14479.203643799587, 14484.34820433083, 7680.155182929873, 7887.802804929923, 7917.406194535433, 7919.406044546625, 7924.9301344318355, 5180.171172612401, 5316.069687804657, 5455.672659640394, 5490.450954904518, 5491.341039075336, 1875.287390791504, 1896.5163883209832, 1920.4142736465371, 1967.4294454608146, 1972.2111155537757, 24199.637005444933, 24461.87769061161, 24506.754932450625, 24529.63205551918, 24609.26172214854, 6689.1972963244725, 6712.731490740316, 6726.764563240263, 6836.897446538306, 6885.690143943534, 16359.0, 16418.83581164197, 16542.172891355625, 16578.917105414395, 16602.58493537647, 7280.817979550554, 7552.39580833532, 7556.546607203475, 7564.848703025908, 7576.545407275581, 6926.307369263134, 6989.545679530815, 7076.504644674823, 7088.0785497884945, 7133.464990125762, 5009.34691551787, 5197.714125723046, 5213.765380557884, 5252.737363131828, 5259.789608415697, 1378.5381897064394, 1432.5272660022167, 1503.8872084593481, 1537.7847101405812, 1546.6210778359373, 860.2172023458747, 860.2515811244133, 862.0775769926245, 881.0132651430439, 886.8093359927647, 7965.207144319364, 8458.027326857367, 8521.53131577769, 8540.316774658013, 8593.82812343762, 941.580996456584, 951.2342564235856, 952.0764858087643, 962.1052421248306, 968.2039816140957, 4337.392765012901, 4411.316245981814, 4418.867433976986, 4446.133004064176, 4535.954640453553, 19515.219391224477, 20386.388408347775, 20414.08136633855, 20470.897645511974, 20600.793992059887, 19342.452603791662, 20108.296209632594, 20142.093605787773, 20359.592808143756, 20465.48836279075, 10534.631287904887, 10747.946260268805, 10768.56925722978, 10781.083607893417, 10793.406362649972, 7304.0, 8466.85697430839, 8558.78603034929, 8863.468191908249, 8912.108789121035, 17498.212580433657, 17672.55818604494, 17696.646067078327, 17883.105844707454, 17980.190891409657, 17550.648987019933, 17899.642007159524, 17975.280988760827, 18120.909395452938, 18225.90887045556, 13021.348932553145, 13214.612465690963, 13249.403776830259, 13440.193588384729, 13444.529441469502, 12264.202826816228, 13501.392437340146, 13633.25017124028, 13634.045616807125, 13640.658983525094, 9786.853197201905, 9802.068803463659, 9927.156191723496, 10011.349262297927, 10135.493225338556, 10355.792884142425, 10555.683329500127, 10560.577576896838, 10588.788224235319, 10720.946395267974, 9492.810143797224, 9706.805863882824, 9760.511974401394, 9763.365381250196, 9798.0, 7365.079365079365, 7446.553206807609, 7461.626918653937, 7462.701491940479, 7463.029806125386, 7372.520786148883, 7447.180810110992, 7468.290512401313, 7525.096988361432, 7542.811429714301], "value": 6500.892089805016, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.78419171851954, 508.605830481377, 527.4751622135975, 528.6378830501108, 534.2493796216318, 6249.31257561669, 6276.435120839124, 6278.654673992928, 6314.431701146896, 6334.841628959279, 6218.502519798417, 6267.623942563449, 6294.6223226606435, 6295.401936816007, 6320.589161704486, 5184.248283998809, 5195.688258704471, 5197.532222100011, 5212.739363031852, 5228.032813929416, 4838.709677419349, 5164.664296820713, 5165.586753059765, 5185.0, 5212.5308722214995, 4909.484504127051, 4928.23612340086, 4959.553640172402, 4972.080165169437, 4977.427595826472, 4920.434150072734, 4970.776315065831, 4999.8500044998345, 5030.937315700545, 5052.595792336604, 4474.7091439056685, 4511.939694171867, 4673.299005149255, 4787.6648634595595, 4892.559669629715, 6037.577369584087, 6052.909206361864, 6105.938940610581, 6153.4154255345675, 6216.844578885519, 6005.969970150165, 6043.335233124353, 6049.153118563405, 6069.332373438918, 6129.049997250433, 6680.298568650271, 6721.462283017347, 6734.191896972346, 6773.288804675537, 6831.521793474459, 5346.518813306821, 5365.141577347645, 5367.677939323614, 5399.785048364126, 5434.701091439969, 6736.360045795691, 6769.356911093439, 6785.9660701696175, 6896.965515172392, 6934.353982831515, 5494.972525137428, 5506.201600767866, 5541.0, 5558.916616250759, 5560.026995275811, 5543.695096769636, 5607.859803504945, 5635.520980716603, 5639.154126881001, 5654.773809047674, 6028.457438830438, 6043.184170136975, 6059.39446038199, 6062.211912451353, 6071.635701857903, 6712.228093769181, 6732.360425759545, 6733.3939945405145, 6734.629595372204, 6747.595144291358, 1971.2410721872182, 1973.2501649373146, 1984.5633960528949, 1986.7218589397496, 1987.224982256921, 1376.593904798087, 1450.3111022264552, 1453.1063396011589, 1475.4762059468735, 1475.9926200369143, 5729.9713501432225, 5733.541316694655, 5741.110127930177, 5743.9425605744245, 5792.913106303409, 6648.368405001614, 6698.196216454056, 6760.560563563353, 6803.897941530881, 6865.897011544831, 5677.858053548612, 5710.457506536873, 5736.254286942671, 5766.942330576724, 5789.1605717171615, 3655.360311945452, 3659.1218107654504, 3659.9634003660153, 3660.682154424405, 3671.908202294964, 6488.410339466766, 6581.656106969377, 6587.63767992765, 6599.208095028627, 6650.900236496456, 6888.622275544911, 6945.2707465715375, 7008.404285635676, 7012.964935175393, 7050.717971281194, 6551.377619126175, 6569.770058047945, 6642.734290628321, 6675.532712710161, 6697.933020669731, 6706.295838937037, 6738.090357801634, 6796.2524122347495, 6815.318468153145, 6886.173659160932, 6637.137172167587, 6647.268800432045, 6724.327567243236, 6757.189137303555, 6792.456603471809, 6527.869442611026, 6600.570962887397, 6609.801705948829, 6620.337966203341, 6658.5671931324305, 5538.778448862, 5561.221428999862, 5570.275864137636, 5578.804741834017, 5607.607467477237, 6509.902351464826, 6746.9325306746305, 6819.89770153458, 6836.213835408992, 6859.314068593101, 6337.461315788025, 6491.350864913471, 6507.819880340139, 6530.738770449128, 6546.312637173029, 6541.901871471837, 6602.075709400592, 6604.768833090819, 6676.432503237279, 6706.966465167643, 6306.117143599991, 6516.250631177286, 6540.967295163494, 6545.70544325516, 6558.8360290991195, 6647.534672572873, 6648.5346025777735, 6656.2345330287635, 6705.362990515893, 6710.899336509859, 6314.011086507919, 6355.332690067661, 6412.358764123737, 6417.550771445954, 6476.0], "value": 5224.276265347421, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [910.6038873090206, 914.3234006834944, 921.2399770189587, 928.4197376639603, 929.8372784762669, 18539.72190417143, 19290.0, 19480.123394447266, 19503.804961950376, 21230.89384553079, 21480.355589332306, 21990.45023874404, 22104.447388815286, 22187.66718499224, 22195.223167189153, 1026.4764969865366, 1049.695588279398, 1057.5346847387164, 1058.253930978662, 1063.8829728729834, 1010.5301035018715, 1043.9217058720587, 1044.634377967713, 1050.8266136087575, 1054.3884546962781, 1085.9239853210279, 1087.40736298717, 1087.4182312462833, 1088.3252383522226, 1089.2266490791546, 1069.7058308965059, 1073.1682945717055, 1078.5577913055608, 1081.2755453845941, 1083.56657337065, 782.2685788787445, 783.725696006399, 790.8615992201342, 791.3787676673841, 794.9364050875973, 19837.702434463496, 19843.90078049615, 20105.698414523795, 20249.696254556195, 20279.29022484206, 21246.46883827917, 21960.121595136174, 22208.11167553296, 22371.217007404826, 22410.887945560167, 17195.484135475956, 17223.052732099728, 17294.56763580908, 17380.913095434567, 17501.299948002066, 3659.176685245825, 3677.0, 3681.1349332906743, 3685.1155722626645, 3685.981570092159, 130256.0, 130844.0, 132056.0, 132584.33707831494, 134442.3277883614, 16660.833391666172, 16926.32294708198, 17027.063511506738, 17376.0, 17467.47597572075, 31106.377872442423, 31863.0, 31912.202194945312, 32091.518627220612, 32132.35735285281, 7787.532748035136, 8068.556229407322, 8985.955070224738, 8999.415038022507, 9343.0, 4387.122575484916, 4466.419365482531, 4468.374427580141, 4472.552744725502, 4494.640428765691, 5148.9485105149215, 5215.322008138917, 5232.764525596357, 5237.869053273623, 5245.947540524622, 1061.5010944855906, 1075.295681328731, 1086.9619563315246, 1091.5033659684825, 1094.8576685031055, 700.6811900585324, 710.3748701143064, 713.7394850879392, 715.7637979466764, 736.5359823311279, 12051.457684404222, 12328.75342493145, 12378.44297006637, 12608.369581520887, 12639.684007899876, 686.3513979289523, 689.1729924091111, 700.2542292458515, 714.4427346669606, 715.2168375628678, 5497.39528651848, 5554.972225138848, 5574.498295153456, 5576.33084029919, 5759.424057594207, 111223.44388278006, 113253.0, 114998.0, 115070.0, 120876.3956180231, 99833.0, 102996.48501757593, 103309.0, 105853.0, 106914.46542767236, 88119.55940220386, 90636.5468172655, 90649.54675226714, 91518.54240728621, 93541.5322923381, 10256.230782691178, 10523.579056837641, 10527.736806579896, 10598.223967937338, 10731.785364292826, 40854.387184192856, 41580.37629435621, 41664.0, 42335.153296934506, 42614.5738542623, 51701.0, 51846.74076629593, 51857.481425185266, 52766.47233527616, 54681.72659136679, 15260.160691162093, 15381.692366152838, 15392.692146157238, 15453.690926181638, 16365.754513682066, 18357.3574924877, 18552.628947420704, 18592.814071859648, 18606.255749769858, 18611.720824187378, 16249.025058496529, 16325.83674163243, 16335.10156941332, 16377.508674739776, 16417.91791041037, 17986.91006544959, 18167.909160454114, 18196.0, 18221.088945552405, 18375.63248734991, 16742.1628918556, 17128.143592820557, 17182.484525464257, 18906.52733681669, 19487.51281217924, 13611.931940340235, 13671.589852304447, 13979.650508737363, 14019.937203300717, 14520.63698407506, 14780.852191477947, 15267.160306183267, 15435.69128617399, 15660.530184094496, 15744.212789360716], "value": 9207.743148269317, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 115.0, 101.0, 106.0, 112.0, 108.0, 109.0, 101.0, 113.0, 106.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 155.0, 179.0, 122.0, 149.0, 150.0, 119.0, 174.0, 120.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 163.0, 163.0, 163.0, 166.0, 164.0, 170.0, 162.0, 165.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 175.0, 75.0, 76.0, 78.0, 76.0, 171.0, 75.0], "value": 95.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 86.0, 139.0, 78.0, 79.0, 78.0, 130.0, 80.0, 78.0, 126.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 115.0, 114.0, 114.0, 114.0, 117.0, 114.0, 114.0, 119.0, 118.0], "value": 116.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 154.0, 151.0, 151.0, 153.0, 151.0, 151.0, 150.0, 155.0], "value": 151.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 99.0, 98.0, 93.0, 94.0, 95.0, 94.0, 94.0, 97.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 53.0, 52.0, 53.0, 61.0, 54.0, 58.0, 54.0, 63.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 54.0, 66.0, 58.0, 57.0, 53.0, 54.0, 53.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 77.0, 76.0, 78.0, 77.0, 77.0, 76.0, 82.0, 76.0, 79.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 121.0, 123.0, 127.0, 129.0, 124.0, 119.0, 121.0, 122.0, 177.0], "value": 129.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 172.0, 174.0, 175.0, 174.0, 178.0, 183.0, 186.0, 172.0, 178.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 71.0, 66.0, 73.0, 66.0, 66.0, 68.0, 70.0, 80.0], "value": 69.8, "unit": "score"}]}]} 18:11:04 INFO - Return code: 0 18:11:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:11:04 INFO - # TBPL SUCCESS # 18:11:04 INFO - Running post-action listener: _package_coverage_data 18:11:04 INFO - Running post-action listener: _resource_record_post_action 18:11:04 INFO - [mozharness: 2017-08-17 01:11:04.355578Z] Finished run-tests step (success) 18:11:04 INFO - Running post-run listener: _resource_record_post_run 18:11:04 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 12288; Write bytes: 434528256; Read time: 268; Write time: 315176 18:11:04 INFO - TinderboxPrint: CPU usage
13.1% 18:11:04 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 268 18:11:04 INFO - TinderboxPrint: I/O write bytes / time
434,528,256 / 315,176 18:11:04 INFO - TinderboxPrint: CPU idle
8,254.7 (86.9%) 18:11:04 INFO - TinderboxPrint: CPU user
1,200.5 (12.6%) 18:11:04 INFO - TinderboxPrint: Swap in / out
0 / 0 18:11:04 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 106418176; Read time: 72; Write time: 103348 18:11:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:11:04 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 328110080; Read time: 184; Write time: 211828 18:11:04 INFO - Running post-run listener: _upload_blobber_files 18:11:04 INFO - Blob upload gear active. 18:11:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:11:04 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 18:11:04 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'] 18:11:04 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 18:11:05 INFO - (blobuploader) - INFO - Open directory for files ... 18:11:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:11:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:11:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:11:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:11:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:11:06 INFO - (blobuploader) - INFO - Done attempting. 18:11:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:11:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:11:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:11:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:11:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:11:12 INFO - (blobuploader) - INFO - Done attempting. 18:11:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:11:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:11:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:11:13 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:11:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:11:13 INFO - (blobuploader) - INFO - Done attempting. 18:11:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:11:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:11:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:11:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:11:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:11:14 INFO - (blobuploader) - INFO - Done attempting. 18:11:14 INFO - (blobuploader) - INFO - Iteration through files over. 18:11:14 INFO - Return code: 0 18:11:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:11:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:11:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd808f1f3c68ce3bfd953761b0ebf91058814625ed880791e9cb10f45fc9c9162fe357bd3af309162216202fe30629d0d97f1a54a536b72e47f4fc9a142d8f96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81199dd236bfe10b620eae424ad371ab7d07c052127eeef383464c679ca19900460426d07eb423374363a4e2a83d55da21616c180216f8ce526d8612f728041d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afbb6c484e00d834b8015af40cec94130884d60592d21b0ba179ed7cc6bb59479c9de9c98f738dce18e4d355814961b988791ec2b26080188070b6e1fcd5a06d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9aa3fd58fb63e967fa3f493be05158ff28ec38a811bc5efa312287872cced4855727fdc28fe5516c27327b363e787f1437f16c3dd77ad7d5af9d4d6dc2fb905d"} 18:11:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:11:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:11:14 INFO - Contents: 18:11:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd808f1f3c68ce3bfd953761b0ebf91058814625ed880791e9cb10f45fc9c9162fe357bd3af309162216202fe30629d0d97f1a54a536b72e47f4fc9a142d8f96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81199dd236bfe10b620eae424ad371ab7d07c052127eeef383464c679ca19900460426d07eb423374363a4e2a83d55da21616c180216f8ce526d8612f728041d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afbb6c484e00d834b8015af40cec94130884d60592d21b0ba179ed7cc6bb59479c9de9c98f738dce18e4d355814961b988791ec2b26080188070b6e1fcd5a06d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9aa3fd58fb63e967fa3f493be05158ff28ec38a811bc5efa312287872cced4855727fdc28fe5516c27327b363e787f1437f16c3dd77ad7d5af9d4d6dc2fb905d"} 18:11:14 INFO - Running post-run listener: copy_logs_to_upload_dir 18:11:14 INFO - Copying logs to upload dir... 18:11:14 INFO - mkdir: /builds/slave/test/build/upload/logs 18:11:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.804858 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-16 18:11:14.453992) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 18:11:14.457759) ========= 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=923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330 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/bd808f1f3c68ce3bfd953761b0ebf91058814625ed880791e9cb10f45fc9c9162fe357bd3af309162216202fe30629d0d97f1a54a536b72e47f4fc9a142d8f96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81199dd236bfe10b620eae424ad371ab7d07c052127eeef383464c679ca19900460426d07eb423374363a4e2a83d55da21616c180216f8ce526d8612f728041d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afbb6c484e00d834b8015af40cec94130884d60592d21b0ba179ed7cc6bb59479c9de9c98f738dce18e4d355814961b988791ec2b26080188070b6e1fcd5a06d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9aa3fd58fb63e967fa3f493be05158ff28ec38a811bc5efa312287872cced4855727fdc28fe5516c27327b363e787f1437f16c3dd77ad7d5af9d4d6dc2fb905d"} build_url:https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011351 build_url: 'https://queue.taskcluster.net/v1/task/VGVatiFiSBqe2fkjUp-Rdg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd808f1f3c68ce3bfd953761b0ebf91058814625ed880791e9cb10f45fc9c9162fe357bd3af309162216202fe30629d0d97f1a54a536b72e47f4fc9a142d8f96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/81199dd236bfe10b620eae424ad371ab7d07c052127eeef383464c679ca19900460426d07eb423374363a4e2a83d55da21616c180216f8ce526d8612f728041d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/afbb6c484e00d834b8015af40cec94130884d60592d21b0ba179ed7cc6bb59479c9de9c98f738dce18e4d355814961b988791ec2b26080188070b6e1fcd5a06d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9aa3fd58fb63e967fa3f493be05158ff28ec38a811bc5efa312287872cced4855727fdc28fe5516c27327b363e787f1437f16c3dd77ad7d5af9d4d6dc2fb905d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 18:11:14.491259) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 18:11:14.491905) ========= 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=923d835db2ba3686ebe126b700000192-1502921589.315828-1980739330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 18:11:14.573941) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 18:11:14.574412) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 18:11:14.574766) ========= ========= Total master_lag: 0.25 =========