builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-088 starttime: 1503501384.73 results: success (0) revision: 76c7aa772dc494d77ae7e1183b0ec1d073152dee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:24.734890) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:24.735300) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:24.735580) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:24.763008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:24.763363) ========= 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=9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-23 08:16:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2017-08-23 08:16:25 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129365 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:24.926202) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:24.926483) ========= 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=9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015238 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:24.986440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:24.986751) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 76c7aa772dc494d77ae7e1183b0ec1d073152dee --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 76c7aa772dc494d77ae7e1183b0ec1d073152dee --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=9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-23 08:16:25,490 truncating revision to first 12 chars 2017-08-23 08:16:25,490 Setting DEBUG logging. 2017-08-23 08:16:25,490 attempt 1/10 2017-08-23 08:16:25,490 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/76c7aa772dc4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-23 08:16:25,777 unpacking tar archive at: mozilla-central-76c7aa772dc4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.662153 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:25.669733) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:25.670039) ========= script_repo_revision: 76c7aa772dc494d77ae7e1183b0ec1d073152dee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:25.670419) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:25.670679) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 08:16:25.689380) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-23 08:16:25.689657) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:16:26 INFO - MultiFileLogger online at 20170823 08:16:26 in /builds/slave/test 08:16:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:16:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:16:26 INFO - {'append_to_log': False, 08:16:26 INFO - 'base_work_dir': '/builds/slave/test', 08:16:26 INFO - 'blob_upload_branch': 'Firefox', 08:16:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:16:26 INFO - 'branch': 'Firefox', 08:16:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:16:26 INFO - 'code_coverage': False, 08:16:26 INFO - 'config_files': ('talos/linux_config.py',), 08:16:26 INFO - 'default_actions': ('clobber', 08:16:26 INFO - 'read-buildbot-config', 08:16:26 INFO - 'download-and-extract', 08:16:26 INFO - 'populate-webroot', 08:16:26 INFO - 'create-virtualenv', 08:16:26 INFO - 'install', 08:16:26 INFO - 'setup-mitmproxy', 08:16:26 INFO - 'run-tests'), 08:16:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:16:26 INFO - 'disable_ccov_upload': False, 08:16:26 INFO - 'download_minidump_stackwalk': True, 08:16:26 INFO - 'download_symbols': 'ondemand', 08:16:26 INFO - 'enable_stylo': False, 08:16:26 INFO - 'enable_webrender': False, 08:16:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:16:26 INFO - 'tooltool.py': '/tools/tooltool.py', 08:16:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:16:26 INFO - '/tools/misc-python/virtualenv.py')}, 08:16:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:16:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:16:26 INFO - 'gecko_profile': False, 08:16:26 INFO - 'gecko_profile_interval': 0, 08:16:26 INFO - 'installer_path': 'installer.exe', 08:16:26 INFO - 'log_level': 'info', 08:16:26 INFO - 'log_name': 'talos', 08:16:26 INFO - 'log_to_console': True, 08:16:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:16:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:16:26 INFO - 'opt_config_files': (), 08:16:26 INFO - 'pip_index': False, 08:16:26 INFO - 'suite': 'dromaeojs-e10s', 08:16:26 INFO - 'system_bits': '32', 08:16:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:16:26 INFO - 'title': 'talos-linux64-ix-088', 08:16:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:16:26 INFO - 'use_talos_json': True, 08:16:26 INFO - 'verify': 'False', 08:16:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:16:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:16:26 INFO - 'work_dir': 'build'} 08:16:26 INFO - [mozharness: 2017-08-23 15:16:26.328428Z] Running clobber step. 08:16:26 INFO - Running pre-action listener: _resource_record_pre_action 08:16:26 INFO - Running main action method: clobber 08:16:26 INFO - rmtree: /builds/slave/test/build 08:16:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:16:27 INFO - Running post-action listener: _resource_record_post_action 08:16:27 INFO - [mozharness: 2017-08-23 15:16:27.356211Z] Finished clobber step (success) 08:16:27 INFO - [mozharness: 2017-08-23 15:16:27.356308Z] Running read-buildbot-config step. 08:16:27 INFO - Running pre-action listener: _resource_record_pre_action 08:16:27 INFO - Running main action method: read_buildbot_config 08:16:27 INFO - Using buildbot properties: 08:16:27 INFO - { 08:16:27 INFO - "project": "", 08:16:27 INFO - "product": "firefox", 08:16:27 INFO - "who": "archaeopteryx@coole-files.de", 08:16:27 INFO - "installer_path": "public/build/target.tar.bz2", 08:16:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 08:16:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 08:16:27 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 08:16:27 INFO - "stage_platform": "linux64-stylosequential", 08:16:27 INFO - "basedir": "/builds/slave/test", 08:16:27 INFO - "buildnumber": 167, 08:16:27 INFO - "platform": "ubuntu64_hw_styloseq", 08:16:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:16:27 INFO - "slavebuilddir": "test", 08:16:27 INFO - "taskId": "LiD0kh-xSoeWdu7lPcmesQ", 08:16:27 INFO - "branch": "mozilla-central", 08:16:27 INFO - "script_repo_revision": "production", 08:16:27 INFO - "revision": "76c7aa772dc494d77ae7e1183b0ec1d073152dee", 08:16:27 INFO - "slavename": "talos-linux64-ix-088", 08:16:27 INFO - "repo_path": "mozilla-central" 08:16:27 INFO - } 08:16:27 INFO - Finding installer, test and symbols from parent task. 08:16:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LiD0kh-xSoeWdu7lPcmesQ'}, attempt #1 08:16:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LiD0kh-xSoeWdu7lPcmesQ'}, attempt #1 08:16:28 INFO - Task dependencies: WODyYTpCRhaowJbHTZlbvA 08:16:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA'}, attempt #1 08:16:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.tar.bz2 08:16:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.test_packages.json 08:16:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.crashreporter-symbols.zip 08:16:28 INFO - Running post-action listener: _resource_record_post_action 08:16:28 INFO - [mozharness: 2017-08-23 15:16:28.782715Z] Finished read-buildbot-config step (success) 08:16:28 INFO - [mozharness: 2017-08-23 15:16:28.782934Z] Running download-and-extract step. 08:16:28 INFO - Running pre-action listener: _resource_record_pre_action 08:16:28 INFO - Running main action method: download_and_extract 08:16:28 INFO - mkdir: /builds/slave/test/build/tests 08:16:28 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')]} 08:16:28 INFO - trying https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.test_packages.json 08:16:28 INFO - Downloading https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:16:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:16:29 INFO - Downloaded 989 bytes. 08:16:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:16:29 INFO - Using the following test package requirements: 08:16:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:16:29 INFO - u'common': [u'target.common.tests.zip'], 08:16:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:16:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:16:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:16:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:16:29 INFO - u'mozbase': [u'target.common.tests.zip'], 08:16:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:16:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:16:29 INFO - u'web-platform': [u'target.common.tests.zip', 08:16:29 INFO - u'target.web-platform.tests.tar.gz'], 08:16:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:16:29 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:16:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.common.tests.zip 08:16:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:16:29 INFO - Fetch https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.common.tests.zip into memory 08:16:30 INFO - Content-Length response header: 54949506 08:16:30 INFO - Bytes received: 54949506 08:16:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:16:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.common.tests.zip 08:16:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:16:41 INFO - Fetch https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.common.tests.zip into memory 08:16:43 INFO - Content-Length response header: 54949506 08:16:43 INFO - Bytes received: 54949506 08:16:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.talos.tests.zip 08:16:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:16:55 INFO - Fetch https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.talos.tests.zip into memory 08:16:55 INFO - Content-Length response header: 14496261 08:16:55 INFO - Bytes received: 14496261 08:16: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')]} 08:16:56 INFO - trying https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.tar.bz2 08:16:56 INFO - Downloading https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:16:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:16:59 INFO - Downloaded 61084946 bytes. 08:16:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.tar.bz2 08:16:59 INFO - mkdir: /builds/slave/test/properties 08:16:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:16:59 INFO - Writing to file /builds/slave/test/properties/build_url 08:16:59 INFO - Contents: 08:16:59 INFO - build_url:https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.tar.bz2 08:16:59 INFO - Running post-action listener: _resource_record_post_action 08:16:59 INFO - Running post-action listener: find_tests_for_verification 08:16:59 INFO - Running post-action listener: set_extra_try_arguments 08:16:59 INFO - [mozharness: 2017-08-23 15:16:59.016819Z] Finished download-and-extract step (success) 08:16:59 INFO - [mozharness: 2017-08-23 15:16:59.017046Z] Running populate-webroot step. 08:16:59 INFO - Running pre-action listener: _resource_record_pre_action 08:16:59 INFO - Running main action method: populate_webroot 08:16:59 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:16:59 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 08:16:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:16:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:16:59 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 08:16:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:16:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:16:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:59 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:16:59 INFO - 'talos_options': ['--stylo'], 08:16:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:16:59 INFO - 'tests': ['damp', 'tps']}, 08:16:59 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:16:59 INFO - 'talos_options': ['--stylo'], 08:16:59 INFO - 'tests': ['damp', 'tps']}, 08:16:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:16:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:16:59 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 08:16:59 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:16:59 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:16:59 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:16:59 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:16:59 INFO - 'talos_options': ['--stylo'], 08:16:59 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:16:59 INFO - 'other-e10s': {'tests': ['a11yr', 08:16:59 INFO - 'ts_paint', 08:16:59 INFO - 'tpaint', 08:16:59 INFO - 'sessionrestore', 08:16:59 INFO - 'sessionrestore_many_windows', 08:16:59 INFO - 'sessionrestore_no_auto_restore', 08:16:59 INFO - 'tabpaint']}, 08:16:59 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 08:16:59 INFO - 'tests': ['a11yr', 08:16:59 INFO - 'ts_paint', 08:16:59 INFO - 'tpaint', 08:16:59 INFO - 'sessionrestore', 08:16:59 INFO - 'sessionrestore_many_windows', 08:16:59 INFO - 'sessionrestore_no_auto_restore', 08:16:59 INFO - 'tabpaint']}, 08:16:59 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:16:59 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 08:16:59 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 08:16:59 INFO - 'tests': ['bloom_basic_singleton']}, 08:16:59 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 08:16:59 INFO - 'tests': ['bloom_basic']}, 08:16:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:16:59 INFO - 'tsvgr_opacity', 08:16:59 INFO - 'tart', 08:16:59 INFO - 'tscrollx', 08:16:59 INFO - 'tsvg_static']}, 08:16:59 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 08:16:59 INFO - 'tests': ['tsvgx', 08:16:59 INFO - 'tsvgr_opacity', 08:16:59 INFO - 'tart', 08:16:59 INFO - 'tscrollx', 08:16:59 INFO - 'tsvg_static']}, 08:16:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:16:59 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:16:59 INFO - 'talos_options': ['--stylo'], 08:16:59 INFO - 'tests': ['tp5o']}, 08:16:59 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:16:59 INFO - 'talos_options': ['--mitmproxy', 08:16:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:16:59 INFO - '--firstNonBlankPaint'], 08:16:59 INFO - 'tests': ['tp6_google', 08:16:59 INFO - 'tp6_youtube', 08:16:59 INFO - 'tp6_amazon', 08:16:59 INFO - 'tp6_facebook']}, 08:16:59 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:16:59 INFO - 'talos_options': ['--stylo', 08:16:59 INFO - '--mitmproxy', 08:16:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:16:59 INFO - '--firstNonBlankPaint'], 08:16:59 INFO - 'tests': ['tp6_google', 08:16:59 INFO - 'tp6_youtube', 08:16:59 INFO - 'tp6_amazon', 08:16:59 INFO - 'tp6_facebook']}, 08:16:59 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:16:59 INFO - 'talos_options': ['--stylo', 08:16:59 INFO - '--stylo-threads=1', 08:16:59 INFO - '--mitmproxy', 08:16:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:16:59 INFO - '--firstNonBlankPaint'], 08:16:59 INFO - 'tests': ['tp6_google', 08:16:59 INFO - 'tp6_youtube', 08:16:59 INFO - 'tp6_amazon', 08:16:59 INFO - 'tp6_facebook']}, 08:16:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:16:59 INFO - 'talos_options': ['--xperf_path', 08:16:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:59 INFO - 'tests': ['tp5n']}, 08:16:59 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 08:16:59 INFO - 'talos_options': ['--stylo', 08:16:59 INFO - '--xperf_path', 08:16:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:59 INFO - 'tests': ['tp5n']}}} 08:16:59 INFO - Running post-action listener: _resource_record_post_action 08:16:59 INFO - [mozharness: 2017-08-23 15:16:59.034369Z] Finished populate-webroot step (success) 08:16:59 INFO - [mozharness: 2017-08-23 15:16:59.034460Z] Running create-virtualenv step. 08:16:59 INFO - Running pre-action listener: _resource_record_pre_action 08:16:59 INFO - Running main action method: create_virtualenv 08:16:59 INFO - Creating virtualenv /builds/slave/test/build/venv 08:16:59 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 08:16:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:16:59 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:16:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:16:59 INFO - Using real prefix '/usr' 08:16:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:16:59 INFO - Installing distribute.............................................................................................................................................................................................done. 08:17:01 INFO - Installing pip.................done. 08:17:01 INFO - Return code: 0 08:17:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:17:01 INFO - Reading from file tmpfile_stdout 08:17:01 INFO - Output received: 08:17:01 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) 08:17:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296af90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968130>, '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 0x2969030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29694c0>, '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': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', '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 08:17: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', 'pip>=1.5'] in /builds/slave/test/build 08:17: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 pip>=1.5 08:17:01 INFO - Using env: {'DISPLAY': ':0', 08:17:01 INFO - 'HOME': '/home/cltbld', 08:17:01 INFO - 'LANG': 'en_US.UTF-8', 08:17:01 INFO - 'LANGUAGE': 'en_US:en', 08:17:01 INFO - 'LOGNAME': 'cltbld', 08:17:01 INFO - 'MAIL': '/var/mail/cltbld', 08:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:01 INFO - 'MOZ_NO_REMOTE': '1', 08:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:01 INFO - 'NO_EM_RESTART': '1', 08:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:01 INFO - 'PWD': '/builds/slave/test', 08:17:01 INFO - 'SHELL': '/bin/bash', 08:17:01 INFO - 'SHLVL': '1', 08:17:01 INFO - 'TERM': 'linux', 08:17:01 INFO - 'TMOUT': '86400', 08:17:01 INFO - 'USER': 'cltbld', 08:17:01 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', 08:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:01 INFO - '_': '/tools/buildbot/bin/python'} 08:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:02 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 08:17:02 INFO - Cleaning up... 08:17:02 INFO - Return code: 0 08:17:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296af90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968130>, '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 0x2969030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29694c0>, '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': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', '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 08:17:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:17:02 INFO - Using env: {'DISPLAY': ':0', 08:17:02 INFO - 'HOME': '/home/cltbld', 08:17:02 INFO - 'LANG': 'en_US.UTF-8', 08:17:02 INFO - 'LANGUAGE': 'en_US:en', 08:17:02 INFO - 'LOGNAME': 'cltbld', 08:17:02 INFO - 'MAIL': '/var/mail/cltbld', 08:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:02 INFO - 'MOZ_NO_REMOTE': '1', 08:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:02 INFO - 'NO_EM_RESTART': '1', 08:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:02 INFO - 'PWD': '/builds/slave/test', 08:17:02 INFO - 'SHELL': '/bin/bash', 08:17:02 INFO - 'SHLVL': '1', 08:17:02 INFO - 'TERM': 'linux', 08:17:02 INFO - 'TMOUT': '86400', 08:17:02 INFO - 'USER': 'cltbld', 08:17:02 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', 08:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:02 INFO - '_': '/tools/buildbot/bin/python'} 08:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:02 INFO - Downloading/unpacking psutil>=3.1.1 08:17: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 08:17: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 08:17: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 08:17: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 08:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:17:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:17:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:17:03 INFO - Installing collected packages: psutil 08:17:03 INFO - Running setup.py install for psutil 08:17:03 INFO - building 'psutil._psutil_linux' extension 08:17:03 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 08:17:03 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 08:17:03 INFO - building 'psutil._psutil_posix' extension 08:17:03 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 08:17:03 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 08:17:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:17:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:17:03 INFO - Successfully installed psutil 08:17:03 INFO - Cleaning up... 08:17:03 INFO - Return code: 0 08:17:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296af90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968130>, '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 0x2969030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29694c0>, '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': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', '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 08:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:17:04 INFO - Using env: {'DISPLAY': ':0', 08:17:04 INFO - 'HOME': '/home/cltbld', 08:17:04 INFO - 'LANG': 'en_US.UTF-8', 08:17:04 INFO - 'LANGUAGE': 'en_US:en', 08:17:04 INFO - 'LOGNAME': 'cltbld', 08:17:04 INFO - 'MAIL': '/var/mail/cltbld', 08:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:04 INFO - 'MOZ_NO_REMOTE': '1', 08:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:04 INFO - 'NO_EM_RESTART': '1', 08:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:04 INFO - 'PWD': '/builds/slave/test', 08:17:04 INFO - 'SHELL': '/bin/bash', 08:17:04 INFO - 'SHLVL': '1', 08:17:04 INFO - 'TERM': 'linux', 08:17:04 INFO - 'TMOUT': '86400', 08:17:04 INFO - 'USER': 'cltbld', 08:17:04 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', 08:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:04 INFO - '_': '/tools/buildbot/bin/python'} 08:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:17:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:17:05 INFO - Installing collected packages: mozsystemmonitor 08:17:05 INFO - Running setup.py install for mozsystemmonitor 08:17:05 INFO - Successfully installed mozsystemmonitor 08:17:05 INFO - Cleaning up... 08:17:05 INFO - Return code: 0 08:17:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:17:05 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')]} 08:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:05 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')]} 08:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:05 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 0x25fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296af90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968130>, '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 0x2969030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29694c0>, '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': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', '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 08:17:05 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 08:17:05 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 08:17:05 INFO - Using env: {'DISPLAY': ':0', 08:17:05 INFO - 'HOME': '/home/cltbld', 08:17:05 INFO - 'LANG': 'en_US.UTF-8', 08:17:05 INFO - 'LANGUAGE': 'en_US:en', 08:17:05 INFO - 'LOGNAME': 'cltbld', 08:17:05 INFO - 'MAIL': '/var/mail/cltbld', 08:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:05 INFO - 'MOZ_NO_REMOTE': '1', 08:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:05 INFO - 'NO_EM_RESTART': '1', 08:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:05 INFO - 'PWD': '/builds/slave/test', 08:17:05 INFO - 'SHELL': '/bin/bash', 08:17:05 INFO - 'SHLVL': '1', 08:17:05 INFO - 'TERM': 'linux', 08:17:05 INFO - 'TMOUT': '86400', 08:17:05 INFO - 'USER': 'cltbld', 08:17:05 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', 08:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:05 INFO - '_': '/tools/buildbot/bin/python'} 08:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:05 INFO - Downloading/unpacking jsonschema==2.5.1 08:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:17:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:17:06 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 08:17:06 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 08:17:06 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 08:17:06 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 08:17:06 INFO - Downloading functools32-3.2.3-2.tar.gz 08:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:17:07 INFO - warning: no files found matching '*.txt' 08:17:07 INFO - no previously-included directories found matching 'build' 08:17:07 INFO - no previously-included directories found matching 'dist' 08:17:07 INFO - no previously-included directories found matching '.git*' 08:17:07 INFO - Installing collected packages: jsonschema, functools32 08:17:07 INFO - Running setup.py install for functools32 08:17:07 INFO - warning: no files found matching '*.txt' 08:17:07 INFO - no previously-included directories found matching 'build' 08:17:07 INFO - no previously-included directories found matching 'dist' 08:17:07 INFO - no previously-included directories found matching '.git*' 08:17:07 INFO - Successfully installed jsonschema functools32 08:17:07 INFO - Cleaning up... 08:17:07 INFO - Return code: 0 08:17:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:17: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')]} 08:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17: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')]} 08:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296af90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968130>, '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 0x2969030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29694c0>, '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': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', '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 08:17:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:17:07 INFO - Using env: {'DISPLAY': ':0', 08:17:07 INFO - 'HOME': '/home/cltbld', 08:17:07 INFO - 'LANG': 'en_US.UTF-8', 08:17:07 INFO - 'LANGUAGE': 'en_US:en', 08:17:07 INFO - 'LOGNAME': 'cltbld', 08:17:07 INFO - 'MAIL': '/var/mail/cltbld', 08:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:07 INFO - 'MOZ_NO_REMOTE': '1', 08:17:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:07 INFO - 'NO_EM_RESTART': '1', 08:17:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:07 INFO - 'PWD': '/builds/slave/test', 08:17:07 INFO - 'SHELL': '/bin/bash', 08:17:07 INFO - 'SHLVL': '1', 08:17:07 INFO - 'TERM': 'linux', 08:17:07 INFO - 'TMOUT': '86400', 08:17:07 INFO - 'USER': 'cltbld', 08:17:07 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', 08:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:07 INFO - '_': '/tools/buildbot/bin/python'} 08:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:17:07 INFO - Cleaning up... 08:17:07 INFO - Return code: 0 08:17:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:17: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')]} 08:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17: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')]} 08:17:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x25fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296af90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968130>, '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 0x2969030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29694c0>, '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': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', '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 08:17:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:17:07 INFO - Using env: {'DISPLAY': ':0', 08:17:07 INFO - 'HOME': '/home/cltbld', 08:17:07 INFO - 'LANG': 'en_US.UTF-8', 08:17:07 INFO - 'LANGUAGE': 'en_US:en', 08:17:07 INFO - 'LOGNAME': 'cltbld', 08:17:07 INFO - 'MAIL': '/var/mail/cltbld', 08:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:07 INFO - 'MOZ_NO_REMOTE': '1', 08:17:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:07 INFO - 'NO_EM_RESTART': '1', 08:17:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:07 INFO - 'PWD': '/builds/slave/test', 08:17:07 INFO - 'SHELL': '/bin/bash', 08:17:07 INFO - 'SHLVL': '1', 08:17:07 INFO - 'TERM': 'linux', 08:17:07 INFO - 'TMOUT': '86400', 08:17:07 INFO - 'USER': 'cltbld', 08:17:07 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', 08:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:07 INFO - '_': '/tools/buildbot/bin/python'} 08:17:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:07 INFO - Downloading/unpacking blobuploader==1.2.4 08:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:08 INFO - Downloading blobuploader-1.2.4.tar.gz 08:17:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:17:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:17:08 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 08:17:08 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 08:17:08 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 08:17:08 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 08:17:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:17:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:17: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 08:17: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 08:17: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 08:17: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 08:17:09 INFO - Downloading docopt-0.6.1.tar.gz 08:17:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:17:09 INFO - Installing collected packages: blobuploader, requests, docopt 08:17:09 INFO - Running setup.py install for blobuploader 08:17:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:17:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:17:09 INFO - Running setup.py install for requests 08:17:09 INFO - Running setup.py install for docopt 08:17:09 INFO - Successfully installed blobuploader requests docopt 08:17:09 INFO - Cleaning up... 08:17:09 INFO - Return code: 0 08:17:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:09 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 0x25fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296af90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968130>, '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 0x2969030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29694c0>, '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': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', '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 08:17:09 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 08:17:09 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 08:17:09 INFO - Using env: {'DISPLAY': ':0', 08:17:09 INFO - 'HOME': '/home/cltbld', 08:17:09 INFO - 'LANG': 'en_US.UTF-8', 08:17:09 INFO - 'LANGUAGE': 'en_US:en', 08:17:09 INFO - 'LOGNAME': 'cltbld', 08:17:09 INFO - 'MAIL': '/var/mail/cltbld', 08:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:09 INFO - 'MOZ_NO_REMOTE': '1', 08:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:09 INFO - 'NO_EM_RESTART': '1', 08:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:09 INFO - 'PWD': '/builds/slave/test', 08:17:09 INFO - 'SHELL': '/bin/bash', 08:17:09 INFO - 'SHLVL': '1', 08:17:09 INFO - 'TERM': 'linux', 08:17:09 INFO - 'TMOUT': '86400', 08:17:09 INFO - 'USER': 'cltbld', 08:17:09 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', 08:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:09 INFO - '_': '/tools/buildbot/bin/python'} 08:17:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:10 INFO - Running setup.py (path:/tmp/pip-BOeP5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:10 INFO - Running setup.py (path:/tmp/pip-snIpPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:10 INFO - Running setup.py (path:/tmp/pip-PBXGph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:10 INFO - Running setup.py (path:/tmp/pip-qv2zV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:10 INFO - Running setup.py (path:/tmp/pip-mBCXzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:10 INFO - Running setup.py (path:/tmp/pip-sc35oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:10 INFO - Running setup.py (path:/tmp/pip-0oQKIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:10 INFO - Running setup.py (path:/tmp/pip-nbETPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:10 INFO - Running setup.py (path:/tmp/pip-kCZIyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:10 INFO - Running setup.py (path:/tmp/pip-5JaJrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:10 INFO - Running setup.py (path:/tmp/pip-5hhx0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:10 INFO - Running setup.py (path:/tmp/pip-LI2586-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:11 INFO - Running setup.py (path:/tmp/pip-pPt2rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:11 INFO - Running setup.py (path:/tmp/pip-aWS890-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:11 INFO - Running setup.py (path:/tmp/pip-bmdRNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:11 INFO - Running setup.py (path:/tmp/pip-cnJmp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:11 INFO - Running setup.py (path:/tmp/pip-aK1N3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:17:11 INFO - Running setup.py install for manifestparser 08:17:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:17:11 INFO - Running setup.py install for mozcrash 08:17:11 INFO - Running setup.py install for mozdebug 08:17:11 INFO - Running setup.py install for mozdevice 08:17:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:17:11 INFO - Running setup.py install for mozfile 08:17:11 INFO - Running setup.py install for mozhttpd 08:17:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:17:11 INFO - Running setup.py install for mozinfo 08:17:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Running setup.py install for mozInstall 08:17:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Running setup.py install for mozleak 08:17:12 INFO - Running setup.py install for mozlog 08:17:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Running setup.py install for moznetwork 08:17:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Running setup.py install for mozprocess 08:17:12 INFO - Running setup.py install for mozprofile 08:17:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Running setup.py install for mozrunner 08:17:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Running setup.py install for mozscreenshot 08:17:12 INFO - Running setup.py install for moztest 08:17:13 INFO - Running setup.py install for mozversion 08:17:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:17:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:17:13 INFO - Cleaning up... 08:17:13 INFO - Return code: 0 08:17:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17: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')]} 08:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17: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')]} 08:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:13 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 0x25fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296af90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968130>, '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 0x2969030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29694c0>, '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': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', '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 08:17:13 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 08:17:13 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 08:17:13 INFO - Using env: {'DISPLAY': ':0', 08:17:13 INFO - 'HOME': '/home/cltbld', 08:17:13 INFO - 'LANG': 'en_US.UTF-8', 08:17:13 INFO - 'LANGUAGE': 'en_US:en', 08:17:13 INFO - 'LOGNAME': 'cltbld', 08:17:13 INFO - 'MAIL': '/var/mail/cltbld', 08:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:13 INFO - 'MOZ_NO_REMOTE': '1', 08:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:13 INFO - 'NO_EM_RESTART': '1', 08:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:13 INFO - 'PWD': '/builds/slave/test', 08:17:13 INFO - 'SHELL': '/bin/bash', 08:17:13 INFO - 'SHLVL': '1', 08:17:13 INFO - 'TERM': 'linux', 08:17:13 INFO - 'TMOUT': '86400', 08:17:13 INFO - 'USER': 'cltbld', 08:17:13 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', 08:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:13 INFO - '_': '/tools/buildbot/bin/python'} 08:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:13 INFO - Running setup.py (path:/tmp/pip-Jf_bDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:13 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)) 08:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:13 INFO - Running setup.py (path:/tmp/pip-2mDGpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:13 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)) 08:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:13 INFO - Running setup.py (path:/tmp/pip-4fjgjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:13 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)) 08:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:13 INFO - Running setup.py (path:/tmp/pip-6vDKAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:13 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)) 08:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:13 INFO - Running setup.py (path:/tmp/pip-8BfAey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:13 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)) 08:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:13 INFO - Running setup.py (path:/tmp/pip-SadpCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:13 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)) 08:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:13 INFO - Running setup.py (path:/tmp/pip-vd1sbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:13 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)) 08:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:13 INFO - Running setup.py (path:/tmp/pip-Cin6lO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:13 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)) 08:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:13 INFO - Running setup.py (path:/tmp/pip-nwGCNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:14 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)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:14 INFO - Running setup.py (path:/tmp/pip-TDNlD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:14 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)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:14 INFO - Running setup.py (path:/tmp/pip-6HpLJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:14 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)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:14 INFO - Running setup.py (path:/tmp/pip-Cwd1k6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:14 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)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:14 INFO - Running setup.py (path:/tmp/pip-Ri4BIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:14 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)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:14 INFO - Running setup.py (path:/tmp/pip-pE6Nr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:14 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)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:14 INFO - Running setup.py (path:/tmp/pip-ojc4n9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:14 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)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:14 INFO - Running setup.py (path:/tmp/pip-x4_oiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:14 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)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:14 INFO - Running setup.py (path:/tmp/pip-ET5QuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:14 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)) 08:17:14 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)) 08:17:14 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)) 08:17:14 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)) 08:17:14 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)) 08:17:14 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)) 08:17:14 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)) 08:17:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:17:14 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 08:17:14 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 08:17:14 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 08:17:14 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 08:17:15 INFO - Downloading blessings-1.6.tar.gz 08:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:17:15 INFO - Installing collected packages: blessings 08:17:15 INFO - Running setup.py install for blessings 08:17:15 INFO - Successfully installed blessings 08:17:15 INFO - Cleaning up... 08:17:15 INFO - Return code: 0 08:17:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:16 INFO - Reading from file tmpfile_stdout 08:17:16 INFO - Current package versions: 08:17:16 INFO - argparse == 1.2.1 08:17:16 INFO - blessings == 1.6 08:17:16 INFO - blobuploader == 1.2.4 08:17:16 INFO - docopt == 0.6.1 08:17:16 INFO - functools32 == 3.2.3-2 08:17:16 INFO - jsonschema == 2.5.1 08:17:16 INFO - manifestparser == 1.1 08:17:16 INFO - mozInstall == 1.13 08:17:16 INFO - mozcrash == 1.0 08:17:16 INFO - mozdebug == 0.1 08:17:16 INFO - mozdevice == 0.51 08:17:16 INFO - mozfile == 1.2 08:17:16 INFO - mozhttpd == 0.7 08:17:16 INFO - mozinfo == 0.10 08:17:16 INFO - mozleak == 0.1 08:17:16 INFO - mozlog == 3.5 08:17:16 INFO - moznetwork == 0.27 08:17:16 INFO - mozprocess == 0.25 08:17:16 INFO - mozprofile == 0.28 08:17:16 INFO - mozrunner == 6.13 08:17:16 INFO - mozscreenshot == 0.1 08:17:16 INFO - mozsystemmonitor == 0.3 08:17:16 INFO - moztest == 0.8 08:17:16 INFO - mozversion == 1.4 08:17:16 INFO - psutil == 3.1.1 08:17:16 INFO - requests == 1.2.3 08:17:16 INFO - wsgiref == 0.1.2 08:17:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:16 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')]} 08:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:16 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')]} 08:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:16 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 0x25fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296af90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968130>, '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 0x2969030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29694c0>, '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': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', '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 08:17:16 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 08:17:16 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 08:17:16 INFO - Using env: {'DISPLAY': ':0', 08:17:16 INFO - 'HOME': '/home/cltbld', 08:17:16 INFO - 'LANG': 'en_US.UTF-8', 08:17:16 INFO - 'LANGUAGE': 'en_US:en', 08:17:16 INFO - 'LOGNAME': 'cltbld', 08:17:16 INFO - 'MAIL': '/var/mail/cltbld', 08:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:16 INFO - 'MOZ_NO_REMOTE': '1', 08:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:16 INFO - 'NO_EM_RESTART': '1', 08:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:16 INFO - 'PWD': '/builds/slave/test', 08:17:16 INFO - 'SHELL': '/bin/bash', 08:17:16 INFO - 'SHLVL': '1', 08:17:16 INFO - 'TERM': 'linux', 08:17:16 INFO - 'TMOUT': '86400', 08:17:16 INFO - 'USER': 'cltbld', 08:17:16 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', 08:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:16 INFO - '_': '/tools/buildbot/bin/python'} 08:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:16 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)) 08:17:16 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)) 08:17:16 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)) 08:17:16 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)) 08:17:16 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)) 08:17:16 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)) 08:17:16 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)) 08:17:16 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)) 08:17:16 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)) 08:17:16 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:17:16 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 08:17:16 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 08:17:16 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 08:17:16 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 08:17:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:17:17 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)) 08:17:17 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)) 08:17:17 INFO - Installing collected packages: simplejson 08:17:17 INFO - Running setup.py install for simplejson 08:17:17 INFO - building 'simplejson._speedups' extension 08:17:17 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 08:17:18 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 08:17:18 INFO - Successfully installed simplejson 08:17:18 INFO - Cleaning up... 08:17:18 INFO - Return code: 0 08:17:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:17:18 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')]} 08:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:18 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')]} 08:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:18 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 0x25fc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27c7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296af90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2968130>, '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 0x2969030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29694c0>, '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': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', '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 08:17:18 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 08:17:18 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 08:17:18 INFO - Using env: {'DISPLAY': ':0', 08:17:18 INFO - 'HOME': '/home/cltbld', 08:17:18 INFO - 'LANG': 'en_US.UTF-8', 08:17:18 INFO - 'LANGUAGE': 'en_US:en', 08:17:18 INFO - 'LOGNAME': 'cltbld', 08:17:18 INFO - 'MAIL': '/var/mail/cltbld', 08:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:18 INFO - 'MOZ_NO_REMOTE': '1', 08:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:18 INFO - 'NO_EM_RESTART': '1', 08:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:18 INFO - 'PWD': '/builds/slave/test', 08:17:18 INFO - 'SHELL': '/bin/bash', 08:17:18 INFO - 'SHLVL': '1', 08:17:18 INFO - 'TERM': 'linux', 08:17:18 INFO - 'TMOUT': '86400', 08:17:18 INFO - 'USER': 'cltbld', 08:17:18 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', 08:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:18 INFO - '_': '/tools/buildbot/bin/python'} 08:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:17:18 INFO - Cleaning up... 08:17:18 INFO - Return code: 0 08:17:18 INFO - Running post-action listener: _resource_record_post_action 08:17:18 INFO - Running post-action listener: _start_resource_monitoring 08:17:18 INFO - Starting resource monitoring. 08:17:18 INFO - [mozharness: 2017-08-23 15:17:18.863508Z] Finished create-virtualenv step (success) 08:17:18 INFO - [mozharness: 2017-08-23 15:17:18.863972Z] Running install step. 08:17:18 INFO - Running pre-action listener: _resource_record_pre_action 08:17:18 INFO - Running main action method: install 08:17:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:19 INFO - Reading from file tmpfile_stdout 08:17:19 INFO - Detecting whether we're running mozinstall >=1.0... 08:17:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:17:19 INFO - Reading from file tmpfile_stdout 08:17:19 INFO - Output received: 08:17:19 INFO - Usage: mozinstall [options] installer 08:17:19 INFO - Options: 08:17:19 INFO - -h, --help show this help message and exit 08:17:19 INFO - -d DEST, --destination=DEST 08:17:19 INFO - Directory to install application into. [default: 08:17:19 INFO - "/builds/slave/test"] 08:17:19 INFO - --app=APP Application being installed. [default: firefox] 08:17:19 INFO - mkdir: /builds/slave/test/build/application 08:17:19 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'] 08:17:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:17:37 INFO - Reading from file tmpfile_stdout 08:17:37 INFO - Output received: 08:17:37 INFO - /builds/slave/test/build/application/firefox/firefox 08:17:37 INFO - Running post-action listener: _resource_record_post_action 08:17:37 INFO - [mozharness: 2017-08-23 15:17:37.027290Z] Finished install step (success) 08:17:37 INFO - [mozharness: 2017-08-23 15:17:37.027436Z] Running setup-mitmproxy step. 08:17:37 INFO - Running pre-action listener: _resource_record_pre_action 08:17:37 INFO - Running main action method: setup_mitmproxy 08:17:37 INFO - Skipping: mitmproxy is not required 08:17:37 INFO - Running post-action listener: _resource_record_post_action 08:17:37 INFO - [mozharness: 2017-08-23 15:17:37.028077Z] Finished setup-mitmproxy step (success) 08:17:37 INFO - [mozharness: 2017-08-23 15:17:37.028205Z] Running run-tests step. 08:17:37 INFO - Running pre-action listener: _resource_record_pre_action 08:17:37 INFO - Running pre-action listener: _set_gcov_prefix 08:17:37 INFO - Running main action method: run_tests 08:17:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:17:37 INFO - Python 2.7.3 08:17:37 INFO - Return code: 0 08:17:37 INFO - grabbing minidump binary from tooltool 08:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:37 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 0x2968130>, '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 0x2969030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29694c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:17:37 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 08:17:37 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 08:17:37 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 08:17:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:17:37 INFO - Return code: 0 08:17:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:17:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:17:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:17:37 INFO - ENV: RUST_BACKTRACE is now full 08:17:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:17:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:17:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 08:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-088 --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 08:17:37 INFO - Using env: {'DISPLAY': ':0', 08:17:37 INFO - 'HOME': '/home/cltbld', 08:17:37 INFO - 'LANG': 'en_US.UTF-8', 08:17:37 INFO - 'LANGUAGE': 'en_US:en', 08:17:37 INFO - 'LOGNAME': 'cltbld', 08:17:37 INFO - 'MAIL': '/var/mail/cltbld', 08:17:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:17:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:37 INFO - 'MOZ_NO_REMOTE': '1', 08:17:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:37 INFO - 'NO_EM_RESTART': '1', 08:17:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:37 INFO - 'PWD': '/builds/slave/test', 08:17:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:17:37 INFO - 'RUST_BACKTRACE': 'full', 08:17:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:17:37 INFO - 'SHELL': '/bin/bash', 08:17:37 INFO - 'SHLVL': '1', 08:17:37 INFO - 'STYLO_FORCE_ENABLED': '1', 08:17:37 INFO - 'TERM': 'linux', 08:17:37 INFO - 'TMOUT': '86400', 08:17:37 INFO - 'USER': 'cltbld', 08:17:37 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112', 08:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:37 INFO - '_': '/tools/buildbot/bin/python'} 08:17:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 08:17:37 INFO - mozversion application_buildid: 20170823142347 08:17:37 INFO - mozversion application_changeset: 76c7aa772dc494d77ae7e1183b0ec1d073152dee 08:17:37 INFO - mozversion application_display_name: Nightly 08:17:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:17:37 INFO - mozversion application_name: Firefox 08:17:37 INFO - mozversion application_remotingname: firefox 08:17:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:17:37 INFO - mozversion application_vendor: Mozilla 08:17:37 INFO - mozversion application_version: 57.0a1 08:17:37 INFO - mozversion platform_buildid: 20170823142347 08:17:37 INFO - mozversion platform_changeset: 76c7aa772dc494d77ae7e1183b0ec1d073152dee 08:17:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:17:37 INFO - mozversion platform_version: 57.0a1 08:17:37 INFO - using testdate: 1503501457 08:17:37 INFO - actual date: 1503501457 08:17:37 INFO - starting webserver on 'localhost:51569' 08:17:37 INFO - SUITE-START | Running 2 tests 08:17:37 INFO - TEST-START | dromaeo_css 08:17:37 INFO - Initialising browser for dromaeo_css test... 08:17:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51569/getInfo.html -profile /tmp/tmpg7d8hT/profile 08:17:37 INFO - TEST-INFO | started process 25476 (/builds/slave/test/build/application/firefox/firefox http://localhost:51569/getInfo.html) 08:17:43 INFO - TEST-INFO | 25476: exit 0 08:17:43 INFO - Browser initialized. 08:17:43 INFO - Running cycle 1/1 for dromaeo_css test... 08:17:43 INFO - TEST-INFO | started process 25662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg7d8hT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:17:44 INFO - PID 25662 | 08:17:44 INFO - PID 25662 | (/builds/slave/test/build/application/firefox/firefox:25712): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:17:44 INFO - PID 25662 | 08:17:44 INFO - PID 25662 | 08:17:44 INFO - PID 25662 | (/builds/slave/test/build/application/firefox/firefox:25771): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:17:44 INFO - PID 25662 | 08:17:44 INFO - PID 25662 | __metrics Screen width/height:1600/1200 08:17:44 INFO - PID 25662 | colorDepth:24 08:17:44 INFO - PID 25662 | Browser inner width/height: 1024/768 08:17:44 INFO - PID 25662 | __metrics 08:17:54 INFO - PID 25662 | RSS: Main: 174825472 08:17:54 INFO - PID 25662 | 08:20:52 INFO - PID 25662 | Cycle 1(1): loaded http://localhost:51569/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51569/tests/dromaeo/cssquery-ext.html) 08:20:54 INFO - PID 25662 | RSS: Main: 178237440 08:20:54 INFO - PID 25662 | 08:23:55 INFO - PID 25662 | Cycle 1(1): loaded http://localhost:51569/tests/dromaeo/cssquery-ext.html (next: http://localhost:51569/tests/dromaeo/cssquery-jquery.html) 08:23:56 INFO - PID 25662 | RSS: Main: 175341568 08:23:56 INFO - PID 25662 | 08:26:58 INFO - PID 25662 | Cycle 1(1): loaded http://localhost:51569/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51569/tests/dromaeo/cssquery-mootools.html) 08:26:58 INFO - PID 25662 | RSS: Main: 177463296 08:26:58 INFO - PID 25662 | 08:30:00 INFO - PID 25662 | Cycle 1(1): loaded http://localhost:51569/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51569/tests/dromaeo/cssquery-prototype.html) 08:30:01 INFO - PID 25662 | RSS: Main: 175267840 08:30:01 INFO - PID 25662 | 08:33:05 INFO - PID 25662 | Cycle 1(1): loaded http://localhost:51569/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51569/tests/dromaeo/cssquery-yui.html) 08:33:05 INFO - PID 25662 | RSS: Main: 179007488 08:33:05 INFO - PID 25662 | 08:36:07 INFO - PID 25662 | Cycle 1(1): loaded http://localhost:51569/tests/dromaeo/cssquery-yui.html (next: http://localhost:51569/tests/dromaeo/cssquery-dojo.html) 08:36:07 INFO - PID 25662 | RSS: Main: 180006912 08:36:07 INFO - PID 25662 | 08:36:07 INFO - PID 25662 | __start_tp_report 08:36:07 INFO - PID 25662 | _x_x_mozilla_page_load 08:36:07 INFO - PID 25662 | _x_x_mozilla_page_load_details 08:36:07 INFO - PID 25662 | |i|pagename|runs| 08:36:07 INFO - PID 25662 | |0;dojo.html;3196.8561414736337;3226.4353738095833;3229.3056992746556;3253.024092772168;3276.311974485358;6011.87976240476;6052.3947605239455;6061.939380606193;6063.029915213567;6128.019516877301;5891.410858914106;6030.33666296707;6033.2760068791695;6060.303065147509;6075.33171351151;5564.944350556493;5572.498475137237;5577.553795696354;5586.10622300432;5601.971990140044;5600;5633.830985070434;5654.151877218409;5661.66030038197;5702.230198923134;5599;5671.631343962629;5677.517411020068;5683.602147849652;5683.687397193153;5407.864803379907;5512.80705175321;5521.751521181556;5630.605857589971;5654.6041777075625;5526.889462210774;5558.944410555923;5587.804426845041;5617.01702202113;5624.9875022495935;6010.338862725097;6023.307319658208;6109.236345456818;6112.419320164578;6140.201773769381;6298.937010629881;6383.585066970632;6437.420632143129;6489.415952564244;6511.958086706151;6584.341565843425;6586.604803711793;6594.307597702268;6601.867962640768;6622.304658010936;6049.818505444844;6120.173776540155;6135.6625385603775;6139.2325959255095;6147.415995480422;6659.700313485905;6685.966570167216;6733.528652994341;6751.763688270887;6775.22084960226;6293.118963345135;6350.745970161234;6394.648294343763;6401.519886008568;6425.228972523327;6379.266384365765;6430.7106180222;6453.419192272624;6469.159009328757;6470.45001174896;6402.455791257702;6418.775342862978;6445.709943052574;6445.709943052574;6448.419642232222;6544.149260596188;6552.180977377828;6568.638724870082;6589.80230593083;6600.669966501656;5198.194279886624;5282.075636763551;5291.947080529146;5293.20601909709;5298.70857102863;4490.438695163105;4555.043440877453;4562.908741825145;4569.177548041384;4635.582797548237;5593.105103183471;5641.576881733804;5654.688992105392;5676.716164191774;5695.145728140729;6574.178227721535;6598.769043083469;6623.668816559153;6628.502862285348;6645.966770166118;5628.493435590816;5703.62926409782;5705.857353566194;5714.628549144292;5714.628549144375;5629.943700563023;5659.5755318351285;5727.11229759388;5733.598648094677;5744;6127.325994140641;6186.19579454677;6217.378262173836;6220.937790622126;6254.655993920287;6467.932791089605;6496.545241833026;6509.088727578238;6521;6531.3468653134305;6174.66039367839;6214.130021797043;6238.563300569098;6251.156093927261;6259.593126446766;5594.608377413542;6348.301686814354;6412.647304398303;6419.903701444576;6508.9349106508325;6564.671766411756;6587.538872278895;6656.367645073904;6662;6667.133272674521;6236.563440559299;6327.209098862642;6327.557071004985;6407.0709747085475;6412.487001039813;6289.182406287154;6317.905231421624;6326.4622507087415;6330.746770129327;6340.461060809883;6213.316535181036;6259;6259.2488901332135;6261.937380626136;6270.435660790551;5556.416576259435;6331.620102793847;6398.328175541687;6444.4844412445955;6520.380563846427;6188.721507532082;6224.284207316216;6266.498680105672;6282.937170628418;6297.338779428094 08:36:07 INFO - PID 25662 | |1;ext.html;776.2431629161565;830.6428235858581;864.0581765875197;872.6683860133148;1096.7551828674461;29565.26086847827;38661.613383866184;39950.60049399505;40003.59996400039;40074.59925400745;39854.40218396719;40141.59858401415;40163.19673606526;40256.39615405764;40284.59715402845;7523.134839493447;7734.5359278443475;7735.1491335953;7741.3419859312025;7741.729039483619;7621.199774023731;7726.072871255429;7728.806779830493;7731.265529774662;7733.188015258401;7697.9230207697765;7722.768316950501;7725.72959946402;7733.574653394061;7755.457118001742;7650.967119438888;7659.7319093832;7682.270184332479;7683.577403242847;7688.077430708295;7554.8866766998535;7612.276833700789;7632.885506717404;7632.969549110854;7634.236576342377;37234.81382593097;37548.43677344842;37551.436728449095;37664;37704.49182032715;3467.4452087666104;3502;3503.4394496880377;3507.9649203507893;3514.0863375522295;30098.24754381136;30188.54717179244;30260.54609180864;30260.848695756602;30261.848690756404;5055.317532133152;5057.772400241998;5076.111680455905;5138.049460849717;5143.485651434827;180756;181715;181717;183124;183174.08412957983;45339;45637.31544026842;45678.314825277645;45722.77138614286;46094.76952615283;48536.27195592069;48660.27009594859;48720.756396217796;48728.512714873104;48840.26739598909;11681.18231723788;11950;14821.407143714347;15052.774208386883;15064.924675376553;12321;12484.937575312066;12577.182483138567;12582.87417125817;12583.182093163916;13393.73212535744;13455.529056482976;13490.865091349157;13537.255450950095;13543.05198636086;5573.972130139405;5641.210230567724;5651.491365777099;5732.570057245724;5734.799282025109;982.8427451607852;1008.6671398438498;1013.5692330759398;1019.0675531888239;1019.0879163148941;22497.212597559006;22590;22601.321960341214;22670.546589068126;22756.886215569146;1105.3257512917114;1112.3881864974232;1113.359818104577;1124.9325040497597;1125.21797350842;11935.820962685566;11950.402479875971;11968.640940771791;11991.280523168638;12003.339816310012;227112;227778;229314;229615;229666;49551.256731149064;49925.50074499209;49945;50038.24942625863;50124.49875501271;1374.5807528703642;1416.858314168575;1421.1615147063283;1428.2144820348974;1452.2956366162402;22483.88758056265;22542;22591.661125082806;22940.31179064631;23016.194433194756;35856;35928.46107308445;35937.46093808542;36128.45807312945;36198;189143.0542847277;189675.051624741;189747;190328;190343;32566.83716581402;33067.503987439726;34830.47754283738;35753;35923.46114808228;43637.345439819066;44432.780460493625;45088.54911450975;45358.54641453675;45714.31428528508;32337.838310808296;32454.188645284055;32463.18842028968;33008.66991330056;33068.1732956678;32464.83767581147;32903.83548082244;32923.34153316968;33051.504227437086;33190.33619327648;35931.28137437289;36341;36711.63288367189;36847.63152368549;37016.444753328185;31559.52660710045;31779.682203177672;31890.68109318877;32313.838430808635;32585.837070814494;23203.303900883002;24646.63030054515;24728.505429891662;25366.239012829643;25488.872555637103 08:36:07 INFO - PID 25662 | |2;jquery.html;550.6888607936513;559.9104143337067;560.6551970538118;567.2342337843911;573.5182446744734;21335.786642133593;22118.557628847415;22139.33581992543;22231.66652500214;22247.44381390466;24712.87643561784;25304.620430693507;25504.362390940234;25519.10683126091;25675.614865777028;6424.871502569946;6581.111549940769;6584.604923704593;6587.538872278942;6588.604683718968;6022.3074346450285;6303.0230314301125;6599.076129341872;6617.933820661804;6624.602523848561;6580.506462015344;6606.834829129262;6608.867822643569;6611.305812889649;6611.768588099418;6561;6563.474922006228;6579.17760279965;6587.934120658804;6606;6085.878282434326;6086.60437071589;6095.116208149793;6108.938910610881;6113.083037544359;28410.28974275639;28887.277818054506;29002.27494312659;29115.854420727974;29235.269118272;2062.0308455026266;2084.937451876446;2087.77034526202;2088.457001179689;2091.3725882235267;18961.14674839622;19547;19626.11682474292;19663.606727865506;19753.80246197534;2364.080010519998;2391.868447235401;2446.0949448704096;2447.9755202447927;2449.6203088521306;128173.35913320466;131281;131289.34355328258;131760;131851;13957.651058723613;14613.415463381558;14630.487932922297;14747.705045899022;15426.305816238297;22436.439089022904;22693.43266418353;22718.772812271665;23061.654075188886;23092.191773287854;9945.751356216153;9956.253281003808;10037.498125093716;10128.392296462236;10225.693229203136;9303.162715355515;9328.626854925727;9344.392614480037;9396.671116511026;9434.103760142776;8993.595288212045;9212.677556285631;9231.215346695471;9323.953380233055;9452.810943781085;2594.2476681762455;2596.389848385628;2623.0293593640326;2635.48608021434;2661.627372167898;961.7884065505577;979.2068424576116;988.7923536057508;988.8961659025842;996.9451680157516;20049.298274560322;20335.694964575545;20349.186032558828;20458.851820558924;20832.79167208339;1032.396048311731;1036.445501656625;1042.2652030318607;1043.9739006524746;1048.3185929146116;11127;11160.386178760084;11197.328160310408;11235.83146252807;11271.661850144508;457721;469282;474029;503010;506472;128113.35943320223;130919.34540327237;131408.3429582846;133474.33262833624;135876.9618455724;1185.5152988385914;1205.1864991130951;1243.1670780577035;1244.676384140112;1247.4947646203302;19919.900400497903;20897.582048358643;21954.451138721022;22075.962018990504;22404.663930041388;58944.115838261605;59107.113393299995;59127;59413.029348533266;60853.39146608477;72560.63719681368;76180.61909690416;78398;78409.60795195987;80169;18422.263109475472;19271.807281927002;19426.514337141685;20933.37199884006;21045.158193672694;22793.202237922258;22917.88541057284;23099.88450057806;23116.537669246183;23163;18339.908300458414;18394.26422943067;18787.812121878607;18889.527761806065;18970.146343414304;14923.552293431214;15939.920300398424;16126.758098628765;16331.101789401222;16891.408800691916;18486.260549578405;19059.90470047641;19107;19132.426027219204;19249.51876203106;20597.79402205959;20654.380368588965;20685.27601533939;20761.065752040893;20791.792082078984;17682.823171768632;17906.731399029286;17908.10459477047;17914.91042544779;17991.550211244823 08:36:07 INFO - PID 25662 | |3;mootools.html;1277.731676347967;1321.1676643714459;1336.9131006484583;1338.2907059258591;1349.7435487257414;14075.577732668024;14549.418023279082;14707.926460367697;14708.926455367722;14729.189894555795;15017.399304027853;15287.541373758777;15312.157831319273;15329.69340613187;15332;2702;2756.2144788735213;2756.738109879558;2759.4205216904475;2764.1431156341496;2473.183849329717;2564.781993530552;2610.765031147196;2746.615473833665;2749.6013078103665;2696.4741875334316;2702.729727027301;2717.320669832542;2727.5090483712925;2730.986345068272;2564.7691707746208;2616.8691565421655;2618.109842653507;2623.7113917469064;2627.0542604662305;2586.6378706981036;2590.909318173855;2629.368951451657;2633.920982370532;2635.235781623327;14208.431662733477;14302.499412520616;14320.641983950485;14333.928330358282;14349.497767578085;7752.961235193788;7967.8406431871035;8018.919810801875;8024.759257222293;8042.919570804275;4925.655204135712;5097.6941383517105;5211.947880521184;5232.005918875401;5239.161734122522;1759.2962814874152;1786.857051435882;1787.1421717575636;1819.8271164239377;1840.447865640316;24439.144629937866;24612.876935615386;24770.25689229326;24801.503969920683;24847;6662.900621397415;6696.63168525726;6722.058911752359;6812.6934287957165;6814.2623630973785;16305;16309.347626095061;16344;16352.509424717278;16364.67270654604;7318.817029574303;7436.219196984239;7438.070241219848;7440.66517006736;7443.4789564729945;6841.315868413219;6890.414314783199;6922.203946546211;7149.428045756327;7266.564006159648;5087.669301495391;5161.122609156452;5191.805884646477;5208.9739551302;5253.527182553588;1350.3113412159869;1387.098386049056;1399.6360946154073;1550.2248875562218;1553.3786485405928;825.8761185822054;846.3567688556741;857.2028013947089;860.5740158621522;877.035261212661;7565.2812982766545;7913.32736717374;8242.917570824335;8599.398042137116;8622.310215182895;940.4028441939417;970.5680971967407;996.5017491254373;1008.5562352564995;1011.8836333821557;4682.6253899687945;4942.258661200777;4943.555080042814;4992.2761199626575;5011.874703132378;19374.515637109183;19576.61952486659;20125;20351.185952562028;20436.693449598268;19752.209911603375;19884.304049358205;20524.486887827923;20731.58536829285;20747.962601869847;10770.461476926122;10822.567097316176;10877.51051202682;10890.564377424815;10992;7640.694372225271;7659;7676;7795.41534384912;7819.960900195462;17451.825481745527;17532.03573803453;17597.912010440377;17934.461966141036;18032.459026229233;18134.365297214536;18144.909275453538;18304.908475457538;18323.908380458546;18525.629487410446;10786.784264314827;11182.384968826793;11225.045871101049;11226.607068752555;11233.045191158517;12220.51117955272;12366.752664946831;12384.56654017105;12405.937970310091;12416;9790.75523111928;10460.58157673715;10546.947265263625;10623.734406639896;10654.520546575577;10229.48852557384;10272.024157705006;10399;10478.528466219192;10577.62978295756;8835.646574136963;9003.14470125337;9092.318076144184;9102.772430689285;9123.726288211365;6648.401643852077;6658.7336506539195;6702.564333318319;6737.090492783412;6833;6737.865242695217;6895.34494223048;6907.791136551184;6977.092977912839;7039.964800175966 08:36:07 INFO - PID 25662 | |4;prototype.html;481.3021119376904;504.3947263284059;511.63673791607954;519.4364114935295;522.6733291692692;6099.1766111574925;6152.169457123293;6162.815115546529;6184.289426344191;6201.193844800181;5975.878563110098;5994.310654274749;5996.610220335675;6011.519078473722;6041.939580604193;5044.545990860813;5044.621653376012;5064.848054558351;5079.746012699368;5117.769700363493;4746.430428348603;4909.410870695521;4945.752712364385;5057.6965382077005;5060.949390506103;4865.343178670887;4871.926921096187;4881.902361952759;4885.363403259895;4893.1926232171645;4815.374001379816;4839.298301746245;4852.8544143675745;4881.8779530511665;4882.145624515695;4269.231538323101;4350.608445239944;4371.737695738266;4372.103718737683;4373.650107991385;5950.196723442323;5982.431668991482;5982.910256346158;6026.728797204137;6046.153538504569;5555.527780138693;5585.2459917910965;5595.740958284394;5608.383077861432;5610.69141197234;6458.741650333981;6461.483081353527;6473.385028422293;6478.222613286389;6489.545731798776;4766.642501812378;4768.809247630091;4785.521447855222;4786.305985632064;4818.59041981432;6506.316836732122;6607.240167380716;6714.932850671479;6729.966350168218;6767.849465590862;4862.124817532807;4880.341153944172;4902.828401006019;4912.189488734391;4928.704277743275;4942.481039490874;4942.604591632661;4950.950490495049;4975.228839529878;4975.751212439363;5460.426655201226;5496;5522.751476183581;5525.392206857243;5550.69471179089;6322.778702745474;6355.459785918156;6492.415682588589;6507.349265073455;6529.608223506605;1683.452877814715;1709.154113557355;1726.5856194513226;1727.3349760342107;1730.5327561558308;1126.6056880092067;1175.400545721688;1178.5816035307514;1195.1394995603152;1199.196538319328;5521.420250873681;5547.195656629766;5563.777448902079;5613.915791263134;5667.574931880043;6442.162518872517;6468.191476065492;6490.156279683611;6503.154589903283;6638.734450621921;5531.174712344917;5610.607257491936;5625.746841392147;5629.634073785191;5673.092305231144;3458.9764987482104;3463.445848664252;3468.722502199818;3487.5989261234777;3491.511188433621;6149.723262453201;6187.628742275478;6229.162397092869;6285.748570057238;6323.557350985387;6625.569337993015;6636.814329121952;6644.767433139914;6720.7821418931635;6728.360805723449;6218.160548326008;6238;6281.309056003836;6281.685915704288;6297.811065668037;6476.643784591893;6517.9348206517325;6541.803745887631;6572.244191917991;6582.111414958919;5956.672383018976;6474.352564743488;6475.676216189077;6546.378094081055;6560.901586476302;6189.338584408568;6193.633488390764;6194.5044396449075;6265.15420418256;6314.116023756769;4875.1224779540025;4885.828995985124;4886.682365646222;4887.706737595756;4915.262710593297;6222.346653601488;6397.936020639734;6414.005829096497;6535.44448721864;6544.8363790905605;6137.877242455215;6212;6313.9266324723985;6348.428641422294;6390.968045159931;6217.937820621917;6225.657588832658;6262.624242545462;6268.655223962726;6377.266614339224;6267.592606480564;6284.214473190851;6291.370862913672;6325.430711236011;6331.810045698637;6403.64779937108;6438.8390290243115;6441.67791610427;6445.838854028687;6449.3873082057125;6206.813795586139;6207.379262073757;6237.5321850860455;6243.562950593415;6248.687565621792 08:36:07 INFO - PID 25662 | |5;yui.html;865.3380164174407;869.6782190589482;888.8933328000641;890.6615486115276;899.1278459893903;17046.147692615366;20202.797972020275;20961.895190524046;21709.565808683856;21801.890990545024;19602.41192764216;20051.29820456284;20297.289594864145;20443.591128177428;20459;921.2445794448555;935.0602644342426;939.9248060155205;940.3511577011874;940.7365937537501;852.7484392104344;938.1556599060832;939.7650587353162;940.4263399326439;952.3095755577186;985.8915519292872;986.7829077602952;989.4904124375952;989.5645915797062;989.915857152143;988.4662282367512;990.7968866382374;991.5538007896439;991.7124034030122;991.8413053911376;727.1492353945896;732.1141418883158;732.3226015935292;732.7508647059972;732.8167958010497;18472;18767.061646917737;18886.811131888644;18927.95896225707;19249.807501925083;17083.37707917746;17716;17981.820181798146;17984.730229046574;18150;14814.70370592593;14837.183954882477;14949.70100597982;14961.551153465414;14974.101553906801;3504.9824750876337;3515.4375299951885;3544.663256990582;3553.733469989761;3569.982150089259;123163.38418307941;124275;125508.37245813804;125993;126791;15919.363225471083;16366.754498682529;16415.26131324093;16469.423570175226;16475.58811029734;22164.113435462725;23243.53512929766;29227.85386073056;29610.259743506154;29900.85049574738;7746.457747957589;8145.266925976691;8154.3884208684585;8165.265126138676;8166.020077590609;4101.91796164075;4124.670026397881;4206.26390381682;4209.410682504452;4211.684123690736;4650.18621741194;4704.764761761899;4743;4745.6440766942615;4769.713817170911;897.9904725401116;914.6524320758069;916.7020718266457;920.1442658327819;920.59953920045;629.0564153769346;629.1066685306876;640.2509064394669;648.6594537867563;673.9224989126313;10226.795464090677;10309.36078764559;10487.265891387682;10545.31455455393;11160.832587511193;653.7842511971038;659.4592434203906;678.8913773796169;688.0401839434062;688.2016860441863;5274.5780337572905;5587.1339942309005;5702.657840529581;5738.311402631711;5867.266591676041;99076;103050.48474757579;105496;105788;106934.46532767286;94440.52779736057;99240;99973;102008.48995754974;102254;83268.58365708133;84571.15428845756;85571.14428855757;86461;88165.11834881698;9489.193418559224;9492.810143797224;9568.33021688503;9628.18160456369;9834;37450.625493744716;37520.62479375171;37621.435678465394;37988.62011379851;39084.60915390924;49825.25262121144;50490.747546262035;51157;51503.74248128735;52171.73914130405;16517.091559964316;16662.08358540292;16728.749068763736;16805;16842.494725158263;18009.2796288147;18168.273269069618;18183.45449636513;18211.45365639033;18333;14965.850341496445;15047.623809404853;15114;15176.31706573229;15180.392784288946;15856.207189640703;15982.440614578434;15982.440614578434;16030;16130.67738645244;14835.258237087886;14891.25543722788;14919.179445130621;14959.626009349853;14976.550703478913;10579.206559507913;10740.570377184826;10755.784884302426;10856.294340867818;10975.61585344541;10752.892471075189;10755.642590945927;10895.945520272347;11029.61396351124;11117 08:36:07 INFO - PID 25662 | __end_tp_report 08:36:07 INFO - PID 25662 | __start_cc_report 08:36:07 INFO - PID 25662 | _x_x_mozilla_cycle_collect,372 08:36:07 INFO - PID 25662 | __end_cc_report 08:36:07 INFO - PID 25662 | __startTimestamp1503502567664__endTimestamp 08:36:07 INFO - PID 25662 | 08:36:07 INFO - PID 25662 | ------- Summary: start ------- 08:36:07 INFO - PID 25662 | Number of tests: 6 08:36:07 INFO - PID 25662 | 08:36:07 INFO - PID 25662 | [#0] dojo.html Cycles:165 Average:5994.83 Median:6214.13 stddev:679.46 (10.9%) stddev-sans-first:645.12 08:36:07 INFO - PID 25662 | Values: 3196.9 3226.4 3229.3 3253.0 3276.3 6011.9 6052.4 6061.9 6063.0 6128.0 5891.4 6030.3 6033.3 6060.3 6075.3 5564.9 5572.5 5577.6 5586.1 5602.0 5600.0 5633.8 5654.2 5661.7 5702.2 5599.0 5671.6 5677.5 5683.6 5683.7 5407.9 5512.8 5521.8 5630.6 5654.6 5526.9 5558.9 5587.8 5617.0 5625.0 6010.3 6023.3 6109.2 6112.4 6140.2 6298.9 6383.6 6437.4 6489.4 6512.0 6584.3 6586.6 6594.3 6601.9 6622.3 6049.8 6120.2 6135.7 6139.2 6147.4 6659.7 6686.0 6733.5 6751.8 6775.2 6293.1 6350.7 6394.6 6401.5 6425.2 6379.3 6430.7 6453.4 6469.2 6470.5 6402.5 6418.8 6445.7 6445.7 6448.4 6544.1 6552.2 6568.6 6589.8 6600.7 5198.2 5282.1 5291.9 5293.2 5298.7 4490.4 4555.0 4562.9 4569.2 4635.6 5593.1 5641.6 5654.7 5676.7 5695.1 6574.2 6598.8 6623.7 6628.5 6646.0 5628.5 5703.6 5705.9 5714.6 5714.6 5629.9 5659.6 5727.1 5733.6 5744.0 6127.3 6186.2 6217.4 6220.9 6254.7 6467.9 6496.5 6509.1 6521.0 6531.3 6174.7 6214.1 6238.6 6251.2 6259.6 5594.6 6348.3 6412.6 6419.9 6508.9 6564.7 6587.5 6656.4 6662.0 6667.1 6236.6 6327.2 6327.6 6407.1 6412.5 6289.2 6317.9 6326.5 6330.7 6340.5 6213.3 6259.0 6259.2 6261.9 6270.4 5556.4 6331.6 6398.3 6444.5 6520.4 6188.7 6224.3 6266.5 6282.9 6297.3 08:36:07 INFO - PID 25662 | 08:36:07 INFO - PID 25662 | [#1] ext.html Cycles:180 Average:36632.21 Median:3502.72 stddev:52107.89 (1487.6%) stddev-sans-first:52184.51 08:36:07 INFO - PID 25662 | Values: 776.2 830.6 864.1 872.7 1096.8 29565.3 38661.6 39950.6 40003.6 40074.6 39854.4 40141.6 40163.2 40256.4 40284.6 7523.1 7734.5 7735.1 7741.3 7741.7 7621.2 7726.1 7728.8 7731.3 7733.2 7697.9 7722.8 7725.7 7733.6 7755.5 7651.0 7659.7 7682.3 7683.6 7688.1 7554.9 7612.3 7632.9 7633.0 7634.2 37234.8 37548.4 37551.4 37664.0 37704.5 3467.4 3502.0 3503.4 3508.0 3514.1 30098.2 30188.5 30260.5 30260.8 30261.8 5055.3 5057.8 5076.1 5138.0 5143.5 180756.0 181715.0 181717.0 183124.0 183174.1 45339.0 45637.3 45678.3 45722.8 46094.8 48536.3 48660.3 48720.8 48728.5 48840.3 11681.2 11950.0 14821.4 15052.8 15064.9 12321.0 12484.9 12577.2 12582.9 12583.2 13393.7 13455.5 13490.9 13537.3 13543.1 5574.0 5641.2 5651.5 5732.6 5734.8 982.8 1008.7 1013.6 1019.1 1019.1 22497.2 22590.0 22601.3 22670.5 22756.9 1105.3 1112.4 1113.4 1124.9 1125.2 11935.8 11950.4 11968.6 11991.3 12003.3 227112.0 227778.0 229314.0 229615.0 229666.0 49551.3 49925.5 49945.0 50038.2 50124.5 1374.6 1416.9 1421.2 1428.2 1452.3 22483.9 22542.0 22591.7 22940.3 23016.2 35856.0 35928.5 35937.5 36128.5 36198.0 189143.1 189675.1 189747.0 190328.0 190343.0 32566.8 33067.5 34830.5 35753.0 35923.5 43637.3 44432.8 45088.5 45358.5 45714.3 32337.8 32454.2 32463.2 33008.7 33068.2 32464.8 32903.8 32923.3 33051.5 33190.3 35931.3 36341.0 36711.6 36847.6 37016.4 31559.5 31779.7 31890.7 32313.8 32585.8 23203.3 24646.6 24728.5 25366.2 25488.9 08:36:07 INFO - PID 25662 | 08:36:07 INFO - PID 25662 | [#2] jquery.html Cycles:180 Average:35413.97 Median:22755.99 stddev:81692.60 (359.0%) stddev-sans-first:81879.84 08:36:07 INFO - PID 25662 | Values: 550.7 559.9 560.7 567.2 573.5 21335.8 22118.6 22139.3 22231.7 22247.4 24712.9 25304.6 25504.4 25519.1 25675.6 6424.9 6581.1 6584.6 6587.5 6588.6 6022.3 6303.0 6599.1 6617.9 6624.6 6580.5 6606.8 6608.9 6611.3 6611.8 6561.0 6563.5 6579.2 6587.9 6606.0 6085.9 6086.6 6095.1 6108.9 6113.1 28410.3 28887.3 29002.3 29115.9 29235.3 2062.0 2084.9 2087.8 2088.5 2091.4 18961.1 19547.0 19626.1 19663.6 19753.8 2364.1 2391.9 2446.1 2448.0 2449.6 128173.4 131281.0 131289.3 131760.0 131851.0 13957.7 14613.4 14630.5 14747.7 15426.3 22436.4 22693.4 22718.8 23061.7 23092.2 9945.8 9956.3 10037.5 10128.4 10225.7 9303.2 9328.6 9344.4 9396.7 9434.1 8993.6 9212.7 9231.2 9324.0 9452.8 2594.2 2596.4 2623.0 2635.5 2661.6 961.8 979.2 988.8 988.9 996.9 20049.3 20335.7 20349.2 20458.9 20832.8 1032.4 1036.4 1042.3 1044.0 1048.3 11127.0 11160.4 11197.3 11235.8 11271.7 457721.0 469282.0 474029.0 503010.0 506472.0 128113.4 130919.3 131408.3 133474.3 135877.0 1185.5 1205.2 1243.2 1244.7 1247.5 19919.9 20897.6 21954.5 22076.0 22404.7 58944.1 59107.1 59127.0 59413.0 60853.4 72560.6 76180.6 78398.0 78409.6 80169.0 18422.3 19271.8 19426.5 20933.4 21045.2 22793.2 22917.9 23099.9 23116.5 23163.0 18339.9 18394.3 18787.8 18889.5 18970.1 14923.6 15939.9 16126.8 16331.1 16891.4 18486.3 19059.9 19107.0 19132.4 19249.5 20597.8 20654.4 20685.3 20761.1 20791.8 17682.8 17906.7 17908.1 17914.9 17991.6 08:36:07 INFO - PID 25662 | 08:36:07 INFO - PID 25662 | [#3] mootools.html Cycles:180 Average:8868.58 Median:2600.84 stddev:6259.14 (240.7%) stddev-sans-first:6250.72 08:36:07 INFO - PID 25662 | Values: 1277.7 1321.2 1336.9 1338.3 1349.7 14075.6 14549.4 14707.9 14708.9 14729.2 15017.4 15287.5 15312.2 15329.7 15332.0 2702.0 2756.2 2756.7 2759.4 2764.1 2473.2 2564.8 2610.8 2746.6 2749.6 2696.5 2702.7 2717.3 2727.5 2731.0 2564.8 2616.9 2618.1 2623.7 2627.1 2586.6 2590.9 2629.4 2633.9 2635.2 14208.4 14302.5 14320.6 14333.9 14349.5 7753.0 7967.8 8018.9 8024.8 8042.9 4925.7 5097.7 5211.9 5232.0 5239.2 1759.3 1786.9 1787.1 1819.8 1840.4 24439.1 24612.9 24770.3 24801.5 24847.0 6662.9 6696.6 6722.1 6812.7 6814.3 16305.0 16309.3 16344.0 16352.5 16364.7 7318.8 7436.2 7438.1 7440.7 7443.5 6841.3 6890.4 6922.2 7149.4 7266.6 5087.7 5161.1 5191.8 5209.0 5253.5 1350.3 1387.1 1399.6 1550.2 1553.4 825.9 846.4 857.2 860.6 877.0 7565.3 7913.3 8242.9 8599.4 8622.3 940.4 970.6 996.5 1008.6 1011.9 4682.6 4942.3 4943.6 4992.3 5011.9 19374.5 19576.6 20125.0 20351.2 20436.7 19752.2 19884.3 20524.5 20731.6 20748.0 10770.5 10822.6 10877.5 10890.6 10992.0 7640.7 7659.0 7676.0 7795.4 7820.0 17451.8 17532.0 17597.9 17934.5 18032.5 18134.4 18144.9 18304.9 18323.9 18525.6 10786.8 11182.4 11225.0 11226.6 11233.0 12220.5 12366.8 12384.6 12405.9 12416.0 9790.8 10460.6 10546.9 10623.7 10654.5 10229.5 10272.0 10399.0 10478.5 10577.6 8835.6 9003.1 9092.3 9102.8 9123.7 6648.4 6658.7 6702.6 6737.1 6833.0 6737.9 6895.3 6907.8 6977.1 7040.0 08:36:07 INFO - PID 25662 | 08:36:07 INFO - PID 25662 | [#4] prototype.html Cycles:180 Average:5370.19 Median:5995.46 stddev:1494.38 (24.9%) stddev-sans-first:1452.82 08:36:07 INFO - PID 25662 | Values: 481.3 504.4 511.6 519.4 522.7 6099.2 6152.2 6162.8 6184.3 6201.2 5975.9 5994.3 5996.6 6011.5 6041.9 5044.5 5044.6 5064.8 5079.7 5117.8 4746.4 4909.4 4945.8 5057.7 5060.9 4865.3 4871.9 4881.9 4885.4 4893.2 4815.4 4839.3 4852.9 4881.9 4882.1 4269.2 4350.6 4371.7 4372.1 4373.7 5950.2 5982.4 5982.9 6026.7 6046.2 5555.5 5585.2 5595.7 5608.4 5610.7 6458.7 6461.5 6473.4 6478.2 6489.5 4766.6 4768.8 4785.5 4786.3 4818.6 6506.3 6607.2 6714.9 6730.0 6767.8 4862.1 4880.3 4902.8 4912.2 4928.7 4942.5 4942.6 4951.0 4975.2 4975.8 5460.4 5496.0 5522.8 5525.4 5550.7 6322.8 6355.5 6492.4 6507.3 6529.6 1683.5 1709.2 1726.6 1727.3 1730.5 1126.6 1175.4 1178.6 1195.1 1199.2 5521.4 5547.2 5563.8 5613.9 5667.6 6442.2 6468.2 6490.2 6503.2 6638.7 5531.2 5610.6 5625.7 5629.6 5673.1 3459.0 3463.4 3468.7 3487.6 3491.5 6149.7 6187.6 6229.2 6285.7 6323.6 6625.6 6636.8 6644.8 6720.8 6728.4 6218.2 6238.0 6281.3 6281.7 6297.8 6476.6 6517.9 6541.8 6572.2 6582.1 5956.7 6474.4 6475.7 6546.4 6560.9 6189.3 6193.6 6194.5 6265.2 6314.1 4875.1 4885.8 4886.7 4887.7 4915.3 6222.3 6397.9 6414.0 6535.4 6544.8 6137.9 6212.0 6313.9 6348.4 6391.0 6217.9 6225.7 6262.6 6268.7 6377.3 6267.6 6284.2 6291.4 6325.4 6331.8 6403.6 6438.8 6441.7 6445.8 6449.4 6206.8 6207.4 6237.5 6243.6 6248.7 08:36:07 INFO - PID 25662 | 08:36:07 INFO - PID 25662 | [#5] yui.html Cycles:180 Average:22087.83 Median:20510.30 stddev:31207.28 (152.2%) stddev-sans-first:31254.14 08:36:07 INFO - PID 25662 | Values: 865.3 869.7 888.9 890.7 899.1 17046.1 20202.8 20961.9 21709.6 21801.9 19602.4 20051.3 20297.3 20443.6 20459.0 921.2 935.1 939.9 940.4 940.7 852.7 938.2 939.8 940.4 952.3 985.9 986.8 989.5 989.6 989.9 988.5 990.8 991.6 991.7 991.8 727.1 732.1 732.3 732.8 732.8 18472.0 18767.1 18886.8 18928.0 19249.8 17083.4 17716.0 17981.8 17984.7 18150.0 14814.7 14837.2 14949.7 14961.6 14974.1 3505.0 3515.4 3544.7 3553.7 3570.0 123163.4 124275.0 125508.4 125993.0 126791.0 15919.4 16366.8 16415.3 16469.4 16475.6 22164.1 23243.5 29227.9 29610.3 29900.9 7746.5 8145.3 8154.4 8165.3 8166.0 4101.9 4124.7 4206.3 4209.4 4211.7 4650.2 4704.8 4743.0 4745.6 4769.7 898.0 914.7 916.7 920.1 920.6 629.1 629.1 640.3 648.7 673.9 10226.8 10309.4 10487.3 10545.3 11160.8 653.8 659.5 678.9 688.0 688.2 5274.6 5587.1 5702.7 5738.3 5867.3 99076.0 103050.5 105496.0 105788.0 106934.5 94440.5 99240.0 99973.0 102008.5 102254.0 83268.6 84571.2 85571.1 86461.0 88165.1 9489.2 9492.8 9568.3 9628.2 9834.0 37450.6 37520.6 37621.4 37988.6 39084.6 49825.3 50490.7 51157.0 51503.7 52171.7 16517.1 16662.1 16728.7 16805.0 16842.5 18009.3 18168.3 18183.5 18211.5 18333.0 14965.9 15047.6 15114.0 15176.3 15180.4 15856.2 15982.4 15982.4 16030.0 16130.7 14835.3 14891.3 14919.2 14959.6 14976.6 10579.2 10740.6 10755.8 10856.3 10975.6 10752.9 10755.6 10895.9 11029.6 11117.0 08:36:07 INFO - PID 25662 | -------- Summary: end -------- 08:36:07 INFO - PID 25662 | 08:36:08 INFO - TEST-INFO | 25662: exit 0 08:36:08 INFO - TEST-OK | dromaeo_css | took 1111034ms 08:36:08 INFO - TEST-START | kraken 08:36:08 INFO - Initialising browser for kraken test... 08:36:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51569/getInfo.html -profile /tmp/tmpCbHg54/profile 08:36:08 INFO - TEST-INFO | started process 26084 (/builds/slave/test/build/application/firefox/firefox http://localhost:51569/getInfo.html) 08:36:13 INFO - TEST-INFO | 26084: exit 0 08:36:13 INFO - Browser initialized. 08:36:13 INFO - Running cycle 1/1 for kraken test... 08:36:13 INFO - TEST-INFO | started process 26272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCbHg54/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:36:14 INFO - PID 26272 | 08:36:14 INFO - PID 26272 | (/builds/slave/test/build/application/firefox/firefox:26322): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:36:14 INFO - PID 26272 | 08:36:15 INFO - PID 26272 | 08:36:15 INFO - PID 26272 | (/builds/slave/test/build/application/firefox/firefox:26381): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:36:15 INFO - PID 26272 | 08:36:15 INFO - PID 26272 | __metrics Screen width/height:1600/1200 08:36:15 INFO - PID 26272 | colorDepth:24 08:36:15 INFO - PID 26272 | Browser inner width/height: 1024/768 08:36:15 INFO - PID 26272 | __metrics 08:36:25 INFO - PID 26272 | RSS: Main: 173969408 08:36:25 INFO - PID 26272 | 08:36:27 INFO - PID 26272 | Cycle 1(1): loaded http://localhost:51569/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51569/tests/kraken/driver.html?testName=audio-beat-detection) 08:36:28 INFO - PID 26272 | RSS: Main: 178073600 08:36:28 INFO - PID 26272 | 08:36:31 INFO - PID 26272 | Cycle 1(1): loaded http://localhost:51569/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51569/tests/kraken/driver.html?testName=audio-dft) 08:36:32 INFO - PID 26272 | RSS: Main: 180580352 08:36:32 INFO - PID 26272 | 08:36:34 INFO - PID 26272 | Cycle 1(1): loaded http://localhost:51569/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51569/tests/kraken/driver.html?testName=audio-fft) 08:36:35 INFO - PID 26272 | RSS: Main: 174190592 08:36:35 INFO - PID 26272 | 08:36:37 INFO - PID 26272 | Cycle 1(1): loaded http://localhost:51569/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51569/tests/kraken/driver.html?testName=audio-oscillator) 08:36:38 INFO - PID 26272 | RSS: Main: 174858240 08:36:38 INFO - PID 26272 | 08:36:40 INFO - PID 26272 | Cycle 1(1): loaded http://localhost:51569/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51569/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:36:41 INFO - PID 26272 | RSS: Main: 175468544 08:36:41 INFO - PID 26272 | 08:36:44 INFO - PID 26272 | Cycle 1(1): loaded http://localhost:51569/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51569/tests/kraken/driver.html?testName=imaging-darkroom) 08:36:45 INFO - PID 26272 | RSS: Main: 176115712 08:36:45 INFO - PID 26272 | 08:36:48 INFO - PID 26272 | Cycle 1(1): loaded http://localhost:51569/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51569/tests/kraken/driver.html?testName=imaging-desaturate) 08:36:49 INFO - PID 26272 | RSS: Main: 175849472 08:36:49 INFO - PID 26272 | 08:36:52 INFO - PID 26272 | Cycle 1(1): loaded http://localhost:51569/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51569/tests/kraken/driver.html?testName=json-parse-financial) 08:36:52 INFO - PID 26272 | RSS: Main: 176291840 08:36:52 INFO - PID 26272 | 08:36:54 INFO - PID 26272 | Cycle 1(1): loaded http://localhost:51569/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51569/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:36:55 INFO - PID 26272 | RSS: Main: 176644096 08:36:55 INFO - PID 26272 | 08:36:57 INFO - PID 26272 | Cycle 1(1): loaded http://localhost:51569/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51569/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:36:57 INFO - PID 26272 | RSS: Main: 177094656 08:36:57 INFO - PID 26272 | 08:36:59 INFO - PID 26272 | Cycle 1(1): loaded http://localhost:51569/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51569/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:37:00 INFO - PID 26272 | RSS: Main: 176418816 08:37:00 INFO - PID 26272 | 08:37:03 INFO - PID 26272 | Cycle 1(1): loaded http://localhost:51569/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51569/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:37:03 INFO - PID 26272 | RSS: Main: 176586752 08:37:03 INFO - PID 26272 | 08:37:06 INFO - PID 26272 | Cycle 1(1): loaded http://localhost:51569/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51569/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:37:07 INFO - PID 26272 | RSS: Main: 176607232 08:37:07 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | Cycle 1(1): loaded http://localhost:51569/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51569/tests/kraken/driver.html?testName=ai-astar) 08:37:09 INFO - PID 26272 | RSS: Main: 178040832 08:37:09 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | __start_tp_report 08:37:09 INFO - PID 26272 | _x_x_mozilla_page_load 08:37:09 INFO - PID 26272 | _x_x_mozilla_page_load_details 08:37:09 INFO - PID 26272 | |i|pagename|runs| 08:37:09 INFO - PID 26272 | |0;ai-astar;100;107;100;108;117;109;109;98;115;109 08:37:09 INFO - PID 26272 | |1;audio-beat-detection;142;119;158;181;123;150;145;122;173;119 08:37:09 INFO - PID 26272 | |2;audio-dft;163;163;163;160;162;163;165;165;167;165 08:37:09 INFO - PID 26272 | |3;audio-fft;73;77;75;173;78;76;74;85;97;79 08:37:09 INFO - PID 26272 | |4;audio-oscillator;80;79;135;82;78;81;127;79;79;137 08:37:09 INFO - PID 26272 | |5;imaging-gaussian-blur;114;113;113;115;116;114;114;117;116;113 08:37:09 INFO - PID 26272 | |6;imaging-darkroom;150;148;147;147;148;151;152;148;149;148 08:37:09 INFO - PID 26272 | |7;imaging-desaturate;94;94;94;95;95;95;94;94;99;102 08:37:09 INFO - PID 26272 | |8;json-parse-financial;56;54;56;54;54;54;55;57;54;59 08:37:09 INFO - PID 26272 | |9;json-stringify-tinderbox;56;63;56;55;55;56;55;61;61;58 08:37:09 INFO - PID 26272 | |10;stanford-crypto-aes;77;76;79;79;75;75;76;74;74;74 08:37:09 INFO - PID 26272 | |11;stanford-crypto-ccm;122;116;125;122;122;127;118;120;124;160 08:37:09 INFO - PID 26272 | |12;stanford-crypto-pbkdf2;173;170;180;172;174;187;171;169;171;170 08:37:09 INFO - PID 26272 | |13;stanford-crypto-sha256-iterative;67;71;67;65;75;63;66;64;64;64 08:37:09 INFO - PID 26272 | __end_tp_report 08:37:09 INFO - PID 26272 | __start_cc_report 08:37:09 INFO - PID 26272 | _x_x_mozilla_cycle_collect,908 08:37:09 INFO - PID 26272 | __end_cc_report 08:37:09 INFO - PID 26272 | __startTimestamp1503502629667__endTimestamp 08:37:09 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | ------- Summary: start ------- 08:37:09 INFO - PID 26272 | Number of tests: 14 08:37:09 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | [#0] ai-astar Cycles:10 Average:107.20 Median:109.00 stddev:6.29 (5.8%) stddev-sans-first:6.10 08:37:09 INFO - PID 26272 | Values: 100.0 107.0 100.0 108.0 117.0 109.0 109.0 98.0 115.0 109.0 08:37:09 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:147.50 stddev:22.65 (15.4%) stddev-sans-first:24.02 08:37:09 INFO - PID 26272 | Values: 142.0 119.0 158.0 181.0 123.0 150.0 145.0 122.0 173.0 119.0 08:37:09 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | [#2] audio-dft Cycles:10 Average:163.60 Median:164.00 stddev:1.96 (1.2%) stddev-sans-first:2.06 08:37:09 INFO - PID 26272 | Values: 163.0 163.0 163.0 160.0 162.0 163.0 165.0 165.0 167.0 165.0 08:37:09 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | [#3] audio-fft Cycles:10 Average:88.70 Median:77.50 stddev:30.45 (39.3%) stddev-sans-first:31.77 08:37:09 INFO - PID 26272 | Values: 73.0 77.0 75.0 173.0 78.0 76.0 74.0 85.0 97.0 79.0 08:37:09 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:79.00 stddev:25.88 (32.8%) stddev-sans-first:26.82 08:37:09 INFO - PID 26272 | Values: 80.0 79.0 135.0 82.0 78.0 81.0 127.0 79.0 79.0 137.0 08:37:09 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.50 stddev:1.43 (1.3%) stddev-sans-first:1.51 08:37:09 INFO - PID 26272 | Values: 114.0 113.0 113.0 115.0 116.0 114.0 114.0 117.0 116.0 113.0 08:37:09 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:148.50 stddev:1.69 (1.1%) stddev-sans-first:1.73 08:37:09 INFO - PID 26272 | Values: 150.0 148.0 147.0 147.0 148.0 151.0 152.0 148.0 149.0 148.0 08:37:09 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:94.50 stddev:2.72 (2.9%) stddev-sans-first:2.82 08:37:09 INFO - PID 26272 | Values: 94.0 94.0 94.0 95.0 95.0 95.0 94.0 94.0 99.0 102.0 08:37:09 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:1.70 (3.1%) stddev-sans-first:1.79 08:37:09 INFO - PID 26272 | Values: 56.0 54.0 56.0 54.0 54.0 54.0 55.0 57.0 54.0 59.0 08:37:09 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | [#9] json-stringify-tinderbox Cycles:10 Average:57.60 Median:57.00 stddev:2.99 (5.2%) stddev-sans-first:3.11 08:37:09 INFO - PID 26272 | Values: 56.0 63.0 56.0 55.0 55.0 56.0 55.0 61.0 61.0 58.0 08:37:09 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:76.00 stddev:1.91 (2.5%) stddev-sans-first:1.99 08:37:09 INFO - PID 26272 | Values: 77.0 76.0 79.0 79.0 75.0 75.0 76.0 74.0 74.0 74.0 08:37:09 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:123.00 stddev:12.51 (10.2%) stddev-sans-first:13.20 08:37:09 INFO - PID 26272 | Values: 122.0 116.0 125.0 122.0 122.0 127.0 118.0 120.0 124.0 160.0 08:37:09 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:172.50 stddev:5.62 (3.3%) stddev-sans-first:5.95 08:37:09 INFO - PID 26272 | Values: 173.0 170.0 180.0 172.0 174.0 187.0 171.0 169.0 171.0 170.0 08:37:09 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:3.75 (5.6%) stddev-sans-first:3.97 08:37:09 INFO - PID 26272 | Values: 67.0 71.0 67.0 65.0 75.0 63.0 66.0 64.0 64.0 64.0 08:37:09 INFO - PID 26272 | -------- Summary: end -------- 08:37:09 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 08:37:09 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | 08:37:09 INFO - PID 26272 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 08:37:09 INFO - PID 26272 | 08:37:10 INFO - PID 26272 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:37:10 INFO - TEST-INFO | 26272: exit 0 08:37:10 INFO - TEST-OK | kraken | took 62151ms 08:37:10 INFO - SUITE-END | took 1173s 08:37:10 INFO - Completed test suite (00:19:33) 08:37:10 INFO - javascript benchmark 08:37:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8295.263680817467, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3196.8561414736337, 3226.4353738095833, 3229.3056992746556, 3253.024092772168, 3276.311974485358, 6011.87976240476, 6052.3947605239455, 6061.939380606193, 6063.029915213567, 6128.019516877301, 5891.410858914106, 6030.33666296707, 6033.2760068791695, 6060.303065147509, 6075.33171351151, 5564.944350556493, 5572.498475137237, 5577.553795696354, 5586.10622300432, 5601.971990140044, 5600.0, 5633.830985070434, 5654.151877218409, 5661.66030038197, 5702.230198923134, 5599.0, 5671.631343962629, 5677.517411020068, 5683.602147849652, 5683.687397193153, 5407.864803379907, 5512.80705175321, 5521.751521181556, 5630.605857589971, 5654.6041777075625, 5526.889462210774, 5558.944410555923, 5587.804426845041, 5617.01702202113, 5624.9875022495935, 6010.338862725097, 6023.307319658208, 6109.236345456818, 6112.419320164578, 6140.201773769381, 6298.937010629881, 6383.585066970632, 6437.420632143129, 6489.415952564244, 6511.958086706151, 6584.341565843425, 6586.604803711793, 6594.307597702268, 6601.867962640768, 6622.304658010936, 6049.818505444844, 6120.173776540155, 6135.6625385603775, 6139.2325959255095, 6147.415995480422, 6659.700313485905, 6685.966570167216, 6733.528652994341, 6751.763688270887, 6775.22084960226, 6293.118963345135, 6350.745970161234, 6394.648294343763, 6401.519886008568, 6425.228972523327, 6379.266384365765, 6430.7106180222, 6453.419192272624, 6469.159009328757, 6470.45001174896, 6402.455791257702, 6418.775342862978, 6445.709943052574, 6445.709943052574, 6448.419642232222, 6544.149260596188, 6552.180977377828, 6568.638724870082, 6589.80230593083, 6600.669966501656, 5198.194279886624, 5282.075636763551, 5291.947080529146, 5293.20601909709, 5298.70857102863, 4490.438695163105, 4555.043440877453, 4562.908741825145, 4569.177548041384, 4635.582797548237, 5593.105103183471, 5641.576881733804, 5654.688992105392, 5676.716164191774, 5695.145728140729, 6574.178227721535, 6598.769043083469, 6623.668816559153, 6628.502862285348, 6645.966770166118, 5628.493435590816, 5703.62926409782, 5705.857353566194, 5714.628549144292, 5714.628549144375, 5629.943700563023, 5659.5755318351285, 5727.11229759388, 5733.598648094677, 5744.0, 6127.325994140641, 6186.19579454677, 6217.378262173836, 6220.937790622126, 6254.655993920287, 6467.932791089605, 6496.545241833026, 6509.088727578238, 6521.0, 6531.3468653134305, 6174.66039367839, 6214.130021797043, 6238.563300569098, 6251.156093927261, 6259.593126446766, 5594.608377413542, 6348.301686814354, 6412.647304398303, 6419.903701444576, 6508.9349106508325, 6564.671766411756, 6587.538872278895, 6656.367645073904, 6662.0, 6667.133272674521, 6236.563440559299, 6327.209098862642, 6327.557071004985, 6407.0709747085475, 6412.487001039813, 6289.182406287154, 6317.905231421624, 6326.4622507087415, 6330.746770129327, 6340.461060809883, 6213.316535181036, 6259.0, 6259.2488901332135, 6261.937380626136, 6270.435660790551, 5556.416576259435, 6331.620102793847, 6398.328175541687, 6444.4844412445955, 6520.380563846427, 6188.721507532082, 6224.284207316216, 6266.498680105672, 6282.937170628418, 6297.338779428094], "value": 5947.5814833336035, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [776.2431629161565, 830.6428235858581, 864.0581765875197, 872.6683860133148, 1096.7551828674461, 29565.26086847827, 38661.613383866184, 39950.60049399505, 40003.59996400039, 40074.59925400745, 39854.40218396719, 40141.59858401415, 40163.19673606526, 40256.39615405764, 40284.59715402845, 7523.134839493447, 7734.5359278443475, 7735.1491335953, 7741.3419859312025, 7741.729039483619, 7621.199774023731, 7726.072871255429, 7728.806779830493, 7731.265529774662, 7733.188015258401, 7697.9230207697765, 7722.768316950501, 7725.72959946402, 7733.574653394061, 7755.457118001742, 7650.967119438888, 7659.7319093832, 7682.270184332479, 7683.577403242847, 7688.077430708295, 7554.8866766998535, 7612.276833700789, 7632.885506717404, 7632.969549110854, 7634.236576342377, 37234.81382593097, 37548.43677344842, 37551.436728449095, 37664.0, 37704.49182032715, 3467.4452087666104, 3502.0, 3503.4394496880377, 3507.9649203507893, 3514.0863375522295, 30098.24754381136, 30188.54717179244, 30260.54609180864, 30260.848695756602, 30261.848690756404, 5055.317532133152, 5057.772400241998, 5076.111680455905, 5138.049460849717, 5143.485651434827, 180756.0, 181715.0, 181717.0, 183124.0, 183174.08412957983, 45339.0, 45637.31544026842, 45678.314825277645, 45722.77138614286, 46094.76952615283, 48536.27195592069, 48660.27009594859, 48720.756396217796, 48728.512714873104, 48840.26739598909, 11681.18231723788, 11950.0, 14821.407143714347, 15052.774208386883, 15064.924675376553, 12321.0, 12484.937575312066, 12577.182483138567, 12582.87417125817, 12583.182093163916, 13393.73212535744, 13455.529056482976, 13490.865091349157, 13537.255450950095, 13543.05198636086, 5573.972130139405, 5641.210230567724, 5651.491365777099, 5732.570057245724, 5734.799282025109, 982.8427451607852, 1008.6671398438498, 1013.5692330759398, 1019.0675531888239, 1019.0879163148941, 22497.212597559006, 22590.0, 22601.321960341214, 22670.546589068126, 22756.886215569146, 1105.3257512917114, 1112.3881864974232, 1113.359818104577, 1124.9325040497597, 1125.21797350842, 11935.820962685566, 11950.402479875971, 11968.640940771791, 11991.280523168638, 12003.339816310012, 227112.0, 227778.0, 229314.0, 229615.0, 229666.0, 49551.256731149064, 49925.50074499209, 49945.0, 50038.24942625863, 50124.49875501271, 1374.5807528703642, 1416.858314168575, 1421.1615147063283, 1428.2144820348974, 1452.2956366162402, 22483.88758056265, 22542.0, 22591.661125082806, 22940.31179064631, 23016.194433194756, 35856.0, 35928.46107308445, 35937.46093808542, 36128.45807312945, 36198.0, 189143.0542847277, 189675.051624741, 189747.0, 190328.0, 190343.0, 32566.83716581402, 33067.503987439726, 34830.47754283738, 35753.0, 35923.46114808228, 43637.345439819066, 44432.780460493625, 45088.54911450975, 45358.54641453675, 45714.31428528508, 32337.838310808296, 32454.188645284055, 32463.18842028968, 33008.66991330056, 33068.1732956678, 32464.83767581147, 32903.83548082244, 32923.34153316968, 33051.504227437086, 33190.33619327648, 35931.28137437289, 36341.0, 36711.63288367189, 36847.63152368549, 37016.444753328185, 31559.52660710045, 31779.682203177672, 31890.68109318877, 32313.838430808635, 32585.837070814494, 23203.303900883002, 24646.63030054515, 24728.505429891662, 25366.239012829643, 25488.872555637103], "value": 16845.994099157928, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.6888607936513, 559.9104143337067, 560.6551970538118, 567.2342337843911, 573.5182446744734, 21335.786642133593, 22118.557628847415, 22139.33581992543, 22231.66652500214, 22247.44381390466, 24712.87643561784, 25304.620430693507, 25504.362390940234, 25519.10683126091, 25675.614865777028, 6424.871502569946, 6581.111549940769, 6584.604923704593, 6587.538872278942, 6588.604683718968, 6022.3074346450285, 6303.0230314301125, 6599.076129341872, 6617.933820661804, 6624.602523848561, 6580.506462015344, 6606.834829129262, 6608.867822643569, 6611.305812889649, 6611.768588099418, 6561.0, 6563.474922006228, 6579.17760279965, 6587.934120658804, 6606.0, 6085.878282434326, 6086.60437071589, 6095.116208149793, 6108.938910610881, 6113.083037544359, 28410.28974275639, 28887.277818054506, 29002.27494312659, 29115.854420727974, 29235.269118272, 2062.0308455026266, 2084.937451876446, 2087.77034526202, 2088.457001179689, 2091.3725882235267, 18961.14674839622, 19547.0, 19626.11682474292, 19663.606727865506, 19753.80246197534, 2364.080010519998, 2391.868447235401, 2446.0949448704096, 2447.9755202447927, 2449.6203088521306, 128173.35913320466, 131281.0, 131289.34355328258, 131760.0, 131851.0, 13957.651058723613, 14613.415463381558, 14630.487932922297, 14747.705045899022, 15426.305816238297, 22436.439089022904, 22693.43266418353, 22718.772812271665, 23061.654075188886, 23092.191773287854, 9945.751356216153, 9956.253281003808, 10037.498125093716, 10128.392296462236, 10225.693229203136, 9303.162715355515, 9328.626854925727, 9344.392614480037, 9396.671116511026, 9434.103760142776, 8993.595288212045, 9212.677556285631, 9231.215346695471, 9323.953380233055, 9452.810943781085, 2594.2476681762455, 2596.389848385628, 2623.0293593640326, 2635.48608021434, 2661.627372167898, 961.7884065505577, 979.2068424576116, 988.7923536057508, 988.8961659025842, 996.9451680157516, 20049.298274560322, 20335.694964575545, 20349.186032558828, 20458.851820558924, 20832.79167208339, 1032.396048311731, 1036.445501656625, 1042.2652030318607, 1043.9739006524746, 1048.3185929146116, 11127.0, 11160.386178760084, 11197.328160310408, 11235.83146252807, 11271.661850144508, 457721.0, 469282.0, 474029.0, 503010.0, 506472.0, 128113.35943320223, 130919.34540327237, 131408.3429582846, 133474.33262833624, 135876.9618455724, 1185.5152988385914, 1205.1864991130951, 1243.1670780577035, 1244.676384140112, 1247.4947646203302, 19919.900400497903, 20897.582048358643, 21954.451138721022, 22075.962018990504, 22404.663930041388, 58944.115838261605, 59107.113393299995, 59127.0, 59413.029348533266, 60853.39146608477, 72560.63719681368, 76180.61909690416, 78398.0, 78409.60795195987, 80169.0, 18422.263109475472, 19271.807281927002, 19426.514337141685, 20933.37199884006, 21045.158193672694, 22793.202237922258, 22917.88541057284, 23099.88450057806, 23116.537669246183, 23163.0, 18339.908300458414, 18394.26422943067, 18787.812121878607, 18889.527761806065, 18970.146343414304, 14923.552293431214, 15939.920300398424, 16126.758098628765, 16331.101789401222, 16891.408800691916, 18486.260549578405, 19059.90470047641, 19107.0, 19132.426027219204, 19249.51876203106, 20597.79402205959, 20654.380368588965, 20685.27601533939, 20761.065752040893, 20791.792082078984, 17682.823171768632, 17906.731399029286, 17908.10459477047, 17914.91042544779, 17991.550211244823], "value": 12300.622592839676, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1277.731676347967, 1321.1676643714459, 1336.9131006484583, 1338.2907059258591, 1349.7435487257414, 14075.577732668024, 14549.418023279082, 14707.926460367697, 14708.926455367722, 14729.189894555795, 15017.399304027853, 15287.541373758777, 15312.157831319273, 15329.69340613187, 15332.0, 2702.0, 2756.2144788735213, 2756.738109879558, 2759.4205216904475, 2764.1431156341496, 2473.183849329717, 2564.781993530552, 2610.765031147196, 2746.615473833665, 2749.6013078103665, 2696.4741875334316, 2702.729727027301, 2717.320669832542, 2727.5090483712925, 2730.986345068272, 2564.7691707746208, 2616.8691565421655, 2618.109842653507, 2623.7113917469064, 2627.0542604662305, 2586.6378706981036, 2590.909318173855, 2629.368951451657, 2633.920982370532, 2635.235781623327, 14208.431662733477, 14302.499412520616, 14320.641983950485, 14333.928330358282, 14349.497767578085, 7752.961235193788, 7967.8406431871035, 8018.919810801875, 8024.759257222293, 8042.919570804275, 4925.655204135712, 5097.6941383517105, 5211.947880521184, 5232.005918875401, 5239.161734122522, 1759.2962814874152, 1786.857051435882, 1787.1421717575636, 1819.8271164239377, 1840.447865640316, 24439.144629937866, 24612.876935615386, 24770.25689229326, 24801.503969920683, 24847.0, 6662.900621397415, 6696.63168525726, 6722.058911752359, 6812.6934287957165, 6814.2623630973785, 16305.0, 16309.347626095061, 16344.0, 16352.509424717278, 16364.67270654604, 7318.817029574303, 7436.219196984239, 7438.070241219848, 7440.66517006736, 7443.4789564729945, 6841.315868413219, 6890.414314783199, 6922.203946546211, 7149.428045756327, 7266.564006159648, 5087.669301495391, 5161.122609156452, 5191.805884646477, 5208.9739551302, 5253.527182553588, 1350.3113412159869, 1387.098386049056, 1399.6360946154073, 1550.2248875562218, 1553.3786485405928, 825.8761185822054, 846.3567688556741, 857.2028013947089, 860.5740158621522, 877.035261212661, 7565.2812982766545, 7913.32736717374, 8242.917570824335, 8599.398042137116, 8622.310215182895, 940.4028441939417, 970.5680971967407, 996.5017491254373, 1008.5562352564995, 1011.8836333821557, 4682.6253899687945, 4942.258661200777, 4943.555080042814, 4992.2761199626575, 5011.874703132378, 19374.515637109183, 19576.61952486659, 20125.0, 20351.185952562028, 20436.693449598268, 19752.209911603375, 19884.304049358205, 20524.486887827923, 20731.58536829285, 20747.962601869847, 10770.461476926122, 10822.567097316176, 10877.51051202682, 10890.564377424815, 10992.0, 7640.694372225271, 7659.0, 7676.0, 7795.41534384912, 7819.960900195462, 17451.825481745527, 17532.03573803453, 17597.912010440377, 17934.461966141036, 18032.459026229233, 18134.365297214536, 18144.909275453538, 18304.908475457538, 18323.908380458546, 18525.629487410446, 10786.784264314827, 11182.384968826793, 11225.045871101049, 11226.607068752555, 11233.045191158517, 12220.51117955272, 12366.752664946831, 12384.56654017105, 12405.937970310091, 12416.0, 9790.75523111928, 10460.58157673715, 10546.947265263625, 10623.734406639896, 10654.520546575577, 10229.48852557384, 10272.024157705006, 10399.0, 10478.528466219192, 10577.62978295756, 8835.646574136963, 9003.14470125337, 9092.318076144184, 9102.772430689285, 9123.726288211365, 6648.401643852077, 6658.7336506539195, 6702.564333318319, 6737.090492783412, 6833.0, 6737.865242695217, 6895.34494223048, 6907.791136551184, 6977.092977912839, 7039.964800175966], "value": 6395.864236888833, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.3021119376904, 504.3947263284059, 511.63673791607954, 519.4364114935295, 522.6733291692692, 6099.1766111574925, 6152.169457123293, 6162.815115546529, 6184.289426344191, 6201.193844800181, 5975.878563110098, 5994.310654274749, 5996.610220335675, 6011.519078473722, 6041.939580604193, 5044.545990860813, 5044.621653376012, 5064.848054558351, 5079.746012699368, 5117.769700363493, 4746.430428348603, 4909.410870695521, 4945.752712364385, 5057.6965382077005, 5060.949390506103, 4865.343178670887, 4871.926921096187, 4881.902361952759, 4885.363403259895, 4893.1926232171645, 4815.374001379816, 4839.298301746245, 4852.8544143675745, 4881.8779530511665, 4882.145624515695, 4269.231538323101, 4350.608445239944, 4371.737695738266, 4372.103718737683, 4373.650107991385, 5950.196723442323, 5982.431668991482, 5982.910256346158, 6026.728797204137, 6046.153538504569, 5555.527780138693, 5585.2459917910965, 5595.740958284394, 5608.383077861432, 5610.69141197234, 6458.741650333981, 6461.483081353527, 6473.385028422293, 6478.222613286389, 6489.545731798776, 4766.642501812378, 4768.809247630091, 4785.521447855222, 4786.305985632064, 4818.59041981432, 6506.316836732122, 6607.240167380716, 6714.932850671479, 6729.966350168218, 6767.849465590862, 4862.124817532807, 4880.341153944172, 4902.828401006019, 4912.189488734391, 4928.704277743275, 4942.481039490874, 4942.604591632661, 4950.950490495049, 4975.228839529878, 4975.751212439363, 5460.426655201226, 5496.0, 5522.751476183581, 5525.392206857243, 5550.69471179089, 6322.778702745474, 6355.459785918156, 6492.415682588589, 6507.349265073455, 6529.608223506605, 1683.452877814715, 1709.154113557355, 1726.5856194513226, 1727.3349760342107, 1730.5327561558308, 1126.6056880092067, 1175.400545721688, 1178.5816035307514, 1195.1394995603152, 1199.196538319328, 5521.420250873681, 5547.195656629766, 5563.777448902079, 5613.915791263134, 5667.574931880043, 6442.162518872517, 6468.191476065492, 6490.156279683611, 6503.154589903283, 6638.734450621921, 5531.174712344917, 5610.607257491936, 5625.746841392147, 5629.634073785191, 5673.092305231144, 3458.9764987482104, 3463.445848664252, 3468.722502199818, 3487.5989261234777, 3491.511188433621, 6149.723262453201, 6187.628742275478, 6229.162397092869, 6285.748570057238, 6323.557350985387, 6625.569337993015, 6636.814329121952, 6644.767433139914, 6720.7821418931635, 6728.360805723449, 6218.160548326008, 6238.0, 6281.309056003836, 6281.685915704288, 6297.811065668037, 6476.643784591893, 6517.9348206517325, 6541.803745887631, 6572.244191917991, 6582.111414958919, 5956.672383018976, 6474.352564743488, 6475.676216189077, 6546.378094081055, 6560.901586476302, 6189.338584408568, 6193.633488390764, 6194.5044396449075, 6265.15420418256, 6314.116023756769, 4875.1224779540025, 4885.828995985124, 4886.682365646222, 4887.706737595756, 4915.262710593297, 6222.346653601488, 6397.936020639734, 6414.005829096497, 6535.44448721864, 6544.8363790905605, 6137.877242455215, 6212.0, 6313.9266324723985, 6348.428641422294, 6390.968045159931, 6217.937820621917, 6225.657588832658, 6262.624242545462, 6268.655223962726, 6377.266614339224, 6267.592606480564, 6284.214473190851, 6291.370862913672, 6325.430711236011, 6331.810045698637, 6403.64779937108, 6438.8390290243115, 6441.67791610427, 6445.838854028687, 6449.3873082057125, 6206.813795586139, 6207.379262073757, 6237.5321850860455, 6243.562950593415, 6248.687565621792], "value": 4930.47939016158, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [865.3380164174407, 869.6782190589482, 888.8933328000641, 890.6615486115276, 899.1278459893903, 17046.147692615366, 20202.797972020275, 20961.895190524046, 21709.565808683856, 21801.890990545024, 19602.41192764216, 20051.29820456284, 20297.289594864145, 20443.591128177428, 20459.0, 921.2445794448555, 935.0602644342426, 939.9248060155205, 940.3511577011874, 940.7365937537501, 852.7484392104344, 938.1556599060832, 939.7650587353162, 940.4263399326439, 952.3095755577186, 985.8915519292872, 986.7829077602952, 989.4904124375952, 989.5645915797062, 989.915857152143, 988.4662282367512, 990.7968866382374, 991.5538007896439, 991.7124034030122, 991.8413053911376, 727.1492353945896, 732.1141418883158, 732.3226015935292, 732.7508647059972, 732.8167958010497, 18472.0, 18767.061646917737, 18886.811131888644, 18927.95896225707, 19249.807501925083, 17083.37707917746, 17716.0, 17981.820181798146, 17984.730229046574, 18150.0, 14814.70370592593, 14837.183954882477, 14949.70100597982, 14961.551153465414, 14974.101553906801, 3504.9824750876337, 3515.4375299951885, 3544.663256990582, 3553.733469989761, 3569.982150089259, 123163.38418307941, 124275.0, 125508.37245813804, 125993.0, 126791.0, 15919.363225471083, 16366.754498682529, 16415.26131324093, 16469.423570175226, 16475.58811029734, 22164.113435462725, 23243.53512929766, 29227.85386073056, 29610.259743506154, 29900.85049574738, 7746.457747957589, 8145.266925976691, 8154.3884208684585, 8165.265126138676, 8166.020077590609, 4101.91796164075, 4124.670026397881, 4206.26390381682, 4209.410682504452, 4211.684123690736, 4650.18621741194, 4704.764761761899, 4743.0, 4745.6440766942615, 4769.713817170911, 897.9904725401116, 914.6524320758069, 916.7020718266457, 920.1442658327819, 920.59953920045, 629.0564153769346, 629.1066685306876, 640.2509064394669, 648.6594537867563, 673.9224989126313, 10226.795464090677, 10309.36078764559, 10487.265891387682, 10545.31455455393, 11160.832587511193, 653.7842511971038, 659.4592434203906, 678.8913773796169, 688.0401839434062, 688.2016860441863, 5274.5780337572905, 5587.1339942309005, 5702.657840529581, 5738.311402631711, 5867.266591676041, 99076.0, 103050.48474757579, 105496.0, 105788.0, 106934.46532767286, 94440.52779736057, 99240.0, 99973.0, 102008.48995754974, 102254.0, 83268.58365708133, 84571.15428845756, 85571.14428855757, 86461.0, 88165.11834881698, 9489.193418559224, 9492.810143797224, 9568.33021688503, 9628.18160456369, 9834.0, 37450.625493744716, 37520.62479375171, 37621.435678465394, 37988.62011379851, 39084.60915390924, 49825.25262121144, 50490.747546262035, 51157.0, 51503.74248128735, 52171.73914130405, 16517.091559964316, 16662.08358540292, 16728.749068763736, 16805.0, 16842.494725158263, 18009.2796288147, 18168.273269069618, 18183.45449636513, 18211.45365639033, 18333.0, 14965.850341496445, 15047.623809404853, 15114.0, 15176.31706573229, 15180.392784288946, 15856.207189640703, 15982.440614578434, 15982.440614578434, 16030.0, 16130.67738645244, 14835.258237087886, 14891.25543722788, 14919.179445130621, 14959.626009349853, 14976.550703478913, 10579.206559507913, 10740.570377184826, 10755.784884302426, 10856.294340867818, 10975.61585344541, 10752.892471075189, 10755.642590945927, 10895.945520272347, 11029.61396351124, 11117.0], "value": 8383.027366261478, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1512.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 107.0, 100.0, 108.0, 117.0, 109.0, 109.0, 98.0, 115.0, 109.0], "value": 107.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 119.0, 158.0, 181.0, 123.0, 150.0, 145.0, 122.0, 173.0, 119.0], "value": 143.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 160.0, 162.0, 163.0, 165.0, 165.0, 167.0, 165.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 75.0, 173.0, 78.0, 76.0, 74.0, 85.0, 97.0, 79.0], "value": 88.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 135.0, 82.0, 78.0, 81.0, 127.0, 79.0, 79.0, 137.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 115.0, 116.0, 114.0, 114.0, 117.0, 116.0, 113.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 147.0, 147.0, 148.0, 151.0, 152.0, 148.0, 149.0, 148.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 99.0, 102.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 56.0, 54.0, 54.0, 54.0, 55.0, 57.0, 54.0, 59.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 63.0, 56.0, 55.0, 55.0, 56.0, 55.0, 61.0, 61.0, 58.0], "value": 57.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 79.0, 79.0, 75.0, 75.0, 76.0, 74.0, 74.0, 74.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 116.0, 125.0, 122.0, 122.0, 127.0, 118.0, 120.0, 124.0, 160.0], "value": 125.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 180.0, 172.0, 174.0, 187.0, 171.0, 169.0, 171.0, 170.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 67.0, 65.0, 75.0, 63.0, 66.0, 64.0, 64.0, 64.0], "value": 66.6, "unit": "score"}]}]} 08:37:10 INFO - Return code: 0 08:37:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:37:10 INFO - # TBPL SUCCESS # 08:37:10 INFO - Running post-action listener: _package_coverage_data 08:37:10 INFO - Running post-action listener: _resource_record_post_action 08:37:10 INFO - [mozharness: 2017-08-23 15:37:10.965406Z] Finished run-tests step (success) 08:37:10 INFO - Running post-run listener: _resource_record_post_run 08:37:11 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 12288; Write bytes: 431849472; Read time: 220; Write time: 289808 08:37:11 INFO - TinderboxPrint: CPU usage
13.1% 08:37:11 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 220 08:37:11 INFO - TinderboxPrint: I/O write bytes / time
431,849,472 / 289,808 08:37:11 INFO - TinderboxPrint: CPU idle
8,257.2 (86.9%) 08:37:11 INFO - TinderboxPrint: CPU user
1,197.3 (12.6%) 08:37:11 INFO - TinderboxPrint: Swap in / out
0 / 0 08:37:11 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106508288; Read time: 0; Write time: 103604 08:37:11 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:37:11 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 8192; Write bytes: 325341184; Read time: 204; Write time: 186204 08:37:11 INFO - Running post-run listener: _upload_blobber_files 08:37:11 INFO - Blob upload gear active. 08:37:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:37:11 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 08:37:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:37:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:37:12 INFO - (blobuploader) - INFO - Open directory for files ... 08:37:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:37:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:37:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:12 INFO - (blobuploader) - INFO - Done attempting. 08:37:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:37:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:37:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:16 INFO - (blobuploader) - INFO - Done attempting. 08:37:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:37:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:37:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:17 INFO - (blobuploader) - INFO - Done attempting. 08:37:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:37:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:17 INFO - (blobuploader) - CRITICAL - Something went wrong on blobber! 08:37:17 INFO - (blobuploader) - INFO - Upload failed. Trying again ... 08:37:17 INFO - (blobuploader) - INFO - Done attempting. 08:37:17 INFO - (blobuploader) - INFO - Iteration through files over. 08:37:17 INFO - Return code: 0 08:37:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:37:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:37:17 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9deb3d5c39a71649930049a5f0b243882e0ee5e332dde527c157665d33751d551762394bcd019f6b796201920771084187618a8cd8c624ad77be1fafcfafaca", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfdb11323ec93682db3c318ef0a0924625c3e964f4ae584efdce20a7b357ee61327be0a2392c95404b8165c2dc10f8cd93931ab0e076ea334c5e2fc74e239006", "dromaeojs-e10s_errorsummary.log": null, "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11e58aaa3dccfcc4ec7decf9d8afd6e687f00f4164ef1540ce51d93653311511a9216fc1068dbab9f023d5bc33f1c40144352fe13acf66238ac7939d7294e3cb"} 08:37:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:37:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:37:17 INFO - Contents: 08:37:17 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9deb3d5c39a71649930049a5f0b243882e0ee5e332dde527c157665d33751d551762394bcd019f6b796201920771084187618a8cd8c624ad77be1fafcfafaca", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfdb11323ec93682db3c318ef0a0924625c3e964f4ae584efdce20a7b357ee61327be0a2392c95404b8165c2dc10f8cd93931ab0e076ea334c5e2fc74e239006", "dromaeojs-e10s_errorsummary.log": null, "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11e58aaa3dccfcc4ec7decf9d8afd6e687f00f4164ef1540ce51d93653311511a9216fc1068dbab9f023d5bc33f1c40144352fe13acf66238ac7939d7294e3cb"} 08:37:17 INFO - Running post-run listener: copy_logs_to_upload_dir 08:37:17 INFO - Copying logs to upload dir... 08:37:17 INFO - mkdir: /builds/slave/test/build/upload/logs 08:37:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.673573 ========= master_lag: -0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-23 08:37:17.308270) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 08:37:17.316233) ========= 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=9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9deb3d5c39a71649930049a5f0b243882e0ee5e332dde527c157665d33751d551762394bcd019f6b796201920771084187618a8cd8c624ad77be1fafcfafaca", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfdb11323ec93682db3c318ef0a0924625c3e964f4ae584efdce20a7b357ee61327be0a2392c95404b8165c2dc10f8cd93931ab0e076ea334c5e2fc74e239006", "dromaeojs-e10s_errorsummary.log": null, "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11e58aaa3dccfcc4ec7decf9d8afd6e687f00f4164ef1540ce51d93653311511a9216fc1068dbab9f023d5bc33f1c40144352fe13acf66238ac7939d7294e3cb"} build_url:https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/WODyYTpCRhaowJbHTZlbvA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d9deb3d5c39a71649930049a5f0b243882e0ee5e332dde527c157665d33751d551762394bcd019f6b796201920771084187618a8cd8c624ad77be1fafcfafaca", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfdb11323ec93682db3c318ef0a0924625c3e964f4ae584efdce20a7b357ee61327be0a2392c95404b8165c2dc10f8cd93931ab0e076ea334c5e2fc74e239006", "dromaeojs-e10s_errorsummary.log": null, "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11e58aaa3dccfcc4ec7decf9d8afd6e687f00f4164ef1540ce51d93653311511a9216fc1068dbab9f023d5bc33f1c40144352fe13acf66238ac7939d7294e3cb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 08:37:17.342083) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:37:17.342401) ========= 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=9f7544b6a75ada7b6b576032000001a7-1503491603.764590-78854112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 08:37:17.391796) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 08:37:17.392102) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 08:37:17.392388) ========= ========= Total master_lag: 0.10 =========