builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-086 starttime: 1502994030.6 results: success (0) revision: e365137fa61bfd729617ba1ebf9f1ed79facd1f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:30.596897) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:30.597365) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:30.597647) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:30.613955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:30.614246) ========= 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=438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-17 11:20:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-08-17 11:20:30 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.244391 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:30.878274) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:30.878570) ========= 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=438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019898 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:30.931529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-17 11:20:30.931836) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e365137fa61bfd729617ba1ebf9f1ed79facd1f2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev e365137fa61bfd729617ba1ebf9f1ed79facd1f2 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-17 11:20:31,101 truncating revision to first 12 chars 2017-08-17 11:20:31,101 Setting DEBUG logging. 2017-08-17 11:20:31,101 attempt 1/10 2017-08-17 11:20:31,101 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e365137fa61b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-17 11:20:32,527 unpacking tar archive at: mozilla-central-e365137fa61b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.755092 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-17 11:20:32.705802) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:32.706129) ========= script_repo_revision: e365137fa61bfd729617ba1ebf9f1ed79facd1f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:32.706523) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:32.706805) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 11:20:32.719679) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-17 11:20:32.720014) ========= /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=438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:20:32 INFO - MultiFileLogger online at 20170817 11:20:32 in /builds/slave/test 11:20:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:20:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:20:32 INFO - {'append_to_log': False, 11:20:32 INFO - 'base_work_dir': '/builds/slave/test', 11:20:32 INFO - 'blob_upload_branch': 'Firefox', 11:20:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:20:32 INFO - 'branch': 'Firefox', 11:20:32 INFO - 'buildbot_json_path': 'buildprops.json', 11:20:32 INFO - 'code_coverage': False, 11:20:32 INFO - 'config_files': ('talos/linux_config.py',), 11:20:32 INFO - 'default_actions': ('clobber', 11:20:32 INFO - 'read-buildbot-config', 11:20:32 INFO - 'download-and-extract', 11:20:32 INFO - 'populate-webroot', 11:20:32 INFO - 'create-virtualenv', 11:20:32 INFO - 'install', 11:20:32 INFO - 'setup-mitmproxy', 11:20:32 INFO - 'run-tests'), 11:20:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:20:32 INFO - 'disable_ccov_upload': False, 11:20:32 INFO - 'download_minidump_stackwalk': True, 11:20:32 INFO - 'download_symbols': 'ondemand', 11:20:32 INFO - 'enable_stylo': False, 11:20:32 INFO - 'enable_webrender': False, 11:20:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:20:32 INFO - 'tooltool.py': '/tools/tooltool.py', 11:20:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:20:32 INFO - '/tools/misc-python/virtualenv.py')}, 11:20:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:20:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:20:32 INFO - 'gecko_profile': False, 11:20:32 INFO - 'gecko_profile_interval': 0, 11:20:32 INFO - 'installer_path': 'installer.exe', 11:20:32 INFO - 'log_level': 'info', 11:20:32 INFO - 'log_name': 'talos', 11:20:32 INFO - 'log_to_console': True, 11:20:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:20:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:20:32 INFO - 'opt_config_files': (), 11:20:32 INFO - 'pip_index': False, 11:20:32 INFO - 'suite': 'dromaeojs-e10s', 11:20:32 INFO - 'system_bits': '32', 11:20:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:20:32 INFO - 'title': 'talos-linux64-ix-086', 11:20:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:20:32 INFO - 'use_talos_json': True, 11:20:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:20:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:20:32 INFO - 'work_dir': 'build'} 11:20:32 INFO - [mozharness: 2017-08-17 18:20:32.989356Z] Running clobber step. 11:20:32 INFO - Running pre-action listener: _resource_record_pre_action 11:20:32 INFO - Running main action method: clobber 11:20:32 INFO - rmtree: /builds/slave/test/build 11:20:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:20:34 INFO - Running post-action listener: _resource_record_post_action 11:20:34 INFO - [mozharness: 2017-08-17 18:20:34.535993Z] Finished clobber step (success) 11:20:34 INFO - [mozharness: 2017-08-17 18:20:34.536094Z] Running read-buildbot-config step. 11:20:34 INFO - Running pre-action listener: _resource_record_pre_action 11:20:34 INFO - Running main action method: read_buildbot_config 11:20:34 INFO - Using buildbot properties: 11:20:34 INFO - { 11:20:34 INFO - "project": "", 11:20:34 INFO - "product": "firefox", 11:20:34 INFO - "who": "archaeopteryx@coole-files.de", 11:20:34 INFO - "installer_path": "public/build/target.tar.bz2", 11:20:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 11:20:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:20:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 11:20:34 INFO - "stage_platform": "linux64-stylosequential", 11:20:34 INFO - "basedir": "/builds/slave/test", 11:20:34 INFO - "buildnumber": 154, 11:20:34 INFO - "platform": "ubuntu64_hw_styloseq", 11:20:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:20:34 INFO - "slavebuilddir": "test", 11:20:34 INFO - "taskId": "aYDT3b_RQOWlNu_GfUeKuA", 11:20:34 INFO - "branch": "mozilla-central", 11:20:34 INFO - "script_repo_revision": "production", 11:20:34 INFO - "revision": "e365137fa61bfd729617ba1ebf9f1ed79facd1f2", 11:20:34 INFO - "slavename": "talos-linux64-ix-086", 11:20:34 INFO - "repo_path": "mozilla-central" 11:20:34 INFO - } 11:20:34 INFO - Finding installer, test and symbols from parent task. 11:20:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aYDT3b_RQOWlNu_GfUeKuA'}, attempt #1 11:20:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aYDT3b_RQOWlNu_GfUeKuA'}, attempt #1 11:20:35 INFO - Task dependencies: aYF0Eu7eSDuOnCwEq2ykWQ 11:20:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ'}, attempt #1 11:20:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 11:20:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.test_packages.json 11:20:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.crashreporter-symbols.zip 11:20:35 INFO - Running post-action listener: _resource_record_post_action 11:20:35 INFO - [mozharness: 2017-08-17 18:20:35.913088Z] Finished read-buildbot-config step (success) 11:20:35 INFO - [mozharness: 2017-08-17 18:20:35.913404Z] Running download-and-extract step. 11:20:35 INFO - Running pre-action listener: _resource_record_pre_action 11:20:35 INFO - Running main action method: download_and_extract 11:20:35 INFO - mkdir: /builds/slave/test/build/tests 11:20:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:36 INFO - trying https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.test_packages.json 11:20:36 INFO - Downloading https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:20:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:20:36 INFO - Downloaded 989 bytes. 11:20:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:20:36 INFO - Using the following test package requirements: 11:20:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:20:36 INFO - u'common': [u'target.common.tests.zip'], 11:20:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:20:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:20:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:20:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:20:36 INFO - u'mozbase': [u'target.common.tests.zip'], 11:20:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:20:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:20:36 INFO - u'web-platform': [u'target.common.tests.zip', 11:20:36 INFO - u'target.web-platform.tests.tar.gz'], 11:20:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:20:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:20:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.common.tests.zip 11:20:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:20:36 INFO - Fetch https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.common.tests.zip into memory 11:20:37 INFO - Content-Length response header: 53999535 11:20:37 INFO - Bytes received: 53999535 11:20:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:20:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.common.tests.zip 11:20:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:20:48 INFO - Fetch https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.common.tests.zip into memory 11:20:49 INFO - Content-Length response header: 53999535 11:20:49 INFO - Bytes received: 53999535 11:21:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.talos.tests.zip 11:21:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:21:03 INFO - Fetch https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.talos.tests.zip into memory 11:21:04 INFO - Content-Length response header: 14496161 11:21:04 INFO - Bytes received: 14496161 11:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:04 INFO - trying https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 11:21:04 INFO - Downloading https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:21:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:21:05 INFO - Downloaded 62276440 bytes. 11:21:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 11:21:05 INFO - mkdir: /builds/slave/test/properties 11:21:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:21:05 INFO - Writing to file /builds/slave/test/properties/build_url 11:21:05 INFO - Contents: 11:21:05 INFO - build_url:https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 11:21:05 INFO - Running post-action listener: _resource_record_post_action 11:21:05 INFO - Running post-action listener: set_extra_try_arguments 11:21:05 INFO - [mozharness: 2017-08-17 18:21:05.518025Z] Finished download-and-extract step (success) 11:21:05 INFO - [mozharness: 2017-08-17 18:21:05.518124Z] Running populate-webroot step. 11:21:05 INFO - Running pre-action listener: _resource_record_pre_action 11:21:05 INFO - Running main action method: populate_webroot 11:21:05 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:21:05 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 11:21:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:21:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:21:05 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 11:21:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:21:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:21:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:21:05 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:21:05 INFO - 'talos_options': ['--stylo'], 11:21:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:21:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:21:05 INFO - 'tests': ['damp', 'tps']}, 11:21:05 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:21:05 INFO - 'talos_options': ['--stylo'], 11:21:05 INFO - 'tests': ['damp', 'tps']}, 11:21:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:21:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:21:05 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 11:21:05 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:21:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:21:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:21:05 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:21:05 INFO - 'talos_options': ['--stylo'], 11:21:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:21:05 INFO - 'other-e10s': {'tests': ['a11yr', 11:21:05 INFO - 'ts_paint', 11:21:05 INFO - 'tpaint', 11:21:05 INFO - 'sessionrestore', 11:21:05 INFO - 'sessionrestore_many_windows', 11:21:05 INFO - 'sessionrestore_no_auto_restore', 11:21:05 INFO - 'tabpaint']}, 11:21:05 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 11:21:05 INFO - 'tests': ['a11yr', 11:21:05 INFO - 'ts_paint', 11:21:05 INFO - 'tpaint', 11:21:05 INFO - 'sessionrestore', 11:21:05 INFO - 'sessionrestore_many_windows', 11:21:05 INFO - 'sessionrestore_no_auto_restore', 11:21:05 INFO - 'tabpaint']}, 11:21:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:21:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:21:05 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 11:21:05 INFO - 'tests': ['bloom_basic_singleton']}, 11:21:05 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 11:21:05 INFO - 'tests': ['bloom_basic']}, 11:21:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:21:05 INFO - 'tsvgr_opacity', 11:21:05 INFO - 'tart', 11:21:05 INFO - 'tscrollx', 11:21:05 INFO - 'tsvg_static']}, 11:21:05 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 11:21:05 INFO - 'tests': ['tsvgx', 11:21:05 INFO - 'tsvgr_opacity', 11:21:05 INFO - 'tart', 11:21:05 INFO - 'tscrollx', 11:21:05 INFO - 'tsvg_static']}, 11:21:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:21:05 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:21:05 INFO - 'talos_options': ['--stylo'], 11:21:05 INFO - 'tests': ['tp5o']}, 11:21:05 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:21:05 INFO - 'talos_options': ['--mitmproxy', 11:21:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:21:05 INFO - '--firstNonBlankPaint'], 11:21:05 INFO - 'tests': ['tp6_google', 11:21:05 INFO - 'tp6_youtube', 11:21:05 INFO - 'tp6_amazon', 11:21:05 INFO - 'tp6_facebook']}, 11:21:05 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:21:05 INFO - 'talos_options': ['--stylo', 11:21:05 INFO - '--mitmproxy', 11:21:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:21:05 INFO - '--firstNonBlankPaint'], 11:21:05 INFO - 'tests': ['tp6_google', 11:21:05 INFO - 'tp6_youtube', 11:21:05 INFO - 'tp6_amazon', 11:21:05 INFO - 'tp6_facebook']}, 11:21:05 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:21:05 INFO - 'talos_options': ['--stylo', 11:21:05 INFO - '--stylo-threads=1', 11:21:05 INFO - '--mitmproxy', 11:21:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:21:05 INFO - '--firstNonBlankPaint'], 11:21:05 INFO - 'tests': ['tp6_google', 11:21:05 INFO - 'tp6_youtube', 11:21:05 INFO - 'tp6_amazon', 11:21:05 INFO - 'tp6_facebook']}, 11:21:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:21:05 INFO - 'talos_options': ['--xperf_path', 11:21:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:21:05 INFO - 'tests': ['tp5n']}, 11:21:05 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:21:05 INFO - 'talos_options': ['--stylo', 11:21:05 INFO - '--xperf_path', 11:21:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:21:05 INFO - 'tests': ['tp5n']}}} 11:21:05 INFO - Running post-action listener: _resource_record_post_action 11:21:05 INFO - [mozharness: 2017-08-17 18:21:05.532347Z] Finished populate-webroot step (success) 11:21:05 INFO - [mozharness: 2017-08-17 18:21:05.532455Z] Running create-virtualenv step. 11:21:05 INFO - Running pre-action listener: _resource_record_pre_action 11:21:05 INFO - Running main action method: create_virtualenv 11:21:05 INFO - Creating virtualenv /builds/slave/test/build/venv 11:21:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:21:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:21:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:21:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:21:05 INFO - Using real prefix '/usr' 11:21:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:21:06 INFO - Installing distribute.............................................................................................................................................................................................done. 11:21:08 INFO - Installing pip.................done. 11:21:08 INFO - Return code: 0 11:21:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:21:08 INFO - Reading from file tmpfile_stdout 11:21:08 INFO - Output received: 11:21:08 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:21:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:08 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 0x1ec41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21690b0>, '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 0x2169fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a440>, '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': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:21:08 INFO - Using env: {'DISPLAY': ':0', 11:21:08 INFO - 'HOME': '/home/cltbld', 11:21:08 INFO - 'LANG': 'en_US.UTF-8', 11:21:08 INFO - 'LANGUAGE': 'en_US:en', 11:21:08 INFO - 'LOGNAME': 'cltbld', 11:21:08 INFO - 'MAIL': '/var/mail/cltbld', 11:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:08 INFO - 'MOZ_NO_REMOTE': '1', 11:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:08 INFO - 'NO_EM_RESTART': '1', 11:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:08 INFO - 'PWD': '/builds/slave/test', 11:21:08 INFO - 'SHELL': '/bin/bash', 11:21:08 INFO - 'SHLVL': '1', 11:21:08 INFO - 'TERM': 'linux', 11:21:08 INFO - 'TMOUT': '86400', 11:21:08 INFO - 'USER': 'cltbld', 11:21:08 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 11:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:08 INFO - '_': '/tools/buildbot/bin/python'} 11:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:21:08 INFO - Cleaning up... 11:21:08 INFO - Return code: 0 11:21:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:08 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 0x1ec41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21690b0>, '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 0x2169fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a440>, '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': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:21:08 INFO - Using env: {'DISPLAY': ':0', 11:21:08 INFO - 'HOME': '/home/cltbld', 11:21:08 INFO - 'LANG': 'en_US.UTF-8', 11:21:08 INFO - 'LANGUAGE': 'en_US:en', 11:21:08 INFO - 'LOGNAME': 'cltbld', 11:21:08 INFO - 'MAIL': '/var/mail/cltbld', 11:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:08 INFO - 'MOZ_NO_REMOTE': '1', 11:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:08 INFO - 'NO_EM_RESTART': '1', 11:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:08 INFO - 'PWD': '/builds/slave/test', 11:21:08 INFO - 'SHELL': '/bin/bash', 11:21:08 INFO - 'SHLVL': '1', 11:21:08 INFO - 'TERM': 'linux', 11:21:08 INFO - 'TMOUT': '86400', 11:21:08 INFO - 'USER': 'cltbld', 11:21:08 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 11:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:08 INFO - '_': '/tools/buildbot/bin/python'} 11:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:08 INFO - Downloading/unpacking psutil>=3.1.1 11:21: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 11:21: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 11:21: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 11:21: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 11:21:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:21:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:21:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:21:10 INFO - Installing collected packages: psutil 11:21:10 INFO - Running setup.py install for psutil 11:21:10 INFO - building 'psutil._psutil_linux' extension 11:21:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:21:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:21:10 INFO - building 'psutil._psutil_posix' extension 11:21:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:21:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:21:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:21:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:21:10 INFO - Successfully installed psutil 11:21:10 INFO - Cleaning up... 11:21:10 INFO - Return code: 0 11:21:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x1ec41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21690b0>, '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 0x2169fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a440>, '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': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:21:10 INFO - Using env: {'DISPLAY': ':0', 11:21:10 INFO - 'HOME': '/home/cltbld', 11:21:10 INFO - 'LANG': 'en_US.UTF-8', 11:21:10 INFO - 'LANGUAGE': 'en_US:en', 11:21:10 INFO - 'LOGNAME': 'cltbld', 11:21:10 INFO - 'MAIL': '/var/mail/cltbld', 11:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:10 INFO - 'MOZ_NO_REMOTE': '1', 11:21:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:10 INFO - 'NO_EM_RESTART': '1', 11:21:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:10 INFO - 'PWD': '/builds/slave/test', 11:21:10 INFO - 'SHELL': '/bin/bash', 11:21:10 INFO - 'SHLVL': '1', 11:21:10 INFO - 'TERM': 'linux', 11:21:10 INFO - 'TMOUT': '86400', 11:21:10 INFO - 'USER': 'cltbld', 11:21:10 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 11:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:10 INFO - '_': '/tools/buildbot/bin/python'} 11:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:21:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:21:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:21:11 INFO - Installing collected packages: mozsystemmonitor 11:21:11 INFO - Running setup.py install for mozsystemmonitor 11:21:11 INFO - Successfully installed mozsystemmonitor 11:21:11 INFO - Cleaning up... 11:21:12 INFO - Return code: 0 11:21:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x1ec41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21690b0>, '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 0x2169fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a440>, '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': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:21:12 INFO - Using env: {'DISPLAY': ':0', 11:21:12 INFO - 'HOME': '/home/cltbld', 11:21:12 INFO - 'LANG': 'en_US.UTF-8', 11:21:12 INFO - 'LANGUAGE': 'en_US:en', 11:21:12 INFO - 'LOGNAME': 'cltbld', 11:21:12 INFO - 'MAIL': '/var/mail/cltbld', 11:21:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:12 INFO - 'MOZ_NO_REMOTE': '1', 11:21:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:12 INFO - 'NO_EM_RESTART': '1', 11:21:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:12 INFO - 'PWD': '/builds/slave/test', 11:21:12 INFO - 'SHELL': '/bin/bash', 11:21:12 INFO - 'SHLVL': '1', 11:21:12 INFO - 'TERM': 'linux', 11:21:12 INFO - 'TMOUT': '86400', 11:21:12 INFO - 'USER': 'cltbld', 11:21:12 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 11:21:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:12 INFO - '_': '/tools/buildbot/bin/python'} 11:21:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:12 INFO - Downloading/unpacking jsonschema==2.5.1 11:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:21:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:13 INFO - Downloading functools32-3.2.3-2.tar.gz 11:21:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:21:13 INFO - warning: no files found matching '*.txt' 11:21:13 INFO - no previously-included directories found matching 'build' 11:21:13 INFO - no previously-included directories found matching 'dist' 11:21:13 INFO - no previously-included directories found matching '.git*' 11:21:13 INFO - Installing collected packages: jsonschema, functools32 11:21:13 INFO - Running setup.py install for functools32 11:21:13 INFO - warning: no files found matching '*.txt' 11:21:13 INFO - no previously-included directories found matching 'build' 11:21:13 INFO - no previously-included directories found matching 'dist' 11:21:13 INFO - no previously-included directories found matching '.git*' 11:21:13 INFO - Successfully installed jsonschema functools32 11:21:13 INFO - Cleaning up... 11:21:13 INFO - Return code: 0 11:21:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ec41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21690b0>, '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 0x2169fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a440>, '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': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:21:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:21:13 INFO - Using env: {'DISPLAY': ':0', 11:21:13 INFO - 'HOME': '/home/cltbld', 11:21:13 INFO - 'LANG': 'en_US.UTF-8', 11:21:13 INFO - 'LANGUAGE': 'en_US:en', 11:21:13 INFO - 'LOGNAME': 'cltbld', 11:21:13 INFO - 'MAIL': '/var/mail/cltbld', 11:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:13 INFO - 'MOZ_NO_REMOTE': '1', 11:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:13 INFO - 'NO_EM_RESTART': '1', 11:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:13 INFO - 'PWD': '/builds/slave/test', 11:21:13 INFO - 'SHELL': '/bin/bash', 11:21:13 INFO - 'SHLVL': '1', 11:21:13 INFO - 'TERM': 'linux', 11:21:13 INFO - 'TMOUT': '86400', 11:21:13 INFO - 'USER': 'cltbld', 11:21:13 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 11:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:13 INFO - '_': '/tools/buildbot/bin/python'} 11:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:21:14 INFO - Cleaning up... 11:21:14 INFO - Return code: 0 11:21:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:14 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 0x1ec41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21690b0>, '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 0x2169fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a440>, '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': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:21:14 INFO - Using env: {'DISPLAY': ':0', 11:21:14 INFO - 'HOME': '/home/cltbld', 11:21:14 INFO - 'LANG': 'en_US.UTF-8', 11:21:14 INFO - 'LANGUAGE': 'en_US:en', 11:21:14 INFO - 'LOGNAME': 'cltbld', 11:21:14 INFO - 'MAIL': '/var/mail/cltbld', 11:21:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:14 INFO - 'MOZ_NO_REMOTE': '1', 11:21:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:14 INFO - 'NO_EM_RESTART': '1', 11:21:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:14 INFO - 'PWD': '/builds/slave/test', 11:21:14 INFO - 'SHELL': '/bin/bash', 11:21:14 INFO - 'SHLVL': '1', 11:21:14 INFO - 'TERM': 'linux', 11:21:14 INFO - 'TMOUT': '86400', 11:21:14 INFO - 'USER': 'cltbld', 11:21:14 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 11:21:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:14 INFO - '_': '/tools/buildbot/bin/python'} 11:21:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:14 INFO - Downloading/unpacking blobuploader==1.2.4 11:21: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 11:21: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 11:21: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 11:21: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 11:21:15 INFO - Downloading blobuploader-1.2.4.tar.gz 11:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:21:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:21:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:15 INFO - Downloading docopt-0.6.1.tar.gz 11:21:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:21:16 INFO - Installing collected packages: blobuploader, requests, docopt 11:21:16 INFO - Running setup.py install for blobuploader 11:21:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:21:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:21:16 INFO - Running setup.py install for requests 11:21:16 INFO - Running setup.py install for docopt 11:21:16 INFO - Successfully installed blobuploader requests docopt 11:21:16 INFO - Cleaning up... 11:21:16 INFO - Return code: 0 11:21:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21: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')]} 11:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21: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')]} 11:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:16 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 0x1ec41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21690b0>, '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 0x2169fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a440>, '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': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:21:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:16 INFO - Using env: {'DISPLAY': ':0', 11:21:16 INFO - 'HOME': '/home/cltbld', 11:21:16 INFO - 'LANG': 'en_US.UTF-8', 11:21:16 INFO - 'LANGUAGE': 'en_US:en', 11:21:16 INFO - 'LOGNAME': 'cltbld', 11:21:16 INFO - 'MAIL': '/var/mail/cltbld', 11:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:16 INFO - 'MOZ_NO_REMOTE': '1', 11:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:16 INFO - 'NO_EM_RESTART': '1', 11:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:16 INFO - 'PWD': '/builds/slave/test', 11:21:16 INFO - 'SHELL': '/bin/bash', 11:21:16 INFO - 'SHLVL': '1', 11:21:16 INFO - 'TERM': 'linux', 11:21:16 INFO - 'TMOUT': '86400', 11:21:16 INFO - 'USER': 'cltbld', 11:21:16 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 11:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:16 INFO - '_': '/tools/buildbot/bin/python'} 11:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:16 INFO - Running setup.py (path:/tmp/pip-Ka7Zcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:16 INFO - Running setup.py (path:/tmp/pip-Q8mmjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:17 INFO - Running setup.py (path:/tmp/pip-AQYjbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:17 INFO - Running setup.py (path:/tmp/pip-du5Ceq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:17 INFO - Running setup.py (path:/tmp/pip-uN9Ms2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:17 INFO - Running setup.py (path:/tmp/pip-2tELCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:17 INFO - Running setup.py (path:/tmp/pip-BLlrpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:17 INFO - Running setup.py (path:/tmp/pip-GA9qgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:17 INFO - Running setup.py (path:/tmp/pip-KTF4HN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:17 INFO - Running setup.py (path:/tmp/pip-0oX0pB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:17 INFO - Running setup.py (path:/tmp/pip-wJ1drF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:17 INFO - Running setup.py (path:/tmp/pip-zEns82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:17 INFO - Running setup.py (path:/tmp/pip-hhonvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:17 INFO - Running setup.py (path:/tmp/pip-Lr9tnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:17 INFO - Running setup.py (path:/tmp/pip-Nye_MF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:18 INFO - Running setup.py (path:/tmp/pip-5NPzcS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:18 INFO - Running setup.py (path:/tmp/pip-o3XF1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:21:18 INFO - Running setup.py install for manifestparser 11:21:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:21:18 INFO - Running setup.py install for mozcrash 11:21:18 INFO - Running setup.py install for mozdebug 11:21:18 INFO - Running setup.py install for mozdevice 11:21:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:21:18 INFO - Running setup.py install for mozfile 11:21:18 INFO - Running setup.py install for mozhttpd 11:21:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:21:18 INFO - Running setup.py install for mozinfo 11:21:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:21:18 INFO - Running setup.py install for mozInstall 11:21:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:21:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:21:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:21:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:21:18 INFO - Running setup.py install for mozleak 11:21:19 INFO - Running setup.py install for mozlog 11:21:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:21:19 INFO - Running setup.py install for moznetwork 11:21:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:21:19 INFO - Running setup.py install for mozprocess 11:21:19 INFO - Running setup.py install for mozprofile 11:21:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:21:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:21:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:21:19 INFO - Running setup.py install for mozrunner 11:21:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:21:19 INFO - Running setup.py install for mozscreenshot 11:21:19 INFO - Running setup.py install for moztest 11:21:19 INFO - Running setup.py install for mozversion 11:21:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:21:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:21:19 INFO - Cleaning up... 11:21:19 INFO - Return code: 0 11:21:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:19 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 0x1ec41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21690b0>, '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 0x2169fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a440>, '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': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:19 INFO - Using env: {'DISPLAY': ':0', 11:21:19 INFO - 'HOME': '/home/cltbld', 11:21:19 INFO - 'LANG': 'en_US.UTF-8', 11:21:19 INFO - 'LANGUAGE': 'en_US:en', 11:21:19 INFO - 'LOGNAME': 'cltbld', 11:21:19 INFO - 'MAIL': '/var/mail/cltbld', 11:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:19 INFO - 'MOZ_NO_REMOTE': '1', 11:21:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:19 INFO - 'NO_EM_RESTART': '1', 11:21:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:19 INFO - 'PWD': '/builds/slave/test', 11:21:19 INFO - 'SHELL': '/bin/bash', 11:21:19 INFO - 'SHLVL': '1', 11:21:19 INFO - 'TERM': 'linux', 11:21:19 INFO - 'TMOUT': '86400', 11:21:19 INFO - 'USER': 'cltbld', 11:21:19 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 11:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:19 INFO - '_': '/tools/buildbot/bin/python'} 11:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:21:20 INFO - Running setup.py (path:/tmp/pip-R9apqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:21:20 INFO - Running setup.py (path:/tmp/pip-uJE4K8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:21:20 INFO - Running setup.py (path:/tmp/pip-bhtHHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:21:20 INFO - Running setup.py (path:/tmp/pip-AztfzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:21:20 INFO - Running setup.py (path:/tmp/pip-OITVoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:21:20 INFO - Running setup.py (path:/tmp/pip-bffPci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:21:20 INFO - Running setup.py (path:/tmp/pip-QcE1cW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:21:20 INFO - Running setup.py (path:/tmp/pip-FMrWFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:21:20 INFO - Running setup.py (path:/tmp/pip-qadaty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:21:20 INFO - Running setup.py (path:/tmp/pip-3rEXbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:21:20 INFO - Running setup.py (path:/tmp/pip-ZmwDDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:21:20 INFO - Running setup.py (path:/tmp/pip-p8bc9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:21:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:21:20 INFO - Running setup.py (path:/tmp/pip-hvdUX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:21:21 INFO - Running setup.py (path:/tmp/pip-i12cO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:21 INFO - Running setup.py (path:/tmp/pip-oWbSvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:21:21 INFO - Running setup.py (path:/tmp/pip-Zabezj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:21:21 INFO - Running setup.py (path:/tmp/pip-Usmx3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:21:21 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:21:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:22 INFO - Downloading blessings-1.6.tar.gz 11:21:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:21:22 INFO - Installing collected packages: blessings 11:21:22 INFO - Running setup.py install for blessings 11:21:22 INFO - Successfully installed blessings 11:21:22 INFO - Cleaning up... 11:21:22 INFO - Return code: 0 11:21:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:21:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:22 INFO - Reading from file tmpfile_stdout 11:21:22 INFO - Current package versions: 11:21:22 INFO - argparse == 1.2.1 11:21:22 INFO - blessings == 1.6 11:21:22 INFO - blobuploader == 1.2.4 11:21:22 INFO - docopt == 0.6.1 11:21:22 INFO - functools32 == 3.2.3-2 11:21:22 INFO - jsonschema == 2.5.1 11:21:22 INFO - manifestparser == 1.1 11:21:22 INFO - mozInstall == 1.13 11:21:22 INFO - mozcrash == 1.0 11:21:22 INFO - mozdebug == 0.1 11:21:22 INFO - mozdevice == 0.51 11:21:22 INFO - mozfile == 1.2 11:21:22 INFO - mozhttpd == 0.7 11:21:22 INFO - mozinfo == 0.10 11:21:22 INFO - mozleak == 0.1 11:21:22 INFO - mozlog == 3.5 11:21:22 INFO - moznetwork == 0.27 11:21:22 INFO - mozprocess == 0.25 11:21:22 INFO - mozprofile == 0.28 11:21:22 INFO - mozrunner == 6.13 11:21:22 INFO - mozscreenshot == 0.1 11:21:22 INFO - mozsystemmonitor == 0.3 11:21:22 INFO - moztest == 0.8 11:21:22 INFO - mozversion == 1.4 11:21:22 INFO - psutil == 3.1.1 11:21:22 INFO - requests == 1.2.3 11:21:22 INFO - wsgiref == 0.1.2 11:21:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:22 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 0x1ec41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21690b0>, '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 0x2169fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a440>, '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': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:21:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:21:22 INFO - Using env: {'DISPLAY': ':0', 11:21:22 INFO - 'HOME': '/home/cltbld', 11:21:22 INFO - 'LANG': 'en_US.UTF-8', 11:21:22 INFO - 'LANGUAGE': 'en_US:en', 11:21:22 INFO - 'LOGNAME': 'cltbld', 11:21:22 INFO - 'MAIL': '/var/mail/cltbld', 11:21:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:22 INFO - 'MOZ_NO_REMOTE': '1', 11:21:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:22 INFO - 'NO_EM_RESTART': '1', 11:21:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:22 INFO - 'PWD': '/builds/slave/test', 11:21:22 INFO - 'SHELL': '/bin/bash', 11:21:22 INFO - 'SHLVL': '1', 11:21:22 INFO - 'TERM': 'linux', 11:21:22 INFO - 'TMOUT': '86400', 11:21:22 INFO - 'USER': 'cltbld', 11:21:22 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 11:21:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:22 INFO - '_': '/tools/buildbot/bin/python'} 11:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:21:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:21:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:21:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:21:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:21:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:21:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:21:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:21:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:21:23 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:21:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:21:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:21:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:21:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:21:24 INFO - Installing collected packages: simplejson 11:21:24 INFO - Running setup.py install for simplejson 11:21:24 INFO - building 'simplejson._speedups' extension 11:21:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:21:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:21:25 INFO - Successfully installed simplejson 11:21:25 INFO - Cleaning up... 11:21:25 INFO - Return code: 0 11:21:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:25 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 0x1ec41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fc8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x216bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21690b0>, '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 0x2169fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a440>, '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': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:21:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:21:25 INFO - Using env: {'DISPLAY': ':0', 11:21:25 INFO - 'HOME': '/home/cltbld', 11:21:25 INFO - 'LANG': 'en_US.UTF-8', 11:21:25 INFO - 'LANGUAGE': 'en_US:en', 11:21:25 INFO - 'LOGNAME': 'cltbld', 11:21:25 INFO - 'MAIL': '/var/mail/cltbld', 11:21:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:25 INFO - 'MOZ_NO_REMOTE': '1', 11:21:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:25 INFO - 'NO_EM_RESTART': '1', 11:21:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:25 INFO - 'PWD': '/builds/slave/test', 11:21:25 INFO - 'SHELL': '/bin/bash', 11:21:25 INFO - 'SHLVL': '1', 11:21:25 INFO - 'TERM': 'linux', 11:21:25 INFO - 'TMOUT': '86400', 11:21:25 INFO - 'USER': 'cltbld', 11:21:25 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 11:21:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:25 INFO - '_': '/tools/buildbot/bin/python'} 11:21:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:21:25 INFO - Cleaning up... 11:21:25 INFO - Return code: 0 11:21:25 INFO - Running post-action listener: _resource_record_post_action 11:21:25 INFO - Running post-action listener: _start_resource_monitoring 11:21:25 INFO - Starting resource monitoring. 11:21:25 INFO - [mozharness: 2017-08-17 18:21:25.602614Z] Finished create-virtualenv step (success) 11:21:25 INFO - [mozharness: 2017-08-17 18:21:25.603130Z] Running install step. 11:21:25 INFO - Running pre-action listener: _resource_record_pre_action 11:21:25 INFO - Running main action method: install 11:21:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:25 INFO - Reading from file tmpfile_stdout 11:21:25 INFO - Detecting whether we're running mozinstall >=1.0... 11:21:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:21:25 INFO - Reading from file tmpfile_stdout 11:21:25 INFO - Output received: 11:21:25 INFO - Usage: mozinstall [options] installer 11:21:25 INFO - Options: 11:21:25 INFO - -h, --help show this help message and exit 11:21:25 INFO - -d DEST, --destination=DEST 11:21:25 INFO - Directory to install application into. [default: 11:21:25 INFO - "/builds/slave/test"] 11:21:25 INFO - --app=APP Application being installed. [default: firefox] 11:21:25 INFO - mkdir: /builds/slave/test/build/application 11:21:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:21:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:21:43 INFO - Reading from file tmpfile_stdout 11:21:43 INFO - Output received: 11:21:43 INFO - /builds/slave/test/build/application/firefox/firefox 11:21:43 INFO - Running post-action listener: _resource_record_post_action 11:21:43 INFO - [mozharness: 2017-08-17 18:21:43.951339Z] Finished install step (success) 11:21:43 INFO - [mozharness: 2017-08-17 18:21:43.951594Z] Running setup-mitmproxy step. 11:21:43 INFO - Running pre-action listener: _resource_record_pre_action 11:21:43 INFO - Running main action method: setup_mitmproxy 11:21:43 INFO - Skipping: mitmproxy is not required 11:21:43 INFO - Running post-action listener: _resource_record_post_action 11:21:43 INFO - [mozharness: 2017-08-17 18:21:43.952801Z] Finished setup-mitmproxy step (success) 11:21:43 INFO - [mozharness: 2017-08-17 18:21:43.953024Z] Running run-tests step. 11:21:43 INFO - Running pre-action listener: _resource_record_pre_action 11:21:43 INFO - Running pre-action listener: _set_gcov_prefix 11:21:43 INFO - Running main action method: run_tests 11:21:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:21:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:21:43 INFO - Python 2.7.3 11:21:43 INFO - Return code: 0 11:21:43 INFO - grabbing minidump binary from tooltool 11:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:43 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 0x21690b0>, '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 0x2169fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x216a440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:21:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:21:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:21:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:21:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:21:44 INFO - Return code: 0 11:21:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:21:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:21:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:21:44 INFO - ENV: RUST_BACKTRACE is now full 11:21:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:21:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:21:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-086 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:21:44 INFO - Using env: {'DISPLAY': ':0', 11:21:44 INFO - 'HOME': '/home/cltbld', 11:21:44 INFO - 'LANG': 'en_US.UTF-8', 11:21:44 INFO - 'LANGUAGE': 'en_US:en', 11:21:44 INFO - 'LOGNAME': 'cltbld', 11:21:44 INFO - 'MAIL': '/var/mail/cltbld', 11:21:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:44 INFO - 'MOZ_NO_REMOTE': '1', 11:21:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:44 INFO - 'NO_EM_RESTART': '1', 11:21:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:44 INFO - 'PWD': '/builds/slave/test', 11:21:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:44 INFO - 'RUST_BACKTRACE': 'full', 11:21:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:21:44 INFO - 'SHELL': '/bin/bash', 11:21:44 INFO - 'SHLVL': '1', 11:21:44 INFO - 'STYLO_FORCE_ENABLED': '1', 11:21:44 INFO - 'TERM': 'linux', 11:21:44 INFO - 'TMOUT': '86400', 11:21:44 INFO - 'USER': 'cltbld', 11:21:44 INFO - 'XDG_SESSION_COOKIE': '438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787', 11:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:44 INFO - '_': '/tools/buildbot/bin/python'} 11:21:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-086', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:21:44 INFO - mozversion application_buildid: 20170817173127 11:21:44 INFO - mozversion application_changeset: e365137fa61bfd729617ba1ebf9f1ed79facd1f2 11:21:44 INFO - mozversion application_display_name: Nightly 11:21:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:21:44 INFO - mozversion application_name: Firefox 11:21:44 INFO - mozversion application_remotingname: firefox 11:21:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:21:44 INFO - mozversion application_vendor: Mozilla 11:21:44 INFO - mozversion application_version: 57.0a1 11:21:44 INFO - mozversion platform_buildid: 20170817173127 11:21:44 INFO - mozversion platform_changeset: e365137fa61bfd729617ba1ebf9f1ed79facd1f2 11:21:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:21:44 INFO - mozversion platform_version: 57.0a1 11:21:44 INFO - using testdate: 1502994104 11:21:44 INFO - actual date: 1502994104 11:21:44 INFO - starting webserver on 'localhost:53511' 11:21:44 INFO - SUITE-START | Running 2 tests 11:21:44 INFO - TEST-START | dromaeo_css 11:21:44 INFO - Initialising browser for dromaeo_css test... 11:21:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53511/getInfo.html -profile /tmp/tmpeS0IUI/profile 11:21:44 INFO - TEST-INFO | started process 12183 (/builds/slave/test/build/application/firefox/firefox http://localhost:53511/getInfo.html) 11:21:50 INFO - TEST-INFO | 12183: exit 0 11:21:50 INFO - Browser initialized. 11:21:50 INFO - Running cycle 1/1 for dromaeo_css test... 11:21:50 INFO - TEST-INFO | started process 12374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeS0IUI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:51 INFO - PID 12374 | 11:21:51 INFO - PID 12374 | (/builds/slave/test/build/application/firefox/firefox:12428): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:21:51 INFO - PID 12374 | 11:22:01 INFO - PID 12374 | RSS: Main: 166502400 11:22:01 INFO - PID 12374 | 11:25:00 INFO - PID 12374 | Cycle 1(1): loaded http://localhost:53511/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53511/tests/dromaeo/cssquery-ext.html) 11:25:01 INFO - PID 12374 | RSS: Main: 174182400 11:25:01 INFO - PID 12374 | 11:28:03 INFO - PID 12374 | Cycle 1(1): loaded http://localhost:53511/tests/dromaeo/cssquery-ext.html (next: http://localhost:53511/tests/dromaeo/cssquery-jquery.html) 11:28:04 INFO - PID 12374 | RSS: Main: 171028480 11:28:04 INFO - PID 12374 | 11:31:06 INFO - PID 12374 | Cycle 1(1): loaded http://localhost:53511/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53511/tests/dromaeo/cssquery-mootools.html) 11:31:06 INFO - PID 12374 | RSS: Main: 173674496 11:31:06 INFO - PID 12374 | 11:34:08 INFO - PID 12374 | Cycle 1(1): loaded http://localhost:53511/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53511/tests/dromaeo/cssquery-prototype.html) 11:34:09 INFO - PID 12374 | RSS: Main: 171929600 11:34:09 INFO - PID 12374 | 11:37:13 INFO - PID 12374 | Cycle 1(1): loaded http://localhost:53511/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53511/tests/dromaeo/cssquery-yui.html) 11:37:13 INFO - PID 12374 | RSS: Main: 174907392 11:37:13 INFO - PID 12374 | 11:40:15 INFO - PID 12374 | Cycle 1(1): loaded http://localhost:53511/tests/dromaeo/cssquery-yui.html (next: http://localhost:53511/tests/dromaeo/cssquery-dojo.html) 11:40:15 INFO - PID 12374 | RSS: Main: 176226304 11:40:15 INFO - PID 12374 | 11:40:15 INFO - PID 12374 | __start_tp_report 11:40:15 INFO - PID 12374 | _x_x_mozilla_page_load 11:40:15 INFO - PID 12374 | _x_x_mozilla_page_load_details 11:40:15 INFO - PID 12374 | |i|pagename|runs| 11:40:15 INFO - PID 12374 | |0;dojo.html;3138.1683853778754;3157.5737275467814;3161.320316132032;3184.6656101109397;3202.919927001825;6036.758529658814;6167.7841275555365;6174.259088909326;6192.969035154818;6200.131981522591;6004.639721616706;6124.724387402566;6134.171886795281;6160.815175544741;6191.969040154793;5638.859028524279;5664;5669.574781891354;5681.630694004876;5702.6293290935955;5627.887442251153;5662.773489060432;5688.715564221793;5706.115552089412;5708.800191993281;5661.886762264752;5668.206451096849;5703.372629010805;5707.400722924095;5766.135079738052;5659.179418984266;5705;5705.400932902048;5759.798407055733;5771.797987070432;5464.590155738296;5586.469285417878;5587.217789509472;5615.129654903497;5685.175649530836;6018.879622407571;6044.909326360108;6073.787417440369;6102.72537735803;6153.169322141498;6599;6622.4370928471135;6702.095217145672;6704.631245281507;6715.294894036154;6478.74085036598;6558.344165583403;6575.835604109936;6673.03241030048;6689.431398331148;6158.137860699506;6166.969165154145;6181.721822517998;6191.288001879841;6207.317195108534;6719.0593316935665;6730.158730158731;6804.489663275274;6809.319068093151;6834.419074378733;6408.647524386203;6444.42000219973;6462.5153113515735;6478.384553467507;6575.243846957661;6480.157579514727;6484.1894763154605;6484.967575162094;6488.610683359014;6505.284418713938;6424.068510066014;6446.806595802133;6511.479081673455;6531.11829902957;6539.378759017981;6589.80230593083;6670.566413183127;6696.096027036385;6704.195496540447;6723.831904202336;5403.540699040547;5435.728213589305;5441.673499589958;5464.3442786865835;5473.67157970523;4575.725456472623;4594.081183763261;4610.492845786961;4646.326282688991;4665.066986602693;5706.087026075808;5726.398728133569;5732.226149469851;5750.02249617566;5753.827385178368;6562.803115906435;6657.833554161185;6668.166479190101;6703.798886033427;6724.831879202961;5671.234383358276;5697;5772.307323121168;5790.797322093791;5802;5727.684977326204;5767.538596912237;5798.5071268941765;5833.88332233353;5939.970300148471;6385.169927909342;6416.069669897839;6426.389492998158;6426.646534440557;6430.64631445275;6610.10763546915;6657.7669781557415;6690.063391125149;6712.328767123248;6720.0591917132615;6344.365563443619;6347.143135676809;6393.7122829471855;6467.741290348334;6476.805695829133;6297.307296197506;6426.871462570816;6432.388923052303;6534.934650653623;6542.051402546699;6478.935210648022;6602.702878370581;6666.600003999775;6670.733170673118;6672.599644021374;6381.904271435839;6430.131932189094;6450.451711604378;6478.384553467413;6487.9619260918025;6372.776952806629;6457.09600655918;6457.128287681103;6467.029945508211;6479.546431749733;6295.779647712308;6307.653079080695;6410.326915673973;6434.2922278548385;6434.774782882577;6276.497880169484;6369.9363006371195;6412.935870641234;6427.035944608346;6452.032195170762;6169.938300616936;6185.195924529782;6268.4671802897265;6274.247090349188;6286.811395658137 11:40:15 INFO - PID 12374 | |1;ext.html;800.16782546152;843.5866425451528;863.1109956744551;871.6513394642143;1174.9295042297458;30843.22891927703;31593.84203078984;43716.78141609291;44341.77829110858;44398.11203775922;44276.557234427644;44450.33324500127;44476;44503.55496445035;44505.33242001373;7258.383037441824;7640.61796910155;7788.805279867992;7806.921930780704;7807.063152421689;7676.846463070735;7770.4560680752365;7779.922200777976;7782.182870798541;7782.37740980723;7764.883526747103;7775.1447340792465;7818.921810781905;7844.0979287382115;7844.803879902991;7711.5758633275145;7786.76639700807;7790.688372465152;7790.766277011699;7793.064832220113;7657;7671.578063206522;7710.807229819299;7736;7737.110232323299;37770;38334.80832595819;38381;38487.422688659695;38587.614123858686;3526.0655926179584;3554.7689400189165;3563.322968635951;3563.6080031196548;3573.356795776759;30757.69242307593;30769;30818.84590577055;30862;30902.381952360825;5082.186850104003;5086.643934924557;5090.440051594322;5113.769880355356;5154.845354639367;186833.06583466995;187661;187867.0606646958;188601;188849;48227.276590851165;48316.758416208395;48474.75762621235;48484.757576211894;48527.514724853005;49699.254511182364;50153;50173;50295.49704502908;50456.243156352684;14562.563123106323;14751.40994360235;14753.631159221106;14787.852121478647;14813.555593332218;11866.525338986516;11962.521499139937;12575.371231438392;12700.301483418316;12733.745325093632;14181.716365672628;14221.502247421498;14271.429142834379;14343.497977570734;14558.199299038442;5475.808346707846;5591.189277554813;5696.430356964353;5710.371859095496;5725.08398656213;1003.914667253277;1016.4612755239586;1018.332991890313;1021.560728886571;1021.7343490692474;22629.773702262766;22814.885925570266;22823;22895;22985;1096.742265567591;1108.2685427617735;1111.6220485035126;1113.2207454781524;1129.3506233915532;12078.818817717742;12110;12138.878611213951;12140.15018948665;12162;212291;213693;214386;215021;215242;52806.20790688143;53360.46639533633;53398;53464.732676337146;53611.73194134004;1437.9137251764719;1450.7026059657744;1487.3381345301236;1489.3149151390264;1503.8947273690956;22087.889560552736;22250.443738906655;22372;22574.20990265333;22709.659355109357;37323.440148397254;37365.4395184067;37568.62431375651;37649.24701506009;37662.246755065295;183955;184691;185113.07443462696;185140.07429962765;185493;33648.83175584106;35987.46018809772;37381.813090934374;37466.62533374631;37552.62447375491;47833.76083119562;49622.50377496323;49664;49738;50131.99736005333;35676.10809729777;35867.64132358643;35977.64022359848;35998.4600231002;36096.639033609325;34437.827810860785;34597.82701086579;34807.30385392329;35002.474962876084;35403.82298088493;38068.23863522659;38210.2357952845;38322.42516362313;38576;39036.219275614894;34237.48643770296;34367.4844877322;34452.310953781285;34455.827720861234;34856.82571587126;23898.385446560445;24161.15435959733;24925.87537062303;25053.248402547953;25243.368915777253 11:40:15 INFO - PID 12374 | |2;jquery.html;564.7345747498674;566.4618612318294;567.8779062501563;596.4274296675192;599.2868486501064;22303.442413939658;22864.085436582558;23124.30627081188;23177.768222317773;23207.76792232077;25774.871125644393;26324.210273691773;26465;26551.601725974127;26559.336016599595;6440.7101680424375;6597.47220222381;6602.9669851650915;6604.306547812483;6605.801825945229;3875.1668391295866;4020.5778393268724;4025.9597404026026;6248.46888014517;6545.312742162076;6460.870782584346;6508.8047358579315;6510.38151375621;6511.869762604745;6538.771143009995;6513.283538810727;6517.902231466532;6531.804045878631;6532.8040158795075;6532.804015879531;6074.331823499411;6077.301110372319;6080.787172448987;6083.422074902877;6098.14625952367;29352.559711604343;29728.8513557433;29926.85036574825;30801;31170.844145779352;1832.578506943397;1922.8365588924958;1923.5479662279354;1926.373928473252;1931.8551108666766;19058.237670493163;19528.12123454434;19741.309054183035;19757.40727778169;19838.107285172202;2352.151191646312;2404.663347131403;2449.461118553915;2460.507898420305;2484.068474322129;135065.32467337602;137243;137825.999999999;139923;143511;14537.491187808588;15067.849321506865;15260.542183734506;15270.31283592241;15590.93294679211;23790.167344142872;23844.523109537713;23912;23913;23926.88036559806;9820.508974551387;9907.3560218587;10032.899671003343;10088.243381746399;10300.793984120275;9174.403663761834;9222.262219022596;9372.109649583279;9406.811863762687;9434.48110353937;7916.960415198002;9190.816183676288;9302.441853488812;9396.67111651089;9495.24038076966;2654.0843409023855;2693.62289279501;2707.783377329809;2711.4848178845955;2764.5162096633007;935.9532023398802;940.3558562384789;954.9045095490395;958.0898146760605;968.1577027985697;19242.903785481263;19910.203591856454;24812;25114;25502.489950200892;1001.3391161833155;1003.3344647884477;1011.2718842433436;1016.8373060310315;1029.1046789293362;10421.791564168674;11468.197226194086;11586.76826463466;11703.063754899587;13683.179009259477;550706;551334;559141;564973;567058;129082.35458822834;132039.33980330228;132363.33818330846;134236.31527369397;134867;1251.4931452761646;1262.2931158551241;1304.6803533134444;1307.7253776706998;1308.241220092344;21595.676064858726;21721.239756608444;21759.782402175777;21910.45223869416;22333.888330558242;62648;64139.679301603195;64769.35230647633;64986;65835.34164658292;73960;73977.26022739704;74232.62883685547;74514.62742686251;75276.62361688157;16506.917465412596;17936.820631793515;20347;21452.78547214508;21622.567548649255;23379.415514612272;23640;24259.636105458078;24298.514029718954;24562.877185613957;16277.511674649779;16819.159042048093;16934.40729574459;16992.83007169962;18135.093245337943;16524.66950660956;16701;16780.58048548796;17011.7448238279;18169.818301816813;14975.550733478012;15937.760933586238;16453.670926581643;16511.422100226435;16729.74905376396;20839.270625528035;20948.266810661553;21045.789542104383;21169.470763231042;21238;15957.760633590739;15998.200089995686;16040;16502.75245871337;16689.74965375496 11:40:15 INFO - PID 12374 | |3;mootools.html;1381.171297221667;1434.447737621016;1440.510226522982;1462.8683418492333;1462.919539425331;13122.671933201675;13638.522651707191;13651.522196723117;13673.521426750065;14767.187804670739;14933.328000239988;15100.47148349808;15190.54428367148;15208.771868421982;15218.163001034938;2490.8131890108225;2556.3481312265344;2556.782673472757;2568.319395360231;2569.267758688774;2545.2491515003026;2633.934151646205;2673.304940715418;2683.1413947536794;2684.5704687250045;2606.0357667662993;2610.3474131467133;2628.3954690421215;2644.7223041580646;2652.230853052622;2534.2270607464716;2538.4796116796106;2552.9489410211786;2557.757013083754;2562.525932702456;2435.9512809743705;2437.0373702387456;2481.019997101153;2483.726790053093;2496.3384703053707;13856.722865542733;14234.288285585782;14316.642083947985;14324.212168330738;14381.568552943429;7365.30029647188;7408;7650.158482566913;7685.423593230475;7693.73071942485;5099.209622508517;5120.974395128038;5171.922421163686;5244.973775131138;5248.370195576517;1869.5886904880904;1869.7943226245102;1901.8668693191482;1919.8560107991957;1952.7363805886166;23494.177703780286;23965.400864978514;23965.520689586112;23999.64000539993;24033.27900162998;6244.718987645476;6460.547761656639;6543.9345606544275;6627.4366678831875;6664.266930637626;16352.918235408746;16358;16382.262798174112;16398.83601163997;16446.095464749313;7206.819829504199;7496.7750967471065;7510.511816731895;7510.887336689954;7522.172561018284;5870.882582348415;6039.275286965504;6388.361163883575;6388.648624325707;6902.516823822284;5080.796768129233;5134.332536770196;5256.159014557652;5264.315638966987;5264.499872512105;1460.591034510339;1471.8969672122848;1474.2112969561233;1509.3660662521547;1511.7656763201721;902.4404868981273;903.3992395057345;912.6030176873081;919.5907821019716;922.372786505183;7409.851802964018;7455.627218639046;7460.29127232912;7497.850042999109;7545;707.2997732245041;708.5606923707231;711.9430445564342;713.5575942915322;722.6134018300185;4445.666575006888;4540.886477838015;4675.602573781199;5076.796928122908;5329.573634109262;19189.232430702894;19428.51428714265;19820.40538783839;19906.60186796285;20114.295999639944;18818;19585.1186696599;19724.90137549303;19745.703814442793;19752;10323.432211228455;10457.477126143662;10604.681859544226;10618.36289822613;10807;8035.437519373588;8076.648903555902;8132.837343252983;8211.794705132419;8249.670013199404;16731.163441827615;16857.241424136188;17159.142042897554;17401.390951316644;17464.912675436542;17616.64766704633;17795.73306400379;17925.910370448066;17953.551161220552;18023.63952720912;10412.739681508023;10577.153827693919;10637.468126593794;10641.201909856636;10643.095336896451;13060.804087938499;13063.934680326538;13200.075994680665;13216.603501894959;13225.669358266121;10915.23593348458;10919.181061420266;10991.120710342993;11042.503087360927;11169.553217871195;10692.411917344309;10821.9458902705;10824.67525974222;10829.945850270698;10972.122230221403;9254;9486.288528360263;9490.193333566724;9492.85760713576;9493.857592135986;6812.14848143982;6861.965690171517;6894.620795856276;6903.275156108536;6924.549904256207;6984.441244700311;6984.755533556301;6989.405900498311;7028.753993610199;7102.573845569283 11:40:15 INFO - PID 12374 | |4;prototype.html;494.94576551944374;504.6139703127107;527.201290045581;530.2708775433779;531.7633653024403;6248.656323902183;6249.156363890874;6267.937320626792;6303.275123360815;6309.211348581427;5944.79193228236;6086.786962456304;6116.7553297868035;6137.386261373871;6145.784897528587;4956.925646115311;4989.2017277235645;4994.026164897847;5014.32020273208;5020;4995.975020124913;4999.525045120708;5002.549770520653;5023.171176755831;5029.019341228462;4812.823536465933;4921.63087768417;4957.206846904496;4979.730168806967;4987;4950.801967921278;4978.377702787152;4980.900381992358;4992.301077849104;4997.325361076281;4445.444319460067;4455.309427038814;4464.17412778637;4464.241079016542;4464.799084041226;5937.168796368512;6040.758369665208;6049.576529642883;6059.545534084961;6060.606060606075;5663;5670.659760414347;5679.233303504016;5740.6268592541355;5782.710864456761;6481.189851268591;6492.383223593751;6514.93485065148;6537.934620653828;6569.474442044673;4857.975710121462;4872.439669438025;4880.829170978998;4884.658073934826;4886.729450342901;6865.27914568968;6879.449644028516;6909.619970901598;6940;6957.112458665935;4933.654644174873;4935.383077115361;5011.19820828673;5022.296878437021;5036;5054.545090941833;5086.949130508721;5092.541671249532;5099.209622508517;5101.464346243591;5690.658560486384;5698.686572238484;5732.936142988521;5742.109972954198;5755.769769209269;6459.289478157399;6461;6546.607203567801;6554.377334153248;6577.276499585042;1640.7538869169482;1717.1414292853574;1723.2331612432597;1733.1507561295127;1777.8399944005102;1213.2417239225483;1222.2971791220084;1237.270010693677;1241.3855141704914;1254.5671743248565;5685.005124103265;5744.310682718101;5754.539636829044;5777.62445441045;5784.8719499698;6530.869382612321;6664.600123992576;6674.399304062657;6723.731050758012;6737.9326206737305;5652.349979752381;5672.14917762339;5720.94046143388;5755.3381361143165;5758.481736643722;3548.8757893473603;3580.928381432409;3594.8741794037605;3629.9637003630155;3647.927041459156;6473.255575608771;6479.829257198891;6572.145621069326;6593.505487088488;6622.403983641495;6861.197161986629;6874.243833178346;6954.200266969262;6971.511994160462;6995.370416662525;6549.901751473732;6556.737730490727;6556.7705130321165;6655.534112612071;6663.333666633394;6751.426128778912;6781.050652908695;6794.592324460548;6840.213375461885;6842.870926297105;6680.5323627345615;6750.25747167821;6777.322267773183;6784.559003664746;6786;6411.627697751862;6437.55155090101;6438.066480360415;6524.641144737085;6539.411452969255;4944.060628480577;4952.281919121635;5046.646734728681;5056.823011194738;5061.139606267017;6702.128723265944;6786.524943253925;6801.489888258499;6802.421794147553;6811.5231933766145;6534.281229064894;6575.868482630416;6597.769078082244;6614.371634694697;6674.332566743286;6220.657863817352;6477.384648458389;6484.319146489739;6624.271330153776;6633.834154146185;6280.466160376419;6349.619022858643;6407.391297826699;6452.322506136976;6491.350864913471;6564.9671751640935;6578.210614726264;6629.977856753543;6646.136002319861;6671.633060181736;6302.684865756602;6312;6321.747130114928;6338.366163383625;6367.363263673596 11:40:15 INFO - PID 12374 | |5;yui.html;861.4314552395418;879.156010230179;920.9493477858715;921.7234829551134;946.0775743649938;18934.24263029479;19891.204351825927;19900.90049549752;19922.601547969032;22418.103275868947;19901.203951841908;21742.456438589044;22132.557348853054;22172.445688857788;22200.222992195275;1040.3289878028647;1055.0241027049985;1063.494839951025;1064.6486659402417;1065.0308219520239;1033.3180101133253;1035.3425574760006;1037.2531777120462;1038.2939601071268;1038.7455073506965;1061.601899287767;1115.2806439846336;1120.2718233148437;1123.0734643918759;1123.2418117770512;1069.844872493488;1114.3202646385698;1115.1859142825701;1118.89929906308;1120.171073405678;782.2412260107686;809.4050872608628;814.6008455856647;819.9713010044679;823.5840900345347;19402.41792746206;19829.801701983084;19968.500787480283;20062.899685501627;20364.28724994618;22114.668279975813;22171;22268.109275628954;22515.887420562955;22696.319110426713;15615;15703.528894133195;15796;15958.76061859073;15993.920030399773;3553.680168784822;3557.5553055868018;3572.6605972432835;3576.445650924111;3578.4095624221973;123486;123737;125204;128109.35945320214;128922.71077289201;16986.150692465573;17163.313467461412;17368.13159342028;17590.824091758917;17700.91149544244;32153.51769723456;32223.35553288921;32323.51514727281;32382.83808580942;32528.674713252563;7914.2085791420395;8180.345572354317;8384.706535271236;9134.132257435533;9222.354435189607;4311.374850646702;4382.452193475816;4383.16719823239;4383.211022016068;4406.581374769392;4976.353074100344;5044.167712327425;5062.696238225644;5081.28861959326;5083.415407228142;1034.9586016559404;1056.1920131099714;1067.108964015056;1068.273573969708;1069.8716154061563;700.929907009295;713.5433322673493;714.2964180282418;716.8924661300742;727.5198369076384;10810.189235807346;10850.565977360817;11507.367094809866;13524.661883452993;13557.186568805902;643.4659232836734;666.1473314157886;693.7745232799259;699.094672399234;706.5760543673755;5458.326891137754;5638.971805140948;5923.49650279731;6198.907016394758;6203;102108.48945755223;102662;104722;114012.42993785144;115985;97401.51299243601;98339;98784.50607746915;100553.49723251337;100875;83761;85717.14282857091;86561;87857.12142878617;89083;12418.937905310415;12660.923821475279;12732.490700372251;12742.808857866954;12864.935675321563;38466.615333846305;39484.40773388459;39672.2065558693;39730.205395892495;40802.59197407988;70503.64748176227;71021;71806.64096679483;72753.6362318185;75129;18169.45491635253;18417.815821842145;18522.259109635463;18943.90528047351;19050.23799048078;18604.7209291858;18655.347062852736;19404.805951940863;19452;22224.77775222227;16464.83535164681;16798.07610581381;16802.32790688408;17056.232469539147;19658.115384808003;17270.913645432196;17458.650826983136;17560.82439175592;17605;18286.542836428664;16347.427840025543;16525.504234872973;16555.66888662244;16617.584560386087;16637.168141593113;13219.735605288033;13469.12450690702;13758.105723128365;13957.511487098309;14091.929540352232;13760.243186624832;14066.156030638194;14530.927345363205;14687.41250349974;15041.473548425753 11:40:15 INFO - PID 12374 | __end_tp_report 11:40:15 INFO - PID 12374 | __start_cc_report 11:40:15 INFO - PID 12374 | _x_x_mozilla_cycle_collect,370 11:40:15 INFO - PID 12374 | __end_cc_report 11:40:15 INFO - PID 12374 | __startTimestamp1502995215806__endTimestamp 11:40:15 INFO - PID 12374 | 11:40:15 INFO - PID 12374 | ------- Summary: start ------- 11:40:15 INFO - PID 12374 | Number of tests: 6 11:40:15 INFO - PID 12374 | 11:40:15 INFO - PID 12374 | [#0] dojo.html Cycles:165 Average:6082.37 Median:6297.31 stddev:699.01 (11.1%) stddev-sans-first:661.90 11:40:15 INFO - PID 12374 | Values: 3138.2 3157.6 3161.3 3184.7 3202.9 6036.8 6167.8 6174.3 6193.0 6200.1 6004.6 6124.7 6134.2 6160.8 6192.0 5638.9 5664.0 5669.6 5681.6 5702.6 5627.9 5662.8 5688.7 5706.1 5708.8 5661.9 5668.2 5703.4 5707.4 5766.1 5659.2 5705.0 5705.4 5759.8 5771.8 5464.6 5586.5 5587.2 5615.1 5685.2 6018.9 6044.9 6073.8 6102.7 6153.2 6599.0 6622.4 6702.1 6704.6 6715.3 6478.7 6558.3 6575.8 6673.0 6689.4 6158.1 6167.0 6181.7 6191.3 6207.3 6719.1 6730.2 6804.5 6809.3 6834.4 6408.6 6444.4 6462.5 6478.4 6575.2 6480.2 6484.2 6485.0 6488.6 6505.3 6424.1 6446.8 6511.5 6531.1 6539.4 6589.8 6670.6 6696.1 6704.2 6723.8 5403.5 5435.7 5441.7 5464.3 5473.7 4575.7 4594.1 4610.5 4646.3 4665.1 5706.1 5726.4 5732.2 5750.0 5753.8 6562.8 6657.8 6668.2 6703.8 6724.8 5671.2 5697.0 5772.3 5790.8 5802.0 5727.7 5767.5 5798.5 5833.9 5940.0 6385.2 6416.1 6426.4 6426.6 6430.6 6610.1 6657.8 6690.1 6712.3 6720.1 6344.4 6347.1 6393.7 6467.7 6476.8 6297.3 6426.9 6432.4 6534.9 6542.1 6478.9 6602.7 6666.6 6670.7 6672.6 6381.9 6430.1 6450.5 6478.4 6488.0 6372.8 6457.1 6457.1 6467.0 6479.5 6295.8 6307.7 6410.3 6434.3 6434.8 6276.5 6369.9 6412.9 6427.0 6452.0 6169.9 6185.2 6268.5 6274.2 6286.8 11:40:15 INFO - PID 12374 | 11:40:15 INFO - PID 12374 | [#1] ext.html Cycles:180 Average:37204.68 Median:35922.64 stddev:50765.89 (141.3%) stddev-sans-first:50834.70 11:40:15 INFO - PID 12374 | Values: 800.2 843.6 863.1 871.7 1174.9 30843.2 31593.8 43716.8 44341.8 44398.1 44276.6 44450.3 44476.0 44503.6 44505.3 7258.4 7640.6 7788.8 7806.9 7807.1 7676.8 7770.5 7779.9 7782.2 7782.4 7764.9 7775.1 7818.9 7844.1 7844.8 7711.6 7786.8 7790.7 7790.8 7793.1 7657.0 7671.6 7710.8 7736.0 7737.1 37770.0 38334.8 38381.0 38487.4 38587.6 3526.1 3554.8 3563.3 3563.6 3573.4 30757.7 30769.0 30818.8 30862.0 30902.4 5082.2 5086.6 5090.4 5113.8 5154.8 186833.1 187661.0 187867.1 188601.0 188849.0 48227.3 48316.8 48474.8 48484.8 48527.5 49699.3 50153.0 50173.0 50295.5 50456.2 14562.6 14751.4 14753.6 14787.9 14813.6 11866.5 11962.5 12575.4 12700.3 12733.7 14181.7 14221.5 14271.4 14343.5 14558.2 5475.8 5591.2 5696.4 5710.4 5725.1 1003.9 1016.5 1018.3 1021.6 1021.7 22629.8 22814.9 22823.0 22895.0 22985.0 1096.7 1108.3 1111.6 1113.2 1129.4 12078.8 12110.0 12138.9 12140.2 12162.0 212291.0 213693.0 214386.0 215021.0 215242.0 52806.2 53360.5 53398.0 53464.7 53611.7 1437.9 1450.7 1487.3 1489.3 1503.9 22087.9 22250.4 22372.0 22574.2 22709.7 37323.4 37365.4 37568.6 37649.2 37662.2 183955.0 184691.0 185113.1 185140.1 185493.0 33648.8 35987.5 37381.8 37466.6 37552.6 47833.8 49622.5 49664.0 49738.0 50132.0 35676.1 35867.6 35977.6 35998.5 36096.6 34437.8 34597.8 34807.3 35002.5 35403.8 38068.2 38210.2 38322.4 38576.0 39036.2 34237.5 34367.5 34452.3 34455.8 34856.8 23898.4 24161.2 24925.9 25053.2 25243.4 11:40:15 INFO - PID 12374 | 11:40:15 INFO - PID 12374 | [#2] jquery.html Cycles:180 Average:37898.91 Median:23912.50 stddev:93711.02 (391.9%) stddev-sans-first:93931.98 11:40:15 INFO - PID 12374 | Values: 564.7 566.5 567.9 596.4 599.3 22303.4 22864.1 23124.3 23177.8 23207.8 25774.9 26324.2 26465.0 26551.6 26559.3 6440.7 6597.5 6603.0 6604.3 6605.8 3875.2 4020.6 4026.0 6248.5 6545.3 6460.9 6508.8 6510.4 6511.9 6538.8 6513.3 6517.9 6531.8 6532.8 6532.8 6074.3 6077.3 6080.8 6083.4 6098.1 29352.6 29728.9 29926.9 30801.0 31170.8 1832.6 1922.8 1923.5 1926.4 1931.9 19058.2 19528.1 19741.3 19757.4 19838.1 2352.2 2404.7 2449.5 2460.5 2484.1 135065.3 137243.0 137826.0 139923.0 143511.0 14537.5 15067.8 15260.5 15270.3 15590.9 23790.2 23844.5 23912.0 23913.0 23926.9 9820.5 9907.4 10032.9 10088.2 10300.8 9174.4 9222.3 9372.1 9406.8 9434.5 7917.0 9190.8 9302.4 9396.7 9495.2 2654.1 2693.6 2707.8 2711.5 2764.5 936.0 940.4 954.9 958.1 968.2 19242.9 19910.2 24812.0 25114.0 25502.5 1001.3 1003.3 1011.3 1016.8 1029.1 10421.8 11468.2 11586.8 11703.1 13683.2 550706.0 551334.0 559141.0 564973.0 567058.0 129082.4 132039.3 132363.3 134236.3 134867.0 1251.5 1262.3 1304.7 1307.7 1308.2 21595.7 21721.2 21759.8 21910.5 22333.9 62648.0 64139.7 64769.4 64986.0 65835.3 73960.0 73977.3 74232.6 74514.6 75276.6 16506.9 17936.8 20347.0 21452.8 21622.6 23379.4 23640.0 24259.6 24298.5 24562.9 16277.5 16819.2 16934.4 16992.8 18135.1 16524.7 16701.0 16780.6 17011.7 18169.8 14975.6 15937.8 16453.7 16511.4 16729.7 20839.3 20948.3 21045.8 21169.5 21238.0 15957.8 15998.2 16040.0 16502.8 16689.7 11:40:15 INFO - PID 12374 | 11:40:15 INFO - PID 12374 | [#3] mootools.html Cycles:180 Average:8750.23 Median:2515.28 stddev:6125.37 (243.5%) stddev-sans-first:6117.52 11:40:15 INFO - PID 12374 | Values: 1381.2 1434.4 1440.5 1462.9 1462.9 13122.7 13638.5 13651.5 13673.5 14767.2 14933.3 15100.5 15190.5 15208.8 15218.2 2490.8 2556.3 2556.8 2568.3 2569.3 2545.2 2633.9 2673.3 2683.1 2684.6 2606.0 2610.3 2628.4 2644.7 2652.2 2534.2 2538.5 2552.9 2557.8 2562.5 2436.0 2437.0 2481.0 2483.7 2496.3 13856.7 14234.3 14316.6 14324.2 14381.6 7365.3 7408.0 7650.2 7685.4 7693.7 5099.2 5121.0 5171.9 5245.0 5248.4 1869.6 1869.8 1901.9 1919.9 1952.7 23494.2 23965.4 23965.5 23999.6 24033.3 6244.7 6460.5 6543.9 6627.4 6664.3 16352.9 16358.0 16382.3 16398.8 16446.1 7206.8 7496.8 7510.5 7510.9 7522.2 5870.9 6039.3 6388.4 6388.6 6902.5 5080.8 5134.3 5256.2 5264.3 5264.5 1460.6 1471.9 1474.2 1509.4 1511.8 902.4 903.4 912.6 919.6 922.4 7409.9 7455.6 7460.3 7497.9 7545.0 707.3 708.6 711.9 713.6 722.6 4445.7 4540.9 4675.6 5076.8 5329.6 19189.2 19428.5 19820.4 19906.6 20114.3 18818.0 19585.1 19724.9 19745.7 19752.0 10323.4 10457.5 10604.7 10618.4 10807.0 8035.4 8076.6 8132.8 8211.8 8249.7 16731.2 16857.2 17159.1 17401.4 17464.9 17616.6 17795.7 17925.9 17953.6 18023.6 10412.7 10577.2 10637.5 10641.2 10643.1 13060.8 13063.9 13200.1 13216.6 13225.7 10915.2 10919.2 10991.1 11042.5 11169.6 10692.4 10821.9 10824.7 10829.9 10972.1 9254.0 9486.3 9490.2 9492.9 9493.9 6812.1 6862.0 6894.6 6903.3 6924.5 6984.4 6984.8 6989.4 7028.8 7102.6 11:40:15 INFO - PID 12374 | 11:40:15 INFO - PID 12374 | [#4] prototype.html Cycles:180 Average:5517.32 Median:6073.70 stddev:1551.92 (25.6%) stddev-sans-first:1509.79 11:40:15 INFO - PID 12374 | Values: 494.9 504.6 527.2 530.3 531.8 6248.7 6249.2 6267.9 6303.3 6309.2 5944.8 6086.8 6116.8 6137.4 6145.8 4956.9 4989.2 4994.0 5014.3 5020.0 4996.0 4999.5 5002.5 5023.2 5029.0 4812.8 4921.6 4957.2 4979.7 4987.0 4950.8 4978.4 4980.9 4992.3 4997.3 4445.4 4455.3 4464.2 4464.2 4464.8 5937.2 6040.8 6049.6 6059.5 6060.6 5663.0 5670.7 5679.2 5740.6 5782.7 6481.2 6492.4 6514.9 6537.9 6569.5 4858.0 4872.4 4880.8 4884.7 4886.7 6865.3 6879.4 6909.6 6940.0 6957.1 4933.7 4935.4 5011.2 5022.3 5036.0 5054.5 5086.9 5092.5 5099.2 5101.5 5690.7 5698.7 5732.9 5742.1 5755.8 6459.3 6461.0 6546.6 6554.4 6577.3 1640.8 1717.1 1723.2 1733.2 1777.8 1213.2 1222.3 1237.3 1241.4 1254.6 5685.0 5744.3 5754.5 5777.6 5784.9 6530.9 6664.6 6674.4 6723.7 6737.9 5652.3 5672.1 5720.9 5755.3 5758.5 3548.9 3580.9 3594.9 3630.0 3647.9 6473.3 6479.8 6572.1 6593.5 6622.4 6861.2 6874.2 6954.2 6971.5 6995.4 6549.9 6556.7 6556.8 6655.5 6663.3 6751.4 6781.1 6794.6 6840.2 6842.9 6680.5 6750.3 6777.3 6784.6 6786.0 6411.6 6437.6 6438.1 6524.6 6539.4 4944.1 4952.3 5046.6 5056.8 5061.1 6702.1 6786.5 6801.5 6802.4 6811.5 6534.3 6575.9 6597.8 6614.4 6674.3 6220.7 6477.4 6484.3 6624.3 6633.8 6280.5 6349.6 6407.4 6452.3 6491.4 6565.0 6578.2 6630.0 6646.1 6671.6 6302.7 6312.0 6321.7 6338.4 6367.4 11:40:15 INFO - PID 12374 | 11:40:15 INFO - PID 12374 | [#5] yui.html Cycles:180 Average:23879.53 Median:19428.40 stddev:32152.56 (165.5%) stddev-sans-first:32196.30 11:40:15 INFO - PID 12374 | Values: 861.4 879.2 920.9 921.7 946.1 18934.2 19891.2 19900.9 19922.6 22418.1 19901.2 21742.5 22132.6 22172.4 22200.2 1040.3 1055.0 1063.5 1064.6 1065.0 1033.3 1035.3 1037.3 1038.3 1038.7 1061.6 1115.3 1120.3 1123.1 1123.2 1069.8 1114.3 1115.2 1118.9 1120.2 782.2 809.4 814.6 820.0 823.6 19402.4 19829.8 19968.5 20062.9 20364.3 22114.7 22171.0 22268.1 22515.9 22696.3 15615.0 15703.5 15796.0 15958.8 15993.9 3553.7 3557.6 3572.7 3576.4 3578.4 123486.0 123737.0 125204.0 128109.4 128922.7 16986.2 17163.3 17368.1 17590.8 17700.9 32153.5 32223.4 32323.5 32382.8 32528.7 7914.2 8180.3 8384.7 9134.1 9222.4 4311.4 4382.5 4383.2 4383.2 4406.6 4976.4 5044.2 5062.7 5081.3 5083.4 1035.0 1056.2 1067.1 1068.3 1069.9 700.9 713.5 714.3 716.9 727.5 10810.2 10850.6 11507.4 13524.7 13557.2 643.5 666.1 693.8 699.1 706.6 5458.3 5639.0 5923.5 6198.9 6203.0 102108.5 102662.0 104722.0 114012.4 115985.0 97401.5 98339.0 98784.5 100553.5 100875.0 83761.0 85717.1 86561.0 87857.1 89083.0 12418.9 12660.9 12732.5 12742.8 12864.9 38466.6 39484.4 39672.2 39730.2 40802.6 70503.6 71021.0 71806.6 72753.6 75129.0 18169.5 18417.8 18522.3 18943.9 19050.2 18604.7 18655.3 19404.8 19452.0 22224.8 16464.8 16798.1 16802.3 17056.2 19658.1 17270.9 17458.7 17560.8 17605.0 18286.5 16347.4 16525.5 16555.7 16617.6 16637.2 13219.7 13469.1 13758.1 13957.5 14091.9 13760.2 14066.2 14530.9 14687.4 15041.5 11:40:15 INFO - PID 12374 | -------- Summary: end -------- 11:40:15 INFO - PID 12374 | 11:40:16 INFO - TEST-INFO | 12374: exit 0 11:40:16 INFO - TEST-OK | dromaeo_css | took 1112206ms 11:40:16 INFO - TEST-START | kraken 11:40:16 INFO - Initialising browser for kraken test... 11:40:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53511/getInfo.html -profile /tmp/tmpzfOp81/profile 11:40:16 INFO - TEST-INFO | started process 12746 (/builds/slave/test/build/application/firefox/firefox http://localhost:53511/getInfo.html) 11:40:22 INFO - TEST-INFO | 12746: exit 0 11:40:22 INFO - Browser initialized. 11:40:22 INFO - Running cycle 1/1 for kraken test... 11:40:22 INFO - TEST-INFO | started process 12937 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzfOp81/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:23 INFO - PID 12937 | 11:40:23 INFO - PID 12937 | (/builds/slave/test/build/application/firefox/firefox:12991): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:40:23 INFO - PID 12937 | 11:40:33 INFO - PID 12937 | RSS: Main: 166289408 11:40:33 INFO - PID 12937 | 11:40:36 INFO - PID 12937 | Cycle 1(1): loaded http://localhost:53511/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53511/tests/kraken/driver.html?testName=audio-beat-detection) 11:40:37 INFO - PID 12937 | RSS: Main: 172687360 11:40:37 INFO - PID 12937 | 11:40:40 INFO - PID 12937 | Cycle 1(1): loaded http://localhost:53511/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53511/tests/kraken/driver.html?testName=audio-dft) 11:40:40 INFO - PID 12937 | RSS: Main: 176041984 11:40:40 INFO - PID 12937 | 11:40:43 INFO - PID 12937 | Cycle 1(1): loaded http://localhost:53511/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53511/tests/kraken/driver.html?testName=audio-fft) 11:40:44 INFO - PID 12937 | RSS: Main: 170639360 11:40:44 INFO - PID 12937 | 11:40:46 INFO - PID 12937 | Cycle 1(1): loaded http://localhost:53511/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53511/tests/kraken/driver.html?testName=audio-oscillator) 11:40:47 INFO - PID 12937 | RSS: Main: 171360256 11:40:47 INFO - PID 12937 | 11:40:49 INFO - PID 12937 | Cycle 1(1): loaded http://localhost:53511/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53511/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:40:50 INFO - PID 12937 | RSS: Main: 171520000 11:40:50 INFO - PID 12937 | 11:40:53 INFO - PID 12937 | Cycle 1(1): loaded http://localhost:53511/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53511/tests/kraken/driver.html?testName=imaging-darkroom) 11:40:54 INFO - PID 12937 | RSS: Main: 172384256 11:40:54 INFO - PID 12937 | 11:40:57 INFO - PID 12937 | Cycle 1(1): loaded http://localhost:53511/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53511/tests/kraken/driver.html?testName=imaging-desaturate) 11:40:58 INFO - PID 12937 | RSS: Main: 172298240 11:40:58 INFO - PID 12937 | 11:41:01 INFO - PID 12937 | Cycle 1(1): loaded http://localhost:53511/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53511/tests/kraken/driver.html?testName=json-parse-financial) 11:41:01 INFO - PID 12937 | RSS: Main: 173273088 11:41:01 INFO - PID 12937 | 11:41:03 INFO - PID 12937 | Cycle 1(1): loaded http://localhost:53511/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53511/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:41:04 INFO - PID 12937 | RSS: Main: 173228032 11:41:04 INFO - PID 12937 | 11:41:05 INFO - PID 12937 | Cycle 1(1): loaded http://localhost:53511/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53511/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:41:06 INFO - PID 12937 | RSS: Main: 173268992 11:41:06 INFO - PID 12937 | 11:41:08 INFO - PID 12937 | Cycle 1(1): loaded http://localhost:53511/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53511/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:41:09 INFO - PID 12937 | RSS: Main: 172978176 11:41:09 INFO - PID 12937 | 11:41:11 INFO - PID 12937 | Cycle 1(1): loaded http://localhost:53511/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:41:12 INFO - PID 12937 | RSS: Main: 173617152 11:41:12 INFO - PID 12937 | 11:41:15 INFO - PID 12937 | Cycle 1(1): loaded http://localhost:53511/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:41:16 INFO - PID 12937 | RSS: Main: 173703168 11:41:16 INFO - PID 12937 | 11:41:18 INFO - PID 12937 | Cycle 1(1): loaded http://localhost:53511/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53511/tests/kraken/driver.html?testName=ai-astar) 11:41:18 INFO - PID 12937 | RSS: Main: 175042560 11:41:18 INFO - PID 12937 | 11:41:18 INFO - PID 12937 | __start_tp_report 11:41:18 INFO - PID 12937 | _x_x_mozilla_page_load 11:41:18 INFO - PID 12937 | _x_x_mozilla_page_load_details 11:41:18 INFO - PID 12937 | |i|pagename|runs| 11:41:18 INFO - PID 12937 | |0;ai-astar;106;115;106;108;116;111;111;99;110;113 11:41:18 INFO - PID 12937 | |1;audio-beat-detection;145;118;148;185;120;151;154;118;182;118 11:41:18 INFO - PID 12937 | |2;audio-dft;163;162;171;162;163;166;162;167;165;162 11:41:18 INFO - PID 12937 | |3;audio-fft;75;75;76;167;74;75;74;82;101;75 11:41:18 INFO - PID 12937 | |4;audio-oscillator;79;87;131;78;80;89;140;79;80;131 11:41:18 INFO - PID 12937 | |5;imaging-gaussian-blur;114;113;113;113;113;113;114;120;118;118 11:41:18 INFO - PID 12937 | |6;imaging-darkroom;149;150;149;149;149;151;153;149;149;149 11:41:18 INFO - PID 12937 | |7;imaging-desaturate;93;94;94;94;98;99;94;93;95;94 11:41:18 INFO - PID 12937 | |8;json-parse-financial;58;57;53;56;54;61;54;55;60;54 11:41:18 INFO - PID 12937 | |9;json-stringify-tinderbox;54;55;54;54;54;62;54;54;60;60 11:41:18 INFO - PID 12937 | |10;stanford-crypto-aes;76;75;77;80;76;75;74;74;79;78 11:41:18 INFO - PID 12937 | |11;stanford-crypto-ccm;128;119;126;121;122;119;124;135;121;170 11:41:18 INFO - PID 12937 | |12;stanford-crypto-pbkdf2;174;175;179;186;177;178;171;175;183;179 11:41:18 INFO - PID 12937 | |13;stanford-crypto-sha256-iterative;67;67;69;69;73;67;68;70;68;66 11:41:18 INFO - PID 12937 | __end_tp_report 11:41:18 INFO - PID 12937 | __start_cc_report 11:41:18 INFO - PID 12937 | _x_x_mozilla_cycle_collect,963 11:41:18 INFO - PID 12937 | __end_cc_report 11:41:18 INFO - PID 12937 | __startTimestamp1502995278503__endTimestamp 11:41:18 INFO - PID 12937 | 11:41:18 INFO - PID 12937 | ------- Summary: start ------- 11:41:18 INFO - PID 12937 | Number of tests: 14 11:41:18 INFO - PID 12937 | 11:41:18 INFO - PID 12937 | [#0] ai-astar Cycles:10 Average:109.50 Median:112.00 stddev:5.02 (4.5%) stddev-sans-first:5.16 11:41:18 INFO - PID 12937 | Values: 106.0 115.0 106.0 108.0 116.0 111.0 111.0 99.0 110.0 113.0 11:41:18 INFO - PID 12937 | 11:41:18 INFO - PID 12937 | [#1] audio-beat-detection Cycles:10 Average:143.90 Median:149.50 stddev:25.59 (17.1%) stddev-sans-first:27.14 11:41:18 INFO - PID 12937 | Values: 145.0 118.0 148.0 185.0 120.0 151.0 154.0 118.0 182.0 118.0 11:41:18 INFO - PID 12937 | 11:41:18 INFO - PID 12937 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:2.98 (1.8%) stddev-sans-first:3.13 11:41:18 INFO - PID 12937 | Values: 163.0 162.0 171.0 162.0 163.0 166.0 162.0 167.0 165.0 162.0 11:41:18 INFO - PID 12937 | 11:41:18 INFO - PID 12937 | [#3] audio-fft Cycles:10 Average:87.40 Median:75.00 stddev:29.16 (38.9%) stddev-sans-first:30.59 11:41:18 INFO - PID 12937 | Values: 75.0 75.0 76.0 167.0 74.0 75.0 74.0 82.0 101.0 75.0 11:41:18 INFO - PID 12937 | 11:41:18 INFO - PID 12937 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:79.50 stddev:25.63 (32.2%) stddev-sans-first:26.30 11:41:18 INFO - PID 12937 | Values: 79.0 87.0 131.0 78.0 80.0 89.0 140.0 79.0 80.0 131.0 11:41:18 INFO - PID 12937 | 11:41:18 INFO - PID 12937 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:114.00 stddev:2.69 (2.4%) stddev-sans-first:2.83 11:41:18 INFO - PID 12937 | Values: 114.0 113.0 113.0 113.0 113.0 113.0 114.0 120.0 118.0 118.0 11:41:18 INFO - PID 12937 | 11:41:18 INFO - PID 12937 | [#6] imaging-darkroom Cycles:10 Average:149.70 Median:149.00 stddev:1.34 (0.9%) stddev-sans-first:1.39 11:41:18 INFO - PID 12937 | Values: 149.0 150.0 149.0 149.0 149.0 151.0 153.0 149.0 149.0 149.0 11:41:18 INFO - PID 12937 | 11:41:18 INFO - PID 12937 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.00 stddev:2.04 (2.2%) stddev-sans-first:2.06 11:41:18 INFO - PID 12937 | Values: 93.0 94.0 94.0 94.0 98.0 99.0 94.0 93.0 95.0 94.0 11:41:18 INFO - PID 12937 | 11:41:18 INFO - PID 12937 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.50 stddev:2.74 (4.9%) stddev-sans-first:2.83 11:41:18 INFO - PID 12937 | Values: 58.0 57.0 53.0 56.0 54.0 61.0 54.0 55.0 60.0 54.0 11:41:18 INFO - PID 12937 | 11:41:18 INFO - PID 12937 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:54.50 stddev:3.21 (5.9%) stddev-sans-first:3.32 11:41:18 INFO - PID 12937 | Values: 54.0 55.0 54.0 54.0 54.0 62.0 54.0 54.0 60.0 60.0 11:41:18 INFO - PID 12937 | 11:41:18 INFO - PID 12937 | [#10] stanford-crypto-aes Cycles:10 Average:76.40 Median:76.50 stddev:2.07 (2.7%) stddev-sans-first:2.19 11:41:18 INFO - PID 12937 | Values: 76.0 75.0 77.0 80.0 76.0 75.0 74.0 74.0 79.0 78.0 11:41:18 INFO - PID 12937 | 11:41:18 INFO - PID 12937 | [#11] stanford-crypto-ccm Cycles:10 Average:128.50 Median:125.00 stddev:15.37 (12.3%) stddev-sans-first:16.30 11:41:18 INFO - PID 12937 | Values: 128.0 119.0 126.0 121.0 122.0 119.0 124.0 135.0 121.0 170.0 11:41:18 INFO - PID 12937 | 11:41:18 INFO - PID 12937 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.70 Median:178.50 stddev:4.40 (2.5%) stddev-sans-first:4.46 11:41:18 INFO - PID 12937 | Values: 174.0 175.0 179.0 186.0 177.0 178.0 171.0 175.0 183.0 179.0 11:41:18 INFO - PID 12937 | 11:41:18 INFO - PID 12937 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:2.01 (2.9%) stddev-sans-first:2.07 11:41:18 INFO - PID 12937 | Values: 67.0 67.0 69.0 69.0 73.0 67.0 68.0 70.0 68.0 66.0 11:41:18 INFO - PID 12937 | -------- Summary: end -------- 11:41:18 INFO - PID 12937 | 11:41:18 INFO - PID 12937 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:41:19 INFO - TEST-INFO | 12937: exit 0 11:41:19 INFO - TEST-OK | kraken | took 62739ms 11:41:19 INFO - SUITE-END | took 1174s 11:41:19 INFO - Completed test suite (00:19:35) 11:41:19 INFO - javascript benchmark 11:41:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8511.086758129133, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3138.1683853778754, 3157.5737275467814, 3161.320316132032, 3184.6656101109397, 3202.919927001825, 6036.758529658814, 6167.7841275555365, 6174.259088909326, 6192.969035154818, 6200.131981522591, 6004.639721616706, 6124.724387402566, 6134.171886795281, 6160.815175544741, 6191.969040154793, 5638.859028524279, 5664.0, 5669.574781891354, 5681.630694004876, 5702.6293290935955, 5627.887442251153, 5662.773489060432, 5688.715564221793, 5706.115552089412, 5708.800191993281, 5661.886762264752, 5668.206451096849, 5703.372629010805, 5707.400722924095, 5766.135079738052, 5659.179418984266, 5705.0, 5705.400932902048, 5759.798407055733, 5771.797987070432, 5464.590155738296, 5586.469285417878, 5587.217789509472, 5615.129654903497, 5685.175649530836, 6018.879622407571, 6044.909326360108, 6073.787417440369, 6102.72537735803, 6153.169322141498, 6599.0, 6622.4370928471135, 6702.095217145672, 6704.631245281507, 6715.294894036154, 6478.74085036598, 6558.344165583403, 6575.835604109936, 6673.03241030048, 6689.431398331148, 6158.137860699506, 6166.969165154145, 6181.721822517998, 6191.288001879841, 6207.317195108534, 6719.0593316935665, 6730.158730158731, 6804.489663275274, 6809.319068093151, 6834.419074378733, 6408.647524386203, 6444.42000219973, 6462.5153113515735, 6478.384553467507, 6575.243846957661, 6480.157579514727, 6484.1894763154605, 6484.967575162094, 6488.610683359014, 6505.284418713938, 6424.068510066014, 6446.806595802133, 6511.479081673455, 6531.11829902957, 6539.378759017981, 6589.80230593083, 6670.566413183127, 6696.096027036385, 6704.195496540447, 6723.831904202336, 5403.540699040547, 5435.728213589305, 5441.673499589958, 5464.3442786865835, 5473.67157970523, 4575.725456472623, 4594.081183763261, 4610.492845786961, 4646.326282688991, 4665.066986602693, 5706.087026075808, 5726.398728133569, 5732.226149469851, 5750.02249617566, 5753.827385178368, 6562.803115906435, 6657.833554161185, 6668.166479190101, 6703.798886033427, 6724.831879202961, 5671.234383358276, 5697.0, 5772.307323121168, 5790.797322093791, 5802.0, 5727.684977326204, 5767.538596912237, 5798.5071268941765, 5833.88332233353, 5939.970300148471, 6385.169927909342, 6416.069669897839, 6426.389492998158, 6426.646534440557, 6430.64631445275, 6610.10763546915, 6657.7669781557415, 6690.063391125149, 6712.328767123248, 6720.0591917132615, 6344.365563443619, 6347.143135676809, 6393.7122829471855, 6467.741290348334, 6476.805695829133, 6297.307296197506, 6426.871462570816, 6432.388923052303, 6534.934650653623, 6542.051402546699, 6478.935210648022, 6602.702878370581, 6666.600003999775, 6670.733170673118, 6672.599644021374, 6381.904271435839, 6430.131932189094, 6450.451711604378, 6478.384553467413, 6487.9619260918025, 6372.776952806629, 6457.09600655918, 6457.128287681103, 6467.029945508211, 6479.546431749733, 6295.779647712308, 6307.653079080695, 6410.326915673973, 6434.2922278548385, 6434.774782882577, 6276.497880169484, 6369.9363006371195, 6412.935870641234, 6427.035944608346, 6452.032195170762, 6169.938300616936, 6185.195924529782, 6268.4671802897265, 6274.247090349188, 6286.811395658137], "value": 6031.3732292552, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.16782546152, 843.5866425451528, 863.1109956744551, 871.6513394642143, 1174.9295042297458, 30843.22891927703, 31593.84203078984, 43716.78141609291, 44341.77829110858, 44398.11203775922, 44276.557234427644, 44450.33324500127, 44476.0, 44503.55496445035, 44505.33242001373, 7258.383037441824, 7640.61796910155, 7788.805279867992, 7806.921930780704, 7807.063152421689, 7676.846463070735, 7770.4560680752365, 7779.922200777976, 7782.182870798541, 7782.37740980723, 7764.883526747103, 7775.1447340792465, 7818.921810781905, 7844.0979287382115, 7844.803879902991, 7711.5758633275145, 7786.76639700807, 7790.688372465152, 7790.766277011699, 7793.064832220113, 7657.0, 7671.578063206522, 7710.807229819299, 7736.0, 7737.110232323299, 37770.0, 38334.80832595819, 38381.0, 38487.422688659695, 38587.614123858686, 3526.0655926179584, 3554.7689400189165, 3563.322968635951, 3563.6080031196548, 3573.356795776759, 30757.69242307593, 30769.0, 30818.84590577055, 30862.0, 30902.381952360825, 5082.186850104003, 5086.643934924557, 5090.440051594322, 5113.769880355356, 5154.845354639367, 186833.06583466995, 187661.0, 187867.0606646958, 188601.0, 188849.0, 48227.276590851165, 48316.758416208395, 48474.75762621235, 48484.757576211894, 48527.514724853005, 49699.254511182364, 50153.0, 50173.0, 50295.49704502908, 50456.243156352684, 14562.563123106323, 14751.40994360235, 14753.631159221106, 14787.852121478647, 14813.555593332218, 11866.525338986516, 11962.521499139937, 12575.371231438392, 12700.301483418316, 12733.745325093632, 14181.716365672628, 14221.502247421498, 14271.429142834379, 14343.497977570734, 14558.199299038442, 5475.808346707846, 5591.189277554813, 5696.430356964353, 5710.371859095496, 5725.08398656213, 1003.914667253277, 1016.4612755239586, 1018.332991890313, 1021.560728886571, 1021.7343490692474, 22629.773702262766, 22814.885925570266, 22823.0, 22895.0, 22985.0, 1096.742265567591, 1108.2685427617735, 1111.6220485035126, 1113.2207454781524, 1129.3506233915532, 12078.818817717742, 12110.0, 12138.878611213951, 12140.15018948665, 12162.0, 212291.0, 213693.0, 214386.0, 215021.0, 215242.0, 52806.20790688143, 53360.46639533633, 53398.0, 53464.732676337146, 53611.73194134004, 1437.9137251764719, 1450.7026059657744, 1487.3381345301236, 1489.3149151390264, 1503.8947273690956, 22087.889560552736, 22250.443738906655, 22372.0, 22574.20990265333, 22709.659355109357, 37323.440148397254, 37365.4395184067, 37568.62431375651, 37649.24701506009, 37662.246755065295, 183955.0, 184691.0, 185113.07443462696, 185140.07429962765, 185493.0, 33648.83175584106, 35987.46018809772, 37381.813090934374, 37466.62533374631, 37552.62447375491, 47833.76083119562, 49622.50377496323, 49664.0, 49738.0, 50131.99736005333, 35676.10809729777, 35867.64132358643, 35977.64022359848, 35998.4600231002, 36096.639033609325, 34437.827810860785, 34597.82701086579, 34807.30385392329, 35002.474962876084, 35403.82298088493, 38068.23863522659, 38210.2357952845, 38322.42516362313, 38576.0, 39036.219275614894, 34237.48643770296, 34367.4844877322, 34452.310953781285, 34455.827720861234, 34856.82571587126, 23898.385446560445, 24161.15435959733, 24925.87537062303, 25053.248402547953, 25243.368915777253], "value": 17312.71155666141, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.7345747498674, 566.4618612318294, 567.8779062501563, 596.4274296675192, 599.2868486501064, 22303.442413939658, 22864.085436582558, 23124.30627081188, 23177.768222317773, 23207.76792232077, 25774.871125644393, 26324.210273691773, 26465.0, 26551.601725974127, 26559.336016599595, 6440.7101680424375, 6597.47220222381, 6602.9669851650915, 6604.306547812483, 6605.801825945229, 3875.1668391295866, 4020.5778393268724, 4025.9597404026026, 6248.46888014517, 6545.312742162076, 6460.870782584346, 6508.8047358579315, 6510.38151375621, 6511.869762604745, 6538.771143009995, 6513.283538810727, 6517.902231466532, 6531.804045878631, 6532.8040158795075, 6532.804015879531, 6074.331823499411, 6077.301110372319, 6080.787172448987, 6083.422074902877, 6098.14625952367, 29352.559711604343, 29728.8513557433, 29926.85036574825, 30801.0, 31170.844145779352, 1832.578506943397, 1922.8365588924958, 1923.5479662279354, 1926.373928473252, 1931.8551108666766, 19058.237670493163, 19528.12123454434, 19741.309054183035, 19757.40727778169, 19838.107285172202, 2352.151191646312, 2404.663347131403, 2449.461118553915, 2460.507898420305, 2484.068474322129, 135065.32467337602, 137243.0, 137825.999999999, 139923.0, 143511.0, 14537.491187808588, 15067.849321506865, 15260.542183734506, 15270.31283592241, 15590.93294679211, 23790.167344142872, 23844.523109537713, 23912.0, 23913.0, 23926.88036559806, 9820.508974551387, 9907.3560218587, 10032.899671003343, 10088.243381746399, 10300.793984120275, 9174.403663761834, 9222.262219022596, 9372.109649583279, 9406.811863762687, 9434.48110353937, 7916.960415198002, 9190.816183676288, 9302.441853488812, 9396.67111651089, 9495.24038076966, 2654.0843409023855, 2693.62289279501, 2707.783377329809, 2711.4848178845955, 2764.5162096633007, 935.9532023398802, 940.3558562384789, 954.9045095490395, 958.0898146760605, 968.1577027985697, 19242.903785481263, 19910.203591856454, 24812.0, 25114.0, 25502.489950200892, 1001.3391161833155, 1003.3344647884477, 1011.2718842433436, 1016.8373060310315, 1029.1046789293362, 10421.791564168674, 11468.197226194086, 11586.76826463466, 11703.063754899587, 13683.179009259477, 550706.0, 551334.0, 559141.0, 564973.0, 567058.0, 129082.35458822834, 132039.33980330228, 132363.33818330846, 134236.31527369397, 134867.0, 1251.4931452761646, 1262.2931158551241, 1304.6803533134444, 1307.7253776706998, 1308.241220092344, 21595.676064858726, 21721.239756608444, 21759.782402175777, 21910.45223869416, 22333.888330558242, 62648.0, 64139.679301603195, 64769.35230647633, 64986.0, 65835.34164658292, 73960.0, 73977.26022739704, 74232.62883685547, 74514.62742686251, 75276.62361688157, 16506.917465412596, 17936.820631793515, 20347.0, 21452.78547214508, 21622.567548649255, 23379.415514612272, 23640.0, 24259.636105458078, 24298.514029718954, 24562.877185613957, 16277.511674649779, 16819.159042048093, 16934.40729574459, 16992.83007169962, 18135.093245337943, 16524.66950660956, 16701.0, 16780.58048548796, 17011.7448238279, 18169.818301816813, 14975.550733478012, 15937.760933586238, 16453.670926581643, 16511.422100226435, 16729.74905376396, 20839.270625528035, 20948.266810661553, 21045.789542104383, 21169.470763231042, 21238.0, 15957.760633590739, 15998.200089995686, 16040.0, 16502.75245871337, 16689.74965375496], "value": 12317.418299820338, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1381.171297221667, 1434.447737621016, 1440.510226522982, 1462.8683418492333, 1462.919539425331, 13122.671933201675, 13638.522651707191, 13651.522196723117, 13673.521426750065, 14767.187804670739, 14933.328000239988, 15100.47148349808, 15190.54428367148, 15208.771868421982, 15218.163001034938, 2490.8131890108225, 2556.3481312265344, 2556.782673472757, 2568.319395360231, 2569.267758688774, 2545.2491515003026, 2633.934151646205, 2673.304940715418, 2683.1413947536794, 2684.5704687250045, 2606.0357667662993, 2610.3474131467133, 2628.3954690421215, 2644.7223041580646, 2652.230853052622, 2534.2270607464716, 2538.4796116796106, 2552.9489410211786, 2557.757013083754, 2562.525932702456, 2435.9512809743705, 2437.0373702387456, 2481.019997101153, 2483.726790053093, 2496.3384703053707, 13856.722865542733, 14234.288285585782, 14316.642083947985, 14324.212168330738, 14381.568552943429, 7365.30029647188, 7408.0, 7650.158482566913, 7685.423593230475, 7693.73071942485, 5099.209622508517, 5120.974395128038, 5171.922421163686, 5244.973775131138, 5248.370195576517, 1869.5886904880904, 1869.7943226245102, 1901.8668693191482, 1919.8560107991957, 1952.7363805886166, 23494.177703780286, 23965.400864978514, 23965.520689586112, 23999.64000539993, 24033.27900162998, 6244.718987645476, 6460.547761656639, 6543.9345606544275, 6627.4366678831875, 6664.266930637626, 16352.918235408746, 16358.0, 16382.262798174112, 16398.83601163997, 16446.095464749313, 7206.819829504199, 7496.7750967471065, 7510.511816731895, 7510.887336689954, 7522.172561018284, 5870.882582348415, 6039.275286965504, 6388.361163883575, 6388.648624325707, 6902.516823822284, 5080.796768129233, 5134.332536770196, 5256.159014557652, 5264.315638966987, 5264.499872512105, 1460.591034510339, 1471.8969672122848, 1474.2112969561233, 1509.3660662521547, 1511.7656763201721, 902.4404868981273, 903.3992395057345, 912.6030176873081, 919.5907821019716, 922.372786505183, 7409.851802964018, 7455.627218639046, 7460.29127232912, 7497.850042999109, 7545.0, 707.2997732245041, 708.5606923707231, 711.9430445564342, 713.5575942915322, 722.6134018300185, 4445.666575006888, 4540.886477838015, 4675.602573781199, 5076.796928122908, 5329.573634109262, 19189.232430702894, 19428.51428714265, 19820.40538783839, 19906.60186796285, 20114.295999639944, 18818.0, 19585.1186696599, 19724.90137549303, 19745.703814442793, 19752.0, 10323.432211228455, 10457.477126143662, 10604.681859544226, 10618.36289822613, 10807.0, 8035.437519373588, 8076.648903555902, 8132.837343252983, 8211.794705132419, 8249.670013199404, 16731.163441827615, 16857.241424136188, 17159.142042897554, 17401.390951316644, 17464.912675436542, 17616.64766704633, 17795.73306400379, 17925.910370448066, 17953.551161220552, 18023.63952720912, 10412.739681508023, 10577.153827693919, 10637.468126593794, 10641.201909856636, 10643.095336896451, 13060.804087938499, 13063.934680326538, 13200.075994680665, 13216.603501894959, 13225.669358266121, 10915.23593348458, 10919.181061420266, 10991.120710342993, 11042.503087360927, 11169.553217871195, 10692.411917344309, 10821.9458902705, 10824.67525974222, 10829.945850270698, 10972.122230221403, 9254.0, 9486.288528360263, 9490.193333566724, 9492.85760713576, 9493.857592135986, 6812.14848143982, 6861.965690171517, 6894.620795856276, 6903.275156108536, 6924.549904256207, 6984.441244700311, 6984.755533556301, 6989.405900498311, 7028.753993610199, 7102.573845569283], "value": 6296.973368133373, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.94576551944374, 504.6139703127107, 527.201290045581, 530.2708775433779, 531.7633653024403, 6248.656323902183, 6249.156363890874, 6267.937320626792, 6303.275123360815, 6309.211348581427, 5944.79193228236, 6086.786962456304, 6116.7553297868035, 6137.386261373871, 6145.784897528587, 4956.925646115311, 4989.2017277235645, 4994.026164897847, 5014.32020273208, 5020.0, 4995.975020124913, 4999.525045120708, 5002.549770520653, 5023.171176755831, 5029.019341228462, 4812.823536465933, 4921.63087768417, 4957.206846904496, 4979.730168806967, 4987.0, 4950.801967921278, 4978.377702787152, 4980.900381992358, 4992.301077849104, 4997.325361076281, 4445.444319460067, 4455.309427038814, 4464.17412778637, 4464.241079016542, 4464.799084041226, 5937.168796368512, 6040.758369665208, 6049.576529642883, 6059.545534084961, 6060.606060606075, 5663.0, 5670.659760414347, 5679.233303504016, 5740.6268592541355, 5782.710864456761, 6481.189851268591, 6492.383223593751, 6514.93485065148, 6537.934620653828, 6569.474442044673, 4857.975710121462, 4872.439669438025, 4880.829170978998, 4884.658073934826, 4886.729450342901, 6865.27914568968, 6879.449644028516, 6909.619970901598, 6940.0, 6957.112458665935, 4933.654644174873, 4935.383077115361, 5011.19820828673, 5022.296878437021, 5036.0, 5054.545090941833, 5086.949130508721, 5092.541671249532, 5099.209622508517, 5101.464346243591, 5690.658560486384, 5698.686572238484, 5732.936142988521, 5742.109972954198, 5755.769769209269, 6459.289478157399, 6461.0, 6546.607203567801, 6554.377334153248, 6577.276499585042, 1640.7538869169482, 1717.1414292853574, 1723.2331612432597, 1733.1507561295127, 1777.8399944005102, 1213.2417239225483, 1222.2971791220084, 1237.270010693677, 1241.3855141704914, 1254.5671743248565, 5685.005124103265, 5744.310682718101, 5754.539636829044, 5777.62445441045, 5784.8719499698, 6530.869382612321, 6664.600123992576, 6674.399304062657, 6723.731050758012, 6737.9326206737305, 5652.349979752381, 5672.14917762339, 5720.94046143388, 5755.3381361143165, 5758.481736643722, 3548.8757893473603, 3580.928381432409, 3594.8741794037605, 3629.9637003630155, 3647.927041459156, 6473.255575608771, 6479.829257198891, 6572.145621069326, 6593.505487088488, 6622.403983641495, 6861.197161986629, 6874.243833178346, 6954.200266969262, 6971.511994160462, 6995.370416662525, 6549.901751473732, 6556.737730490727, 6556.7705130321165, 6655.534112612071, 6663.333666633394, 6751.426128778912, 6781.050652908695, 6794.592324460548, 6840.213375461885, 6842.870926297105, 6680.5323627345615, 6750.25747167821, 6777.322267773183, 6784.559003664746, 6786.0, 6411.627697751862, 6437.55155090101, 6438.066480360415, 6524.641144737085, 6539.411452969255, 4944.060628480577, 4952.281919121635, 5046.646734728681, 5056.823011194738, 5061.139606267017, 6702.128723265944, 6786.524943253925, 6801.489888258499, 6802.421794147553, 6811.5231933766145, 6534.281229064894, 6575.868482630416, 6597.769078082244, 6614.371634694697, 6674.332566743286, 6220.657863817352, 6477.384648458389, 6484.319146489739, 6624.271330153776, 6633.834154146185, 6280.466160376419, 6349.619022858643, 6407.391297826699, 6452.322506136976, 6491.350864913471, 6564.9671751640935, 6578.210614726264, 6629.977856753543, 6646.136002319861, 6671.633060181736, 6302.684865756602, 6312.0, 6321.747130114928, 6338.366163383625, 6367.363263673596], "value": 5061.14069842072, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [861.4314552395418, 879.156010230179, 920.9493477858715, 921.7234829551134, 946.0775743649938, 18934.24263029479, 19891.204351825927, 19900.90049549752, 19922.601547969032, 22418.103275868947, 19901.203951841908, 21742.456438589044, 22132.557348853054, 22172.445688857788, 22200.222992195275, 1040.3289878028647, 1055.0241027049985, 1063.494839951025, 1064.6486659402417, 1065.0308219520239, 1033.3180101133253, 1035.3425574760006, 1037.2531777120462, 1038.2939601071268, 1038.7455073506965, 1061.601899287767, 1115.2806439846336, 1120.2718233148437, 1123.0734643918759, 1123.2418117770512, 1069.844872493488, 1114.3202646385698, 1115.1859142825701, 1118.89929906308, 1120.171073405678, 782.2412260107686, 809.4050872608628, 814.6008455856647, 819.9713010044679, 823.5840900345347, 19402.41792746206, 19829.801701983084, 19968.500787480283, 20062.899685501627, 20364.28724994618, 22114.668279975813, 22171.0, 22268.109275628954, 22515.887420562955, 22696.319110426713, 15615.0, 15703.528894133195, 15796.0, 15958.76061859073, 15993.920030399773, 3553.680168784822, 3557.5553055868018, 3572.6605972432835, 3576.445650924111, 3578.4095624221973, 123486.0, 123737.0, 125204.0, 128109.35945320214, 128922.71077289201, 16986.150692465573, 17163.313467461412, 17368.13159342028, 17590.824091758917, 17700.91149544244, 32153.51769723456, 32223.35553288921, 32323.51514727281, 32382.83808580942, 32528.674713252563, 7914.2085791420395, 8180.345572354317, 8384.706535271236, 9134.132257435533, 9222.354435189607, 4311.374850646702, 4382.452193475816, 4383.16719823239, 4383.211022016068, 4406.581374769392, 4976.353074100344, 5044.167712327425, 5062.696238225644, 5081.28861959326, 5083.415407228142, 1034.9586016559404, 1056.1920131099714, 1067.108964015056, 1068.273573969708, 1069.8716154061563, 700.929907009295, 713.5433322673493, 714.2964180282418, 716.8924661300742, 727.5198369076384, 10810.189235807346, 10850.565977360817, 11507.367094809866, 13524.661883452993, 13557.186568805902, 643.4659232836734, 666.1473314157886, 693.7745232799259, 699.094672399234, 706.5760543673755, 5458.326891137754, 5638.971805140948, 5923.49650279731, 6198.907016394758, 6203.0, 102108.48945755223, 102662.0, 104722.0, 114012.42993785144, 115985.0, 97401.51299243601, 98339.0, 98784.50607746915, 100553.49723251337, 100875.0, 83761.0, 85717.14282857091, 86561.0, 87857.12142878617, 89083.0, 12418.937905310415, 12660.923821475279, 12732.490700372251, 12742.808857866954, 12864.935675321563, 38466.615333846305, 39484.40773388459, 39672.2065558693, 39730.205395892495, 40802.59197407988, 70503.64748176227, 71021.0, 71806.64096679483, 72753.6362318185, 75129.0, 18169.45491635253, 18417.815821842145, 18522.259109635463, 18943.90528047351, 19050.23799048078, 18604.7209291858, 18655.347062852736, 19404.805951940863, 19452.0, 22224.77775222227, 16464.83535164681, 16798.07610581381, 16802.32790688408, 17056.232469539147, 19658.115384808003, 17270.913645432196, 17458.650826983136, 17560.82439175592, 17605.0, 18286.542836428664, 16347.427840025543, 16525.504234872973, 16555.66888662244, 16617.584560386087, 16637.168141593113, 13219.735605288033, 13469.12450690702, 13758.105723128365, 13957.511487098309, 14091.929540352232, 13760.243186624832, 14066.156030638194, 14530.927345363205, 14687.41250349974, 15041.473548425753], "value": 9272.589924971382, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 106.0, 108.0, 116.0, 111.0, 111.0, 99.0, 110.0, 113.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 118.0, 148.0, 185.0, 120.0, 151.0, 154.0, 118.0, 182.0, 118.0], "value": 143.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 171.0, 162.0, 163.0, 166.0, 162.0, 167.0, 165.0, 162.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 167.0, 74.0, 75.0, 74.0, 82.0, 101.0, 75.0], "value": 87.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 87.0, 131.0, 78.0, 80.0, 89.0, 140.0, 79.0, 80.0, 131.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 120.0, 118.0, 118.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 149.0, 149.0, 149.0, 151.0, 153.0, 149.0, 149.0, 149.0], "value": 149.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 98.0, 99.0, 94.0, 93.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 53.0, 56.0, 54.0, 61.0, 54.0, 55.0, 60.0, 54.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 54.0, 54.0, 62.0, 54.0, 54.0, 60.0, 60.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 80.0, 76.0, 75.0, 74.0, 74.0, 79.0, 78.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 119.0, 126.0, 121.0, 122.0, 119.0, 124.0, 135.0, 121.0, 170.0], "value": 128.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 179.0, 186.0, 177.0, 178.0, 171.0, 175.0, 183.0, 179.0], "value": 177.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 69.0, 73.0, 67.0, 68.0, 70.0, 68.0, 66.0], "value": 68.4, "unit": "score"}]}]} 11:41:19 INFO - Return code: 0 11:41:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:41:19 INFO - # TBPL SUCCESS # 11:41:19 INFO - Running post-action listener: _package_coverage_data 11:41:19 INFO - Running post-action listener: _resource_record_post_action 11:41:19 INFO - [mozharness: 2017-08-17 18:41:19.782299Z] Finished run-tests step (success) 11:41:19 INFO - Running post-run listener: _resource_record_post_run 11:41:19 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 439521280; Read time: 252; Write time: 280728 11:41:19 INFO - TinderboxPrint: CPU usage
13.1% 11:41:19 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 252 11:41:19 INFO - TinderboxPrint: I/O write bytes / time
439,521,280 / 280,728 11:41:19 INFO - TinderboxPrint: CPU idle
8,268.1 (86.9%) 11:41:19 INFO - TinderboxPrint: CPU user
1,200.6 (12.6%) 11:41:19 INFO - TinderboxPrint: Swap in / out
0 / 0 11:41:19 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 115412992; Read time: 108; Write time: 99036 11:41:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:41:19 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 324108288; Read time: 144; Write time: 181692 11:41:20 INFO - Running post-run listener: _upload_blobber_files 11:41:20 INFO - Blob upload gear active. 11:41:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:41:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:41:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:41:20 INFO - (blobuploader) - INFO - Open directory for files ... 11:41:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:41:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:41:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:27 INFO - (blobuploader) - INFO - Done attempting. 11:41:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:41:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:41:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:28 INFO - (blobuploader) - INFO - Done attempting. 11:41:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:41:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:41:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:29 INFO - (blobuploader) - INFO - Done attempting. 11:41:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:41:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:41:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:30 INFO - (blobuploader) - INFO - Done attempting. 11:41:30 INFO - (blobuploader) - INFO - Iteration through files over. 11:41:30 INFO - Return code: 0 11:41:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:41:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:41:30 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e497cfec961ef672b5d3d0f222fbeb8074000985f3f5ef7adfef1365e800c619a9279320e910888d0c263b798b471db570870152302dd6f7151abc9377b0edc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1e07660d24f33f439bf8ca5977b368488a843cf7197773937e5a0dc158b4c6403dedf2b0c5e77817427bc483eeed65843c9f26a4782a12b05d17c35f2c30b6d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ce48f1312cb8ad10093a87c6dc5978c359c0d8cba483e98818a6410d8f6869d729f008f7738957e22ed51dd20e764b0d944020add61c243583affd25cc18c61", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b83c7cbb4c00e3571711154194eeff153174157f3a549a53f5f97aebf06c6580e1166ba0736f2242f4306ed14628985626b3f03359fd3f1b9c1861b6cca7ff5"} 11:41:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:41:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:41:30 INFO - Contents: 11:41:30 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e497cfec961ef672b5d3d0f222fbeb8074000985f3f5ef7adfef1365e800c619a9279320e910888d0c263b798b471db570870152302dd6f7151abc9377b0edc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1e07660d24f33f439bf8ca5977b368488a843cf7197773937e5a0dc158b4c6403dedf2b0c5e77817427bc483eeed65843c9f26a4782a12b05d17c35f2c30b6d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ce48f1312cb8ad10093a87c6dc5978c359c0d8cba483e98818a6410d8f6869d729f008f7738957e22ed51dd20e764b0d944020add61c243583affd25cc18c61", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b83c7cbb4c00e3571711154194eeff153174157f3a549a53f5f97aebf06c6580e1166ba0736f2242f4306ed14628985626b3f03359fd3f1b9c1861b6cca7ff5"} 11:41:30 INFO - Running post-run listener: copy_logs_to_upload_dir 11:41:30 INFO - Copying logs to upload dir... 11:41:30 INFO - mkdir: /builds/slave/test/build/upload/logs 11:41:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.309474 ========= master_lag: -0.39 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-17 11:41:29.636014) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 11:41:29.640252) ========= 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=438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e497cfec961ef672b5d3d0f222fbeb8074000985f3f5ef7adfef1365e800c619a9279320e910888d0c263b798b471db570870152302dd6f7151abc9377b0edc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1e07660d24f33f439bf8ca5977b368488a843cf7197773937e5a0dc158b4c6403dedf2b0c5e77817427bc483eeed65843c9f26a4782a12b05d17c35f2c30b6d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ce48f1312cb8ad10093a87c6dc5978c359c0d8cba483e98818a6410d8f6869d729f008f7738957e22ed51dd20e764b0d944020add61c243583affd25cc18c61", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b83c7cbb4c00e3571711154194eeff153174157f3a549a53f5f97aebf06c6580e1166ba0736f2242f4306ed14628985626b3f03359fd3f1b9c1861b6cca7ff5"} build_url:https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011291 build_url: 'https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e497cfec961ef672b5d3d0f222fbeb8074000985f3f5ef7adfef1365e800c619a9279320e910888d0c263b798b471db570870152302dd6f7151abc9377b0edc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1e07660d24f33f439bf8ca5977b368488a843cf7197773937e5a0dc158b4c6403dedf2b0c5e77817427bc483eeed65843c9f26a4782a12b05d17c35f2c30b6d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ce48f1312cb8ad10093a87c6dc5978c359c0d8cba483e98818a6410d8f6869d729f008f7738957e22ed51dd20e764b0d944020add61c243583affd25cc18c61", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b83c7cbb4c00e3571711154194eeff153174157f3a549a53f5f97aebf06c6580e1166ba0736f2242f4306ed14628985626b3f03359fd3f1b9c1861b6cca7ff5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 11:41:29.669397) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:41:29.669684) ========= 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=438111f3d31ce799eff2119d000001bc-1502993955.207539-1836415787 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004577 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:41:29.748408) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 11:41:29.748683) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 11:41:29.751952) ========= ========= Total master_lag: -0.23 =========