builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1502994012.94 results: success (0) revision: e365137fa61bfd729617ba1ebf9f1ed79facd1f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:12.938219) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:12.938673) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:12.938951) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:13.021773) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:13.022153) ========= 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=6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-17 11:20:13-- 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% 228M=0s 2017-08-17 11:20:13 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120534 ========= master_lag: 0.22 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:13.358741) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:13.359481) ========= 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=6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017668 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:13.509691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 10 secs) (at 2017-08-17 11:20:13.510017) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e365137fa61bfd729617ba1ebf9f1ed79facd1f2 --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 e365137fa61bfd729617ba1ebf9f1ed79facd1f2 --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=6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-17 11:20:13,877 truncating revision to first 12 chars 2017-08-17 11:20:13,877 Setting DEBUG logging. 2017-08-17 11:20:13,877 attempt 1/10 2017-08-17 11:20:13,877 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e365137fa61b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-17 11:20:14,258 attempt 1/10 2017-08-17 11:20:14,828 current task status: no status available at this point. state: STARTED 2017-08-17 11:20:14,829 sleeping for 9.00s (attempt 1/10) 2017-08-17 11:20:23,838 attempt 2/10 2017-08-17 11:20:24,232 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-17 11:20:24,425 unpacking tar archive at: mozilla-central-e365137fa61b/testing/mozharness/ program finished with exit code 0 elapsedTime=10.890295 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 10 secs) (at 2017-08-17 11:20:24.421300) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:24.421628) ========= script_repo_revision: e365137fa61bfd729617ba1ebf9f1ed79facd1f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:24.422055) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:24.422324) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:24.433632) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-17 11:20:24.434023) ========= /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=6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:20:24 INFO - MultiFileLogger online at 20170817 11:20:24 in /builds/slave/test 11:20:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:20:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:20:24 INFO - {'append_to_log': False, 11:20:24 INFO - 'base_work_dir': '/builds/slave/test', 11:20:24 INFO - 'blob_upload_branch': 'Firefox', 11:20:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:20:24 INFO - 'branch': 'Firefox', 11:20:24 INFO - 'buildbot_json_path': 'buildprops.json', 11:20:24 INFO - 'code_coverage': False, 11:20:24 INFO - 'config_files': ('talos/linux_config.py',), 11:20:24 INFO - 'default_actions': ('clobber', 11:20:24 INFO - 'read-buildbot-config', 11:20:24 INFO - 'download-and-extract', 11:20:24 INFO - 'populate-webroot', 11:20:24 INFO - 'create-virtualenv', 11:20:24 INFO - 'install', 11:20:24 INFO - 'setup-mitmproxy', 11:20:24 INFO - 'run-tests'), 11:20:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:20:24 INFO - 'disable_ccov_upload': False, 11:20:24 INFO - 'download_minidump_stackwalk': True, 11:20:24 INFO - 'download_symbols': 'ondemand', 11:20:24 INFO - 'enable_stylo': False, 11:20:24 INFO - 'enable_webrender': False, 11:20:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:20:24 INFO - 'tooltool.py': '/tools/tooltool.py', 11:20:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:20:24 INFO - '/tools/misc-python/virtualenv.py')}, 11:20:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:20:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:20:24 INFO - 'gecko_profile': False, 11:20:24 INFO - 'gecko_profile_interval': 0, 11:20:24 INFO - 'installer_path': 'installer.exe', 11:20:24 INFO - 'log_level': 'info', 11:20:24 INFO - 'log_name': 'talos', 11:20:24 INFO - 'log_to_console': True, 11:20:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:20:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:20:24 INFO - 'opt_config_files': (), 11:20:24 INFO - 'pip_index': False, 11:20:24 INFO - 'suite': 'dromaeojs-e10s', 11:20:24 INFO - 'system_bits': '32', 11:20:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:20:24 INFO - 'title': 'talos-linux64-ix-023', 11:20:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:20:24 INFO - 'use_talos_json': True, 11:20:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:20:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:20:24 INFO - 'work_dir': 'build'} 11:20:24 INFO - [mozharness: 2017-08-17 18:20:24.906240Z] Running clobber step. 11:20:24 INFO - Running pre-action listener: _resource_record_pre_action 11:20:24 INFO - Running main action method: clobber 11:20:24 INFO - rmtree: /builds/slave/test/build 11:20:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:20:25 INFO - Running post-action listener: _resource_record_post_action 11:20:25 INFO - [mozharness: 2017-08-17 18:20:25.948038Z] Finished clobber step (success) 11:20:25 INFO - [mozharness: 2017-08-17 18:20:25.948138Z] Running read-buildbot-config step. 11:20:25 INFO - Running pre-action listener: _resource_record_pre_action 11:20:25 INFO - Running main action method: read_buildbot_config 11:20:25 INFO - Using buildbot properties: 11:20:25 INFO - { 11:20:25 INFO - "project": "", 11:20:25 INFO - "product": "firefox", 11:20:25 INFO - "who": "archaeopteryx@coole-files.de", 11:20:25 INFO - "installer_path": "public/build/target.tar.bz2", 11:20:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 11:20:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:20:25 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 11:20:25 INFO - "stage_platform": "linux64-stylo", 11:20:25 INFO - "basedir": "/builds/slave/test", 11:20:25 INFO - "buildnumber": 39, 11:20:25 INFO - "platform": "ubuntu64_hw_stylo", 11:20:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:20:25 INFO - "slavebuilddir": "test", 11:20:25 INFO - "taskId": "J4eT-9TWSPOz7sagY90DbA", 11:20:25 INFO - "branch": "mozilla-central", 11:20:25 INFO - "script_repo_revision": "production", 11:20:25 INFO - "revision": "e365137fa61bfd729617ba1ebf9f1ed79facd1f2", 11:20:25 INFO - "slavename": "talos-linux64-ix-023", 11:20:25 INFO - "repo_path": "mozilla-central" 11:20:25 INFO - } 11:20:25 INFO - Finding installer, test and symbols from parent task. 11:20:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J4eT-9TWSPOz7sagY90DbA'}, attempt #1 11:20:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J4eT-9TWSPOz7sagY90DbA'}, attempt #1 11:20:26 INFO - Task dependencies: aYF0Eu7eSDuOnCwEq2ykWQ 11:20:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ'}, attempt #1 11:20:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 11:20:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.test_packages.json 11:20:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.crashreporter-symbols.zip 11:20:27 INFO - Running post-action listener: _resource_record_post_action 11:20:27 INFO - [mozharness: 2017-08-17 18:20:27.332811Z] Finished read-buildbot-config step (success) 11:20:27 INFO - [mozharness: 2017-08-17 18:20:27.333033Z] Running download-and-extract step. 11:20:27 INFO - Running pre-action listener: _resource_record_pre_action 11:20:27 INFO - Running main action method: download_and_extract 11:20:27 INFO - mkdir: /builds/slave/test/build/tests 11:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:27 INFO - trying https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.test_packages.json 11:20:27 INFO - Downloading https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:20:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:20:27 INFO - Downloaded 989 bytes. 11:20:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:20:27 INFO - Using the following test package requirements: 11:20:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:20:27 INFO - u'common': [u'target.common.tests.zip'], 11:20:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:20:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:20:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:20:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:20:27 INFO - u'mozbase': [u'target.common.tests.zip'], 11:20:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:20:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:20:27 INFO - u'web-platform': [u'target.common.tests.zip', 11:20:27 INFO - u'target.web-platform.tests.tar.gz'], 11:20:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:20:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:20:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.common.tests.zip 11:20:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:20:27 INFO - Fetch https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.common.tests.zip into memory 11:20:29 INFO - Content-Length response header: 53999535 11:20:29 INFO - Bytes received: 53999535 11:20:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:20:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.common.tests.zip 11:20:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:20:40 INFO - Fetch https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.common.tests.zip into memory 11:20:41 INFO - Content-Length response header: 53999535 11:20:41 INFO - Bytes received: 53999535 11:20:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.talos.tests.zip 11:20:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:20:53 INFO - Fetch https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.talos.tests.zip into memory 11:20:54 INFO - Content-Length response header: 14496161 11:20:54 INFO - Bytes received: 14496161 11:20: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')]} 11:20:54 INFO - trying https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 11:20:54 INFO - Downloading https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:20:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:20:55 INFO - Downloaded 62276440 bytes. 11:20:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 11:20:55 INFO - mkdir: /builds/slave/test/properties 11:20:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:20:55 INFO - Writing to file /builds/slave/test/properties/build_url 11:20:55 INFO - Contents: 11:20:55 INFO - build_url:https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 11:20:55 INFO - Running post-action listener: _resource_record_post_action 11:20:55 INFO - Running post-action listener: set_extra_try_arguments 11:20:55 INFO - [mozharness: 2017-08-17 18:20:55.737542Z] Finished download-and-extract step (success) 11:20:55 INFO - [mozharness: 2017-08-17 18:20:55.737640Z] Running populate-webroot step. 11:20:55 INFO - Running pre-action listener: _resource_record_pre_action 11:20:55 INFO - Running main action method: populate_webroot 11:20:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:20:55 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 11:20:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:20:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:20:55 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 11:20:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:20:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:20:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:55 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:20:55 INFO - 'talos_options': ['--stylo'], 11:20:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:20:55 INFO - 'tests': ['damp', 'tps']}, 11:20:55 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:20:55 INFO - 'talos_options': ['--stylo'], 11:20:55 INFO - 'tests': ['damp', 'tps']}, 11:20:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:20:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:20:55 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 11:20:55 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:20:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:20:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:20:55 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:20:55 INFO - 'talos_options': ['--stylo'], 11:20:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:20:55 INFO - 'other-e10s': {'tests': ['a11yr', 11:20:55 INFO - 'ts_paint', 11:20:55 INFO - 'tpaint', 11:20:55 INFO - 'sessionrestore', 11:20:55 INFO - 'sessionrestore_many_windows', 11:20:55 INFO - 'sessionrestore_no_auto_restore', 11:20:55 INFO - 'tabpaint']}, 11:20:55 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 11:20:55 INFO - 'tests': ['a11yr', 11:20:55 INFO - 'ts_paint', 11:20:55 INFO - 'tpaint', 11:20:55 INFO - 'sessionrestore', 11:20:55 INFO - 'sessionrestore_many_windows', 11:20:55 INFO - 'sessionrestore_no_auto_restore', 11:20:55 INFO - 'tabpaint']}, 11:20:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:20:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:20:55 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 11:20:55 INFO - 'tests': ['bloom_basic_singleton']}, 11:20:55 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 11:20:55 INFO - 'tests': ['bloom_basic']}, 11:20:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:20:55 INFO - 'tsvgr_opacity', 11:20:55 INFO - 'tart', 11:20:55 INFO - 'tscrollx', 11:20:55 INFO - 'tsvg_static']}, 11:20:55 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 11:20:55 INFO - 'tests': ['tsvgx', 11:20:55 INFO - 'tsvgr_opacity', 11:20:55 INFO - 'tart', 11:20:55 INFO - 'tscrollx', 11:20:55 INFO - 'tsvg_static']}, 11:20:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:20:55 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:20:55 INFO - 'talos_options': ['--stylo'], 11:20:55 INFO - 'tests': ['tp5o']}, 11:20:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:55 INFO - 'talos_options': ['--mitmproxy', 11:20:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:55 INFO - '--firstNonBlankPaint'], 11:20:55 INFO - 'tests': ['tp6_google', 11:20:55 INFO - 'tp6_youtube', 11:20:55 INFO - 'tp6_amazon', 11:20:55 INFO - 'tp6_facebook']}, 11:20:55 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:55 INFO - 'talos_options': ['--stylo', 11:20:55 INFO - '--mitmproxy', 11:20:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:55 INFO - '--firstNonBlankPaint'], 11:20:55 INFO - 'tests': ['tp6_google', 11:20:55 INFO - 'tp6_youtube', 11:20:55 INFO - 'tp6_amazon', 11:20:55 INFO - 'tp6_facebook']}, 11:20:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:55 INFO - 'talos_options': ['--stylo', 11:20:55 INFO - '--stylo-threads=1', 11:20:55 INFO - '--mitmproxy', 11:20:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:55 INFO - '--firstNonBlankPaint'], 11:20:55 INFO - 'tests': ['tp6_google', 11:20:55 INFO - 'tp6_youtube', 11:20:55 INFO - 'tp6_amazon', 11:20:55 INFO - 'tp6_facebook']}, 11:20:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:20:55 INFO - 'talos_options': ['--xperf_path', 11:20:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:55 INFO - 'tests': ['tp5n']}, 11:20:55 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:20:55 INFO - 'talos_options': ['--stylo', 11:20:55 INFO - '--xperf_path', 11:20:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:55 INFO - 'tests': ['tp5n']}}} 11:20:55 INFO - Running post-action listener: _resource_record_post_action 11:20:55 INFO - [mozharness: 2017-08-17 18:20:55.751933Z] Finished populate-webroot step (success) 11:20:55 INFO - [mozharness: 2017-08-17 18:20:55.752024Z] Running create-virtualenv step. 11:20:55 INFO - Running pre-action listener: _resource_record_pre_action 11:20:55 INFO - Running main action method: create_virtualenv 11:20:55 INFO - Creating virtualenv /builds/slave/test/build/venv 11:20:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:20:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:20:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:20:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:20:55 INFO - Using real prefix '/usr' 11:20:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:20:56 INFO - Installing distribute.............................................................................................................................................................................................done. 11:20:58 INFO - Installing pip.................done. 11:20:58 INFO - Return code: 0 11:20:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:20:58 INFO - Reading from file tmpfile_stdout 11:20:58 INFO - Output received: 11:20:58 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:20:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:20: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')]} 11:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20: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')]} 11:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd42a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee30b0>, '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 0xee3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee4440>, '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': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20: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', 'pip>=1.5'] in /builds/slave/test/build 11:20: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 pip>=1.5 11:20:58 INFO - Using env: {'DISPLAY': ':0', 11:20:58 INFO - 'HOME': '/home/cltbld', 11:20:58 INFO - 'LANG': 'en_US.UTF-8', 11:20:58 INFO - 'LANGUAGE': 'en_US:en', 11:20:58 INFO - 'LOGNAME': 'cltbld', 11:20:58 INFO - 'MAIL': '/var/mail/cltbld', 11:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:58 INFO - 'MOZ_NO_REMOTE': '1', 11:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:58 INFO - 'NO_EM_RESTART': '1', 11:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:58 INFO - 'PWD': '/builds/slave/test', 11:20:58 INFO - 'SHELL': '/bin/bash', 11:20:58 INFO - 'SHLVL': '1', 11:20:58 INFO - 'TERM': 'linux', 11:20:58 INFO - 'TMOUT': '86400', 11:20:58 INFO - 'USER': 'cltbld', 11:20:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 11:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:58 INFO - '_': '/tools/buildbot/bin/python'} 11:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:20:58 INFO - Cleaning up... 11:20:58 INFO - Return code: 0 11:20:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:20: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')]} 11:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20: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')]} 11:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20: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', '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 0xc3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd42a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee30b0>, '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 0xee3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee4440>, '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': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:20: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:20: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 psutil>=3.1.1 11:20:58 INFO - Using env: {'DISPLAY': ':0', 11:20:58 INFO - 'HOME': '/home/cltbld', 11:20:58 INFO - 'LANG': 'en_US.UTF-8', 11:20:58 INFO - 'LANGUAGE': 'en_US:en', 11:20:58 INFO - 'LOGNAME': 'cltbld', 11:20:58 INFO - 'MAIL': '/var/mail/cltbld', 11:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:58 INFO - 'MOZ_NO_REMOTE': '1', 11:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:58 INFO - 'NO_EM_RESTART': '1', 11:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:58 INFO - 'PWD': '/builds/slave/test', 11:20:58 INFO - 'SHELL': '/bin/bash', 11:20:58 INFO - 'SHLVL': '1', 11:20:58 INFO - 'TERM': 'linux', 11:20:58 INFO - 'TMOUT': '86400', 11:20:58 INFO - 'USER': 'cltbld', 11:20:58 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 11:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:58 INFO - '_': '/tools/buildbot/bin/python'} 11:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:58 INFO - Downloading/unpacking psutil>=3.1.1 11:20: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 11:20: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 11:20: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 11:20: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 11:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:21:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:21:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:21:00 INFO - Installing collected packages: psutil 11:21:00 INFO - Running setup.py install for psutil 11:21:00 INFO - building 'psutil._psutil_linux' extension 11:21:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:21:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:21:00 INFO - building 'psutil._psutil_posix' extension 11:21:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:21:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:21:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:21:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:21:00 INFO - Successfully installed psutil 11:21:00 INFO - Cleaning up... 11:21:00 INFO - Return code: 0 11:21:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:21: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')]} 11:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21: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')]} 11:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd42a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee30b0>, '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 0xee3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee4440>, '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': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:21: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 mozsystemmonitor==0.3 11:21:00 INFO - Using env: {'DISPLAY': ':0', 11:21:00 INFO - 'HOME': '/home/cltbld', 11:21:00 INFO - 'LANG': 'en_US.UTF-8', 11:21:00 INFO - 'LANGUAGE': 'en_US:en', 11:21:00 INFO - 'LOGNAME': 'cltbld', 11:21:00 INFO - 'MAIL': '/var/mail/cltbld', 11:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:00 INFO - 'MOZ_NO_REMOTE': '1', 11:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:00 INFO - 'NO_EM_RESTART': '1', 11:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:00 INFO - 'PWD': '/builds/slave/test', 11:21:00 INFO - 'SHELL': '/bin/bash', 11:21:00 INFO - 'SHLVL': '1', 11:21:00 INFO - 'TERM': 'linux', 11:21:00 INFO - 'TMOUT': '86400', 11:21:00 INFO - 'USER': 'cltbld', 11:21:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 11:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:00 INFO - '_': '/tools/buildbot/bin/python'} 11:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:21: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 11:21: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 11:21: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 11:21: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 11:21:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:21:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:21:02 INFO - Installing collected packages: mozsystemmonitor 11:21:02 INFO - Running setup.py install for mozsystemmonitor 11:21:02 INFO - Successfully installed mozsystemmonitor 11:21:02 INFO - Cleaning up... 11:21:02 INFO - Return code: 0 11:21:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:21: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')]} 11:21:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21: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')]} 11:21:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:02 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 0xc3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd42a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee30b0>, '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 0xee3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee4440>, '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': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:21:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:21:02 INFO - Using env: {'DISPLAY': ':0', 11:21:02 INFO - 'HOME': '/home/cltbld', 11:21:02 INFO - 'LANG': 'en_US.UTF-8', 11:21:02 INFO - 'LANGUAGE': 'en_US:en', 11:21:02 INFO - 'LOGNAME': 'cltbld', 11:21:02 INFO - 'MAIL': '/var/mail/cltbld', 11:21:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:02 INFO - 'MOZ_NO_REMOTE': '1', 11:21:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:02 INFO - 'NO_EM_RESTART': '1', 11:21:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:02 INFO - 'PWD': '/builds/slave/test', 11:21:02 INFO - 'SHELL': '/bin/bash', 11:21:02 INFO - 'SHLVL': '1', 11:21:02 INFO - 'TERM': 'linux', 11:21:02 INFO - 'TMOUT': '86400', 11:21:02 INFO - 'USER': 'cltbld', 11:21:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 11:21:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:02 INFO - '_': '/tools/buildbot/bin/python'} 11:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:02 INFO - Downloading/unpacking jsonschema==2.5.1 11:21: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 11:21: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 11:21: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 11:21: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 11:21:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:21:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:03 INFO - Downloading functools32-3.2.3-2.tar.gz 11:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:21:03 INFO - warning: no files found matching '*.txt' 11:21:03 INFO - no previously-included directories found matching 'build' 11:21:03 INFO - no previously-included directories found matching 'dist' 11:21:03 INFO - no previously-included directories found matching '.git*' 11:21:03 INFO - Installing collected packages: jsonschema, functools32 11:21:03 INFO - Running setup.py install for functools32 11:21:03 INFO - warning: no files found matching '*.txt' 11:21:03 INFO - no previously-included directories found matching 'build' 11:21:03 INFO - no previously-included directories found matching 'dist' 11:21:03 INFO - no previously-included directories found matching '.git*' 11:21:03 INFO - Successfully installed jsonschema functools32 11:21:03 INFO - Cleaning up... 11:21:03 INFO - Return code: 0 11:21:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:03 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 0xc3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd42a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee30b0>, '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 0xee3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee4440>, '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': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:21:03 INFO - Using env: {'DISPLAY': ':0', 11:21:03 INFO - 'HOME': '/home/cltbld', 11:21:03 INFO - 'LANG': 'en_US.UTF-8', 11:21:03 INFO - 'LANGUAGE': 'en_US:en', 11:21:03 INFO - 'LOGNAME': 'cltbld', 11:21:03 INFO - 'MAIL': '/var/mail/cltbld', 11:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:03 INFO - 'MOZ_NO_REMOTE': '1', 11:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:03 INFO - 'NO_EM_RESTART': '1', 11:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:03 INFO - 'PWD': '/builds/slave/test', 11:21:03 INFO - 'SHELL': '/bin/bash', 11:21:03 INFO - 'SHLVL': '1', 11:21:03 INFO - 'TERM': 'linux', 11:21:03 INFO - 'TMOUT': '86400', 11:21:03 INFO - 'USER': 'cltbld', 11:21:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 11:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:03 INFO - '_': '/tools/buildbot/bin/python'} 11:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:21:04 INFO - Cleaning up... 11:21:04 INFO - Return code: 0 11:21:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:04 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 0xc3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd42a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee30b0>, '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 0xee3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee4440>, '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': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:21:04 INFO - Using env: {'DISPLAY': ':0', 11:21:04 INFO - 'HOME': '/home/cltbld', 11:21:04 INFO - 'LANG': 'en_US.UTF-8', 11:21:04 INFO - 'LANGUAGE': 'en_US:en', 11:21:04 INFO - 'LOGNAME': 'cltbld', 11:21:04 INFO - 'MAIL': '/var/mail/cltbld', 11:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:04 INFO - 'MOZ_NO_REMOTE': '1', 11:21:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:04 INFO - 'NO_EM_RESTART': '1', 11:21:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:04 INFO - 'PWD': '/builds/slave/test', 11:21:04 INFO - 'SHELL': '/bin/bash', 11:21:04 INFO - 'SHLVL': '1', 11:21:04 INFO - 'TERM': 'linux', 11:21:04 INFO - 'TMOUT': '86400', 11:21:04 INFO - 'USER': 'cltbld', 11:21:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 11:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:04 INFO - '_': '/tools/buildbot/bin/python'} 11:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:04 INFO - Downloading/unpacking blobuploader==1.2.4 11:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:05 INFO - Downloading blobuploader-1.2.4.tar.gz 11:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:21:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:21:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:05 INFO - Downloading docopt-0.6.1.tar.gz 11:21:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:21:06 INFO - Installing collected packages: blobuploader, requests, docopt 11:21:06 INFO - Running setup.py install for blobuploader 11:21:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:21:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:21:06 INFO - Running setup.py install for requests 11:21:06 INFO - Running setup.py install for docopt 11:21:06 INFO - Successfully installed blobuploader requests docopt 11:21:06 INFO - Cleaning up... 11:21:06 INFO - Return code: 0 11:21:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21: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')]} 11:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21: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')]} 11:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:06 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 0xc3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd42a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee30b0>, '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 0xee3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee4440>, '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': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:06 INFO - Using env: {'DISPLAY': ':0', 11:21:06 INFO - 'HOME': '/home/cltbld', 11:21:06 INFO - 'LANG': 'en_US.UTF-8', 11:21:06 INFO - 'LANGUAGE': 'en_US:en', 11:21:06 INFO - 'LOGNAME': 'cltbld', 11:21:06 INFO - 'MAIL': '/var/mail/cltbld', 11:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:06 INFO - 'MOZ_NO_REMOTE': '1', 11:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:06 INFO - 'NO_EM_RESTART': '1', 11:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:06 INFO - 'PWD': '/builds/slave/test', 11:21:06 INFO - 'SHELL': '/bin/bash', 11:21:06 INFO - 'SHLVL': '1', 11:21:06 INFO - 'TERM': 'linux', 11:21:06 INFO - 'TMOUT': '86400', 11:21:06 INFO - 'USER': 'cltbld', 11:21:06 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 11:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:06 INFO - '_': '/tools/buildbot/bin/python'} 11:21:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:06 INFO - Running setup.py (path:/tmp/pip-6XzMMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:06 INFO - Running setup.py (path:/tmp/pip-ew8Bja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:07 INFO - Running setup.py (path:/tmp/pip-7nXrYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:07 INFO - Running setup.py (path:/tmp/pip-2pieYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:07 INFO - Running setup.py (path:/tmp/pip-C7js7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:07 INFO - Running setup.py (path:/tmp/pip-0inI2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:07 INFO - Running setup.py (path:/tmp/pip-G8xxI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:07 INFO - Running setup.py (path:/tmp/pip-mapYhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:07 INFO - Running setup.py (path:/tmp/pip-UCpxDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:07 INFO - Running setup.py (path:/tmp/pip-Bd7CXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:07 INFO - Running setup.py (path:/tmp/pip-RJwpB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:07 INFO - Running setup.py (path:/tmp/pip-WMRx9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:07 INFO - Running setup.py (path:/tmp/pip-HXNtPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:07 INFO - Running setup.py (path:/tmp/pip-ZL2boX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:07 INFO - Running setup.py (path:/tmp/pip-tHzQQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:07 INFO - Running setup.py (path:/tmp/pip-e2_iHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:08 INFO - Running setup.py (path:/tmp/pip-wmo5RZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:21:08 INFO - Running setup.py install for manifestparser 11:21:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:21:08 INFO - Running setup.py install for mozcrash 11:21:08 INFO - Running setup.py install for mozdebug 11:21:08 INFO - Running setup.py install for mozdevice 11:21:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:21:08 INFO - Running setup.py install for mozfile 11:21:08 INFO - Running setup.py install for mozhttpd 11:21:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:21:08 INFO - Running setup.py install for mozinfo 11:21:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:21:08 INFO - Running setup.py install for mozInstall 11:21:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:21:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:21:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:21:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:21:08 INFO - Running setup.py install for mozleak 11:21:09 INFO - Running setup.py install for mozlog 11:21:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:21:09 INFO - Running setup.py install for moznetwork 11:21:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:21:09 INFO - Running setup.py install for mozprocess 11:21:09 INFO - Running setup.py install for mozprofile 11:21:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:21:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:21:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:21:09 INFO - Running setup.py install for mozrunner 11:21:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:21:09 INFO - Running setup.py install for mozscreenshot 11:21:09 INFO - Running setup.py install for moztest 11:21:09 INFO - Running setup.py install for mozversion 11:21:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:21:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:21:09 INFO - Cleaning up... 11:21:09 INFO - Return code: 0 11:21:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:09 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 0xc3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd42a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee30b0>, '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 0xee3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee4440>, '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': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:09 INFO - Using env: {'DISPLAY': ':0', 11:21:09 INFO - 'HOME': '/home/cltbld', 11:21:09 INFO - 'LANG': 'en_US.UTF-8', 11:21:09 INFO - 'LANGUAGE': 'en_US:en', 11:21:09 INFO - 'LOGNAME': 'cltbld', 11:21:09 INFO - 'MAIL': '/var/mail/cltbld', 11:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:09 INFO - 'MOZ_NO_REMOTE': '1', 11:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:09 INFO - 'NO_EM_RESTART': '1', 11:21:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:09 INFO - 'PWD': '/builds/slave/test', 11:21:09 INFO - 'SHELL': '/bin/bash', 11:21:09 INFO - 'SHLVL': '1', 11:21:09 INFO - 'TERM': 'linux', 11:21:09 INFO - 'TMOUT': '86400', 11:21:09 INFO - 'USER': 'cltbld', 11:21:09 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 11:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:09 INFO - '_': '/tools/buildbot/bin/python'} 11:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:10 INFO - Running setup.py (path:/tmp/pip-TNBzk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:10 INFO - Running setup.py (path:/tmp/pip-8vyAx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:10 INFO - Running setup.py (path:/tmp/pip-ssmZz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:10 INFO - Running setup.py (path:/tmp/pip-RdKDhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:10 INFO - Running setup.py (path:/tmp/pip-Y6nf2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:10 INFO - Running setup.py (path:/tmp/pip-gM1e7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:10 INFO - Running setup.py (path:/tmp/pip-ijAihK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:10 INFO - Running setup.py (path:/tmp/pip-xw3dBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:10 INFO - Running setup.py (path:/tmp/pip-fUzZ6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:10 INFO - Running setup.py (path:/tmp/pip-pX13n1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:10 INFO - Running setup.py (path:/tmp/pip-LFSZEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:21:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:10 INFO - Running setup.py (path:/tmp/pip-9jzVwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:11 INFO - Running setup.py (path:/tmp/pip-pUoHnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:11 INFO - Running setup.py (path:/tmp/pip-H68vwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:11 INFO - Running setup.py (path:/tmp/pip-GFNZFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:11 INFO - Running setup.py (path:/tmp/pip-nIABYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:21:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:11 INFO - Running setup.py (path:/tmp/pip-qheznr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:21:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:12 INFO - Downloading blessings-1.6.tar.gz 11:21:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:21:12 INFO - Installing collected packages: blessings 11:21:12 INFO - Running setup.py install for blessings 11:21:12 INFO - Successfully installed blessings 11:21:12 INFO - Cleaning up... 11:21:12 INFO - Return code: 0 11:21:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:21:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:12 INFO - Reading from file tmpfile_stdout 11:21:12 INFO - Current package versions: 11:21:12 INFO - argparse == 1.2.1 11:21:12 INFO - blessings == 1.6 11:21:12 INFO - blobuploader == 1.2.4 11:21:12 INFO - docopt == 0.6.1 11:21:12 INFO - functools32 == 3.2.3-2 11:21:12 INFO - jsonschema == 2.5.1 11:21:12 INFO - manifestparser == 1.1 11:21:12 INFO - mozInstall == 1.13 11:21:12 INFO - mozcrash == 1.0 11:21:12 INFO - mozdebug == 0.1 11:21:12 INFO - mozdevice == 0.51 11:21:12 INFO - mozfile == 1.2 11:21:12 INFO - mozhttpd == 0.7 11:21:12 INFO - mozinfo == 0.10 11:21:12 INFO - mozleak == 0.1 11:21:12 INFO - mozlog == 3.5 11:21:12 INFO - moznetwork == 0.27 11:21:12 INFO - mozprocess == 0.25 11:21:12 INFO - mozprofile == 0.28 11:21:12 INFO - mozrunner == 6.13 11:21:12 INFO - mozscreenshot == 0.1 11:21:12 INFO - mozsystemmonitor == 0.3 11:21:12 INFO - moztest == 0.8 11:21:12 INFO - mozversion == 1.4 11:21:12 INFO - psutil == 3.1.1 11:21:12 INFO - requests == 1.2.3 11:21:12 INFO - wsgiref == 0.1.2 11:21:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:12 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 0xc3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd42a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee30b0>, '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 0xee3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee4440>, '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': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:12 INFO - Using env: {'DISPLAY': ':0', 11:21:12 INFO - 'HOME': '/home/cltbld', 11:21:12 INFO - 'LANG': 'en_US.UTF-8', 11:21:12 INFO - 'LANGUAGE': 'en_US:en', 11:21:12 INFO - 'LOGNAME': 'cltbld', 11:21:12 INFO - 'MAIL': '/var/mail/cltbld', 11:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:12 INFO - 'MOZ_NO_REMOTE': '1', 11:21:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:12 INFO - 'NO_EM_RESTART': '1', 11:21:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:12 INFO - 'PWD': '/builds/slave/test', 11:21:12 INFO - 'SHELL': '/bin/bash', 11:21:12 INFO - 'SHLVL': '1', 11:21:12 INFO - 'TERM': 'linux', 11:21:12 INFO - 'TMOUT': '86400', 11:21:12 INFO - 'USER': 'cltbld', 11:21:12 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 11:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:12 INFO - '_': '/tools/buildbot/bin/python'} 11:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:21:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:21:14 INFO - Installing collected packages: simplejson 11:21:14 INFO - Running setup.py install for simplejson 11:21:14 INFO - building 'simplejson._speedups' extension 11:21:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:21:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:21:15 INFO - Successfully installed simplejson 11:21:15 INFO - Cleaning up... 11:21:15 INFO - Return code: 0 11:21:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc3e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd42a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xee5ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xee30b0>, '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 0xee3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee4440>, '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': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:21:15 INFO - Using env: {'DISPLAY': ':0', 11:21:15 INFO - 'HOME': '/home/cltbld', 11:21:15 INFO - 'LANG': 'en_US.UTF-8', 11:21:15 INFO - 'LANGUAGE': 'en_US:en', 11:21:15 INFO - 'LOGNAME': 'cltbld', 11:21:15 INFO - 'MAIL': '/var/mail/cltbld', 11:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:15 INFO - 'MOZ_NO_REMOTE': '1', 11:21:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:15 INFO - 'NO_EM_RESTART': '1', 11:21:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:15 INFO - 'PWD': '/builds/slave/test', 11:21:15 INFO - 'SHELL': '/bin/bash', 11:21:15 INFO - 'SHLVL': '1', 11:21:15 INFO - 'TERM': 'linux', 11:21:15 INFO - 'TMOUT': '86400', 11:21:15 INFO - 'USER': 'cltbld', 11:21:15 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 11:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:15 INFO - '_': '/tools/buildbot/bin/python'} 11:21:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:21:15 INFO - Cleaning up... 11:21:15 INFO - Return code: 0 11:21:15 INFO - Running post-action listener: _resource_record_post_action 11:21:15 INFO - Running post-action listener: _start_resource_monitoring 11:21:15 INFO - Starting resource monitoring. 11:21:15 INFO - [mozharness: 2017-08-17 18:21:15.654551Z] Finished create-virtualenv step (success) 11:21:15 INFO - [mozharness: 2017-08-17 18:21:15.655061Z] Running install step. 11:21:15 INFO - Running pre-action listener: _resource_record_pre_action 11:21:15 INFO - Running main action method: install 11:21:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:15 INFO - Reading from file tmpfile_stdout 11:21:15 INFO - Detecting whether we're running mozinstall >=1.0... 11:21:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:21:16 INFO - Reading from file tmpfile_stdout 11:21:16 INFO - Output received: 11:21:16 INFO - Usage: mozinstall [options] installer 11:21:16 INFO - Options: 11:21:16 INFO - -h, --help show this help message and exit 11:21:16 INFO - -d DEST, --destination=DEST 11:21:16 INFO - Directory to install application into. [default: 11:21:16 INFO - "/builds/slave/test"] 11:21:16 INFO - --app=APP Application being installed. [default: firefox] 11:21:16 INFO - mkdir: /builds/slave/test/build/application 11:21:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:21:34 INFO - Reading from file tmpfile_stdout 11:21:34 INFO - Output received: 11:21:34 INFO - /builds/slave/test/build/application/firefox/firefox 11:21:34 INFO - Running post-action listener: _resource_record_post_action 11:21:34 INFO - [mozharness: 2017-08-17 18:21:34.032756Z] Finished install step (success) 11:21:34 INFO - [mozharness: 2017-08-17 18:21:34.033039Z] Running setup-mitmproxy step. 11:21:34 INFO - Running pre-action listener: _resource_record_pre_action 11:21:34 INFO - Running main action method: setup_mitmproxy 11:21:34 INFO - Skipping: mitmproxy is not required 11:21:34 INFO - Running post-action listener: _resource_record_post_action 11:21:34 INFO - [mozharness: 2017-08-17 18:21:34.034228Z] Finished setup-mitmproxy step (success) 11:21:34 INFO - [mozharness: 2017-08-17 18:21:34.034450Z] Running run-tests step. 11:21:34 INFO - Running pre-action listener: _resource_record_pre_action 11:21:34 INFO - Running pre-action listener: _set_gcov_prefix 11:21:34 INFO - Running main action method: run_tests 11:21:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:21:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:21:34 INFO - Python 2.7.3 11:21:34 INFO - Return code: 0 11:21:34 INFO - grabbing minidump binary from tooltool 11:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:34 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 0xee30b0>, '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 0xee3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xee4440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:21:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:21:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:21:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:21:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:21:34 INFO - Return code: 0 11:21:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:21:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:21:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:21:34 INFO - ENV: RUST_BACKTRACE is now full 11:21:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:21:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:21:34 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/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:21:34 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/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:21:34 INFO - Using env: {'DISPLAY': ':0', 11:21:34 INFO - 'HOME': '/home/cltbld', 11:21:34 INFO - 'LANG': 'en_US.UTF-8', 11:21:34 INFO - 'LANGUAGE': 'en_US:en', 11:21:34 INFO - 'LOGNAME': 'cltbld', 11:21:34 INFO - 'MAIL': '/var/mail/cltbld', 11:21:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:34 INFO - 'MOZ_NO_REMOTE': '1', 11:21:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:34 INFO - 'NO_EM_RESTART': '1', 11:21:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:34 INFO - 'PWD': '/builds/slave/test', 11:21:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:34 INFO - 'RUST_BACKTRACE': 'full', 11:21:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:21:34 INFO - 'SHELL': '/bin/bash', 11:21:34 INFO - 'SHLVL': '1', 11:21:34 INFO - 'STYLO_FORCE_ENABLED': '1', 11:21:34 INFO - 'TERM': 'linux', 11:21:34 INFO - 'TMOUT': '86400', 11:21:34 INFO - 'USER': 'cltbld', 11:21:34 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330', 11:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:34 INFO - '_': '/tools/buildbot/bin/python'} 11:21:34 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/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:21:34 INFO - mozversion application_buildid: 20170817173127 11:21:34 INFO - mozversion application_changeset: e365137fa61bfd729617ba1ebf9f1ed79facd1f2 11:21:34 INFO - mozversion application_display_name: Nightly 11:21:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:21:34 INFO - mozversion application_name: Firefox 11:21:34 INFO - mozversion application_remotingname: firefox 11:21:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:21:34 INFO - mozversion application_vendor: Mozilla 11:21:34 INFO - mozversion application_version: 57.0a1 11:21:34 INFO - mozversion platform_buildid: 20170817173127 11:21:34 INFO - mozversion platform_changeset: e365137fa61bfd729617ba1ebf9f1ed79facd1f2 11:21:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:21:34 INFO - mozversion platform_version: 57.0a1 11:21:34 INFO - using testdate: 1502994094 11:21:34 INFO - actual date: 1502994094 11:21:34 INFO - starting webserver on 'localhost:55732' 11:21:34 INFO - SUITE-START | Running 2 tests 11:21:34 INFO - TEST-START | dromaeo_css 11:21:34 INFO - Initialising browser for dromaeo_css test... 11:21:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55732/getInfo.html -profile /tmp/tmpPWlSmX/profile 11:21:34 INFO - TEST-INFO | started process 28262 (/builds/slave/test/build/application/firefox/firefox http://localhost:55732/getInfo.html) 11:21:40 INFO - TEST-INFO | 28262: exit 0 11:21:40 INFO - Browser initialized. 11:21:40 INFO - Running cycle 1/1 for dromaeo_css test... 11:21:40 INFO - TEST-INFO | started process 28454 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPWlSmX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:41 INFO - PID 28454 | 11:21:41 INFO - PID 28454 | (/builds/slave/test/build/application/firefox/firefox:28508): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:21:41 INFO - PID 28454 | 11:21:51 INFO - PID 28454 | RSS: Main: 166645760 11:21:51 INFO - PID 28454 | 11:24:50 INFO - PID 28454 | Cycle 1(1): loaded http://localhost:55732/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55732/tests/dromaeo/cssquery-ext.html) 11:24:51 INFO - PID 28454 | RSS: Main: 174202880 11:24:51 INFO - PID 28454 | 11:27:53 INFO - PID 28454 | Cycle 1(1): loaded http://localhost:55732/tests/dromaeo/cssquery-ext.html (next: http://localhost:55732/tests/dromaeo/cssquery-jquery.html) 11:27:54 INFO - PID 28454 | RSS: Main: 172052480 11:27:54 INFO - PID 28454 | 11:30:56 INFO - PID 28454 | Cycle 1(1): loaded http://localhost:55732/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55732/tests/dromaeo/cssquery-mootools.html) 11:30:56 INFO - PID 28454 | RSS: Main: 173658112 11:30:56 INFO - PID 28454 | 11:33:58 INFO - PID 28454 | Cycle 1(1): loaded http://localhost:55732/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55732/tests/dromaeo/cssquery-prototype.html) 11:33:59 INFO - PID 28454 | RSS: Main: 171933696 11:33:59 INFO - PID 28454 | 11:37:03 INFO - PID 28454 | Cycle 1(1): loaded http://localhost:55732/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55732/tests/dromaeo/cssquery-yui.html) 11:37:03 INFO - PID 28454 | RSS: Main: 175566848 11:37:03 INFO - PID 28454 | 11:40:05 INFO - PID 28454 | Cycle 1(1): loaded http://localhost:55732/tests/dromaeo/cssquery-yui.html (next: http://localhost:55732/tests/dromaeo/cssquery-dojo.html) 11:40:05 INFO - PID 28454 | RSS: Main: 176152576 11:40:05 INFO - PID 28454 | 11:40:05 INFO - PID 28454 | __start_tp_report 11:40:05 INFO - PID 28454 | _x_x_mozilla_page_load 11:40:05 INFO - PID 28454 | _x_x_mozilla_page_load_details 11:40:05 INFO - PID 28454 | |i|pagename|runs| 11:40:05 INFO - PID 28454 | |0;dojo.html;3148.2444213388794;3157.6368717597475;3175.269687971765;3190.250291181572;3214.1161180675313;6146.723397447115;6148.415900489452;6169.198004259451;6174.259088909332;6199.34906834782;6050.455459008688;6115.755369785204;6134.539909506782;6150.4157105075055;6166.599171053889;5577.051901176789;5585.469380408865;5588.580856435763;5621.971890140544;5640.943590564103;5649.519790817785;5655.3779084300695;5658.91511627326;5728.882867840752;5743;5634.802781902634;5701.714914254291;5722.456366645162;5722.484976352128;5815.38938411467;5469.617126801126;5580.804671836507;5673.744681489343;5686.5735069869925;5715.8571035724235;5565.499105080562;5630.268065151545;5643.802466913679;5643.830685079413;5673.602847800656;5957.761689532414;6059;6147.415995480422;6170.660613666247;6196.659183744892;6452.903206451907;6569.605823650596;6593.274739778621;6603.108580341641;6693.464522838161;6546.770863019771;6683.398494135503;6688.464922806213;6695.062691223233;6695.096162018114;6204.534659900525;6205.317415084337;6229.345918678564;6233.625982440977;6268.623882567061;6814.114165158498;6824.385805277549;6909.654517274116;6915.377616014583;6921.861562768817;6403;6455.419012288917;6491.8701625967215;6525.282218955911;6551.770688025897;6556.344365563501;6559.573627714183;6560.737570497126;6566.1135746674545;6569.671516424255;6434.903476447857;6454.548181627241;6500.382463665944;6513.2509761377105;6522.380373864476;6543.44380727634;6634.336566343327;6641.402273795382;6642.701078451481;6645.368689974444;5458.399576046631;5461.5357694596405;5473.917891231635;5477.315335583052;5485.75314110858;4623.953760462352;4649.4420669519195;4686.015936653273;4697.342372067913;4709.529047095331;5656.462636049569;5739.765950320701;5768.451997060272;5772.134179873053;5823.242978412779;6598.37315455031;6636.402723754885;6636.734530618721;6642.900356494656;6642.96678516614;5737.082066869364;5765.567582431335;5766.221560089418;5783.421657834183;5784;5799.4780469757925;5817.243758311392;5869.442402971711;5922.970385148046;5933;6457.225132984072;6459.773907913201;6475.7733479328;6562.409383155539;6568.244651865001;6511.869762604816;6647.867042659023;6657.3342665733035;6712.731490740316;6750.72997080131;6393.744250230125;6458.192725909262;6466.902996454963;6472.126262954441;6478.157839481026;6532.118164047793;6582.3746744059235;6590.143281373583;6590.90113648286;6593.868122637617;6657.966710166418;6675.866482670416;6727.966360168168;6729.057931889637;6771.458283337222;6320;6385.776497822554;6390.137331460193;6465.482761379172;6488.416042556192;6317.526185536011;6328.968355158195;6329.556931014785;6334.588251763621;6345.90481142774;6219.533534984804;6278.591891527219;6280.874382512416;6283.874322513616;6291.905621415591;6350.237971443456;6367.968160159355;6374.394432528902;6408.198975128109;6408.359164083555;5479.698616575967;6298.960671489153;6325.810225693236;6389.552731308764;6406.807795766134 11:40:05 INFO - PID 28454 | |1;ext.html;786.9252421020001;833.3041910005145;860.3117505995205;885.1016218538181;886.6409104312753;39692.801535992316;40362.78911632649;40375.59624403759;40412.59587404125;40434.595654043485;37107;37225;37264.81367593165;37461.625383746155;37575;6658.833529161773;6815.38661520463;6815.591064536119;6816.352446517573;6818.386345228929;6675.365840245193;6754.324567543231;6757.594544327331;6759.898601520981;6761.864762704743;7448.180700122982;7603.733869314575;7607.923920760777;7645.655945482439;7686.846263074735;7527.623618819064;7558.508696934737;7596.734114306;7598.0882294124785;7598.392128629696;7321.890171647429;7414.110306763169;7585.051868516435;7593.658285377116;7596.468247222697;37648.24703505915;37836.43245351322;37998;38048.619513804784;38097.23805523902;3501.9474707879403;3554.9466757998653;3562.2163124112653;3569.7322700797286;3577.910552236189;30810.383792324028;30912;30943.381132377228;30943.845280773676;31012;4991.850244492671;5056.115179843549;5059.569936555397;5069.417017043051;5073.162928116856;229540;232935;232965;233849;234584;48360.75819620879;48484;48624.27063594049;48638.756806215744;48693.26960095602;54399.18401223985;55115;55134;55147;55234.723826380614;16420.917895410446;16450.6709865802;16450.6709865802;16607.08661023631;16620;13682.452701892013;13703.588892333246;13725.45098196081;13727.519536816164;13730.794038089436;14117.78823317651;14293.78559321611;14308.928455357865;14356.712865742627;14476.203808790407;5786.884262314814;5792.768289268466;5851.683371241436;5867.853303667357;5868.178455016301;997.9750506237402;1001.9849702254472;1012.1700205831295;1014.6347314966606;1017.9389236645825;23117;23363.76636233616;23448.765512344657;23542.4114397138;23597.646035309484;1050.611273828673;1105.5909313554037;1106.950187241576;1117.6032508459543;1123.3316176874746;12269;12385.504579816707;12396.938015309866;12415.689607759878;12432.440540175714;249892;250257;251697;252367;252785;51170.74414627903;51482.22776658278;51541.742291288305;52023.73988130035;56716.43283567111;1458.117838707588;1459.4818839312104;1488.404638144729;1491.537623336769;1506.0662389318693;27609.585856211772;27996.580051299654;28535.286617833888;28934.42131157323;29023;37880;38188.80905595565;38210.2357952845;38273.4258986121;38305.80847095747;210073;210529;210931;211061;211922;33994.320113598085;34273.82863085669;34371.14072148217;34474;34488.37872023402;44242;44783.55216447794;44795.77602111969;44818;44981.775091124335;32033.007505325546;32169.678303216668;32360.190995224366;32536.186595335304;33031.66968330286;31846.363072737953;31932.840335798173;32445.51331729979;32609.34781304408;32752.34495310128;35002.29995400129;35009.474857876645;35116;35261;38103.42844857274;33013;33364.66635333616;33672.83163584166;33689;33882.152946176546;23674.763252367255;24121.276361709177;24768.25695229146;24990.875045624656;25508 11:40:05 INFO - PID 28454 | |2;jquery.html;552.9004779139754;584.7660935625746;589.8053642298042;590.5659340384818;590.5688847141587;21688.674669879943;22536.211232606864;22565.774342256573;22599.887000564973;22784.8860755696;24667.383315417123;26523.204303870865;26564.203073907764;26582;26709;6483.448906842912;6638.535302528825;6644.734210631569;6650.2352229493745;6658.866822663544;5977.133315669225;6497.707603157869;6506.446952009085;6528.11870397495;6555.803325900207;6441.83895402614;6443.806685799434;6446.452051575622;6456.483481321483;6465.288818229991;6447.903281450782;6454.580452270588;6463.192100987377;6465.450436712885;6484;5986.28164620244;6005;6008.549358798107;6008.579399442041;6033.3664965178905;28915.85542072297;29856.25359366033;30394.392112157853;30563.388732225452;30664.080077597708;1902.5053486093577;1930.8648394612383;1936.1674479973606;1937.6318499485194;1938.4378530226359;19422.22311107554;20038.398848034438;20072.79927200724;20081.497962551053;20088;2381.083282936082;2430.2344761400104;2472.431340791628;2474.7277799442045;2486.5026994601153;136087.31956340253;138731;139797;139935.30032349774;140009;14418.783718244234;14915.179665118305;15171;15300.693986120215;15881.52355429339;23046.15630749536;23680.52638947246;23683;23687.644685329735;23810.523789524457;10110.140638045848;10334.276600637882;10390.272680912263;10421.791564168674;10518.526666300035;9586.424814511152;9670.75823104414;9684.806303873884;9752.609895604239;9768.951155244178;9183.403078799856;9404.435733855991;9495;9514;9562.426254424758;2668.8799004044863;2676.745709157627;2740.8629568521496;2773.486904922596;2777.264025033368;939.2861425316809;965.5932885306045;974.3228456222857;976.8876579193342;976.9023097690316;19875.105620247123;23689.17087901915;24888.37779055538;25051;25069.749302507105;1023.4371095897227;1050.09167070485;1058.4760543531002;1058.7935352606169;1058.8200005999;10869;11202.327860328243;11249;11259.774804503864;11315.151363647594;542059;551155;560972;569553;571279;120348.39825800815;121782;123703.381483092;125627;125815;1239.7148655809215;1271.580378475101;1287.9871201288054;1288.9291088990196;1293.3339330244744;17755.644887101927;17806.643867122842;17975.820241797937;18049;18121.003344816163;59249.70375148096;60296;60639;62883.6855815718;63634;71451.28548714446;72264;72315.63842180755;72437.63781181061;73332.63333683298;14923.477678281208;15290.311935962685;15375.538733838002;15455.53633391;15471.767923480931;24418.633720494563;24503.632445512976;24562.01751929903;24574.139905103235;24876.50246995086;17965.550861228574;18059.909700451415;18157.092145392413;18241.45275641733;18250.178741956377;17396;17953.73069403986;18022.36921707734;18065.548361291072;18129.637407251517;16896;17178.31286748516;17191.57021074483;17281.222344994254;18328.541786455444;14196.716065678835;15145;15251.618709532351;15254.855885808387;15258.771118433011;17971.820281797536;17979.820201797815;18044.2782288707;18094.909525452287;18210.45368638943 11:40:05 INFO - PID 28454 | |3;mootools.html;1366.6856622976716;1430.7067051254487;1443.2062365698866;1447.211269857928;1449.2391494465398;14363.71272574548;14418.49535266266;14937.17845518496;14956.401743930257;15028.098314101147;13997.230152341617;14267.785983210235;14269.35787889545;14292.142471451694;14325.78511322331;2649.350909027286;2706.4181201041774;2708.336457567889;2710.037936532532;2711.9728802712016;2594.455164415466;2674.6389237452986;2711.3221694576355;2711.7423844734717;2720.469508445854;2616.0582190411533;2663.893444262227;2668.5330067238156;2708.3229192701824;2708.9322766930886;2631.184332856811;2637.6439180710645;2642.9207123786123;2657.8936842526177;2658.960115598248;2609.4389706213065;2623.9897639408964;2629.763321301073;2632.9605055924176;2638.4195476995033;13984.650383740387;14119.71760564783;14280.428782848674;14281.357338919774;14288.357023933844;7545.094588649343;7872.212778722139;7882.172371900925;7884.132745398002;7899.723509677134;4954.5293197146575;4969.776360063805;5174.534291913746;5197.1424714922;5213.165893457029;1837.5773572078363;1858.1823997441218;1860.1164446887756;1881.6949237184476;1895.8578106642058;24062.834344909043;24188;24270.878645606834;24285.757142428527;24361.147359842496;6295.150154729145;6505.739770409131;6574.671266436659;6698.296678848748;6726.630035348103;16409.097499637635;16435.506934791974;16436.424725134802;16444;16453.506394808173;7613;7734.419918506134;7741.18717534662;7749.108852482037;7775.727849525239;5642.746076426571;6015.699215039231;6060.2727672678675;6810.523263371517;7111.431085513146;5259.631825772236;5265.368155821326;5362.731863406814;5379.919301210485;5387.542058924957;1515.1060874084344;1527.3279756906925;1538.2078229711708;1551.1701239836634;1555.7821904933319;887.9422837515541;904.0913881549001;906.2795077913075;909.2680392284143;914.5655813488672;7249.130104387507;7286.635668216674;7308.926910730825;7329.853402932018;7503.099628044561;708.1608294171423;713.6931119618614;714.4891402647132;718.8993540904278;725.050184258623;4677.555632214934;5062.898742025139;5169.467459158882;5182.093133701587;5201.141811601119;18874.245030198912;19520.414387568395;19567.8043219566;19762.604747904963;19824.306149284996;17895;20217.696734548994;20288.391348259574;20296.898515507328;20372.69440958387;11016.724581885357;11234.550617975354;11243.381614011309;11245.437728113562;11245.550177992789;8664.48013119215;8698.739037828875;8819.426737262058;9111.134442227978;9163.129502697233;17000.829991699924;17291.481255562354;17715.73426398631;17731.202095905974;18071.096445177427;17690.823091768918;18061.367852125113;18144.274229030692;18396.632067358845;18477.445676629723;11681.182317237712;11769.705757356134;12144.635660930186;12289.44697488633;12292.262464252173;13646;13784;13790.931045344709;13792.724145517233;13798;11249.493772780408;11273.71815704614;11282.266652667551;11383.43082845871;11436.37099959477;11101.50043248072;11142.164337674545;11204.66386008421;11249.550017999516;11351.318920864443;9360.11078947499;9456.19622332082;9470.005649406989;9472.526373681427;9488.667896623585;6528.347165283433;6657.633830139389;6704.497162712719;7142.964285178541;7185;7234.240404757425;7258.818529536804;7289.307515785992;7372.63136843145;7382.630868456448 11:40:05 INFO - PID 28454 | |4;prototype.html;495.3597326251081;499.36955839185066;526.5945222178922;533.1682575182717;536.4715754981343;6144.692765361725;6232.626042437451;6241.875162496747;6277.905831412521;6280.528960327976;5858.1505681676135;6012.789552365668;6042.274927008754;6046.818595442132;6053.697315134248;4876.829310974116;4886.242632391985;4924.187509061001;4934.753262336878;5008.549230569248;4768.165571025074;4912.803487860481;4923.753812309388;4929.531694489017;4975.502449755014;4848.345473361104;4892.706437613754;4896.1186986342445;4906.681065730734;4960.60315174787;4883.243097319921;4887.6089912807065;4942.258661200813;4966.379202599675;4973.254011898208;4441.111777644452;4446.844360447369;4457.7711144427785;4461.732296062214;4462.263726485126;5956.404359564052;5977.491913187384;5984.551158663117;6027.758889644409;6038.667873266969;5677.602567820254;5689.687067211302;5713.371529131792;5720.713964301768;5735.627184233012;6346.921023426029;6402.967985160044;6429.742810287629;6493.837654058639;6519.250286217099;4844.297576851337;4846.127697014536;4858.29554714568;4874.7562621868765;4876.658633895629;6821.624810635413;6852.554583952027;6866.828329291808;6895.310468953115;6952.965235173791;4929.433115191727;4936.975315123402;4981.501849814989;4984.750762461862;5028.924566131511;5010.323606313101;5013.39839219296;5040.042391945592;5070.239464080418;5077.898442031213;5538.086215774352;5702.887936852357;5720.942790572124;5722.456366645162;5743.913841292384;6445.1621289233035;6456.709448074754;6471.870562588816;6521.739130434729;6552.279249282575;1680.386658869504;1714.1943286655253;1715.8198389169206;1717.3388245525314;1766.5406994181606;1203.3201241298639;1209.4980583057932;1230.4278510492663;1232.445399570197;1234.0559472003924;5675.120356344773;5678.346990096109;5718.598943258929;5745.569082318842;5770.221020162308;6519.739210431624;6525.11910892033;6599.769008084694;6629.569078009914;6648.800535983928;5656.745446454919;5703.657780533182;5732.856678583069;5771.740271687784;5784.305883293948;3511.8068506231893;3521.330947120039;3539.752217344761;3573.2496175802853;3595.7662751921043;6538.803835884931;6543.901841472381;6557.901631475532;6579.276279609335;6644.966775166094;6860.965695171592;6870.828229294308;6900.827479313058;6903.963330817421;6970.616616086164;6412.665413984795;6508.3491650835485;6567.376099270562;6569.178852643419;6631.867362652816;6605.636689981905;6696.455346968316;6699.794037073373;6724.865502690017;6754.493412993947;6513.576617520036;6647.700853461509;6670.166229221348;6675.666216689049;6695.058433054554;6449.516286278642;6452.644944561507;6475.222973243052;6510.804675859732;6529;4930.975345123252;4951.925721114114;4952.801887924443;4972.5276098770555;4992.400911890596;6594.736210551524;6656.36764507371;6663.933360666331;6703.564268322543;6713.765018224339;6464;6512.902306465312;6518.784972022458;6537.378948999837;6558.1802274715665;6299.716512756845;6475.870482590228;6517.9348206517325;6536.281009089092;6591.274959754519;6214.378562143749;6308.621482711052;6357.904631430625;6365.745370185141;6398.99247353743;6413.454856337264;6525.053867189136;6527.738890444329;6547.544670748469;6561.639109849004;6198.783042593487;6228.252609686867;6285.009019272703;6301.905471418024;6348.206474190726 11:40:05 INFO - PID 28454 | |5;yui.html;904.0552622509477;916.9587368568414;925.7037747920668;928.4382948316269;933.1648174883477;19312.806871931276;20234.89882550587;20237.494062648442;20255.898720506397;22598.774012259873;21483.355499335004;21974.340769776893;22067.558648827013;22238.221662241824;22274.331770046923;963.4700914497033;996.8155891160159;999.1607050077934;999.7400675824301;1000.8048430556045;973.2505970402785;1052.0584077250855;1059.4332032362688;1069.1179776684228;1070.561069961316;1097.8847221041794;1116.0011789448438;1116.017904244268;1116.1182665694091;1117.022605220432;1079.1259080145107;1095.5453486802967;1098.7088421568292;1098.9890101098968;1099.741560733227;806.4193780478105;811.8416908702806;816.8774683797478;818.0469752738053;819.7171975668385;20128.295509657237;20298.49253768653;20440.795592044036;20443.693344599844;20625.278115265894;21738.456538586503;21768;21941.122355105777;22086.779132208634;22470.550588988128;16746.99518028922;16835.242414091274;17047.659046818993;17075.146242687817;17171.484855454233;3565.0196196046036;3571.3035957988204;3588.372034893883;3603.747737658365;3604.2431089471243;130349.34825325813;132365;132626.336868316;133466;136644.63355366417;17015.82984170167;17296;17313.39403120885;17644.647107057786;17679;31743.682563174072;32097;32942.01173964737;32965.340693186;33140;7891.6054197289905;8288.419810613199;8420.200080992296;8812.559372031374;9269.860952085724;4333.544977777351;4416.955830441654;4443.37792709021;4445.399871017371;4451;5072.923906141411;5237.397699264558;5286.682799031993;5288.762005709752;5304.92042619361;950.6340059077305;967.2842096848423;980.5342462330336;983.2969426859829;984.3503287829998;678.7454704485817;687.6596084937888;696.7631005458169;698.8951657251453;706.0820932787356;11840.407979600985;11875.88124118765;12285.815712764315;12903.677408064686;13343.733125337632;650.778735230024;658.0622612776774;668.7391917152314;668.8762578922915;684.1687349869833;5795.420457954255;5806.390329015392;5829.5044921181325;5844.970775146097;5872.618279811799;112413;112894.43552782347;114307.42846285715;115441;116230;99187;100747;100819;101557.49221253846;101682.49158754159;80892;82681.58659206665;83616.58191709002;85069.57465212759;85428.14571854327;11085.944570277097;11195.104391648485;11328.490217940047;12762.29807360604;13334;39074.804625976685;39820.00449988658;39872.40191397073;40186.39720404138;41388.379174311805;70868;71006;72528.63735681288;73987;77882.6105869467;18531.536711582317;20148.899255503628;20413.285535006202;20562.58874822525;20692.68960965617;23006.539869202858;23015;23111.768882311633;23436.296911092013;23503.882480587486;19096.713549296495;19592.216311347387;19696.40910772679;19702.901485492483;19917.203311867364;20454.590908181457;20460.79539204589;20896.582068358854;20940.47648808792;21025.31664483523;17575.82424175793;17592.29630814753;17630.559236019202;17686.11569421498;17793.288268469634;13695.520656776966;14052;14083.507077252247;14315.856841431452;14370.209638469985;13392.397342119433;14369.13785172893;14721.33753981095;14742.2628868554;14884.925575372054 11:40:05 INFO - PID 28454 | __end_tp_report 11:40:05 INFO - PID 28454 | __start_cc_report 11:40:05 INFO - PID 28454 | _x_x_mozilla_cycle_collect,378 11:40:05 INFO - PID 28454 | __end_cc_report 11:40:05 INFO - PID 28454 | __startTimestamp1502995205787__endTimestamp 11:40:05 INFO - PID 28454 | 11:40:05 INFO - PID 28454 | ------- Summary: start ------- 11:40:05 INFO - PID 28454 | Number of tests: 6 11:40:05 INFO - PID 28454 | 11:40:05 INFO - PID 28454 | [#0] dojo.html Cycles:165 Average:6090.54 Median:6317.53 stddev:701.94 (11.1%) stddev-sans-first:665.06 11:40:05 INFO - PID 28454 | Values: 3148.2 3157.6 3175.3 3190.3 3214.1 6146.7 6148.4 6169.2 6174.3 6199.3 6050.5 6115.8 6134.5 6150.4 6166.6 5577.1 5585.5 5588.6 5622.0 5640.9 5649.5 5655.4 5658.9 5728.9 5743.0 5634.8 5701.7 5722.5 5722.5 5815.4 5469.6 5580.8 5673.7 5686.6 5715.9 5565.5 5630.3 5643.8 5643.8 5673.6 5957.8 6059.0 6147.4 6170.7 6196.7 6452.9 6569.6 6593.3 6603.1 6693.5 6546.8 6683.4 6688.5 6695.1 6695.1 6204.5 6205.3 6229.3 6233.6 6268.6 6814.1 6824.4 6909.7 6915.4 6921.9 6403.0 6455.4 6491.9 6525.3 6551.8 6556.3 6559.6 6560.7 6566.1 6569.7 6434.9 6454.5 6500.4 6513.3 6522.4 6543.4 6634.3 6641.4 6642.7 6645.4 5458.4 5461.5 5473.9 5477.3 5485.8 4624.0 4649.4 4686.0 4697.3 4709.5 5656.5 5739.8 5768.5 5772.1 5823.2 6598.4 6636.4 6636.7 6642.9 6643.0 5737.1 5765.6 5766.2 5783.4 5784.0 5799.5 5817.2 5869.4 5923.0 5933.0 6457.2 6459.8 6475.8 6562.4 6568.2 6511.9 6647.9 6657.3 6712.7 6750.7 6393.7 6458.2 6466.9 6472.1 6478.2 6532.1 6582.4 6590.1 6590.9 6593.9 6658.0 6675.9 6728.0 6729.1 6771.5 6320.0 6385.8 6390.1 6465.5 6488.4 6317.5 6329.0 6329.6 6334.6 6345.9 6219.5 6278.6 6280.9 6283.9 6291.9 6350.2 6368.0 6374.4 6408.2 6408.4 5479.7 6299.0 6325.8 6389.6 6406.8 11:40:05 INFO - PID 28454 | 11:40:05 INFO - PID 28454 | [#1] ext.html Cycles:180 Average:39924.64 Median:19255.71 stddev:60330.16 (313.3%) stddev-sans-first:60427.83 11:40:05 INFO - PID 28454 | Values: 786.9 833.3 860.3 885.1 886.6 39692.8 40362.8 40375.6 40412.6 40434.6 37107.0 37225.0 37264.8 37461.6 37575.0 6658.8 6815.4 6815.6 6816.4 6818.4 6675.4 6754.3 6757.6 6759.9 6761.9 7448.2 7603.7 7607.9 7645.7 7686.8 7527.6 7558.5 7596.7 7598.1 7598.4 7321.9 7414.1 7585.1 7593.7 7596.5 37648.2 37836.4 37998.0 38048.6 38097.2 3501.9 3554.9 3562.2 3569.7 3577.9 30810.4 30912.0 30943.4 30943.8 31012.0 4991.9 5056.1 5059.6 5069.4 5073.2 229540.0 232935.0 232965.0 233849.0 234584.0 48360.8 48484.0 48624.3 48638.8 48693.3 54399.2 55115.0 55134.0 55147.0 55234.7 16420.9 16450.7 16450.7 16607.1 16620.0 13682.5 13703.6 13725.5 13727.5 13730.8 14117.8 14293.8 14308.9 14356.7 14476.2 5786.9 5792.8 5851.7 5867.9 5868.2 998.0 1002.0 1012.2 1014.6 1017.9 23117.0 23363.8 23448.8 23542.4 23597.6 1050.6 1105.6 1107.0 1117.6 1123.3 12269.0 12385.5 12396.9 12415.7 12432.4 249892.0 250257.0 251697.0 252367.0 252785.0 51170.7 51482.2 51541.7 52023.7 56716.4 1458.1 1459.5 1488.4 1491.5 1506.1 27609.6 27996.6 28535.3 28934.4 29023.0 37880.0 38188.8 38210.2 38273.4 38305.8 210073.0 210529.0 210931.0 211061.0 211922.0 33994.3 34273.8 34371.1 34474.0 34488.4 44242.0 44783.6 44795.8 44818.0 44981.8 32033.0 32169.7 32360.2 32536.2 33031.7 31846.4 31932.8 32445.5 32609.3 32752.3 35002.3 35009.5 35116.0 35261.0 38103.4 33013.0 33364.7 33672.8 33689.0 33882.2 23674.8 24121.3 24768.3 24990.9 25508.0 11:40:05 INFO - PID 28454 | 11:40:05 INFO - PID 28454 | [#2] jquery.html Cycles:180 Average:37335.97 Median:13035.13 stddev:93522.35 (717.5%) stddev-sans-first:93743.93 11:40:05 INFO - PID 28454 | Values: 552.9 584.8 589.8 590.6 590.6 21688.7 22536.2 22565.8 22599.9 22784.9 24667.4 26523.2 26564.2 26582.0 26709.0 6483.4 6638.5 6644.7 6650.2 6658.9 5977.1 6497.7 6506.4 6528.1 6555.8 6441.8 6443.8 6446.5 6456.5 6465.3 6447.9 6454.6 6463.2 6465.5 6484.0 5986.3 6005.0 6008.5 6008.6 6033.4 28915.9 29856.3 30394.4 30563.4 30664.1 1902.5 1930.9 1936.2 1937.6 1938.4 19422.2 20038.4 20072.8 20081.5 20088.0 2381.1 2430.2 2472.4 2474.7 2486.5 136087.3 138731.0 139797.0 139935.3 140009.0 14418.8 14915.2 15171.0 15300.7 15881.5 23046.2 23680.5 23683.0 23687.6 23810.5 10110.1 10334.3 10390.3 10421.8 10518.5 9586.4 9670.8 9684.8 9752.6 9769.0 9183.4 9404.4 9495.0 9514.0 9562.4 2668.9 2676.7 2740.9 2773.5 2777.3 939.3 965.6 974.3 976.9 976.9 19875.1 23689.2 24888.4 25051.0 25069.7 1023.4 1050.1 1058.5 1058.8 1058.8 10869.0 11202.3 11249.0 11259.8 11315.2 542059.0 551155.0 560972.0 569553.0 571279.0 120348.4 121782.0 123703.4 125627.0 125815.0 1239.7 1271.6 1288.0 1288.9 1293.3 17755.6 17806.6 17975.8 18049.0 18121.0 59249.7 60296.0 60639.0 62883.7 63634.0 71451.3 72264.0 72315.6 72437.6 73332.6 14923.5 15290.3 15375.5 15455.5 15471.8 24418.6 24503.6 24562.0 24574.1 24876.5 17965.6 18059.9 18157.1 18241.5 18250.2 17396.0 17953.7 18022.4 18065.5 18129.6 16896.0 17178.3 17191.6 17281.2 18328.5 14196.7 15145.0 15251.6 15254.9 15258.8 17971.8 17979.8 18044.3 18094.9 18210.5 11:40:05 INFO - PID 28454 | 11:40:05 INFO - PID 28454 | [#3] mootools.html Cycles:180 Average:8942.39 Median:2632.07 stddev:6203.19 (235.7%) stddev-sans-first:6194.47 11:40:05 INFO - PID 28454 | Values: 1366.7 1430.7 1443.2 1447.2 1449.2 14363.7 14418.5 14937.2 14956.4 15028.1 13997.2 14267.8 14269.4 14292.1 14325.8 2649.4 2706.4 2708.3 2710.0 2712.0 2594.5 2674.6 2711.3 2711.7 2720.5 2616.1 2663.9 2668.5 2708.3 2708.9 2631.2 2637.6 2642.9 2657.9 2659.0 2609.4 2624.0 2629.8 2633.0 2638.4 13984.7 14119.7 14280.4 14281.4 14288.4 7545.1 7872.2 7882.2 7884.1 7899.7 4954.5 4969.8 5174.5 5197.1 5213.2 1837.6 1858.2 1860.1 1881.7 1895.9 24062.8 24188.0 24270.9 24285.8 24361.1 6295.2 6505.7 6574.7 6698.3 6726.6 16409.1 16435.5 16436.4 16444.0 16453.5 7613.0 7734.4 7741.2 7749.1 7775.7 5642.7 6015.7 6060.3 6810.5 7111.4 5259.6 5265.4 5362.7 5379.9 5387.5 1515.1 1527.3 1538.2 1551.2 1555.8 887.9 904.1 906.3 909.3 914.6 7249.1 7286.6 7308.9 7329.9 7503.1 708.2 713.7 714.5 718.9 725.1 4677.6 5062.9 5169.5 5182.1 5201.1 18874.2 19520.4 19567.8 19762.6 19824.3 17895.0 20217.7 20288.4 20296.9 20372.7 11016.7 11234.6 11243.4 11245.4 11245.6 8664.5 8698.7 8819.4 9111.1 9163.1 17000.8 17291.5 17715.7 17731.2 18071.1 17690.8 18061.4 18144.3 18396.6 18477.4 11681.2 11769.7 12144.6 12289.4 12292.3 13646.0 13784.0 13790.9 13792.7 13798.0 11249.5 11273.7 11282.3 11383.4 11436.4 11101.5 11142.2 11204.7 11249.6 11351.3 9360.1 9456.2 9470.0 9472.5 9488.7 6528.3 6657.6 6704.5 7143.0 7185.0 7234.2 7258.8 7289.3 7372.6 7382.6 11:40:05 INFO - PID 28454 | 11:40:05 INFO - PID 28454 | [#4] prototype.html Cycles:180 Average:5473.33 Median:6033.21 stddev:1537.80 (25.5%) stddev-sans-first:1496.04 11:40:05 INFO - PID 28454 | Values: 495.4 499.4 526.6 533.2 536.5 6144.7 6232.6 6241.9 6277.9 6280.5 5858.2 6012.8 6042.3 6046.8 6053.7 4876.8 4886.2 4924.2 4934.8 5008.5 4768.2 4912.8 4923.8 4929.5 4975.5 4848.3 4892.7 4896.1 4906.7 4960.6 4883.2 4887.6 4942.3 4966.4 4973.3 4441.1 4446.8 4457.8 4461.7 4462.3 5956.4 5977.5 5984.6 6027.8 6038.7 5677.6 5689.7 5713.4 5720.7 5735.6 6346.9 6403.0 6429.7 6493.8 6519.3 4844.3 4846.1 4858.3 4874.8 4876.7 6821.6 6852.6 6866.8 6895.3 6953.0 4929.4 4937.0 4981.5 4984.8 5028.9 5010.3 5013.4 5040.0 5070.2 5077.9 5538.1 5702.9 5720.9 5722.5 5743.9 6445.2 6456.7 6471.9 6521.7 6552.3 1680.4 1714.2 1715.8 1717.3 1766.5 1203.3 1209.5 1230.4 1232.4 1234.1 5675.1 5678.3 5718.6 5745.6 5770.2 6519.7 6525.1 6599.8 6629.6 6648.8 5656.7 5703.7 5732.9 5771.7 5784.3 3511.8 3521.3 3539.8 3573.2 3595.8 6538.8 6543.9 6557.9 6579.3 6645.0 6861.0 6870.8 6900.8 6904.0 6970.6 6412.7 6508.3 6567.4 6569.2 6631.9 6605.6 6696.5 6699.8 6724.9 6754.5 6513.6 6647.7 6670.2 6675.7 6695.1 6449.5 6452.6 6475.2 6510.8 6529.0 4931.0 4951.9 4952.8 4972.5 4992.4 6594.7 6656.4 6663.9 6703.6 6713.8 6464.0 6512.9 6518.8 6537.4 6558.2 6299.7 6475.9 6517.9 6536.3 6591.3 6214.4 6308.6 6357.9 6365.7 6399.0 6413.5 6525.1 6527.7 6547.5 6561.6 6198.8 6228.3 6285.0 6301.9 6348.2 11:40:05 INFO - PID 28454 | 11:40:05 INFO - PID 28454 | [#5] yui.html Cycles:180 Average:24639.12 Median:21854.56 stddev:33195.46 (151.9%) stddev-sans-first:33240.74 11:40:05 INFO - PID 28454 | Values: 904.1 917.0 925.7 928.4 933.2 19312.8 20234.9 20237.5 20255.9 22598.8 21483.4 21974.3 22067.6 22238.2 22274.3 963.5 996.8 999.2 999.7 1000.8 973.3 1052.1 1059.4 1069.1 1070.6 1097.9 1116.0 1116.0 1116.1 1117.0 1079.1 1095.5 1098.7 1099.0 1099.7 806.4 811.8 816.9 818.0 819.7 20128.3 20298.5 20440.8 20443.7 20625.3 21738.5 21768.0 21941.1 22086.8 22470.6 16747.0 16835.2 17047.7 17075.1 17171.5 3565.0 3571.3 3588.4 3603.7 3604.2 130349.3 132365.0 132626.3 133466.0 136644.6 17015.8 17296.0 17313.4 17644.6 17679.0 31743.7 32097.0 32942.0 32965.3 33140.0 7891.6 8288.4 8420.2 8812.6 9269.9 4333.5 4417.0 4443.4 4445.4 4451.0 5072.9 5237.4 5286.7 5288.8 5304.9 950.6 967.3 980.5 983.3 984.4 678.7 687.7 696.8 698.9 706.1 11840.4 11875.9 12285.8 12903.7 13343.7 650.8 658.1 668.7 668.9 684.2 5795.4 5806.4 5829.5 5845.0 5872.6 112413.0 112894.4 114307.4 115441.0 116230.0 99187.0 100747.0 100819.0 101557.5 101682.5 80892.0 82681.6 83616.6 85069.6 85428.1 11085.9 11195.1 11328.5 12762.3 13334.0 39074.8 39820.0 39872.4 40186.4 41388.4 70868.0 71006.0 72528.6 73987.0 77882.6 18531.5 20148.9 20413.3 20562.6 20692.7 23006.5 23015.0 23111.8 23436.3 23503.9 19096.7 19592.2 19696.4 19702.9 19917.2 20454.6 20460.8 20896.6 20940.5 21025.3 17575.8 17592.3 17630.6 17686.1 17793.3 13695.5 14052.0 14083.5 14315.9 14370.2 13392.4 14369.1 14721.3 14742.3 14884.9 11:40:05 INFO - PID 28454 | -------- Summary: end -------- 11:40:05 INFO - PID 28454 | 11:40:06 INFO - TEST-INFO | 28454: exit 0 11:40:06 INFO - TEST-OK | dromaeo_css | took 1112005ms 11:40:06 INFO - TEST-START | kraken 11:40:06 INFO - Initialising browser for kraken test... 11:40:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55732/getInfo.html -profile /tmp/tmpPhEZN7/profile 11:40:06 INFO - TEST-INFO | started process 28830 (/builds/slave/test/build/application/firefox/firefox http://localhost:55732/getInfo.html) 11:40:11 INFO - TEST-INFO | 28830: exit 0 11:40:11 INFO - Browser initialized. 11:40:11 INFO - Running cycle 1/1 for kraken test... 11:40:11 INFO - TEST-INFO | started process 29023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPhEZN7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:12 INFO - PID 29023 | 11:40:12 INFO - PID 29023 | (/builds/slave/test/build/application/firefox/firefox:29077): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:40:12 INFO - PID 29023 | 11:40:23 INFO - PID 29023 | RSS: Main: 170311680 11:40:23 INFO - PID 29023 | 11:40:26 INFO - PID 29023 | Cycle 1(1): loaded http://localhost:55732/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55732/tests/kraken/driver.html?testName=audio-beat-detection) 11:40:26 INFO - PID 29023 | RSS: Main: 176078848 11:40:26 INFO - PID 29023 | 11:40:29 INFO - PID 29023 | Cycle 1(1): loaded http://localhost:55732/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55732/tests/kraken/driver.html?testName=audio-dft) 11:40:30 INFO - PID 29023 | RSS: Main: 180211712 11:40:30 INFO - PID 29023 | 11:40:33 INFO - PID 29023 | Cycle 1(1): loaded http://localhost:55732/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55732/tests/kraken/driver.html?testName=audio-fft) 11:40:33 INFO - PID 29023 | RSS: Main: 174358528 11:40:33 INFO - PID 29023 | 11:40:36 INFO - PID 29023 | Cycle 1(1): loaded http://localhost:55732/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55732/tests/kraken/driver.html?testName=audio-oscillator) 11:40:36 INFO - PID 29023 | RSS: Main: 174968832 11:40:36 INFO - PID 29023 | 11:40:39 INFO - PID 29023 | Cycle 1(1): loaded http://localhost:55732/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55732/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:40:39 INFO - PID 29023 | RSS: Main: 175390720 11:40:39 INFO - PID 29023 | 11:40:42 INFO - PID 29023 | Cycle 1(1): loaded http://localhost:55732/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55732/tests/kraken/driver.html?testName=imaging-darkroom) 11:40:43 INFO - PID 29023 | RSS: Main: 176209920 11:40:43 INFO - PID 29023 | 11:40:46 INFO - PID 29023 | Cycle 1(1): loaded http://localhost:55732/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55732/tests/kraken/driver.html?testName=imaging-desaturate) 11:40:47 INFO - PID 29023 | RSS: Main: 176234496 11:40:47 INFO - PID 29023 | 11:40:50 INFO - PID 29023 | Cycle 1(1): loaded http://localhost:55732/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55732/tests/kraken/driver.html?testName=json-parse-financial) 11:40:51 INFO - PID 29023 | RSS: Main: 176984064 11:40:51 INFO - PID 29023 | 11:40:52 INFO - PID 29023 | Cycle 1(1): loaded http://localhost:55732/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55732/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:40:53 INFO - PID 29023 | RSS: Main: 177037312 11:40:53 INFO - PID 29023 | 11:40:55 INFO - PID 29023 | Cycle 1(1): loaded http://localhost:55732/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55732/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:40:55 INFO - PID 29023 | RSS: Main: 174219264 11:40:55 INFO - PID 29023 | 11:40:58 INFO - PID 29023 | Cycle 1(1): loaded http://localhost:55732/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55732/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:40:58 INFO - PID 29023 | RSS: Main: 173805568 11:40:58 INFO - PID 29023 | 11:41:01 INFO - PID 29023 | Cycle 1(1): loaded http://localhost:55732/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55732/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:41:02 INFO - PID 29023 | RSS: Main: 173813760 11:41:02 INFO - PID 29023 | 11:41:05 INFO - PID 29023 | Cycle 1(1): loaded http://localhost:55732/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55732/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:41:05 INFO - PID 29023 | RSS: Main: 174698496 11:41:05 INFO - PID 29023 | 11:41:07 INFO - PID 29023 | Cycle 1(1): loaded http://localhost:55732/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55732/tests/kraken/driver.html?testName=ai-astar) 11:41:08 INFO - PID 29023 | RSS: Main: 175493120 11:41:08 INFO - PID 29023 | 11:41:08 INFO - PID 29023 | __start_tp_report 11:41:08 INFO - PID 29023 | _x_x_mozilla_page_load 11:41:08 INFO - PID 29023 | _x_x_mozilla_page_load_details 11:41:08 INFO - PID 29023 | |i|pagename|runs| 11:41:08 INFO - PID 29023 | |0;ai-astar;109;108;110;107;114;107;111;105;109;108 11:41:08 INFO - PID 29023 | |1;audio-beat-detection;145;117;148;165;122;152;143;121;176;121 11:41:08 INFO - PID 29023 | |2;audio-dft;163;161;171;161;164;163;166;175;163;164 11:41:08 INFO - PID 29023 | |3;audio-fft;81;75;76;164;75;77;76;84;97;76 11:41:08 INFO - PID 29023 | |4;audio-oscillator;81;80;142;82;85;79;125;85;83;129 11:41:08 INFO - PID 29023 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;119;118 11:41:08 INFO - PID 29023 | |6;imaging-darkroom;151;150;150;151;152;150;151;148;149;154 11:41:08 INFO - PID 29023 | |7;imaging-desaturate;98;93;100;94;93;94;94;94;98;98 11:41:08 INFO - PID 29023 | |8;json-parse-financial;59;53;58;58;53;53;52;53;53;59 11:41:08 INFO - PID 29023 | |9;json-stringify-tinderbox;54;55;54;54;54;62;55;59;62;63 11:41:08 INFO - PID 29023 | |10;stanford-crypto-aes;77;75;76;76;76;81;75;86;77;76 11:41:08 INFO - PID 29023 | |11;stanford-crypto-ccm;130;121;125;122;118;131;120;133;120;157 11:41:08 INFO - PID 29023 | |12;stanford-crypto-pbkdf2;179;183;178;190;184;183;175;187;179;172 11:41:08 INFO - PID 29023 | |13;stanford-crypto-sha256-iterative;74;69;69;69;69;73;69;67;69;66 11:41:08 INFO - PID 29023 | __end_tp_report 11:41:08 INFO - PID 29023 | __start_cc_report 11:41:08 INFO - PID 29023 | _x_x_mozilla_cycle_collect,979 11:41:08 INFO - PID 29023 | __end_cc_report 11:41:08 INFO - PID 29023 | __startTimestamp1502995268048__endTimestamp 11:41:08 INFO - PID 29023 | 11:41:08 INFO - PID 29023 | ------- Summary: start ------- 11:41:08 INFO - PID 29023 | Number of tests: 14 11:41:08 INFO - PID 29023 | 11:41:08 INFO - PID 29023 | [#0] ai-astar Cycles:10 Average:108.80 Median:109.00 stddev:2.49 (2.3%) stddev-sans-first:2.64 11:41:08 INFO - PID 29023 | Values: 109.0 108.0 110.0 107.0 114.0 107.0 111.0 105.0 109.0 108.0 11:41:08 INFO - PID 29023 | 11:41:08 INFO - PID 29023 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:146.50 stddev:20.35 (13.9%) stddev-sans-first:21.54 11:41:08 INFO - PID 29023 | Values: 145.0 117.0 148.0 165.0 122.0 152.0 143.0 121.0 176.0 121.0 11:41:08 INFO - PID 29023 | 11:41:08 INFO - PID 29023 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.00 stddev:4.51 (2.7%) stddev-sans-first:4.72 11:41:08 INFO - PID 29023 | Values: 163.0 161.0 171.0 161.0 164.0 163.0 166.0 175.0 163.0 164.0 11:41:08 INFO - PID 29023 | 11:41:08 INFO - PID 29023 | [#3] audio-fft Cycles:10 Average:88.10 Median:76.50 stddev:27.51 (36.0%) stddev-sans-first:29.06 11:41:08 INFO - PID 29023 | Values: 81.0 75.0 76.0 164.0 75.0 77.0 76.0 84.0 97.0 76.0 11:41:08 INFO - PID 29023 | 11:41:08 INFO - PID 29023 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:81.50 stddev:24.52 (30.1%) stddev-sans-first:25.31 11:41:08 INFO - PID 29023 | Values: 81.0 80.0 142.0 82.0 85.0 79.0 125.0 85.0 83.0 129.0 11:41:08 INFO - PID 29023 | 11:41:08 INFO - PID 29023 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 11:41:08 INFO - PID 29023 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 119.0 118.0 11:41:08 INFO - PID 29023 | 11:41:08 INFO - PID 29023 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:1.65 (1.1%) stddev-sans-first:1.74 11:41:08 INFO - PID 29023 | Values: 151.0 150.0 150.0 151.0 152.0 150.0 151.0 148.0 149.0 154.0 11:41:08 INFO - PID 29023 | 11:41:08 INFO - PID 29023 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:94.00 stddev:2.59 (2.8%) stddev-sans-first:2.60 11:41:08 INFO - PID 29023 | Values: 98.0 93.0 100.0 94.0 93.0 94.0 94.0 94.0 98.0 98.0 11:41:08 INFO - PID 29023 | 11:41:08 INFO - PID 29023 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.50 stddev:2.96 (5.3%) stddev-sans-first:2.78 11:41:08 INFO - PID 29023 | Values: 59.0 53.0 58.0 58.0 53.0 53.0 52.0 53.0 53.0 59.0 11:41:08 INFO - PID 29023 | 11:41:08 INFO - PID 29023 | [#9] json-stringify-tinderbox Cycles:10 Average:57.20 Median:57.00 stddev:3.85 (6.8%) stddev-sans-first:3.91 11:41:08 INFO - PID 29023 | Values: 54.0 55.0 54.0 54.0 54.0 62.0 55.0 59.0 62.0 63.0 11:41:08 INFO - PID 29023 | 11:41:08 INFO - PID 29023 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:76.50 stddev:3.44 (4.5%) stddev-sans-first:3.64 11:41:08 INFO - PID 29023 | Values: 77.0 75.0 76.0 76.0 76.0 81.0 75.0 86.0 77.0 76.0 11:41:08 INFO - PID 29023 | 11:41:08 INFO - PID 29023 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:127.50 stddev:11.55 (9.1%) stddev-sans-first:12.22 11:41:08 INFO - PID 29023 | Values: 130.0 121.0 125.0 122.0 118.0 131.0 120.0 133.0 120.0 157.0 11:41:08 INFO - PID 29023 | 11:41:08 INFO - PID 29023 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.00 Median:183.00 stddev:5.46 (3.0%) stddev-sans-first:5.74 11:41:08 INFO - PID 29023 | Values: 179.0 183.0 178.0 190.0 184.0 183.0 175.0 187.0 179.0 172.0 11:41:08 INFO - PID 29023 | 11:41:08 INFO - PID 29023 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.00 stddev:2.41 (3.5%) stddev-sans-first:1.90 11:41:08 INFO - PID 29023 | Values: 74.0 69.0 69.0 69.0 69.0 73.0 69.0 67.0 69.0 66.0 11:41:08 INFO - PID 29023 | -------- Summary: end -------- 11:41:08 INFO - PID 29023 | 11:41:08 INFO - PID 29023 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:41:08 INFO - TEST-INFO | 29023: exit 0 11:41:08 INFO - TEST-OK | kraken | took 62490ms 11:41:08 INFO - SUITE-END | took 1174s 11:41:09 INFO - Completed test suite (00:19:34) 11:41:09 INFO - javascript benchmark 11:41:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8556.557520171196, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3148.2444213388794, 3157.6368717597475, 3175.269687971765, 3190.250291181572, 3214.1161180675313, 6146.723397447115, 6148.415900489452, 6169.198004259451, 6174.259088909332, 6199.34906834782, 6050.455459008688, 6115.755369785204, 6134.539909506782, 6150.4157105075055, 6166.599171053889, 5577.051901176789, 5585.469380408865, 5588.580856435763, 5621.971890140544, 5640.943590564103, 5649.519790817785, 5655.3779084300695, 5658.91511627326, 5728.882867840752, 5743.0, 5634.802781902634, 5701.714914254291, 5722.456366645162, 5722.484976352128, 5815.38938411467, 5469.617126801126, 5580.804671836507, 5673.744681489343, 5686.5735069869925, 5715.8571035724235, 5565.499105080562, 5630.268065151545, 5643.802466913679, 5643.830685079413, 5673.602847800656, 5957.761689532414, 6059.0, 6147.415995480422, 6170.660613666247, 6196.659183744892, 6452.903206451907, 6569.605823650596, 6593.274739778621, 6603.108580341641, 6693.464522838161, 6546.770863019771, 6683.398494135503, 6688.464922806213, 6695.062691223233, 6695.096162018114, 6204.534659900525, 6205.317415084337, 6229.345918678564, 6233.625982440977, 6268.623882567061, 6814.114165158498, 6824.385805277549, 6909.654517274116, 6915.377616014583, 6921.861562768817, 6403.0, 6455.419012288917, 6491.8701625967215, 6525.282218955911, 6551.770688025897, 6556.344365563501, 6559.573627714183, 6560.737570497126, 6566.1135746674545, 6569.671516424255, 6434.903476447857, 6454.548181627241, 6500.382463665944, 6513.2509761377105, 6522.380373864476, 6543.44380727634, 6634.336566343327, 6641.402273795382, 6642.701078451481, 6645.368689974444, 5458.399576046631, 5461.5357694596405, 5473.917891231635, 5477.315335583052, 5485.75314110858, 4623.953760462352, 4649.4420669519195, 4686.015936653273, 4697.342372067913, 4709.529047095331, 5656.462636049569, 5739.765950320701, 5768.451997060272, 5772.134179873053, 5823.242978412779, 6598.37315455031, 6636.402723754885, 6636.734530618721, 6642.900356494656, 6642.96678516614, 5737.082066869364, 5765.567582431335, 5766.221560089418, 5783.421657834183, 5784.0, 5799.4780469757925, 5817.243758311392, 5869.442402971711, 5922.970385148046, 5933.0, 6457.225132984072, 6459.773907913201, 6475.7733479328, 6562.409383155539, 6568.244651865001, 6511.869762604816, 6647.867042659023, 6657.3342665733035, 6712.731490740316, 6750.72997080131, 6393.744250230125, 6458.192725909262, 6466.902996454963, 6472.126262954441, 6478.157839481026, 6532.118164047793, 6582.3746744059235, 6590.143281373583, 6590.90113648286, 6593.868122637617, 6657.966710166418, 6675.866482670416, 6727.966360168168, 6729.057931889637, 6771.458283337222, 6320.0, 6385.776497822554, 6390.137331460193, 6465.482761379172, 6488.416042556192, 6317.526185536011, 6328.968355158195, 6329.556931014785, 6334.588251763621, 6345.90481142774, 6219.533534984804, 6278.591891527219, 6280.874382512416, 6283.874322513616, 6291.905621415591, 6350.237971443456, 6367.968160159355, 6374.394432528902, 6408.198975128109, 6408.359164083555, 5479.698616575967, 6298.960671489153, 6325.810225693236, 6389.552731308764, 6406.807795766134], "value": 6039.694375438948, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.9252421020001, 833.3041910005145, 860.3117505995205, 885.1016218538181, 886.6409104312753, 39692.801535992316, 40362.78911632649, 40375.59624403759, 40412.59587404125, 40434.595654043485, 37107.0, 37225.0, 37264.81367593165, 37461.625383746155, 37575.0, 6658.833529161773, 6815.38661520463, 6815.591064536119, 6816.352446517573, 6818.386345228929, 6675.365840245193, 6754.324567543231, 6757.594544327331, 6759.898601520981, 6761.864762704743, 7448.180700122982, 7603.733869314575, 7607.923920760777, 7645.655945482439, 7686.846263074735, 7527.623618819064, 7558.508696934737, 7596.734114306, 7598.0882294124785, 7598.392128629696, 7321.890171647429, 7414.110306763169, 7585.051868516435, 7593.658285377116, 7596.468247222697, 37648.24703505915, 37836.43245351322, 37998.0, 38048.619513804784, 38097.23805523902, 3501.9474707879403, 3554.9466757998653, 3562.2163124112653, 3569.7322700797286, 3577.910552236189, 30810.383792324028, 30912.0, 30943.381132377228, 30943.845280773676, 31012.0, 4991.850244492671, 5056.115179843549, 5059.569936555397, 5069.417017043051, 5073.162928116856, 229540.0, 232935.0, 232965.0, 233849.0, 234584.0, 48360.75819620879, 48484.0, 48624.27063594049, 48638.756806215744, 48693.26960095602, 54399.18401223985, 55115.0, 55134.0, 55147.0, 55234.723826380614, 16420.917895410446, 16450.6709865802, 16450.6709865802, 16607.08661023631, 16620.0, 13682.452701892013, 13703.588892333246, 13725.45098196081, 13727.519536816164, 13730.794038089436, 14117.78823317651, 14293.78559321611, 14308.928455357865, 14356.712865742627, 14476.203808790407, 5786.884262314814, 5792.768289268466, 5851.683371241436, 5867.853303667357, 5868.178455016301, 997.9750506237402, 1001.9849702254472, 1012.1700205831295, 1014.6347314966606, 1017.9389236645825, 23117.0, 23363.76636233616, 23448.765512344657, 23542.4114397138, 23597.646035309484, 1050.611273828673, 1105.5909313554037, 1106.950187241576, 1117.6032508459543, 1123.3316176874746, 12269.0, 12385.504579816707, 12396.938015309866, 12415.689607759878, 12432.440540175714, 249892.0, 250257.0, 251697.0, 252367.0, 252785.0, 51170.74414627903, 51482.22776658278, 51541.742291288305, 52023.73988130035, 56716.43283567111, 1458.117838707588, 1459.4818839312104, 1488.404638144729, 1491.537623336769, 1506.0662389318693, 27609.585856211772, 27996.580051299654, 28535.286617833888, 28934.42131157323, 29023.0, 37880.0, 38188.80905595565, 38210.2357952845, 38273.4258986121, 38305.80847095747, 210073.0, 210529.0, 210931.0, 211061.0, 211922.0, 33994.320113598085, 34273.82863085669, 34371.14072148217, 34474.0, 34488.37872023402, 44242.0, 44783.55216447794, 44795.77602111969, 44818.0, 44981.775091124335, 32033.007505325546, 32169.678303216668, 32360.190995224366, 32536.186595335304, 33031.66968330286, 31846.363072737953, 31932.840335798173, 32445.51331729979, 32609.34781304408, 32752.34495310128, 35002.29995400129, 35009.474857876645, 35116.0, 35261.0, 38103.42844857274, 33013.0, 33364.66635333616, 33672.83163584166, 33689.0, 33882.152946176546, 23674.763252367255, 24121.276361709177, 24768.25695229146, 24990.875045624656, 25508.0], "value": 17368.707925186358, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.9004779139754, 584.7660935625746, 589.8053642298042, 590.5659340384818, 590.5688847141587, 21688.674669879943, 22536.211232606864, 22565.774342256573, 22599.887000564973, 22784.8860755696, 24667.383315417123, 26523.204303870865, 26564.203073907764, 26582.0, 26709.0, 6483.448906842912, 6638.535302528825, 6644.734210631569, 6650.2352229493745, 6658.866822663544, 5977.133315669225, 6497.707603157869, 6506.446952009085, 6528.11870397495, 6555.803325900207, 6441.83895402614, 6443.806685799434, 6446.452051575622, 6456.483481321483, 6465.288818229991, 6447.903281450782, 6454.580452270588, 6463.192100987377, 6465.450436712885, 6484.0, 5986.28164620244, 6005.0, 6008.549358798107, 6008.579399442041, 6033.3664965178905, 28915.85542072297, 29856.25359366033, 30394.392112157853, 30563.388732225452, 30664.080077597708, 1902.5053486093577, 1930.8648394612383, 1936.1674479973606, 1937.6318499485194, 1938.4378530226359, 19422.22311107554, 20038.398848034438, 20072.79927200724, 20081.497962551053, 20088.0, 2381.083282936082, 2430.2344761400104, 2472.431340791628, 2474.7277799442045, 2486.5026994601153, 136087.31956340253, 138731.0, 139797.0, 139935.30032349774, 140009.0, 14418.783718244234, 14915.179665118305, 15171.0, 15300.693986120215, 15881.52355429339, 23046.15630749536, 23680.52638947246, 23683.0, 23687.644685329735, 23810.523789524457, 10110.140638045848, 10334.276600637882, 10390.272680912263, 10421.791564168674, 10518.526666300035, 9586.424814511152, 9670.75823104414, 9684.806303873884, 9752.609895604239, 9768.951155244178, 9183.403078799856, 9404.435733855991, 9495.0, 9514.0, 9562.426254424758, 2668.8799004044863, 2676.745709157627, 2740.8629568521496, 2773.486904922596, 2777.264025033368, 939.2861425316809, 965.5932885306045, 974.3228456222857, 976.8876579193342, 976.9023097690316, 19875.105620247123, 23689.17087901915, 24888.37779055538, 25051.0, 25069.749302507105, 1023.4371095897227, 1050.09167070485, 1058.4760543531002, 1058.7935352606169, 1058.8200005999, 10869.0, 11202.327860328243, 11249.0, 11259.774804503864, 11315.151363647594, 542059.0, 551155.0, 560972.0, 569553.0, 571279.0, 120348.39825800815, 121782.0, 123703.381483092, 125627.0, 125815.0, 1239.7148655809215, 1271.580378475101, 1287.9871201288054, 1288.9291088990196, 1293.3339330244744, 17755.644887101927, 17806.643867122842, 17975.820241797937, 18049.0, 18121.003344816163, 59249.70375148096, 60296.0, 60639.0, 62883.6855815718, 63634.0, 71451.28548714446, 72264.0, 72315.63842180755, 72437.63781181061, 73332.63333683298, 14923.477678281208, 15290.311935962685, 15375.538733838002, 15455.53633391, 15471.767923480931, 24418.633720494563, 24503.632445512976, 24562.01751929903, 24574.139905103235, 24876.50246995086, 17965.550861228574, 18059.909700451415, 18157.092145392413, 18241.45275641733, 18250.178741956377, 17396.0, 17953.73069403986, 18022.36921707734, 18065.548361291072, 18129.637407251517, 16896.0, 17178.31286748516, 17191.57021074483, 17281.222344994254, 18328.541786455444, 14196.716065678835, 15145.0, 15251.618709532351, 15254.855885808387, 15258.771118433011, 17971.820281797536, 17979.820201797815, 18044.2782288707, 18094.909525452287, 18210.45368638943], "value": 12238.819529317121, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.6856622976716, 1430.7067051254487, 1443.2062365698866, 1447.211269857928, 1449.2391494465398, 14363.71272574548, 14418.49535266266, 14937.17845518496, 14956.401743930257, 15028.098314101147, 13997.230152341617, 14267.785983210235, 14269.35787889545, 14292.142471451694, 14325.78511322331, 2649.350909027286, 2706.4181201041774, 2708.336457567889, 2710.037936532532, 2711.9728802712016, 2594.455164415466, 2674.6389237452986, 2711.3221694576355, 2711.7423844734717, 2720.469508445854, 2616.0582190411533, 2663.893444262227, 2668.5330067238156, 2708.3229192701824, 2708.9322766930886, 2631.184332856811, 2637.6439180710645, 2642.9207123786123, 2657.8936842526177, 2658.960115598248, 2609.4389706213065, 2623.9897639408964, 2629.763321301073, 2632.9605055924176, 2638.4195476995033, 13984.650383740387, 14119.71760564783, 14280.428782848674, 14281.357338919774, 14288.357023933844, 7545.094588649343, 7872.212778722139, 7882.172371900925, 7884.132745398002, 7899.723509677134, 4954.5293197146575, 4969.776360063805, 5174.534291913746, 5197.1424714922, 5213.165893457029, 1837.5773572078363, 1858.1823997441218, 1860.1164446887756, 1881.6949237184476, 1895.8578106642058, 24062.834344909043, 24188.0, 24270.878645606834, 24285.757142428527, 24361.147359842496, 6295.150154729145, 6505.739770409131, 6574.671266436659, 6698.296678848748, 6726.630035348103, 16409.097499637635, 16435.506934791974, 16436.424725134802, 16444.0, 16453.506394808173, 7613.0, 7734.419918506134, 7741.18717534662, 7749.108852482037, 7775.727849525239, 5642.746076426571, 6015.699215039231, 6060.2727672678675, 6810.523263371517, 7111.431085513146, 5259.631825772236, 5265.368155821326, 5362.731863406814, 5379.919301210485, 5387.542058924957, 1515.1060874084344, 1527.3279756906925, 1538.2078229711708, 1551.1701239836634, 1555.7821904933319, 887.9422837515541, 904.0913881549001, 906.2795077913075, 909.2680392284143, 914.5655813488672, 7249.130104387507, 7286.635668216674, 7308.926910730825, 7329.853402932018, 7503.099628044561, 708.1608294171423, 713.6931119618614, 714.4891402647132, 718.8993540904278, 725.050184258623, 4677.555632214934, 5062.898742025139, 5169.467459158882, 5182.093133701587, 5201.141811601119, 18874.245030198912, 19520.414387568395, 19567.8043219566, 19762.604747904963, 19824.306149284996, 17895.0, 20217.696734548994, 20288.391348259574, 20296.898515507328, 20372.69440958387, 11016.724581885357, 11234.550617975354, 11243.381614011309, 11245.437728113562, 11245.550177992789, 8664.48013119215, 8698.739037828875, 8819.426737262058, 9111.134442227978, 9163.129502697233, 17000.829991699924, 17291.481255562354, 17715.73426398631, 17731.202095905974, 18071.096445177427, 17690.823091768918, 18061.367852125113, 18144.274229030692, 18396.632067358845, 18477.445676629723, 11681.182317237712, 11769.705757356134, 12144.635660930186, 12289.44697488633, 12292.262464252173, 13646.0, 13784.0, 13790.931045344709, 13792.724145517233, 13798.0, 11249.493772780408, 11273.71815704614, 11282.266652667551, 11383.43082845871, 11436.37099959477, 11101.50043248072, 11142.164337674545, 11204.66386008421, 11249.550017999516, 11351.318920864443, 9360.11078947499, 9456.19622332082, 9470.005649406989, 9472.526373681427, 9488.667896623585, 6528.347165283433, 6657.633830139389, 6704.497162712719, 7142.964285178541, 7185.0, 7234.240404757425, 7258.818529536804, 7289.307515785992, 7372.63136843145, 7382.630868456448], "value": 6438.715329128742, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.3597326251081, 499.36955839185066, 526.5945222178922, 533.1682575182717, 536.4715754981343, 6144.692765361725, 6232.626042437451, 6241.875162496747, 6277.905831412521, 6280.528960327976, 5858.1505681676135, 6012.789552365668, 6042.274927008754, 6046.818595442132, 6053.697315134248, 4876.829310974116, 4886.242632391985, 4924.187509061001, 4934.753262336878, 5008.549230569248, 4768.165571025074, 4912.803487860481, 4923.753812309388, 4929.531694489017, 4975.502449755014, 4848.345473361104, 4892.706437613754, 4896.1186986342445, 4906.681065730734, 4960.60315174787, 4883.243097319921, 4887.6089912807065, 4942.258661200813, 4966.379202599675, 4973.254011898208, 4441.111777644452, 4446.844360447369, 4457.7711144427785, 4461.732296062214, 4462.263726485126, 5956.404359564052, 5977.491913187384, 5984.551158663117, 6027.758889644409, 6038.667873266969, 5677.602567820254, 5689.687067211302, 5713.371529131792, 5720.713964301768, 5735.627184233012, 6346.921023426029, 6402.967985160044, 6429.742810287629, 6493.837654058639, 6519.250286217099, 4844.297576851337, 4846.127697014536, 4858.29554714568, 4874.7562621868765, 4876.658633895629, 6821.624810635413, 6852.554583952027, 6866.828329291808, 6895.310468953115, 6952.965235173791, 4929.433115191727, 4936.975315123402, 4981.501849814989, 4984.750762461862, 5028.924566131511, 5010.323606313101, 5013.39839219296, 5040.042391945592, 5070.239464080418, 5077.898442031213, 5538.086215774352, 5702.887936852357, 5720.942790572124, 5722.456366645162, 5743.913841292384, 6445.1621289233035, 6456.709448074754, 6471.870562588816, 6521.739130434729, 6552.279249282575, 1680.386658869504, 1714.1943286655253, 1715.8198389169206, 1717.3388245525314, 1766.5406994181606, 1203.3201241298639, 1209.4980583057932, 1230.4278510492663, 1232.445399570197, 1234.0559472003924, 5675.120356344773, 5678.346990096109, 5718.598943258929, 5745.569082318842, 5770.221020162308, 6519.739210431624, 6525.11910892033, 6599.769008084694, 6629.569078009914, 6648.800535983928, 5656.745446454919, 5703.657780533182, 5732.856678583069, 5771.740271687784, 5784.305883293948, 3511.8068506231893, 3521.330947120039, 3539.752217344761, 3573.2496175802853, 3595.7662751921043, 6538.803835884931, 6543.901841472381, 6557.901631475532, 6579.276279609335, 6644.966775166094, 6860.965695171592, 6870.828229294308, 6900.827479313058, 6903.963330817421, 6970.616616086164, 6412.665413984795, 6508.3491650835485, 6567.376099270562, 6569.178852643419, 6631.867362652816, 6605.636689981905, 6696.455346968316, 6699.794037073373, 6724.865502690017, 6754.493412993947, 6513.576617520036, 6647.700853461509, 6670.166229221348, 6675.666216689049, 6695.058433054554, 6449.516286278642, 6452.644944561507, 6475.222973243052, 6510.804675859732, 6529.0, 4930.975345123252, 4951.925721114114, 4952.801887924443, 4972.5276098770555, 4992.400911890596, 6594.736210551524, 6656.36764507371, 6663.933360666331, 6703.564268322543, 6713.765018224339, 6464.0, 6512.902306465312, 6518.784972022458, 6537.378948999837, 6558.1802274715665, 6299.716512756845, 6475.870482590228, 6517.9348206517325, 6536.281009089092, 6591.274959754519, 6214.378562143749, 6308.621482711052, 6357.904631430625, 6365.745370185141, 6398.99247353743, 6413.454856337264, 6525.053867189136, 6527.738890444329, 6547.544670748469, 6561.639109849004, 6198.783042593487, 6228.252609686867, 6285.009019272703, 6301.905471418024, 6348.206474190726], "value": 5022.473127912684, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.0552622509477, 916.9587368568414, 925.7037747920668, 928.4382948316269, 933.1648174883477, 19312.806871931276, 20234.89882550587, 20237.494062648442, 20255.898720506397, 22598.774012259873, 21483.355499335004, 21974.340769776893, 22067.558648827013, 22238.221662241824, 22274.331770046923, 963.4700914497033, 996.8155891160159, 999.1607050077934, 999.7400675824301, 1000.8048430556045, 973.2505970402785, 1052.0584077250855, 1059.4332032362688, 1069.1179776684228, 1070.561069961316, 1097.8847221041794, 1116.0011789448438, 1116.017904244268, 1116.1182665694091, 1117.022605220432, 1079.1259080145107, 1095.5453486802967, 1098.7088421568292, 1098.9890101098968, 1099.741560733227, 806.4193780478105, 811.8416908702806, 816.8774683797478, 818.0469752738053, 819.7171975668385, 20128.295509657237, 20298.49253768653, 20440.795592044036, 20443.693344599844, 20625.278115265894, 21738.456538586503, 21768.0, 21941.122355105777, 22086.779132208634, 22470.550588988128, 16746.99518028922, 16835.242414091274, 17047.659046818993, 17075.146242687817, 17171.484855454233, 3565.0196196046036, 3571.3035957988204, 3588.372034893883, 3603.747737658365, 3604.2431089471243, 130349.34825325813, 132365.0, 132626.336868316, 133466.0, 136644.63355366417, 17015.82984170167, 17296.0, 17313.39403120885, 17644.647107057786, 17679.0, 31743.682563174072, 32097.0, 32942.01173964737, 32965.340693186, 33140.0, 7891.6054197289905, 8288.419810613199, 8420.200080992296, 8812.559372031374, 9269.860952085724, 4333.544977777351, 4416.955830441654, 4443.37792709021, 4445.399871017371, 4451.0, 5072.923906141411, 5237.397699264558, 5286.682799031993, 5288.762005709752, 5304.92042619361, 950.6340059077305, 967.2842096848423, 980.5342462330336, 983.2969426859829, 984.3503287829998, 678.7454704485817, 687.6596084937888, 696.7631005458169, 698.8951657251453, 706.0820932787356, 11840.407979600985, 11875.88124118765, 12285.815712764315, 12903.677408064686, 13343.733125337632, 650.778735230024, 658.0622612776774, 668.7391917152314, 668.8762578922915, 684.1687349869833, 5795.420457954255, 5806.390329015392, 5829.5044921181325, 5844.970775146097, 5872.618279811799, 112413.0, 112894.43552782347, 114307.42846285715, 115441.0, 116230.0, 99187.0, 100747.0, 100819.0, 101557.49221253846, 101682.49158754159, 80892.0, 82681.58659206665, 83616.58191709002, 85069.57465212759, 85428.14571854327, 11085.944570277097, 11195.104391648485, 11328.490217940047, 12762.29807360604, 13334.0, 39074.804625976685, 39820.00449988658, 39872.40191397073, 40186.39720404138, 41388.379174311805, 70868.0, 71006.0, 72528.63735681288, 73987.0, 77882.6105869467, 18531.536711582317, 20148.899255503628, 20413.285535006202, 20562.58874822525, 20692.68960965617, 23006.539869202858, 23015.0, 23111.768882311633, 23436.296911092013, 23503.882480587486, 19096.713549296495, 19592.216311347387, 19696.40910772679, 19702.901485492483, 19917.203311867364, 20454.590908181457, 20460.79539204589, 20896.582068358854, 20940.47648808792, 21025.31664483523, 17575.82424175793, 17592.29630814753, 17630.559236019202, 17686.11569421498, 17793.288268469634, 13695.520656776966, 14052.0, 14083.507077252247, 14315.856841431452, 14370.209638469985, 13392.397342119433, 14369.13785172893, 14721.33753981095, 14742.2628868554, 14884.925575372054], "value": 9452.09048815838, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 110.0, 107.0, 114.0, 107.0, 111.0, 105.0, 109.0, 108.0], "value": 108.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 148.0, 165.0, 122.0, 152.0, 143.0, 121.0, 176.0, 121.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 171.0, 161.0, 164.0, 163.0, 166.0, 175.0, 163.0, 164.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 76.0, 164.0, 75.0, 77.0, 76.0, 84.0, 97.0, 76.0], "value": 88.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 142.0, 82.0, 85.0, 79.0, 125.0, 85.0, 83.0, 129.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 151.0, 152.0, 150.0, 151.0, 148.0, 149.0, 154.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 93.0, 100.0, 94.0, 93.0, 94.0, 94.0, 94.0, 98.0, 98.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 53.0, 58.0, 58.0, 53.0, 53.0, 52.0, 53.0, 53.0, 59.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 54.0, 62.0, 55.0, 59.0, 62.0, 63.0], "value": 57.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 76.0, 76.0, 81.0, 75.0, 86.0, 77.0, 76.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 121.0, 125.0, 122.0, 118.0, 131.0, 120.0, 133.0, 120.0, 157.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 183.0, 178.0, 190.0, 184.0, 183.0, 175.0, 187.0, 179.0, 172.0], "value": 181.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 69.0, 69.0, 69.0, 69.0, 73.0, 69.0, 67.0, 69.0, 66.0], "value": 69.4, "unit": "score"}]}]} 11:41:09 INFO - Return code: 0 11:41:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:41:09 INFO - # TBPL SUCCESS # 11:41:09 INFO - Running post-action listener: _package_coverage_data 11:41:09 INFO - Running post-action listener: _resource_record_post_action 11:41:09 INFO - [mozharness: 2017-08-17 18:41:09.321176Z] Finished run-tests step (success) 11:41:09 INFO - Running post-run listener: _resource_record_post_run 11:41:09 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 436776960; Read time: 0; Write time: 330020 11:41:09 INFO - TinderboxPrint: CPU usage
13.1% 11:41:09 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 11:41:09 INFO - TinderboxPrint: I/O write bytes / time
436,776,960 / 330,020 11:41:09 INFO - TinderboxPrint: CPU idle
8,261.2 (86.8%) 11:41:09 INFO - TinderboxPrint: CPU user
1,201.9 (12.6%) 11:41:09 INFO - TinderboxPrint: Swap in / out
0 / 0 11:41:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 111939584; Read time: 0; Write time: 123844 11:41:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:41:09 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 323715072; Read time: 0; Write time: 206096 11:41:09 INFO - Running post-run listener: _upload_blobber_files 11:41:09 INFO - Blob upload gear active. 11:41:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:41:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:41:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:41:10 INFO - (blobuploader) - INFO - Open directory for files ... 11:41:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:41:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:41:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:11 INFO - (blobuploader) - INFO - Done attempting. 11:41:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:41:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:41:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:11 INFO - (blobuploader) - INFO - Done attempting. 11:41:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:41:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:41:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:12 INFO - (blobuploader) - INFO - Done attempting. 11:41:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:41:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:41:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:19 INFO - (blobuploader) - INFO - Done attempting. 11:41:19 INFO - (blobuploader) - INFO - Iteration through files over. 11:41:19 INFO - Return code: 0 11:41:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:41:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:41:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b936a98921b7caf46177ffdd99523af123f1eb87d1a288d00a76cd22c191147e4d221f15ea112298126f3fd43bc385730d63d33b6d39636bac75ba80dffa88c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2117b919722e2cb5306ef88641221df6c694f92f00b74c7d42847dcaea09aa684d25bbb42f92b1c008d5feb54d8836923ef5ddaf6dabf7cc322c45b0c7602314", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e878012f49dd69cc9558730a52e424c2e4b3ce0afb655a1ad4aeb3ac8a5f7a8bcfa69b5054b39bf292ecfd786aa6c26574b5f1e1ef562d0ab82e228b37cfbea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57fc2580bee650b24c0e16ee2728fea0442f726704660a067a04a255c86f0db27b4e091bbb685ba9a1744020cd6cdb103beb58d98d1acc95887ed608bcae97e5"} 11:41:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:41:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:41:19 INFO - Contents: 11:41:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b936a98921b7caf46177ffdd99523af123f1eb87d1a288d00a76cd22c191147e4d221f15ea112298126f3fd43bc385730d63d33b6d39636bac75ba80dffa88c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2117b919722e2cb5306ef88641221df6c694f92f00b74c7d42847dcaea09aa684d25bbb42f92b1c008d5feb54d8836923ef5ddaf6dabf7cc322c45b0c7602314", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e878012f49dd69cc9558730a52e424c2e4b3ce0afb655a1ad4aeb3ac8a5f7a8bcfa69b5054b39bf292ecfd786aa6c26574b5f1e1ef562d0ab82e228b37cfbea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57fc2580bee650b24c0e16ee2728fea0442f726704660a067a04a255c86f0db27b4e091bbb685ba9a1744020cd6cdb103beb58d98d1acc95887ed608bcae97e5"} 11:41:19 INFO - Running post-run listener: copy_logs_to_upload_dir 11:41:19 INFO - Copying logs to upload dir... 11:41:19 INFO - mkdir: /builds/slave/test/build/upload/logs 11:41:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.744452 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-17 11:41:19.198745) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 11:41:19.206455) ========= 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=6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330 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/6b936a98921b7caf46177ffdd99523af123f1eb87d1a288d00a76cd22c191147e4d221f15ea112298126f3fd43bc385730d63d33b6d39636bac75ba80dffa88c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2117b919722e2cb5306ef88641221df6c694f92f00b74c7d42847dcaea09aa684d25bbb42f92b1c008d5feb54d8836923ef5ddaf6dabf7cc322c45b0c7602314", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e878012f49dd69cc9558730a52e424c2e4b3ce0afb655a1ad4aeb3ac8a5f7a8bcfa69b5054b39bf292ecfd786aa6c26574b5f1e1ef562d0ab82e228b37cfbea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57fc2580bee650b24c0e16ee2728fea0442f726704660a067a04a255c86f0db27b4e091bbb685ba9a1744020cd6cdb103beb58d98d1acc95887ed608bcae97e5"} build_url:https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011670 build_url: 'https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6b936a98921b7caf46177ffdd99523af123f1eb87d1a288d00a76cd22c191147e4d221f15ea112298126f3fd43bc385730d63d33b6d39636bac75ba80dffa88c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2117b919722e2cb5306ef88641221df6c694f92f00b74c7d42847dcaea09aa684d25bbb42f92b1c008d5feb54d8836923ef5ddaf6dabf7cc322c45b0c7602314", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e878012f49dd69cc9558730a52e424c2e4b3ce0afb655a1ad4aeb3ac8a5f7a8bcfa69b5054b39bf292ecfd786aa6c26574b5f1e1ef562d0ab82e228b37cfbea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57fc2580bee650b24c0e16ee2728fea0442f726704660a067a04a255c86f0db27b4e091bbb685ba9a1744020cd6cdb103beb58d98d1acc95887ed608bcae97e5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 11:41:19.238460) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:41:19.238776) ========= 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=6d15e502d8e29d5d2676d664000001c3-1502993462.352161-1714028330 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:41:19.316944) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 11:41:19.320301) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 11:41:19.320593) ========= ========= Total master_lag: 0.48 =========