builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1502994090.53 results: success (0) revision: e365137fa61bfd729617ba1ebf9f1ed79facd1f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 11:21:30.532535) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 11:21:30.533010) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 11:21:30.533292) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 11:21:30.570680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:21:30.570964) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-17 11:21: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% 223M=0s 2017-08-17 11:21:30 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137768 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:21:30.723762) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:21:30.727099) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017950 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:21:30.782933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-17 11:21:30.783242) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-17 11:21:31,112 truncating revision to first 12 chars 2017-08-17 11:21:31,112 Setting DEBUG logging. 2017-08-17 11:21:31,112 attempt 1/10 2017-08-17 11:21:31,112 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:21:31,891 unpacking tar archive at: mozilla-central-e365137fa61b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.090391 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-17 11:21:31.888283) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 11:21:31.888555) ========= script_repo_revision: e365137fa61bfd729617ba1ebf9f1ed79facd1f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 11:21:31.891896) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 11:21:31.892158) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 11:21:31.904085) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-17 11:21:31.904352) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:21:32 INFO - MultiFileLogger online at 20170817 11:21:32 in /builds/slave/test 11:21: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:21:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:21:32 INFO - {'append_to_log': False, 11:21:32 INFO - 'base_work_dir': '/builds/slave/test', 11:21:32 INFO - 'blob_upload_branch': 'Firefox', 11:21:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:21:32 INFO - 'branch': 'Firefox', 11:21:32 INFO - 'buildbot_json_path': 'buildprops.json', 11:21:32 INFO - 'code_coverage': False, 11:21:32 INFO - 'config_files': ('talos/linux_config.py',), 11:21:32 INFO - 'default_actions': ('clobber', 11:21:32 INFO - 'read-buildbot-config', 11:21:32 INFO - 'download-and-extract', 11:21:32 INFO - 'populate-webroot', 11:21:32 INFO - 'create-virtualenv', 11:21:32 INFO - 'install', 11:21:32 INFO - 'setup-mitmproxy', 11:21:32 INFO - 'run-tests'), 11:21:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:21:32 INFO - 'disable_ccov_upload': False, 11:21:32 INFO - 'download_minidump_stackwalk': True, 11:21:32 INFO - 'download_symbols': 'ondemand', 11:21:32 INFO - 'enable_stylo': False, 11:21:32 INFO - 'enable_webrender': False, 11:21:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:21:32 INFO - 'tooltool.py': '/tools/tooltool.py', 11:21:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:21:32 INFO - '/tools/misc-python/virtualenv.py')}, 11:21:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:21:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:21:32 INFO - 'gecko_profile': False, 11:21:32 INFO - 'gecko_profile_interval': 0, 11:21:32 INFO - 'installer_path': 'installer.exe', 11:21:32 INFO - 'log_level': 'info', 11:21:32 INFO - 'log_name': 'talos', 11:21:32 INFO - 'log_to_console': True, 11:21:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:21:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:21:32 INFO - 'opt_config_files': (), 11:21:32 INFO - 'pip_index': False, 11:21:32 INFO - 'suite': 'dromaeojs-e10s', 11:21:32 INFO - 'system_bits': '32', 11:21:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:21:32 INFO - 'title': 'talos-linux64-ix-012', 11:21:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:21:32 INFO - 'use_talos_json': True, 11:21:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:21:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:21:32 INFO - 'work_dir': 'build'} 11:21:32 INFO - [mozharness: 2017-08-17 18:21:32.339993Z] Running clobber step. 11:21:32 INFO - Running pre-action listener: _resource_record_pre_action 11:21:32 INFO - Running main action method: clobber 11:21:32 INFO - rmtree: /builds/slave/test/build 11:21:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:21:33 INFO - Running post-action listener: _resource_record_post_action 11:21:33 INFO - [mozharness: 2017-08-17 18:21:33.386839Z] Finished clobber step (success) 11:21:33 INFO - [mozharness: 2017-08-17 18:21:33.386940Z] Running read-buildbot-config step. 11:21:33 INFO - Running pre-action listener: _resource_record_pre_action 11:21:33 INFO - Running main action method: read_buildbot_config 11:21:33 INFO - Using buildbot properties: 11:21:33 INFO - { 11:21:33 INFO - "project": "", 11:21:33 INFO - "product": "firefox", 11:21:33 INFO - "who": "archaeopteryx@coole-files.de", 11:21:33 INFO - "installer_path": "public/build/target.tar.bz2", 11:21:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 11:21:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:21:33 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 11:21:33 INFO - "stage_platform": "linux64-qr", 11:21:33 INFO - "basedir": "/builds/slave/test", 11:21:33 INFO - "buildnumber": 7, 11:21:33 INFO - "platform": "ubuntu64_hw_qr", 11:21:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:21:33 INFO - "slavebuilddir": "test", 11:21:33 INFO - "taskId": "d3W8aFxNRRq7WJFIY0tG7w", 11:21:33 INFO - "branch": "mozilla-central", 11:21:33 INFO - "script_repo_revision": "production", 11:21:33 INFO - "revision": "e365137fa61bfd729617ba1ebf9f1ed79facd1f2", 11:21:33 INFO - "slavename": "talos-linux64-ix-012", 11:21:33 INFO - "repo_path": "mozilla-central" 11:21:33 INFO - } 11:21:33 INFO - Finding installer, test and symbols from parent task. 11:21:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d3W8aFxNRRq7WJFIY0tG7w'}, attempt #1 11:21:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d3W8aFxNRRq7WJFIY0tG7w'}, attempt #1 11:21:34 INFO - Task dependencies: aYF0Eu7eSDuOnCwEq2ykWQ 11:21:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ'}, attempt #1 11:21:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 11:21:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.test_packages.json 11:21:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.crashreporter-symbols.zip 11:21:34 INFO - Running post-action listener: _resource_record_post_action 11:21:34 INFO - [mozharness: 2017-08-17 18:21:34.774111Z] Finished read-buildbot-config step (success) 11:21:34 INFO - [mozharness: 2017-08-17 18:21:34.774334Z] Running download-and-extract step. 11:21:34 INFO - Running pre-action listener: _resource_record_pre_action 11:21:34 INFO - Running main action method: download_and_extract 11:21:34 INFO - mkdir: /builds/slave/test/build/tests 11:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:34 INFO - trying https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.test_packages.json 11:21:34 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:21:34 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:21:35 INFO - Downloaded 989 bytes. 11:21:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:21:35 INFO - Using the following test package requirements: 11:21:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:21:35 INFO - u'common': [u'target.common.tests.zip'], 11:21:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:21:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:21:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:21:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:21:35 INFO - u'mozbase': [u'target.common.tests.zip'], 11:21:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:21:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:21:35 INFO - u'web-platform': [u'target.common.tests.zip', 11:21:35 INFO - u'target.web-platform.tests.tar.gz'], 11:21:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:21:35 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:21:35 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:21:35 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:21:35 INFO - Fetch https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.common.tests.zip into memory 11:21:36 INFO - Content-Length response header: 53999535 11:21:36 INFO - Bytes received: 53999535 11:21:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:21:47 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:21:47 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:21:47 INFO - Fetch https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.common.tests.zip into memory 11:21:48 INFO - Content-Length response header: 53999535 11:21:48 INFO - Bytes received: 53999535 11:22:00 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:22:00 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:22:00 INFO - Fetch https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.talos.tests.zip into memory 11:22:01 INFO - Content-Length response header: 14496161 11:22:01 INFO - Bytes received: 14496161 11:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:01 INFO - trying https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 11:22:01 INFO - Downloading https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:22:01 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:22:02 INFO - Downloaded 62276440 bytes. 11:22:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 11:22:02 INFO - mkdir: /builds/slave/test/properties 11:22:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:22:02 INFO - Writing to file /builds/slave/test/properties/build_url 11:22:02 INFO - Contents: 11:22:02 INFO - build_url:https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 11:22:02 INFO - Running post-action listener: _resource_record_post_action 11:22:02 INFO - Running post-action listener: set_extra_try_arguments 11:22:02 INFO - [mozharness: 2017-08-17 18:22:02.858783Z] Finished download-and-extract step (success) 11:22:02 INFO - [mozharness: 2017-08-17 18:22:02.858881Z] Running populate-webroot step. 11:22:02 INFO - Running pre-action listener: _resource_record_pre_action 11:22:02 INFO - Running main action method: populate_webroot 11:22:02 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:22:02 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 11:22:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:22:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:22:02 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 11:22:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:22:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:22:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:02 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:22:02 INFO - 'talos_options': ['--stylo'], 11:22:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:22:02 INFO - 'tests': ['damp', 'tps']}, 11:22:02 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:22:02 INFO - 'talos_options': ['--stylo'], 11:22:02 INFO - 'tests': ['damp', 'tps']}, 11:22:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:22:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:22:02 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 11:22:02 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:22:02 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:22:02 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:22:02 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:22:02 INFO - 'talos_options': ['--stylo'], 11:22:02 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:22:02 INFO - 'other-e10s': {'tests': ['a11yr', 11:22:02 INFO - 'ts_paint', 11:22:02 INFO - 'tpaint', 11:22:02 INFO - 'sessionrestore', 11:22:02 INFO - 'sessionrestore_many_windows', 11:22:02 INFO - 'sessionrestore_no_auto_restore', 11:22:02 INFO - 'tabpaint']}, 11:22:02 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 11:22:02 INFO - 'tests': ['a11yr', 11:22:02 INFO - 'ts_paint', 11:22:02 INFO - 'tpaint', 11:22:02 INFO - 'sessionrestore', 11:22:02 INFO - 'sessionrestore_many_windows', 11:22:02 INFO - 'sessionrestore_no_auto_restore', 11:22:02 INFO - 'tabpaint']}, 11:22:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:22:02 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:22:02 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 11:22:02 INFO - 'tests': ['bloom_basic_singleton']}, 11:22:02 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 11:22:02 INFO - 'tests': ['bloom_basic']}, 11:22:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:22:02 INFO - 'tsvgr_opacity', 11:22:02 INFO - 'tart', 11:22:02 INFO - 'tscrollx', 11:22:02 INFO - 'tsvg_static']}, 11:22:02 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 11:22:02 INFO - 'tests': ['tsvgx', 11:22:02 INFO - 'tsvgr_opacity', 11:22:02 INFO - 'tart', 11:22:02 INFO - 'tscrollx', 11:22:02 INFO - 'tsvg_static']}, 11:22:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:22:02 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:22:02 INFO - 'talos_options': ['--stylo'], 11:22:02 INFO - 'tests': ['tp5o']}, 11:22:02 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:22:02 INFO - 'talos_options': ['--mitmproxy', 11:22:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:22:02 INFO - '--firstNonBlankPaint'], 11:22:02 INFO - 'tests': ['tp6_google', 11:22:02 INFO - 'tp6_youtube', 11:22:02 INFO - 'tp6_amazon', 11:22:02 INFO - 'tp6_facebook']}, 11:22:02 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:22:02 INFO - 'talos_options': ['--stylo', 11:22:02 INFO - '--mitmproxy', 11:22:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:22:02 INFO - '--firstNonBlankPaint'], 11:22:02 INFO - 'tests': ['tp6_google', 11:22:02 INFO - 'tp6_youtube', 11:22:02 INFO - 'tp6_amazon', 11:22:02 INFO - 'tp6_facebook']}, 11:22:02 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:22:02 INFO - 'talos_options': ['--stylo', 11:22:02 INFO - '--stylo-threads=1', 11:22:02 INFO - '--mitmproxy', 11:22:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:22:02 INFO - '--firstNonBlankPaint'], 11:22:02 INFO - 'tests': ['tp6_google', 11:22:02 INFO - 'tp6_youtube', 11:22:02 INFO - 'tp6_amazon', 11:22:02 INFO - 'tp6_facebook']}, 11:22:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:22:02 INFO - 'talos_options': ['--xperf_path', 11:22:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:02 INFO - 'tests': ['tp5n']}, 11:22:02 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:22:02 INFO - 'talos_options': ['--stylo', 11:22:02 INFO - '--xperf_path', 11:22:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:02 INFO - 'tests': ['tp5n']}}} 11:22:02 INFO - Running post-action listener: _resource_record_post_action 11:22:02 INFO - [mozharness: 2017-08-17 18:22:02.873109Z] Finished populate-webroot step (success) 11:22:02 INFO - [mozharness: 2017-08-17 18:22:02.873200Z] Running create-virtualenv step. 11:22:02 INFO - Running pre-action listener: _resource_record_pre_action 11:22:02 INFO - Running main action method: create_virtualenv 11:22:02 INFO - Creating virtualenv /builds/slave/test/build/venv 11:22:02 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:22:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:22:02 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:22:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:22:02 INFO - Using real prefix '/usr' 11:22:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:22:03 INFO - Installing distribute.............................................................................................................................................................................................done. 11:22:05 INFO - Installing pip.................done. 11:22:05 INFO - Return code: 0 11:22:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:22:05 INFO - Reading from file tmpfile_stdout 11:22:05 INFO - Output received: 11:22:05 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:22:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c0b0>, '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 0x2c6cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d440>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', '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:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:22:05 INFO - Using env: {'DISPLAY': ':0', 11:22:05 INFO - 'HOME': '/home/cltbld', 11:22:05 INFO - 'LANG': 'en_US.UTF-8', 11:22:05 INFO - 'LANGUAGE': 'en_US:en', 11:22:05 INFO - 'LOGNAME': 'cltbld', 11:22:05 INFO - 'MAIL': '/var/mail/cltbld', 11:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:05 INFO - 'MOZ_NO_REMOTE': '1', 11:22:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:05 INFO - 'NO_EM_RESTART': '1', 11:22:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:05 INFO - 'PWD': '/builds/slave/test', 11:22:05 INFO - 'SHELL': '/bin/bash', 11:22:05 INFO - 'SHLVL': '1', 11:22:05 INFO - 'TERM': 'linux', 11:22:05 INFO - 'TMOUT': '86400', 11:22:05 INFO - 'USER': 'cltbld', 11:22:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', 11:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:05 INFO - '_': '/tools/buildbot/bin/python'} 11:22:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:05 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:22:05 INFO - Cleaning up... 11:22:05 INFO - Return code: 0 11:22:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c0b0>, '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 0x2c6cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d440>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', '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:22:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:22:05 INFO - Using env: {'DISPLAY': ':0', 11:22:05 INFO - 'HOME': '/home/cltbld', 11:22:05 INFO - 'LANG': 'en_US.UTF-8', 11:22:05 INFO - 'LANGUAGE': 'en_US:en', 11:22:05 INFO - 'LOGNAME': 'cltbld', 11:22:05 INFO - 'MAIL': '/var/mail/cltbld', 11:22:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:05 INFO - 'MOZ_NO_REMOTE': '1', 11:22:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:05 INFO - 'NO_EM_RESTART': '1', 11:22:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:05 INFO - 'PWD': '/builds/slave/test', 11:22:05 INFO - 'SHELL': '/bin/bash', 11:22:05 INFO - 'SHLVL': '1', 11:22:05 INFO - 'TERM': 'linux', 11:22:05 INFO - 'TMOUT': '86400', 11:22:05 INFO - 'USER': 'cltbld', 11:22:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', 11:22:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:05 INFO - '_': '/tools/buildbot/bin/python'} 11:22:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:06 INFO - Downloading/unpacking psutil>=3.1.1 11:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:22:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:07 INFO - Installing collected packages: psutil 11:22:07 INFO - Running setup.py install for psutil 11:22:07 INFO - building 'psutil._psutil_linux' extension 11:22:07 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:22:07 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:22:07 INFO - building 'psutil._psutil_posix' extension 11:22:07 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:22:07 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:22:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:07 INFO - Successfully installed psutil 11:22:07 INFO - Cleaning up... 11:22:07 INFO - Return code: 0 11:22:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c0b0>, '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 0x2c6cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d440>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', '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:22:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:22:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:22:07 INFO - Using env: {'DISPLAY': ':0', 11:22:07 INFO - 'HOME': '/home/cltbld', 11:22:07 INFO - 'LANG': 'en_US.UTF-8', 11:22:07 INFO - 'LANGUAGE': 'en_US:en', 11:22:07 INFO - 'LOGNAME': 'cltbld', 11:22:07 INFO - 'MAIL': '/var/mail/cltbld', 11:22:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:07 INFO - 'MOZ_NO_REMOTE': '1', 11:22:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:07 INFO - 'NO_EM_RESTART': '1', 11:22:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:07 INFO - 'PWD': '/builds/slave/test', 11:22:07 INFO - 'SHELL': '/bin/bash', 11:22:07 INFO - 'SHLVL': '1', 11:22:07 INFO - 'TERM': 'linux', 11:22:07 INFO - 'TMOUT': '86400', 11:22:07 INFO - 'USER': 'cltbld', 11:22:07 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', 11:22:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:07 INFO - '_': '/tools/buildbot/bin/python'} 11:22:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:22: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:22: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:22: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:22: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:22:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:22:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:22:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:22:09 INFO - Installing collected packages: mozsystemmonitor 11:22:09 INFO - Running setup.py install for mozsystemmonitor 11:22:09 INFO - Successfully installed mozsystemmonitor 11:22:09 INFO - Cleaning up... 11:22:09 INFO - Return code: 0 11:22:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:09 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 0x29c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c0b0>, '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 0x2c6cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d440>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', '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:22:09 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:22:09 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:22:09 INFO - Using env: {'DISPLAY': ':0', 11:22:09 INFO - 'HOME': '/home/cltbld', 11:22:09 INFO - 'LANG': 'en_US.UTF-8', 11:22:09 INFO - 'LANGUAGE': 'en_US:en', 11:22:09 INFO - 'LOGNAME': 'cltbld', 11:22:09 INFO - 'MAIL': '/var/mail/cltbld', 11:22:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:09 INFO - 'MOZ_NO_REMOTE': '1', 11:22:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:09 INFO - 'NO_EM_RESTART': '1', 11:22:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:09 INFO - 'PWD': '/builds/slave/test', 11:22:09 INFO - 'SHELL': '/bin/bash', 11:22:09 INFO - 'SHLVL': '1', 11:22:09 INFO - 'TERM': 'linux', 11:22:09 INFO - 'TMOUT': '86400', 11:22:09 INFO - 'USER': 'cltbld', 11:22:09 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', 11:22:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:09 INFO - '_': '/tools/buildbot/bin/python'} 11:22:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:09 INFO - Downloading/unpacking jsonschema==2.5.1 11:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:22:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:22: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:22: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:22: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:22: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:22:10 INFO - Downloading functools32-3.2.3-2.tar.gz 11:22:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:22:10 INFO - warning: no files found matching '*.txt' 11:22:10 INFO - no previously-included directories found matching 'build' 11:22:10 INFO - no previously-included directories found matching 'dist' 11:22:10 INFO - no previously-included directories found matching '.git*' 11:22:10 INFO - Installing collected packages: jsonschema, functools32 11:22:10 INFO - Running setup.py install for functools32 11:22:11 INFO - warning: no files found matching '*.txt' 11:22:11 INFO - no previously-included directories found matching 'build' 11:22:11 INFO - no previously-included directories found matching 'dist' 11:22:11 INFO - no previously-included directories found matching '.git*' 11:22:11 INFO - Successfully installed jsonschema functools32 11:22:11 INFO - Cleaning up... 11:22:11 INFO - Return code: 0 11:22:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c0b0>, '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 0x2c6cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d440>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', '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:22:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:22:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:22:11 INFO - Using env: {'DISPLAY': ':0', 11:22:11 INFO - 'HOME': '/home/cltbld', 11:22:11 INFO - 'LANG': 'en_US.UTF-8', 11:22:11 INFO - 'LANGUAGE': 'en_US:en', 11:22:11 INFO - 'LOGNAME': 'cltbld', 11:22:11 INFO - 'MAIL': '/var/mail/cltbld', 11:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:11 INFO - 'MOZ_NO_REMOTE': '1', 11:22:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:11 INFO - 'NO_EM_RESTART': '1', 11:22:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:11 INFO - 'PWD': '/builds/slave/test', 11:22:11 INFO - 'SHELL': '/bin/bash', 11:22:11 INFO - 'SHLVL': '1', 11:22:11 INFO - 'TERM': 'linux', 11:22:11 INFO - 'TMOUT': '86400', 11:22:11 INFO - 'USER': 'cltbld', 11:22:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', 11:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:11 INFO - '_': '/tools/buildbot/bin/python'} 11:22:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:22:11 INFO - Cleaning up... 11:22:11 INFO - Return code: 0 11:22:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c0b0>, '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 0x2c6cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d440>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', '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:22:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:22:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:22:11 INFO - Using env: {'DISPLAY': ':0', 11:22:11 INFO - 'HOME': '/home/cltbld', 11:22:11 INFO - 'LANG': 'en_US.UTF-8', 11:22:11 INFO - 'LANGUAGE': 'en_US:en', 11:22:11 INFO - 'LOGNAME': 'cltbld', 11:22:11 INFO - 'MAIL': '/var/mail/cltbld', 11:22:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:11 INFO - 'MOZ_NO_REMOTE': '1', 11:22:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:11 INFO - 'NO_EM_RESTART': '1', 11:22:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:11 INFO - 'PWD': '/builds/slave/test', 11:22:11 INFO - 'SHELL': '/bin/bash', 11:22:11 INFO - 'SHLVL': '1', 11:22:11 INFO - 'TERM': 'linux', 11:22:11 INFO - 'TMOUT': '86400', 11:22:11 INFO - 'USER': 'cltbld', 11:22:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', 11:22:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:11 INFO - '_': '/tools/buildbot/bin/python'} 11:22:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:11 INFO - Downloading/unpacking blobuploader==1.2.4 11:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:22:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:22:12 INFO - Downloading blobuploader-1.2.4.tar.gz 11:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:22:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:22: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:22: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:22: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:22: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:22:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:22:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:22: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:22: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:22: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:22: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:22:13 INFO - Downloading docopt-0.6.1.tar.gz 11:22:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:22:13 INFO - Installing collected packages: blobuploader, requests, docopt 11:22:13 INFO - Running setup.py install for blobuploader 11:22:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:22:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:22:13 INFO - Running setup.py install for requests 11:22:13 INFO - Running setup.py install for docopt 11:22:13 INFO - Successfully installed blobuploader requests docopt 11:22:13 INFO - Cleaning up... 11:22:13 INFO - Return code: 0 11:22:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22: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:22:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22: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:22:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:13 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 0x29c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c0b0>, '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 0x2c6cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d440>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', '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:22:13 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:22:13 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:22:13 INFO - Using env: {'DISPLAY': ':0', 11:22:13 INFO - 'HOME': '/home/cltbld', 11:22:13 INFO - 'LANG': 'en_US.UTF-8', 11:22:13 INFO - 'LANGUAGE': 'en_US:en', 11:22:13 INFO - 'LOGNAME': 'cltbld', 11:22:13 INFO - 'MAIL': '/var/mail/cltbld', 11:22:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:13 INFO - 'MOZ_NO_REMOTE': '1', 11:22:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:13 INFO - 'NO_EM_RESTART': '1', 11:22:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:13 INFO - 'PWD': '/builds/slave/test', 11:22:13 INFO - 'SHELL': '/bin/bash', 11:22:13 INFO - 'SHLVL': '1', 11:22:13 INFO - 'TERM': 'linux', 11:22:13 INFO - 'TMOUT': '86400', 11:22:13 INFO - 'USER': 'cltbld', 11:22:13 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', 11:22:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:13 INFO - '_': '/tools/buildbot/bin/python'} 11:22:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:22:14 INFO - Running setup.py (path:/tmp/pip-0qS17n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:22:14 INFO - Running setup.py (path:/tmp/pip-C_mUQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:22:14 INFO - Running setup.py (path:/tmp/pip-4D25Bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:22:14 INFO - Running setup.py (path:/tmp/pip-iHfYQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:22:14 INFO - Running setup.py (path:/tmp/pip-5NSoIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:22:14 INFO - Running setup.py (path:/tmp/pip-Zmj6LZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:22:14 INFO - Running setup.py (path:/tmp/pip-MPv9rB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:22:14 INFO - Running setup.py (path:/tmp/pip-GcTT8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:22:14 INFO - Running setup.py (path:/tmp/pip-tIsjSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:22:14 INFO - Running setup.py (path:/tmp/pip-E7kVXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:22:14 INFO - Running setup.py (path:/tmp/pip-VaCvKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:22:14 INFO - Running setup.py (path:/tmp/pip-thI8Kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:22:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:22:14 INFO - Running setup.py (path:/tmp/pip-DYVxIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:22:15 INFO - Running setup.py (path:/tmp/pip-49tq_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:15 INFO - Running setup.py (path:/tmp/pip-TmFwl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:22:15 INFO - Running setup.py (path:/tmp/pip-by9SQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:22:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:22:15 INFO - Running setup.py (path:/tmp/pip-fMIJpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:22:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:22:15 INFO - Running setup.py install for manifestparser 11:22:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:22:15 INFO - Running setup.py install for mozcrash 11:22:15 INFO - Running setup.py install for mozdebug 11:22:15 INFO - Running setup.py install for mozdevice 11:22:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:22:15 INFO - Running setup.py install for mozfile 11:22:15 INFO - Running setup.py install for mozhttpd 11:22:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:22:15 INFO - Running setup.py install for mozinfo 11:22:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:22:15 INFO - Running setup.py install for mozInstall 11:22:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:22:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:22:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:22:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:22:16 INFO - Running setup.py install for mozleak 11:22:16 INFO - Running setup.py install for mozlog 11:22:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:22:16 INFO - Running setup.py install for moznetwork 11:22:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:22:16 INFO - Running setup.py install for mozprocess 11:22:16 INFO - Running setup.py install for mozprofile 11:22:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:22:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:22:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:22:16 INFO - Running setup.py install for mozrunner 11:22:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:22:16 INFO - Running setup.py install for mozscreenshot 11:22:16 INFO - Running setup.py install for moztest 11:22:16 INFO - Running setup.py install for mozversion 11:22:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:22:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:22:17 INFO - Cleaning up... 11:22:17 INFO - Return code: 0 11:22:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22:17 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:22:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:17 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:22:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:17 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 0x29c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c0b0>, '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 0x2c6cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d440>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', '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:22:17 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:22:17 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:22:17 INFO - Using env: {'DISPLAY': ':0', 11:22:17 INFO - 'HOME': '/home/cltbld', 11:22:17 INFO - 'LANG': 'en_US.UTF-8', 11:22:17 INFO - 'LANGUAGE': 'en_US:en', 11:22:17 INFO - 'LOGNAME': 'cltbld', 11:22:17 INFO - 'MAIL': '/var/mail/cltbld', 11:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:17 INFO - 'MOZ_NO_REMOTE': '1', 11:22:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:17 INFO - 'NO_EM_RESTART': '1', 11:22:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:17 INFO - 'PWD': '/builds/slave/test', 11:22:17 INFO - 'SHELL': '/bin/bash', 11:22:17 INFO - 'SHLVL': '1', 11:22:17 INFO - 'TERM': 'linux', 11:22:17 INFO - 'TMOUT': '86400', 11:22:17 INFO - 'USER': 'cltbld', 11:22:17 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', 11:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:17 INFO - '_': '/tools/buildbot/bin/python'} 11:22:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:22:17 INFO - Running setup.py (path:/tmp/pip-j6sTTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:22:17 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:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:22:17 INFO - Running setup.py (path:/tmp/pip-rF6Rxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:22:17 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:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:22:17 INFO - Running setup.py (path:/tmp/pip-qNj1oL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:22:17 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:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:22:17 INFO - Running setup.py (path:/tmp/pip-633VvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:22:17 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:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:22:17 INFO - Running setup.py (path:/tmp/pip-aIg1iI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:22:17 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:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:22:17 INFO - Running setup.py (path:/tmp/pip-RrTvj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:22:17 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:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:22:17 INFO - Running setup.py (path:/tmp/pip-b4smEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:22:17 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:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:22:17 INFO - Running setup.py (path:/tmp/pip-38Q4W6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:22:17 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:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:22:17 INFO - Running setup.py (path:/tmp/pip-cVWM1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:22:17 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:22:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:22:17 INFO - Running setup.py (path:/tmp/pip-hhPznL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:22:18 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:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:22:18 INFO - Running setup.py (path:/tmp/pip-66DAve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:22:18 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:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:22:18 INFO - Running setup.py (path:/tmp/pip-snGtis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:22:18 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:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:22:18 INFO - Running setup.py (path:/tmp/pip-A9qWx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:22:18 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:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:22:18 INFO - Running setup.py (path:/tmp/pip-hIgt6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:22:18 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:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:18 INFO - Running setup.py (path:/tmp/pip-gnaXcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:18 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:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:22:18 INFO - Running setup.py (path:/tmp/pip-vtdkT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:22:18 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:22:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:22:18 INFO - Running setup.py (path:/tmp/pip-Mpu_0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:22:18 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:22:18 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:22:18 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:22:18 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:22:18 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:22:18 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:22:18 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:22:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:22:18 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:22:18 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:22:18 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:22:18 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:22:19 INFO - Downloading blessings-1.6.tar.gz 11:22:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:22:19 INFO - Installing collected packages: blessings 11:22:19 INFO - Running setup.py install for blessings 11:22:19 INFO - Successfully installed blessings 11:22:19 INFO - Cleaning up... 11:22:19 INFO - Return code: 0 11:22:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:22:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:22:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:22:20 INFO - Reading from file tmpfile_stdout 11:22:20 INFO - Current package versions: 11:22:20 INFO - argparse == 1.2.1 11:22:20 INFO - blessings == 1.6 11:22:20 INFO - blobuploader == 1.2.4 11:22:20 INFO - docopt == 0.6.1 11:22:20 INFO - functools32 == 3.2.3-2 11:22:20 INFO - jsonschema == 2.5.1 11:22:20 INFO - manifestparser == 1.1 11:22:20 INFO - mozInstall == 1.13 11:22:20 INFO - mozcrash == 1.0 11:22:20 INFO - mozdebug == 0.1 11:22:20 INFO - mozdevice == 0.51 11:22:20 INFO - mozfile == 1.2 11:22:20 INFO - mozhttpd == 0.7 11:22:20 INFO - mozinfo == 0.10 11:22:20 INFO - mozleak == 0.1 11:22:20 INFO - mozlog == 3.5 11:22:20 INFO - moznetwork == 0.27 11:22:20 INFO - mozprocess == 0.25 11:22:20 INFO - mozprofile == 0.28 11:22:20 INFO - mozrunner == 6.13 11:22:20 INFO - mozscreenshot == 0.1 11:22:20 INFO - mozsystemmonitor == 0.3 11:22:20 INFO - moztest == 0.8 11:22:20 INFO - mozversion == 1.4 11:22:20 INFO - psutil == 3.1.1 11:22:20 INFO - requests == 1.2.3 11:22:20 INFO - wsgiref == 0.1.2 11:22:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22:20 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:22:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:20 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:22:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:20 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 0x29c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c0b0>, '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 0x2c6cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d440>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', '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:22:20 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:22:20 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:22:20 INFO - Using env: {'DISPLAY': ':0', 11:22:20 INFO - 'HOME': '/home/cltbld', 11:22:20 INFO - 'LANG': 'en_US.UTF-8', 11:22:20 INFO - 'LANGUAGE': 'en_US:en', 11:22:20 INFO - 'LOGNAME': 'cltbld', 11:22:20 INFO - 'MAIL': '/var/mail/cltbld', 11:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:20 INFO - 'MOZ_NO_REMOTE': '1', 11:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:20 INFO - 'NO_EM_RESTART': '1', 11:22:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:20 INFO - 'PWD': '/builds/slave/test', 11:22:20 INFO - 'SHELL': '/bin/bash', 11:22:20 INFO - 'SHLVL': '1', 11:22:20 INFO - 'TERM': 'linux', 11:22:20 INFO - 'TMOUT': '86400', 11:22:20 INFO - 'USER': 'cltbld', 11:22:20 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', 11:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:20 INFO - '_': '/tools/buildbot/bin/python'} 11:22:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:20 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:22:20 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:22:20 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:22:20 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:22:20 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:22:20 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:22:20 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:22:20 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:22:20 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:22:20 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:22:20 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:22:20 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:22:20 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:22:20 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:22:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:22:21 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:22:21 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:22:21 INFO - Installing collected packages: simplejson 11:22:21 INFO - Running setup.py install for simplejson 11:22:21 INFO - building 'simplejson._speedups' extension 11:22:21 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:22:22 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:22:22 INFO - Successfully installed simplejson 11:22:22 INFO - Cleaning up... 11:22:22 INFO - Return code: 0 11:22:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:22: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:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22: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:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:22 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 0x29c71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6c0b0>, '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 0x2c6cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d440>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', '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:22:22 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:22:22 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:22:22 INFO - Using env: {'DISPLAY': ':0', 11:22:22 INFO - 'HOME': '/home/cltbld', 11:22:22 INFO - 'LANG': 'en_US.UTF-8', 11:22:22 INFO - 'LANGUAGE': 'en_US:en', 11:22:22 INFO - 'LOGNAME': 'cltbld', 11:22:22 INFO - 'MAIL': '/var/mail/cltbld', 11:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:22 INFO - 'MOZ_NO_REMOTE': '1', 11:22:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:22 INFO - 'NO_EM_RESTART': '1', 11:22:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:22 INFO - 'PWD': '/builds/slave/test', 11:22:22 INFO - 'SHELL': '/bin/bash', 11:22:22 INFO - 'SHLVL': '1', 11:22:22 INFO - 'TERM': 'linux', 11:22:22 INFO - 'TMOUT': '86400', 11:22:22 INFO - 'USER': 'cltbld', 11:22:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', 11:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:22 INFO - '_': '/tools/buildbot/bin/python'} 11:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:22:22 INFO - Cleaning up... 11:22:22 INFO - Return code: 0 11:22:22 INFO - Running post-action listener: _resource_record_post_action 11:22:22 INFO - Running post-action listener: _start_resource_monitoring 11:22:22 INFO - Starting resource monitoring. 11:22:22 INFO - [mozharness: 2017-08-17 18:22:22.811133Z] Finished create-virtualenv step (success) 11:22:22 INFO - [mozharness: 2017-08-17 18:22:22.811645Z] Running install step. 11:22:22 INFO - Running pre-action listener: _resource_record_pre_action 11:22:22 INFO - Running main action method: install 11:22:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:22:23 INFO - Reading from file tmpfile_stdout 11:22:23 INFO - Detecting whether we're running mozinstall >=1.0... 11:22:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:22:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:22:23 INFO - Reading from file tmpfile_stdout 11:22:23 INFO - Output received: 11:22:23 INFO - Usage: mozinstall [options] installer 11:22:23 INFO - Options: 11:22:23 INFO - -h, --help show this help message and exit 11:22:23 INFO - -d DEST, --destination=DEST 11:22:23 INFO - Directory to install application into. [default: 11:22:23 INFO - "/builds/slave/test"] 11:22:23 INFO - --app=APP Application being installed. [default: firefox] 11:22:23 INFO - mkdir: /builds/slave/test/build/application 11:22:23 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:22:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:22:41 INFO - Reading from file tmpfile_stdout 11:22:41 INFO - Output received: 11:22:41 INFO - /builds/slave/test/build/application/firefox/firefox 11:22:41 INFO - Running post-action listener: _resource_record_post_action 11:22:41 INFO - [mozharness: 2017-08-17 18:22:41.172393Z] Finished install step (success) 11:22:41 INFO - [mozharness: 2017-08-17 18:22:41.172548Z] Running setup-mitmproxy step. 11:22:41 INFO - Running pre-action listener: _resource_record_pre_action 11:22:41 INFO - Running main action method: setup_mitmproxy 11:22:41 INFO - Skipping: mitmproxy is not required 11:22:41 INFO - Running post-action listener: _resource_record_post_action 11:22:41 INFO - [mozharness: 2017-08-17 18:22:41.173088Z] Finished setup-mitmproxy step (success) 11:22:41 INFO - [mozharness: 2017-08-17 18:22:41.173193Z] Running run-tests step. 11:22:41 INFO - Running pre-action listener: _resource_record_pre_action 11:22:41 INFO - Running pre-action listener: _set_gcov_prefix 11:22:41 INFO - Running main action method: run_tests 11:22:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:22:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:22:41 INFO - Python 2.7.3 11:22:41 INFO - Return code: 0 11:22:41 INFO - grabbing minidump binary from tooltool 11:22:41 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:22:41 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 0x2c6c0b0>, '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 0x2c6cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6d440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:22:41 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:22:41 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:22:41 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:22:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:22:41 INFO - Return code: 0 11:22:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:22:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:22:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:22:41 INFO - ENV: RUST_BACKTRACE is now full 11:22:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:22:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:22:41 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-012', '--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:22:41 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-012 --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:22:41 INFO - Using env: {'DISPLAY': ':0', 11:22:41 INFO - 'HOME': '/home/cltbld', 11:22:41 INFO - 'LANG': 'en_US.UTF-8', 11:22:41 INFO - 'LANGUAGE': 'en_US:en', 11:22:41 INFO - 'LOGNAME': 'cltbld', 11:22:41 INFO - 'MAIL': '/var/mail/cltbld', 11:22:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:22:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:22:41 INFO - 'MOZ_ACCELERATED': '1', 11:22:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:41 INFO - 'MOZ_NO_REMOTE': '1', 11:22:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:22:41 INFO - 'MOZ_WEBRENDER': '1', 11:22:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:41 INFO - 'NO_EM_RESTART': '1', 11:22:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:41 INFO - 'PWD': '/builds/slave/test', 11:22:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:22:41 INFO - 'RUST_BACKTRACE': 'full', 11:22:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:22:41 INFO - 'SHELL': '/bin/bash', 11:22:41 INFO - 'SHLVL': '1', 11:22:41 INFO - 'TERM': 'linux', 11:22:41 INFO - 'TMOUT': '86400', 11:22:41 INFO - 'USER': 'cltbld', 11:22:41 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831', 11:22:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:41 INFO - '_': '/tools/buildbot/bin/python'} 11:22:41 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-012', '--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:22:41 INFO - mozversion application_buildid: 20170817173127 11:22:41 INFO - mozversion application_changeset: e365137fa61bfd729617ba1ebf9f1ed79facd1f2 11:22:41 INFO - mozversion application_display_name: Nightly 11:22:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:22:41 INFO - mozversion application_name: Firefox 11:22:41 INFO - mozversion application_remotingname: firefox 11:22:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:22:41 INFO - mozversion application_vendor: Mozilla 11:22:41 INFO - mozversion application_version: 57.0a1 11:22:41 INFO - mozversion platform_buildid: 20170817173127 11:22:41 INFO - mozversion platform_changeset: e365137fa61bfd729617ba1ebf9f1ed79facd1f2 11:22:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:22:41 INFO - mozversion platform_version: 57.0a1 11:22:41 INFO - using testdate: 1502994161 11:22:41 INFO - actual date: 1502994161 11:22:41 INFO - starting webserver on 'localhost:38841' 11:22:41 INFO - SUITE-START | Running 2 tests 11:22:41 INFO - TEST-START | dromaeo_css 11:22:41 INFO - Initialising browser for dromaeo_css test... 11:22:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38841/getInfo.html -profile /tmp/tmp213BYX/profile 11:22:41 INFO - TEST-INFO | started process 23136 (/builds/slave/test/build/application/firefox/firefox http://localhost:38841/getInfo.html) 11:22:47 INFO - TEST-INFO | 23136: exit 0 11:22:47 INFO - Browser initialized. 11:22:47 INFO - Running cycle 1/1 for dromaeo_css test... 11:22:47 INFO - TEST-INFO | started process 23319 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp213BYX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:22:48 INFO - PID 23319 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:22:48 INFO - PID 23319 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:22:48 INFO - PID 23319 | 11:22:48 INFO - PID 23319 | (/builds/slave/test/build/application/firefox/firefox:23377): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:22:48 INFO - PID 23319 | 11:22:59 INFO - PID 23319 | RSS: Main: 193540096 11:22:59 INFO - PID 23319 | 11:23:02 INFO - PID 23319 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:25:58 INFO - PID 23319 | Cycle 1(1): loaded http://localhost:38841/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38841/tests/dromaeo/cssquery-ext.html) 11:26:00 INFO - PID 23319 | RSS: Main: 219631616 11:26:00 INFO - PID 23319 | 11:29:02 INFO - PID 23319 | Cycle 1(1): loaded http://localhost:38841/tests/dromaeo/cssquery-ext.html (next: http://localhost:38841/tests/dromaeo/cssquery-jquery.html) 11:29:03 INFO - PID 23319 | RSS: Main: 220274688 11:29:03 INFO - PID 23319 | 11:32:05 INFO - PID 23319 | Cycle 1(1): loaded http://localhost:38841/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38841/tests/dromaeo/cssquery-mootools.html) 11:32:06 INFO - PID 23319 | RSS: Main: 222158848 11:32:06 INFO - PID 23319 | 11:35:08 INFO - PID 23319 | Cycle 1(1): loaded http://localhost:38841/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38841/tests/dromaeo/cssquery-prototype.html) 11:35:09 INFO - PID 23319 | RSS: Main: 272486400 11:35:09 INFO - PID 23319 | 11:38:12 INFO - PID 23319 | Cycle 1(1): loaded http://localhost:38841/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38841/tests/dromaeo/cssquery-yui.html) 11:38:13 INFO - PID 23319 | RSS: Main: 279117824 11:38:13 INFO - PID 23319 | 11:41:15 INFO - PID 23319 | Cycle 1(1): loaded http://localhost:38841/tests/dromaeo/cssquery-yui.html (next: http://localhost:38841/tests/dromaeo/cssquery-dojo.html) 11:41:15 INFO - PID 23319 | RSS: Main: 279252992 11:41:15 INFO - PID 23319 | 11:41:15 INFO - PID 23319 | __start_tp_report 11:41:15 INFO - PID 23319 | _x_x_mozilla_page_load 11:41:15 INFO - PID 23319 | _x_x_mozilla_page_load_details 11:41:15 INFO - PID 23319 | |i|pagename|runs| 11:41:15 INFO - PID 23319 | |0;dojo.html;3130.7182353588187;3144.6855314468544;3154.038018404387;3178.6821317868216;3182.5226216067585;6012.5791194616395;6096.847578810521;6102.176206212154;6147.077938309256;6148.600340977833;5991.730372133254;6125.387461253872;6129.509639228862;6188.690565471719;6196.535259855517;5566.666000039991;5596.664200147984;5613.775448982035;5673.886522269552;5689.573282003846;5500.532454741332;5553.555715542767;5587.916181257285;5636.379998200195;5681.971590142043;5529.529989950859;5588;5590.02174619442;5610.326760788711;5614.961232172041;5478.671279723229;5560;5581.10702287632;5604.299462567179;5628.296462942132;5409.026375252453;5419.647722898038;5465.207544905967;5477.959187754314;5522.834314970517;6040;6047.455728984412;6090.116933044684;6094.6038507497315;6129.448349648508;6496.5127615428555;6510.511711621647;6550.2794692583775;6554.80335589933;6629.403353698142;6498.252700939405;6572.178477690289;6641.7675381361905;6691.6319602421845;6698.799036028927;6024.337322894478;6047.15339852421;6063.969680151571;6065.757369705207;6090.482309003695;6561.901571476432;6673.03241030048;6689.665516724144;6703.765368212089;6706.731730730814;6320.083587879823;6359.07793369968;6361.109444677749;6423.357664233539;6424.164858568356;6590.3080176581725;6602.60384376939;6612.702428390734;6623.933760662332;6630.535862489676;6469.838254043687;6543.8364040898405;6573.539852210395;6590.077389165521;6641.800745977628;6532.804015879531;6564.967175164189;6630.701618427182;6653.833654158588;6655.0682904393425;5299.12564426873;5306.8407947761625;5352.839414817562;5370.91943620846;5408.891822163613;4617.746023968647;4670.673052886334;4680.508546602626;4682.9765851171205;4693.108309421199;5787.450192231731;5836.737346819404;5845.444682755132;5847.3275573308765;5854.677992710442;6613.140291762136;6617.503687223478;6688.297728738413;6700;6705.430038446689;5603.075492543766;5737.684427356536;5748.5688573357165;5774.769009239667;5820.35976042635;5734.598578099576;5851.444112809277;5851.561132915049;5854.795082172103;5858.882822343529;6405.807825765234;6415.486761059104;6422.967885160638;6450;6478.611283323015;6614.437772789367;6622.238442579165;6691.230508491391;6692;6726.091977583159;6406.135171751754;6431.710573024132;6470.22357317125;6500.739970401131;6563.901541476977;6447.097406363207;6482.611043337415;6506.316836732075;6529.183852018497;6532.248791388861;6496.902546461902;6605.47156227491;6611.041398997022;6628.668566571556;6632.1709786276715;6375.713092910923;6397.520185985976;6422.100905873088;6426.3573642635365;6430.64631445275;6317.842053948688;6368.745250189941;6400.359964003563;6402.071699603624;6408.743650253938;5433.701146436984;6225.315215326401;6340.080688300263;6357.650329231937;6360.650164240826;6381.3937675920715;6413.326600707045;6423.582467139621;6451.70967306463;6484.351564843478;6108;6200.441960223601;6260.499160067093;6266.592671476522;6275.686215689106 11:41:15 INFO - PID 23319 | |1;ext.html;769.2000319667543;826.9214424629658;861.7328628125282;882.1046637662771;891.2023738753819;39837.80081099594;39902.40146397799;40453.19093618126;40486.59513404865;40651.79674101629;36927.63072369275;37506.81246593763;37516.81241593788;37537.43693844594;37592.62407375925;6674.365935236145;6768.593884366929;6781.389674929255;6791.151106111736;6822.522423430361;6656;6681.365270299314;6712.295209003058;6724;6798.660066996655;6667.633280169589;7327.487075904689;7516.5114267572435;7540.321371076602;7560.886586701204;7450.739224127156;7509.061367329084;7534.133574638904;7542.396608271325;7544.321011109027;7259.12890453149;7442.367398771111;7468.10382754073;7517.924820751778;7529.774106776806;37178.44232336517;37587.62412375869;37590.43614345787;37597.060073498105;37603.62396376056;3457.481377793326;3463.5324231228965;3505.8422370993367;3513.139280876176;3523.4186359250693;30712.53931191034;30730.231744206572;30743;30764.38471230585;30857.845710771304;4965.528274813887;5020.121478741242;5058.645894787366;5068.82259120929;5105.693658380509;228220;236043;236849;237008;237579;48447.273290900666;48581;48782.75608621934;48890.51109488859;48921.26618100731;51974;52055.47944520582;54570.72714636481;55876.441235587125;55978.16032759512;16815.159242037847;16926.57683557921;16932.661346772995;16957.745633815503;16976.151192440328;13937.930310348384;13975.860241397659;14000.789988150185;14004.089734167246;14024.228667423185;14488.710225795425;14809.481668141563;14834.925825370805;14881.33034013472;15045.924770376078;5798.449147331081;5840.707964601753;5843.707814609337;5865.618734782225;6076.392360763888;990.4404011733347;1010.3887148275335;1018.5976539266948;1018.6180182431589;1022.5909636145601;22891;23116.422089447562;23137.65293520565;23179.884100579387;23614.173503927625;1104.2987702808614;1106.1040557148735;1111.6831702964616;1123.1913022623698;1129.5594718059963;12463.376831158586;12534.122611417113;12609.621711348675;12640.936795315965;12672.49310027607;226587;227961;228437;229383;229987;53649.731751340994;53659.73170134125;53851.19223211655;56370.43629563734;61641.38358616446;1471.2790732540977;1503.5714821275883;1506.5103841251637;1520.3918432626817;1521.4522771802142;28486.715132848407;28778.28054298659;28848;28951.565726514542;29369.85315073411;39325.213495730495;39452.80273598614;39625.603743962194;39661.20677586374;39739.80130099331;205072;205098;206411;206942;208533;36871;36928;37159.44260836144;37331.44002840014;37398.626013739515;41926;44297;44831.103377931606;44883.77558112189;45241.773791130836;33345;33414.33171336608;34208.82895585506;34361;34898;32035.679643204203;32949.83525082359;32972.34055318928;33077.66922330746;33782.324353513286;35847.283054338244;35855.28289434144;35957.82021089982;36052.819735901154;36151.45772813463;31644.367112658078;31885.68114318827;32070.19824504406;32232.83883580567;32636.836815816718;22723.88638056799;23608.29175124749;23656.408589784704;23860.52278954446;23957.52084958326 11:41:15 INFO - PID 23319 | |2;jquery.html;557.785252677719;573.3607028163597;581.7527550790912;584.377637815726;592.5674257791812;21627.134914603415;22224.333270001884;22422.215222467217;22547.098116075358;22574.097036118575;25168.74831251687;27805.165845024632;27807.16578502643;27832.860835695792;27983.860080699567;6921.7923462296085;7109.537880037807;7122.145342558874;7129.215786263533;7137.750178743745;6285.120083188334;6649.9667501662425;6910.75812346568;6967.721291148348;6973.058637084005;6925.757598484054;6930.237673855871;6945.444364450857;6952.443804495653;6995.475339349544;6995.125609298838;7008.929910700905;7010.158780946268;7016.228214896358;7018.684159212848;6818.386345228903;6840.555363901331;6849.657517124174;6858.382745552874;6864.176298844171;30450.54324185117;31095.68904310973;31583.368332633447;31880.362392752246;32109.51835722466;1932.2657390191778;1973.9506512337307;1976.802319768026;1984.5534754680225;1987.3441764217919;20240.49398765028;20589.4852628684;20639.380818575468;20680.17279308826;20915.477113072142;2494.95010099797;2543.6693229879997;2632.1840229528716;2632.5393056215084;2634.380920483685;141295;142765;143026.284868575;144837.27581362132;145182.27408862993;19176.71234931477;21299.46751331198;21782.82171782809;21815.67276490854;22246.88876555607;44866.32700509495;45355.773221133684;45369.546304537194;45512.317315240296;45692.77153614211;11433.428328583537;11626.186166968231;11643.359615221074;11728.824067638992;11842.197323311688;9589.376690515093;9626.855597166048;9663.758406039764;9749.951250243845;9786.41281523111;8783.25342345895;9279.67521136757;9448.952755236318;11027.724306892393;11593.304401735923;2639.920802375932;2720.9047683330987;2745.2450576091337;2763.4749397614387;2857.0857325655593;934.3412893909777;957.090763774417;968.6052084997722;971.4996776660025;996.2826764729383;19694.70457943132;23301.7669823303;25043.87478062598;25152.371190720012;25443.236702898943;1004.6182450668699;1040.1262939131166;1063.473580577619;1063.6808957312776;1065.7282392989894;11241.887581124247;13448.260345680887;14306.427742890375;14448.711025779425;14643.707125857636;510846;525013;533000;539343;540846;120384;122339.38830305792;122771;125186;126019.36990315173;1217.6286232699113;1255.6107606641788;1272.4910035985495;1275.8213850061;1288.5232463988384;21574.568508629425;21703.91480425941;22077;22194.112235510398;22325.665115022963;59932.400675992685;61111.69444152751;61541.69229154005;61609.69195153996;63785.36214637794;70465.64767176131;70757;70804;71035.28964710493;71689;14333.928330358698;15212.315445805187;15263;15287.847121528643;15410.152441615819;23776.4055898597;23991.880040599684;25057.248282551554;25223.621645675696;25278.620820688073;19276.710849337553;19320.32378866733;19482.512937176118;19635.607287853876;19655.70516442283;17540.561485962953;17670;17989.73015404796;18016.2793488259;18334.908325458287;19575.804241957398;19597.31409400664;19946.900265498578;20140.09369578343;20351.59296814085;14831.629209269855;14858.257087145816;14881.47914822976;15054.924725376302;15140.091594504365;17772.822271777117;17941;18299.54251143732;19433.445324374297;19579.70630440573 11:41:15 INFO - PID 23319 | |3;mootools.html;1351.4121357209613;1380.751464736347;1407.7888316752492;1408.9295535223248;1413.1874172350895;14052.578422647312;14556;14674.633134171638;14706.705865882675;14710.926445367759;12186.329751863645;12559.686007849808;12641.367931603429;14120.858791412084;14794.630134246649;2493.7506249375056;2555.105713000444;2563.2054063240457;2567.191334729554;2568.6018667106628;2599.46710924261;2607.569750991084;2672.772814310786;2675.1172113202597;2689.4486630240754;2580.845149291039;2606.2441891851436;2615.659964204651;2627.3037645023987;2634.012245407972;2521.306640673811;2566;2576;2586.5732154194534;2607.4394005288955;2543.1353339864536;2544.402065514603;2558.897644094234;2576.2271318604344;2580.0324878170686;13494.392752326168;13730.725385492335;13736.65658358539;13799.724005519935;13800.93099534506;7537.736179233755;7752.844943101163;7754.728584499516;7815.413843961669;7845.764627061198;4782.378290822171;4976.154053810861;5131.61512886535;5143.588512918957;5157.742112894378;1858.4610462965725;1859.9349022784272;1876.5402476393372;1924.4996300961711;1951.4633475794128;22791.54416911669;23303.88348058266;23307.067717291287;23376.064957401682;23400;6724.327567243236;6809.557378770364;6902.689378977958;6939.583624982517;6954.513184077066;18310.725339119923;18326;18359;18379.264829406675;18401.63196736058;7942.483738556975;8080.474769139987;8087.191280871866;8092.433529652868;8104.554249516215;7053.188883278489;7146.642667866586;7195.604241766649;7202.92797072033;7267.963660181666;5376.973115134399;5544.611877168641;5590.440955904458;5608;5636.267285252973;1568.294267579571;1701.8213087625868;1710.880238383326;1730.480855743272;1738.0093346792207;704.3625518905399;877.1491653096487;888.9422187557788;907.2379201470796;950.2160717408166;8200.097989221182;8427.873581896276;8436.620352084172;8437.620307086196;8573.871391929126;977.1059480575194;986.452518852044;988.204495381225;989.2185173712686;1015.9949200254099;4975.975120124376;5101.821651024214;5167.199084141889;5235.345581802275;5247.10799164143;19003.619927601372;19318.903405482884;19612.313569025016;19840.90079549593;20125;18974.43076707701;19469.12388942501;19769;19928.90035549842;19963.800361996484;10711.785764284827;10921.672349829518;10958.726031849108;11131.165162612837;11145.832812507819;7791.597747272773;7954.125046244792;7995.2804247618;8148.714794982147;8230.958845205736;17020.14899255057;17089.91455042717;17270.395536156175;17753.467395978143;17800;17533.912330438267;17871.553211169823;17981.73027404616;18336.449906502825;18539.721904171718;10837.403942782907;10985.61550345734;11049.447527623426;11068.723281918017;11100.777984440105;13057.477700892237;13130.409131589293;13167;13290.601281961557;13359;10035.949820250851;10658.89341106579;11147.777044459228;11209.607663731731;11413.144014199135;10299.3820370778;10409.895901040893;10457.267991240844;10639.734006649896;10697.197710171613;9290.489023103793;9400.106989835955;9416.717498475056;9428;9434.669786557712;7110.43116550685;7277.963610181915;7282.198958114709;7309.926900731138;7315;7301.853962920818;7303.30618591233;7337.4246608176845;7368.778936631909;7402.499053388748 11:41:15 INFO - PID 23319 | |4;prototype.html;498.76059491444084;506.29877619497006;522.3209827224609;523.9397469291033;526.4209369693338;6111.480524155447;6130.203073600437;6137.601055931373;6162.627388455443;6205.937940620587;6022.156898034279;6024.1566180734735;6040.546958978083;6048.3044449888275;6092.659614884729;4981.1283025470575;5050.217216331465;5066.417362003362;5066.41736200338;5078.898422031557;4991.226359914219;5039.546440820325;5064.518870707296;5066.113430149728;5073.1122053640465;4800.591949684281;4807.4952130026195;4819.855404337875;4871.415430148387;4952.257161425779;4812.783424745895;4852;4887.266909963499;4899.6325275604295;4932.284818701304;4281.614654681093;4384.583464570893;4389.209942210401;4407.289516947055;4426.313921342197;5759.3376761672525;5767.884642307173;5851.297844258674;5856.238688970407;5877.559183061245;5579.804706835242;5596.720163991825;5601.831945041615;5640;5653.745581448845;6403.478087052103;6496.187976502937;6499.415052645285;6505.381988711065;6532.628148088907;4775.188218002948;4835.274708793674;4839.177339852234;4858.5384388483035;4863.392075990501;6485.4487368573255;6744.258131605519;6756.324367563205;6775.661216939183;6871.278515755824;4760.904781904343;4919.286703428054;4926.45808961014;4946.777395017233;4956.3804524434445;4964.517741129435;5024.346834911438;5029.572486338702;5032.245163225545;5051.318072060299;5506.1190209566275;5546.473085056913;5547.278853748987;5574.526165275915;5574.86062848432;6380;6449.451796597342;6490;6512.41388275048;6528.281888992207;1735.0977491704496;1745.860331173503;1758.788945326569;1760.542259012666;1772.645470905824;1156.3004382348558;1221.5785553983862;1223.1988047828686;1231.9938400307942;1243.533674871923;5560.527355174855;5571.804986825442;5706.4864162225595;5722.4277572242445;5775.249217601685;6524.6737663116655;6613.966930165415;6632.502562307846;6656.600603963778;6705.631190284581;5645.463680950304;5665.12190610456;5701.486866182064;5742.48317651405;5767.106098554731;3408.948865766966;3458.4985177149674;3477.7132460989596;3520.753547251668;3536.1866770642896;6437.645929473924;6474.255460621995;6483.481321494269;6511.837204069841;6512.641804700692;6687.465002799861;6724.630145342053;6814.557053791487;6833.624150671761;6865.210500792473;6299.1811064562235;6328.456064603744;6341.841453963688;6364.649944252926;6464;6562.967185164043;6570.532038214061;6598.1422415085735;6607.372299631527;6643.634600096848;6539.411452969255;6570.145881035626;6586.341365863567;6596.5052621052655;6642.236142843635;6408.359164083555;6412.487001039813;6425.8714825704155;6551.901721474277;6586.637734924625;4914.827981020647;4955.851324460272;4959.404871415453;4970.155073637563;4985.102681517216;6474.611523308617;6482.902756458562;6619.834504137242;6697.296783837627;6763.729450821912;6417.791104447776;6425.389587989133;6439.388258115471;6482.092507048923;6528.575642583217;6295.779647712308;6344.206974128234;6369.9681501592195;6376.840578985377;6378.2983871774995;6115.602485838406;6226.62640241587;6343.111964324906;6350.142730731477;6437.903431448625;6419.839504012437;6455.256515980784;6462.5153113515735;6507.772227971998;6560.639164845788;6229.937700622936;6264.937350626436;6300.086487459384;6360.363963603602;6398.968005159944 11:41:15 INFO - PID 23319 | |5;yui.html;887.0597167002974;897.5646811296524;906.4697152165983;906.7869050773071;921.6129225725194;18912.71630925537;19900.90049549752;20004;20046.899765501188;20056.896870672124;20394.69407958882;21408.036638351274;21496.247631332906;21570.13719451224;21782.237621683205;982.302565178724;995.3778888194878;997.2620261006875;1003.9046290602417;1003.934744241622;1014.8477728340735;1018.8981101889789;1021.7037059252808;1022.626741239446;1031.2626472072466;1004.1665417703289;1042.0829669890525;1078.2560033576806;1083.864516935383;1093.3767752381145;1069.2141276162015;1072.1958531101673;1076.6662334676237;1080.200651517875;1085.3379438542484;764.1556080531044;776.1307335783902;783.0877028262067;786.5516655506364;787.7282337593521;20022.69965950512;20196.394108176777;20280.391588252376;20440.795592044036;20687.379378618665;21398.358049258546;21844.89077554618;22038.88980555087;22404;22423;16479.588010299718;16749.413770517975;16875.662486750196;16919.830801691947;17074.402395916208;3676.5477636333767;3722.8324725387424;3728.217074414349;3746.4754934308944;3751.8874433767032;120200;122175;123717.38141309326;124654;125637;16407.5898102546;16920.830791692173;16937.661246775242;16962.15189240533;16965.830341696674;30365;30729.385412292075;31131.533027004614;31415.057548273588;31462.842685786425;8581.270591999624;8603.31173506118;8654.826903461895;8694.782630434163;8734.30125589964;4244.554321796229;4275.850345237902;4349.869503914888;4351.73889566627;4366.410534577855;4752.405949256343;5028.17035189197;5153.871153221199;5156.793728250828;5177.896442071137;882.7175303902818;985.2413641496152;1067.6263307842194;1071.3786004117594;1078;662.7945336945562;678.1692426777257;680.7923583307139;686.2656957055902;695.5166159519085;12010.159288849696;12307;12666.683332916751;12983.415746291439;12999.675008124872;670.8624731929942;672.6603065451916;677.7221339250883;677.8745932002595;692.5290802254415;5576.1356989666665;5750.741216645261;5765.654060756368;5808.912866307009;5824;109568.4521577387;110133.44933275443;112222;113704.43147784208;113954;94359.52820235993;96660;96929.25233317883;96971.51514242525;97912;87396.56301718578;87780;88201.55899220463;89191.55404222937;89345.55327223323;10582.788344232918;10854.131669466582;10942.452877355941;11028.28316159447;12702.87297127017;38858.6114138855;39526.60473395229;39734.80132599434;39818.2036359277;40639.79680101581;70227.29772702207;71004.28995709977;72999.63500182464;73753;74680.25319746733;17601.471955841345;18069.81930180734;19947.401577952685;20455.69316460284;20704.48238793982;22231.333060008226;23032.539349212588;23167;23442.17952371659;23782.643260351455;20235.19059237673;20720.48198795042;20808.063637136063;21108;21264.574708505435;18789.6242075155;19190.520236994187;19497.902510487358;20164.49588760234;21130.788692113496;18832.435026949213;19194.904025479784;20038.699419508426;20165.193392264144;20704.378868633965;12950.546730864375;13172.341382931007;13448;13626.659333516742;13641.181529108286;13942.721145577234;14462.493812716504;14707.852921470649;14720.779188312397;14754.704905902037 11:41:15 INFO - PID 23319 | __end_tp_report 11:41:15 INFO - PID 23319 | __start_cc_report 11:41:15 INFO - PID 23319 | _x_x_mozilla_cycle_collect,358 11:41:15 INFO - PID 23319 | __end_cc_report 11:41:15 INFO - PID 23319 | __startTimestamp1502995275952__endTimestamp 11:41:15 INFO - PID 23319 | 11:41:15 INFO - PID 23319 | ------- Summary: start ------- 11:41:15 INFO - PID 23319 | Number of tests: 6 11:41:15 INFO - PID 23319 | 11:41:15 INFO - PID 23319 | [#0] dojo.html Cycles:165 Average:6051.51 Median:6317.84 stddev:705.09 (11.2%) stddev-sans-first:668.98 11:41:15 INFO - PID 23319 | Values: 3130.7 3144.7 3154.0 3178.7 3182.5 6012.6 6096.8 6102.2 6147.1 6148.6 5991.7 6125.4 6129.5 6188.7 6196.5 5566.7 5596.7 5613.8 5673.9 5689.6 5500.5 5553.6 5587.9 5636.4 5682.0 5529.5 5588.0 5590.0 5610.3 5615.0 5478.7 5560.0 5581.1 5604.3 5628.3 5409.0 5419.6 5465.2 5478.0 5522.8 6040.0 6047.5 6090.1 6094.6 6129.4 6496.5 6510.5 6550.3 6554.8 6629.4 6498.3 6572.2 6641.8 6691.6 6698.8 6024.3 6047.2 6064.0 6065.8 6090.5 6561.9 6673.0 6689.7 6703.8 6706.7 6320.1 6359.1 6361.1 6423.4 6424.2 6590.3 6602.6 6612.7 6623.9 6630.5 6469.8 6543.8 6573.5 6590.1 6641.8 6532.8 6565.0 6630.7 6653.8 6655.1 5299.1 5306.8 5352.8 5370.9 5408.9 4617.7 4670.7 4680.5 4683.0 4693.1 5787.5 5836.7 5845.4 5847.3 5854.7 6613.1 6617.5 6688.3 6700.0 6705.4 5603.1 5737.7 5748.6 5774.8 5820.4 5734.6 5851.4 5851.6 5854.8 5858.9 6405.8 6415.5 6423.0 6450.0 6478.6 6614.4 6622.2 6691.2 6692.0 6726.1 6406.1 6431.7 6470.2 6500.7 6563.9 6447.1 6482.6 6506.3 6529.2 6532.2 6496.9 6605.5 6611.0 6628.7 6632.2 6375.7 6397.5 6422.1 6426.4 6430.6 6317.8 6368.7 6400.4 6402.1 6408.7 5433.7 6225.3 6340.1 6357.7 6360.7 6381.4 6413.3 6423.6 6451.7 6484.4 6108.0 6200.4 6260.5 6266.6 6275.7 11:41:15 INFO - PID 23319 | 11:41:15 INFO - PID 23319 | [#1] ext.html Cycles:180 Average:39423.45 Median:35906.55 stddev:58030.69 (161.6%) stddev-sans-first:58120.89 11:41:15 INFO - PID 23319 | Values: 769.2 826.9 861.7 882.1 891.2 39837.8 39902.4 40453.2 40486.6 40651.8 36927.6 37506.8 37516.8 37537.4 37592.6 6674.4 6768.6 6781.4 6791.2 6822.5 6656.0 6681.4 6712.3 6724.0 6798.7 6667.6 7327.5 7516.5 7540.3 7560.9 7450.7 7509.1 7534.1 7542.4 7544.3 7259.1 7442.4 7468.1 7517.9 7529.8 37178.4 37587.6 37590.4 37597.1 37603.6 3457.5 3463.5 3505.8 3513.1 3523.4 30712.5 30730.2 30743.0 30764.4 30857.8 4965.5 5020.1 5058.6 5068.8 5105.7 228220.0 236043.0 236849.0 237008.0 237579.0 48447.3 48581.0 48782.8 48890.5 48921.3 51974.0 52055.5 54570.7 55876.4 55978.2 16815.2 16926.6 16932.7 16957.7 16976.2 13937.9 13975.9 14000.8 14004.1 14024.2 14488.7 14809.5 14834.9 14881.3 15045.9 5798.4 5840.7 5843.7 5865.6 6076.4 990.4 1010.4 1018.6 1018.6 1022.6 22891.0 23116.4 23137.7 23179.9 23614.2 1104.3 1106.1 1111.7 1123.2 1129.6 12463.4 12534.1 12609.6 12640.9 12672.5 226587.0 227961.0 228437.0 229383.0 229987.0 53649.7 53659.7 53851.2 56370.4 61641.4 1471.3 1503.6 1506.5 1520.4 1521.5 28486.7 28778.3 28848.0 28951.6 29369.9 39325.2 39452.8 39625.6 39661.2 39739.8 205072.0 205098.0 206411.0 206942.0 208533.0 36871.0 36928.0 37159.4 37331.4 37398.6 41926.0 44297.0 44831.1 44883.8 45241.8 33345.0 33414.3 34208.8 34361.0 34898.0 32035.7 32949.8 32972.3 33077.7 33782.3 35847.3 35855.3 35957.8 36052.8 36151.5 31644.4 31885.7 32070.2 32232.8 32636.8 22723.9 23608.3 23656.4 23860.5 23957.5 11:41:15 INFO - PID 23319 | 11:41:15 INFO - PID 23319 | [#2] jquery.html Cycles:180 Average:37902.71 Median:13243.42 stddev:88945.22 (671.6%) stddev-sans-first:89150.54 11:41:15 INFO - PID 23319 | Values: 557.8 573.4 581.8 584.4 592.6 21627.1 22224.3 22422.2 22547.1 22574.1 25168.7 27805.2 27807.2 27832.9 27983.9 6921.8 7109.5 7122.1 7129.2 7137.8 6285.1 6650.0 6910.8 6967.7 6973.1 6925.8 6930.2 6945.4 6952.4 6995.5 6995.1 7008.9 7010.2 7016.2 7018.7 6818.4 6840.6 6849.7 6858.4 6864.2 30450.5 31095.7 31583.4 31880.4 32109.5 1932.3 1974.0 1976.8 1984.6 1987.3 20240.5 20589.5 20639.4 20680.2 20915.5 2495.0 2543.7 2632.2 2632.5 2634.4 141295.0 142765.0 143026.3 144837.3 145182.3 19176.7 21299.5 21782.8 21815.7 22246.9 44866.3 45355.8 45369.5 45512.3 45692.8 11433.4 11626.2 11643.4 11728.8 11842.2 9589.4 9626.9 9663.8 9750.0 9786.4 8783.3 9279.7 9449.0 11027.7 11593.3 2639.9 2720.9 2745.2 2763.5 2857.1 934.3 957.1 968.6 971.5 996.3 19694.7 23301.8 25043.9 25152.4 25443.2 1004.6 1040.1 1063.5 1063.7 1065.7 11241.9 13448.3 14306.4 14448.7 14643.7 510846.0 525013.0 533000.0 539343.0 540846.0 120384.0 122339.4 122771.0 125186.0 126019.4 1217.6 1255.6 1272.5 1275.8 1288.5 21574.6 21703.9 22077.0 22194.1 22325.7 59932.4 61111.7 61541.7 61609.7 63785.4 70465.6 70757.0 70804.0 71035.3 71689.0 14333.9 15212.3 15263.0 15287.8 15410.2 23776.4 23991.9 25057.2 25223.6 25278.6 19276.7 19320.3 19482.5 19635.6 19655.7 17540.6 17670.0 17989.7 18016.3 18334.9 19575.8 19597.3 19946.9 20140.1 20351.6 14831.6 14858.3 14881.5 15054.9 15140.1 17772.8 17941.0 18299.5 19433.4 19579.7 11:41:15 INFO - PID 23319 | 11:41:15 INFO - PID 23319 | [#3] mootools.html Cycles:180 Average:8891.97 Median:2557.00 stddev:6092.97 (238.3%) stddev-sans-first:6083.72 11:41:15 INFO - PID 23319 | Values: 1351.4 1380.8 1407.8 1408.9 1413.2 14052.6 14556.0 14674.6 14706.7 14710.9 12186.3 12559.7 12641.4 14120.9 14794.6 2493.8 2555.1 2563.2 2567.2 2568.6 2599.5 2607.6 2672.8 2675.1 2689.4 2580.8 2606.2 2615.7 2627.3 2634.0 2521.3 2566.0 2576.0 2586.6 2607.4 2543.1 2544.4 2558.9 2576.2 2580.0 13494.4 13730.7 13736.7 13799.7 13800.9 7537.7 7752.8 7754.7 7815.4 7845.8 4782.4 4976.2 5131.6 5143.6 5157.7 1858.5 1859.9 1876.5 1924.5 1951.5 22791.5 23303.9 23307.1 23376.1 23400.0 6724.3 6809.6 6902.7 6939.6 6954.5 18310.7 18326.0 18359.0 18379.3 18401.6 7942.5 8080.5 8087.2 8092.4 8104.6 7053.2 7146.6 7195.6 7202.9 7268.0 5377.0 5544.6 5590.4 5608.0 5636.3 1568.3 1701.8 1710.9 1730.5 1738.0 704.4 877.1 888.9 907.2 950.2 8200.1 8427.9 8436.6 8437.6 8573.9 977.1 986.5 988.2 989.2 1016.0 4976.0 5101.8 5167.2 5235.3 5247.1 19003.6 19318.9 19612.3 19840.9 20125.0 18974.4 19469.1 19769.0 19928.9 19963.8 10711.8 10921.7 10958.7 11131.2 11145.8 7791.6 7954.1 7995.3 8148.7 8231.0 17020.1 17089.9 17270.4 17753.5 17800.0 17533.9 17871.6 17981.7 18336.4 18539.7 10837.4 10985.6 11049.4 11068.7 11100.8 13057.5 13130.4 13167.0 13290.6 13359.0 10035.9 10658.9 11147.8 11209.6 11413.1 10299.4 10409.9 10457.3 10639.7 10697.2 9290.5 9400.1 9416.7 9428.0 9434.7 7110.4 7278.0 7282.2 7309.9 7315.0 7301.9 7303.3 7337.4 7368.8 7402.5 11:41:15 INFO - PID 23319 | 11:41:15 INFO - PID 23319 | [#4] prototype.html Cycles:180 Average:5431.71 Median:6023.16 stddev:1517.89 (25.2%) stddev-sans-first:1476.30 11:41:15 INFO - PID 23319 | Values: 498.8 506.3 522.3 523.9 526.4 6111.5 6130.2 6137.6 6162.6 6205.9 6022.2 6024.2 6040.5 6048.3 6092.7 4981.1 5050.2 5066.4 5066.4 5078.9 4991.2 5039.5 5064.5 5066.1 5073.1 4800.6 4807.5 4819.9 4871.4 4952.3 4812.8 4852.0 4887.3 4899.6 4932.3 4281.6 4384.6 4389.2 4407.3 4426.3 5759.3 5767.9 5851.3 5856.2 5877.6 5579.8 5596.7 5601.8 5640.0 5653.7 6403.5 6496.2 6499.4 6505.4 6532.6 4775.2 4835.3 4839.2 4858.5 4863.4 6485.4 6744.3 6756.3 6775.7 6871.3 4760.9 4919.3 4926.5 4946.8 4956.4 4964.5 5024.3 5029.6 5032.2 5051.3 5506.1 5546.5 5547.3 5574.5 5574.9 6380.0 6449.5 6490.0 6512.4 6528.3 1735.1 1745.9 1758.8 1760.5 1772.6 1156.3 1221.6 1223.2 1232.0 1243.5 5560.5 5571.8 5706.5 5722.4 5775.2 6524.7 6614.0 6632.5 6656.6 6705.6 5645.5 5665.1 5701.5 5742.5 5767.1 3408.9 3458.5 3477.7 3520.8 3536.2 6437.6 6474.3 6483.5 6511.8 6512.6 6687.5 6724.6 6814.6 6833.6 6865.2 6299.2 6328.5 6341.8 6364.6 6464.0 6563.0 6570.5 6598.1 6607.4 6643.6 6539.4 6570.1 6586.3 6596.5 6642.2 6408.4 6412.5 6425.9 6551.9 6586.6 4914.8 4955.9 4959.4 4970.2 4985.1 6474.6 6482.9 6619.8 6697.3 6763.7 6417.8 6425.4 6439.4 6482.1 6528.6 6295.8 6344.2 6370.0 6376.8 6378.3 6115.6 6226.6 6343.1 6350.1 6437.9 6419.8 6455.3 6462.5 6507.8 6560.6 6229.9 6264.9 6300.1 6360.4 6399.0 11:41:15 INFO - PID 23319 | 11:41:15 INFO - PID 23319 | [#5] yui.html Cycles:180 Average:24188.88 Median:21331.47 stddev:32103.55 (150.5%) stddev-sans-first:32145.93 11:41:15 INFO - PID 23319 | Values: 887.1 897.6 906.5 906.8 921.6 18912.7 19900.9 20004.0 20046.9 20056.9 20394.7 21408.0 21496.2 21570.1 21782.2 982.3 995.4 997.3 1003.9 1003.9 1014.8 1018.9 1021.7 1022.6 1031.3 1004.2 1042.1 1078.3 1083.9 1093.4 1069.2 1072.2 1076.7 1080.2 1085.3 764.2 776.1 783.1 786.6 787.7 20022.7 20196.4 20280.4 20440.8 20687.4 21398.4 21844.9 22038.9 22404.0 22423.0 16479.6 16749.4 16875.7 16919.8 17074.4 3676.5 3722.8 3728.2 3746.5 3751.9 120200.0 122175.0 123717.4 124654.0 125637.0 16407.6 16920.8 16937.7 16962.2 16965.8 30365.0 30729.4 31131.5 31415.1 31462.8 8581.3 8603.3 8654.8 8694.8 8734.3 4244.6 4275.9 4349.9 4351.7 4366.4 4752.4 5028.2 5153.9 5156.8 5177.9 882.7 985.2 1067.6 1071.4 1078.0 662.8 678.2 680.8 686.3 695.5 12010.2 12307.0 12666.7 12983.4 12999.7 670.9 672.7 677.7 677.9 692.5 5576.1 5750.7 5765.7 5808.9 5824.0 109568.5 110133.4 112222.0 113704.4 113954.0 94359.5 96660.0 96929.3 96971.5 97912.0 87396.6 87780.0 88201.6 89191.6 89345.6 10582.8 10854.1 10942.5 11028.3 12702.9 38858.6 39526.6 39734.8 39818.2 40639.8 70227.3 71004.3 72999.6 73753.0 74680.3 17601.5 18069.8 19947.4 20455.7 20704.5 22231.3 23032.5 23167.0 23442.2 23782.6 20235.2 20720.5 20808.1 21108.0 21264.6 18789.6 19190.5 19497.9 20164.5 21130.8 18832.4 19194.9 20038.7 20165.2 20704.4 12950.5 13172.3 13448.0 13626.7 13641.2 13942.7 14462.5 14707.9 14720.8 14754.7 11:41:15 INFO - PID 23319 | -------- Summary: end -------- 11:41:15 INFO - PID 23319 | 11:41:16 INFO - TEST-INFO | 23319: exit 0 11:41:16 INFO - TEST-OK | dromaeo_css | took 1115297ms 11:41:16 INFO - TEST-START | kraken 11:41:16 INFO - Initialising browser for kraken test... 11:41:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38841/getInfo.html -profile /tmp/tmpQbAq4h/profile 11:41:16 INFO - TEST-INFO | started process 23702 (/builds/slave/test/build/application/firefox/firefox http://localhost:38841/getInfo.html) 11:41:22 INFO - TEST-INFO | 23702: exit 0 11:41:22 INFO - Browser initialized. 11:41:22 INFO - Running cycle 1/1 for kraken test... 11:41:22 INFO - TEST-INFO | started process 23883 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQbAq4h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:41:23 INFO - PID 23883 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:41:23 INFO - PID 23883 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:41:23 INFO - PID 23883 | 11:41:23 INFO - PID 23883 | (/builds/slave/test/build/application/firefox/firefox:23942): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:41:23 INFO - PID 23883 | 11:41:34 INFO - PID 23883 | RSS: Main: 195309568 11:41:34 INFO - PID 23883 | 11:41:36 INFO - PID 23883 | Cycle 1(1): loaded http://localhost:38841/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38841/tests/kraken/driver.html?testName=audio-beat-detection) 11:41:37 INFO - PID 23883 | RSS: Main: 203788288 11:41:37 INFO - PID 23883 | 11:41:40 INFO - PID 23883 | Cycle 1(1): loaded http://localhost:38841/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38841/tests/kraken/driver.html?testName=audio-dft) 11:41:41 INFO - PID 23883 | RSS: Main: 204382208 11:41:41 INFO - PID 23883 | 11:41:44 INFO - PID 23883 | Cycle 1(1): loaded http://localhost:38841/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38841/tests/kraken/driver.html?testName=audio-fft) 11:41:44 INFO - PID 23883 | RSS: Main: 199180288 11:41:44 INFO - PID 23883 | 11:41:47 INFO - PID 23883 | Cycle 1(1): loaded http://localhost:38841/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38841/tests/kraken/driver.html?testName=audio-oscillator) 11:41:47 INFO - PID 23883 | RSS: Main: 197820416 11:41:47 INFO - PID 23883 | 11:41:49 INFO - PID 23883 | Cycle 1(1): loaded http://localhost:38841/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38841/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:41:50 INFO - PID 23883 | RSS: Main: 213094400 11:41:50 INFO - PID 23883 | 11:41:53 INFO - PID 23883 | Cycle 1(1): loaded http://localhost:38841/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38841/tests/kraken/driver.html?testName=imaging-darkroom) 11:41:54 INFO - PID 23883 | RSS: Main: 216092672 11:41:54 INFO - PID 23883 | 11:41:57 INFO - PID 23883 | Cycle 1(1): loaded http://localhost:38841/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38841/tests/kraken/driver.html?testName=imaging-desaturate) 11:41:58 INFO - PID 23883 | RSS: Main: 215629824 11:41:58 INFO - PID 23883 | 11:42:01 INFO - PID 23883 | Cycle 1(1): loaded http://localhost:38841/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38841/tests/kraken/driver.html?testName=json-parse-financial) 11:42:02 INFO - PID 23883 | RSS: Main: 216023040 11:42:02 INFO - PID 23883 | 11:42:03 INFO - PID 23883 | Cycle 1(1): loaded http://localhost:38841/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38841/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:42:04 INFO - PID 23883 | RSS: Main: 216096768 11:42:04 INFO - PID 23883 | 11:42:06 INFO - PID 23883 | Cycle 1(1): loaded http://localhost:38841/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38841/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:42:06 INFO - PID 23883 | RSS: Main: 216104960 11:42:06 INFO - PID 23883 | 11:42:09 INFO - PID 23883 | Cycle 1(1): loaded http://localhost:38841/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38841/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:42:09 INFO - PID 23883 | RSS: Main: 216215552 11:42:09 INFO - PID 23883 | 11:42:12 INFO - PID 23883 | Cycle 1(1): loaded http://localhost:38841/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38841/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:42:13 INFO - PID 23883 | RSS: Main: 216055808 11:42:13 INFO - PID 23883 | 11:42:16 INFO - PID 23883 | Cycle 1(1): loaded http://localhost:38841/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38841/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:42:16 INFO - PID 23883 | RSS: Main: 217030656 11:42:16 INFO - PID 23883 | 11:42:18 INFO - PID 23883 | Cycle 1(1): loaded http://localhost:38841/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38841/tests/kraken/driver.html?testName=ai-astar) 11:42:19 INFO - PID 23883 | RSS: Main: 218705920 11:42:19 INFO - PID 23883 | 11:42:19 INFO - PID 23883 | __start_tp_report 11:42:19 INFO - PID 23883 | _x_x_mozilla_page_load 11:42:19 INFO - PID 23883 | _x_x_mozilla_page_load_details 11:42:19 INFO - PID 23883 | |i|pagename|runs| 11:42:19 INFO - PID 23883 | |0;ai-astar;103;113;109;111;109;120;117;106;114;114 11:42:19 INFO - PID 23883 | |1;audio-beat-detection;147;118;147;175;132;155;150;127;177;125 11:42:19 INFO - PID 23883 | |2;audio-dft;171;166;163;171;168;170;172;168;177;166 11:42:19 INFO - PID 23883 | |3;audio-fft;79;81;91;173;80;76;83;79;150;76 11:42:19 INFO - PID 23883 | |4;audio-oscillator;83;82;143;88;85;79;123;88;85;133 11:42:19 INFO - PID 23883 | |5;imaging-gaussian-blur;121;120;114;121;118;118;115;117;119;122 11:42:19 INFO - PID 23883 | |6;imaging-darkroom;149;155;154;152;153;154;151;151;155;153 11:42:19 INFO - PID 23883 | |7;imaging-desaturate;94;101;95;95;95;103;96;97;94;95 11:42:19 INFO - PID 23883 | |8;json-parse-financial;61;55;55;53;54;54;54;54;64;54 11:42:19 INFO - PID 23883 | |9;json-stringify-tinderbox;56;55;55;63;55;59;55;65;60;60 11:42:19 INFO - PID 23883 | |10;stanford-crypto-aes;85;97;78;83;79;85;80;87;76;77 11:42:19 INFO - PID 23883 | |11;stanford-crypto-ccm;127;127;131;130;132;128;139;129;132;156 11:42:19 INFO - PID 23883 | |12;stanford-crypto-pbkdf2;185;178;179;186;186;191;175;184;180;178 11:42:19 INFO - PID 23883 | |13;stanford-crypto-sha256-iterative;68;68;69;78;70;69;69;72;72;67 11:42:19 INFO - PID 23883 | __end_tp_report 11:42:19 INFO - PID 23883 | __start_cc_report 11:42:19 INFO - PID 23883 | _x_x_mozilla_cycle_collect,947 11:42:19 INFO - PID 23883 | __end_cc_report 11:42:19 INFO - PID 23883 | __startTimestamp1502995339024__endTimestamp 11:42:19 INFO - PID 23883 | 11:42:19 INFO - PID 23883 | ------- Summary: start ------- 11:42:19 INFO - PID 23883 | Number of tests: 14 11:42:19 INFO - PID 23883 | 11:42:19 INFO - PID 23883 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.50 stddev:5.08 (4.5%) stddev-sans-first:4.33 11:42:19 INFO - PID 23883 | Values: 103.0 113.0 109.0 111.0 109.0 120.0 117.0 106.0 114.0 114.0 11:42:19 INFO - PID 23883 | 11:42:19 INFO - PID 23883 | [#1] audio-beat-detection Cycles:10 Average:145.30 Median:148.50 stddev:20.22 (13.6%) stddev-sans-first:21.43 11:42:19 INFO - PID 23883 | Values: 147.0 118.0 147.0 175.0 132.0 155.0 150.0 127.0 177.0 125.0 11:42:19 INFO - PID 23883 | 11:42:19 INFO - PID 23883 | [#2] audio-dft Cycles:10 Average:169.20 Median:170.50 stddev:3.91 (2.3%) stddev-sans-first:4.09 11:42:19 INFO - PID 23883 | Values: 171.0 166.0 163.0 171.0 168.0 170.0 172.0 168.0 177.0 166.0 11:42:19 INFO - PID 23883 | 11:42:19 INFO - PID 23883 | [#3] audio-fft Cycles:10 Average:96.80 Median:79.50 stddev:34.79 (43.8%) stddev-sans-first:36.30 11:42:19 INFO - PID 23883 | Values: 79.0 81.0 91.0 173.0 80.0 76.0 83.0 79.0 150.0 76.0 11:42:19 INFO - PID 23883 | 11:42:19 INFO - PID 23883 | [#4] audio-oscillator Cycles:10 Average:98.90 Median:84.00 stddev:24.15 (28.7%) stddev-sans-first:24.91 11:42:19 INFO - PID 23883 | Values: 83.0 82.0 143.0 88.0 85.0 79.0 123.0 88.0 85.0 133.0 11:42:19 INFO - PID 23883 | 11:42:19 INFO - PID 23883 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:119.50 stddev:2.64 (2.2%) stddev-sans-first:2.64 11:42:19 INFO - PID 23883 | Values: 121.0 120.0 114.0 121.0 118.0 118.0 115.0 117.0 119.0 122.0 11:42:19 INFO - PID 23883 | 11:42:19 INFO - PID 23883 | [#6] imaging-darkroom Cycles:10 Average:152.70 Median:153.50 stddev:1.95 (1.3%) stddev-sans-first:1.54 11:42:19 INFO - PID 23883 | Values: 149.0 155.0 154.0 152.0 153.0 154.0 151.0 151.0 155.0 153.0 11:42:19 INFO - PID 23883 | 11:42:19 INFO - PID 23883 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:95.00 stddev:3.06 (3.2%) stddev-sans-first:3.11 11:42:19 INFO - PID 23883 | Values: 94.0 101.0 95.0 95.0 95.0 103.0 96.0 97.0 94.0 95.0 11:42:19 INFO - PID 23883 | 11:42:19 INFO - PID 23883 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:54.50 stddev:3.65 (6.7%) stddev-sans-first:3.35 11:42:19 INFO - PID 23883 | Values: 61.0 55.0 55.0 53.0 54.0 54.0 54.0 54.0 64.0 54.0 11:42:19 INFO - PID 23883 | 11:42:19 INFO - PID 23883 | [#9] json-stringify-tinderbox Cycles:10 Average:58.30 Median:59.50 stddev:3.68 (6.2%) stddev-sans-first:3.81 11:42:19 INFO - PID 23883 | Values: 56.0 55.0 55.0 63.0 55.0 59.0 55.0 65.0 60.0 60.0 11:42:19 INFO - PID 23883 | 11:42:19 INFO - PID 23883 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:84.00 stddev:6.27 (7.5%) stddev-sans-first:6.60 11:42:19 INFO - PID 23883 | Values: 85.0 97.0 78.0 83.0 79.0 85.0 80.0 87.0 76.0 77.0 11:42:19 INFO - PID 23883 | 11:42:19 INFO - PID 23883 | [#11] stanford-crypto-ccm Cycles:10 Average:133.10 Median:131.50 stddev:8.77 (6.7%) stddev-sans-first:9.02 11:42:19 INFO - PID 23883 | Values: 127.0 127.0 131.0 130.0 132.0 128.0 139.0 129.0 132.0 156.0 11:42:19 INFO - PID 23883 | 11:42:19 INFO - PID 23883 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.20 Median:184.50 stddev:4.94 (2.7%) stddev-sans-first:5.13 11:42:19 INFO - PID 23883 | Values: 185.0 178.0 179.0 186.0 186.0 191.0 175.0 184.0 180.0 178.0 11:42:19 INFO - PID 23883 | 11:42:19 INFO - PID 23883 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:69.50 stddev:3.19 (4.6%) stddev-sans-first:3.28 11:42:19 INFO - PID 23883 | Values: 68.0 68.0 69.0 78.0 70.0 69.0 69.0 72.0 72.0 67.0 11:42:19 INFO - PID 23883 | -------- Summary: end -------- 11:42:19 INFO - PID 23883 | 11:42:19 INFO - PID 23883 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:42:19 INFO - TEST-INFO | 23883: exit 0 11:42:19 INFO - TEST-OK | kraken | took 62943ms 11:42:19 INFO - SUITE-END | took 1178s 11:42:20 INFO - Completed test suite (00:19:38) 11:42:20 INFO - javascript benchmark 11:42:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8626.942587581432, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3130.7182353588187, 3144.6855314468544, 3154.038018404387, 3178.6821317868216, 3182.5226216067585, 6012.5791194616395, 6096.847578810521, 6102.176206212154, 6147.077938309256, 6148.600340977833, 5991.730372133254, 6125.387461253872, 6129.509639228862, 6188.690565471719, 6196.535259855517, 5566.666000039991, 5596.664200147984, 5613.775448982035, 5673.886522269552, 5689.573282003846, 5500.532454741332, 5553.555715542767, 5587.916181257285, 5636.379998200195, 5681.971590142043, 5529.529989950859, 5588.0, 5590.02174619442, 5610.326760788711, 5614.961232172041, 5478.671279723229, 5560.0, 5581.10702287632, 5604.299462567179, 5628.296462942132, 5409.026375252453, 5419.647722898038, 5465.207544905967, 5477.959187754314, 5522.834314970517, 6040.0, 6047.455728984412, 6090.116933044684, 6094.6038507497315, 6129.448349648508, 6496.5127615428555, 6510.511711621647, 6550.2794692583775, 6554.80335589933, 6629.403353698142, 6498.252700939405, 6572.178477690289, 6641.7675381361905, 6691.6319602421845, 6698.799036028927, 6024.337322894478, 6047.15339852421, 6063.969680151571, 6065.757369705207, 6090.482309003695, 6561.901571476432, 6673.03241030048, 6689.665516724144, 6703.765368212089, 6706.731730730814, 6320.083587879823, 6359.07793369968, 6361.109444677749, 6423.357664233539, 6424.164858568356, 6590.3080176581725, 6602.60384376939, 6612.702428390734, 6623.933760662332, 6630.535862489676, 6469.838254043687, 6543.8364040898405, 6573.539852210395, 6590.077389165521, 6641.800745977628, 6532.804015879531, 6564.967175164189, 6630.701618427182, 6653.833654158588, 6655.0682904393425, 5299.12564426873, 5306.8407947761625, 5352.839414817562, 5370.91943620846, 5408.891822163613, 4617.746023968647, 4670.673052886334, 4680.508546602626, 4682.9765851171205, 4693.108309421199, 5787.450192231731, 5836.737346819404, 5845.444682755132, 5847.3275573308765, 5854.677992710442, 6613.140291762136, 6617.503687223478, 6688.297728738413, 6700.0, 6705.430038446689, 5603.075492543766, 5737.684427356536, 5748.5688573357165, 5774.769009239667, 5820.35976042635, 5734.598578099576, 5851.444112809277, 5851.561132915049, 5854.795082172103, 5858.882822343529, 6405.807825765234, 6415.486761059104, 6422.967885160638, 6450.0, 6478.611283323015, 6614.437772789367, 6622.238442579165, 6691.230508491391, 6692.0, 6726.091977583159, 6406.135171751754, 6431.710573024132, 6470.22357317125, 6500.739970401131, 6563.901541476977, 6447.097406363207, 6482.611043337415, 6506.316836732075, 6529.183852018497, 6532.248791388861, 6496.902546461902, 6605.47156227491, 6611.041398997022, 6628.668566571556, 6632.1709786276715, 6375.713092910923, 6397.520185985976, 6422.100905873088, 6426.3573642635365, 6430.64631445275, 6317.842053948688, 6368.745250189941, 6400.359964003563, 6402.071699603624, 6408.743650253938, 5433.701146436984, 6225.315215326401, 6340.080688300263, 6357.650329231937, 6360.650164240826, 6381.3937675920715, 6413.326600707045, 6423.582467139621, 6451.70967306463, 6484.351564843478, 6108.0, 6200.441960223601, 6260.499160067093, 6266.592671476522, 6275.686215689106], "value": 6000.140496548289, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.2000319667543, 826.9214424629658, 861.7328628125282, 882.1046637662771, 891.2023738753819, 39837.80081099594, 39902.40146397799, 40453.19093618126, 40486.59513404865, 40651.79674101629, 36927.63072369275, 37506.81246593763, 37516.81241593788, 37537.43693844594, 37592.62407375925, 6674.365935236145, 6768.593884366929, 6781.389674929255, 6791.151106111736, 6822.522423430361, 6656.0, 6681.365270299314, 6712.295209003058, 6724.0, 6798.660066996655, 6667.633280169589, 7327.487075904689, 7516.5114267572435, 7540.321371076602, 7560.886586701204, 7450.739224127156, 7509.061367329084, 7534.133574638904, 7542.396608271325, 7544.321011109027, 7259.12890453149, 7442.367398771111, 7468.10382754073, 7517.924820751778, 7529.774106776806, 37178.44232336517, 37587.62412375869, 37590.43614345787, 37597.060073498105, 37603.62396376056, 3457.481377793326, 3463.5324231228965, 3505.8422370993367, 3513.139280876176, 3523.4186359250693, 30712.53931191034, 30730.231744206572, 30743.0, 30764.38471230585, 30857.845710771304, 4965.528274813887, 5020.121478741242, 5058.645894787366, 5068.82259120929, 5105.693658380509, 228220.0, 236043.0, 236849.0, 237008.0, 237579.0, 48447.273290900666, 48581.0, 48782.75608621934, 48890.51109488859, 48921.26618100731, 51974.0, 52055.47944520582, 54570.72714636481, 55876.441235587125, 55978.16032759512, 16815.159242037847, 16926.57683557921, 16932.661346772995, 16957.745633815503, 16976.151192440328, 13937.930310348384, 13975.860241397659, 14000.789988150185, 14004.089734167246, 14024.228667423185, 14488.710225795425, 14809.481668141563, 14834.925825370805, 14881.33034013472, 15045.924770376078, 5798.449147331081, 5840.707964601753, 5843.707814609337, 5865.618734782225, 6076.392360763888, 990.4404011733347, 1010.3887148275335, 1018.5976539266948, 1018.6180182431589, 1022.5909636145601, 22891.0, 23116.422089447562, 23137.65293520565, 23179.884100579387, 23614.173503927625, 1104.2987702808614, 1106.1040557148735, 1111.6831702964616, 1123.1913022623698, 1129.5594718059963, 12463.376831158586, 12534.122611417113, 12609.621711348675, 12640.936795315965, 12672.49310027607, 226587.0, 227961.0, 228437.0, 229383.0, 229987.0, 53649.731751340994, 53659.73170134125, 53851.19223211655, 56370.43629563734, 61641.38358616446, 1471.2790732540977, 1503.5714821275883, 1506.5103841251637, 1520.3918432626817, 1521.4522771802142, 28486.715132848407, 28778.28054298659, 28848.0, 28951.565726514542, 29369.85315073411, 39325.213495730495, 39452.80273598614, 39625.603743962194, 39661.20677586374, 39739.80130099331, 205072.0, 205098.0, 206411.0, 206942.0, 208533.0, 36871.0, 36928.0, 37159.44260836144, 37331.44002840014, 37398.626013739515, 41926.0, 44297.0, 44831.103377931606, 44883.77558112189, 45241.773791130836, 33345.0, 33414.33171336608, 34208.82895585506, 34361.0, 34898.0, 32035.679643204203, 32949.83525082359, 32972.34055318928, 33077.66922330746, 33782.324353513286, 35847.283054338244, 35855.28289434144, 35957.82021089982, 36052.819735901154, 36151.45772813463, 31644.367112658078, 31885.68114318827, 32070.19824504406, 32232.83883580567, 32636.836815816718, 22723.88638056799, 23608.29175124749, 23656.408589784704, 23860.52278954446, 23957.52084958326], "value": 17406.49527375713, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.785252677719, 573.3607028163597, 581.7527550790912, 584.377637815726, 592.5674257791812, 21627.134914603415, 22224.333270001884, 22422.215222467217, 22547.098116075358, 22574.097036118575, 25168.74831251687, 27805.165845024632, 27807.16578502643, 27832.860835695792, 27983.860080699567, 6921.7923462296085, 7109.537880037807, 7122.145342558874, 7129.215786263533, 7137.750178743745, 6285.120083188334, 6649.9667501662425, 6910.75812346568, 6967.721291148348, 6973.058637084005, 6925.757598484054, 6930.237673855871, 6945.444364450857, 6952.443804495653, 6995.475339349544, 6995.125609298838, 7008.929910700905, 7010.158780946268, 7016.228214896358, 7018.684159212848, 6818.386345228903, 6840.555363901331, 6849.657517124174, 6858.382745552874, 6864.176298844171, 30450.54324185117, 31095.68904310973, 31583.368332633447, 31880.362392752246, 32109.51835722466, 1932.2657390191778, 1973.9506512337307, 1976.802319768026, 1984.5534754680225, 1987.3441764217919, 20240.49398765028, 20589.4852628684, 20639.380818575468, 20680.17279308826, 20915.477113072142, 2494.95010099797, 2543.6693229879997, 2632.1840229528716, 2632.5393056215084, 2634.380920483685, 141295.0, 142765.0, 143026.284868575, 144837.27581362132, 145182.27408862993, 19176.71234931477, 21299.46751331198, 21782.82171782809, 21815.67276490854, 22246.88876555607, 44866.32700509495, 45355.773221133684, 45369.546304537194, 45512.317315240296, 45692.77153614211, 11433.428328583537, 11626.186166968231, 11643.359615221074, 11728.824067638992, 11842.197323311688, 9589.376690515093, 9626.855597166048, 9663.758406039764, 9749.951250243845, 9786.41281523111, 8783.25342345895, 9279.67521136757, 9448.952755236318, 11027.724306892393, 11593.304401735923, 2639.920802375932, 2720.9047683330987, 2745.2450576091337, 2763.4749397614387, 2857.0857325655593, 934.3412893909777, 957.090763774417, 968.6052084997722, 971.4996776660025, 996.2826764729383, 19694.70457943132, 23301.7669823303, 25043.87478062598, 25152.371190720012, 25443.236702898943, 1004.6182450668699, 1040.1262939131166, 1063.473580577619, 1063.6808957312776, 1065.7282392989894, 11241.887581124247, 13448.260345680887, 14306.427742890375, 14448.711025779425, 14643.707125857636, 510846.0, 525013.0, 533000.0, 539343.0, 540846.0, 120384.0, 122339.38830305792, 122771.0, 125186.0, 126019.36990315173, 1217.6286232699113, 1255.6107606641788, 1272.4910035985495, 1275.8213850061, 1288.5232463988384, 21574.568508629425, 21703.91480425941, 22077.0, 22194.112235510398, 22325.665115022963, 59932.400675992685, 61111.69444152751, 61541.69229154005, 61609.69195153996, 63785.36214637794, 70465.64767176131, 70757.0, 70804.0, 71035.28964710493, 71689.0, 14333.928330358698, 15212.315445805187, 15263.0, 15287.847121528643, 15410.152441615819, 23776.4055898597, 23991.880040599684, 25057.248282551554, 25223.621645675696, 25278.620820688073, 19276.710849337553, 19320.32378866733, 19482.512937176118, 19635.607287853876, 19655.70516442283, 17540.561485962953, 17670.0, 17989.73015404796, 18016.2793488259, 18334.908325458287, 19575.804241957398, 19597.31409400664, 19946.900265498578, 20140.09369578343, 20351.59296814085, 14831.629209269855, 14858.257087145816, 14881.47914822976, 15054.924725376302, 15140.091594504365, 17772.822271777117, 17941.0, 18299.54251143732, 19433.445324374297, 19579.70630440573], "value": 13060.170391538359, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.4121357209613, 1380.751464736347, 1407.7888316752492, 1408.9295535223248, 1413.1874172350895, 14052.578422647312, 14556.0, 14674.633134171638, 14706.705865882675, 14710.926445367759, 12186.329751863645, 12559.686007849808, 12641.367931603429, 14120.858791412084, 14794.630134246649, 2493.7506249375056, 2555.105713000444, 2563.2054063240457, 2567.191334729554, 2568.6018667106628, 2599.46710924261, 2607.569750991084, 2672.772814310786, 2675.1172113202597, 2689.4486630240754, 2580.845149291039, 2606.2441891851436, 2615.659964204651, 2627.3037645023987, 2634.012245407972, 2521.306640673811, 2566.0, 2576.0, 2586.5732154194534, 2607.4394005288955, 2543.1353339864536, 2544.402065514603, 2558.897644094234, 2576.2271318604344, 2580.0324878170686, 13494.392752326168, 13730.725385492335, 13736.65658358539, 13799.724005519935, 13800.93099534506, 7537.736179233755, 7752.844943101163, 7754.728584499516, 7815.413843961669, 7845.764627061198, 4782.378290822171, 4976.154053810861, 5131.61512886535, 5143.588512918957, 5157.742112894378, 1858.4610462965725, 1859.9349022784272, 1876.5402476393372, 1924.4996300961711, 1951.4633475794128, 22791.54416911669, 23303.88348058266, 23307.067717291287, 23376.064957401682, 23400.0, 6724.327567243236, 6809.557378770364, 6902.689378977958, 6939.583624982517, 6954.513184077066, 18310.725339119923, 18326.0, 18359.0, 18379.264829406675, 18401.63196736058, 7942.483738556975, 8080.474769139987, 8087.191280871866, 8092.433529652868, 8104.554249516215, 7053.188883278489, 7146.642667866586, 7195.604241766649, 7202.92797072033, 7267.963660181666, 5376.973115134399, 5544.611877168641, 5590.440955904458, 5608.0, 5636.267285252973, 1568.294267579571, 1701.8213087625868, 1710.880238383326, 1730.480855743272, 1738.0093346792207, 704.3625518905399, 877.1491653096487, 888.9422187557788, 907.2379201470796, 950.2160717408166, 8200.097989221182, 8427.873581896276, 8436.620352084172, 8437.620307086196, 8573.871391929126, 977.1059480575194, 986.452518852044, 988.204495381225, 989.2185173712686, 1015.9949200254099, 4975.975120124376, 5101.821651024214, 5167.199084141889, 5235.345581802275, 5247.10799164143, 19003.619927601372, 19318.903405482884, 19612.313569025016, 19840.90079549593, 20125.0, 18974.43076707701, 19469.12388942501, 19769.0, 19928.90035549842, 19963.800361996484, 10711.785764284827, 10921.672349829518, 10958.726031849108, 11131.165162612837, 11145.832812507819, 7791.597747272773, 7954.125046244792, 7995.2804247618, 8148.714794982147, 8230.958845205736, 17020.14899255057, 17089.91455042717, 17270.395536156175, 17753.467395978143, 17800.0, 17533.912330438267, 17871.553211169823, 17981.73027404616, 18336.449906502825, 18539.721904171718, 10837.403942782907, 10985.61550345734, 11049.447527623426, 11068.723281918017, 11100.777984440105, 13057.477700892237, 13130.409131589293, 13167.0, 13290.601281961557, 13359.0, 10035.949820250851, 10658.89341106579, 11147.777044459228, 11209.607663731731, 11413.144014199135, 10299.3820370778, 10409.895901040893, 10457.267991240844, 10639.734006649896, 10697.197710171613, 9290.489023103793, 9400.106989835955, 9416.717498475056, 9428.0, 9434.669786557712, 7110.43116550685, 7277.963610181915, 7282.198958114709, 7309.926900731138, 7315.0, 7301.853962920818, 7303.30618591233, 7337.4246608176845, 7368.778936631909, 7402.499053388748], "value": 6480.715790325665, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.76059491444084, 506.29877619497006, 522.3209827224609, 523.9397469291033, 526.4209369693338, 6111.480524155447, 6130.203073600437, 6137.601055931373, 6162.627388455443, 6205.937940620587, 6022.156898034279, 6024.1566180734735, 6040.546958978083, 6048.3044449888275, 6092.659614884729, 4981.1283025470575, 5050.217216331465, 5066.417362003362, 5066.41736200338, 5078.898422031557, 4991.226359914219, 5039.546440820325, 5064.518870707296, 5066.113430149728, 5073.1122053640465, 4800.591949684281, 4807.4952130026195, 4819.855404337875, 4871.415430148387, 4952.257161425779, 4812.783424745895, 4852.0, 4887.266909963499, 4899.6325275604295, 4932.284818701304, 4281.614654681093, 4384.583464570893, 4389.209942210401, 4407.289516947055, 4426.313921342197, 5759.3376761672525, 5767.884642307173, 5851.297844258674, 5856.238688970407, 5877.559183061245, 5579.804706835242, 5596.720163991825, 5601.831945041615, 5640.0, 5653.745581448845, 6403.478087052103, 6496.187976502937, 6499.415052645285, 6505.381988711065, 6532.628148088907, 4775.188218002948, 4835.274708793674, 4839.177339852234, 4858.5384388483035, 4863.392075990501, 6485.4487368573255, 6744.258131605519, 6756.324367563205, 6775.661216939183, 6871.278515755824, 4760.904781904343, 4919.286703428054, 4926.45808961014, 4946.777395017233, 4956.3804524434445, 4964.517741129435, 5024.346834911438, 5029.572486338702, 5032.245163225545, 5051.318072060299, 5506.1190209566275, 5546.473085056913, 5547.278853748987, 5574.526165275915, 5574.86062848432, 6380.0, 6449.451796597342, 6490.0, 6512.41388275048, 6528.281888992207, 1735.0977491704496, 1745.860331173503, 1758.788945326569, 1760.542259012666, 1772.645470905824, 1156.3004382348558, 1221.5785553983862, 1223.1988047828686, 1231.9938400307942, 1243.533674871923, 5560.527355174855, 5571.804986825442, 5706.4864162225595, 5722.4277572242445, 5775.249217601685, 6524.6737663116655, 6613.966930165415, 6632.502562307846, 6656.600603963778, 6705.631190284581, 5645.463680950304, 5665.12190610456, 5701.486866182064, 5742.48317651405, 5767.106098554731, 3408.948865766966, 3458.4985177149674, 3477.7132460989596, 3520.753547251668, 3536.1866770642896, 6437.645929473924, 6474.255460621995, 6483.481321494269, 6511.837204069841, 6512.641804700692, 6687.465002799861, 6724.630145342053, 6814.557053791487, 6833.624150671761, 6865.210500792473, 6299.1811064562235, 6328.456064603744, 6341.841453963688, 6364.649944252926, 6464.0, 6562.967185164043, 6570.532038214061, 6598.1422415085735, 6607.372299631527, 6643.634600096848, 6539.411452969255, 6570.145881035626, 6586.341365863567, 6596.5052621052655, 6642.236142843635, 6408.359164083555, 6412.487001039813, 6425.8714825704155, 6551.901721474277, 6586.637734924625, 4914.827981020647, 4955.851324460272, 4959.404871415453, 4970.155073637563, 4985.102681517216, 6474.611523308617, 6482.902756458562, 6619.834504137242, 6697.296783837627, 6763.729450821912, 6417.791104447776, 6425.389587989133, 6439.388258115471, 6482.092507048923, 6528.575642583217, 6295.779647712308, 6344.206974128234, 6369.9681501592195, 6376.840578985377, 6378.2983871774995, 6115.602485838406, 6226.62640241587, 6343.111964324906, 6350.142730731477, 6437.903431448625, 6419.839504012437, 6455.256515980784, 6462.5153113515735, 6507.772227971998, 6560.639164845788, 6229.937700622936, 6264.937350626436, 6300.086487459384, 6360.363963603602, 6398.968005159944], "value": 4988.359268707945, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [887.0597167002974, 897.5646811296524, 906.4697152165983, 906.7869050773071, 921.6129225725194, 18912.71630925537, 19900.90049549752, 20004.0, 20046.899765501188, 20056.896870672124, 20394.69407958882, 21408.036638351274, 21496.247631332906, 21570.13719451224, 21782.237621683205, 982.302565178724, 995.3778888194878, 997.2620261006875, 1003.9046290602417, 1003.934744241622, 1014.8477728340735, 1018.8981101889789, 1021.7037059252808, 1022.626741239446, 1031.2626472072466, 1004.1665417703289, 1042.0829669890525, 1078.2560033576806, 1083.864516935383, 1093.3767752381145, 1069.2141276162015, 1072.1958531101673, 1076.6662334676237, 1080.200651517875, 1085.3379438542484, 764.1556080531044, 776.1307335783902, 783.0877028262067, 786.5516655506364, 787.7282337593521, 20022.69965950512, 20196.394108176777, 20280.391588252376, 20440.795592044036, 20687.379378618665, 21398.358049258546, 21844.89077554618, 22038.88980555087, 22404.0, 22423.0, 16479.588010299718, 16749.413770517975, 16875.662486750196, 16919.830801691947, 17074.402395916208, 3676.5477636333767, 3722.8324725387424, 3728.217074414349, 3746.4754934308944, 3751.8874433767032, 120200.0, 122175.0, 123717.38141309326, 124654.0, 125637.0, 16407.5898102546, 16920.830791692173, 16937.661246775242, 16962.15189240533, 16965.830341696674, 30365.0, 30729.385412292075, 31131.533027004614, 31415.057548273588, 31462.842685786425, 8581.270591999624, 8603.31173506118, 8654.826903461895, 8694.782630434163, 8734.30125589964, 4244.554321796229, 4275.850345237902, 4349.869503914888, 4351.73889566627, 4366.410534577855, 4752.405949256343, 5028.17035189197, 5153.871153221199, 5156.793728250828, 5177.896442071137, 882.7175303902818, 985.2413641496152, 1067.6263307842194, 1071.3786004117594, 1078.0, 662.7945336945562, 678.1692426777257, 680.7923583307139, 686.2656957055902, 695.5166159519085, 12010.159288849696, 12307.0, 12666.683332916751, 12983.415746291439, 12999.675008124872, 670.8624731929942, 672.6603065451916, 677.7221339250883, 677.8745932002595, 692.5290802254415, 5576.1356989666665, 5750.741216645261, 5765.654060756368, 5808.912866307009, 5824.0, 109568.4521577387, 110133.44933275443, 112222.0, 113704.43147784208, 113954.0, 94359.52820235993, 96660.0, 96929.25233317883, 96971.51514242525, 97912.0, 87396.56301718578, 87780.0, 88201.55899220463, 89191.55404222937, 89345.55327223323, 10582.788344232918, 10854.131669466582, 10942.452877355941, 11028.28316159447, 12702.87297127017, 38858.6114138855, 39526.60473395229, 39734.80132599434, 39818.2036359277, 40639.79680101581, 70227.29772702207, 71004.28995709977, 72999.63500182464, 73753.0, 74680.25319746733, 17601.471955841345, 18069.81930180734, 19947.401577952685, 20455.69316460284, 20704.48238793982, 22231.333060008226, 23032.539349212588, 23167.0, 23442.17952371659, 23782.643260351455, 20235.19059237673, 20720.48198795042, 20808.063637136063, 21108.0, 21264.574708505435, 18789.6242075155, 19190.520236994187, 19497.902510487358, 20164.49588760234, 21130.788692113496, 18832.435026949213, 19194.904025479784, 20038.699419508426, 20165.193392264144, 20704.378868633965, 12950.546730864375, 13172.341382931007, 13448.0, 13626.659333516742, 13641.181529108286, 13942.721145577234, 14462.493812716504, 14707.852921470649, 14720.779188312397, 14754.704905902037], "value": 9347.814492599624, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1571.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 109.0, 111.0, 109.0, 120.0, 117.0, 106.0, 114.0, 114.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 147.0, 175.0, 132.0, 155.0, 150.0, 127.0, 177.0, 125.0], "value": 145.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 166.0, 163.0, 171.0, 168.0, 170.0, 172.0, 168.0, 177.0, 166.0], "value": 169.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 91.0, 173.0, 80.0, 76.0, 83.0, 79.0, 150.0, 76.0], "value": 96.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 143.0, 88.0, 85.0, 79.0, 123.0, 88.0, 85.0, 133.0], "value": 98.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 120.0, 114.0, 121.0, 118.0, 118.0, 115.0, 117.0, 119.0, 122.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 155.0, 154.0, 152.0, 153.0, 154.0, 151.0, 151.0, 155.0, 153.0], "value": 152.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 101.0, 95.0, 95.0, 95.0, 103.0, 96.0, 97.0, 94.0, 95.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 55.0, 55.0, 53.0, 54.0, 54.0, 54.0, 54.0, 64.0, 54.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 63.0, 55.0, 59.0, 55.0, 65.0, 60.0, 60.0], "value": 58.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 97.0, 78.0, 83.0, 79.0, 85.0, 80.0, 87.0, 76.0, 77.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 127.0, 131.0, 130.0, 132.0, 128.0, 139.0, 129.0, 132.0, 156.0], "value": 133.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 178.0, 179.0, 186.0, 186.0, 191.0, 175.0, 184.0, 180.0, 178.0], "value": 182.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 78.0, 70.0, 69.0, 69.0, 72.0, 72.0, 67.0], "value": 70.2, "unit": "score"}]}]} 11:42:20 INFO - Return code: 0 11:42:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:42:20 INFO - # TBPL SUCCESS # 11:42:20 INFO - Running post-action listener: _package_coverage_data 11:42:20 INFO - Running post-action listener: _resource_record_post_action 11:42:20 INFO - [mozharness: 2017-08-17 18:42:20.308872Z] Finished run-tests step (success) 11:42:20 INFO - Running post-run listener: _resource_record_post_run 11:42:20 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 430878720; Read time: 40; Write time: 276832 11:42:20 INFO - TinderboxPrint: CPU usage
13.3% 11:42:20 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 40 11:42:20 INFO - TinderboxPrint: I/O write bytes / time
430,878,720 / 276,832 11:42:20 INFO - TinderboxPrint: CPU idle
8,271.8 (86.7%) 11:42:20 INFO - TinderboxPrint: CPU user
1,208.3 (12.7%) 11:42:20 INFO - TinderboxPrint: Swap in / out
0 / 0 11:42:20 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 106995712; Read time: 32; Write time: 81604 11:42:20 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:42:20 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 322760704; Read time: 0; Write time: 195120 11:42:20 INFO - Running post-run listener: _upload_blobber_files 11:42:20 INFO - Blob upload gear active. 11:42:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:42: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:42: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:42: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:42:21 INFO - (blobuploader) - INFO - Open directory for files ... 11:42:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:42:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:42:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:22 INFO - (blobuploader) - INFO - Done attempting. 11:42:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:42:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:42:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:29 INFO - (blobuploader) - INFO - Done attempting. 11:42:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:42:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:42:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:30 INFO - (blobuploader) - INFO - Done attempting. 11:42:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:42:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:42:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:30 INFO - (blobuploader) - INFO - Done attempting. 11:42:30 INFO - (blobuploader) - INFO - Iteration through files over. 11:42:30 INFO - Return code: 0 11:42:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:42:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:42:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0e6bc8307ddc237a45245b68212043fc0ad1861e40f67d86e5fea558aa18d6a5e64d25f085eb7ed4d261a795c7bad099cbbe43440da14f8e262d4d533c785df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e1d802e2b6adbdacbe88ad4b25e1b9631ac04b644698044d97d6a3a64a7c69b42e46dc3322a59a7507f8bf9c0bf9307fffe096c3f2a281f3b1d77c3b26d6584", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26ee2e5d5d3b1fc1fc0cbd26506017f40465eb2a8fc0a230295669161ef1e869ed043558d101ea05fe185c7d59bd1bad87861867ef7ed3b1a678368b02e40f71", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e2774f796817f7786d2803c7502c0539b02fef19a8221dc13d8f49155ac08030e551331c0da616fa71d80d499a7d45b72208866e9455c173b1cbc37f4b54686"} 11:42:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:42:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:42:30 INFO - Contents: 11:42:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0e6bc8307ddc237a45245b68212043fc0ad1861e40f67d86e5fea558aa18d6a5e64d25f085eb7ed4d261a795c7bad099cbbe43440da14f8e262d4d533c785df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e1d802e2b6adbdacbe88ad4b25e1b9631ac04b644698044d97d6a3a64a7c69b42e46dc3322a59a7507f8bf9c0bf9307fffe096c3f2a281f3b1d77c3b26d6584", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26ee2e5d5d3b1fc1fc0cbd26506017f40465eb2a8fc0a230295669161ef1e869ed043558d101ea05fe185c7d59bd1bad87861867ef7ed3b1a678368b02e40f71", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e2774f796817f7786d2803c7502c0539b02fef19a8221dc13d8f49155ac08030e551331c0da616fa71d80d499a7d45b72208866e9455c173b1cbc37f4b54686"} 11:42:30 INFO - Running post-run listener: copy_logs_to_upload_dir 11:42:30 INFO - Copying logs to upload dir... 11:42:30 INFO - mkdir: /builds/slave/test/build/upload/logs 11:42:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.725927 ========= master_lag: -0.37 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-17 11:42:30.255843) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 11:42:30.262259) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0e6bc8307ddc237a45245b68212043fc0ad1861e40f67d86e5fea558aa18d6a5e64d25f085eb7ed4d261a795c7bad099cbbe43440da14f8e262d4d533c785df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e1d802e2b6adbdacbe88ad4b25e1b9631ac04b644698044d97d6a3a64a7c69b42e46dc3322a59a7507f8bf9c0bf9307fffe096c3f2a281f3b1d77c3b26d6584", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26ee2e5d5d3b1fc1fc0cbd26506017f40465eb2a8fc0a230295669161ef1e869ed043558d101ea05fe185c7d59bd1bad87861867ef7ed3b1a678368b02e40f71", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e2774f796817f7786d2803c7502c0539b02fef19a8221dc13d8f49155ac08030e551331c0da616fa71d80d499a7d45b72208866e9455c173b1cbc37f4b54686"} build_url:https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011432 build_url: 'https://queue.taskcluster.net/v1/task/aYF0Eu7eSDuOnCwEq2ykWQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0e6bc8307ddc237a45245b68212043fc0ad1861e40f67d86e5fea558aa18d6a5e64d25f085eb7ed4d261a795c7bad099cbbe43440da14f8e262d4d533c785df", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7e1d802e2b6adbdacbe88ad4b25e1b9631ac04b644698044d97d6a3a64a7c69b42e46dc3322a59a7507f8bf9c0bf9307fffe096c3f2a281f3b1d77c3b26d6584", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26ee2e5d5d3b1fc1fc0cbd26506017f40465eb2a8fc0a230295669161ef1e869ed043558d101ea05fe185c7d59bd1bad87861867ef7ed3b1a678368b02e40f71", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e2774f796817f7786d2803c7502c0539b02fef19a8221dc13d8f49155ac08030e551331c0da616fa71d80d499a7d45b72208866e9455c173b1cbc37f4b54686"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 11:42:30.290689) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:42:30.291073) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1502993939.864738-1133216831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004691 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:42:30.371528) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 11:42:30.371824) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 11:42:30.374372) ========= ========= Total master_lag: -0.21 =========