builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-034 starttime: 1502994020.27 results: success (0) revision: e365137fa61bfd729617ba1ebf9f1ed79facd1f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:20.274358) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:20.274854) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:20.275135) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:20.295614) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:20.295913) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-17 11:20:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.1M=0.001s 2017-08-17 11:20:20 (20.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134659 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:20.462598) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:20.462902) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017657 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:20.514737) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:20.515063) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-17 11:20:20,902 truncating revision to first 12 chars 2017-08-17 11:20:20,902 Setting DEBUG logging. 2017-08-17 11:20:20,903 attempt 1/10 2017-08-17 11:20:20,903 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:21,215 unpacking tar archive at: mozilla-central-e365137fa61b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635207 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:21.166318) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:21.166612) ========= script_repo_revision: e365137fa61bfd729617ba1ebf9f1ed79facd1f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:21.167007) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:21.167270) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:21.209512) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-17 11:20:21.209818) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=d6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:20:21 INFO - MultiFileLogger online at 20170817 11:20:21 in /builds/slave/test 11:20:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:20:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:20:21 INFO - {'append_to_log': False, 11:20:21 INFO - 'base_work_dir': '/builds/slave/test', 11:20:21 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:20:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:20:21 INFO - 'branch': 'Firefox-Non-PGO', 11:20:21 INFO - 'buildbot_json_path': 'buildprops.json', 11:20:21 INFO - 'code_coverage': False, 11:20:21 INFO - 'config_files': ('talos/linux_config.py',), 11:20:21 INFO - 'default_actions': ('clobber', 11:20:21 INFO - 'read-buildbot-config', 11:20:21 INFO - 'download-and-extract', 11:20:21 INFO - 'populate-webroot', 11:20:21 INFO - 'create-virtualenv', 11:20:21 INFO - 'install', 11:20:21 INFO - 'setup-mitmproxy', 11:20:21 INFO - 'run-tests'), 11:20:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:20:21 INFO - 'disable_ccov_upload': False, 11:20:21 INFO - 'download_minidump_stackwalk': True, 11:20:21 INFO - 'download_symbols': 'ondemand', 11:20:21 INFO - 'enable_stylo': False, 11:20:21 INFO - 'enable_webrender': False, 11:20:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:20:21 INFO - 'tooltool.py': '/tools/tooltool.py', 11:20:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:20:21 INFO - '/tools/misc-python/virtualenv.py')}, 11:20:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:20:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:20:21 INFO - 'gecko_profile': False, 11:20:21 INFO - 'gecko_profile_interval': 0, 11:20:21 INFO - 'installer_path': 'installer.exe', 11:20:21 INFO - 'log_level': 'info', 11:20:21 INFO - 'log_name': 'talos', 11:20:21 INFO - 'log_to_console': True, 11:20:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:20:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:20:21 INFO - 'opt_config_files': (), 11:20:21 INFO - 'pip_index': False, 11:20:21 INFO - 'suite': 'dromaeojs-e10s', 11:20:21 INFO - 'system_bits': '32', 11:20:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:20:21 INFO - 'title': 'talos-linux64-ix-034', 11:20:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:20:21 INFO - 'use_talos_json': True, 11:20:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:20:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:20:21 INFO - 'work_dir': 'build'} 11:20:21 INFO - [mozharness: 2017-08-17 18:20:21.702390Z] Running clobber step. 11:20:21 INFO - Running pre-action listener: _resource_record_pre_action 11:20:21 INFO - Running main action method: clobber 11:20:21 INFO - rmtree: /builds/slave/test/build 11:20:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:20:23 INFO - Running post-action listener: _resource_record_post_action 11:20:23 INFO - [mozharness: 2017-08-17 18:20:23.263211Z] Finished clobber step (success) 11:20:23 INFO - [mozharness: 2017-08-17 18:20:23.263313Z] Running read-buildbot-config step. 11:20:23 INFO - Running pre-action listener: _resource_record_pre_action 11:20:23 INFO - Running main action method: read_buildbot_config 11:20:23 INFO - Using buildbot properties: 11:20:23 INFO - { 11:20:23 INFO - "project": "", 11:20:23 INFO - "product": "firefox", 11:20:23 INFO - "who": "archaeopteryx@coole-files.de", 11:20:23 INFO - "installer_path": "public/build/target.tar.bz2", 11:20:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:20:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:20:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 11:20:23 INFO - "stage_platform": "linux64", 11:20:23 INFO - "basedir": "/builds/slave/test", 11:20:23 INFO - "buildnumber": 1083, 11:20:23 INFO - "platform": "ubuntu64_hw", 11:20:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:20:23 INFO - "slavebuilddir": "test", 11:20:23 INFO - "taskId": "brKO14hdRVCioATBcfKH3A", 11:20:23 INFO - "branch": "mozilla-central", 11:20:23 INFO - "script_repo_revision": "production", 11:20:23 INFO - "revision": "e365137fa61bfd729617ba1ebf9f1ed79facd1f2", 11:20:23 INFO - "slavename": "talos-linux64-ix-034", 11:20:23 INFO - "repo_path": "mozilla-central" 11:20:23 INFO - } 11:20:23 INFO - Finding installer, test and symbols from parent task. 11:20:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/brKO14hdRVCioATBcfKH3A'}, attempt #1 11:20:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/brKO14hdRVCioATBcfKH3A'}, attempt #1 11:20:24 INFO - Task dependencies: aYF0Eu7eSDuOnCwEq2ykWQ 11:20:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ'}, attempt #1 11:20:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 11:20:24 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.test_packages.json 11:20:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.crashreporter-symbols.zip 11:20:24 INFO - Running post-action listener: _resource_record_post_action 11:20:24 INFO - [mozharness: 2017-08-17 18:20:24.648875Z] Finished read-buildbot-config step (success) 11:20:24 INFO - [mozharness: 2017-08-17 18:20:24.649098Z] Running download-and-extract step. 11:20:24 INFO - Running pre-action listener: _resource_record_pre_action 11:20:24 INFO - Running main action method: download_and_extract 11:20:24 INFO - mkdir: /builds/slave/test/build/tests 11:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:24 INFO - trying https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.test_packages.json 11:20:24 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:24 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:26 INFO - Downloaded 989 bytes. 11:20:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:20:26 INFO - Using the following test package requirements: 11:20:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:20:26 INFO - u'common': [u'target.common.tests.zip'], 11:20:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:20:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:20:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:20:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:20:26 INFO - u'mozbase': [u'target.common.tests.zip'], 11:20:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:20:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:20:26 INFO - u'web-platform': [u'target.common.tests.zip', 11:20:26 INFO - u'target.web-platform.tests.tar.gz'], 11:20:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:20:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:20:26 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:26 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:26 INFO - Fetch https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.common.tests.zip into memory 11:20:27 INFO - Content-Length response header: 53999535 11:20:27 INFO - Bytes received: 53999535 11:20:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:20:38 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:38 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:38 INFO - Fetch https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.common.tests.zip into memory 11:20:39 INFO - Content-Length response header: 53999535 11:20:39 INFO - Bytes received: 53999535 11:20:51 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:51 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:51 INFO - Fetch https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.talos.tests.zip into memory 11:20:52 INFO - Content-Length response header: 14496161 11:20:52 INFO - Bytes received: 14496161 11:20:52 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:52 INFO - trying https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 11:20:52 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:52 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:53 INFO - Downloaded 62276440 bytes. 11:20:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 11:20:53 INFO - mkdir: /builds/slave/test/properties 11:20:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:20:53 INFO - Writing to file /builds/slave/test/properties/build_url 11:20:53 INFO - Contents: 11:20:53 INFO - build_url:https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 11:20:53 INFO - Running post-action listener: _resource_record_post_action 11:20:53 INFO - Running post-action listener: set_extra_try_arguments 11:20:53 INFO - [mozharness: 2017-08-17 18:20:53.487219Z] Finished download-and-extract step (success) 11:20:53 INFO - [mozharness: 2017-08-17 18:20:53.487317Z] Running populate-webroot step. 11:20:53 INFO - Running pre-action listener: _resource_record_pre_action 11:20:53 INFO - Running main action method: populate_webroot 11:20:53 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:20:53 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 11:20:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:20:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:20:53 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 11:20:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:20:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:20:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:53 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:20:53 INFO - 'talos_options': ['--stylo'], 11:20:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:20:53 INFO - 'tests': ['damp', 'tps']}, 11:20:53 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:20:53 INFO - 'talos_options': ['--stylo'], 11:20:53 INFO - 'tests': ['damp', 'tps']}, 11:20:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:20:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:20:53 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 11:20:53 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:20:53 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:20:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:20:53 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:20:53 INFO - 'talos_options': ['--stylo'], 11:20:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:20:53 INFO - 'other-e10s': {'tests': ['a11yr', 11:20:53 INFO - 'ts_paint', 11:20:53 INFO - 'tpaint', 11:20:53 INFO - 'sessionrestore', 11:20:53 INFO - 'sessionrestore_many_windows', 11:20:53 INFO - 'sessionrestore_no_auto_restore', 11:20:53 INFO - 'tabpaint']}, 11:20:53 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 11:20:53 INFO - 'tests': ['a11yr', 11:20:53 INFO - 'ts_paint', 11:20:53 INFO - 'tpaint', 11:20:53 INFO - 'sessionrestore', 11:20:53 INFO - 'sessionrestore_many_windows', 11:20:53 INFO - 'sessionrestore_no_auto_restore', 11:20:53 INFO - 'tabpaint']}, 11:20:53 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:20:53 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:20:53 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 11:20:53 INFO - 'tests': ['bloom_basic_singleton']}, 11:20:53 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 11:20:53 INFO - 'tests': ['bloom_basic']}, 11:20:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:20:53 INFO - 'tsvgr_opacity', 11:20:53 INFO - 'tart', 11:20:53 INFO - 'tscrollx', 11:20:53 INFO - 'tsvg_static']}, 11:20:53 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 11:20:53 INFO - 'tests': ['tsvgx', 11:20:53 INFO - 'tsvgr_opacity', 11:20:53 INFO - 'tart', 11:20:53 INFO - 'tscrollx', 11:20:53 INFO - 'tsvg_static']}, 11:20:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:20:53 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:20:53 INFO - 'talos_options': ['--stylo'], 11:20:53 INFO - 'tests': ['tp5o']}, 11:20:53 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:53 INFO - 'talos_options': ['--mitmproxy', 11:20:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:53 INFO - '--firstNonBlankPaint'], 11:20:53 INFO - 'tests': ['tp6_google', 11:20:53 INFO - 'tp6_youtube', 11:20:53 INFO - 'tp6_amazon', 11:20:53 INFO - 'tp6_facebook']}, 11:20:53 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:53 INFO - 'talos_options': ['--stylo', 11:20:53 INFO - '--mitmproxy', 11:20:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:53 INFO - '--firstNonBlankPaint'], 11:20:53 INFO - 'tests': ['tp6_google', 11:20:53 INFO - 'tp6_youtube', 11:20:53 INFO - 'tp6_amazon', 11:20:53 INFO - 'tp6_facebook']}, 11:20:53 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:20:53 INFO - 'talos_options': ['--stylo', 11:20:53 INFO - '--stylo-threads=1', 11:20:53 INFO - '--mitmproxy', 11:20:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:20:53 INFO - '--firstNonBlankPaint'], 11:20:53 INFO - 'tests': ['tp6_google', 11:20:53 INFO - 'tp6_youtube', 11:20:53 INFO - 'tp6_amazon', 11:20:53 INFO - 'tp6_facebook']}, 11:20:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:20:53 INFO - 'talos_options': ['--xperf_path', 11:20:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:53 INFO - 'tests': ['tp5n']}, 11:20:53 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:20:53 INFO - 'talos_options': ['--stylo', 11:20:53 INFO - '--xperf_path', 11:20:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:53 INFO - 'tests': ['tp5n']}}} 11:20:53 INFO - Running post-action listener: _resource_record_post_action 11:20:53 INFO - [mozharness: 2017-08-17 18:20:53.501737Z] Finished populate-webroot step (success) 11:20:53 INFO - [mozharness: 2017-08-17 18:20:53.501828Z] Running create-virtualenv step. 11:20:53 INFO - Running pre-action listener: _resource_record_pre_action 11:20:53 INFO - Running main action method: create_virtualenv 11:20:53 INFO - Creating virtualenv /builds/slave/test/build/venv 11:20:53 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:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:20:53 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:20:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:20:53 INFO - Using real prefix '/usr' 11:20:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:20:54 INFO - Installing distribute.............................................................................................................................................................................................done. 11:20:56 INFO - Installing pip.................done. 11:20:56 INFO - Return code: 0 11:20:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:20:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:20:56 INFO - Reading from file tmpfile_stdout 11:20:56 INFO - Output received: 11:20:56 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:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:20:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f72a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2115ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21130b0>, '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 0x2113fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114440>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', '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:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:20:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:20:56 INFO - Using env: {'DISPLAY': ':0', 11:20:56 INFO - 'HOME': '/home/cltbld', 11:20:56 INFO - 'LANG': 'en_US.UTF-8', 11:20:56 INFO - 'LANGUAGE': 'en_US:en', 11:20:56 INFO - 'LOGNAME': 'cltbld', 11:20:56 INFO - 'MAIL': '/var/mail/cltbld', 11:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:56 INFO - 'MOZ_NO_REMOTE': '1', 11:20:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:56 INFO - 'NO_EM_RESTART': '1', 11:20:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:56 INFO - 'PWD': '/builds/slave/test', 11:20:56 INFO - 'SHELL': '/bin/bash', 11:20:56 INFO - 'SHLVL': '1', 11:20:56 INFO - 'TERM': 'linux', 11:20:56 INFO - 'TMOUT': '86400', 11:20:56 INFO - 'USER': 'cltbld', 11:20:56 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', 11:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:56 INFO - '_': '/tools/buildbot/bin/python'} 11:20:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:56 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:56 INFO - Cleaning up... 11:20:56 INFO - Return code: 0 11:20:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:20:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e6c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f72a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2115ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21130b0>, '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 0x2113fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114440>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', '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:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:20:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:20:56 INFO - Using env: {'DISPLAY': ':0', 11:20:56 INFO - 'HOME': '/home/cltbld', 11:20:56 INFO - 'LANG': 'en_US.UTF-8', 11:20:56 INFO - 'LANGUAGE': 'en_US:en', 11:20:56 INFO - 'LOGNAME': 'cltbld', 11:20:56 INFO - 'MAIL': '/var/mail/cltbld', 11:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:56 INFO - 'MOZ_NO_REMOTE': '1', 11:20:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:56 INFO - 'NO_EM_RESTART': '1', 11:20:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:56 INFO - 'PWD': '/builds/slave/test', 11:20:56 INFO - 'SHELL': '/bin/bash', 11:20:56 INFO - 'SHLVL': '1', 11:20:56 INFO - 'TERM': 'linux', 11:20:56 INFO - 'TMOUT': '86400', 11:20:56 INFO - 'USER': 'cltbld', 11:20:56 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', 11:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:56 INFO - '_': '/tools/buildbot/bin/python'} 11:20:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:56 INFO - Downloading/unpacking psutil>=3.1.1 11:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:20:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:57 INFO - Installing collected packages: psutil 11:20:57 INFO - Running setup.py install for psutil 11:20:58 INFO - building 'psutil._psutil_linux' extension 11:20:58 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:20:58 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:20:58 INFO - building 'psutil._psutil_posix' extension 11:20:58 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:20:58 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:20:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:58 INFO - Successfully installed psutil 11:20:58 INFO - Cleaning up... 11:20:58 INFO - Return code: 0 11:20:58 INFO - Installing mozsystemmonitor==0.3 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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f72a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2115ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21130b0>, '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 0x2113fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114440>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', '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', 'mozsystemmonitor==0.3'] 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 mozsystemmonitor==0.3 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': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', 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 mozsystemmonitor==0.3 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:20:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:20:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:20:59 INFO - Installing collected packages: mozsystemmonitor 11:20:59 INFO - Running setup.py install for mozsystemmonitor 11:20:59 INFO - Successfully installed mozsystemmonitor 11:20:59 INFO - Cleaning up... 11:20:59 INFO - Return code: 0 11:20:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:20:59 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:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:59 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:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:59 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 0x1e6c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f72a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2115ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21130b0>, '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 0x2113fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114440>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', '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:59 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:20:59 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:20:59 INFO - Using env: {'DISPLAY': ':0', 11:20:59 INFO - 'HOME': '/home/cltbld', 11:20:59 INFO - 'LANG': 'en_US.UTF-8', 11:20:59 INFO - 'LANGUAGE': 'en_US:en', 11:20:59 INFO - 'LOGNAME': 'cltbld', 11:20:59 INFO - 'MAIL': '/var/mail/cltbld', 11:20:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:59 INFO - 'MOZ_NO_REMOTE': '1', 11:20:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:59 INFO - 'NO_EM_RESTART': '1', 11:20:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:59 INFO - 'PWD': '/builds/slave/test', 11:20:59 INFO - 'SHELL': '/bin/bash', 11:20:59 INFO - 'SHLVL': '1', 11:20:59 INFO - 'TERM': 'linux', 11:20:59 INFO - 'TMOUT': '86400', 11:20:59 INFO - 'USER': 'cltbld', 11:20:59 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', 11:20:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:59 INFO - '_': '/tools/buildbot/bin/python'} 11:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:00 INFO - Downloading/unpacking jsonschema==2.5.1 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:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:21:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:01 INFO - Downloading functools32-3.2.3-2.tar.gz 11:21:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:21:01 INFO - warning: no files found matching '*.txt' 11:21:01 INFO - no previously-included directories found matching 'build' 11:21:01 INFO - no previously-included directories found matching 'dist' 11:21:01 INFO - no previously-included directories found matching '.git*' 11:21:01 INFO - Installing collected packages: jsonschema, functools32 11:21:01 INFO - Running setup.py install for functools32 11:21:01 INFO - warning: no files found matching '*.txt' 11:21:01 INFO - no previously-included directories found matching 'build' 11:21:01 INFO - no previously-included directories found matching 'dist' 11:21:01 INFO - no previously-included directories found matching '.git*' 11:21:01 INFO - Successfully installed jsonschema functools32 11:21:01 INFO - Cleaning up... 11:21:01 INFO - Return code: 0 11:21:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:01 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 0x1e6c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f72a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2115ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21130b0>, '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 0x2113fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114440>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', '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:01 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:01 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:01 INFO - Using env: {'DISPLAY': ':0', 11:21:01 INFO - 'HOME': '/home/cltbld', 11:21:01 INFO - 'LANG': 'en_US.UTF-8', 11:21:01 INFO - 'LANGUAGE': 'en_US:en', 11:21:01 INFO - 'LOGNAME': 'cltbld', 11:21:01 INFO - 'MAIL': '/var/mail/cltbld', 11:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:01 INFO - 'MOZ_NO_REMOTE': '1', 11:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:01 INFO - 'NO_EM_RESTART': '1', 11:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:01 INFO - 'PWD': '/builds/slave/test', 11:21:01 INFO - 'SHELL': '/bin/bash', 11:21:01 INFO - 'SHLVL': '1', 11:21:01 INFO - 'TERM': 'linux', 11:21:01 INFO - 'TMOUT': '86400', 11:21:01 INFO - 'USER': 'cltbld', 11:21:01 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', 11:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:01 INFO - '_': '/tools/buildbot/bin/python'} 11:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:21:01 INFO - Cleaning up... 11:21:01 INFO - Return code: 0 11:21:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:01 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 0x1e6c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f72a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2115ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21130b0>, '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 0x2113fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114440>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', '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:01 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:01 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:01 INFO - Using env: {'DISPLAY': ':0', 11:21:01 INFO - 'HOME': '/home/cltbld', 11:21:01 INFO - 'LANG': 'en_US.UTF-8', 11:21:01 INFO - 'LANGUAGE': 'en_US:en', 11:21:01 INFO - 'LOGNAME': 'cltbld', 11:21:01 INFO - 'MAIL': '/var/mail/cltbld', 11:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:01 INFO - 'MOZ_NO_REMOTE': '1', 11:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:01 INFO - 'NO_EM_RESTART': '1', 11:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:01 INFO - 'PWD': '/builds/slave/test', 11:21:01 INFO - 'SHELL': '/bin/bash', 11:21:01 INFO - 'SHLVL': '1', 11:21:01 INFO - 'TERM': 'linux', 11:21:01 INFO - 'TMOUT': '86400', 11:21:01 INFO - 'USER': 'cltbld', 11:21:01 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', 11:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:01 INFO - '_': '/tools/buildbot/bin/python'} 11:21:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:02 INFO - Downloading/unpacking blobuploader==1.2.4 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 blobuploader-1.2.4.tar.gz 11:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:21:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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 - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:21:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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 docopt-0.6.1.tar.gz 11:21:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:21:04 INFO - Installing collected packages: blobuploader, requests, docopt 11:21:04 INFO - Running setup.py install for blobuploader 11:21:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:21:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:21:04 INFO - Running setup.py install for requests 11:21:04 INFO - Running setup.py install for docopt 11:21:04 INFO - Successfully installed blobuploader requests docopt 11:21:04 INFO - Cleaning up... 11:21:04 INFO - Return code: 0 11:21:04 INFO - Installing None 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', '--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 0x1e6c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f72a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2115ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21130b0>, '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 0x2113fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114440>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', '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', '--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:04 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: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': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:04 INFO - Running setup.py (path:/tmp/pip-FCZFzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:04 INFO - Running setup.py (path:/tmp/pip-_KRdEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:04 INFO - Running setup.py (path:/tmp/pip-qcXwHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:05 INFO - Running setup.py (path:/tmp/pip-GspsoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:05 INFO - Running setup.py (path:/tmp/pip-2RYUFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:05 INFO - Running setup.py (path:/tmp/pip-37clsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:05 INFO - Running setup.py (path:/tmp/pip-1RyR3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:05 INFO - Running setup.py (path:/tmp/pip-RGpbW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:05 INFO - Running setup.py (path:/tmp/pip-kYkeiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:05 INFO - Running setup.py (path:/tmp/pip-FpqJcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:05 INFO - Running setup.py (path:/tmp/pip-oVSsgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:05 INFO - Running setup.py (path:/tmp/pip-zXVw93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:05 INFO - Running setup.py (path:/tmp/pip-G8efUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:05 INFO - Running setup.py (path:/tmp/pip-_sosGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:05 INFO - Running setup.py (path:/tmp/pip-jvEbqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:05 INFO - Running setup.py (path:/tmp/pip-ELRagF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:05 INFO - Running setup.py (path:/tmp/pip-Uy7ws0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:21:06 INFO - Running setup.py install for manifestparser 11:21:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:21:06 INFO - Running setup.py install for mozcrash 11:21:06 INFO - Running setup.py install for mozdebug 11:21:06 INFO - Running setup.py install for mozdevice 11:21:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:21:06 INFO - Running setup.py install for mozfile 11:21:06 INFO - Running setup.py install for mozhttpd 11:21:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:21:06 INFO - Running setup.py install for mozinfo 11:21:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:21:06 INFO - Running setup.py install for mozInstall 11:21:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:21:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:21:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:21:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:21:06 INFO - Running setup.py install for mozleak 11:21:06 INFO - Running setup.py install for mozlog 11:21:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:21:07 INFO - Running setup.py install for moznetwork 11:21:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:21:07 INFO - Running setup.py install for mozprocess 11:21:07 INFO - Running setup.py install for mozprofile 11:21:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:21:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:21:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:21:07 INFO - Running setup.py install for mozrunner 11:21:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:21:07 INFO - Running setup.py install for mozscreenshot 11:21:07 INFO - Running setup.py install for moztest 11:21:07 INFO - Running setup.py install for mozversion 11:21:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:21:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:21:07 INFO - Cleaning up... 11:21:07 INFO - Return code: 0 11:21:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:07 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 0x1e6c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f72a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2115ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21130b0>, '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 0x2113fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114440>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', '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:07 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:07 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:07 INFO - Using env: {'DISPLAY': ':0', 11:21:07 INFO - 'HOME': '/home/cltbld', 11:21:07 INFO - 'LANG': 'en_US.UTF-8', 11:21:07 INFO - 'LANGUAGE': 'en_US:en', 11:21:07 INFO - 'LOGNAME': 'cltbld', 11:21:07 INFO - 'MAIL': '/var/mail/cltbld', 11:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:07 INFO - 'MOZ_NO_REMOTE': '1', 11:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:07 INFO - 'NO_EM_RESTART': '1', 11:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:07 INFO - 'PWD': '/builds/slave/test', 11:21:07 INFO - 'SHELL': '/bin/bash', 11:21:07 INFO - 'SHLVL': '1', 11:21:07 INFO - 'TERM': 'linux', 11:21:07 INFO - 'TMOUT': '86400', 11:21:07 INFO - 'USER': 'cltbld', 11:21:07 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', 11:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:07 INFO - '_': '/tools/buildbot/bin/python'} 11:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:08 INFO - Running setup.py (path:/tmp/pip-78eQcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:08 INFO - Running setup.py (path:/tmp/pip-cx5mbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:08 INFO - Running setup.py (path:/tmp/pip-EzWUYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:08 INFO - Running setup.py (path:/tmp/pip-fNBaLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:08 INFO - Running setup.py (path:/tmp/pip-6bIteF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:08 INFO - Running setup.py (path:/tmp/pip-fvzAhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:08 INFO - Running setup.py (path:/tmp/pip-hsX9Dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:08 INFO - Running setup.py (path:/tmp/pip-qmQwlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:08 INFO - Running setup.py (path:/tmp/pip-IXZypw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:08 INFO - Running setup.py (path:/tmp/pip-XbbFvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:08 INFO - Running setup.py (path:/tmp/pip-b2MHnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:08 INFO - Running setup.py (path:/tmp/pip-vooo3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:08 INFO - Running setup.py (path:/tmp/pip-0W2qyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:08 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:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:08 INFO - Running setup.py (path:/tmp/pip-mSbkoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:09 INFO - Running setup.py (path:/tmp/pip-t5M6Jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:09 INFO - Running setup.py (path:/tmp/pip-xKPYKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:09 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:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:09 INFO - Running setup.py (path:/tmp/pip-jvQJqM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:09 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:09 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:09 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:09 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:09 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:09 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:09 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:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:10 INFO - Downloading blessings-1.6.tar.gz 11:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:21:10 INFO - Installing collected packages: blessings 11:21:10 INFO - Running setup.py install for blessings 11:21:10 INFO - Successfully installed blessings 11:21:10 INFO - Cleaning up... 11:21:10 INFO - Return code: 0 11:21:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:21:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:10 INFO - Reading from file tmpfile_stdout 11:21:10 INFO - Current package versions: 11:21:10 INFO - argparse == 1.2.1 11:21:10 INFO - blessings == 1.6 11:21:10 INFO - blobuploader == 1.2.4 11:21:10 INFO - docopt == 0.6.1 11:21:10 INFO - functools32 == 3.2.3-2 11:21:10 INFO - jsonschema == 2.5.1 11:21:10 INFO - manifestparser == 1.1 11:21:10 INFO - mozInstall == 1.13 11:21:10 INFO - mozcrash == 1.0 11:21:10 INFO - mozdebug == 0.1 11:21:10 INFO - mozdevice == 0.51 11:21:10 INFO - mozfile == 1.2 11:21:10 INFO - mozhttpd == 0.7 11:21:10 INFO - mozinfo == 0.10 11:21:10 INFO - mozleak == 0.1 11:21:10 INFO - mozlog == 3.5 11:21:10 INFO - moznetwork == 0.27 11:21:10 INFO - mozprocess == 0.25 11:21:10 INFO - mozprofile == 0.28 11:21:10 INFO - mozrunner == 6.13 11:21:10 INFO - mozscreenshot == 0.1 11:21:10 INFO - mozsystemmonitor == 0.3 11:21:10 INFO - moztest == 0.8 11:21:10 INFO - mozversion == 1.4 11:21:10 INFO - psutil == 3.1.1 11:21:10 INFO - requests == 1.2.3 11:21:10 INFO - wsgiref == 0.1.2 11:21:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:10 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 0x1e6c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f72a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2115ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21130b0>, '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 0x2113fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114440>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', '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:10 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:10 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:10 INFO - Using env: {'DISPLAY': ':0', 11:21:10 INFO - 'HOME': '/home/cltbld', 11:21:10 INFO - 'LANG': 'en_US.UTF-8', 11:21:10 INFO - 'LANGUAGE': 'en_US:en', 11:21:10 INFO - 'LOGNAME': 'cltbld', 11:21:10 INFO - 'MAIL': '/var/mail/cltbld', 11:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:10 INFO - 'MOZ_NO_REMOTE': '1', 11:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:10 INFO - 'NO_EM_RESTART': '1', 11:21:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:10 INFO - 'PWD': '/builds/slave/test', 11:21:10 INFO - 'SHELL': '/bin/bash', 11:21:10 INFO - 'SHLVL': '1', 11:21:10 INFO - 'TERM': 'linux', 11:21:10 INFO - 'TMOUT': '86400', 11:21:10 INFO - 'USER': 'cltbld', 11:21:10 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', 11:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:10 INFO - '_': '/tools/buildbot/bin/python'} 11:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:11 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:11 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:11 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:11 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:11 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:11 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:11 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:11 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:11 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:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/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 - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:21:12 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:12 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:12 INFO - Installing collected packages: simplejson 11:21:12 INFO - Running setup.py install for simplejson 11:21:12 INFO - building 'simplejson._speedups' extension 11:21:12 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:13 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:13 INFO - Successfully installed simplejson 11:21:13 INFO - Cleaning up... 11:21:13 INFO - Return code: 0 11:21:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f72a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2115ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21130b0>, '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 0x2113fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114440>, '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': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', '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:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:21:13 INFO - Using env: {'DISPLAY': ':0', 11:21:13 INFO - 'HOME': '/home/cltbld', 11:21:13 INFO - 'LANG': 'en_US.UTF-8', 11:21:13 INFO - 'LANGUAGE': 'en_US:en', 11:21:13 INFO - 'LOGNAME': 'cltbld', 11:21:13 INFO - 'MAIL': '/var/mail/cltbld', 11:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:13 INFO - 'MOZ_NO_REMOTE': '1', 11:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:13 INFO - 'NO_EM_RESTART': '1', 11:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:13 INFO - 'PWD': '/builds/slave/test', 11:21:13 INFO - 'SHELL': '/bin/bash', 11:21:13 INFO - 'SHLVL': '1', 11:21:13 INFO - 'TERM': 'linux', 11:21:13 INFO - 'TMOUT': '86400', 11:21:13 INFO - 'USER': 'cltbld', 11:21:13 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', 11:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:13 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): jsonschema in ./venv/lib/python2.7/site-packages 11:21:13 INFO - Cleaning up... 11:21:13 INFO - Return code: 0 11:21:13 INFO - Running post-action listener: _resource_record_post_action 11:21:13 INFO - Running post-action listener: _start_resource_monitoring 11:21:13 INFO - Starting resource monitoring. 11:21:13 INFO - [mozharness: 2017-08-17 18:21:13.542682Z] Finished create-virtualenv step (success) 11:21:13 INFO - [mozharness: 2017-08-17 18:21:13.543189Z] Running install step. 11:21:13 INFO - Running pre-action listener: _resource_record_pre_action 11:21:13 INFO - Running main action method: install 11:21:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:13 INFO - Reading from file tmpfile_stdout 11:21:13 INFO - Detecting whether we're running mozinstall >=1.0... 11:21:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:21:13 INFO - Reading from file tmpfile_stdout 11:21:13 INFO - Output received: 11:21:13 INFO - Usage: mozinstall [options] installer 11:21:13 INFO - Options: 11:21:13 INFO - -h, --help show this help message and exit 11:21:13 INFO - -d DEST, --destination=DEST 11:21:13 INFO - Directory to install application into. [default: 11:21:13 INFO - "/builds/slave/test"] 11:21:13 INFO - --app=APP Application being installed. [default: firefox] 11:21:13 INFO - mkdir: /builds/slave/test/build/application 11:21:13 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:13 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:31 INFO - Reading from file tmpfile_stdout 11:21:31 INFO - Output received: 11:21:31 INFO - /builds/slave/test/build/application/firefox/firefox 11:21:31 INFO - Running post-action listener: _resource_record_post_action 11:21:31 INFO - [mozharness: 2017-08-17 18:21:31.892003Z] Finished install step (success) 11:21:31 INFO - [mozharness: 2017-08-17 18:21:31.892293Z] Running setup-mitmproxy step. 11:21:31 INFO - Running pre-action listener: _resource_record_pre_action 11:21:31 INFO - Running main action method: setup_mitmproxy 11:21:31 INFO - Skipping: mitmproxy is not required 11:21:31 INFO - Running post-action listener: _resource_record_post_action 11:21:31 INFO - [mozharness: 2017-08-17 18:21:31.893514Z] Finished setup-mitmproxy step (success) 11:21:31 INFO - [mozharness: 2017-08-17 18:21:31.893738Z] Running run-tests step. 11:21:31 INFO - Running pre-action listener: _resource_record_pre_action 11:21:31 INFO - Running pre-action listener: _set_gcov_prefix 11:21:31 INFO - Running main action method: run_tests 11:21:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:21:31 INFO - Python 2.7.3 11:21:31 INFO - Return code: 0 11:21:31 INFO - grabbing minidump binary from tooltool 11:21:31 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:31 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 0x21130b0>, '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 0x2113fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2114440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:21:31 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:31 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:31 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:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:21:32 INFO - Return code: 0 11:21:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:21:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:21:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:21:32 INFO - ENV: RUST_BACKTRACE is now full 11:21:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:21:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:21:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--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-034', '--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:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --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-034 --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:32 INFO - Using env: {'DISPLAY': ':0', 11:21:32 INFO - 'HOME': '/home/cltbld', 11:21:32 INFO - 'LANG': 'en_US.UTF-8', 11:21:32 INFO - 'LANGUAGE': 'en_US:en', 11:21:32 INFO - 'LOGNAME': 'cltbld', 11:21:32 INFO - 'MAIL': '/var/mail/cltbld', 11:21:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:32 INFO - 'MOZ_NO_REMOTE': '1', 11:21:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:32 INFO - 'NO_EM_RESTART': '1', 11:21:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:32 INFO - 'PWD': '/builds/slave/test', 11:21:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:32 INFO - 'RUST_BACKTRACE': 'full', 11:21:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:21:32 INFO - 'SHELL': '/bin/bash', 11:21:32 INFO - 'SHLVL': '1', 11:21:32 INFO - 'TERM': 'linux', 11:21:32 INFO - 'TMOUT': '86400', 11:21:32 INFO - 'USER': 'cltbld', 11:21:32 INFO - 'XDG_SESSION_COOKIE': 'd6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430', 11:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:32 INFO - '_': '/tools/buildbot/bin/python'} 11:21:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--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-034', '--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:32 INFO - mozversion application_buildid: 20170817173127 11:21:32 INFO - mozversion application_changeset: e365137fa61bfd729617ba1ebf9f1ed79facd1f2 11:21:32 INFO - mozversion application_display_name: Nightly 11:21:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:21:32 INFO - mozversion application_name: Firefox 11:21:32 INFO - mozversion application_remotingname: firefox 11:21:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:21:32 INFO - mozversion application_vendor: Mozilla 11:21:32 INFO - mozversion application_version: 57.0a1 11:21:32 INFO - mozversion platform_buildid: 20170817173127 11:21:32 INFO - mozversion platform_changeset: e365137fa61bfd729617ba1ebf9f1ed79facd1f2 11:21:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:21:32 INFO - mozversion platform_version: 57.0a1 11:21:32 INFO - using testdate: 1502994092 11:21:32 INFO - actual date: 1502994092 11:21:32 INFO - starting webserver on 'localhost:40008' 11:21:32 INFO - SUITE-START | Running 2 tests 11:21:32 INFO - TEST-START | dromaeo_css 11:21:32 INFO - Initialising browser for dromaeo_css test... 11:21:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40008/getInfo.html -profile /tmp/tmp7ZYy54/profile 11:21:32 INFO - TEST-INFO | started process 14685 (/builds/slave/test/build/application/firefox/firefox http://localhost:40008/getInfo.html) 11:21:38 INFO - TEST-INFO | 14685: exit 0 11:21:38 INFO - Browser initialized. 11:21:38 INFO - Running cycle 1/1 for dromaeo_css test... 11:21:38 INFO - TEST-INFO | started process 14860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7ZYy54/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:39 INFO - PID 14860 | 11:21:39 INFO - PID 14860 | (/builds/slave/test/build/application/firefox/firefox:14908): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:21:39 INFO - PID 14860 | 11:21:49 INFO - PID 14860 | RSS: Main: 167436288 11:21:49 INFO - PID 14860 | 11:24:49 INFO - PID 14860 | Cycle 1(1): loaded http://localhost:40008/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40008/tests/dromaeo/cssquery-ext.html) 11:24:50 INFO - PID 14860 | RSS: Main: 172720128 11:24:50 INFO - PID 14860 | 11:27:52 INFO - PID 14860 | Cycle 1(1): loaded http://localhost:40008/tests/dromaeo/cssquery-ext.html (next: http://localhost:40008/tests/dromaeo/cssquery-jquery.html) 11:27:52 INFO - PID 14860 | RSS: Main: 169709568 11:27:52 INFO - PID 14860 | 11:30:54 INFO - PID 14860 | Cycle 1(1): loaded http://localhost:40008/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40008/tests/dromaeo/cssquery-mootools.html) 11:30:55 INFO - PID 14860 | RSS: Main: 170012672 11:30:55 INFO - PID 14860 | 11:33:56 INFO - PID 14860 | Cycle 1(1): loaded http://localhost:40008/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40008/tests/dromaeo/cssquery-prototype.html) 11:33:57 INFO - PID 14860 | RSS: Main: 169783296 11:33:57 INFO - PID 14860 | 11:37:01 INFO - PID 14860 | Cycle 1(1): loaded http://localhost:40008/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40008/tests/dromaeo/cssquery-yui.html) 11:37:01 INFO - PID 14860 | RSS: Main: 172453888 11:37:01 INFO - PID 14860 | 11:40:03 INFO - PID 14860 | Cycle 1(1): loaded http://localhost:40008/tests/dromaeo/cssquery-yui.html (next: http://localhost:40008/tests/dromaeo/cssquery-dojo.html) 11:40:03 INFO - PID 14860 | RSS: Main: 174284800 11:40:03 INFO - PID 14860 | 11:40:03 INFO - PID 14860 | __start_tp_report 11:40:03 INFO - PID 14860 | _x_x_mozilla_page_load 11:40:03 INFO - PID 14860 | _x_x_mozilla_page_load_details 11:40:03 INFO - PID 14860 | |i|pagename|runs| 11:40:03 INFO - PID 14860 | |0;dojo.html;3166.366726654668;3181.98409007955;3182.1090094773463;3201.615806103268;3205.503147012214;6081.878362432749;6189.071639254114;6227.782027629034;6238.500919926406;6249.843753906154;6016.2479690038745;6073.969630151854;6101.572889897709;6208.720607572659;6211.161493198417;5618.381977982419;5636.577256705753;5725.885482290351;5734.225879506255;5765.164051212571;5481.342238931334;5603.8599035024245;5666.858328541778;5692.0608099663505;5705.942940570582;5605;5646.378898321182;5675;5705.71471426427;5725.6278341908055;5539.861503462405;5580.776768929238;5594.160875868612;5605.019121653735;5605.831825045255;5586.469285417919;5594.832155035315;5595.244641973322;5656.434356564352;5665.716714164275;6044.395560443964;6071.332153463116;6139.140520327158;6153.538484613672;6201.596896201732;6557.3442655734525;6595.175603049619;6668.099806526106;6672.332766723289;6681.33186681328;6657.533972621918;6719.764808231688;6730.528862979593;6748.527603067787;6753.527253092286;6159.19930409044;6163.506919446433;6242.906356404657;6247.562670613013;6260.09228661846;6654.600723956578;6803.149606299213;6807.693653785592;6896.93103068973;6906.827329316808;6481.967590162019;6495.415412612888;6547.083408322838;6551.3776191262705;6556.63938483388;6596.406323430914;6600;6617.503687223478;6676.098726671934;6701.899471507932;6530.8040758777315;6531.477481801445;6617.272100068989;6623.271440141581;6645.933540664531;6493.837654058591;6588;6595.538312318187;6596.505262105361;6601.042848786899;5375.19372094189;5401.027814993339;5442;5451.318585176853;5501.9174712379345;4650.302454631832;4694.95305046952;4703.200455922433;4713.599344055794;4788.209945358977;5752.395998420189;5763;5785.8553536161935;5835.56233282497;5850.327212370632;6489.221293444817;6629.668516574152;6630.303818099127;6679.833004174838;6757.831054223586;5662.745176466987;5715.199872017921;5738.913916291259;5751.741171647286;5762.971185144132;5882.323532793698;5895.263092113486;5911.4975227105315;5938.049912014057;5951.553633477506;6459.547831651833;6465.773697920645;6538.313477084933;6554;6560.704768285439;6626.2379826318665;6632.966835165793;6634.104395906684;6726.831829204309;6738.056672066013;6418.454431373386;6434.517411194272;6438.323975982455;6446.0975463434215;6578.079068930258;6571.934280657132;6577.736890524326;6652.933470665232;6660.267370589135;6686.3313668632745;6690.899636505554;6700.2964688708935;6775.559588626724;6797.72809087631;6803.115594972622;6431.871362572816;6438.67806609677;6492.188476440445;6499.0901273820755;6501.967490162708;6381;6397.96801015992;6411.3909178627955;6436.581622194542;6464.644444555594;6293.874122517615;6309.274433440213;6316.11574379578;6393.104965304954;6421.550491465552;6353.52348573868;6373.044043393343;6479.8056058318325;6487.675616219076;6495.870082598416;6194.783182588588;6214.285357183981;6221.004639257697;6222.595531290452;6231.314555398993 11:40:03 INFO - PID 14860 | |1;ext.html;796.8645330293849;860.4665107633267;891.61660485991;896.6503063805117;1173.941302934854;30876.073717788448;31346;31347;40330.395044074365;41544;42422.36366454498;42682;42814.14371712564;42829.57170428295;42843;7612.124605670336;7615.80960475987;7773.183815699355;7775.30022297993;7843.333316668061;7594.126675432313;7713.228677132298;7714.421418393615;7714.807129821743;7716.884246736304;7649.579273139975;7678.270564296411;7717.6912923483;7720.189380115091;7721.845563088735;7660.961695191544;7671.769846904602;7681;7682.039745031843;7706.422018348646;7553.69785208591;7593.506422082547;7601.923980760177;7609.885851712229;7618.733344332977;38615.42076868849;39092.21815563701;39151.60848391508;39291.41062884059;39312;3573.446115852021;3602.5136606558303;3606.9098272543133;3616.7829930204007;3617.5478065241846;31039.844800775852;31187.532187017212;31229.37541249185;31246.843765781254;31263;5025.874353141164;5027.396712394499;5063.620228482841;5092.28707980883;5105.744712764384;196316;196513;197941;198207;198301.99999999854;47779;47849.5215047852;47850.76074619604;47865.282020769715;47917.520824792;49654;49726.25410618843;49791.50208497941;49835.25247121296;49875.75062124739;14826.777598336033;15049.322780474906;15057.774133388008;15081.396744130112;15094.698106038037;11695;12133.332666703416;13325.600231993056;13692.110012849133;13715.725685486233;14496.130232186102;14508.564743057725;14515;14524.128552286897;14622.049566778338;5782.6819524925695;5815.534757219412;5876.794312199053;6022.638641681513;6054.697265136726;994.3636072913341;1023.4217667018111;1025.8922813104666;1026.6355443817486;1029.9227557933184;22822.201222957116;23390.298291051295;30117.69882301149;30751.23121921925;31157.221069473446;1103.61925135828;1104.9060829829555;1113.7661091170944;1120.3110087296254;1124.960626378073;12470.314132722788;12690.175138615961;12760.680982975315;12801.0399220057;12833.101682882296;246099;249424;249449;249506;249624;54742.452575474534;54915;54994.450055498935;55079.44920550823;55148;1461.6272850423074;1512.3723654683404;1514.5986313626897;1529.9923500382426;1546.4510098914723;22930.312090637308;23021.19425820088;23109;23134.76865231326;23270.185543505897;39434.2113157741;39638.80180599194;39691.80154099211;39820.60179398169;39856;226307;227278;227579;227886;228243;36677.449838251916;37934.24131517409;38789.22421551609;38798.61201388063;38865.41701874418;46842.29736553886;47632.2855157166;48332.75833620809;48342;48514.75742621264;35338.46992295169;35424.645753542136;35660.821695891354;35907.46138807972;36223.818880905426;34231;34236;34491.655083448844;34654.306913862085;35398.29203415969;36384.27231455303;37196.81401592975;37344.253114938096;37410.251794963406;37509.624903751705;32743.672563274064;32774.67225327811;33032.33935321328;33252.66747332593;33457.16357090995;23611.88194059019;23946.88026559856;24821;24948.002079917325;25272.62091068672 11:40:03 INFO - PID 14860 | |2;jquery.html;571.4371344225939;571.948524632783;577.5899111630742;585.8711083561615;587.1339773833596;21441.14235430583;22292.777072229273;22359.888200558973;22409.55180896381;24184.395390115256;25226.243212703648;25841.353966150808;25924.48151036978;25932;26055.609165862526;6389.329120442357;6551.115599394068;6557.245916719567;6566.606003639797;6571.211454625452;6189.876202475948;6463.418292353711;6495.772647957322;6499.447546958514;6500.349965003509;6468.870622587546;6469.902951455709;6471.514636402265;6472;6474.870502589945;6345.333739957284;6441.549091563593;6455.774047908324;6464.935350646504;6470.870582588369;5986.221791167164;5988.520918326567;5991.670458124801;5992.700364981733;6005.579609427342;28956.855215723786;29038;29462.70537294621;30474.390512189853;30748.38503229945;1945.863789534733;2001.6797312429942;2002.9399118026483;2003.6193123306525;2003.8296744776712;19057;19298.13158407875;19752.40742777719;20151.798482015285;20201.494962625904;2338.1348900906773;2358.6226203807482;2402.9519409611885;2418.2019933422102;2419.2984034629935;129257;136345.6365436343;136523.31738341245;137491;137803;14132;14637.85362146365;14884.925575372054;15169.696606067817;15333.463328783439;23527.764722352556;23550.7644923552;23565.410864728517;23605.29184124479;23627;10383.532741026673;10549.103326217204;10719.83920241197;10748.22654262038;10776.892231077745;8726.389152759373;9282.90717092834;9748.220142388593;9889.752756181153;10014.048665376778;8926.821463570692;9180.724578262663;9260.629574817067;9288.442693438416;9641;2632.3945492536823;2667.6798784146026;2689.838609683386;2714.80996330255;2808.775297976157;977.5991843344194;986.5363279258737;994.2592768387598;1009.8434742614907;1017.4607458047099;19735;19766.604667906562;19948.3018094366;20137.798622013885;20372.388828335173;1042.2287507244585;1050.5745173204864;1052.678932925465;1054.435876805905;1061.8938106189319;10955.287906286225;11375.260608060615;13062;14050.36773345202;14111;538893;541176;544413.8337924934;546504;552459;124546;128435;130925;131216;132042.33978830237;1249.5501619417003;1257.2016769351344;1295.7214198947083;1296.1704509114174;1303.192020947;20295.9852007402;20390.490237744176;20543.8972805141;20557.794422055587;21032.789672103696;58651.41348586459;60478.395216047276;61988.760224796155;62644.686776565824;63955;71444.64277678786;72329;72713;78844;82432.17567824245;14364.28178591087;14869.033512821632;15015.549533514011;15022.774658380351;15043.849561504245;23260.76739232586;23361.41596460102;23477.53044939126;23637.172698955455;23694;18449.81550184481;18500.814991849908;18558.164882580048;18657.160427780513;18762.624747504702;15924.681506369576;16342.591435214215;16864.915675422035;17341.393051243147;17810.910945445707;17733.911330443265;18496.81503185005;18557.44327670172;18728.6254274911;18898.811011889706;14759.188244646648;14794.852051479347;14814.851851481348;14953.252337383305;14981;16775;17034.148292585072;17055.573610659834;17101.14494275306;17881.821181788535 11:40:03 INFO - PID 14860 | |3;mootools.html;1338.3776543907084;1392.6518370407398;1402.3549167383003;1404.4382247101164;1405.7469655462019;14117.929410352946;14388.208648524327;14743.189124598157;14789.926050369733;14797.556073317817;14142.080764750284;14349.354279057441;14378.352974116164;14385.280735963186;14399;2615.673040869896;2661.2548486423734;2663.161104252164;2667.333166708323;2667.7599016088548;2512.196097248881;2652.1778248742853;2694.9056783012597;2699.446613444249;2705.864706764664;2480.1443501991876;2503.7245902950663;2599.233226198276;2652.3634327761297;2653.615225792259;2452.91414800482;2463.8275320727557;2476.2447453526665;2478.045952308365;2478.1450399612286;2507.611320245365;2516.30801529579;2527.3428908483743;2528.532221539021;2528.5448619248527;13791;14141;14142.292885355793;14151.575452736331;14151.787723184161;7463.589502577356;7738.303552680286;7754;7789.454738168331;7791.22087791222;4806.903861922777;4974.676646017997;5041.571466425358;5119.718415487147;5149;1835.2383760739276;1837.5130590393555;1849.0847030719744;1886.3020682347483;1896.3078476356168;23319.883400582887;24042.879785601133;24767.5046499069;24792.132275370277;24810.131645392325;6468.094466774655;6500.902486462707;6544.509161812883;6584.440322572539;6771.28901465339;16095;16339;16346.18269086541;16571;16590.336386544644;7564.319211270902;7793.649285782153;7818.960905195438;7820.217978202248;7821.256980586835;7177.246389129171;7226.313500217471;7258.2741725828055;7298;7337.59643219628;5028.32117664118;5129.410117836422;5170.1986192140275;5185.092608793446;5213.582913366921;1487.3381345301236;1497.071815474391;1506.1038681984203;1513.402206128595;1523.200319832075;845.1843970568431;863.2921004776024;870.2863651805585;885.2386947225381;894.9463032218088;6989.405900498515;7081.964590177119;7101;7109.253528379446;7139.535930164523;701.4703898556659;702.3854127638316;705.0869124483805;706.3925024478943;710.9289071092953;4639.234526303122;5074.923876141861;5252.789888404497;5276.736163191825;5513.035218836688;18262.726059109125;20052.498687532927;20283.695744563844;20381.79618203799;20492.18031278732;19228.61542769137;19742.50643733918;20065.39803805888;20084.598308033757;20119.59760804805;11097.722556936142;11203.21577489568;11282.661520154408;11287.943560282147;11319.264247823865;7905.209479052049;8055.436119471581;8145.714899978472;8262.545559994258;8370.832583348178;17126.229319680395;17340.393086241922;17502.562435939202;17637.470875873743;18265.178066987282;17661.646767064845;18026.72959905576;18069.91580505174;18184.636307273515;18213.726794098366;11605.30368177912;11776.470058847544;11780.587679431179;11781.587644432746;11920.761584768083;12840.10119291678;13176.143550669176;13322;13332.733345333232;13336.799948000593;11065.889341106486;11076.612318568812;11088.002079812855;11141.2201145919;11282.492287846902;10749.785004299714;10885.727856803644;10921.83617245726;11112.333260004425;11233.775324493628;9635.855462168212;9667.419954802734;9844;9888.950555247178;9899.010098990331;7367.373773229121;7388.519746216479;7428.257174282745;7429.517081389692;7483.476156669199;7218.855622887618;7271.927280727125;7281.453890958093;7292.562446253241;7298.4526160539235 11:40:03 INFO - PID 14860 | |4;prototype.html;491.6352345219493;499.1605932140062;528.3254961741092;529.9004565526534;536.1983834167918;6138.171346868172;6176.629402235863;6198.535109866762;6212;6221.097940798587;5897.557683173758;5983.820485385435;6037.366076561963;6057.91046566251;6075.392460753922;4875.341828853113;4898.510148985109;4935.6545041847085;4962.478939711333;4975.800967961277;4800.303955926389;4884.902301953959;4916.950830491703;4942.308076869242;4955.876103097416;4873;4892.706437613754;4913.312136300903;4934.25986102084;4952.182889823175;4861.270809378586;4896.363472748538;4898.363212782351;4922.876928076791;4927.975360123194;4390.53899340571;4405.11897620474;4411.801468933906;4424.380586717862;4444.177827101997;5835.679037652927;5904.763809447617;5908.852278693024;5922.55808143892;6013.759449622054;5539.224508568804;5542.334919809648;5597.944020559824;5634.562916620858;5683.857903552403;6309.810705678837;6328.620282783002;6352.871787951042;6479.64361960092;6490.740370385179;4797.328374027639;4814.831480898151;4818.975905120487;4828.420589529243;4865.586425153866;6661.600303981777;6709.798706038827;6724.260331363546;6822.454203663695;6888;4952.504749525091;4953.50464953509;4960.652754307164;4970.353853998957;4993.825216117491;5065;5080.949190508048;5085.4914508548845;5093.974530127326;5112.769925353368;5577.163425486209;5613.158026296088;5650.124230744241;5696.971515142398;5699.601027928005;6429.3570642936265;6453.741850326029;6457.677116144174;6461.644609546426;6538.215414150332;1678.7901512310962;1698.736695812151;1829.1494455078453;1880.2385034061226;1917.405604262683;1389.6728624164102;1398.1680899864564;1421.133108803629;1450.2531196433845;1455.1923682356182;5487.5609951203805;5547.528460080857;5570.526505247019;5592.552595792326;5650.5479561634975;6522.7381713555515;6542.869142617216;6586.571872828251;6639.269680335159;6645.800625981228;5655.519280861173;5670;5688.374278829326;5691.345495268014;5728.226689396962;3530.6292839252023;3555.8755443559353;3564.11102115879;3578.4632305153914;3583.8566457341935;6545.247296560957;6566.704498297588;6572.277049524549;6585.506087043491;6590.340965903371;6851.794446166623;6920.550164239308;6929.826754331081;6930.237673855871;6930.237673855871;6442.871142577216;6485.313818407248;6512.479001679949;6540;6590.934090659128;6625.536212465274;6680.766173183915;6684.532082754161;6702.396784289437;6707.1616047994;6545.901811472737;6634.436072933855;6638.435732962752;6641;6652.667366631552;6453.612783233021;6500.489735542754;6507.544471886922;6556.967215163893;6559.180102487189;4967.155583550877;4977.203647416396;4990.451050384528;5044.9315780529805;5054.393472783143;6404.967975160094;6648.335166483506;6654.90017649726;6708.899366509604;6725.242650513266;6368;6404.71178796946;6439.484841212786;6439.67801609927;6470.7088181032905;6377.808665740035;6452.645104519296;6523.347665233438;6525.477961762953;6562.80311590653;6112.572119951561;6368.9044664330995;6409.7115629795835;6424.261209960914;6441;6340.334264902303;6385.297617262005;6400.743970241325;6478.70845811949;6531.967340163269;6202.689865506797;6220.813375598739;6243.157173781481;6271.714298568691;6320.577869979218 11:40:03 INFO - PID 14860 | |5;yui.html;908.9636414543419;919.599974011305;932.6222879733701;936.5036530638764;943.1276069635585;18575.814241857577;19463;19575.314863979762;19583.314583989562;21391.251306204285;21357.252496162637;21732.565348693017;21744.456388590293;21945.890270548665;21971.121155153774;1030.7268573827923;1057.1384321777764;1058.449606204773;1066.402814423925;1067.11429513504;954.8281309364312;1056.6407421476697;1058.031900810761;1060.0724366179593;1062.4050531702233;1103.1615971861404;1103.4041617526525;1103.6413165721174;1105.8949399807045;1106.2919731371887;1091.1707102602;1095.8246680531156;1102.1348241630321;1103.6082190822262;1105.690406686129;806.3911746631256;806.7862016565615;806.9757907262791;807.3057170833079;810.6676262732251;19242.80757192424;20356;20789.480262993395;20959.68560471594;21002.264920727703;21039.263625773023;21578.89210553953;21617.891910540504;21626.567468650537;22640.660390094163;16207.270672819752;16799.412020579344;17072.06103664298;17139.485815425556;17156.914215428842;3663.285659296438;3681.834317455721;3706.610805865399;3706.9073273168115;3707.2214834884708;115630;117628.82371176264;128311.35844320718;130221;133540;17396.39112631052;18029;18053.548661283574;18114.547136321435;18163.72754408685;31468.527972080436;31677.8416107918;31990.200244993597;32016.839915800272;32381.19047023796;7699.384049276045;8054.758357249292;9137.177654011039;9419.858702119474;9419.905800941902;4456.309272062836;4548.56788605082;4557.475890272594;4563.224251877189;4568.565986231302;5234.398044224887;5258.447862974409;5359.544438722674;5398.784048638089;5408.8377348679605;1066.6853278282924;1068.108129711684;1068.7435015596202;1082.3722241100143;1084.8426978088132;603.3574243430733;620.8230654263514;622.5206590925053;626.0921663587816;643.1863692429081;11702.35637039971;12119.272843629411;12537.373131343396;13397.397117129753;13834.446622135203;693.1855070292386;693.7606525748608;696.1437431958618;706.1103010207175;713.0302788208033;5351.331083614548;5646.971765141148;5878.970605146947;5941.316748573883;5959.970200149059;102355.48822255842;106239.4688026555;107897;109088.4545577267;109596.4520177394;91410.54294728617;98850;99349.50325248328;102328.48835755922;102840.48579757054;80733;85793.57103214443;85907.57046214853;89465.55267223752;89628;12212.267263964191;12421.503139874303;12642.2414655121;12698.36508174606;12698.809517857424;38997.415038775005;39869.60130398659;40151.79924100361;40563.391549126194;41001;69278;69703.65148174227;70067;72314.27685723286;78079;17279.56801079983;17696.646067078327;17797;18865.811341886954;19189.904050479658;20822.89588552108;21157.576848462635;21275;21546.030428630434;21637.783622163577;18926;19254.326098586484;19309.227630894606;19421.2231510738;19432.125554349805;18113.18490667897;18115.36596219126;18329.633407331512;18512;18565.628687425906;17597.208125634123;17767.822321776617;17869.106544672974;18243.90878045601;18317.175727092046;12710.36448177606;12941.482340706267;13227.603171904859;13418.731625367243;13517.256550889795;14465.638359041108;14895.702085958437;15365;15469.071855688695;15528.767068493755 11:40:03 INFO - PID 14860 | __end_tp_report 11:40:03 INFO - PID 14860 | __start_cc_report 11:40:03 INFO - PID 14860 | _x_x_mozilla_cycle_collect,343 11:40:03 INFO - PID 14860 | __end_cc_report 11:40:03 INFO - PID 14860 | __startTimestamp1502995203774__endTimestamp 11:40:03 INFO - PID 14860 | 11:40:03 INFO - PID 14860 | ------- Summary: start ------- 11:40:03 INFO - PID 14860 | Number of tests: 6 11:40:03 INFO - PID 14860 | 11:40:03 INFO - PID 14860 | [#0] dojo.html Cycles:165 Average:6111.95 Median:6316.12 stddev:708.50 (11.2%) stddev-sans-first:671.94 11:40:03 INFO - PID 14860 | Values: 3166.4 3182.0 3182.1 3201.6 3205.5 6081.9 6189.1 6227.8 6238.5 6249.8 6016.2 6074.0 6101.6 6208.7 6211.2 5618.4 5636.6 5725.9 5734.2 5765.2 5481.3 5603.9 5666.9 5692.1 5705.9 5605.0 5646.4 5675.0 5705.7 5725.6 5539.9 5580.8 5594.2 5605.0 5605.8 5586.5 5594.8 5595.2 5656.4 5665.7 6044.4 6071.3 6139.1 6153.5 6201.6 6557.3 6595.2 6668.1 6672.3 6681.3 6657.5 6719.8 6730.5 6748.5 6753.5 6159.2 6163.5 6242.9 6247.6 6260.1 6654.6 6803.1 6807.7 6896.9 6906.8 6482.0 6495.4 6547.1 6551.4 6556.6 6596.4 6600.0 6617.5 6676.1 6701.9 6530.8 6531.5 6617.3 6623.3 6645.9 6493.8 6588.0 6595.5 6596.5 6601.0 5375.2 5401.0 5442.0 5451.3 5501.9 4650.3 4695.0 4703.2 4713.6 4788.2 5752.4 5763.0 5785.9 5835.6 5850.3 6489.2 6629.7 6630.3 6679.8 6757.8 5662.7 5715.2 5738.9 5751.7 5763.0 5882.3 5895.3 5911.5 5938.0 5951.6 6459.5 6465.8 6538.3 6554.0 6560.7 6626.2 6633.0 6634.1 6726.8 6738.1 6418.5 6434.5 6438.3 6446.1 6578.1 6571.9 6577.7 6652.9 6660.3 6686.3 6690.9 6700.3 6775.6 6797.7 6803.1 6431.9 6438.7 6492.2 6499.1 6502.0 6381.0 6398.0 6411.4 6436.6 6464.6 6293.9 6309.3 6316.1 6393.1 6421.6 6353.5 6373.0 6479.8 6487.7 6495.9 6194.8 6214.3 6221.0 6222.6 6231.3 11:40:03 INFO - PID 14860 | 11:40:03 INFO - PID 14860 | [#1] ext.html Cycles:180 Average:39688.22 Median:3617.17 stddev:58529.38 (1618.1%) stddev-sans-first:58620.72 11:40:03 INFO - PID 14860 | Values: 796.9 860.5 891.6 896.7 1173.9 30876.1 31346.0 31347.0 40330.4 41544.0 42422.4 42682.0 42814.1 42829.6 42843.0 7612.1 7615.8 7773.2 7775.3 7843.3 7594.1 7713.2 7714.4 7714.8 7716.9 7649.6 7678.3 7717.7 7720.2 7721.8 7661.0 7671.8 7681.0 7682.0 7706.4 7553.7 7593.5 7601.9 7609.9 7618.7 38615.4 39092.2 39151.6 39291.4 39312.0 3573.4 3602.5 3606.9 3616.8 3617.5 31039.8 31187.5 31229.4 31246.8 31263.0 5025.9 5027.4 5063.6 5092.3 5105.7 196316.0 196513.0 197941.0 198207.0 198302.0 47779.0 47849.5 47850.8 47865.3 47917.5 49654.0 49726.3 49791.5 49835.3 49875.8 14826.8 15049.3 15057.8 15081.4 15094.7 11695.0 12133.3 13325.6 13692.1 13715.7 14496.1 14508.6 14515.0 14524.1 14622.0 5782.7 5815.5 5876.8 6022.6 6054.7 994.4 1023.4 1025.9 1026.6 1029.9 22822.2 23390.3 30117.7 30751.2 31157.2 1103.6 1104.9 1113.8 1120.3 1125.0 12470.3 12690.2 12760.7 12801.0 12833.1 246099.0 249424.0 249449.0 249506.0 249624.0 54742.5 54915.0 54994.5 55079.4 55148.0 1461.6 1512.4 1514.6 1530.0 1546.5 22930.3 23021.2 23109.0 23134.8 23270.2 39434.2 39638.8 39691.8 39820.6 39856.0 226307.0 227278.0 227579.0 227886.0 228243.0 36677.4 37934.2 38789.2 38798.6 38865.4 46842.3 47632.3 48332.8 48342.0 48514.8 35338.5 35424.6 35660.8 35907.5 36223.8 34231.0 34236.0 34491.7 34654.3 35398.3 36384.3 37196.8 37344.3 37410.3 37509.6 32743.7 32774.7 33032.3 33252.7 33457.2 23611.9 23946.9 24821.0 24948.0 25272.6 11:40:03 INFO - PID 14860 | 11:40:03 INFO - PID 14860 | [#2] jquery.html Cycles:180 Average:37019.93 Median:22384.72 stddev:91388.82 (408.3%) stddev-sans-first:91604.22 11:40:03 INFO - PID 14860 | Values: 571.4 571.9 577.6 585.9 587.1 21441.1 22292.8 22359.9 22409.6 24184.4 25226.2 25841.4 25924.5 25932.0 26055.6 6389.3 6551.1 6557.2 6566.6 6571.2 6189.9 6463.4 6495.8 6499.4 6500.3 6468.9 6469.9 6471.5 6472.0 6474.9 6345.3 6441.5 6455.8 6464.9 6470.9 5986.2 5988.5 5991.7 5992.7 6005.6 28956.9 29038.0 29462.7 30474.4 30748.4 1945.9 2001.7 2002.9 2003.6 2003.8 19057.0 19298.1 19752.4 20151.8 20201.5 2338.1 2358.6 2403.0 2418.2 2419.3 129257.0 136345.6 136523.3 137491.0 137803.0 14132.0 14637.9 14884.9 15169.7 15333.5 23527.8 23550.8 23565.4 23605.3 23627.0 10383.5 10549.1 10719.8 10748.2 10776.9 8726.4 9282.9 9748.2 9889.8 10014.0 8926.8 9180.7 9260.6 9288.4 9641.0 2632.4 2667.7 2689.8 2714.8 2808.8 977.6 986.5 994.3 1009.8 1017.5 19735.0 19766.6 19948.3 20137.8 20372.4 1042.2 1050.6 1052.7 1054.4 1061.9 10955.3 11375.3 13062.0 14050.4 14111.0 538893.0 541176.0 544413.8 546504.0 552459.0 124546.0 128435.0 130925.0 131216.0 132042.3 1249.6 1257.2 1295.7 1296.2 1303.2 20296.0 20390.5 20543.9 20557.8 21032.8 58651.4 60478.4 61988.8 62644.7 63955.0 71444.6 72329.0 72713.0 78844.0 82432.2 14364.3 14869.0 15015.5 15022.8 15043.8 23260.8 23361.4 23477.5 23637.2 23694.0 18449.8 18500.8 18558.2 18657.2 18762.6 15924.7 16342.6 16864.9 17341.4 17810.9 17733.9 18496.8 18557.4 18728.6 18898.8 14759.2 14794.9 14814.9 14953.3 14981.0 16775.0 17034.1 17055.6 17101.1 17881.8 11:40:03 INFO - PID 14860 | 11:40:03 INFO - PID 14860 | [#3] mootools.html Cycles:180 Average:8914.48 Median:13656.93 stddev:6212.09 (45.5%) stddev-sans-first:6203.43 11:40:03 INFO - PID 14860 | Values: 1338.4 1392.7 1402.4 1404.4 1405.7 14117.9 14388.2 14743.2 14789.9 14797.6 14142.1 14349.4 14378.4 14385.3 14399.0 2615.7 2661.3 2663.2 2667.3 2667.8 2512.2 2652.2 2694.9 2699.4 2705.9 2480.1 2503.7 2599.2 2652.4 2653.6 2452.9 2463.8 2476.2 2478.0 2478.1 2507.6 2516.3 2527.3 2528.5 2528.5 13791.0 14141.0 14142.3 14151.6 14151.8 7463.6 7738.3 7754.0 7789.5 7791.2 4806.9 4974.7 5041.6 5119.7 5149.0 1835.2 1837.5 1849.1 1886.3 1896.3 23319.9 24042.9 24767.5 24792.1 24810.1 6468.1 6500.9 6544.5 6584.4 6771.3 16095.0 16339.0 16346.2 16571.0 16590.3 7564.3 7793.6 7819.0 7820.2 7821.3 7177.2 7226.3 7258.3 7298.0 7337.6 5028.3 5129.4 5170.2 5185.1 5213.6 1487.3 1497.1 1506.1 1513.4 1523.2 845.2 863.3 870.3 885.2 894.9 6989.4 7082.0 7101.0 7109.3 7139.5 701.5 702.4 705.1 706.4 710.9 4639.2 5074.9 5252.8 5276.7 5513.0 18262.7 20052.5 20283.7 20381.8 20492.2 19228.6 19742.5 20065.4 20084.6 20119.6 11097.7 11203.2 11282.7 11287.9 11319.3 7905.2 8055.4 8145.7 8262.5 8370.8 17126.2 17340.4 17502.6 17637.5 18265.2 17661.6 18026.7 18069.9 18184.6 18213.7 11605.3 11776.5 11780.6 11781.6 11920.8 12840.1 13176.1 13322.0 13332.7 13336.8 11065.9 11076.6 11088.0 11141.2 11282.5 10749.8 10885.7 10921.8 11112.3 11233.8 9635.9 9667.4 9844.0 9889.0 9899.0 7367.4 7388.5 7428.3 7429.5 7483.5 7218.9 7271.9 7281.5 7292.6 7298.5 11:40:03 INFO - PID 14860 | 11:40:03 INFO - PID 14860 | [#4] prototype.html Cycles:180 Average:5457.41 Median:5998.79 stddev:1506.45 (25.1%) stddev-sans-first:1463.84 11:40:03 INFO - PID 14860 | Values: 491.6 499.2 528.3 529.9 536.2 6138.2 6176.6 6198.5 6212.0 6221.1 5897.6 5983.8 6037.4 6057.9 6075.4 4875.3 4898.5 4935.7 4962.5 4975.8 4800.3 4884.9 4917.0 4942.3 4955.9 4873.0 4892.7 4913.3 4934.3 4952.2 4861.3 4896.4 4898.4 4922.9 4928.0 4390.5 4405.1 4411.8 4424.4 4444.2 5835.7 5904.8 5908.9 5922.6 6013.8 5539.2 5542.3 5597.9 5634.6 5683.9 6309.8 6328.6 6352.9 6479.6 6490.7 4797.3 4814.8 4819.0 4828.4 4865.6 6661.6 6709.8 6724.3 6822.5 6888.0 4952.5 4953.5 4960.7 4970.4 4993.8 5065.0 5080.9 5085.5 5094.0 5112.8 5577.2 5613.2 5650.1 5697.0 5699.6 6429.4 6453.7 6457.7 6461.6 6538.2 1678.8 1698.7 1829.1 1880.2 1917.4 1389.7 1398.2 1421.1 1450.3 1455.2 5487.6 5547.5 5570.5 5592.6 5650.5 6522.7 6542.9 6586.6 6639.3 6645.8 5655.5 5670.0 5688.4 5691.3 5728.2 3530.6 3555.9 3564.1 3578.5 3583.9 6545.2 6566.7 6572.3 6585.5 6590.3 6851.8 6920.6 6929.8 6930.2 6930.2 6442.9 6485.3 6512.5 6540.0 6590.9 6625.5 6680.8 6684.5 6702.4 6707.2 6545.9 6634.4 6638.4 6641.0 6652.7 6453.6 6500.5 6507.5 6557.0 6559.2 4967.2 4977.2 4990.5 5044.9 5054.4 6405.0 6648.3 6654.9 6708.9 6725.2 6368.0 6404.7 6439.5 6439.7 6470.7 6377.8 6452.6 6523.3 6525.5 6562.8 6112.6 6368.9 6409.7 6424.3 6441.0 6340.3 6385.3 6400.7 6478.7 6532.0 6202.7 6220.8 6243.2 6271.7 6320.6 11:40:03 INFO - PID 14860 | 11:40:03 INFO - PID 14860 | [#5] yui.html Cycles:180 Average:24022.42 Median:19969.66 stddev:31944.98 (160.0%) stddev-sans-first:31987.44 11:40:03 INFO - PID 14860 | Values: 909.0 919.6 932.6 936.5 943.1 18575.8 19463.0 19575.3 19583.3 21391.3 21357.3 21732.6 21744.5 21945.9 21971.1 1030.7 1057.1 1058.4 1066.4 1067.1 954.8 1056.6 1058.0 1060.1 1062.4 1103.2 1103.4 1103.6 1105.9 1106.3 1091.2 1095.8 1102.1 1103.6 1105.7 806.4 806.8 807.0 807.3 810.7 19242.8 20356.0 20789.5 20959.7 21002.3 21039.3 21578.9 21617.9 21626.6 22640.7 16207.3 16799.4 17072.1 17139.5 17156.9 3663.3 3681.8 3706.6 3706.9 3707.2 115630.0 117628.8 128311.4 130221.0 133540.0 17396.4 18029.0 18053.5 18114.5 18163.7 31468.5 31677.8 31990.2 32016.8 32381.2 7699.4 8054.8 9137.2 9419.9 9419.9 4456.3 4548.6 4557.5 4563.2 4568.6 5234.4 5258.4 5359.5 5398.8 5408.8 1066.7 1068.1 1068.7 1082.4 1084.8 603.4 620.8 622.5 626.1 643.2 11702.4 12119.3 12537.4 13397.4 13834.4 693.2 693.8 696.1 706.1 713.0 5351.3 5647.0 5879.0 5941.3 5960.0 102355.5 106239.5 107897.0 109088.5 109596.5 91410.5 98850.0 99349.5 102328.5 102840.5 80733.0 85793.6 85907.6 89465.6 89628.0 12212.3 12421.5 12642.2 12698.4 12698.8 38997.4 39869.6 40151.8 40563.4 41001.0 69278.0 69703.7 70067.0 72314.3 78079.0 17279.6 17696.6 17797.0 18865.8 19189.9 20822.9 21157.6 21275.0 21546.0 21637.8 18926.0 19254.3 19309.2 19421.2 19432.1 18113.2 18115.4 18329.6 18512.0 18565.6 17597.2 17767.8 17869.1 18243.9 18317.2 12710.4 12941.5 13227.6 13418.7 13517.3 14465.6 14895.7 15365.0 15469.1 15528.8 11:40:03 INFO - PID 14860 | -------- Summary: end -------- 11:40:03 INFO - PID 14860 | 11:40:04 INFO - TEST-INFO | 14860: exit 0 11:40:04 INFO - TEST-OK | dromaeo_css | took 1112194ms 11:40:04 INFO - TEST-START | kraken 11:40:04 INFO - Initialising browser for kraken test... 11:40:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40008/getInfo.html -profile /tmp/tmpOnTt4Y/profile 11:40:04 INFO - TEST-INFO | started process 15225 (/builds/slave/test/build/application/firefox/firefox http://localhost:40008/getInfo.html) 11:40:10 INFO - TEST-INFO | 15225: exit 0 11:40:10 INFO - Browser initialized. 11:40:10 INFO - Running cycle 1/1 for kraken test... 11:40:10 INFO - TEST-INFO | started process 15400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOnTt4Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:11 INFO - PID 15400 | 11:40:11 INFO - PID 15400 | (/builds/slave/test/build/application/firefox/firefox:15448): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:40:11 INFO - PID 15400 | 11:40:21 INFO - PID 15400 | RSS: Main: 163205120 11:40:21 INFO - PID 15400 | 11:40:24 INFO - PID 15400 | Cycle 1(1): loaded http://localhost:40008/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40008/tests/kraken/driver.html?testName=audio-beat-detection) 11:40:25 INFO - PID 15400 | RSS: Main: 170774528 11:40:25 INFO - PID 15400 | 11:40:27 INFO - PID 15400 | Cycle 1(1): loaded http://localhost:40008/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40008/tests/kraken/driver.html?testName=audio-dft) 11:40:28 INFO - PID 15400 | RSS: Main: 174096384 11:40:28 INFO - PID 15400 | 11:40:31 INFO - PID 15400 | Cycle 1(1): loaded http://localhost:40008/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40008/tests/kraken/driver.html?testName=audio-fft) 11:40:32 INFO - PID 15400 | RSS: Main: 167485440 11:40:32 INFO - PID 15400 | 11:40:34 INFO - PID 15400 | Cycle 1(1): loaded http://localhost:40008/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40008/tests/kraken/driver.html?testName=audio-oscillator) 11:40:34 INFO - PID 15400 | RSS: Main: 167182336 11:40:34 INFO - PID 15400 | 11:40:37 INFO - PID 15400 | Cycle 1(1): loaded http://localhost:40008/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40008/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:40:37 INFO - PID 15400 | RSS: Main: 168800256 11:40:37 INFO - PID 15400 | 11:40:40 INFO - PID 15400 | Cycle 1(1): loaded http://localhost:40008/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40008/tests/kraken/driver.html?testName=imaging-darkroom) 11:40:41 INFO - PID 15400 | RSS: Main: 169267200 11:40:41 INFO - PID 15400 | 11:40:44 INFO - PID 15400 | Cycle 1(1): loaded http://localhost:40008/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40008/tests/kraken/driver.html?testName=imaging-desaturate) 11:40:45 INFO - PID 15400 | RSS: Main: 171704320 11:40:45 INFO - PID 15400 | 11:40:48 INFO - PID 15400 | Cycle 1(1): loaded http://localhost:40008/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40008/tests/kraken/driver.html?testName=json-parse-financial) 11:40:48 INFO - PID 15400 | RSS: Main: 170192896 11:40:48 INFO - PID 15400 | 11:40:50 INFO - PID 15400 | Cycle 1(1): loaded http://localhost:40008/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40008/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:40:51 INFO - PID 15400 | RSS: Main: 169840640 11:40:51 INFO - PID 15400 | 11:40:52 INFO - PID 15400 | Cycle 1(1): loaded http://localhost:40008/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40008/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:40:53 INFO - PID 15400 | RSS: Main: 170024960 11:40:53 INFO - PID 15400 | 11:40:55 INFO - PID 15400 | Cycle 1(1): loaded http://localhost:40008/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40008/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:40:56 INFO - PID 15400 | RSS: Main: 169496576 11:40:56 INFO - PID 15400 | 11:40:58 INFO - PID 15400 | Cycle 1(1): loaded http://localhost:40008/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:40:59 INFO - PID 15400 | RSS: Main: 171122688 11:40:59 INFO - PID 15400 | 11:41:02 INFO - PID 15400 | Cycle 1(1): loaded http://localhost:40008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:41:03 INFO - PID 15400 | RSS: Main: 170463232 11:41:03 INFO - PID 15400 | 11:41:05 INFO - PID 15400 | Cycle 1(1): loaded http://localhost:40008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40008/tests/kraken/driver.html?testName=ai-astar) 11:41:05 INFO - PID 15400 | RSS: Main: 172503040 11:41:05 INFO - PID 15400 | 11:41:05 INFO - PID 15400 | __start_tp_report 11:41:05 INFO - PID 15400 | _x_x_mozilla_page_load 11:41:05 INFO - PID 15400 | _x_x_mozilla_page_load_details 11:41:05 INFO - PID 15400 | |i|pagename|runs| 11:41:05 INFO - PID 15400 | |0;ai-astar;97;108;101;108;107;110;107;99;107;108 11:41:05 INFO - PID 15400 | |1;audio-beat-detection;143;120;151;181;121;146;147;120;188;120 11:41:05 INFO - PID 15400 | |2;audio-dft;164;163;163;163;163;161;164;164;166;167 11:41:05 INFO - PID 15400 | |3;audio-fft;75;75;75;104;75;75;75;89;122;76 11:41:05 INFO - PID 15400 | |4;audio-oscillator;79;78;135;78;79;79;141;79;79;131 11:41:05 INFO - PID 15400 | |5;imaging-gaussian-blur;114;114;114;114;114;114;114;115;115;114 11:41:05 INFO - PID 15400 | |6;imaging-darkroom;151;151;150;149;149;149;150;150;152;151 11:41:05 INFO - PID 15400 | |7;imaging-desaturate;94;95;94;94;94;95;94;94;95;94 11:41:05 INFO - PID 15400 | |8;json-parse-financial;54;54;54;54;54;53;53;58;54;54 11:41:05 INFO - PID 15400 | |9;json-stringify-tinderbox;54;54;53;54;54;53;54;54;54;54 11:41:05 INFO - PID 15400 | |10;stanford-crypto-aes;82;76;76;77;77;77;76;76;75;77 11:41:05 INFO - PID 15400 | |11;stanford-crypto-ccm;134;131;119;121;125;126;126;127;118;172 11:41:05 INFO - PID 15400 | |12;stanford-crypto-pbkdf2;175;177;179;174;189;174;174;178;169;173 11:41:05 INFO - PID 15400 | |13;stanford-crypto-sha256-iterative;68;72;68;68;68;67;66;68;68;66 11:41:05 INFO - PID 15400 | __end_tp_report 11:41:05 INFO - PID 15400 | __start_cc_report 11:41:05 INFO - PID 15400 | _x_x_mozilla_cycle_collect,948 11:41:05 INFO - PID 15400 | __end_cc_report 11:41:05 INFO - PID 15400 | __startTimestamp1502995265352__endTimestamp 11:41:05 INFO - PID 15400 | 11:41:05 INFO - PID 15400 | ------- Summary: start ------- 11:41:05 INFO - PID 15400 | Number of tests: 14 11:41:05 INFO - PID 15400 | 11:41:05 INFO - PID 15400 | [#0] ai-astar Cycles:10 Average:105.20 Median:108.00 stddev:4.47 (4.1%) stddev-sans-first:3.62 11:41:05 INFO - PID 15400 | Values: 97.0 108.0 101.0 108.0 107.0 110.0 107.0 99.0 107.0 108.0 11:41:05 INFO - PID 15400 | 11:41:05 INFO - PID 15400 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:146.50 stddev:25.00 (17.1%) stddev-sans-first:26.51 11:41:05 INFO - PID 15400 | Values: 143.0 120.0 151.0 181.0 121.0 146.0 147.0 120.0 188.0 120.0 11:41:05 INFO - PID 15400 | 11:41:05 INFO - PID 15400 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:1.69 (1.0%) stddev-sans-first:1.79 11:41:05 INFO - PID 15400 | Values: 164.0 163.0 163.0 163.0 163.0 161.0 164.0 164.0 166.0 167.0 11:41:05 INFO - PID 15400 | 11:41:05 INFO - PID 15400 | [#3] audio-fft Cycles:10 Average:84.10 Median:75.00 stddev:16.39 (21.9%) stddev-sans-first:17.05 11:41:05 INFO - PID 15400 | Values: 75.0 75.0 75.0 104.0 75.0 75.0 75.0 89.0 122.0 76.0 11:41:05 INFO - PID 15400 | 11:41:05 INFO - PID 15400 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:79.00 stddev:27.62 (35.0%) stddev-sans-first:28.61 11:41:05 INFO - PID 15400 | Values: 79.0 78.0 135.0 78.0 79.0 79.0 141.0 79.0 79.0 131.0 11:41:05 INFO - PID 15400 | 11:41:05 INFO - PID 15400 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:41:05 INFO - PID 15400 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 114.0 115.0 115.0 114.0 11:41:05 INFO - PID 15400 | 11:41:05 INFO - PID 15400 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.50 stddev:1.03 (0.7%) stddev-sans-first:1.05 11:41:05 INFO - PID 15400 | Values: 151.0 151.0 150.0 149.0 149.0 149.0 150.0 150.0 152.0 151.0 11:41:05 INFO - PID 15400 | 11:41:05 INFO - PID 15400 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:41:05 INFO - PID 15400 | Values: 94.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 11:41:05 INFO - PID 15400 | 11:41:05 INFO - PID 15400 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:1.40 (2.6%) stddev-sans-first:1.48 11:41:05 INFO - PID 15400 | Values: 54.0 54.0 54.0 54.0 54.0 53.0 53.0 58.0 54.0 54.0 11:41:05 INFO - PID 15400 | 11:41:05 INFO - PID 15400 | [#9] json-stringify-tinderbox Cycles:10 Average:53.80 Median:54.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 11:41:05 INFO - PID 15400 | Values: 54.0 54.0 53.0 54.0 54.0 53.0 54.0 54.0 54.0 54.0 11:41:05 INFO - PID 15400 | 11:41:05 INFO - PID 15400 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:77.00 stddev:1.91 (2.5%) stddev-sans-first:0.71 11:41:05 INFO - PID 15400 | Values: 82.0 76.0 76.0 77.0 77.0 77.0 76.0 76.0 75.0 77.0 11:41:05 INFO - PID 15400 | 11:41:05 INFO - PID 15400 | [#11] stanford-crypto-ccm Cycles:10 Average:129.90 Median:126.50 stddev:15.61 (12.3%) stddev-sans-first:16.49 11:41:05 INFO - PID 15400 | Values: 134.0 131.0 119.0 121.0 125.0 126.0 126.0 127.0 118.0 172.0 11:41:05 INFO - PID 15400 | 11:41:05 INFO - PID 15400 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.20 Median:176.00 stddev:5.31 (3.0%) stddev-sans-first:5.61 11:41:05 INFO - PID 15400 | Values: 175.0 177.0 179.0 174.0 189.0 174.0 174.0 178.0 169.0 173.0 11:41:05 INFO - PID 15400 | 11:41:05 INFO - PID 15400 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.66 (2.4%) stddev-sans-first:1.76 11:41:05 INFO - PID 15400 | Values: 68.0 72.0 68.0 68.0 68.0 67.0 66.0 68.0 68.0 66.0 11:41:05 INFO - PID 15400 | -------- Summary: end -------- 11:41:05 INFO - PID 15400 | 11:41:05 INFO - PID 15400 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:41:05 INFO - TEST-INFO | 15400: exit 0 11:41:06 INFO - TEST-OK | kraken | took 61588ms 11:41:06 INFO - SUITE-END | took 1173s 11:41:06 INFO - Completed test suite (00:19:34) 11:41:06 INFO - javascript benchmark 11:41:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8563.433236156327, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3166.366726654668, 3181.98409007955, 3182.1090094773463, 3201.615806103268, 3205.503147012214, 6081.878362432749, 6189.071639254114, 6227.782027629034, 6238.500919926406, 6249.843753906154, 6016.2479690038745, 6073.969630151854, 6101.572889897709, 6208.720607572659, 6211.161493198417, 5618.381977982419, 5636.577256705753, 5725.885482290351, 5734.225879506255, 5765.164051212571, 5481.342238931334, 5603.8599035024245, 5666.858328541778, 5692.0608099663505, 5705.942940570582, 5605.0, 5646.378898321182, 5675.0, 5705.71471426427, 5725.6278341908055, 5539.861503462405, 5580.776768929238, 5594.160875868612, 5605.019121653735, 5605.831825045255, 5586.469285417919, 5594.832155035315, 5595.244641973322, 5656.434356564352, 5665.716714164275, 6044.395560443964, 6071.332153463116, 6139.140520327158, 6153.538484613672, 6201.596896201732, 6557.3442655734525, 6595.175603049619, 6668.099806526106, 6672.332766723289, 6681.33186681328, 6657.533972621918, 6719.764808231688, 6730.528862979593, 6748.527603067787, 6753.527253092286, 6159.19930409044, 6163.506919446433, 6242.906356404657, 6247.562670613013, 6260.09228661846, 6654.600723956578, 6803.149606299213, 6807.693653785592, 6896.93103068973, 6906.827329316808, 6481.967590162019, 6495.415412612888, 6547.083408322838, 6551.3776191262705, 6556.63938483388, 6596.406323430914, 6600.0, 6617.503687223478, 6676.098726671934, 6701.899471507932, 6530.8040758777315, 6531.477481801445, 6617.272100068989, 6623.271440141581, 6645.933540664531, 6493.837654058591, 6588.0, 6595.538312318187, 6596.505262105361, 6601.042848786899, 5375.19372094189, 5401.027814993339, 5442.0, 5451.318585176853, 5501.9174712379345, 4650.302454631832, 4694.95305046952, 4703.200455922433, 4713.599344055794, 4788.209945358977, 5752.395998420189, 5763.0, 5785.8553536161935, 5835.56233282497, 5850.327212370632, 6489.221293444817, 6629.668516574152, 6630.303818099127, 6679.833004174838, 6757.831054223586, 5662.745176466987, 5715.199872017921, 5738.913916291259, 5751.741171647286, 5762.971185144132, 5882.323532793698, 5895.263092113486, 5911.4975227105315, 5938.049912014057, 5951.553633477506, 6459.547831651833, 6465.773697920645, 6538.313477084933, 6554.0, 6560.704768285439, 6626.2379826318665, 6632.966835165793, 6634.104395906684, 6726.831829204309, 6738.056672066013, 6418.454431373386, 6434.517411194272, 6438.323975982455, 6446.0975463434215, 6578.079068930258, 6571.934280657132, 6577.736890524326, 6652.933470665232, 6660.267370589135, 6686.3313668632745, 6690.899636505554, 6700.2964688708935, 6775.559588626724, 6797.72809087631, 6803.115594972622, 6431.871362572816, 6438.67806609677, 6492.188476440445, 6499.0901273820755, 6501.967490162708, 6381.0, 6397.96801015992, 6411.3909178627955, 6436.581622194542, 6464.644444555594, 6293.874122517615, 6309.274433440213, 6316.11574379578, 6393.104965304954, 6421.550491465552, 6353.52348573868, 6373.044043393343, 6479.8056058318325, 6487.675616219076, 6495.870082598416, 6194.783182588588, 6214.285357183981, 6221.004639257697, 6222.595531290452, 6231.314555398993], "value": 6060.173974741967, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.8645330293849, 860.4665107633267, 891.61660485991, 896.6503063805117, 1173.941302934854, 30876.073717788448, 31346.0, 31347.0, 40330.395044074365, 41544.0, 42422.36366454498, 42682.0, 42814.14371712564, 42829.57170428295, 42843.0, 7612.124605670336, 7615.80960475987, 7773.183815699355, 7775.30022297993, 7843.333316668061, 7594.126675432313, 7713.228677132298, 7714.421418393615, 7714.807129821743, 7716.884246736304, 7649.579273139975, 7678.270564296411, 7717.6912923483, 7720.189380115091, 7721.845563088735, 7660.961695191544, 7671.769846904602, 7681.0, 7682.039745031843, 7706.422018348646, 7553.69785208591, 7593.506422082547, 7601.923980760177, 7609.885851712229, 7618.733344332977, 38615.42076868849, 39092.21815563701, 39151.60848391508, 39291.41062884059, 39312.0, 3573.446115852021, 3602.5136606558303, 3606.9098272543133, 3616.7829930204007, 3617.5478065241846, 31039.844800775852, 31187.532187017212, 31229.37541249185, 31246.843765781254, 31263.0, 5025.874353141164, 5027.396712394499, 5063.620228482841, 5092.28707980883, 5105.744712764384, 196316.0, 196513.0, 197941.0, 198207.0, 198301.99999999854, 47779.0, 47849.5215047852, 47850.76074619604, 47865.282020769715, 47917.520824792, 49654.0, 49726.25410618843, 49791.50208497941, 49835.25247121296, 49875.75062124739, 14826.777598336033, 15049.322780474906, 15057.774133388008, 15081.396744130112, 15094.698106038037, 11695.0, 12133.332666703416, 13325.600231993056, 13692.110012849133, 13715.725685486233, 14496.130232186102, 14508.564743057725, 14515.0, 14524.128552286897, 14622.049566778338, 5782.6819524925695, 5815.534757219412, 5876.794312199053, 6022.638641681513, 6054.697265136726, 994.3636072913341, 1023.4217667018111, 1025.8922813104666, 1026.6355443817486, 1029.9227557933184, 22822.201222957116, 23390.298291051295, 30117.69882301149, 30751.23121921925, 31157.221069473446, 1103.61925135828, 1104.9060829829555, 1113.7661091170944, 1120.3110087296254, 1124.960626378073, 12470.314132722788, 12690.175138615961, 12760.680982975315, 12801.0399220057, 12833.101682882296, 246099.0, 249424.0, 249449.0, 249506.0, 249624.0, 54742.452575474534, 54915.0, 54994.450055498935, 55079.44920550823, 55148.0, 1461.6272850423074, 1512.3723654683404, 1514.5986313626897, 1529.9923500382426, 1546.4510098914723, 22930.312090637308, 23021.19425820088, 23109.0, 23134.76865231326, 23270.185543505897, 39434.2113157741, 39638.80180599194, 39691.80154099211, 39820.60179398169, 39856.0, 226307.0, 227278.0, 227579.0, 227886.0, 228243.0, 36677.449838251916, 37934.24131517409, 38789.22421551609, 38798.61201388063, 38865.41701874418, 46842.29736553886, 47632.2855157166, 48332.75833620809, 48342.0, 48514.75742621264, 35338.46992295169, 35424.645753542136, 35660.821695891354, 35907.46138807972, 36223.818880905426, 34231.0, 34236.0, 34491.655083448844, 34654.306913862085, 35398.29203415969, 36384.27231455303, 37196.81401592975, 37344.253114938096, 37410.251794963406, 37509.624903751705, 32743.672563274064, 32774.67225327811, 33032.33935321328, 33252.66747332593, 33457.16357090995, 23611.88194059019, 23946.88026559856, 24821.0, 24948.002079917325, 25272.62091068672], "value": 17647.107138557232, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.4371344225939, 571.948524632783, 577.5899111630742, 585.8711083561615, 587.1339773833596, 21441.14235430583, 22292.777072229273, 22359.888200558973, 22409.55180896381, 24184.395390115256, 25226.243212703648, 25841.353966150808, 25924.48151036978, 25932.0, 26055.609165862526, 6389.329120442357, 6551.115599394068, 6557.245916719567, 6566.606003639797, 6571.211454625452, 6189.876202475948, 6463.418292353711, 6495.772647957322, 6499.447546958514, 6500.349965003509, 6468.870622587546, 6469.902951455709, 6471.514636402265, 6472.0, 6474.870502589945, 6345.333739957284, 6441.549091563593, 6455.774047908324, 6464.935350646504, 6470.870582588369, 5986.221791167164, 5988.520918326567, 5991.670458124801, 5992.700364981733, 6005.579609427342, 28956.855215723786, 29038.0, 29462.70537294621, 30474.390512189853, 30748.38503229945, 1945.863789534733, 2001.6797312429942, 2002.9399118026483, 2003.6193123306525, 2003.8296744776712, 19057.0, 19298.13158407875, 19752.40742777719, 20151.798482015285, 20201.494962625904, 2338.1348900906773, 2358.6226203807482, 2402.9519409611885, 2418.2019933422102, 2419.2984034629935, 129257.0, 136345.6365436343, 136523.31738341245, 137491.0, 137803.0, 14132.0, 14637.85362146365, 14884.925575372054, 15169.696606067817, 15333.463328783439, 23527.764722352556, 23550.7644923552, 23565.410864728517, 23605.29184124479, 23627.0, 10383.532741026673, 10549.103326217204, 10719.83920241197, 10748.22654262038, 10776.892231077745, 8726.389152759373, 9282.90717092834, 9748.220142388593, 9889.752756181153, 10014.048665376778, 8926.821463570692, 9180.724578262663, 9260.629574817067, 9288.442693438416, 9641.0, 2632.3945492536823, 2667.6798784146026, 2689.838609683386, 2714.80996330255, 2808.775297976157, 977.5991843344194, 986.5363279258737, 994.2592768387598, 1009.8434742614907, 1017.4607458047099, 19735.0, 19766.604667906562, 19948.3018094366, 20137.798622013885, 20372.388828335173, 1042.2287507244585, 1050.5745173204864, 1052.678932925465, 1054.435876805905, 1061.8938106189319, 10955.287906286225, 11375.260608060615, 13062.0, 14050.36773345202, 14111.0, 538893.0, 541176.0, 544413.8337924934, 546504.0, 552459.0, 124546.0, 128435.0, 130925.0, 131216.0, 132042.33978830237, 1249.5501619417003, 1257.2016769351344, 1295.7214198947083, 1296.1704509114174, 1303.192020947, 20295.9852007402, 20390.490237744176, 20543.8972805141, 20557.794422055587, 21032.789672103696, 58651.41348586459, 60478.395216047276, 61988.760224796155, 62644.686776565824, 63955.0, 71444.64277678786, 72329.0, 72713.0, 78844.0, 82432.17567824245, 14364.28178591087, 14869.033512821632, 15015.549533514011, 15022.774658380351, 15043.849561504245, 23260.76739232586, 23361.41596460102, 23477.53044939126, 23637.172698955455, 23694.0, 18449.81550184481, 18500.814991849908, 18558.164882580048, 18657.160427780513, 18762.624747504702, 15924.681506369576, 16342.591435214215, 16864.915675422035, 17341.393051243147, 17810.910945445707, 17733.911330443265, 18496.81503185005, 18557.44327670172, 18728.6254274911, 18898.811011889706, 14759.188244646648, 14794.852051479347, 14814.851851481348, 14953.252337383305, 14981.0, 16775.0, 17034.148292585072, 17055.573610659834, 17101.14494275306, 17881.821181788535], "value": 12230.721643950365, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.3776543907084, 1392.6518370407398, 1402.3549167383003, 1404.4382247101164, 1405.7469655462019, 14117.929410352946, 14388.208648524327, 14743.189124598157, 14789.926050369733, 14797.556073317817, 14142.080764750284, 14349.354279057441, 14378.352974116164, 14385.280735963186, 14399.0, 2615.673040869896, 2661.2548486423734, 2663.161104252164, 2667.333166708323, 2667.7599016088548, 2512.196097248881, 2652.1778248742853, 2694.9056783012597, 2699.446613444249, 2705.864706764664, 2480.1443501991876, 2503.7245902950663, 2599.233226198276, 2652.3634327761297, 2653.615225792259, 2452.91414800482, 2463.8275320727557, 2476.2447453526665, 2478.045952308365, 2478.1450399612286, 2507.611320245365, 2516.30801529579, 2527.3428908483743, 2528.532221539021, 2528.5448619248527, 13791.0, 14141.0, 14142.292885355793, 14151.575452736331, 14151.787723184161, 7463.589502577356, 7738.303552680286, 7754.0, 7789.454738168331, 7791.22087791222, 4806.903861922777, 4974.676646017997, 5041.571466425358, 5119.718415487147, 5149.0, 1835.2383760739276, 1837.5130590393555, 1849.0847030719744, 1886.3020682347483, 1896.3078476356168, 23319.883400582887, 24042.879785601133, 24767.5046499069, 24792.132275370277, 24810.131645392325, 6468.094466774655, 6500.902486462707, 6544.509161812883, 6584.440322572539, 6771.28901465339, 16095.0, 16339.0, 16346.18269086541, 16571.0, 16590.336386544644, 7564.319211270902, 7793.649285782153, 7818.960905195438, 7820.217978202248, 7821.256980586835, 7177.246389129171, 7226.313500217471, 7258.2741725828055, 7298.0, 7337.59643219628, 5028.32117664118, 5129.410117836422, 5170.1986192140275, 5185.092608793446, 5213.582913366921, 1487.3381345301236, 1497.071815474391, 1506.1038681984203, 1513.402206128595, 1523.200319832075, 845.1843970568431, 863.2921004776024, 870.2863651805585, 885.2386947225381, 894.9463032218088, 6989.405900498515, 7081.964590177119, 7101.0, 7109.253528379446, 7139.535930164523, 701.4703898556659, 702.3854127638316, 705.0869124483805, 706.3925024478943, 710.9289071092953, 4639.234526303122, 5074.923876141861, 5252.789888404497, 5276.736163191825, 5513.035218836688, 18262.726059109125, 20052.498687532927, 20283.695744563844, 20381.79618203799, 20492.18031278732, 19228.61542769137, 19742.50643733918, 20065.39803805888, 20084.598308033757, 20119.59760804805, 11097.722556936142, 11203.21577489568, 11282.661520154408, 11287.943560282147, 11319.264247823865, 7905.209479052049, 8055.436119471581, 8145.714899978472, 8262.545559994258, 8370.832583348178, 17126.229319680395, 17340.393086241922, 17502.562435939202, 17637.470875873743, 18265.178066987282, 17661.646767064845, 18026.72959905576, 18069.91580505174, 18184.636307273515, 18213.726794098366, 11605.30368177912, 11776.470058847544, 11780.587679431179, 11781.587644432746, 11920.761584768083, 12840.10119291678, 13176.143550669176, 13322.0, 13332.733345333232, 13336.799948000593, 11065.889341106486, 11076.612318568812, 11088.002079812855, 11141.2201145919, 11282.492287846902, 10749.785004299714, 10885.727856803644, 10921.83617245726, 11112.333260004425, 11233.775324493628, 9635.855462168212, 9667.419954802734, 9844.0, 9888.950555247178, 9899.010098990331, 7367.373773229121, 7388.519746216479, 7428.257174282745, 7429.517081389692, 7483.476156669199, 7218.855622887618, 7271.927280727125, 7281.453890958093, 7292.562446253241, 7298.4526160539235], "value": 6388.001583686317, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.6352345219493, 499.1605932140062, 528.3254961741092, 529.9004565526534, 536.1983834167918, 6138.171346868172, 6176.629402235863, 6198.535109866762, 6212.0, 6221.097940798587, 5897.557683173758, 5983.820485385435, 6037.366076561963, 6057.91046566251, 6075.392460753922, 4875.341828853113, 4898.510148985109, 4935.6545041847085, 4962.478939711333, 4975.800967961277, 4800.303955926389, 4884.902301953959, 4916.950830491703, 4942.308076869242, 4955.876103097416, 4873.0, 4892.706437613754, 4913.312136300903, 4934.25986102084, 4952.182889823175, 4861.270809378586, 4896.363472748538, 4898.363212782351, 4922.876928076791, 4927.975360123194, 4390.53899340571, 4405.11897620474, 4411.801468933906, 4424.380586717862, 4444.177827101997, 5835.679037652927, 5904.763809447617, 5908.852278693024, 5922.55808143892, 6013.759449622054, 5539.224508568804, 5542.334919809648, 5597.944020559824, 5634.562916620858, 5683.857903552403, 6309.810705678837, 6328.620282783002, 6352.871787951042, 6479.64361960092, 6490.740370385179, 4797.328374027639, 4814.831480898151, 4818.975905120487, 4828.420589529243, 4865.586425153866, 6661.600303981777, 6709.798706038827, 6724.260331363546, 6822.454203663695, 6888.0, 4952.504749525091, 4953.50464953509, 4960.652754307164, 4970.353853998957, 4993.825216117491, 5065.0, 5080.949190508048, 5085.4914508548845, 5093.974530127326, 5112.769925353368, 5577.163425486209, 5613.158026296088, 5650.124230744241, 5696.971515142398, 5699.601027928005, 6429.3570642936265, 6453.741850326029, 6457.677116144174, 6461.644609546426, 6538.215414150332, 1678.7901512310962, 1698.736695812151, 1829.1494455078453, 1880.2385034061226, 1917.405604262683, 1389.6728624164102, 1398.1680899864564, 1421.133108803629, 1450.2531196433845, 1455.1923682356182, 5487.5609951203805, 5547.528460080857, 5570.526505247019, 5592.552595792326, 5650.5479561634975, 6522.7381713555515, 6542.869142617216, 6586.571872828251, 6639.269680335159, 6645.800625981228, 5655.519280861173, 5670.0, 5688.374278829326, 5691.345495268014, 5728.226689396962, 3530.6292839252023, 3555.8755443559353, 3564.11102115879, 3578.4632305153914, 3583.8566457341935, 6545.247296560957, 6566.704498297588, 6572.277049524549, 6585.506087043491, 6590.340965903371, 6851.794446166623, 6920.550164239308, 6929.826754331081, 6930.237673855871, 6930.237673855871, 6442.871142577216, 6485.313818407248, 6512.479001679949, 6540.0, 6590.934090659128, 6625.536212465274, 6680.766173183915, 6684.532082754161, 6702.396784289437, 6707.1616047994, 6545.901811472737, 6634.436072933855, 6638.435732962752, 6641.0, 6652.667366631552, 6453.612783233021, 6500.489735542754, 6507.544471886922, 6556.967215163893, 6559.180102487189, 4967.155583550877, 4977.203647416396, 4990.451050384528, 5044.9315780529805, 5054.393472783143, 6404.967975160094, 6648.335166483506, 6654.90017649726, 6708.899366509604, 6725.242650513266, 6368.0, 6404.71178796946, 6439.484841212786, 6439.67801609927, 6470.7088181032905, 6377.808665740035, 6452.645104519296, 6523.347665233438, 6525.477961762953, 6562.80311590653, 6112.572119951561, 6368.9044664330995, 6409.7115629795835, 6424.261209960914, 6441.0, 6340.334264902303, 6385.297617262005, 6400.743970241325, 6478.70845811949, 6531.967340163269, 6202.689865506797, 6220.813375598739, 6243.157173781481, 6271.714298568691, 6320.577869979218], "value": 5030.420776193358, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [908.9636414543419, 919.599974011305, 932.6222879733701, 936.5036530638764, 943.1276069635585, 18575.814241857577, 19463.0, 19575.314863979762, 19583.314583989562, 21391.251306204285, 21357.252496162637, 21732.565348693017, 21744.456388590293, 21945.890270548665, 21971.121155153774, 1030.7268573827923, 1057.1384321777764, 1058.449606204773, 1066.402814423925, 1067.11429513504, 954.8281309364312, 1056.6407421476697, 1058.031900810761, 1060.0724366179593, 1062.4050531702233, 1103.1615971861404, 1103.4041617526525, 1103.6413165721174, 1105.8949399807045, 1106.2919731371887, 1091.1707102602, 1095.8246680531156, 1102.1348241630321, 1103.6082190822262, 1105.690406686129, 806.3911746631256, 806.7862016565615, 806.9757907262791, 807.3057170833079, 810.6676262732251, 19242.80757192424, 20356.0, 20789.480262993395, 20959.68560471594, 21002.264920727703, 21039.263625773023, 21578.89210553953, 21617.891910540504, 21626.567468650537, 22640.660390094163, 16207.270672819752, 16799.412020579344, 17072.06103664298, 17139.485815425556, 17156.914215428842, 3663.285659296438, 3681.834317455721, 3706.610805865399, 3706.9073273168115, 3707.2214834884708, 115630.0, 117628.82371176264, 128311.35844320718, 130221.0, 133540.0, 17396.39112631052, 18029.0, 18053.548661283574, 18114.547136321435, 18163.72754408685, 31468.527972080436, 31677.8416107918, 31990.200244993597, 32016.839915800272, 32381.19047023796, 7699.384049276045, 8054.758357249292, 9137.177654011039, 9419.858702119474, 9419.905800941902, 4456.309272062836, 4548.56788605082, 4557.475890272594, 4563.224251877189, 4568.565986231302, 5234.398044224887, 5258.447862974409, 5359.544438722674, 5398.784048638089, 5408.8377348679605, 1066.6853278282924, 1068.108129711684, 1068.7435015596202, 1082.3722241100143, 1084.8426978088132, 603.3574243430733, 620.8230654263514, 622.5206590925053, 626.0921663587816, 643.1863692429081, 11702.35637039971, 12119.272843629411, 12537.373131343396, 13397.397117129753, 13834.446622135203, 693.1855070292386, 693.7606525748608, 696.1437431958618, 706.1103010207175, 713.0302788208033, 5351.331083614548, 5646.971765141148, 5878.970605146947, 5941.316748573883, 5959.970200149059, 102355.48822255842, 106239.4688026555, 107897.0, 109088.4545577267, 109596.4520177394, 91410.54294728617, 98850.0, 99349.50325248328, 102328.48835755922, 102840.48579757054, 80733.0, 85793.57103214443, 85907.57046214853, 89465.55267223752, 89628.0, 12212.267263964191, 12421.503139874303, 12642.2414655121, 12698.36508174606, 12698.809517857424, 38997.415038775005, 39869.60130398659, 40151.79924100361, 40563.391549126194, 41001.0, 69278.0, 69703.65148174227, 70067.0, 72314.27685723286, 78079.0, 17279.56801079983, 17696.646067078327, 17797.0, 18865.811341886954, 19189.904050479658, 20822.89588552108, 21157.576848462635, 21275.0, 21546.030428630434, 21637.783622163577, 18926.0, 19254.326098586484, 19309.227630894606, 19421.2231510738, 19432.125554349805, 18113.18490667897, 18115.36596219126, 18329.633407331512, 18512.0, 18565.628687425906, 17597.208125634123, 17767.822321776617, 17869.106544672974, 18243.90878045601, 18317.175727092046, 12710.36448177606, 12941.482340706267, 13227.603171904859, 13418.731625367243, 13517.256550889795, 14465.638359041108, 14895.702085958437, 15365.0, 15469.071855688695, 15528.767068493755], "value": 9381.653188978416, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1510.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 108.0, 101.0, 108.0, 107.0, 110.0, 107.0, 99.0, 107.0, 108.0], "value": 105.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 120.0, 151.0, 181.0, 121.0, 146.0, 147.0, 120.0, 188.0, 120.0], "value": 143.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 163.0, 163.0, 161.0, 164.0, 164.0, 166.0, 167.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 104.0, 75.0, 75.0, 75.0, 89.0, 122.0, 76.0], "value": 84.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 135.0, 78.0, 79.0, 79.0, 141.0, 79.0, 79.0, 131.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 115.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 149.0, 149.0, 149.0, 150.0, 150.0, 152.0, 151.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 53.0, 53.0, 58.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 54.0, 53.0, 54.0, 54.0, 54.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 76.0, 77.0, 77.0, 77.0, 76.0, 76.0, 75.0, 77.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 131.0, 119.0, 121.0, 125.0, 126.0, 126.0, 127.0, 118.0, 172.0], "value": 129.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 177.0, 179.0, 174.0, 189.0, 174.0, 174.0, 178.0, 169.0, 173.0], "value": 176.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 68.0, 68.0, 68.0, 67.0, 66.0, 68.0, 68.0, 66.0], "value": 67.9, "unit": "score"}]}]} 11:41:06 INFO - Return code: 0 11:41:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:41:06 INFO - # TBPL SUCCESS # 11:41:06 INFO - Running post-action listener: _package_coverage_data 11:41:06 INFO - Running post-action listener: _resource_record_post_action 11:41:06 INFO - [mozharness: 2017-08-17 18:41:06.631467Z] Finished run-tests step (success) 11:41:06 INFO - Running post-run listener: _resource_record_post_run 11:41:06 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 433545216; Read time: 16; Write time: 303596 11:41:06 INFO - TinderboxPrint: CPU usage
13.1% 11:41:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:41:06 INFO - TinderboxPrint: I/O write bytes / time
433,545,216 / 303,596 11:41:06 INFO - TinderboxPrint: CPU idle
8,265.5 (86.9%) 11:41:06 INFO - TinderboxPrint: CPU user
1,196.9 (12.6%) 11:41:06 INFO - TinderboxPrint: Swap in / out
0 / 0 11:41:06 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107761664; Read time: 0; Write time: 104452 11:41:06 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:06 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 325783552; Read time: 0; Write time: 199144 11:41:07 INFO - Running post-run listener: _upload_blobber_files 11:41:07 INFO - Blob upload gear active. 11:41:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:41:07 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:07 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:41:07 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:41:07 INFO - (blobuploader) - INFO - Open directory for files ... 11:41:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:41:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:41:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:08 INFO - (blobuploader) - INFO - Done attempting. 11:41:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:41:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:41:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:09 INFO - (blobuploader) - INFO - Done attempting. 11:41:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:41:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:09 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/resource-usage.json ... 11:41:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:41:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:17 INFO - (blobuploader) - INFO - Done attempting. 11:41:17 INFO - (blobuploader) - INFO - Iteration through files over. 11:41:17 INFO - Return code: 0 11:41:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:41:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:41:17 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5615e86569ad2518e96fc194992f37c95107620a1de5812342e50d12ac4154d720b73d0b0a9d38d5fc77d0c6d6f78f8264a8c8799b0e0b3d85037e882564974a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a6f2c1619f9429e2065e40686667c71e89f28d813170475950310e049047887275b623011c52808c7093929f90ca818296aae96c7cc4f6ca1ad8e9e263f762aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bfa952f6f6ef55b3dc2174cd13c9898a8d5b276272ad6db637d08d7cf23748aa7f408f9b56d286226009fb35f244fce72acd2272422bfbe6581e60d0097287ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0fb78a6a94c01721eec2786741da4ca1f4efe64aa8302de0b26d6bdb57f795952f644381442bc482940771265ba1e85e1857759fd8e39879a38fae306766f9f3"} 11:41:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:41:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:41:17 INFO - Contents: 11:41:17 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5615e86569ad2518e96fc194992f37c95107620a1de5812342e50d12ac4154d720b73d0b0a9d38d5fc77d0c6d6f78f8264a8c8799b0e0b3d85037e882564974a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a6f2c1619f9429e2065e40686667c71e89f28d813170475950310e049047887275b623011c52808c7093929f90ca818296aae96c7cc4f6ca1ad8e9e263f762aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bfa952f6f6ef55b3dc2174cd13c9898a8d5b276272ad6db637d08d7cf23748aa7f408f9b56d286226009fb35f244fce72acd2272422bfbe6581e60d0097287ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0fb78a6a94c01721eec2786741da4ca1f4efe64aa8302de0b26d6bdb57f795952f644381442bc482940771265ba1e85e1857759fd8e39879a38fae306766f9f3"} 11:41:17 INFO - Running post-run listener: copy_logs_to_upload_dir 11:41:17 INFO - Copying logs to upload dir... 11:41:17 INFO - mkdir: /builds/slave/test/build/upload/logs 11:41:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.463201 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-17 11:41:17.694017) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 11:41:17.697827) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5615e86569ad2518e96fc194992f37c95107620a1de5812342e50d12ac4154d720b73d0b0a9d38d5fc77d0c6d6f78f8264a8c8799b0e0b3d85037e882564974a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a6f2c1619f9429e2065e40686667c71e89f28d813170475950310e049047887275b623011c52808c7093929f90ca818296aae96c7cc4f6ca1ad8e9e263f762aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bfa952f6f6ef55b3dc2174cd13c9898a8d5b276272ad6db637d08d7cf23748aa7f408f9b56d286226009fb35f244fce72acd2272422bfbe6581e60d0097287ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0fb78a6a94c01721eec2786741da4ca1f4efe64aa8302de0b26d6bdb57f795952f644381442bc482940771265ba1e85e1857759fd8e39879a38fae306766f9f3"} build_url:https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011748 build_url: 'https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5615e86569ad2518e96fc194992f37c95107620a1de5812342e50d12ac4154d720b73d0b0a9d38d5fc77d0c6d6f78f8264a8c8799b0e0b3d85037e882564974a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a6f2c1619f9429e2065e40686667c71e89f28d813170475950310e049047887275b623011c52808c7093929f90ca818296aae96c7cc4f6ca1ad8e9e263f762aa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bfa952f6f6ef55b3dc2174cd13c9898a8d5b276272ad6db637d08d7cf23748aa7f408f9b56d286226009fb35f244fce72acd2272422bfbe6581e60d0097287ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0fb78a6a94c01721eec2786741da4ca1f4efe64aa8302de0b26d6bdb57f795952f644381442bc482940771265ba1e85e1857759fd8e39879a38fae306766f9f3"}' ========= master_lag: 0.45 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 11:41:18.162772) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:41:18.163161) ========= 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=d6bbd613908ccac0c6c9cb47000001f7-1502993889.120834-20540430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:41:18.181939) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 11:41:18.182283) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 11:41:18.182610) ========= ========= Total master_lag: 0.57 =========