builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-011 starttime: 1504376121.32 results: success (0) revision: 59611e1583e7411bab615d29109894e4c657af33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:21.317747) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:21.318176) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:21.318444) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:21.344918) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:21.345228) ========= 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=5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-02 11:15:21-- 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% 46.0M=0s 2017-09-02 11:15:21 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.288624 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:21.670700) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:21.670997) ========= 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=5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013675 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:21.721199) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-02 11:15:21.724543) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 59611e1583e7411bab615d29109894e4c657af33 --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 59611e1583e7411bab615d29109894e4c657af33 --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=5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-02 11:15:22,122 truncating revision to first 12 chars 2017-09-02 11:15:22,123 Setting DEBUG logging. 2017-09-02 11:15:22,123 attempt 1/10 2017-09-02 11:15:22,123 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/59611e1583e7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-02 11:15:22,876 unpacking tar archive at: mozilla-central-59611e1583e7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.160159 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-02 11:15:22.908037) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:22.908298) ========= script_repo_revision: 59611e1583e7411bab615d29109894e4c657af33 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:22.911653) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:22.911916) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-02 11:15:22.925092) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-09-02 11:15:22.925378) ========= /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=5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:15:23 INFO - MultiFileLogger online at 20170902 11:15:23 in /builds/slave/test 11:15:23 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:15:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:15:23 INFO - {'append_to_log': False, 11:15:23 INFO - 'base_work_dir': '/builds/slave/test', 11:15:23 INFO - 'blob_upload_branch': 'Firefox', 11:15:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:15:23 INFO - 'branch': 'Firefox', 11:15:23 INFO - 'buildbot_json_path': 'buildprops.json', 11:15:23 INFO - 'code_coverage': False, 11:15:23 INFO - 'config_files': ('talos/linux_config.py',), 11:15:23 INFO - 'default_actions': ('clobber', 11:15:23 INFO - 'read-buildbot-config', 11:15:23 INFO - 'download-and-extract', 11:15:23 INFO - 'populate-webroot', 11:15:23 INFO - 'create-virtualenv', 11:15:23 INFO - 'install', 11:15:23 INFO - 'setup-mitmproxy', 11:15:23 INFO - 'run-tests'), 11:15:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:15:23 INFO - 'disable_ccov_upload': False, 11:15:23 INFO - 'disable_stylo': False, 11:15:23 INFO - 'download_minidump_stackwalk': True, 11:15:23 INFO - 'download_symbols': 'ondemand', 11:15:23 INFO - 'enable_stylo': False, 11:15:23 INFO - 'enable_webrender': False, 11:15:23 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:15:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:15:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:15:23 INFO - 'gecko_profile': False, 11:15:23 INFO - 'gecko_profile_interval': 0, 11:15:23 INFO - 'installer_path': 'installer.exe', 11:15:23 INFO - 'log_level': 'info', 11:15:23 INFO - 'log_name': 'talos', 11:15:23 INFO - 'log_to_console': True, 11:15:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:15:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:15:23 INFO - 'opt_config_files': (), 11:15:23 INFO - 'pip_index': False, 11:15:23 INFO - 'suite': 'dromaeojs-e10s', 11:15:23 INFO - 'system_bits': '32', 11:15:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:15:23 INFO - 'title': 'talos-linux64-ix-011', 11:15:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:15:23 INFO - 'use_talos_json': True, 11:15:23 INFO - 'verify': 'False', 11:15:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:15:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:15:23 INFO - 'work_dir': 'build'} 11:15:23 INFO - [mozharness: 2017-09-02 18:15:23.585605Z] Running clobber step. 11:15:23 INFO - Running pre-action listener: _resource_record_pre_action 11:15:23 INFO - Running main action method: clobber 11:15:23 INFO - rmtree: /builds/slave/test/build 11:15:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:15:24 INFO - Running post-action listener: _resource_record_post_action 11:15:24 INFO - [mozharness: 2017-09-02 18:15:24.567266Z] Finished clobber step (success) 11:15:24 INFO - [mozharness: 2017-09-02 18:15:24.567365Z] Running read-buildbot-config step. 11:15:24 INFO - Running pre-action listener: _resource_record_pre_action 11:15:24 INFO - Running main action method: read_buildbot_config 11:15:24 INFO - Using buildbot properties: 11:15:24 INFO - { 11:15:24 INFO - "project": "", 11:15:24 INFO - "product": "firefox", 11:15:24 INFO - "who": "ffxbld@noreply.mozilla.org", 11:15:24 INFO - "installer_path": "public/build/target.tar.bz2", 11:15:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 11:15:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:15:24 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 11:15:24 INFO - "stage_platform": "linux64-qr", 11:15:24 INFO - "basedir": "/builds/slave/test", 11:15:24 INFO - "buildnumber": 30, 11:15:24 INFO - "platform": "ubuntu64_hw_qr", 11:15:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:15:24 INFO - "slavebuilddir": "test", 11:15:24 INFO - "taskId": "E6Q9MfGSSjavmJe-Uiul6g", 11:15:24 INFO - "branch": "mozilla-central", 11:15:24 INFO - "script_repo_revision": "production", 11:15:24 INFO - "revision": "59611e1583e7411bab615d29109894e4c657af33", 11:15:24 INFO - "slavename": "talos-linux64-ix-011", 11:15:24 INFO - "repo_path": "mozilla-central" 11:15:24 INFO - } 11:15:24 INFO - Finding installer, test and symbols from parent task. 11:15:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E6Q9MfGSSjavmJe-Uiul6g'}, attempt #1 11:15:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E6Q9MfGSSjavmJe-Uiul6g'}, attempt #1 11:15:25 INFO - Task dependencies: C-9NEaTqQja8SGXabZPikw 11:15:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw'}, attempt #1 11:15:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.tar.bz2 11:15:25 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.test_packages.json 11:15:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.crashreporter-symbols.zip 11:15:25 INFO - Running post-action listener: _resource_record_post_action 11:15:25 INFO - [mozharness: 2017-09-02 18:15:25.910833Z] Finished read-buildbot-config step (success) 11:15:25 INFO - [mozharness: 2017-09-02 18:15:25.911050Z] Running download-and-extract step. 11:15:25 INFO - Running pre-action listener: _resource_record_pre_action 11:15:25 INFO - Running main action method: download_and_extract 11:15:25 INFO - mkdir: /builds/slave/test/build/tests 11:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:25 INFO - trying https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.test_packages.json 11:15:25 INFO - Downloading https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:15:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:15:26 INFO - Downloaded 989 bytes. 11:15:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:15:26 INFO - Using the following test package requirements: 11:15:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:15:26 INFO - u'common': [u'target.common.tests.zip'], 11:15:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:15:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:15:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:15:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:15:26 INFO - u'mozbase': [u'target.common.tests.zip'], 11:15:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:15:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:15:26 INFO - u'web-platform': [u'target.common.tests.zip', 11:15:26 INFO - u'target.web-platform.tests.tar.gz'], 11:15:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:15:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:15:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.common.tests.zip 11:15:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:15:26 INFO - Fetch https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.common.tests.zip into memory 11:15:27 INFO - Content-Length response header: 55022419 11:15:27 INFO - Bytes received: 55022419 11:15:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:15:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.common.tests.zip 11:15:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:15:39 INFO - Fetch https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.common.tests.zip into memory 11:15:40 INFO - Content-Length response header: 55022419 11:15:40 INFO - Bytes received: 55022419 11:15:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.talos.tests.zip 11:15:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:15:53 INFO - Fetch https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.talos.tests.zip into memory 11:15:53 INFO - Content-Length response header: 14496650 11:15:53 INFO - Bytes received: 14496650 11:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:54 INFO - trying https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.tar.bz2 11:15:54 INFO - Downloading https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:15:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:15:55 INFO - Downloaded 62714781 bytes. 11:15:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.tar.bz2 11:15:55 INFO - mkdir: /builds/slave/test/properties 11:15:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:15:55 INFO - Writing to file /builds/slave/test/properties/build_url 11:15:55 INFO - Contents: 11:15:55 INFO - build_url:https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.tar.bz2 11:15:55 INFO - Running post-action listener: _resource_record_post_action 11:15:55 INFO - Running post-action listener: find_tests_for_verification 11:15:55 INFO - Running post-action listener: set_extra_try_arguments 11:15:55 INFO - [mozharness: 2017-09-02 18:15:55.376263Z] Finished download-and-extract step (success) 11:15:55 INFO - [mozharness: 2017-09-02 18:15:55.376360Z] Running populate-webroot step. 11:15:55 INFO - Running pre-action listener: _resource_record_pre_action 11:15:55 INFO - Running main action method: populate_webroot 11:15:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:15:55 INFO - 'chromez-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:15:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:15:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:15:55 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:15:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:15:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:15:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:55 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:15:55 INFO - 'talos_options': ['--enable-stylo'], 11:15:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:15:55 INFO - 'tests': ['damp', 'tps']}, 11:15:55 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:15:55 INFO - 'talos_options': ['--enable-stylo'], 11:15:55 INFO - 'tests': ['damp', 'tps']}, 11:15:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:15:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:15:55 INFO - 'g4-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:15:55 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:15:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:15:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:15:55 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:15:55 INFO - 'talos_options': ['--enable-stylo'], 11:15:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:15:55 INFO - 'other-e10s': {'tests': ['a11yr', 11:15:55 INFO - 'ts_paint', 11:15:55 INFO - 'tpaint', 11:15:55 INFO - 'sessionrestore', 11:15:55 INFO - 'sessionrestore_many_windows', 11:15:55 INFO - 'sessionrestore_no_auto_restore', 11:15:55 INFO - 'tabpaint']}, 11:15:55 INFO - 'other-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:15:55 INFO - 'tests': ['a11yr', 11:15:55 INFO - 'ts_paint', 11:15:55 INFO - 'tpaint', 11:15:55 INFO - 'sessionrestore', 11:15:55 INFO - 'sessionrestore_many_windows', 11:15:55 INFO - 'sessionrestore_no_auto_restore', 11:15:55 INFO - 'tabpaint']}, 11:15:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:15:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:15:55 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:15:55 INFO - 'tests': ['bloom_basic_singleton']}, 11:15:55 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:15:55 INFO - 'tests': ['bloom_basic']}, 11:15:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:15:55 INFO - 'tsvgr_opacity', 11:15:55 INFO - 'tart', 11:15:55 INFO - 'tscrollx', 11:15:55 INFO - 'tsvg_static']}, 11:15:55 INFO - 'svgr-stylo-e10s': {'talos_options': ['--enable-stylo'], 11:15:55 INFO - 'tests': ['tsvgx', 11:15:55 INFO - 'tsvgr_opacity', 11:15:55 INFO - 'tart', 11:15:55 INFO - 'tscrollx', 11:15:55 INFO - 'tsvg_static']}, 11:15:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:15:55 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:15:55 INFO - 'talos_options': ['--enable-stylo'], 11:15:55 INFO - 'tests': ['tp5o']}, 11:15:55 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:15:55 INFO - 'talos_options': ['--mitmproxy', 11:15:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:15:55 INFO - '--firstNonBlankPaint'], 11:15:55 INFO - 'tests': ['tp6_google', 11:15:55 INFO - 'tp6_youtube', 11:15:55 INFO - 'tp6_amazon', 11:15:55 INFO - 'tp6_facebook']}, 11:15:55 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:15:55 INFO - 'talos_options': ['--enable-stylo', 11:15:55 INFO - '--mitmproxy', 11:15:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:15:55 INFO - '--firstNonBlankPaint'], 11:15:55 INFO - 'tests': ['tp6_google', 11:15:55 INFO - 'tp6_youtube', 11:15:55 INFO - 'tp6_amazon', 11:15:55 INFO - 'tp6_facebook']}, 11:15:55 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:15:55 INFO - 'talos_options': ['--enable-stylo', 11:15:55 INFO - '--stylo-threads=1', 11:15:55 INFO - '--mitmproxy', 11:15:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:15:55 INFO - '--firstNonBlankPaint'], 11:15:55 INFO - 'tests': ['tp6_google', 11:15:55 INFO - 'tp6_youtube', 11:15:55 INFO - 'tp6_amazon', 11:15:55 INFO - 'tp6_facebook']}, 11:15:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:15:55 INFO - 'talos_options': ['--xperf_path', 11:15:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:55 INFO - 'tests': ['tp5n']}, 11:15:55 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:15:55 INFO - 'talos_options': ['--enable-stylo', 11:15:55 INFO - '--xperf_path', 11:15:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:55 INFO - 'tests': ['tp5n']}}} 11:15:55 INFO - Running post-action listener: _resource_record_post_action 11:15:55 INFO - [mozharness: 2017-09-02 18:15:55.390645Z] Finished populate-webroot step (success) 11:15:55 INFO - [mozharness: 2017-09-02 18:15:55.390734Z] Running create-virtualenv step. 11:15:55 INFO - Running pre-action listener: _resource_record_pre_action 11:15:55 INFO - Running main action method: create_virtualenv 11:15:55 INFO - Creating virtualenv /builds/slave/test/build/venv 11:15:55 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:15:55 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:15:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:15:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:15:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:15:56 INFO - Installing distribute.............................................................................................................................................................................................done. 11:15:56 INFO - Installing pip...............done. 11:15:56 INFO - Return code: 0 11:15:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:15:56 INFO - Reading from file tmpfile_stdout 11:15:56 INFO - Output received: 11:15:56 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:15:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1454a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fb090>, '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 0x15fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f5f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', '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:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:15:56 INFO - Using env: {'DISPLAY': ':0', 11:15:56 INFO - 'HOME': '/home/cltbld', 11:15:56 INFO - 'LANG': 'en_US.UTF-8', 11:15:56 INFO - 'LANGUAGE': 'en_US:en', 11:15:56 INFO - 'LOGNAME': 'cltbld', 11:15:56 INFO - 'MAIL': '/var/mail/cltbld', 11:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:56 INFO - 'MOZ_NO_REMOTE': '1', 11:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:56 INFO - 'NO_EM_RESTART': '1', 11:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:56 INFO - 'PWD': '/builds/slave/test', 11:15:56 INFO - 'SHELL': '/bin/bash', 11:15:56 INFO - 'SHLVL': '1', 11:15:56 INFO - 'TERM': 'linux', 11:15:56 INFO - 'TMOUT': '86400', 11:15:56 INFO - 'USER': 'cltbld', 11:15:56 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', 11:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:56 INFO - '_': '/tools/buildbot/bin/python'} 11:15:57 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:15:57 INFO - Downloading/unpacking pip>=1.5 11:15:57 INFO - Running setup.py egg_info for package pip 11:15:57 INFO - warning: no files found matching 'pip/cacert.pem' 11:15:57 INFO - warning: no files found matching '*.html' under directory 'docs' 11:15:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:15:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:15:57 INFO - Installing collected packages: pip 11:15:57 INFO - Found existing installation: pip 1.1 11:15:57 INFO - Uninstalling pip: 11:15:57 INFO - Successfully uninstalled pip 11:15:57 INFO - Running setup.py install for pip 11:15:57 INFO - warning: no files found matching 'pip/cacert.pem' 11:15:57 INFO - warning: no files found matching '*.html' under directory 'docs' 11:15:57 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:15:57 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:15:57 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:15:57 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:15:57 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:15:57 INFO - Successfully installed pip 11:15:57 INFO - Cleaning up... 11:15:57 INFO - Return code: 0 11:15:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:15:57 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:15:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:57 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:15:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:57 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 0x128b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1454a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fb090>, '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 0x15fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f5f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', '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:15:57 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:15:57 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:15:57 INFO - Using env: {'DISPLAY': ':0', 11:15:57 INFO - 'HOME': '/home/cltbld', 11:15:57 INFO - 'LANG': 'en_US.UTF-8', 11:15:57 INFO - 'LANGUAGE': 'en_US:en', 11:15:57 INFO - 'LOGNAME': 'cltbld', 11:15:57 INFO - 'MAIL': '/var/mail/cltbld', 11:15:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:57 INFO - 'MOZ_NO_REMOTE': '1', 11:15:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:15:57 INFO - 'NO_EM_RESTART': '1', 11:15:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:15:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:57 INFO - 'PWD': '/builds/slave/test', 11:15:57 INFO - 'SHELL': '/bin/bash', 11:15:57 INFO - 'SHLVL': '1', 11:15:57 INFO - 'TERM': 'linux', 11:15:57 INFO - 'TMOUT': '86400', 11:15:57 INFO - 'USER': 'cltbld', 11:15:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', 11:15:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:57 INFO - '_': '/tools/buildbot/bin/python'} 11:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:58 INFO - Downloading/unpacking psutil>=3.1.1 11:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:15:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:15:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:15:59 INFO - Installing collected packages: psutil 11:15:59 INFO - Running setup.py install for psutil 11:15:59 INFO - building 'psutil._psutil_linux' extension 11:15:59 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:16:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:16:00 INFO - building 'psutil._psutil_posix' extension 11:16:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:16:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:16:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:16:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:16:00 INFO - Successfully installed psutil 11:16:00 INFO - Cleaning up... 11:16:01 INFO - Return code: 0 11:16:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:16: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:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16: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:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1454a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fb090>, '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 0x15fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f5f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', '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:16:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:16:01 INFO - Using env: {'DISPLAY': ':0', 11:16:01 INFO - 'HOME': '/home/cltbld', 11:16:01 INFO - 'LANG': 'en_US.UTF-8', 11:16:01 INFO - 'LANGUAGE': 'en_US:en', 11:16:01 INFO - 'LOGNAME': 'cltbld', 11:16:01 INFO - 'MAIL': '/var/mail/cltbld', 11:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:01 INFO - 'MOZ_NO_REMOTE': '1', 11:16:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:01 INFO - 'NO_EM_RESTART': '1', 11:16:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:01 INFO - 'PWD': '/builds/slave/test', 11:16:01 INFO - 'SHELL': '/bin/bash', 11:16:01 INFO - 'SHLVL': '1', 11:16:01 INFO - 'TERM': 'linux', 11:16:01 INFO - 'TMOUT': '86400', 11:16:01 INFO - 'USER': 'cltbld', 11:16:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', 11:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:01 INFO - '_': '/tools/buildbot/bin/python'} 11:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:16:02 INFO - Installing collected packages: mozsystemmonitor 11:16:02 INFO - Running setup.py install for mozsystemmonitor 11:16:02 INFO - Successfully installed mozsystemmonitor 11:16:02 INFO - Cleaning up... 11:16:02 INFO - Return code: 0 11:16:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1454a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fb090>, '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 0x15fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f5f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', '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:16:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:16:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:16:02 INFO - Using env: {'DISPLAY': ':0', 11:16:02 INFO - 'HOME': '/home/cltbld', 11:16:02 INFO - 'LANG': 'en_US.UTF-8', 11:16:02 INFO - 'LANGUAGE': 'en_US:en', 11:16:02 INFO - 'LOGNAME': 'cltbld', 11:16:02 INFO - 'MAIL': '/var/mail/cltbld', 11:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:02 INFO - 'MOZ_NO_REMOTE': '1', 11:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:02 INFO - 'NO_EM_RESTART': '1', 11:16:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:02 INFO - 'PWD': '/builds/slave/test', 11:16:02 INFO - 'SHELL': '/bin/bash', 11:16:02 INFO - 'SHLVL': '1', 11:16:02 INFO - 'TERM': 'linux', 11:16:02 INFO - 'TMOUT': '86400', 11:16:02 INFO - 'USER': 'cltbld', 11:16:02 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', 11:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:02 INFO - '_': '/tools/buildbot/bin/python'} 11:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:02 INFO - Downloading/unpacking jsonschema==2.5.1 11:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:16:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:03 INFO - Downloading functools32-3.2.3-2.tar.gz 11:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:16:03 INFO - warning: no files found matching '*.txt' 11:16:03 INFO - no previously-included directories found matching 'build' 11:16:03 INFO - no previously-included directories found matching 'dist' 11:16:03 INFO - no previously-included directories found matching '.git*' 11:16:04 INFO - Installing collected packages: jsonschema, functools32 11:16:04 INFO - Running setup.py install for functools32 11:16:04 INFO - warning: no files found matching '*.txt' 11:16:04 INFO - no previously-included directories found matching 'build' 11:16:04 INFO - no previously-included directories found matching 'dist' 11:16:04 INFO - no previously-included directories found matching '.git*' 11:16:04 INFO - Successfully installed jsonschema functools32 11:16:04 INFO - Cleaning up... 11:16:04 INFO - Return code: 0 11:16:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x128b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1454a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fb090>, '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 0x15fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f5f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', '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:16:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:16:04 INFO - Using env: {'DISPLAY': ':0', 11:16:04 INFO - 'HOME': '/home/cltbld', 11:16:04 INFO - 'LANG': 'en_US.UTF-8', 11:16:04 INFO - 'LANGUAGE': 'en_US:en', 11:16:04 INFO - 'LOGNAME': 'cltbld', 11:16:04 INFO - 'MAIL': '/var/mail/cltbld', 11:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:04 INFO - 'MOZ_NO_REMOTE': '1', 11:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:04 INFO - 'NO_EM_RESTART': '1', 11:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:04 INFO - 'PWD': '/builds/slave/test', 11:16:04 INFO - 'SHELL': '/bin/bash', 11:16:04 INFO - 'SHLVL': '1', 11:16:04 INFO - 'TERM': 'linux', 11:16:04 INFO - 'TMOUT': '86400', 11:16:04 INFO - 'USER': 'cltbld', 11:16:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', 11:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:04 INFO - '_': '/tools/buildbot/bin/python'} 11:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:16:04 INFO - Cleaning up... 11:16:04 INFO - Return code: 0 11:16:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1454a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fb090>, '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 0x15fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f5f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', '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:16:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:16:04 INFO - Using env: {'DISPLAY': ':0', 11:16:04 INFO - 'HOME': '/home/cltbld', 11:16:04 INFO - 'LANG': 'en_US.UTF-8', 11:16:04 INFO - 'LANGUAGE': 'en_US:en', 11:16:04 INFO - 'LOGNAME': 'cltbld', 11:16:04 INFO - 'MAIL': '/var/mail/cltbld', 11:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:04 INFO - 'MOZ_NO_REMOTE': '1', 11:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:04 INFO - 'NO_EM_RESTART': '1', 11:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:04 INFO - 'PWD': '/builds/slave/test', 11:16:04 INFO - 'SHELL': '/bin/bash', 11:16:04 INFO - 'SHLVL': '1', 11:16:04 INFO - 'TERM': 'linux', 11:16:04 INFO - 'TMOUT': '86400', 11:16:04 INFO - 'USER': 'cltbld', 11:16:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', 11:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:04 INFO - '_': '/tools/buildbot/bin/python'} 11:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:04 INFO - Downloading/unpacking blobuploader==1.2.4 11:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:05 INFO - Downloading blobuploader-1.2.4.tar.gz 11:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:16:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:16:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:16:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:16:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:16: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:16: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:16: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:16: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:16:06 INFO - Downloading docopt-0.6.1.tar.gz 11:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:16:06 INFO - Installing collected packages: blobuploader, requests, docopt 11:16:06 INFO - Running setup.py install for blobuploader 11:16:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:16:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:16:06 INFO - Running setup.py install for requests 11:16:06 INFO - Running setup.py install for docopt 11:16:06 INFO - Successfully installed blobuploader requests docopt 11:16:06 INFO - Cleaning up... 11:16:06 INFO - Return code: 0 11:16:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1454a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fb090>, '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 0x15fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f5f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', '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:16:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:16:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:16:06 INFO - Using env: {'DISPLAY': ':0', 11:16:06 INFO - 'HOME': '/home/cltbld', 11:16:06 INFO - 'LANG': 'en_US.UTF-8', 11:16:06 INFO - 'LANGUAGE': 'en_US:en', 11:16:06 INFO - 'LOGNAME': 'cltbld', 11:16:06 INFO - 'MAIL': '/var/mail/cltbld', 11:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:06 INFO - 'MOZ_NO_REMOTE': '1', 11:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:06 INFO - 'NO_EM_RESTART': '1', 11:16:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:06 INFO - 'PWD': '/builds/slave/test', 11:16:06 INFO - 'SHELL': '/bin/bash', 11:16:06 INFO - 'SHLVL': '1', 11:16:06 INFO - 'TERM': 'linux', 11:16:06 INFO - 'TMOUT': '86400', 11:16:06 INFO - 'USER': 'cltbld', 11:16:06 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', 11:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:06 INFO - '_': '/tools/buildbot/bin/python'} 11:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:16:07 INFO - Running setup.py (path:/tmp/pip-tJDj17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:16:07 INFO - Running setup.py (path:/tmp/pip-jIqHvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:16:07 INFO - Running setup.py (path:/tmp/pip-3kJa1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:16:07 INFO - Running setup.py (path:/tmp/pip-pw2ua3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:16:07 INFO - Running setup.py (path:/tmp/pip-Djr2qL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:16:07 INFO - Running setup.py (path:/tmp/pip-heb4_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:16:07 INFO - Running setup.py (path:/tmp/pip-5K2z8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:16:07 INFO - Running setup.py (path:/tmp/pip-70RZ0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:16:07 INFO - Running setup.py (path:/tmp/pip-SWeON0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:16:07 INFO - Running setup.py (path:/tmp/pip-Z03K29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:16:07 INFO - Running setup.py (path:/tmp/pip-tfPjw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:16:07 INFO - Running setup.py (path:/tmp/pip-40sCtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:16:07 INFO - Running setup.py (path:/tmp/pip-Ilb0NS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:16:08 INFO - Running setup.py (path:/tmp/pip-i3x61R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:08 INFO - Running setup.py (path:/tmp/pip-BQDFRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:16:08 INFO - Running setup.py (path:/tmp/pip-RxaCn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:16:08 INFO - Running setup.py (path:/tmp/pip-M6v_0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:16:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:16:08 INFO - Running setup.py install for manifestparser 11:16:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:16:08 INFO - Running setup.py install for mozcrash 11:16:08 INFO - Running setup.py install for mozdebug 11:16:08 INFO - Running setup.py install for mozdevice 11:16:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:16:08 INFO - Running setup.py install for mozfile 11:16:08 INFO - Running setup.py install for mozhttpd 11:16:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:16:08 INFO - Running setup.py install for mozinfo 11:16:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:16:08 INFO - Running setup.py install for mozInstall 11:16:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:16:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:16:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:16:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:16:09 INFO - Running setup.py install for mozleak 11:16:09 INFO - Running setup.py install for mozlog 11:16:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:16:09 INFO - Running setup.py install for moznetwork 11:16:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:16:09 INFO - Running setup.py install for mozprocess 11:16:09 INFO - Running setup.py install for mozprofile 11:16:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:16:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:16:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:16:09 INFO - Running setup.py install for mozrunner 11:16:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:16:09 INFO - Running setup.py install for mozscreenshot 11:16:09 INFO - Running setup.py install for moztest 11:16:09 INFO - Running setup.py install for mozversion 11:16:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:16:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:16:10 INFO - Cleaning up... 11:16:10 INFO - Return code: 0 11:16:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:10 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 0x128b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1454a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fb090>, '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 0x15fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f5f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', '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:16:10 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:16:10 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:16:10 INFO - Using env: {'DISPLAY': ':0', 11:16:10 INFO - 'HOME': '/home/cltbld', 11:16:10 INFO - 'LANG': 'en_US.UTF-8', 11:16:10 INFO - 'LANGUAGE': 'en_US:en', 11:16:10 INFO - 'LOGNAME': 'cltbld', 11:16:10 INFO - 'MAIL': '/var/mail/cltbld', 11:16:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:10 INFO - 'MOZ_NO_REMOTE': '1', 11:16:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:10 INFO - 'NO_EM_RESTART': '1', 11:16:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:10 INFO - 'PWD': '/builds/slave/test', 11:16:10 INFO - 'SHELL': '/bin/bash', 11:16:10 INFO - 'SHLVL': '1', 11:16:10 INFO - 'TERM': 'linux', 11:16:10 INFO - 'TMOUT': '86400', 11:16:10 INFO - 'USER': 'cltbld', 11:16:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', 11:16:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:10 INFO - '_': '/tools/buildbot/bin/python'} 11:16:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:16:10 INFO - Running setup.py (path:/tmp/pip-9rl4kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:16:10 INFO - Running setup.py (path:/tmp/pip-3ZE1x9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:16:10 INFO - Running setup.py (path:/tmp/pip-hNUJa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:16:10 INFO - Running setup.py (path:/tmp/pip-pUDnRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:16:10 INFO - Running setup.py (path:/tmp/pip-7dOZpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:16:10 INFO - Running setup.py (path:/tmp/pip-lSXYE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:16:10 INFO - Running setup.py (path:/tmp/pip-xHQA46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:16:10 INFO - Running setup.py (path:/tmp/pip-pbbe7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:16:10 INFO - Running setup.py (path:/tmp/pip-VadkoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:16:10 INFO - Running setup.py (path:/tmp/pip-u_SYpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:16:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:16:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:16:10 INFO - Running setup.py (path:/tmp/pip-006WYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:16:11 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:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:16:11 INFO - Running setup.py (path:/tmp/pip-K4kizt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:16:11 INFO - Running setup.py (path:/tmp/pip-7xtVe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:16:11 INFO - Running setup.py (path:/tmp/pip-hRvK1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:11 INFO - Running setup.py (path:/tmp/pip-LJrb38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:16:11 INFO - Running setup.py (path:/tmp/pip-zHPqiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:16:11 INFO - Running setup.py (path:/tmp/pip-lxYUJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:16:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:16: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:16: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:16: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:16: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:16:12 INFO - Downloading blessings-1.6.tar.gz 11:16:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:16:12 INFO - Installing collected packages: blessings 11:16:12 INFO - Running setup.py install for blessings 11:16:12 INFO - Successfully installed blessings 11:16:12 INFO - Cleaning up... 11:16:12 INFO - Return code: 0 11:16:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:16:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:16:13 INFO - Reading from file tmpfile_stdout 11:16:13 INFO - Current package versions: 11:16:13 INFO - argparse == 1.2.1 11:16:13 INFO - blessings == 1.6 11:16:13 INFO - blobuploader == 1.2.4 11:16:13 INFO - docopt == 0.6.1 11:16:13 INFO - functools32 == 3.2.3-2 11:16:13 INFO - jsonschema == 2.5.1 11:16:13 INFO - manifestparser == 1.1 11:16:13 INFO - mozInstall == 1.13 11:16:13 INFO - mozcrash == 1.0 11:16:13 INFO - mozdebug == 0.1 11:16:13 INFO - mozdevice == 0.51 11:16:13 INFO - mozfile == 1.2 11:16:13 INFO - mozhttpd == 0.7 11:16:13 INFO - mozinfo == 0.10 11:16:13 INFO - mozleak == 0.1 11:16:13 INFO - mozlog == 3.5 11:16:13 INFO - moznetwork == 0.27 11:16:13 INFO - mozprocess == 0.25 11:16:13 INFO - mozprofile == 0.28 11:16:13 INFO - mozrunner == 6.13 11:16:13 INFO - mozscreenshot == 0.1 11:16:13 INFO - mozsystemmonitor == 0.3 11:16:13 INFO - moztest == 0.8 11:16:13 INFO - mozversion == 1.4 11:16:13 INFO - psutil == 3.1.1 11:16:13 INFO - requests == 1.2.3 11:16:13 INFO - wsgiref == 0.1.2 11:16:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:16: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:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16: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:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:13 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 0x128b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1454a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fb090>, '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 0x15fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f5f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', '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:16:13 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:16:13 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:16:13 INFO - Using env: {'DISPLAY': ':0', 11:16:13 INFO - 'HOME': '/home/cltbld', 11:16:13 INFO - 'LANG': 'en_US.UTF-8', 11:16:13 INFO - 'LANGUAGE': 'en_US:en', 11:16:13 INFO - 'LOGNAME': 'cltbld', 11:16:13 INFO - 'MAIL': '/var/mail/cltbld', 11:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:13 INFO - 'MOZ_NO_REMOTE': '1', 11:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:13 INFO - 'NO_EM_RESTART': '1', 11:16:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:13 INFO - 'PWD': '/builds/slave/test', 11:16:13 INFO - 'SHELL': '/bin/bash', 11:16:13 INFO - 'SHLVL': '1', 11:16:13 INFO - 'TERM': 'linux', 11:16:13 INFO - 'TMOUT': '86400', 11:16:13 INFO - 'USER': 'cltbld', 11:16:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', 11:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:13 INFO - '_': '/tools/buildbot/bin/python'} 11:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:16:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:16:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:16: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:16: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:16: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:16: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:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:16:14 INFO - Installing collected packages: simplejson 11:16:14 INFO - Running setup.py install for simplejson 11:16:14 INFO - building 'simplejson._speedups' extension 11:16:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:16:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:16:15 INFO - Successfully installed simplejson 11:16:15 INFO - Cleaning up... 11:16:15 INFO - Return code: 0 11:16:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:16:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x128b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1454a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f7a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15fb090>, '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 0x15fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f5f90>, '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': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', '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:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:16:15 INFO - Using env: {'DISPLAY': ':0', 11:16:15 INFO - 'HOME': '/home/cltbld', 11:16:15 INFO - 'LANG': 'en_US.UTF-8', 11:16:15 INFO - 'LANGUAGE': 'en_US:en', 11:16:15 INFO - 'LOGNAME': 'cltbld', 11:16:15 INFO - 'MAIL': '/var/mail/cltbld', 11:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:15 INFO - 'MOZ_NO_REMOTE': '1', 11:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:15 INFO - 'NO_EM_RESTART': '1', 11:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:15 INFO - 'PWD': '/builds/slave/test', 11:16:15 INFO - 'SHELL': '/bin/bash', 11:16:15 INFO - 'SHLVL': '1', 11:16:15 INFO - 'TERM': 'linux', 11:16:15 INFO - 'TMOUT': '86400', 11:16:15 INFO - 'USER': 'cltbld', 11:16:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', 11:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:15 INFO - '_': '/tools/buildbot/bin/python'} 11:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:16:15 INFO - Cleaning up... 11:16:15 INFO - Return code: 0 11:16:15 INFO - Running post-action listener: _resource_record_post_action 11:16:15 INFO - Running post-action listener: _start_resource_monitoring 11:16:15 INFO - Starting resource monitoring. 11:16:15 INFO - [mozharness: 2017-09-02 18:16:15.880555Z] Finished create-virtualenv step (success) 11:16:15 INFO - [mozharness: 2017-09-02 18:16:15.881651Z] Running install step. 11:16:15 INFO - Running pre-action listener: _resource_record_pre_action 11:16:15 INFO - Running main action method: install 11:16:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:16:16 INFO - Reading from file tmpfile_stdout 11:16:16 INFO - Detecting whether we're running mozinstall >=1.0... 11:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:16:16 INFO - Reading from file tmpfile_stdout 11:16:16 INFO - Output received: 11:16:16 INFO - Usage: mozinstall [options] installer 11:16:16 INFO - Options: 11:16:16 INFO - -h, --help show this help message and exit 11:16:16 INFO - -d DEST, --destination=DEST 11:16:16 INFO - Directory to install application into. [default: 11:16:16 INFO - "/builds/slave/test"] 11:16:16 INFO - --app=APP Application being installed. [default: firefox] 11:16:16 INFO - mkdir: /builds/slave/test/build/application 11:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:16:32 INFO - Reading from file tmpfile_stdout 11:16:32 INFO - Output received: 11:16:32 INFO - /builds/slave/test/build/application/firefox/firefox 11:16:32 INFO - Running post-action listener: _resource_record_post_action 11:16:32 INFO - [mozharness: 2017-09-02 18:16:32.711966Z] Finished install step (success) 11:16:32 INFO - [mozharness: 2017-09-02 18:16:32.712217Z] Running setup-mitmproxy step. 11:16:32 INFO - Running pre-action listener: _resource_record_pre_action 11:16:32 INFO - Running main action method: setup_mitmproxy 11:16:32 INFO - Skipping: mitmproxy is not required 11:16:32 INFO - Running post-action listener: _resource_record_post_action 11:16:32 INFO - [mozharness: 2017-09-02 18:16:32.713337Z] Finished setup-mitmproxy step (success) 11:16:32 INFO - [mozharness: 2017-09-02 18:16:32.713656Z] Running run-tests step. 11:16:32 INFO - Running pre-action listener: _resource_record_pre_action 11:16:32 INFO - Running pre-action listener: _set_gcov_prefix 11:16:32 INFO - Running main action method: run_tests 11:16:32 WARNING - Try message not found. 11:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:16:32 INFO - Python 2.7.3 11:16:32 INFO - Return code: 0 11:16:32 INFO - grabbing minidump binary from tooltool 11:16:32 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:16:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x15fb090>, '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 0x15fbd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f5f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:16:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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:16:32 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:16:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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:16:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:16:32 INFO - Return code: 0 11:16:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:16:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:16:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:16:32 INFO - ENV: RUST_BACKTRACE is now full 11:16:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:16:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:16:32 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/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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:16:32 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/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-011 --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:16:32 INFO - Using env: {'DISPLAY': ':0', 11:16:32 INFO - 'HOME': '/home/cltbld', 11:16:32 INFO - 'LANG': 'en_US.UTF-8', 11:16:32 INFO - 'LANGUAGE': 'en_US:en', 11:16:32 INFO - 'LOGNAME': 'cltbld', 11:16:32 INFO - 'MAIL': '/var/mail/cltbld', 11:16:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:16:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:16:32 INFO - 'MOZ_ACCELERATED': '1', 11:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:32 INFO - 'MOZ_NO_REMOTE': '1', 11:16:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:16:32 INFO - 'MOZ_WEBRENDER': '1', 11:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:32 INFO - 'NO_EM_RESTART': '1', 11:16:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:32 INFO - 'PWD': '/builds/slave/test', 11:16:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:16:32 INFO - 'RUST_BACKTRACE': 'full', 11:16:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:16:32 INFO - 'SHELL': '/bin/bash', 11:16:32 INFO - 'SHLVL': '1', 11:16:32 INFO - 'TERM': 'linux', 11:16:32 INFO - 'TMOUT': '86400', 11:16:32 INFO - 'USER': 'cltbld', 11:16:32 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', 11:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:32 INFO - '_': '/tools/buildbot/bin/python'} 11:16:32 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/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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:16:33 INFO - mozversion application_buildid: 20170902172544 11:16:33 INFO - mozversion application_changeset: 59611e1583e7411bab615d29109894e4c657af33 11:16:33 INFO - mozversion application_display_name: Nightly 11:16:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:16:33 INFO - mozversion application_name: Firefox 11:16:33 INFO - mozversion application_remotingname: firefox 11:16:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:16:33 INFO - mozversion application_vendor: Mozilla 11:16:33 INFO - mozversion application_version: 57.0a1 11:16:33 INFO - mozversion platform_buildid: 20170902172544 11:16:33 INFO - mozversion platform_changeset: 59611e1583e7411bab615d29109894e4c657af33 11:16:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:16:33 INFO - mozversion platform_version: 57.0a1 11:16:33 INFO - using testdate: 1504376193 11:16:33 INFO - actual date: 1504376193 11:16:33 INFO - starting webserver on 'localhost:52725' 11:16:33 INFO - SUITE-START | Running 2 tests 11:16:33 INFO - TEST-START | dromaeo_css 11:16:33 INFO - Initialising browser for dromaeo_css test... 11:16:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52725/getInfo.html -profile /tmp/tmpihD7Dn/profile 11:16:33 INFO - TEST-INFO | started process 3585 (/builds/slave/test/build/application/firefox/firefox http://localhost:52725/getInfo.html) 11:16:42 INFO - TEST-INFO | 3585: exit 0 11:16:42 INFO - Browser initialized. 11:16:42 INFO - Running cycle 1/1 for dromaeo_css test... 11:16:42 INFO - Using env: {'DISPLAY': ':0', 11:16:42 INFO - 'HOME': '/home/cltbld', 11:16:42 INFO - 'JSGC_DISABLE_POISONING': '1', 11:16:42 INFO - 'LANG': 'en_US.UTF-8', 11:16:42 INFO - 'LANGUAGE': 'en_US:en', 11:16:42 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:16:42 INFO - 'LOGNAME': 'cltbld', 11:16:42 INFO - 'MAIL': '/var/mail/cltbld', 11:16:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:16:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:16:42 INFO - 'MOZ_ACCELERATED': '1', 11:16:42 INFO - 'MOZ_CRASHREPORTER': '1', 11:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:42 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:16:42 INFO - 'MOZ_NO_REMOTE': '1', 11:16:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:16:42 INFO - 'MOZ_WEBRENDER': '1', 11:16:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:16:42 INFO - 'NO_EM_RESTART': '1', 11:16:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:42 INFO - 'PWD': '/builds/slave/test', 11:16:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:16:42 INFO - 'RUST_BACKTRACE': 'full', 11:16:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:16:42 INFO - 'SHELL': '/bin/bash', 11:16:42 INFO - 'SHLVL': '1', 11:16:42 INFO - 'TERM': 'linux', 11:16:42 INFO - 'TMOUT': '86400', 11:16:42 INFO - 'USER': 'cltbld', 11:16:42 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', 11:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:42 INFO - '_': '/tools/buildbot/bin/python'} 11:16:42 INFO - TEST-INFO | started process 3782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpihD7Dn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:43 INFO - PID 3782 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:16:43 INFO - PID 3782 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:16:43 INFO - PID 3782 | 11:16:43 INFO - PID 3782 | (/builds/slave/test/build/application/firefox/firefox:3846): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:16:43 INFO - PID 3782 | 11:16:54 INFO - PID 3782 | RSS: Main: 198823936 11:16:54 INFO - PID 3782 | 11:16:57 INFO - PID 3782 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:19:53 INFO - PID 3782 | Cycle 1(1): loaded http://localhost:52725/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52725/tests/dromaeo/cssquery-ext.html) 11:19:55 INFO - PID 3782 | RSS: Main: 212664320 11:19:55 INFO - PID 3782 | 11:22:57 INFO - PID 3782 | Cycle 1(1): loaded http://localhost:52725/tests/dromaeo/cssquery-ext.html (next: http://localhost:52725/tests/dromaeo/cssquery-jquery.html) 11:22:57 INFO - PID 3782 | RSS: Main: 210354176 11:22:57 INFO - PID 3782 | 11:25:59 INFO - PID 3782 | Cycle 1(1): loaded http://localhost:52725/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52725/tests/dromaeo/cssquery-mootools.html) 11:26:00 INFO - PID 3782 | RSS: Main: 212529152 11:26:00 INFO - PID 3782 | 11:29:02 INFO - PID 3782 | Cycle 1(1): loaded http://localhost:52725/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52725/tests/dromaeo/cssquery-prototype.html) 11:29:03 INFO - PID 3782 | RSS: Main: 211161088 11:29:03 INFO - PID 3782 | 11:32:07 INFO - PID 3782 | Cycle 1(1): loaded http://localhost:52725/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52725/tests/dromaeo/cssquery-yui.html) 11:32:07 INFO - PID 3782 | RSS: Main: 214773760 11:32:07 INFO - PID 3782 | 11:35:09 INFO - PID 3782 | Cycle 1(1): loaded http://localhost:52725/tests/dromaeo/cssquery-yui.html (next: http://localhost:52725/tests/dromaeo/cssquery-dojo.html) 11:35:09 INFO - PID 3782 | RSS: Main: 214646784 11:35:09 INFO - PID 3782 | 11:35:09 INFO - PID 3782 | __start_tp_report 11:35:09 INFO - PID 3782 | _x_x_mozilla_page_load 11:35:09 INFO - PID 3782 | _x_x_mozilla_page_load_details 11:35:09 INFO - PID 3782 | |i|pagename|runs| 11:35:09 INFO - PID 3782 | |0;dojo.html;3314.4862546305317;3352.6982571568556;3370.1911541230106;3386.0180547641185;3409.6931276185137;6282.2147231596055;6338.841528961772;6376.681165941696;6395.456386207172;6450.838729031777;6372.394622510854;6375.266844312905;6380.808575742723;6383.840403989891;6428;5822.647174714329;5833.737481813308;5843;5845.473907348338;5865.560082993771;5855.47300742933;5873.324567674708;5884.794032208873;5904.822855314326;5927.022041363191;5908.763649454017;5968.850778730544;5977.193078934353;5997.910031349533;6023.216981792383;5867.706614669292;5880.558958078119;5899.410058994109;5913.556483263751;5972.522198224154;5667.1782591524;5792.942070579283;5797.391273916262;5841.357450680422;5884.882302353929;6192.225971753531;6362.172917520739;6370.362963703593;6435.774747883802;6456.51576131792;6593.076969224312;6726.663666816639;6818.795436136924;6819.795406137824;6873.140857392826;6838.350356716153;6950.061741664861;6970.372666460043;6978.0230767692565;6978.162620485524;6440.871182576322;6443.806685799434;6465.191851018622;6470.223573171203;6478.967605162038;7048.048513450721;7056.435485161175;7140.393066589294;7144.499885008104;7160.248173941765;6544.9672751635935;6742.797716068526;6751.729930802713;6804.387605115563;6846.383825455633;6699.933000670028;6756.527043107034;6852.828679282959;6895.138107736533;6900.861982760317;6772.11962444879;6877.518573699893;6884.51808373419;6906.240313565504;6919.515633905679;6880.69036893341;6901.206361268418;6905.9309406906295;6987.755428560077;6989.650517474106;4976;5054.21659642756;5066.316047333637;5162.1224391853475;5162.6386152968935;4429.402030725875;4449.377087207794;4454.57681520255;4470.240059189946;4475;5981.760729570856;5990.850228744316;5996.760129594854;5998.700064996733;6012;6771.593704377753;6882;6883.552569082994;6884.380405763505;6887;5958.582899197015;5976.342602313742;6001.099835024781;6004.039353703386;6010.849728756729;5885.852853678607;5901.852453688693;5974.2233509643465;5996.370381110008;6032.758689652453;6658.876762051582;6698.5980841149685;6811.863762724718;6818.386345228953;6825.69284382204;6794.728210871707;6836.179658441019;6861.519693621399;6946.479014073863;7034.718611255697;6689.063531105747;6689.966550167218;6711.798646040431;6723.865522689616;6728.428083612947;6819.283975182733;6823.147106611674;6834.658267086526;6838.487113466411;6851.794446166623;6901.137357830271;6954.3045695430055;6988.79033628992;7021.0872586565465;7038.859222815618;6573.1454910861285;6602.1747281589805;6658.900116498159;6707.698153583003;6723.159605049369;6547.312532184052;6557.803265902031;6629;6637.900431493628;6648.16897887764;6195.473384762346;6607.900881486878;6627.734890604322;6648.833779155367;6649.534532582673;6693.531452798257;6716;6746.123004009447;6766.5263431559315;6773.221079575912;6351.2060992375955;6435.710393032418;6437.291897891322;6474.223093228654;6510.47916166715 11:35:09 INFO - PID 3782 | |1;ext.html;778.3967425245434;838.0613712641841;868.0711638546755;868.2359523619214;1119.6752941646923;29263.707362926365;29930.401391972147;38338.808305958504;39119.41320880189;39460.80269598648;39614.60385396145;39905.40141897867;40019;40033.199336013335;40055;7498.475106742517;7559.395248380117;7602.391808655322;7608.961955190244;7614;7273.527220730662;7352.04423424954;7357.448191385641;7367.521111127787;7369.447291453135;7030.191527974297;7217.278272172794;7368.189499155089;7376.926230737705;7649.6940122395035;7536.924630753704;7591.468597198198;7614.4669873108905;7622.161562228151;7622.4664273500875;7363.6318184091115;7533.510321829063;7534.397248220129;7549.471536992412;7561.508501947411;35476.46785298223;36477.81761091204;36547.63452365495;36669;36690.44964325537;3463.4458486642015;3486.9128271793406;3536.840842162109;3538.1862171700654;3546.4325707886874;30159.849200754074;30338.241543961576;30384.8480757597;30416.8479157605;30445;4966.404031516241;5080.974595127038;5142.404669299469;5167.509086636764;5248.580113590903;174412;175706;177311;178422;178631;46153.76923115363;46198.53801461942;46205.537944620126;46271.76864115658;46278.53721462809;47843.28235076477;48124.27813582799;48366.75816620894;48432.515674843504;48715.5128448711;15356.232188390535;15514.612134696497;15590.688186236212;15601.765973510406;15676.451324203597;12840.743185136245;12842.101052926206;12879.034072444416;12920.806187907188;12966.611001669966;13751.312434378442;13849.723005539832;13914.930425347808;13964.51124210668;14064.367103480368;5627.549796016309;5747.453991870766;5778.595498315078;5783.681897495678;5846.327672317738;1002.5037606384741;1011.4942528735633;1023.3246057602096;1024.5184763161303;1031.1493018259966;22891.7710822893;22971.770282297297;22973.42566435819;23089.307320780405;23447.882760586086;1094.5676457799125;1099.6591056772427;1099.9450027498592;1112.076976109827;1112.816385296417;11999.700007499709;12038.4582693779;12223.266604003788;12252.14235003559;12258.877411225774;227213;227632;228117;229090;229792;50585.49414505808;50842;50849;50869.74565127151;50996;1397.2943663450096;1425.1520345394474;1451.7822326651087;1465.904716193444;1475.9852401476062;25795.613065803653;26087.347816304744;26233.606495902193;26599.468010640066;26724.732752672226;36692;36819.263614728094;36985.81507092447;37144.442833358065;37194.8140259297;194023;195934;196397;196628;196777;32938;33968.15079623029;34125;34273.14317142092;34299.485507716905;40371.59628403679;40403.797981009906;40443.79778101091;40461.39307910325;40779.38830917479;32341.51487727639;32832;33056.83471582627;33326.33347333088;33338.666453342565;31623.20941976469;32454.188645283113;32474.675253247166;32943.176420589676;33197;35527;36524.45213321749;36841.26317473582;37396.252074958895;37479;31437;31801.8409907949;32030.67969320277;32111.35777284488;32173.356532868744;23840.64239036381;24098.63852042256;24441.51116977686;24488.51022979495;24783.380415489755 11:35:09 INFO - PID 3782 | |2;jquery.html;560.1681502968095;566.6430149006123;574.4915749561636;581.3953488372092;588.7998080652578;21567;22312.553748925053;22317.55364892703;22346.88826555867;22540.88729556354;23546.88226558869;25939.48121037578;25943.74056259437;25944.481110377783;25994.870025649892;6485.513586481009;6646.667666616674;6651.600903945755;6651.900221496681;6658.4673226141795;6323.272823625273;6407.295197528269;6537.052127441542;6629;6643.335666433342;6557;6564.737410503598;6568.047633093199;6594.703238354262;6622.139121914144;6528.314526974695;6568.540202185849;6576.145101136845;6632.2704502504685;6639.93360066398;6055.545834062419;6122.326544080148;6125.663088530129;6128.938710612882;6153.200083989098;27221.591676124874;28350;28692.426151477062;28836.567451488245;28839.85580072107;1941.5825597496605;2003.5291706448972;2006.8595198335977;2007.29744589394;2010.4169790760661;18531.90734046321;19178.13698383576;19182.52043698905;19201.519962000923;19205;2396.041583366667;2441.8523294051765;2465.8890349934295;2473.3322003059075;2476.2076135636603;131667;136732;139038;139121;139153;13886.236257005961;14002.859971400156;14397.78403323951;14470.855291446951;14602.707945841024;22522.77477225207;22678.886605566866;22697.432564185696;22777.544449110927;22799.658005129935;9937.503124843728;10069.54687039085;10121.645742398981;10329.690109296733;10330.741731456623;9429.481378524248;9484.762880927894;9488.857667134998;9584.76038099053;9588.232941364813;7566.848663026709;8756.649734010696;8973.910260897308;9020.684276050306;9171.81656366869;2663.2809141532066;2685.5166070107566;2754.4628797384717;2756.4349308391734;2785.1366076516347;931.3992474853682;937.151877550804;980.2060331131806;981.2885657897967;989.9208063354914;19153.61692766165;19181.520461988282;19240.8075919239;19631.509212269808;20001;1031.1750599520353;1045.1012129568564;1051.1748277602046;1052.5632511621582;1054.7099547624464;10441.634542790965;10557.736056598493;10600.946995264974;10664.733381665365;10743.78512429747;484866;485217;493132;496079;497229;117861;120391.39804301098;121780;123507.38246308711;124302;1137.8765289280977;1172.20290202663;1180.6458062581362;1180.7874582575048;1187.4003628167893;17298.82701172972;17592.648147037242;17628;20372;21465.356039318845;55107;55534.44465555293;56483.15275270792;57778.422215777304;61138.38861611505;64833.67583162054;65021.67489162524;65102;65207.67396162989;66251.66874165791;11542.307461552333;12074.27554346742;14476.203808790618;14660.266986650839;14684;17459.30162793474;17987.640247194722;23122.884385577963;23513.529729404974;23544.29367118989;18332.99168545743;18379.724304135718;18434.723479147557;18692;18770.530736731693;16229;16493.422730204384;16658.50024499267;16691.582710432336;16846.326146953983;19568.21727130899;19806.108725107115;19878.60242795107;19964.401067967985;19996.600067998268;13728.725425491235;14414.927925360305;14615.196164211071;14708.926455367655;14728.55814325572;18393.264269429073;18432.723509147105;18495.722564161817;18645.720314195027;18949.43151705451 11:35:09 INFO - PID 3782 | |3;mootools.html;1325.8607846176153;1360.1567028442366;1394.762890308647;1402.312866695319;1409.3376113226793;13211.471541138368;15030.624234394145;15599.922000389995;15630.218489075543;15739.134347610876;13069.67325816855;15177.089374637502;15589;15670.529884103467;15707.764383534257;2729.0857562716515;2811;2811.4939310924024;2817.09852847089;2817.3520090379125;2703.7566619004288;2756.531389663762;2812.8874845006176;2825.9152225433268;2832.5326321156986;2786.4148528808973;2812.1141840320233;2814.7466727994474;2817.478766428207;2824.1951043952477;2711.3221694576355;2730;2742.8491432971177;2742.9862850685818;2747;2735.685396179445;2763.295359683288;2771.2240572639694;2775.4587855368213;2776.514110030757;15091.169985650895;15417.3833046678;15483.612909677235;15504.379824806994;15536.145511996836;7850.528968261866;8177;8189.344852411793;8192.50844949299;8197.098319184885;5433.945660543383;5560.165975103726;5599.300087489064;5682.431756824326;5722.113072473731;1950.2004178286834;1974.4866334752924;1976.8616196866226;2014.1339224133617;2019.7475315585552;27552.448951020866;27763.305917352027;27780.444391112065;27832.30419239515;27833.72166278352;6485.351464853571;6499.09012738217;6931.202911665122;6966.12923384577;7109.111361079865;17514.64970700579;17561.648767024843;17609.207585658674;17638.382656607213;17670;7777.105632852295;7901.920980790233;7906.16985216544;7906.723264685824;7909.1695371985115;6946.826329341807;7230.855382892312;7278.417726581861;7293.489455738048;7316.597587132759;5275.235090911796;5350.652207606571;5366.91949620756;5480.479354461399;5520.282363292747;1391.8956078294168;1423.9715205695827;1440.6542429816768;1456.4611093895326;1467.5157198124593;894.7449976756593;920.4569304110473;942.3733217410345;949.3591825517748;952.8427809411509;7550.320471157622;7924.603769811486;7926.762197134095;8024.157463466368;8085.110637829834;971.2958105373548;984.6602921991902;987.8962708915604;1001.3241062283075;1022.3405903192548;5149.588032957355;5191.273221748958;5200.531952124251;5201.6358854880555;5308.601854860824;20666.896665516877;20777.896110519352;21670.34988950334;21770.346889593337;21901.342959711234;21265.255716049865;21399.25102621401;21462.356129316144;21473.248436304653;21714.89142554277;10324.328918620266;10922.399268040333;11555.480003399867;11721.941390293165;11751.823722644167;8528.445651032664;8713.651453941771;8723.476591404537;8733.257673097858;8767.123287671182;18592.907035464737;18593.070346482353;18602.627947441248;18836.52908677294;19195.712064318766;18768.906155469136;18792.342268020555;18887.716684249473;19454.124564394355;19564.510887227934;12294.524657041213;12321.260724356567;12463.813042804184;12489.125761196628;12502.062180362058;13773.655658608615;14041.297935103408;14047.157170569799;14055.929720351332;14064.718705626035;11027.283226590245;11044.226904116635;11416.257943233662;11505.597304094317;11715.062794976551;10882.891171088188;11096.556137754722;11151.498182581641;11308.943455283;11362.54549817998;9680.75798105053;9948.55231514598;9951.15415189717;9954.402735835873;9969.601215951281;7216.8917466237;7265.200827909031;7339.816504587428;7381.003564518721;7420.146683131293;7209.567425954459;7252.854942901218;7281.344678978918;7319.34125928669;7322.194558598443 11:35:09 INFO - PID 3782 | |4;prototype.html;496.322519760527;504.75267119111624;529.2933933199179;532.7948739735203;540.1870185371016;6304.464120549747;6370.821398041366;6373.844946751359;6470.191226096732;6482.481401487881;6056.1824153739235;6169.784057557987;6260.5930614510025;6292.748290068404;6325.46233570146;5104.69371837691;5105.259737338084;5134.383873935114;5151.536361727443;5166.689998600077;5023.799048038074;5099.592032637399;5101.20931255656;5105.744712764365;5137.691738495702;4865.562099411052;4888.800039982005;4974.8258810941625;4999.225120106389;5071.873203169932;4944.332515110468;4994.750262486898;5010.473900240495;5037.697738135687;5103.311053007834;4499.955000450019;4552.544745525454;4565.452145742499;4567.33773602829;4571.611413029863;6188.957643977476;6194.721237544276;6207.658578778165;6265.248170219557;6288.213973253343;5728.338781753287;5744.856378590527;5794.217780599607;5805.896879592864;5813.273340832396;6569.474442044625;6576.835579110512;6647.468202543785;6648.93351066488;6664.733410663568;4936.6050715943;4974.607110009203;4979.701217926936;4980.228064649985;4998.750062496861;7014.859702805916;7021.332973367573;7050.717971281143;7063.89404158938;7109.964450177716;5012.749362531858;5019.247112933016;5097.209932460474;5114.411842638145;5135.845924622267;5150.939624150295;5173.430922598511;5194.558462530652;5203.115470370046;5217.0870097733505;5807.82576522705;5831.241938548046;5842.824715258549;5859.765609375662;5874.9118763218585;6619.238787539398;6700.698468568926;6750.008747419523;6828.214755303204;6829.453643708492;1757.77148970633;1766.0639860873757;1769.2215425212864;1774.5031391210482;1787.204693911197;1120.9159313051555;1150.5857891159176;1182.2256422043574;1219.2806244315896;1232.5994051933158;5835.5915085944425;5864.7947321844385;5991.340952495222;6023.247094113236;6102.789075537865;6756.527043106936;6771.424428923498;6867.107276054181;6890.209465166616;6898.585495076683;5875.177475153482;5913.852153696106;5959.672218027963;6008.789692360747;6039.305479869783;3623.963760362363;3665.340238756996;3676.6690997810324;3700.6484383984016;3727.4781530585738;6673.933260667428;6730.97106302166;6740.752960702286;6787.201391631222;6821.897671534931;6800.08198893153;6874.175098988154;6988;7024.894626580605;7080.362767350963;6566.638834864033;6607.966960165265;6624.735010599522;6661.568527487432;6692.297308782702;6754.527183097136;6838.794836154923;6840.897386539305;6900.275471075464;6901.344372284625;6759.155105611799;6846.589204647538;6863.210730766026;6865.691043902936;6920.100386949664;6655;6693.661267746373;6697.732090716317;6707.8993815091835;6711.295313992156;4980.228064649985;5028.371453568304;5028.969061342489;5065.0116431305705;5108.208227724708;6687.465002799861;6838.111045564045;6869.668210917801;6888.517803753689;6959.791206263821;6505.707243173973;6517.511186661114;6520.804375868732;6617.205935287796;6653.405171983028;6433.356664333529;6498;6546.672666366758;6606.603603783596;6618.007298905202;6036.426539478743;6400.815849067937;6464.288928217987;6494.3505649436565;6557.606543607399;6603.405693487609;6699.832504187434;6717.328267173243;6719.26088130315;6764.526483146133;6366.140571022853;6368.681565921778;6449.161608990801;6481.35186481367;6524.67376631176 11:35:09 INFO - PID 3782 | |5;yui.html;889.0931250124869;902.963881444742;916.2669864108714;924.2744445610198;925.421611492817;19216.423507294785;20139;20176.798232017674;20233.59532809343;20234.89882550585;17173.570660733487;17250.82749172508;17318.393856215036;21569.46076348092;21581.136754529838;980.181548407081;999.7000899730052;1002.3785253143061;1004.4073996342157;1005.8541511480831;907.7412937312868;1006.4464544500496;1006.5017816180964;1007.0382784440878;1008.6066434090674;1055.430067763407;1056.8361903904868;1057.0961827637375;1057.9629712960048;1059.3802625464114;1052.5737076483997;1054.8734151901745;1055.0609957138076;1056.8097742406364;1062.0335494699825;766.4290103872595;767.3707559800965;769.5075151902787;775.9806004849868;779.8245394786185;19582.902085489623;19973.600527989358;20051.298204562918;20060.197592096298;20798.27206047781;20035.899820500803;20292.797072029385;20632.27787027447;20689.172433102656;20764.48088797777;16981.150942452827;17595.5601109972;17603.559911002198;17764.644707105785;17903.910480447645;3715.981420092882;3733.4399840023943;3745.5879853216397;3748.7188460865545;3761.811909404546;123245;123846;125667.3716631411;127763;128388;16362.754558681629;16554.751678724828;17076.573085672957;17154.914225428794;17289.13554322279;31382.215444614067;31610;31658.683413166033;31712.36575268482;31923.201919951724;8623.094575069654;8669.869951950726;8672.739817805475;8707.172818582225;8715.564221789013;4058.817353219112;4250.659947204216;4258.808353624095;4283.164782867373;4336.804843782037;5301.708406037705;5428.7285635718845;5436.374816896028;5437;5441.129419292894;1113.6158025481195;1125.7073160978205;1128.4752590045669;1134.7843909657138;1169.128998895811;668.1647940074906;676.3473248315399;692.4979389942251;695.2005194026909;695.3081683724625;11992.220505667105;12078.577249796215;12130.72627374113;12186.959952850542;12612.054095942658;673.3872176319526;685.2530741491798;685.5372623479132;694.5728377048079;706.5019161491136;5707.200991861143;5751.511121554631;5772.595918285764;5779.219805326311;5904;110316.44841775739;111783.44108279406;114559.20550799939;114672;115512;95879;96599;96936.51531742296;99475.50262248643;99977.50011250042;80558.59720701359;83433;83754;85654;87954.1204587946;11723.41382930833;12065.64381045562;12127.575534856238;12184.695382615506;12289.754204916031;39691.603083969945;40386.59613403946;40735;40761.79619101885;41947.1610567793;65780.6710966442;70480;70851;71446;73984.26015739773;18755.812441875405;19097.140628671466;19162.329318474345;19189;19490.512737181685;19580.944000879703;20127.09428075711;21150.47123821917;21593.24423645165;21954.45113872166;18589;18676.533086672942;18706.438806835817;19160.61678766389;20037.29869454562;18841.434756957315;19138.808611913704;19390.709139363204;19526.21895124236;20276.290329838386;18442.81557184411;18523.536911577317;18603.162857671166;18671.81328186755;18795.718064228775;12901;13778.931105344409;13781.310934453437;13822.377992990541;14057.297135143406;14144.575662730134;14305.356258968162;14372.49696260626;14409.855901440851;14480.275986200859 11:35:09 INFO - PID 3782 | __end_tp_report 11:35:09 INFO - PID 3782 | __start_cc_report 11:35:09 INFO - PID 3782 | _x_x_mozilla_cycle_collect,379 11:35:09 INFO - PID 3782 | __end_cc_report 11:35:09 INFO - PID 3782 | __startTimestamp1504377309909__endTimestamp 11:35:09 INFO - PID 3782 | 11:35:09 INFO - PID 3782 | ------- Summary: start ------- 11:35:09 INFO - PID 3782 | Number of tests: 6 11:35:09 INFO - PID 3782 | 11:35:09 INFO - PID 3782 | [#0] dojo.html Cycles:165 Average:6304.55 Median:6547.31 stddev:773.31 (11.8%) stddev-sans-first:739.25 11:35:09 INFO - PID 3782 | Values: 3314.5 3352.7 3370.2 3386.0 3409.7 6282.2 6338.8 6376.7 6395.5 6450.8 6372.4 6375.3 6380.8 6383.8 6428.0 5822.6 5833.7 5843.0 5845.5 5865.6 5855.5 5873.3 5884.8 5904.8 5927.0 5908.8 5968.9 5977.2 5997.9 6023.2 5867.7 5880.6 5899.4 5913.6 5972.5 5667.2 5792.9 5797.4 5841.4 5884.9 6192.2 6362.2 6370.4 6435.8 6456.5 6593.1 6726.7 6818.8 6819.8 6873.1 6838.4 6950.1 6970.4 6978.0 6978.2 6440.9 6443.8 6465.2 6470.2 6479.0 7048.0 7056.4 7140.4 7144.5 7160.2 6545.0 6742.8 6751.7 6804.4 6846.4 6699.9 6756.5 6852.8 6895.1 6900.9 6772.1 6877.5 6884.5 6906.2 6919.5 6880.7 6901.2 6905.9 6987.8 6989.7 4976.0 5054.2 5066.3 5162.1 5162.6 4429.4 4449.4 4454.6 4470.2 4475.0 5981.8 5990.9 5996.8 5998.7 6012.0 6771.6 6882.0 6883.6 6884.4 6887.0 5958.6 5976.3 6001.1 6004.0 6010.8 5885.9 5901.9 5974.2 5996.4 6032.8 6658.9 6698.6 6811.9 6818.4 6825.7 6794.7 6836.2 6861.5 6946.5 7034.7 6689.1 6690.0 6711.8 6723.9 6728.4 6819.3 6823.1 6834.7 6838.5 6851.8 6901.1 6954.3 6988.8 7021.1 7038.9 6573.1 6602.2 6658.9 6707.7 6723.2 6547.3 6557.8 6629.0 6637.9 6648.2 6195.5 6607.9 6627.7 6648.8 6649.5 6693.5 6716.0 6746.1 6766.5 6773.2 6351.2 6435.7 6437.3 6474.2 6510.5 11:35:09 INFO - PID 3782 | 11:35:09 INFO - PID 3782 | [#1] ext.html Cycles:180 Average:36622.14 Median:34199.07 stddev:52136.25 (152.4%) stddev-sans-first:52213.03 11:35:09 INFO - PID 3782 | Values: 778.4 838.1 868.1 868.2 1119.7 29263.7 29930.4 38338.8 39119.4 39460.8 39614.6 39905.4 40019.0 40033.2 40055.0 7498.5 7559.4 7602.4 7609.0 7614.0 7273.5 7352.0 7357.4 7367.5 7369.4 7030.2 7217.3 7368.2 7376.9 7649.7 7536.9 7591.5 7614.5 7622.2 7622.5 7363.6 7533.5 7534.4 7549.5 7561.5 35476.5 36477.8 36547.6 36669.0 36690.4 3463.4 3486.9 3536.8 3538.2 3546.4 30159.8 30338.2 30384.8 30416.8 30445.0 4966.4 5081.0 5142.4 5167.5 5248.6 174412.0 175706.0 177311.0 178422.0 178631.0 46153.8 46198.5 46205.5 46271.8 46278.5 47843.3 48124.3 48366.8 48432.5 48715.5 15356.2 15514.6 15590.7 15601.8 15676.5 12840.7 12842.1 12879.0 12920.8 12966.6 13751.3 13849.7 13914.9 13964.5 14064.4 5627.5 5747.5 5778.6 5783.7 5846.3 1002.5 1011.5 1023.3 1024.5 1031.1 22891.8 22971.8 22973.4 23089.3 23447.9 1094.6 1099.7 1099.9 1112.1 1112.8 11999.7 12038.5 12223.3 12252.1 12258.9 227213.0 227632.0 228117.0 229090.0 229792.0 50585.5 50842.0 50849.0 50869.7 50996.0 1397.3 1425.2 1451.8 1465.9 1476.0 25795.6 26087.3 26233.6 26599.5 26724.7 36692.0 36819.3 36985.8 37144.4 37194.8 194023.0 195934.0 196397.0 196628.0 196777.0 32938.0 33968.2 34125.0 34273.1 34299.5 40371.6 40403.8 40443.8 40461.4 40779.4 32341.5 32832.0 33056.8 33326.3 33338.7 31623.2 32454.2 32474.7 32943.2 33197.0 35527.0 36524.5 36841.3 37396.3 37479.0 31437.0 31801.8 32030.7 32111.4 32173.4 23840.6 24098.6 24441.5 24488.5 24783.4 11:35:09 INFO - PID 3782 | 11:35:09 INFO - PID 3782 | [#2] jquery.html Cycles:180 Average:34661.88 Median:22531.83 stddev:82874.82 (367.8%) stddev-sans-first:83067.75 11:35:09 INFO - PID 3782 | Values: 560.2 566.6 574.5 581.4 588.8 21567.0 22312.6 22317.6 22346.9 22540.9 23546.9 25939.5 25943.7 25944.5 25994.9 6485.5 6646.7 6651.6 6651.9 6658.5 6323.3 6407.3 6537.1 6629.0 6643.3 6557.0 6564.7 6568.0 6594.7 6622.1 6528.3 6568.5 6576.1 6632.3 6639.9 6055.5 6122.3 6125.7 6128.9 6153.2 27221.6 28350.0 28692.4 28836.6 28839.9 1941.6 2003.5 2006.9 2007.3 2010.4 18531.9 19178.1 19182.5 19201.5 19205.0 2396.0 2441.9 2465.9 2473.3 2476.2 131667.0 136732.0 139038.0 139121.0 139153.0 13886.2 14002.9 14397.8 14470.9 14602.7 22522.8 22678.9 22697.4 22777.5 22799.7 9937.5 10069.5 10121.6 10329.7 10330.7 9429.5 9484.8 9488.9 9584.8 9588.2 7566.8 8756.6 8973.9 9020.7 9171.8 2663.3 2685.5 2754.5 2756.4 2785.1 931.4 937.2 980.2 981.3 989.9 19153.6 19181.5 19240.8 19631.5 20001.0 1031.2 1045.1 1051.2 1052.6 1054.7 10441.6 10557.7 10600.9 10664.7 10743.8 484866.0 485217.0 493132.0 496079.0 497229.0 117861.0 120391.4 121780.0 123507.4 124302.0 1137.9 1172.2 1180.6 1180.8 1187.4 17298.8 17592.6 17628.0 20372.0 21465.4 55107.0 55534.4 56483.2 57778.4 61138.4 64833.7 65021.7 65102.0 65207.7 66251.7 11542.3 12074.3 14476.2 14660.3 14684.0 17459.3 17987.6 23122.9 23513.5 23544.3 18333.0 18379.7 18434.7 18692.0 18770.5 16229.0 16493.4 16658.5 16691.6 16846.3 19568.2 19806.1 19878.6 19964.4 19996.6 13728.7 14414.9 14615.2 14708.9 14728.6 18393.3 18432.7 18495.7 18645.7 18949.4 11:35:09 INFO - PID 3782 | 11:35:09 INFO - PID 3782 | [#3] mootools.html Cycles:180 Average:9434.15 Median:15154.49 stddev:6762.27 (44.6%) stddev-sans-first:6753.80 11:35:09 INFO - PID 3782 | Values: 1325.9 1360.2 1394.8 1402.3 1409.3 13211.5 15030.6 15599.9 15630.2 15739.1 13069.7 15177.1 15589.0 15670.5 15707.8 2729.1 2811.0 2811.5 2817.1 2817.4 2703.8 2756.5 2812.9 2825.9 2832.5 2786.4 2812.1 2814.7 2817.5 2824.2 2711.3 2730.0 2742.8 2743.0 2747.0 2735.7 2763.3 2771.2 2775.5 2776.5 15091.2 15417.4 15483.6 15504.4 15536.1 7850.5 8177.0 8189.3 8192.5 8197.1 5433.9 5560.2 5599.3 5682.4 5722.1 1950.2 1974.5 1976.9 2014.1 2019.7 27552.4 27763.3 27780.4 27832.3 27833.7 6485.4 6499.1 6931.2 6966.1 7109.1 17514.6 17561.6 17609.2 17638.4 17670.0 7777.1 7901.9 7906.2 7906.7 7909.2 6946.8 7230.9 7278.4 7293.5 7316.6 5275.2 5350.7 5366.9 5480.5 5520.3 1391.9 1424.0 1440.7 1456.5 1467.5 894.7 920.5 942.4 949.4 952.8 7550.3 7924.6 7926.8 8024.2 8085.1 971.3 984.7 987.9 1001.3 1022.3 5149.6 5191.3 5200.5 5201.6 5308.6 20666.9 20777.9 21670.3 21770.3 21901.3 21265.3 21399.3 21462.4 21473.2 21714.9 10324.3 10922.4 11555.5 11721.9 11751.8 8528.4 8713.7 8723.5 8733.3 8767.1 18592.9 18593.1 18602.6 18836.5 19195.7 18768.9 18792.3 18887.7 19454.1 19564.5 12294.5 12321.3 12463.8 12489.1 12502.1 13773.7 14041.3 14047.2 14055.9 14064.7 11027.3 11044.2 11416.3 11505.6 11715.1 10882.9 11096.6 11151.5 11308.9 11362.5 9680.8 9948.6 9951.2 9954.4 9969.6 7216.9 7265.2 7339.8 7381.0 7420.1 7209.6 7252.9 7281.3 7319.3 7322.2 11:35:09 INFO - PID 3782 | 11:35:09 INFO - PID 3782 | [#4] prototype.html Cycles:180 Average:5612.36 Median:6234.13 stddev:1581.11 (25.4%) stddev-sans-first:1538.21 11:35:09 INFO - PID 3782 | Values: 496.3 504.8 529.3 532.8 540.2 6304.5 6370.8 6373.8 6470.2 6482.5 6056.2 6169.8 6260.6 6292.7 6325.5 5104.7 5105.3 5134.4 5151.5 5166.7 5023.8 5099.6 5101.2 5105.7 5137.7 4865.6 4888.8 4974.8 4999.2 5071.9 4944.3 4994.8 5010.5 5037.7 5103.3 4500.0 4552.5 4565.5 4567.3 4571.6 6189.0 6194.7 6207.7 6265.2 6288.2 5728.3 5744.9 5794.2 5805.9 5813.3 6569.5 6576.8 6647.5 6648.9 6664.7 4936.6 4974.6 4979.7 4980.2 4998.8 7014.9 7021.3 7050.7 7063.9 7110.0 5012.7 5019.2 5097.2 5114.4 5135.8 5150.9 5173.4 5194.6 5203.1 5217.1 5807.8 5831.2 5842.8 5859.8 5874.9 6619.2 6700.7 6750.0 6828.2 6829.5 1757.8 1766.1 1769.2 1774.5 1787.2 1120.9 1150.6 1182.2 1219.3 1232.6 5835.6 5864.8 5991.3 6023.2 6102.8 6756.5 6771.4 6867.1 6890.2 6898.6 5875.2 5913.9 5959.7 6008.8 6039.3 3624.0 3665.3 3676.7 3700.6 3727.5 6673.9 6731.0 6740.8 6787.2 6821.9 6800.1 6874.2 6988.0 7024.9 7080.4 6566.6 6608.0 6624.7 6661.6 6692.3 6754.5 6838.8 6840.9 6900.3 6901.3 6759.2 6846.6 6863.2 6865.7 6920.1 6655.0 6693.7 6697.7 6707.9 6711.3 4980.2 5028.4 5029.0 5065.0 5108.2 6687.5 6838.1 6869.7 6888.5 6959.8 6505.7 6517.5 6520.8 6617.2 6653.4 6433.4 6498.0 6546.7 6606.6 6618.0 6036.4 6400.8 6464.3 6494.4 6557.6 6603.4 6699.8 6717.3 6719.3 6764.5 6366.1 6368.7 6449.2 6481.4 6524.7 11:35:09 INFO - PID 3782 | 11:35:09 INFO - PID 3782 | [#5] yui.html Cycles:180 Average:23988.96 Median:20093.65 stddev:32239.73 (160.4%) stddev-sans-first:32283.51 11:35:09 INFO - PID 3782 | Values: 889.1 903.0 916.3 924.3 925.4 19216.4 20139.0 20176.8 20233.6 20234.9 17173.6 17250.8 17318.4 21569.5 21581.1 980.2 999.7 1002.4 1004.4 1005.9 907.7 1006.4 1006.5 1007.0 1008.6 1055.4 1056.8 1057.1 1058.0 1059.4 1052.6 1054.9 1055.1 1056.8 1062.0 766.4 767.4 769.5 776.0 779.8 19582.9 19973.6 20051.3 20060.2 20798.3 20035.9 20292.8 20632.3 20689.2 20764.5 16981.2 17595.6 17603.6 17764.6 17903.9 3716.0 3733.4 3745.6 3748.7 3761.8 123245.0 123846.0 125667.4 127763.0 128388.0 16362.8 16554.8 17076.6 17154.9 17289.1 31382.2 31610.0 31658.7 31712.4 31923.2 8623.1 8669.9 8672.7 8707.2 8715.6 4058.8 4250.7 4258.8 4283.2 4336.8 5301.7 5428.7 5436.4 5437.0 5441.1 1113.6 1125.7 1128.5 1134.8 1169.1 668.2 676.3 692.5 695.2 695.3 11992.2 12078.6 12130.7 12187.0 12612.1 673.4 685.3 685.5 694.6 706.5 5707.2 5751.5 5772.6 5779.2 5904.0 110316.4 111783.4 114559.2 114672.0 115512.0 95879.0 96599.0 96936.5 99475.5 99977.5 80558.6 83433.0 83754.0 85654.0 87954.1 11723.4 12065.6 12127.6 12184.7 12289.8 39691.6 40386.6 40735.0 40761.8 41947.2 65780.7 70480.0 70851.0 71446.0 73984.3 18755.8 19097.1 19162.3 19189.0 19490.5 19580.9 20127.1 21150.5 21593.2 21954.5 18589.0 18676.5 18706.4 19160.6 20037.3 18841.4 19138.8 19390.7 19526.2 20276.3 18442.8 18523.5 18603.2 18671.8 18795.7 12901.0 13778.9 13781.3 13822.4 14057.3 14144.6 14305.4 14372.5 14409.9 14480.3 11:35:09 INFO - PID 3782 | -------- Summary: end -------- 11:35:09 INFO - PID 3782 | 11:35:10 INFO - TEST-INFO | 3782: exit 0 11:35:10 INFO - TEST-OK | dromaeo_css | took 1117791ms 11:35:10 INFO - TEST-START | kraken 11:35:10 INFO - Initialising browser for kraken test... 11:35:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52725/getInfo.html -profile /tmp/tmpwJgPjK/profile 11:35:11 INFO - TEST-INFO | started process 4176 (/builds/slave/test/build/application/firefox/firefox http://localhost:52725/getInfo.html) 11:35:17 INFO - TEST-INFO | 4176: exit 0 11:35:17 INFO - Browser initialized. 11:35:17 INFO - Running cycle 1/1 for kraken test... 11:35:17 INFO - Using env: {'DISPLAY': ':0', 11:35:17 INFO - 'HOME': '/home/cltbld', 11:35:17 INFO - 'JSGC_DISABLE_POISONING': '1', 11:35:17 INFO - 'LANG': 'en_US.UTF-8', 11:35:17 INFO - 'LANGUAGE': 'en_US:en', 11:35:17 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:35:17 INFO - 'LOGNAME': 'cltbld', 11:35:17 INFO - 'MAIL': '/var/mail/cltbld', 11:35:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:35:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:35:17 INFO - 'MOZ_ACCELERATED': '1', 11:35:17 INFO - 'MOZ_CRASHREPORTER': '1', 11:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:35:17 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:35:17 INFO - 'MOZ_NO_REMOTE': '1', 11:35:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:35:17 INFO - 'MOZ_WEBRENDER': '1', 11:35:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:35:17 INFO - 'NO_EM_RESTART': '1', 11:35:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:35:17 INFO - 'PWD': '/builds/slave/test', 11:35:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:35:17 INFO - 'RUST_BACKTRACE': 'full', 11:35:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:35:17 INFO - 'SHELL': '/bin/bash', 11:35:17 INFO - 'SHLVL': '1', 11:35:17 INFO - 'TERM': 'linux', 11:35:17 INFO - 'TMOUT': '86400', 11:35:17 INFO - 'USER': 'cltbld', 11:35:17 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444', 11:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:35:17 INFO - '_': '/tools/buildbot/bin/python'} 11:35:17 INFO - TEST-INFO | started process 4369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwJgPjK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:35:18 INFO - PID 4369 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:35:18 INFO - PID 4369 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 11:35:18 INFO - PID 4369 | 11:35:18 INFO - PID 4369 | (/builds/slave/test/build/application/firefox/firefox:4431): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:35:18 INFO - PID 4369 | 11:35:29 INFO - PID 4369 | RSS: Main: 198504448 11:35:29 INFO - PID 4369 | 11:35:31 INFO - PID 4369 | Cycle 1(1): loaded http://localhost:52725/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52725/tests/kraken/driver.html?testName=audio-beat-detection) 11:35:32 INFO - PID 4369 | RSS: Main: 204513280 11:35:32 INFO - PID 4369 | 11:35:35 INFO - PID 4369 | Cycle 1(1): loaded http://localhost:52725/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52725/tests/kraken/driver.html?testName=audio-dft) 11:35:36 INFO - PID 4369 | RSS: Main: 205426688 11:35:36 INFO - PID 4369 | 11:35:39 INFO - PID 4369 | Cycle 1(1): loaded http://localhost:52725/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52725/tests/kraken/driver.html?testName=audio-fft) 11:35:39 INFO - PID 4369 | RSS: Main: 200024064 11:35:39 INFO - PID 4369 | 11:35:41 INFO - PID 4369 | Cycle 1(1): loaded http://localhost:52725/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52725/tests/kraken/driver.html?testName=audio-oscillator) 11:35:42 INFO - PID 4369 | RSS: Main: 200880128 11:35:42 INFO - PID 4369 | 11:35:44 INFO - PID 4369 | Cycle 1(1): loaded http://localhost:52725/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52725/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:35:45 INFO - PID 4369 | RSS: Main: 200384512 11:35:45 INFO - PID 4369 | 11:35:48 INFO - PID 4369 | Cycle 1(1): loaded http://localhost:52725/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52725/tests/kraken/driver.html?testName=imaging-darkroom) 11:35:49 INFO - PID 4369 | RSS: Main: 204439552 11:35:49 INFO - PID 4369 | 11:35:52 INFO - PID 4369 | Cycle 1(1): loaded http://localhost:52725/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52725/tests/kraken/driver.html?testName=imaging-desaturate) 11:35:53 INFO - PID 4369 | RSS: Main: 203632640 11:35:53 INFO - PID 4369 | 11:35:56 INFO - PID 4369 | Cycle 1(1): loaded http://localhost:52725/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52725/tests/kraken/driver.html?testName=json-parse-financial) 11:35:56 INFO - PID 4369 | RSS: Main: 203685888 11:35:56 INFO - PID 4369 | 11:35:58 INFO - PID 4369 | Cycle 1(1): loaded http://localhost:52725/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52725/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:35:59 INFO - PID 4369 | RSS: Main: 203878400 11:35:59 INFO - PID 4369 | 11:36:00 INFO - PID 4369 | Cycle 1(1): loaded http://localhost:52725/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52725/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:36:01 INFO - PID 4369 | RSS: Main: 202276864 11:36:01 INFO - PID 4369 | 11:36:03 INFO - PID 4369 | Cycle 1(1): loaded http://localhost:52725/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52725/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:36:04 INFO - PID 4369 | RSS: Main: 203505664 11:36:04 INFO - PID 4369 | 11:36:06 INFO - PID 4369 | Cycle 1(1): loaded http://localhost:52725/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52725/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:36:07 INFO - PID 4369 | RSS: Main: 203952128 11:36:07 INFO - PID 4369 | 11:36:10 INFO - PID 4369 | Cycle 1(1): loaded http://localhost:52725/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52725/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:36:11 INFO - PID 4369 | RSS: Main: 204255232 11:36:11 INFO - PID 4369 | 11:36:12 INFO - PID 4369 | Cycle 1(1): loaded http://localhost:52725/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52725/tests/kraken/driver.html?testName=ai-astar) 11:36:13 INFO - PID 4369 | RSS: Main: 207073280 11:36:13 INFO - PID 4369 | 11:36:13 INFO - PID 4369 | __start_tp_report 11:36:13 INFO - PID 4369 | _x_x_mozilla_page_load 11:36:13 INFO - PID 4369 | _x_x_mozilla_page_load_details 11:36:13 INFO - PID 4369 | |i|pagename|runs| 11:36:13 INFO - PID 4369 | |0;ai-astar;98;114;101;106;111;110;108;107;113;114 11:36:13 INFO - PID 4369 | |1;audio-beat-detection;157;122;153;171;115;145;142;117;175;117 11:36:13 INFO - PID 4369 | |2;audio-dft;164;166;170;163;169;168;164;167;162;164 11:36:13 INFO - PID 4369 | |3;audio-fft;75;79;73;177;74;73;78;94;92;77 11:36:13 INFO - PID 4369 | |4;audio-oscillator;85;84;136;79;81;80;129;89;80;131 11:36:13 INFO - PID 4369 | |5;imaging-gaussian-blur;119;114;114;124;120;115;115;116;118;114 11:36:13 INFO - PID 4369 | |6;imaging-darkroom;148;150;150;154;148;148;150;154;153;155 11:36:13 INFO - PID 4369 | |7;imaging-desaturate;96;104;95;97;102;93;94;94;104;94 11:36:13 INFO - PID 4369 | |8;json-parse-financial;53;53;54;61;59;53;53;51;52;53 11:36:13 INFO - PID 4369 | |9;json-stringify-tinderbox;39;39;48;38;39;41;44;41;39;42 11:36:13 INFO - PID 4369 | |10;stanford-crypto-aes;82;80;74;86;74;77;77;76;76;76 11:36:13 INFO - PID 4369 | |11;stanford-crypto-ccm;126;119;128;125;125;117;122;129;122;158 11:36:13 INFO - PID 4369 | |12;stanford-crypto-pbkdf2;176;175;175;169;173;173;171;172;173;177 11:36:13 INFO - PID 4369 | |13;stanford-crypto-sha256-iterative;64;64;72;65;74;62;64;69;65;63 11:36:13 INFO - PID 4369 | __end_tp_report 11:36:13 INFO - PID 4369 | __start_cc_report 11:36:13 INFO - PID 4369 | _x_x_mozilla_cycle_collect,916 11:36:13 INFO - PID 4369 | __end_cc_report 11:36:13 INFO - PID 4369 | __startTimestamp1504377373238__endTimestamp 11:36:13 INFO - PID 4369 | 11:36:13 INFO - PID 4369 | ------- Summary: start ------- 11:36:13 INFO - PID 4369 | Number of tests: 14 11:36:13 INFO - PID 4369 | 11:36:13 INFO - PID 4369 | [#0] ai-astar Cycles:10 Average:108.20 Median:112.00 stddev:5.41 (4.8%) stddev-sans-first:4.30 11:36:13 INFO - PID 4369 | Values: 98.0 114.0 101.0 106.0 111.0 110.0 108.0 107.0 113.0 114.0 11:36:13 INFO - PID 4369 | 11:36:13 INFO - PID 4369 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:149.00 stddev:22.76 (15.3%) stddev-sans-first:23.43 11:36:13 INFO - PID 4369 | Values: 157.0 122.0 153.0 171.0 115.0 145.0 142.0 117.0 175.0 117.0 11:36:13 INFO - PID 4369 | 11:36:13 INFO - PID 4369 | [#2] audio-dft Cycles:10 Average:165.70 Median:166.50 stddev:2.71 (1.6%) stddev-sans-first:2.80 11:36:13 INFO - PID 4369 | Values: 164.0 166.0 170.0 163.0 169.0 168.0 164.0 167.0 162.0 164.0 11:36:13 INFO - PID 4369 | 11:36:13 INFO - PID 4369 | [#3] audio-fft Cycles:10 Average:89.20 Median:77.50 stddev:31.76 (41.0%) stddev-sans-first:33.26 11:36:13 INFO - PID 4369 | Values: 75.0 79.0 73.0 177.0 74.0 73.0 78.0 94.0 92.0 77.0 11:36:13 INFO - PID 4369 | 11:36:13 INFO - PID 4369 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:80.50 stddev:24.12 (30.0%) stddev-sans-first:25.16 11:36:13 INFO - PID 4369 | Values: 85.0 84.0 136.0 79.0 81.0 80.0 129.0 89.0 80.0 131.0 11:36:13 INFO - PID 4369 | 11:36:13 INFO - PID 4369 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:3.31 (2.8%) stddev-sans-first:3.43 11:36:13 INFO - PID 4369 | Values: 119.0 114.0 114.0 124.0 120.0 115.0 115.0 116.0 118.0 114.0 11:36:13 INFO - PID 4369 | 11:36:13 INFO - PID 4369 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.50 stddev:2.75 (1.8%) stddev-sans-first:2.69 11:36:13 INFO - PID 4369 | Values: 148.0 150.0 150.0 154.0 148.0 148.0 150.0 154.0 153.0 155.0 11:36:13 INFO - PID 4369 | 11:36:13 INFO - PID 4369 | [#7] imaging-desaturate Cycles:10 Average:97.30 Median:94.00 stddev:4.35 (4.6%) stddev-sans-first:4.59 11:36:13 INFO - PID 4369 | Values: 96.0 104.0 95.0 97.0 102.0 93.0 94.0 94.0 104.0 94.0 11:36:13 INFO - PID 4369 | 11:36:13 INFO - PID 4369 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:53.00 stddev:3.19 (6.0%) stddev-sans-first:3.35 11:36:13 INFO - PID 4369 | Values: 53.0 53.0 54.0 61.0 59.0 53.0 53.0 51.0 52.0 53.0 11:36:13 INFO - PID 4369 | 11:36:13 INFO - PID 4369 | [#9] json-stringify-tinderbox Cycles:10 Average:41.00 Median:41.00 stddev:3.06 (7.5%) stddev-sans-first:3.15 11:36:13 INFO - PID 4369 | Values: 39.0 39.0 48.0 38.0 39.0 41.0 44.0 41.0 39.0 42.0 11:36:13 INFO - PID 4369 | 11:36:13 INFO - PID 4369 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:77.00 stddev:3.79 (4.9%) stddev-sans-first:3.71 11:36:13 INFO - PID 4369 | Values: 82.0 80.0 74.0 86.0 74.0 77.0 77.0 76.0 76.0 76.0 11:36:13 INFO - PID 4369 | 11:36:13 INFO - PID 4369 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:125.50 stddev:11.49 (9.2%) stddev-sans-first:12.18 11:36:13 INFO - PID 4369 | Values: 126.0 119.0 128.0 125.0 125.0 117.0 122.0 129.0 122.0 158.0 11:36:13 INFO - PID 4369 | 11:36:13 INFO - PID 4369 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:174.00 stddev:2.41 (1.4%) stddev-sans-first:2.37 11:36:13 INFO - PID 4369 | Values: 176.0 175.0 175.0 169.0 173.0 173.0 171.0 172.0 173.0 177.0 11:36:13 INFO - PID 4369 | 11:36:13 INFO - PID 4369 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:65.00 stddev:4.05 (6.2%) stddev-sans-first:4.22 11:36:13 INFO - PID 4369 | Values: 64.0 64.0 72.0 65.0 74.0 62.0 64.0 69.0 65.0 63.0 11:36:13 INFO - PID 4369 | -------- Summary: end -------- 11:36:13 INFO - PID 4369 | 11:36:13 INFO - PID 4369 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:36:14 INFO - TEST-INFO | 4369: exit 0 11:36:14 INFO - TEST-OK | kraken | took 63132ms 11:36:14 INFO - SUITE-END | took 1180s 11:36:14 INFO - Completed test suite (00:19:41) 11:36:14 INFO - javascript benchmark 11:36:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8599.32837211428, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3314.4862546305317, 3352.6982571568556, 3370.1911541230106, 3386.0180547641185, 3409.6931276185137, 6282.2147231596055, 6338.841528961772, 6376.681165941696, 6395.456386207172, 6450.838729031777, 6372.394622510854, 6375.266844312905, 6380.808575742723, 6383.840403989891, 6428.0, 5822.647174714329, 5833.737481813308, 5843.0, 5845.473907348338, 5865.560082993771, 5855.47300742933, 5873.324567674708, 5884.794032208873, 5904.822855314326, 5927.022041363191, 5908.763649454017, 5968.850778730544, 5977.193078934353, 5997.910031349533, 6023.216981792383, 5867.706614669292, 5880.558958078119, 5899.410058994109, 5913.556483263751, 5972.522198224154, 5667.1782591524, 5792.942070579283, 5797.391273916262, 5841.357450680422, 5884.882302353929, 6192.225971753531, 6362.172917520739, 6370.362963703593, 6435.774747883802, 6456.51576131792, 6593.076969224312, 6726.663666816639, 6818.795436136924, 6819.795406137824, 6873.140857392826, 6838.350356716153, 6950.061741664861, 6970.372666460043, 6978.0230767692565, 6978.162620485524, 6440.871182576322, 6443.806685799434, 6465.191851018622, 6470.223573171203, 6478.967605162038, 7048.048513450721, 7056.435485161175, 7140.393066589294, 7144.499885008104, 7160.248173941765, 6544.9672751635935, 6742.797716068526, 6751.729930802713, 6804.387605115563, 6846.383825455633, 6699.933000670028, 6756.527043107034, 6852.828679282959, 6895.138107736533, 6900.861982760317, 6772.11962444879, 6877.518573699893, 6884.51808373419, 6906.240313565504, 6919.515633905679, 6880.69036893341, 6901.206361268418, 6905.9309406906295, 6987.755428560077, 6989.650517474106, 4976.0, 5054.21659642756, 5066.316047333637, 5162.1224391853475, 5162.6386152968935, 4429.402030725875, 4449.377087207794, 4454.57681520255, 4470.240059189946, 4475.0, 5981.760729570856, 5990.850228744316, 5996.760129594854, 5998.700064996733, 6012.0, 6771.593704377753, 6882.0, 6883.552569082994, 6884.380405763505, 6887.0, 5958.582899197015, 5976.342602313742, 6001.099835024781, 6004.039353703386, 6010.849728756729, 5885.852853678607, 5901.852453688693, 5974.2233509643465, 5996.370381110008, 6032.758689652453, 6658.876762051582, 6698.5980841149685, 6811.863762724718, 6818.386345228953, 6825.69284382204, 6794.728210871707, 6836.179658441019, 6861.519693621399, 6946.479014073863, 7034.718611255697, 6689.063531105747, 6689.966550167218, 6711.798646040431, 6723.865522689616, 6728.428083612947, 6819.283975182733, 6823.147106611674, 6834.658267086526, 6838.487113466411, 6851.794446166623, 6901.137357830271, 6954.3045695430055, 6988.79033628992, 7021.0872586565465, 7038.859222815618, 6573.1454910861285, 6602.1747281589805, 6658.900116498159, 6707.698153583003, 6723.159605049369, 6547.312532184052, 6557.803265902031, 6629.0, 6637.900431493628, 6648.16897887764, 6195.473384762346, 6607.900881486878, 6627.734890604322, 6648.833779155367, 6649.534532582673, 6693.531452798257, 6716.0, 6746.123004009447, 6766.5263431559315, 6773.221079575912, 6351.2060992375955, 6435.710393032418, 6437.291897891322, 6474.223093228654, 6510.47916166715], "value": 6245.811474874274, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.3967425245434, 838.0613712641841, 868.0711638546755, 868.2359523619214, 1119.6752941646923, 29263.707362926365, 29930.401391972147, 38338.808305958504, 39119.41320880189, 39460.80269598648, 39614.60385396145, 39905.40141897867, 40019.0, 40033.199336013335, 40055.0, 7498.475106742517, 7559.395248380117, 7602.391808655322, 7608.961955190244, 7614.0, 7273.527220730662, 7352.04423424954, 7357.448191385641, 7367.521111127787, 7369.447291453135, 7030.191527974297, 7217.278272172794, 7368.189499155089, 7376.926230737705, 7649.6940122395035, 7536.924630753704, 7591.468597198198, 7614.4669873108905, 7622.161562228151, 7622.4664273500875, 7363.6318184091115, 7533.510321829063, 7534.397248220129, 7549.471536992412, 7561.508501947411, 35476.46785298223, 36477.81761091204, 36547.63452365495, 36669.0, 36690.44964325537, 3463.4458486642015, 3486.9128271793406, 3536.840842162109, 3538.1862171700654, 3546.4325707886874, 30159.849200754074, 30338.241543961576, 30384.8480757597, 30416.8479157605, 30445.0, 4966.404031516241, 5080.974595127038, 5142.404669299469, 5167.509086636764, 5248.580113590903, 174412.0, 175706.0, 177311.0, 178422.0, 178631.0, 46153.76923115363, 46198.53801461942, 46205.537944620126, 46271.76864115658, 46278.53721462809, 47843.28235076477, 48124.27813582799, 48366.75816620894, 48432.515674843504, 48715.5128448711, 15356.232188390535, 15514.612134696497, 15590.688186236212, 15601.765973510406, 15676.451324203597, 12840.743185136245, 12842.101052926206, 12879.034072444416, 12920.806187907188, 12966.611001669966, 13751.312434378442, 13849.723005539832, 13914.930425347808, 13964.51124210668, 14064.367103480368, 5627.549796016309, 5747.453991870766, 5778.595498315078, 5783.681897495678, 5846.327672317738, 1002.5037606384741, 1011.4942528735633, 1023.3246057602096, 1024.5184763161303, 1031.1493018259966, 22891.7710822893, 22971.770282297297, 22973.42566435819, 23089.307320780405, 23447.882760586086, 1094.5676457799125, 1099.6591056772427, 1099.9450027498592, 1112.076976109827, 1112.816385296417, 11999.700007499709, 12038.4582693779, 12223.266604003788, 12252.14235003559, 12258.877411225774, 227213.0, 227632.0, 228117.0, 229090.0, 229792.0, 50585.49414505808, 50842.0, 50849.0, 50869.74565127151, 50996.0, 1397.2943663450096, 1425.1520345394474, 1451.7822326651087, 1465.904716193444, 1475.9852401476062, 25795.613065803653, 26087.347816304744, 26233.606495902193, 26599.468010640066, 26724.732752672226, 36692.0, 36819.263614728094, 36985.81507092447, 37144.442833358065, 37194.8140259297, 194023.0, 195934.0, 196397.0, 196628.0, 196777.0, 32938.0, 33968.15079623029, 34125.0, 34273.14317142092, 34299.485507716905, 40371.59628403679, 40403.797981009906, 40443.79778101091, 40461.39307910325, 40779.38830917479, 32341.51487727639, 32832.0, 33056.83471582627, 33326.33347333088, 33338.666453342565, 31623.20941976469, 32454.188645283113, 32474.675253247166, 32943.176420589676, 33197.0, 35527.0, 36524.45213321749, 36841.26317473582, 37396.252074958895, 37479.0, 31437.0, 31801.8409907949, 32030.67969320277, 32111.35777284488, 32173.356532868744, 23840.64239036381, 24098.63852042256, 24441.51116977686, 24488.51022979495, 24783.380415489755], "value": 16889.643289431595, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.1681502968095, 566.6430149006123, 574.4915749561636, 581.3953488372092, 588.7998080652578, 21567.0, 22312.553748925053, 22317.55364892703, 22346.88826555867, 22540.88729556354, 23546.88226558869, 25939.48121037578, 25943.74056259437, 25944.481110377783, 25994.870025649892, 6485.513586481009, 6646.667666616674, 6651.600903945755, 6651.900221496681, 6658.4673226141795, 6323.272823625273, 6407.295197528269, 6537.052127441542, 6629.0, 6643.335666433342, 6557.0, 6564.737410503598, 6568.047633093199, 6594.703238354262, 6622.139121914144, 6528.314526974695, 6568.540202185849, 6576.145101136845, 6632.2704502504685, 6639.93360066398, 6055.545834062419, 6122.326544080148, 6125.663088530129, 6128.938710612882, 6153.200083989098, 27221.591676124874, 28350.0, 28692.426151477062, 28836.567451488245, 28839.85580072107, 1941.5825597496605, 2003.5291706448972, 2006.8595198335977, 2007.29744589394, 2010.4169790760661, 18531.90734046321, 19178.13698383576, 19182.52043698905, 19201.519962000923, 19205.0, 2396.041583366667, 2441.8523294051765, 2465.8890349934295, 2473.3322003059075, 2476.2076135636603, 131667.0, 136732.0, 139038.0, 139121.0, 139153.0, 13886.236257005961, 14002.859971400156, 14397.78403323951, 14470.855291446951, 14602.707945841024, 22522.77477225207, 22678.886605566866, 22697.432564185696, 22777.544449110927, 22799.658005129935, 9937.503124843728, 10069.54687039085, 10121.645742398981, 10329.690109296733, 10330.741731456623, 9429.481378524248, 9484.762880927894, 9488.857667134998, 9584.76038099053, 9588.232941364813, 7566.848663026709, 8756.649734010696, 8973.910260897308, 9020.684276050306, 9171.81656366869, 2663.2809141532066, 2685.5166070107566, 2754.4628797384717, 2756.4349308391734, 2785.1366076516347, 931.3992474853682, 937.151877550804, 980.2060331131806, 981.2885657897967, 989.9208063354914, 19153.61692766165, 19181.520461988282, 19240.8075919239, 19631.509212269808, 20001.0, 1031.1750599520353, 1045.1012129568564, 1051.1748277602046, 1052.5632511621582, 1054.7099547624464, 10441.634542790965, 10557.736056598493, 10600.946995264974, 10664.733381665365, 10743.78512429747, 484866.0, 485217.0, 493132.0, 496079.0, 497229.0, 117861.0, 120391.39804301098, 121780.0, 123507.38246308711, 124302.0, 1137.8765289280977, 1172.20290202663, 1180.6458062581362, 1180.7874582575048, 1187.4003628167893, 17298.82701172972, 17592.648147037242, 17628.0, 20372.0, 21465.356039318845, 55107.0, 55534.44465555293, 56483.15275270792, 57778.422215777304, 61138.38861611505, 64833.67583162054, 65021.67489162524, 65102.0, 65207.67396162989, 66251.66874165791, 11542.307461552333, 12074.27554346742, 14476.203808790618, 14660.266986650839, 14684.0, 17459.30162793474, 17987.640247194722, 23122.884385577963, 23513.529729404974, 23544.29367118989, 18332.99168545743, 18379.724304135718, 18434.723479147557, 18692.0, 18770.530736731693, 16229.0, 16493.422730204384, 16658.50024499267, 16691.582710432336, 16846.326146953983, 19568.21727130899, 19806.108725107115, 19878.60242795107, 19964.401067967985, 19996.600067998268, 13728.725425491235, 14414.927925360305, 14615.196164211071, 14708.926455367655, 14728.55814325572, 18393.264269429073, 18432.723509147105, 18495.722564161817, 18645.720314195027, 18949.43151705451], "value": 11871.343255194757, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.8607846176153, 1360.1567028442366, 1394.762890308647, 1402.312866695319, 1409.3376113226793, 13211.471541138368, 15030.624234394145, 15599.922000389995, 15630.218489075543, 15739.134347610876, 13069.67325816855, 15177.089374637502, 15589.0, 15670.529884103467, 15707.764383534257, 2729.0857562716515, 2811.0, 2811.4939310924024, 2817.09852847089, 2817.3520090379125, 2703.7566619004288, 2756.531389663762, 2812.8874845006176, 2825.9152225433268, 2832.5326321156986, 2786.4148528808973, 2812.1141840320233, 2814.7466727994474, 2817.478766428207, 2824.1951043952477, 2711.3221694576355, 2730.0, 2742.8491432971177, 2742.9862850685818, 2747.0, 2735.685396179445, 2763.295359683288, 2771.2240572639694, 2775.4587855368213, 2776.514110030757, 15091.169985650895, 15417.3833046678, 15483.612909677235, 15504.379824806994, 15536.145511996836, 7850.528968261866, 8177.0, 8189.344852411793, 8192.50844949299, 8197.098319184885, 5433.945660543383, 5560.165975103726, 5599.300087489064, 5682.431756824326, 5722.113072473731, 1950.2004178286834, 1974.4866334752924, 1976.8616196866226, 2014.1339224133617, 2019.7475315585552, 27552.448951020866, 27763.305917352027, 27780.444391112065, 27832.30419239515, 27833.72166278352, 6485.351464853571, 6499.09012738217, 6931.202911665122, 6966.12923384577, 7109.111361079865, 17514.64970700579, 17561.648767024843, 17609.207585658674, 17638.382656607213, 17670.0, 7777.105632852295, 7901.920980790233, 7906.16985216544, 7906.723264685824, 7909.1695371985115, 6946.826329341807, 7230.855382892312, 7278.417726581861, 7293.489455738048, 7316.597587132759, 5275.235090911796, 5350.652207606571, 5366.91949620756, 5480.479354461399, 5520.282363292747, 1391.8956078294168, 1423.9715205695827, 1440.6542429816768, 1456.4611093895326, 1467.5157198124593, 894.7449976756593, 920.4569304110473, 942.3733217410345, 949.3591825517748, 952.8427809411509, 7550.320471157622, 7924.603769811486, 7926.762197134095, 8024.157463466368, 8085.110637829834, 971.2958105373548, 984.6602921991902, 987.8962708915604, 1001.3241062283075, 1022.3405903192548, 5149.588032957355, 5191.273221748958, 5200.531952124251, 5201.6358854880555, 5308.601854860824, 20666.896665516877, 20777.896110519352, 21670.34988950334, 21770.346889593337, 21901.342959711234, 21265.255716049865, 21399.25102621401, 21462.356129316144, 21473.248436304653, 21714.89142554277, 10324.328918620266, 10922.399268040333, 11555.480003399867, 11721.941390293165, 11751.823722644167, 8528.445651032664, 8713.651453941771, 8723.476591404537, 8733.257673097858, 8767.123287671182, 18592.907035464737, 18593.070346482353, 18602.627947441248, 18836.52908677294, 19195.712064318766, 18768.906155469136, 18792.342268020555, 18887.716684249473, 19454.124564394355, 19564.510887227934, 12294.524657041213, 12321.260724356567, 12463.813042804184, 12489.125761196628, 12502.062180362058, 13773.655658608615, 14041.297935103408, 14047.157170569799, 14055.929720351332, 14064.718705626035, 11027.283226590245, 11044.226904116635, 11416.257943233662, 11505.597304094317, 11715.062794976551, 10882.891171088188, 11096.556137754722, 11151.498182581641, 11308.943455283, 11362.54549817998, 9680.75798105053, 9948.55231514598, 9951.15415189717, 9954.402735835873, 9969.601215951281, 7216.8917466237, 7265.200827909031, 7339.816504587428, 7381.003564518721, 7420.146683131293, 7209.567425954459, 7252.854942901218, 7281.344678978918, 7319.34125928669, 7322.194558598443], "value": 6758.858219115316, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.322519760527, 504.75267119111624, 529.2933933199179, 532.7948739735203, 540.1870185371016, 6304.464120549747, 6370.821398041366, 6373.844946751359, 6470.191226096732, 6482.481401487881, 6056.1824153739235, 6169.784057557987, 6260.5930614510025, 6292.748290068404, 6325.46233570146, 5104.69371837691, 5105.259737338084, 5134.383873935114, 5151.536361727443, 5166.689998600077, 5023.799048038074, 5099.592032637399, 5101.20931255656, 5105.744712764365, 5137.691738495702, 4865.562099411052, 4888.800039982005, 4974.8258810941625, 4999.225120106389, 5071.873203169932, 4944.332515110468, 4994.750262486898, 5010.473900240495, 5037.697738135687, 5103.311053007834, 4499.955000450019, 4552.544745525454, 4565.452145742499, 4567.33773602829, 4571.611413029863, 6188.957643977476, 6194.721237544276, 6207.658578778165, 6265.248170219557, 6288.213973253343, 5728.338781753287, 5744.856378590527, 5794.217780599607, 5805.896879592864, 5813.273340832396, 6569.474442044625, 6576.835579110512, 6647.468202543785, 6648.93351066488, 6664.733410663568, 4936.6050715943, 4974.607110009203, 4979.701217926936, 4980.228064649985, 4998.750062496861, 7014.859702805916, 7021.332973367573, 7050.717971281143, 7063.89404158938, 7109.964450177716, 5012.749362531858, 5019.247112933016, 5097.209932460474, 5114.411842638145, 5135.845924622267, 5150.939624150295, 5173.430922598511, 5194.558462530652, 5203.115470370046, 5217.0870097733505, 5807.82576522705, 5831.241938548046, 5842.824715258549, 5859.765609375662, 5874.9118763218585, 6619.238787539398, 6700.698468568926, 6750.008747419523, 6828.214755303204, 6829.453643708492, 1757.77148970633, 1766.0639860873757, 1769.2215425212864, 1774.5031391210482, 1787.204693911197, 1120.9159313051555, 1150.5857891159176, 1182.2256422043574, 1219.2806244315896, 1232.5994051933158, 5835.5915085944425, 5864.7947321844385, 5991.340952495222, 6023.247094113236, 6102.789075537865, 6756.527043106936, 6771.424428923498, 6867.107276054181, 6890.209465166616, 6898.585495076683, 5875.177475153482, 5913.852153696106, 5959.672218027963, 6008.789692360747, 6039.305479869783, 3623.963760362363, 3665.340238756996, 3676.6690997810324, 3700.6484383984016, 3727.4781530585738, 6673.933260667428, 6730.97106302166, 6740.752960702286, 6787.201391631222, 6821.897671534931, 6800.08198893153, 6874.175098988154, 6988.0, 7024.894626580605, 7080.362767350963, 6566.638834864033, 6607.966960165265, 6624.735010599522, 6661.568527487432, 6692.297308782702, 6754.527183097136, 6838.794836154923, 6840.897386539305, 6900.275471075464, 6901.344372284625, 6759.155105611799, 6846.589204647538, 6863.210730766026, 6865.691043902936, 6920.100386949664, 6655.0, 6693.661267746373, 6697.732090716317, 6707.8993815091835, 6711.295313992156, 4980.228064649985, 5028.371453568304, 5028.969061342489, 5065.0116431305705, 5108.208227724708, 6687.465002799861, 6838.111045564045, 6869.668210917801, 6888.517803753689, 6959.791206263821, 6505.707243173973, 6517.511186661114, 6520.804375868732, 6617.205935287796, 6653.405171983028, 6433.356664333529, 6498.0, 6546.672666366758, 6606.603603783596, 6618.007298905202, 6036.426539478743, 6400.815849067937, 6464.288928217987, 6494.3505649436565, 6557.606543607399, 6603.405693487609, 6699.832504187434, 6717.328267173243, 6719.26088130315, 6764.526483146133, 6366.140571022853, 6368.681565921778, 6449.161608990801, 6481.35186481367, 6524.67376631176], "value": 5141.895026960027, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [889.0931250124869, 902.963881444742, 916.2669864108714, 924.2744445610198, 925.421611492817, 19216.423507294785, 20139.0, 20176.798232017674, 20233.59532809343, 20234.89882550585, 17173.570660733487, 17250.82749172508, 17318.393856215036, 21569.46076348092, 21581.136754529838, 980.181548407081, 999.7000899730052, 1002.3785253143061, 1004.4073996342157, 1005.8541511480831, 907.7412937312868, 1006.4464544500496, 1006.5017816180964, 1007.0382784440878, 1008.6066434090674, 1055.430067763407, 1056.8361903904868, 1057.0961827637375, 1057.9629712960048, 1059.3802625464114, 1052.5737076483997, 1054.8734151901745, 1055.0609957138076, 1056.8097742406364, 1062.0335494699825, 766.4290103872595, 767.3707559800965, 769.5075151902787, 775.9806004849868, 779.8245394786185, 19582.902085489623, 19973.600527989358, 20051.298204562918, 20060.197592096298, 20798.27206047781, 20035.899820500803, 20292.797072029385, 20632.27787027447, 20689.172433102656, 20764.48088797777, 16981.150942452827, 17595.5601109972, 17603.559911002198, 17764.644707105785, 17903.910480447645, 3715.981420092882, 3733.4399840023943, 3745.5879853216397, 3748.7188460865545, 3761.811909404546, 123245.0, 123846.0, 125667.3716631411, 127763.0, 128388.0, 16362.754558681629, 16554.751678724828, 17076.573085672957, 17154.914225428794, 17289.13554322279, 31382.215444614067, 31610.0, 31658.683413166033, 31712.36575268482, 31923.201919951724, 8623.094575069654, 8669.869951950726, 8672.739817805475, 8707.172818582225, 8715.564221789013, 4058.817353219112, 4250.659947204216, 4258.808353624095, 4283.164782867373, 4336.804843782037, 5301.708406037705, 5428.7285635718845, 5436.374816896028, 5437.0, 5441.129419292894, 1113.6158025481195, 1125.7073160978205, 1128.4752590045669, 1134.7843909657138, 1169.128998895811, 668.1647940074906, 676.3473248315399, 692.4979389942251, 695.2005194026909, 695.3081683724625, 11992.220505667105, 12078.577249796215, 12130.72627374113, 12186.959952850542, 12612.054095942658, 673.3872176319526, 685.2530741491798, 685.5372623479132, 694.5728377048079, 706.5019161491136, 5707.200991861143, 5751.511121554631, 5772.595918285764, 5779.219805326311, 5904.0, 110316.44841775739, 111783.44108279406, 114559.20550799939, 114672.0, 115512.0, 95879.0, 96599.0, 96936.51531742296, 99475.50262248643, 99977.50011250042, 80558.59720701359, 83433.0, 83754.0, 85654.0, 87954.1204587946, 11723.41382930833, 12065.64381045562, 12127.575534856238, 12184.695382615506, 12289.754204916031, 39691.603083969945, 40386.59613403946, 40735.0, 40761.79619101885, 41947.1610567793, 65780.6710966442, 70480.0, 70851.0, 71446.0, 73984.26015739773, 18755.812441875405, 19097.140628671466, 19162.329318474345, 19189.0, 19490.512737181685, 19580.944000879703, 20127.09428075711, 21150.47123821917, 21593.24423645165, 21954.45113872166, 18589.0, 18676.533086672942, 18706.438806835817, 19160.61678766389, 20037.29869454562, 18841.434756957315, 19138.808611913704, 19390.709139363204, 19526.21895124236, 20276.290329838386, 18442.81557184411, 18523.536911577317, 18603.162857671166, 18671.81328186755, 18795.718064228775, 12901.0, 13778.931105344409, 13781.310934453437, 13822.377992990541, 14057.297135143406, 14144.575662730134, 14305.356258968162, 14372.49696260626, 14409.855901440851, 14480.275986200859], "value": 9290.887004241453, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1506.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 114.0, 101.0, 106.0, 111.0, 110.0, 108.0, 107.0, 113.0, 114.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 122.0, 153.0, 171.0, 115.0, 145.0, 142.0, 117.0, 175.0, 117.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 170.0, 163.0, 169.0, 168.0, 164.0, 167.0, 162.0, 164.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 73.0, 177.0, 74.0, 73.0, 78.0, 94.0, 92.0, 77.0], "value": 89.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 136.0, 79.0, 81.0, 80.0, 129.0, 89.0, 80.0, 131.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 114.0, 114.0, 124.0, 120.0, 115.0, 115.0, 116.0, 118.0, 114.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 150.0, 154.0, 148.0, 148.0, 150.0, 154.0, 153.0, 155.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 104.0, 95.0, 97.0, 102.0, 93.0, 94.0, 94.0, 104.0, 94.0], "value": 97.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 61.0, 59.0, 53.0, 53.0, 51.0, 52.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 48.0, 38.0, 39.0, 41.0, 44.0, 41.0, 39.0, 42.0], "value": 41.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 74.0, 86.0, 74.0, 77.0, 77.0, 76.0, 76.0, 76.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 119.0, 128.0, 125.0, 125.0, 117.0, 122.0, 129.0, 122.0, 158.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 175.0, 175.0, 169.0, 173.0, 173.0, 171.0, 172.0, 173.0, 177.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 72.0, 65.0, 74.0, 62.0, 64.0, 69.0, 65.0, 63.0], "value": 66.2, "unit": "score"}]}]} 11:36:14 INFO - Return code: 0 11:36:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:36:14 INFO - # TBPL SUCCESS # 11:36:14 INFO - Running post-action listener: _package_coverage_data 11:36:14 INFO - Running post-action listener: _resource_record_post_action 11:36:14 INFO - [mozharness: 2017-09-02 18:36:14.534420Z] Finished run-tests step (success) 11:36:14 INFO - Running post-run listener: _resource_record_post_run 11:36:14 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 12353536; Write bytes: 402812928; Read time: 10228; Write time: 492856 11:36:14 INFO - TinderboxPrint: CPU usage
13.3% 11:36:14 INFO - TinderboxPrint: I/O read bytes / time
12,353,536 / 10,228 11:36:14 INFO - TinderboxPrint: I/O write bytes / time
402,812,928 / 492,856 11:36:14 INFO - TinderboxPrint: CPU idle
8,276.2 (86.7%) 11:36:14 INFO - TinderboxPrint: CPU user
1,201.3 (12.6%) 11:36:14 INFO - TinderboxPrint: Swap in / out
0 / 0 11:36:14 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 118587392; Read time: 0; Write time: 197024 11:36:14 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:36:14 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 10608640; Write bytes: 284225536; Read time: 10156; Write time: 295832 11:36:15 INFO - Running post-run listener: _upload_blobber_files 11:36:15 INFO - Blob upload gear active. 11:36:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:36:15 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:36:15 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:36:15 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:36:15 INFO - (blobuploader) - INFO - Open directory for files ... 11:36:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:36:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:36:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:16 INFO - (blobuploader) - INFO - Done attempting. 11:36:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:36:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:36:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:17 INFO - (blobuploader) - INFO - Done attempting. 11:36:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:36:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:36:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:24 INFO - (blobuploader) - INFO - Done attempting. 11:36:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:36:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:36:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:36:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:36:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:36:25 INFO - (blobuploader) - INFO - Done attempting. 11:36:25 INFO - (blobuploader) - INFO - Iteration through files over. 11:36:25 INFO - Return code: 0 11:36:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:36:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:36:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aecd0a26952088fd3a0b328032f7c7b250520aaa5b6fa0631e23a3a0d5dbfd570ae9fcb00876b9a0f721dd52bb5def849c3e1200fbc43b3956d0d6956df5c8cd", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29435ac867fc861dc62cfbc61c3f0ddff18f79b6a2e06bddc57fa1074cb1e796d196d0af2b415ce36f07353122847be424d7d6fe6982d7fd4c312f73c4eaa08a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d51dc6fe9daeb12b94aa24474ef5070821446e6ac072ab4bf6e0adef755cc0a228622da9b67409833ce1b9dc20facf46941fec1b1dd815f89a7fdd3a58c56f55", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/edb445300e84313dd7eb0673fdd4c6b7aecbcf721610b49c3800cecb211ddf237b91e2ca294fe82e7d303409bd558f7a636319daac022e9e9015ff7be986e1da"} 11:36:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:36:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:36:25 INFO - Contents: 11:36:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aecd0a26952088fd3a0b328032f7c7b250520aaa5b6fa0631e23a3a0d5dbfd570ae9fcb00876b9a0f721dd52bb5def849c3e1200fbc43b3956d0d6956df5c8cd", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29435ac867fc861dc62cfbc61c3f0ddff18f79b6a2e06bddc57fa1074cb1e796d196d0af2b415ce36f07353122847be424d7d6fe6982d7fd4c312f73c4eaa08a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d51dc6fe9daeb12b94aa24474ef5070821446e6ac072ab4bf6e0adef755cc0a228622da9b67409833ce1b9dc20facf46941fec1b1dd815f89a7fdd3a58c56f55", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/edb445300e84313dd7eb0673fdd4c6b7aecbcf721610b49c3800cecb211ddf237b91e2ca294fe82e7d303409bd558f7a636319daac022e9e9015ff7be986e1da"} 11:36:25 INFO - Running post-run listener: copy_logs_to_upload_dir 11:36:25 INFO - Copying logs to upload dir... 11:36:25 INFO - mkdir: /builds/slave/test/build/upload/logs 11:36:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.340387 ========= master_lag: -0.33 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-09-02 11:36:24.932207) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-02 11:36:24.936965) ========= 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=5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aecd0a26952088fd3a0b328032f7c7b250520aaa5b6fa0631e23a3a0d5dbfd570ae9fcb00876b9a0f721dd52bb5def849c3e1200fbc43b3956d0d6956df5c8cd", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29435ac867fc861dc62cfbc61c3f0ddff18f79b6a2e06bddc57fa1074cb1e796d196d0af2b415ce36f07353122847be424d7d6fe6982d7fd4c312f73c4eaa08a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d51dc6fe9daeb12b94aa24474ef5070821446e6ac072ab4bf6e0adef755cc0a228622da9b67409833ce1b9dc20facf46941fec1b1dd815f89a7fdd3a58c56f55", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/edb445300e84313dd7eb0673fdd4c6b7aecbcf721610b49c3800cecb211ddf237b91e2ca294fe82e7d303409bd558f7a636319daac022e9e9015ff7be986e1da"} build_url:https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011180 build_url: 'https://queue.taskcluster.net/v1/task/C-9NEaTqQja8SGXabZPikw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aecd0a26952088fd3a0b328032f7c7b250520aaa5b6fa0631e23a3a0d5dbfd570ae9fcb00876b9a0f721dd52bb5def849c3e1200fbc43b3956d0d6956df5c8cd", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29435ac867fc861dc62cfbc61c3f0ddff18f79b6a2e06bddc57fa1074cb1e796d196d0af2b415ce36f07353122847be424d7d6fe6982d7fd4c312f73c4eaa08a", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d51dc6fe9daeb12b94aa24474ef5070821446e6ac072ab4bf6e0adef755cc0a228622da9b67409833ce1b9dc20facf46941fec1b1dd815f89a7fdd3a58c56f55", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/edb445300e84313dd7eb0673fdd4c6b7aecbcf721610b49c3800cecb211ddf237b91e2ca294fe82e7d303409bd558f7a636319daac022e9e9015ff7be986e1da"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-02 11:36:24.964500) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 11:36:24.964820) ========= 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=5cf47e208febbcd81da23b2e0000026f-1504359802.364277-656260444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-02 11:36:25.051521) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-02 11:36:25.051895) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-02 11:36:25.052226) ========= ========= Total master_lag: -0.14 =========