builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1503013058.98 results: success (0) revision: 2fb6d8f7bac1be26b2b49b68fc34cc6decd7f339 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 16:37:38.982181) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 16:37:38.982603) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 16:37:38.982876) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 16:37:38.992575) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:37:38.992831) ========= 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=8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-17 16:37:38-- 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.3M=0s 2017-08-17 16:37:38 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.079928 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:37:39.087477) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:37:39.087769) ========= 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=8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015990 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:37:39.136609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:37:39.136919) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2fb6d8f7bac1be26b2b49b68fc34cc6decd7f339 --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 2fb6d8f7bac1be26b2b49b68fc34cc6decd7f339 --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=8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-17 16:37:39,111 truncating revision to first 12 chars 2017-08-17 16:37:39,111 Setting DEBUG logging. 2017-08-17 16:37:39,111 attempt 1/10 2017-08-17 16:37:39,111 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2fb6d8f7bac1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-17 16:37:39,628 unpacking tar archive at: mozilla-central-2fb6d8f7bac1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.835618 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:37:39.990416) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 16:37:39.990742) ========= script_repo_revision: 2fb6d8f7bac1be26b2b49b68fc34cc6decd7f339 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 16:37:39.994113) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 16:37:39.994380) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 16:37:40.005766) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-17 16:37:40.006038) ========= /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=8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:37:40 INFO - MultiFileLogger online at 20170817 16:37:40 in /builds/slave/test 16:37:40 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 16:37:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:37:40 INFO - {'append_to_log': False, 16:37:40 INFO - 'base_work_dir': '/builds/slave/test', 16:37:40 INFO - 'blob_upload_branch': 'Firefox', 16:37:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:37:40 INFO - 'branch': 'Firefox', 16:37:40 INFO - 'buildbot_json_path': 'buildprops.json', 16:37:40 INFO - 'code_coverage': False, 16:37:40 INFO - 'config_files': ('talos/linux_config.py',), 16:37:40 INFO - 'default_actions': ('clobber', 16:37:40 INFO - 'read-buildbot-config', 16:37:40 INFO - 'download-and-extract', 16:37:40 INFO - 'populate-webroot', 16:37:40 INFO - 'create-virtualenv', 16:37:40 INFO - 'install', 16:37:40 INFO - 'setup-mitmproxy', 16:37:40 INFO - 'run-tests'), 16:37:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:37:40 INFO - 'disable_ccov_upload': False, 16:37:40 INFO - 'download_minidump_stackwalk': True, 16:37:40 INFO - 'download_symbols': 'ondemand', 16:37:40 INFO - 'enable_stylo': False, 16:37:40 INFO - 'enable_webrender': False, 16:37:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:37:40 INFO - 'tooltool.py': '/tools/tooltool.py', 16:37:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:37:40 INFO - '/tools/misc-python/virtualenv.py')}, 16:37:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:37:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:37:40 INFO - 'gecko_profile': False, 16:37:40 INFO - 'gecko_profile_interval': 0, 16:37:40 INFO - 'installer_path': 'installer.exe', 16:37:40 INFO - 'log_level': 'info', 16:37:40 INFO - 'log_name': 'talos', 16:37:40 INFO - 'log_to_console': True, 16:37:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:37:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:37:40 INFO - 'opt_config_files': (), 16:37:40 INFO - 'pip_index': False, 16:37:40 INFO - 'suite': 'dromaeojs-e10s', 16:37:40 INFO - 'system_bits': '32', 16:37:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:37:40 INFO - 'title': 'talos-linux64-ix-038', 16:37:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:37:40 INFO - 'use_talos_json': True, 16:37:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:37:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:37:40 INFO - 'work_dir': 'build'} 16:37:40 INFO - [mozharness: 2017-08-17 23:37:40.082101Z] Running clobber step. 16:37:40 INFO - Running pre-action listener: _resource_record_pre_action 16:37:40 INFO - Running main action method: clobber 16:37:40 INFO - rmtree: /builds/slave/test/build 16:37:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:37:41 INFO - Running post-action listener: _resource_record_post_action 16:37:41 INFO - [mozharness: 2017-08-17 23:37:41.297717Z] Finished clobber step (success) 16:37:41 INFO - [mozharness: 2017-08-17 23:37:41.297822Z] Running read-buildbot-config step. 16:37:41 INFO - Running pre-action listener: _resource_record_pre_action 16:37:41 INFO - Running main action method: read_buildbot_config 16:37:41 INFO - Using buildbot properties: 16:37:41 INFO - { 16:37:41 INFO - "project": "", 16:37:41 INFO - "product": "firefox", 16:37:41 INFO - "who": "kwierso@gmail.com", 16:37:41 INFO - "installer_path": "public/build/target.tar.bz2", 16:37:41 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 16:37:41 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:37:41 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 16:37:41 INFO - "stage_platform": "linux64-stylosequential", 16:37:41 INFO - "basedir": "/builds/slave/test", 16:37:41 INFO - "buildnumber": 155, 16:37:41 INFO - "platform": "ubuntu64_hw_styloseq", 16:37:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:37:41 INFO - "slavebuilddir": "test", 16:37:41 INFO - "taskId": "XoOH21ghSz6AyaNSFE0FqA", 16:37:41 INFO - "branch": "mozilla-central", 16:37:41 INFO - "script_repo_revision": "production", 16:37:41 INFO - "revision": "2fb6d8f7bac1be26b2b49b68fc34cc6decd7f339", 16:37:41 INFO - "slavename": "talos-linux64-ix-038", 16:37:41 INFO - "repo_path": "mozilla-central" 16:37:41 INFO - } 16:37:41 INFO - Finding installer, test and symbols from parent task. 16:37:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XoOH21ghSz6AyaNSFE0FqA'}, attempt #1 16:37:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XoOH21ghSz6AyaNSFE0FqA'}, attempt #1 16:37:42 INFO - Task dependencies: Fda-eMH8RpC4QtyvHDqLcA 16:37:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA'}, attempt #1 16:37:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.tar.bz2 16:37:42 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.test_packages.json 16:37:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.crashreporter-symbols.zip 16:37:42 INFO - Running post-action listener: _resource_record_post_action 16:37:42 INFO - [mozharness: 2017-08-17 23:37:42.683972Z] Finished read-buildbot-config step (success) 16:37:42 INFO - [mozharness: 2017-08-17 23:37:42.684193Z] Running download-and-extract step. 16:37:42 INFO - Running pre-action listener: _resource_record_pre_action 16:37:42 INFO - Running main action method: download_and_extract 16:37:42 INFO - mkdir: /builds/slave/test/build/tests 16:37:42 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')]} 16:37:42 INFO - trying https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.test_packages.json 16:37:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:37:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:37:43 INFO - Downloaded 989 bytes. 16:37:43 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:37:43 INFO - Using the following test package requirements: 16:37:43 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:37:43 INFO - u'common': [u'target.common.tests.zip'], 16:37:43 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:37:43 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:37:43 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:37:43 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:37:43 INFO - u'mozbase': [u'target.common.tests.zip'], 16:37:43 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:37:43 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:37:43 INFO - u'web-platform': [u'target.common.tests.zip', 16:37:43 INFO - u'target.web-platform.tests.tar.gz'], 16:37:43 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:37:43 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:37:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.common.tests.zip 16:37:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:37:43 INFO - Fetch https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.common.tests.zip into memory 16:37:44 INFO - Content-Length response header: 54000841 16:37:44 INFO - Bytes received: 54000841 16:37:55 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:37:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.common.tests.zip 16:37:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:37:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.common.tests.zip into memory 16:37:56 INFO - Content-Length response header: 54000841 16:37:56 INFO - Bytes received: 54000841 16:38:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.talos.tests.zip 16:38:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:38:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.talos.tests.zip into memory 16:38:08 INFO - Content-Length response header: 14496161 16:38:08 INFO - Bytes received: 14496161 16:38:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:09 INFO - trying https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.tar.bz2 16:38:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:38:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:38:10 INFO - Downloaded 62296625 bytes. 16:38:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.tar.bz2 16:38:10 INFO - mkdir: /builds/slave/test/properties 16:38:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:38:10 INFO - Writing to file /builds/slave/test/properties/build_url 16:38:10 INFO - Contents: 16:38:10 INFO - build_url:https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.tar.bz2 16:38:10 INFO - Running post-action listener: _resource_record_post_action 16:38:10 INFO - Running post-action listener: set_extra_try_arguments 16:38:10 INFO - [mozharness: 2017-08-17 23:38:10.171589Z] Finished download-and-extract step (success) 16:38:10 INFO - [mozharness: 2017-08-17 23:38:10.171687Z] Running populate-webroot step. 16:38:10 INFO - Running pre-action listener: _resource_record_pre_action 16:38:10 INFO - Running main action method: populate_webroot 16:38:10 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:38:10 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 16:38:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:38:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:38:10 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 16:38:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:38:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:38:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:38:10 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:38:10 INFO - 'talos_options': ['--stylo'], 16:38:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:38:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:38:10 INFO - 'tests': ['damp', 'tps']}, 16:38:10 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:38:10 INFO - 'talos_options': ['--stylo'], 16:38:10 INFO - 'tests': ['damp', 'tps']}, 16:38:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:38:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:38:10 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 16:38:10 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:38:10 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:38:10 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:38:10 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:38:10 INFO - 'talos_options': ['--stylo'], 16:38:10 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:38:10 INFO - 'other-e10s': {'tests': ['a11yr', 16:38:10 INFO - 'ts_paint', 16:38:10 INFO - 'tpaint', 16:38:10 INFO - 'sessionrestore', 16:38:10 INFO - 'sessionrestore_many_windows', 16:38:10 INFO - 'sessionrestore_no_auto_restore', 16:38:10 INFO - 'tabpaint']}, 16:38:10 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 16:38:10 INFO - 'tests': ['a11yr', 16:38:10 INFO - 'ts_paint', 16:38:10 INFO - 'tpaint', 16:38:10 INFO - 'sessionrestore', 16:38:10 INFO - 'sessionrestore_many_windows', 16:38:10 INFO - 'sessionrestore_no_auto_restore', 16:38:10 INFO - 'tabpaint']}, 16:38:10 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:38:10 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:38:10 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 16:38:10 INFO - 'tests': ['bloom_basic_singleton']}, 16:38:10 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 16:38:10 INFO - 'tests': ['bloom_basic']}, 16:38:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:38:10 INFO - 'tsvgr_opacity', 16:38:10 INFO - 'tart', 16:38:10 INFO - 'tscrollx', 16:38:10 INFO - 'tsvg_static']}, 16:38:10 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 16:38:10 INFO - 'tests': ['tsvgx', 16:38:10 INFO - 'tsvgr_opacity', 16:38:10 INFO - 'tart', 16:38:10 INFO - 'tscrollx', 16:38:10 INFO - 'tsvg_static']}, 16:38:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:38:10 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:38:10 INFO - 'talos_options': ['--stylo'], 16:38:10 INFO - 'tests': ['tp5o']}, 16:38:10 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:38:10 INFO - 'talos_options': ['--mitmproxy', 16:38:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:38:10 INFO - '--firstNonBlankPaint'], 16:38:10 INFO - 'tests': ['tp6_google', 16:38:10 INFO - 'tp6_youtube', 16:38:10 INFO - 'tp6_amazon', 16:38:10 INFO - 'tp6_facebook']}, 16:38:10 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:38:10 INFO - 'talos_options': ['--stylo', 16:38:10 INFO - '--mitmproxy', 16:38:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:38:10 INFO - '--firstNonBlankPaint'], 16:38:10 INFO - 'tests': ['tp6_google', 16:38:10 INFO - 'tp6_youtube', 16:38:10 INFO - 'tp6_amazon', 16:38:10 INFO - 'tp6_facebook']}, 16:38:10 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:38:10 INFO - 'talos_options': ['--stylo', 16:38:10 INFO - '--stylo-threads=1', 16:38:10 INFO - '--mitmproxy', 16:38:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:38:10 INFO - '--firstNonBlankPaint'], 16:38:10 INFO - 'tests': ['tp6_google', 16:38:10 INFO - 'tp6_youtube', 16:38:10 INFO - 'tp6_amazon', 16:38:10 INFO - 'tp6_facebook']}, 16:38:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:38:10 INFO - 'talos_options': ['--xperf_path', 16:38:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:38:10 INFO - 'tests': ['tp5n']}, 16:38:10 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:38:10 INFO - 'talos_options': ['--stylo', 16:38:10 INFO - '--xperf_path', 16:38:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:38:10 INFO - 'tests': ['tp5n']}}} 16:38:10 INFO - Running post-action listener: _resource_record_post_action 16:38:10 INFO - [mozharness: 2017-08-17 23:38:10.186124Z] Finished populate-webroot step (success) 16:38:10 INFO - [mozharness: 2017-08-17 23:38:10.186216Z] Running create-virtualenv step. 16:38:10 INFO - Running pre-action listener: _resource_record_pre_action 16:38:10 INFO - Running main action method: create_virtualenv 16:38:10 INFO - Creating virtualenv /builds/slave/test/build/venv 16:38:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:38:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:38:10 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:38:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:38:10 INFO - Using real prefix '/usr' 16:38:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:38:10 INFO - Installing distribute.............................................................................................................................................................................................done. 16:38:12 INFO - Installing pip.................done. 16:38:12 INFO - Return code: 0 16:38:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:38:12 INFO - Reading from file tmpfile_stdout 16:38:12 INFO - Output received: 16:38:12 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:38:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239aef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23980b0>, '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 0x2398fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2399440>, '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': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', '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 16:38:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:38:12 INFO - Using env: {'DISPLAY': ':0', 16:38:12 INFO - 'HOME': '/home/cltbld', 16:38:12 INFO - 'LANG': 'en_US.UTF-8', 16:38:12 INFO - 'LANGUAGE': 'en_US:en', 16:38:12 INFO - 'LOGNAME': 'cltbld', 16:38:12 INFO - 'MAIL': '/var/mail/cltbld', 16:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:12 INFO - 'MOZ_NO_REMOTE': '1', 16:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:12 INFO - 'NO_EM_RESTART': '1', 16:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:12 INFO - 'PWD': '/builds/slave/test', 16:38:12 INFO - 'SHELL': '/bin/bash', 16:38:12 INFO - 'SHLVL': '1', 16:38:12 INFO - 'TERM': 'linux', 16:38:12 INFO - 'TMOUT': '86400', 16:38:12 INFO - 'USER': 'cltbld', 16:38:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', 16:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:12 INFO - '_': '/tools/buildbot/bin/python'} 16:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:38:13 INFO - Cleaning up... 16:38:13 INFO - Return code: 0 16:38:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:38: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')]} 16:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38: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')]} 16:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239aef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23980b0>, '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 0x2398fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2399440>, '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': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', '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 16:38:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:38:13 INFO - Using env: {'DISPLAY': ':0', 16:38:13 INFO - 'HOME': '/home/cltbld', 16:38:13 INFO - 'LANG': 'en_US.UTF-8', 16:38:13 INFO - 'LANGUAGE': 'en_US:en', 16:38:13 INFO - 'LOGNAME': 'cltbld', 16:38:13 INFO - 'MAIL': '/var/mail/cltbld', 16:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:13 INFO - 'MOZ_NO_REMOTE': '1', 16:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:13 INFO - 'NO_EM_RESTART': '1', 16:38:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:13 INFO - 'PWD': '/builds/slave/test', 16:38:13 INFO - 'SHELL': '/bin/bash', 16:38:13 INFO - 'SHLVL': '1', 16:38:13 INFO - 'TERM': 'linux', 16:38:13 INFO - 'TMOUT': '86400', 16:38:13 INFO - 'USER': 'cltbld', 16:38:13 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', 16:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:13 INFO - '_': '/tools/buildbot/bin/python'} 16:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:13 INFO - Downloading/unpacking psutil>=3.1.1 16:38: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 16:38: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 16:38: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 16:38: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 16:38:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:38:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:38:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:38:14 INFO - Installing collected packages: psutil 16:38:14 INFO - Running setup.py install for psutil 16:38:15 INFO - building 'psutil._psutil_linux' extension 16:38:15 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 16:38:15 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 16:38:15 INFO - building 'psutil._psutil_posix' extension 16:38:15 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 16:38:15 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 16:38:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:38:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:38:15 INFO - Successfully installed psutil 16:38:15 INFO - Cleaning up... 16:38:15 INFO - Return code: 0 16:38:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:38: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')]} 16:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38: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')]} 16:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239aef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23980b0>, '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 0x2398fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2399440>, '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': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', '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 16:38: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:38: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 mozsystemmonitor==0.3 16:38:15 INFO - Using env: {'DISPLAY': ':0', 16:38:15 INFO - 'HOME': '/home/cltbld', 16:38:15 INFO - 'LANG': 'en_US.UTF-8', 16:38:15 INFO - 'LANGUAGE': 'en_US:en', 16:38:15 INFO - 'LOGNAME': 'cltbld', 16:38:15 INFO - 'MAIL': '/var/mail/cltbld', 16:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:15 INFO - 'MOZ_NO_REMOTE': '1', 16:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:15 INFO - 'NO_EM_RESTART': '1', 16:38:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:15 INFO - 'PWD': '/builds/slave/test', 16:38:15 INFO - 'SHELL': '/bin/bash', 16:38:15 INFO - 'SHLVL': '1', 16:38:15 INFO - 'TERM': 'linux', 16:38:15 INFO - 'TMOUT': '86400', 16:38:15 INFO - 'USER': 'cltbld', 16:38:15 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', 16:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:15 INFO - '_': '/tools/buildbot/bin/python'} 16:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:38:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:38:16 INFO - Installing collected packages: mozsystemmonitor 16:38:16 INFO - Running setup.py install for mozsystemmonitor 16:38:16 INFO - Successfully installed mozsystemmonitor 16:38:16 INFO - Cleaning up... 16:38:16 INFO - Return code: 0 16:38:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:17 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 0x20f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239aef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23980b0>, '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 0x2398fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2399440>, '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': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', '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 16:38:17 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 16:38:17 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 16:38:17 INFO - Using env: {'DISPLAY': ':0', 16:38:17 INFO - 'HOME': '/home/cltbld', 16:38:17 INFO - 'LANG': 'en_US.UTF-8', 16:38:17 INFO - 'LANGUAGE': 'en_US:en', 16:38:17 INFO - 'LOGNAME': 'cltbld', 16:38:17 INFO - 'MAIL': '/var/mail/cltbld', 16:38:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:17 INFO - 'MOZ_NO_REMOTE': '1', 16:38:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:17 INFO - 'NO_EM_RESTART': '1', 16:38:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:17 INFO - 'PWD': '/builds/slave/test', 16:38:17 INFO - 'SHELL': '/bin/bash', 16:38:17 INFO - 'SHLVL': '1', 16:38:17 INFO - 'TERM': 'linux', 16:38:17 INFO - 'TMOUT': '86400', 16:38:17 INFO - 'USER': 'cltbld', 16:38:17 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', 16:38:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:17 INFO - '_': '/tools/buildbot/bin/python'} 16:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:17 INFO - Downloading/unpacking jsonschema==2.5.1 16:38:17 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 16:38:17 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 16:38:17 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 16:38:17 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 16:38:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:38:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:18 INFO - Downloading functools32-3.2.3-2.tar.gz 16:38:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:38:18 INFO - warning: no files found matching '*.txt' 16:38:18 INFO - no previously-included directories found matching 'build' 16:38:18 INFO - no previously-included directories found matching 'dist' 16:38:18 INFO - no previously-included directories found matching '.git*' 16:38:18 INFO - Installing collected packages: jsonschema, functools32 16:38:18 INFO - Running setup.py install for functools32 16:38:18 INFO - warning: no files found matching '*.txt' 16:38:18 INFO - no previously-included directories found matching 'build' 16:38:18 INFO - no previously-included directories found matching 'dist' 16:38:18 INFO - no previously-included directories found matching '.git*' 16:38:18 INFO - Successfully installed jsonschema functools32 16:38:18 INFO - Cleaning up... 16:38:18 INFO - Return code: 0 16:38:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239aef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23980b0>, '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 0x2398fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2399440>, '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': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', '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 16:38:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:38:18 INFO - Using env: {'DISPLAY': ':0', 16:38:18 INFO - 'HOME': '/home/cltbld', 16:38:18 INFO - 'LANG': 'en_US.UTF-8', 16:38:18 INFO - 'LANGUAGE': 'en_US:en', 16:38:18 INFO - 'LOGNAME': 'cltbld', 16:38:18 INFO - 'MAIL': '/var/mail/cltbld', 16:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:18 INFO - 'MOZ_NO_REMOTE': '1', 16:38:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:18 INFO - 'NO_EM_RESTART': '1', 16:38:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:18 INFO - 'PWD': '/builds/slave/test', 16:38:18 INFO - 'SHELL': '/bin/bash', 16:38:18 INFO - 'SHLVL': '1', 16:38:18 INFO - 'TERM': 'linux', 16:38:18 INFO - 'TMOUT': '86400', 16:38:18 INFO - 'USER': 'cltbld', 16:38:18 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', 16:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:18 INFO - '_': '/tools/buildbot/bin/python'} 16:38:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:38:18 INFO - Cleaning up... 16:38:18 INFO - Return code: 0 16:38:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239aef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23980b0>, '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 0x2398fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2399440>, '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': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', '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 16:38:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:38:18 INFO - Using env: {'DISPLAY': ':0', 16:38:18 INFO - 'HOME': '/home/cltbld', 16:38:18 INFO - 'LANG': 'en_US.UTF-8', 16:38:18 INFO - 'LANGUAGE': 'en_US:en', 16:38:18 INFO - 'LOGNAME': 'cltbld', 16:38:18 INFO - 'MAIL': '/var/mail/cltbld', 16:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:18 INFO - 'MOZ_NO_REMOTE': '1', 16:38:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:18 INFO - 'NO_EM_RESTART': '1', 16:38:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:18 INFO - 'PWD': '/builds/slave/test', 16:38:18 INFO - 'SHELL': '/bin/bash', 16:38:18 INFO - 'SHLVL': '1', 16:38:18 INFO - 'TERM': 'linux', 16:38:18 INFO - 'TMOUT': '86400', 16:38:18 INFO - 'USER': 'cltbld', 16:38:18 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', 16:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:18 INFO - '_': '/tools/buildbot/bin/python'} 16:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:19 INFO - Downloading/unpacking blobuploader==1.2.4 16:38:19 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 16:38:19 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 16:38:19 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 16:38:19 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 16:38:20 INFO - Downloading blobuploader-1.2.4.tar.gz 16:38:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:38:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:38:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:38:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:38:20 INFO - Downloading docopt-0.6.1.tar.gz 16:38:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:38:20 INFO - Installing collected packages: blobuploader, requests, docopt 16:38:20 INFO - Running setup.py install for blobuploader 16:38:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:38:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:38:20 INFO - Running setup.py install for requests 16:38:21 INFO - Running setup.py install for docopt 16:38:21 INFO - Successfully installed blobuploader requests docopt 16:38:21 INFO - Cleaning up... 16:38:21 INFO - Return code: 0 16:38:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:38:21 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')]} 16:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:21 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')]} 16:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:21 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 0x20f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239aef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23980b0>, '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 0x2398fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2399440>, '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': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', '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 16:38:21 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 16:38:21 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 16:38:21 INFO - Using env: {'DISPLAY': ':0', 16:38:21 INFO - 'HOME': '/home/cltbld', 16:38:21 INFO - 'LANG': 'en_US.UTF-8', 16:38:21 INFO - 'LANGUAGE': 'en_US:en', 16:38:21 INFO - 'LOGNAME': 'cltbld', 16:38:21 INFO - 'MAIL': '/var/mail/cltbld', 16:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:21 INFO - 'MOZ_NO_REMOTE': '1', 16:38:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:21 INFO - 'NO_EM_RESTART': '1', 16:38:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:21 INFO - 'PWD': '/builds/slave/test', 16:38:21 INFO - 'SHELL': '/bin/bash', 16:38:21 INFO - 'SHLVL': '1', 16:38:21 INFO - 'TERM': 'linux', 16:38:21 INFO - 'TMOUT': '86400', 16:38:21 INFO - 'USER': 'cltbld', 16:38:21 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', 16:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:21 INFO - '_': '/tools/buildbot/bin/python'} 16:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:38:21 INFO - Running setup.py (path:/tmp/pip-3yVi5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:38:21 INFO - Running setup.py (path:/tmp/pip-HiOE2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:38:21 INFO - Running setup.py (path:/tmp/pip-X_KuN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:38:21 INFO - Running setup.py (path:/tmp/pip-1pRgKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:38:21 INFO - Running setup.py (path:/tmp/pip-o4nK8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:38:22 INFO - Running setup.py (path:/tmp/pip-Z_4OGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:38:22 INFO - Running setup.py (path:/tmp/pip-BNI9vR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:38:22 INFO - Running setup.py (path:/tmp/pip-_1OZ73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:38:22 INFO - Running setup.py (path:/tmp/pip-7pUwtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:38:22 INFO - Running setup.py (path:/tmp/pip-MwdVnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:38:22 INFO - Running setup.py (path:/tmp/pip-mWP3pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:38:22 INFO - Running setup.py (path:/tmp/pip-E9G0w3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:38:22 INFO - Running setup.py (path:/tmp/pip-H4QvwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:38:22 INFO - Running setup.py (path:/tmp/pip-aaZLZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:22 INFO - Running setup.py (path:/tmp/pip-c06w0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:38:22 INFO - Running setup.py (path:/tmp/pip-EtiX4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:38:22 INFO - Running setup.py (path:/tmp/pip-1S5WQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:38:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:38:22 INFO - Running setup.py install for manifestparser 16:38:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:38:23 INFO - Running setup.py install for mozcrash 16:38:23 INFO - Running setup.py install for mozdebug 16:38:23 INFO - Running setup.py install for mozdevice 16:38:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:38:23 INFO - Running setup.py install for mozfile 16:38:23 INFO - Running setup.py install for mozhttpd 16:38:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:38:23 INFO - Running setup.py install for mozinfo 16:38:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:38:23 INFO - Running setup.py install for mozInstall 16:38:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:38:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:38:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:38:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:38:23 INFO - Running setup.py install for mozleak 16:38:23 INFO - Running setup.py install for mozlog 16:38:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:38:23 INFO - Running setup.py install for moznetwork 16:38:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:38:24 INFO - Running setup.py install for mozprocess 16:38:24 INFO - Running setup.py install for mozprofile 16:38:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:38:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:38:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:38:24 INFO - Running setup.py install for mozrunner 16:38:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:38:24 INFO - Running setup.py install for mozscreenshot 16:38:24 INFO - Running setup.py install for moztest 16:38:24 INFO - Running setup.py install for mozversion 16:38:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:38:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:38:24 INFO - Cleaning up... 16:38:24 INFO - Return code: 0 16:38:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:38:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:24 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 0x20f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239aef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23980b0>, '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 0x2398fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2399440>, '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': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', '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 16:38:24 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 16:38:24 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 16:38:24 INFO - Using env: {'DISPLAY': ':0', 16:38:24 INFO - 'HOME': '/home/cltbld', 16:38:24 INFO - 'LANG': 'en_US.UTF-8', 16:38:24 INFO - 'LANGUAGE': 'en_US:en', 16:38:24 INFO - 'LOGNAME': 'cltbld', 16:38:24 INFO - 'MAIL': '/var/mail/cltbld', 16:38:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:24 INFO - 'MOZ_NO_REMOTE': '1', 16:38:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:24 INFO - 'NO_EM_RESTART': '1', 16:38:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:24 INFO - 'PWD': '/builds/slave/test', 16:38:24 INFO - 'SHELL': '/bin/bash', 16:38:24 INFO - 'SHLVL': '1', 16:38:24 INFO - 'TERM': 'linux', 16:38:24 INFO - 'TMOUT': '86400', 16:38:24 INFO - 'USER': 'cltbld', 16:38:24 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', 16:38:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:24 INFO - '_': '/tools/buildbot/bin/python'} 16:38:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:38:24 INFO - Running setup.py (path:/tmp/pip-PzwnwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:38:24 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)) 16:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:38:24 INFO - Running setup.py (path:/tmp/pip-EQeYA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:38:25 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)) 16:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:38:25 INFO - Running setup.py (path:/tmp/pip-qVbYaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:38:25 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)) 16:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:38:25 INFO - Running setup.py (path:/tmp/pip-Yln1dM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:38:25 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)) 16:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:38:25 INFO - Running setup.py (path:/tmp/pip-es7E0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:38:25 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)) 16:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:38:25 INFO - Running setup.py (path:/tmp/pip-9XaP4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:38:25 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)) 16:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:38:25 INFO - Running setup.py (path:/tmp/pip-Gsh9EL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:38:25 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)) 16:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:38:25 INFO - Running setup.py (path:/tmp/pip-dYWdTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:38:25 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)) 16:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:38:25 INFO - Running setup.py (path:/tmp/pip-1ORfdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:38:25 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)) 16:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:38:25 INFO - Running setup.py (path:/tmp/pip-n3svll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:38:25 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)) 16:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:38:25 INFO - Running setup.py (path:/tmp/pip-g285eZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:38:25 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)) 16:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:38:25 INFO - Running setup.py (path:/tmp/pip-5BwjyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:38:25 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)) 16:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:38:25 INFO - Running setup.py (path:/tmp/pip-CoH2zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:38:25 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)) 16:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:38:25 INFO - Running setup.py (path:/tmp/pip-uB92Ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:38:25 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)) 16:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:25 INFO - Running setup.py (path:/tmp/pip-MDDJWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:38:25 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)) 16:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:38:25 INFO - Running setup.py (path:/tmp/pip-tzRH94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:38:26 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)) 16:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:38:26 INFO - Running setup.py (path:/tmp/pip-G1kgjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:38:26 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)) 16:38:26 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)) 16:38:26 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)) 16:38:26 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)) 16:38:26 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)) 16:38:26 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)) 16:38:26 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)) 16:38:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:38:26 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 16:38:26 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 16:38:26 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 16:38:26 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 16:38:27 INFO - Downloading blessings-1.6.tar.gz 16:38:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:38:27 INFO - Installing collected packages: blessings 16:38:27 INFO - Running setup.py install for blessings 16:38:27 INFO - Successfully installed blessings 16:38:27 INFO - Cleaning up... 16:38:27 INFO - Return code: 0 16:38:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:38:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:38:27 INFO - Reading from file tmpfile_stdout 16:38:27 INFO - Current package versions: 16:38:27 INFO - argparse == 1.2.1 16:38:27 INFO - blessings == 1.6 16:38:27 INFO - blobuploader == 1.2.4 16:38:27 INFO - docopt == 0.6.1 16:38:27 INFO - functools32 == 3.2.3-2 16:38:27 INFO - jsonschema == 2.5.1 16:38:27 INFO - manifestparser == 1.1 16:38:27 INFO - mozInstall == 1.13 16:38:27 INFO - mozcrash == 1.0 16:38:27 INFO - mozdebug == 0.1 16:38:27 INFO - mozdevice == 0.51 16:38:27 INFO - mozfile == 1.2 16:38:27 INFO - mozhttpd == 0.7 16:38:27 INFO - mozinfo == 0.10 16:38:27 INFO - mozleak == 0.1 16:38:27 INFO - mozlog == 3.5 16:38:27 INFO - moznetwork == 0.27 16:38:27 INFO - mozprocess == 0.25 16:38:27 INFO - mozprofile == 0.28 16:38:27 INFO - mozrunner == 6.13 16:38:27 INFO - mozscreenshot == 0.1 16:38:27 INFO - mozsystemmonitor == 0.3 16:38:27 INFO - moztest == 0.8 16:38:27 INFO - mozversion == 1.4 16:38:27 INFO - psutil == 3.1.1 16:38:27 INFO - requests == 1.2.3 16:38:27 INFO - wsgiref == 0.1.2 16:38:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:38:27 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')]} 16:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:27 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')]} 16:38:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:27 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 0x20f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239aef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23980b0>, '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 0x2398fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2399440>, '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': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', '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 16:38:27 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 16:38:27 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 16:38:27 INFO - Using env: {'DISPLAY': ':0', 16:38:27 INFO - 'HOME': '/home/cltbld', 16:38:27 INFO - 'LANG': 'en_US.UTF-8', 16:38:27 INFO - 'LANGUAGE': 'en_US:en', 16:38:27 INFO - 'LOGNAME': 'cltbld', 16:38:27 INFO - 'MAIL': '/var/mail/cltbld', 16:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:27 INFO - 'MOZ_NO_REMOTE': '1', 16:38:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:27 INFO - 'NO_EM_RESTART': '1', 16:38:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:27 INFO - 'PWD': '/builds/slave/test', 16:38:27 INFO - 'SHELL': '/bin/bash', 16:38:27 INFO - 'SHLVL': '1', 16:38:27 INFO - 'TERM': 'linux', 16:38:27 INFO - 'TMOUT': '86400', 16:38:27 INFO - 'USER': 'cltbld', 16:38:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', 16:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:27 INFO - '_': '/tools/buildbot/bin/python'} 16:38:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:27 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)) 16:38:27 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)) 16:38:27 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)) 16:38:27 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)) 16:38:27 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)) 16:38:27 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)) 16:38:27 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)) 16:38:27 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)) 16:38:27 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)) 16:38:27 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:38:27 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 16:38:27 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 16:38:27 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 16:38:27 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 16:38:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:38:29 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)) 16:38:29 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)) 16:38:29 INFO - Installing collected packages: simplejson 16:38:29 INFO - Running setup.py install for simplejson 16:38:29 INFO - building 'simplejson._speedups' extension 16:38:29 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 16:38:29 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 16:38:30 INFO - Successfully installed simplejson 16:38:30 INFO - Cleaning up... 16:38:30 INFO - Return code: 0 16:38:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:38:30 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')]} 16:38:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:38:30 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')]} 16:38:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:38:30 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 0x20f31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x239aef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23980b0>, '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 0x2398fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2399440>, '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': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', '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 16:38:30 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 16:38:30 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 16:38:30 INFO - Using env: {'DISPLAY': ':0', 16:38:30 INFO - 'HOME': '/home/cltbld', 16:38:30 INFO - 'LANG': 'en_US.UTF-8', 16:38:30 INFO - 'LANGUAGE': 'en_US:en', 16:38:30 INFO - 'LOGNAME': 'cltbld', 16:38:30 INFO - 'MAIL': '/var/mail/cltbld', 16:38:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:30 INFO - 'MOZ_NO_REMOTE': '1', 16:38:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:30 INFO - 'NO_EM_RESTART': '1', 16:38:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:30 INFO - 'PWD': '/builds/slave/test', 16:38:30 INFO - 'SHELL': '/bin/bash', 16:38:30 INFO - 'SHLVL': '1', 16:38:30 INFO - 'TERM': 'linux', 16:38:30 INFO - 'TMOUT': '86400', 16:38:30 INFO - 'USER': 'cltbld', 16:38:30 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', 16:38:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:30 INFO - '_': '/tools/buildbot/bin/python'} 16:38:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:38:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:38:30 INFO - Cleaning up... 16:38:30 INFO - Return code: 0 16:38:30 INFO - Running post-action listener: _resource_record_post_action 16:38:30 INFO - Running post-action listener: _start_resource_monitoring 16:38:30 INFO - Starting resource monitoring. 16:38:30 INFO - [mozharness: 2017-08-17 23:38:30.405253Z] Finished create-virtualenv step (success) 16:38:30 INFO - [mozharness: 2017-08-17 23:38:30.405721Z] Running install step. 16:38:30 INFO - Running pre-action listener: _resource_record_pre_action 16:38:30 INFO - Running main action method: install 16:38:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:38:30 INFO - Reading from file tmpfile_stdout 16:38:30 INFO - Detecting whether we're running mozinstall >=1.0... 16:38:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:38:30 INFO - Reading from file tmpfile_stdout 16:38:30 INFO - Output received: 16:38:30 INFO - Usage: mozinstall [options] installer 16:38:30 INFO - Options: 16:38:30 INFO - -h, --help show this help message and exit 16:38:30 INFO - -d DEST, --destination=DEST 16:38:30 INFO - Directory to install application into. [default: 16:38:30 INFO - "/builds/slave/test"] 16:38:30 INFO - --app=APP Application being installed. [default: firefox] 16:38:30 INFO - mkdir: /builds/slave/test/build/application 16:38:30 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'] 16:38:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:38:50 INFO - Reading from file tmpfile_stdout 16:38:50 INFO - Output received: 16:38:50 INFO - /builds/slave/test/build/application/firefox/firefox 16:38:50 INFO - Running post-action listener: _resource_record_post_action 16:38:50 INFO - [mozharness: 2017-08-17 23:38:50.217609Z] Finished install step (success) 16:38:50 INFO - [mozharness: 2017-08-17 23:38:50.217862Z] Running setup-mitmproxy step. 16:38:50 INFO - Running pre-action listener: _resource_record_pre_action 16:38:50 INFO - Running main action method: setup_mitmproxy 16:38:50 INFO - Skipping: mitmproxy is not required 16:38:50 INFO - Running post-action listener: _resource_record_post_action 16:38:50 INFO - [mozharness: 2017-08-17 23:38:50.219009Z] Finished setup-mitmproxy step (success) 16:38:50 INFO - [mozharness: 2017-08-17 23:38:50.219230Z] Running run-tests step. 16:38:50 INFO - Running pre-action listener: _resource_record_pre_action 16:38:50 INFO - Running pre-action listener: _set_gcov_prefix 16:38:50 INFO - Running main action method: run_tests 16:38:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:38:50 INFO - Python 2.7.3 16:38:50 INFO - Return code: 0 16:38:50 INFO - grabbing minidump binary from tooltool 16:38:50 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')]} 16:38:50 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23980b0>, '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 0x2398fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2399440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:38:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:38:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:38:50 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:38:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:38:50 INFO - Return code: 0 16:38:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:38:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:38:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:38:50 INFO - ENV: RUST_BACKTRACE is now full 16:38:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:38:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:38:50 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/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 16:38:50 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/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 16:38:50 INFO - Using env: {'DISPLAY': ':0', 16:38:50 INFO - 'HOME': '/home/cltbld', 16:38:50 INFO - 'LANG': 'en_US.UTF-8', 16:38:50 INFO - 'LANGUAGE': 'en_US:en', 16:38:50 INFO - 'LOGNAME': 'cltbld', 16:38:50 INFO - 'MAIL': '/var/mail/cltbld', 16:38:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:38:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:38:50 INFO - 'MOZ_NO_REMOTE': '1', 16:38:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:38:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:38:50 INFO - 'NO_EM_RESTART': '1', 16:38:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:38:50 INFO - 'PWD': '/builds/slave/test', 16:38:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:38:50 INFO - 'RUST_BACKTRACE': 'full', 16:38:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:38:50 INFO - 'SHELL': '/bin/bash', 16:38:50 INFO - 'SHLVL': '1', 16:38:50 INFO - 'STYLO_FORCE_ENABLED': '1', 16:38:50 INFO - 'TERM': 'linux', 16:38:50 INFO - 'TMOUT': '86400', 16:38:50 INFO - 'USER': 'cltbld', 16:38:50 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537', 16:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:38:50 INFO - '_': '/tools/buildbot/bin/python'} 16:38:50 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/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 16:38:50 INFO - mozversion application_buildid: 20170817223319 16:38:50 INFO - mozversion application_changeset: 2fb6d8f7bac1be26b2b49b68fc34cc6decd7f339 16:38:50 INFO - mozversion application_display_name: Nightly 16:38:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:38:50 INFO - mozversion application_name: Firefox 16:38:50 INFO - mozversion application_remotingname: firefox 16:38:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:38:50 INFO - mozversion application_vendor: Mozilla 16:38:50 INFO - mozversion application_version: 57.0a1 16:38:50 INFO - mozversion platform_buildid: 20170817223319 16:38:50 INFO - mozversion platform_changeset: 2fb6d8f7bac1be26b2b49b68fc34cc6decd7f339 16:38:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:38:50 INFO - mozversion platform_version: 57.0a1 16:38:50 INFO - using testdate: 1503013130 16:38:50 INFO - actual date: 1503013130 16:38:50 INFO - starting webserver on 'localhost:32798' 16:38:50 INFO - SUITE-START | Running 2 tests 16:38:50 INFO - TEST-START | dromaeo_css 16:38:50 INFO - Initialising browser for dromaeo_css test... 16:38:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:32798/getInfo.html -profile /tmp/tmpHUnJh9/profile 16:38:50 INFO - TEST-INFO | started process 16271 (/builds/slave/test/build/application/firefox/firefox http://localhost:32798/getInfo.html) 16:38:57 INFO - TEST-INFO | 16271: exit 0 16:38:57 INFO - Browser initialized. 16:38:57 INFO - Running cycle 1/1 for dromaeo_css test... 16:38:57 INFO - TEST-INFO | started process 16464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHUnJh9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:38:58 INFO - PID 16464 | 16:38:58 INFO - PID 16464 | (/builds/slave/test/build/application/firefox/firefox:16518): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:38:58 INFO - PID 16464 | 16:39:08 INFO - PID 16464 | RSS: Main: 169934848 16:39:08 INFO - PID 16464 | 16:42:08 INFO - PID 16464 | Cycle 1(1): loaded http://localhost:32798/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32798/tests/dromaeo/cssquery-ext.html) 16:42:09 INFO - PID 16464 | RSS: Main: 174870528 16:42:09 INFO - PID 16464 | 16:45:11 INFO - PID 16464 | Cycle 1(1): loaded http://localhost:32798/tests/dromaeo/cssquery-ext.html (next: http://localhost:32798/tests/dromaeo/cssquery-jquery.html) 16:45:11 INFO - PID 16464 | RSS: Main: 172003328 16:45:11 INFO - PID 16464 | 16:48:13 INFO - PID 16464 | Cycle 1(1): loaded http://localhost:32798/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32798/tests/dromaeo/cssquery-mootools.html) 16:48:14 INFO - PID 16464 | RSS: Main: 173940736 16:48:14 INFO - PID 16464 | 16:51:16 INFO - PID 16464 | Cycle 1(1): loaded http://localhost:32798/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32798/tests/dromaeo/cssquery-prototype.html) 16:51:16 INFO - PID 16464 | RSS: Main: 172744704 16:51:16 INFO - PID 16464 | 16:54:20 INFO - PID 16464 | Cycle 1(1): loaded http://localhost:32798/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32798/tests/dromaeo/cssquery-yui.html) 16:54:21 INFO - PID 16464 | RSS: Main: 173756416 16:54:21 INFO - PID 16464 | 16:57:22 INFO - PID 16464 | Cycle 1(1): loaded http://localhost:32798/tests/dromaeo/cssquery-yui.html (next: http://localhost:32798/tests/dromaeo/cssquery-dojo.html) 16:57:23 INFO - PID 16464 | RSS: Main: 176271360 16:57:23 INFO - PID 16464 | 16:57:23 INFO - PID 16464 | __start_tp_report 16:57:23 INFO - PID 16464 | _x_x_mozilla_page_load 16:57:23 INFO - PID 16464 | _x_x_mozilla_page_load_details 16:57:23 INFO - PID 16464 | |i|pagename|runs| 16:57:23 INFO - PID 16464 | |0;dojo.html;3150.2439414540518;3179.3005538781467;3192.9840350798236;3201.3437245364703;3232.628247751509;6029.246344206974;6094.390560943909;6142;6158.630482171062;6219.595726277788;6191.907121393183;6214;6221.377862213776;6237.407446292606;6300.810975670725;5561.721913904309;5609.439056094378;5699.743511541969;5728.455796699307;5766.855828604276;5603.775848966036;5683.971580142093;5686.857828554278;5700.059490184135;5775.624584402021;5602.747876345574;5639.915401268984;5649.406812284692;5740.425957404289;5748.97125514374;5462.481064298885;5643.8589035274035;5676.3188417389765;5699.059655156894;5728.198052272685;5548.140038294071;5560.165975103726;5616.943830561683;5655.915161272585;5656.038473459481;6048.939510604926;6059.878802423971;6098.451139397475;6120.60216085953;6143.047827586731;6571.310012448672;6583.275839657634;6627.138471998657;6673.399394054559;6681.565698229648;6588.934110658928;6651.268360480343;6710.7315707371645;6749.93250067498;6761.864762704768;6184.134221209034;6230.626162430269;6239.750409983595;6251.093591429218;6255.186825712719;6731.326867313327;6850.965745171342;6940.895886561706;6944.930550694529;6968.721251149897;6490.123833282447;6492.383223593751;6504.024396340492;6509.1863517060365;6516.5112616553;6618.338166183439;6630.336966303331;6631.668416579152;6635.236947750974;6635.6350400728425;6565.24499682533;6572.4084832365315;6592;6698.63157526331;6730.596164230162;6679.833004174934;6755.763548275787;6779.9322006780285;6782.525223234425;6809.148856392951;5433.782648694087;5480.095784195563;5516.972415137979;5544.140658197985;5545.500904918496;4545.36364908913;4604.838830640979;4664.976675116603;4712.458067322234;4742.478327383985;5708.143778433268;5773.88452230953;5787.681677507778;5788.27646544182;5792.1311803229855;6720.1599800025;6747.05541224229;6765.695543700545;6786.321367863273;6787.287334829871;5724.971375143097;5733.512651424592;5809.302883653904;5816.040353341651;5832.970835145882;5834.445727655866;5899.587028908021;5924.318703349084;6001.309849367379;6003.039513677791;6448.516361272923;6459.483241340681;6463.095166676669;6463.870722585522;6520.869582608321;6598.90101648466;6700.43046341047;6708.161479815023;6716.697748601422;6719.932800671931;6057.939420605738;6444.903326450013;6468.514861385321;6473.417392434703;6503.382178693017;6522;6555.901661475177;6616.801495955129;6621.702023409054;6641.900371494528;6651.800445986628;6670.633115178712;6734.427573656294;6751.628660423724;6780.355866192901;6315.747370105328;6416.7754128605275;6452.257990331172;6455.709493072729;6457.967710161419;6392.648404337806;6479.222493300834;6502.219733631994;6562.967185164043;6563.967180164069;6133.969330153499;6405.615663060231;6480.70836812354;6490;6530.510211734044;6453.096566480603;6549.8690026200165;6590.143281373583;6609.570377925419;6626.403623673892;6171.783987560414;6284.74861005573;6288.968555157195;6329.525285603506;6334.904976425265 16:57:23 INFO - PID 16464 | |1;ext.html;835.9456635318704;858.184724511714;887.6937456577479;891.2736120062153;1144.19906065754;32033.679663203362;32292.838535807317;42586.99999999996;43197;43216;42677;42992;43001.35497967525;43004.784976075156;43026;7337.559746415232;7685.577293248869;7940.325072368855;7941.404394670423;7943.165967573379;7772.261635144652;7852.882206766903;7868.881966770503;7873.409494287923;7895.328897043758;7845;7847.9215207847765;7848.45060845741;7852.097008843999;7864.685412583518;7840.764777056697;7847.176046515119;7847.489913155627;7856;7911.920880791176;7740.612969351566;7808.063032436144;7816.687332506693;7819.6481158348015;7820.139784623687;39030.414543781866;39158.21683566313;39178;39409.60590394088;39446.80276598627;3594.101474631342;3613.4941108244866;3634.7637403568683;3641.18073433478;3645.489631451599;31946.840265798754;31969.040928772174;32010.039698809072;32226.355472890646;32254.193645158823;4933.161362568336;4939.975300123477;4989.57588604969;4994.375703037121;5031.471695471996;191296;193968;194318;194358;194427;49975.75012124916;50029;50073.49926500761;50114.74942625264;50151.24773128406;52183.217251741255;52259.73870130625;52291.73854130705;52320.21519677208;52334.738326308885;13850.376733047036;15320.846791532165;15435.15106669144;15493.07041577509;15511.301991410413;11131.777364452828;11376.260543064674;11397.031252343644;11429.714257143472;11431.942840285745;14460.783088253685;14506.274686265644;14544.927275363767;14552;14622.122672639676;5677.829665110054;5793.797217097465;5870.853228669317;5873.353931067579;5914;1001.7746007148334;1007.3804610164696;1021.341234903483;1041.9843702344472;1045.8849526552074;23412.64881026786;23737.694426806345;23937;30613.69386306153;30956.380872382426;1092.1044743310408;1128.700894263021;1135.3868910788083;1140.3101123820136;1142.257532603814;12556.246625202517;12845.935770321088;12855.935720321339;12881.484740610458;12891.677708057374;248590;249877;250491;250746;250867;53007;53291.20063199055;53449;53490.73254633702;53572;1525.83978682239;1531.5635044012627;1556.7664850272324;1558.5480210738986;1563.7419825728855;23275.53448930978;23514.882425587763;23519.88240058789;23530.294091177293;23574.29277121689;38215;38372.424413633256;38382.23235535218;38509.614903850605;38525.036874078374;223827;224349;225474;226281;226651;36838;39140.412893806046;39747.60252397555;39824.20351592894;39911.800440997606;46766;48586.514134859615;48694;49018.77453063702;49031;35431;35789.82105089458;35885.64114358823;36265.81867090753;36679.633203667625;34546.30907381788;34955.12612184614;35109.12227194341;35113.473297901066;35321.293574127856;38234.61765382422;38339.42490862695;38465.42301865418;38767.6123238764;38822.80588597152;33592;33894.81368152103;33942;34238.48642270318;34456.138596534285;23926.52146957086;24556.508869822148;24607.50784984326;24810.131645392325;25191.11831085903 16:57:23 INFO - PID 16464 | |2;jquery.html;568.3776264989838;576.9653820770751;583.4136692623912;598.6886818854194;603.8520562462197;22496;23235;23276.301710948697;23291.06835726569;23329.183478578252;23807;25988.610170847405;26049;26060.34849128773;26084.739152608516;6520.184976877878;6683.732650693966;6687.598744075347;6691.063251144844;6694.43097336727;5944;6475.417212450879;6503.7073331700185;6562.475001999828;6562.606243625398;6428.132202152697;6435.066915297279;6449.6775161241985;6450.225972883237;6451.612903225798;6440.967795161041;6441.227052753676;6453.580517266386;6458.3864532869775;6461.547691661585;6005.219321488223;6022.277326720821;6024.21685180928;6024.638521688669;6034.63792172471;28519;29063.56404653932;29462.70537294621;29523.70476295231;29891.701082989108;1969.202472998438;2005.5988802239465;2011.4367976966473;2013.3758534854096;2018.8788672679686;19923.10346034432;20014.79985200144;20204.69692954607;20266.392008239778;20970.37088887336;2428.9028438862424;2448.302233863358;2486.4405508760565;2497.8501289922665;2506.0978047902922;135701;138843;139304;139664;139856;14699.338529766186;15043.849561504245;15088.548878080992;15242.390304387922;15536.689266214838;24033.759662403503;24059.278221653378;24060.639090413308;24094;24122.276331710076;9824.852627210597;10093.293469457214;10156.949215253877;10163.9491802542;10278.280520363653;9158.81682366349;9272.72181834546;9329.067093290616;9329.486878221764;9416.199623032118;8260.719588463677;9521.23830093591;12074.637760867188;12177.208481448677;12258.44836982338;4143.606357396043;4230.471191101113;4403.867883963486;4408.4930233023615;4453.755043472575;946.4652471353663;948.137195152408;965.3001573858896;987.8468837330225;1001.6694490818013;19620.411387658394;19800.801991980185;19826.909519976252;20176.89911550433;20314.898425507778;1024.1236918264333;1030.0986636692894;1033.1012019542895;1044.613493007592;1045.0698877998586;10961.287516311573;10984.670459886216;11098.223124381377;11107.500162492708;11144.554217831195;575153;582161;597457;613255;614906;126843;128861;129922;130677;130998.34500827435;1219.3659297165425;1229.489761748864;1236.9010479161645;1237.975240495203;1240.6340129661771;17346.5663358412;17392.739108913123;17398.478045658652;17570.033648149474;17720.911395443454;53333.46666533285;53666.73166634142;54565.908681826935;55339;56063;74462;74925.62537187498;75197.6240118796;75639;77460;14647.19440430744;14960.17719025464;14964.700705986037;15248.618784530476;15266.618334541725;23488.765112348658;23752.287431377088;23941.16205932784;23969.16107936214;24089.03643854226;18045.368412105512;18465;18631.347902823338;18786;18790.812091878906;16601.335946562;17042.829571704126;17057.829421705625;17720;17787.822121779132;18957.810421896156;19042.809571904105;19232.23071077141;19287.132079056755;19307.324243651405;14732.410703571737;14745.557633271019;14774.409023639364;14777.778333324793;14911.701765964837;18464.446066618024;18598.44204673862;18648.34730784416;18739.437816865517;18764 16:57:23 INFO - PID 16464 | |3;mootools.html;1375.4429456070293;1404.9297535123242;1411.1674112273756;1419.354193841802;1432.6275168456198;12424.503019879217;13855.376508057136;14353.35409906554;14444.205568693718;14486.348114334854;12334.198277111982;14197.92901035496;14742.778858317133;14803.555893323191;14876.553703388889;2615.93460163496;2663.866806659669;2677.732226777326;2680.437108207269;2684.7986401019903;2510.6108553174195;2527.545041892459;2605.9087931922386;2636.9340766480896;2702.6486556747595;2619.1487766475875;2647.0602935957745;2647.4308023774884;2648.1261183809393;2648.682158141026;2573.137998770405;2578.458523710023;2583.547879121156;2596.247088344378;2649.086065307466;2540.695116586003;2572.241188849294;2581.1224183777604;2583.6124581312765;2592.079811666869;13534;13826.170429774245;13844.446222151102;13906;13907;7510.474266801326;7780.988471498726;7785.766427007199;7796.610169491502;7820.061592608867;4986.4514903360605;5070.442251352385;5134.871628209287;5137.17805151174;5192.376914770214;1881.9529511762178;1883.4179289396836;1900.0309841980688;1926.807319268076;1930.0735646889573;23632;24135;24184.51630967371;24186.274411767674;24204.878975605185;6982.79051628452;7034.265227357422;7313.305236002571;7314.341709246193;7360.631968401665;16132.677346453005;16177.676446471005;16219.35122595083;16247;16311.592210194603;7399.297066778755;7604.581748003802;7611.923880761232;7614.2766437188375;7616.7334143305825;6856.6228857412325;7009.7897063088185;7014.684339204748;7082.787516374517;7128.251533589002;5117.309163262987;5246.344206974129;5254.474552544715;5287.68273903567;5290.470952904679;1386.5978866128912;1401.3623801170443;1492.3582859370358;1499;1509.2076659753498;869.2524428991063;888.0630934364308;897.4884315939852;901.369041670833;903.0472851142108;8415.45299555527;8903.688370906988;8914.643414263357;9081.45511269326;9156.450612963243;990.2424645146468;996.2428554298785;999.1806718490913;1004.3622299839508;1014.2291858187831;5037.999570851856;5218.63469557135;5393.164059570773;5405.7837686492885;5483.561315094783;19151.808481915003;19433;19496.512587185432;19819.513536484534;20027.799722002885;17942.910285448488;19462.805371946382;19974.90012549957;20014.099365528586;20021.899890500456;10281.383117013153;10377.533011014522;10620.628278010232;10627.096696780705;10631.362118272928;7724.806879827825;7863.803404914923;8301.128381519853;8340.916590834257;8486.151384861465;16470.588235294214;17232.913835430743;17245.22396492136;17271.654566908845;17440.563985900455;17640.470785876445;17835.375761848274;18090.45728628143;18225.45323640293;18240.270389184814;11513.251638643462;11547.076233901436;11561.88438115608;11683.123765717435;11705.531778729097;12749.8087528689;12890.904273136888;12899.484020639069;12906.548270810477;12959.287239201934;10097.44464054484;10117.29178957466;10137.036981486746;10211.23415743837;10332.380057196291;9826.4104153751;9987.650432234837;10102.09081182697;10211.23415743837;10276.17790576767;8827.029026807175;8860.202581767671;8889.777755555904;8938.46369217849;8946.418482798597;6686.732530698718;6767.458603311625;6840.41856442208;6842.076319696777;6843.486738494732;6947.687354068978;7069;7070.893936591058;7086.645667716697;7095.929040709527 16:57:23 INFO - PID 16464 | |4;prototype.html;501.3282201849521;508.3188527373319;528.7541293298615;533.2081858440216;534.2520471340126;6188.752449901998;6194.597351172182;6269.235381110355;6338.239411270648;6345.968270158654;5869.7358618862145;6054.576179667425;6075.787347442841;6088.421599948009;6155.815325540229;4954.603631709455;4987.476314986929;4989.825356112537;5044.571211447032;5054.241863720453;4977.755561109722;4998.150314446535;5013.323201367805;5031;5060.84817455477;4827.348307978431;4929.531694489017;4954.25686147079;4980.377452818398;5027.396712394499;4913.06651736169;4936.80252789888;4992.251162325662;5010.123228435009;5011.248312753116;4450.154470650598;4499.122671079141;4504.436945381827;4508.301213311942;4516.796744146522;5982.8504287392725;6076.878462430726;6095.786647467362;6115.021596544576;6134.202553667995;5709.571782116358;5725.341585717654;5797.652140871562;5811.27359080115;5836.445537673914;6476.190476190476;6554.377334153248;6588.967055164693;6593.571417857824;6656.134702488694;4878.146324393217;4915.164422048225;4918.139325618003;4924.43369012561;4974.4235303520845;6948.930510694829;7000.614966176859;7003.404710599605;7058.576485410892;7095.325944035309;4932.901341973212;4987.875303117378;5019.799208031638;5036.11867923112;5046.571041461517;5115.18157094863;5118.872028199325;5132.615053870974;5143.897122057538;5153.484651534892;5705.719211453431;5716.399778023331;5721.856953576111;5740;5774.0761478163295;6519.282878883319;6553.770618028346;6617.7683781067435;6626.635535045619;6655.86688266232;1693.4834875363133;1715.7683712698627;1725.9223334949957;1766.9911650441666;1783.3847322673657;1201.741625550511;1219.8780121987909;1231.4212320209488;1236.1285293867802;1242.7203879127123;5722.427757224327;5724.25584673998;5764.452377024176;5768.048272035151;5810.970945145332;6579.671016449159;6655.800325990228;6685.264620891698;6737.898931516032;6772.492063095287;5679.971600141973;5753.223314852441;5768.097117450134;5793.94206057934;5808.186853840466;3544.149404142987;3596.244788594372;3615.620359862229;3624.7643903146213;3643.8521865612247;6503.561164563289;6524.412802847766;6570.211574611078;6583.80248592543;6634.83412914681;6863.38229559342;6985.755498557628;6986.4061554767395;7008.894866577006;7012.9129984852425;6551.115599394021;6599.868002640016;6599.901001484982;6601.240857301472;6616.900746488806;6649.335066493312;6677.899831502628;6706.698198580978;6756.966215169089;6764.289749576224;6642.83392915181;6674.26583075871;6685.364890335411;6738.865222695421;6775.288594697486;6529.183852018497;6570.5729127606555;6586.901196482152;6605.57063790852;6680.231773345933;5038.420581633159;5059;5064.18972964324;5082.974585127051;5087.389513258433;6836.760713375008;6844.4182244509775;6849.520533562602;6863.245043045161;6867.2145242238375;6632.336766323329;6646.833829154117;6665.333466653296;6682.966585167043;6691.598504089576;6360.459360954371;6645.501587380869;6654.268030516736;6668;6696.330366963265;6310.6529140895855;6448.290688024407;6458.25627080695;6506.837329066811;6543.672816359258;6589.4728421725185;6634.966825166036;6639.900401493885;6643.2360278568585;6653.667316634052;6299.433051025429;6352.618842869442;6396.136521569529;6404.935950640434;6446.419822216023 16:57:23 INFO - PID 16464 | |5;yui.html;899.3120262998806;904.8326059678964;914.0767824497256;923.93070519711;925.7269105613846;19031;20036;20127.899360503194;20157.09293081811;22124.22565210218;20622.278220262255;20923.476913077182;21012.57974840506;21063.368098957057;21071.367858964255;1006.7583779892827;1033.1631378583334;1033.5659023210233;1034.151995363802;1038.210959670652;1036.7200855768938;1037.1132681557274;1037.5434808684154;1037.65238645054;1038.2732087538716;967.89837067108;1036.3263878478974;1051.0750539525245;1051.6897515233024;1117.5920788912028;1050.4012712753733;1052.3475445223933;1053.389034360073;1054.177741361739;1054.7837693272938;775.8564665536894;779.0339978426766;780.4107898536625;780.5862892666896;780.7462574663257;17792.733109003377;17889.642207155783;18042.27830886763;18218.726719099224;21030.684539731916;20877.37367878966;20891.268805591884;21312.573748525097;21328.573428531497;21953.231636892793;16574.917125414297;16716.58208544784;16732.996020238825;16968.3212671493;16981;3551.2897420516;3553.236054248349;3559.9644003559893;3561.0741207286032;3582.7133829293593;129416;130051;131303.34348328292;134096.6590334094;134623.32688336496;16239.59401014984;16379.59051023734;16608.335666573443;16676.58308542272;16747.581310467092;25987.480250394885;26617.86691066532;26686;26729.599056014176;27057.323566910592;7939.722109726132;8251.752447426587;8276.586170691442;8678.349123815738;8849.4247873888;3584.301061293023;4179.958200418017;4339.7396156230725;4344.391785150082;4398.362237475548;5035.823746168867;5112.693238405707;5122.513361230677;5138.152204886227;5150.330457040561;961.2358175250693;967.8596603492454;975.4001289207087;983.2183414185739;988.8467287570438;666.2038863558001;667.8664267146493;678.6097993653669;688.4870771275432;690.4752388185016;11572.537098516133;12057.336846473352;12635.229333959549;13074.542391016268;13080.738385232433;692.3699433515477;695.1623293930801;701.7087908517908;708.6704682322745;710.2790667472519;5444.128939369761;5524.254225679562;5530.087535556588;6391.392817682313;6437.485001199892;108115.40442040224;108804;111859.44070279597;118196;120391;97151.28044971892;101995.49002255089;102372;103887;105056.47471762593;86541.56729216313;86581;86917.5654121738;88263;89989;11232.382218978035;11994;12008.39958002114;12063.034957203226;12308.692282692646;38651.22697546089;40238;40381;41355.7932210337;41581.58418415777;68456.6577167111;71833;72548;73594;76576.61711691406;16843;17521.561960950567;17541;17550.561235969202;17681.115944202997;19092;20013.09941052627;20121.496962576053;20310.59378812386;22582.20962266313;16690.499285020982;16949.067801270554;17457.56356091108;17787.377441789475;18058.36795712196;17792.733109003115;18032.188551515475;18151.273949042417;18288.634227315113;18417.079146042914;17740.733888991417;17834.10829458548;18927.242910283436;18983.430497085108;19191.90404047971;13170.209787412403;13647.181169129884;14121;14230.501932432315;14269.857301426853;13866.861331386557;14260.363607280076;14262.857371426153;14508.709825803213;14651.487197948021 16:57:23 INFO - PID 16464 | __end_tp_report 16:57:23 INFO - PID 16464 | __start_cc_report 16:57:23 INFO - PID 16464 | _x_x_mozilla_cycle_collect,380 16:57:23 INFO - PID 16464 | __end_cc_report 16:57:23 INFO - PID 16464 | __startTimestamp1503014243177__endTimestamp 16:57:23 INFO - PID 16464 | 16:57:23 INFO - PID 16464 | ------- Summary: start ------- 16:57:23 INFO - PID 16464 | Number of tests: 6 16:57:23 INFO - PID 16464 | 16:57:23 INFO - PID 16464 | [#0] dojo.html Cycles:165 Average:6131.57 Median:6334.90 stddev:718.11 (11.3%) stddev-sans-first:681.16 16:57:23 INFO - PID 16464 | Values: 3150.2 3179.3 3193.0 3201.3 3232.6 6029.2 6094.4 6142.0 6158.6 6219.6 6191.9 6214.0 6221.4 6237.4 6300.8 5561.7 5609.4 5699.7 5728.5 5766.9 5603.8 5684.0 5686.9 5700.1 5775.6 5602.7 5639.9 5649.4 5740.4 5749.0 5462.5 5643.9 5676.3 5699.1 5728.2 5548.1 5560.2 5616.9 5655.9 5656.0 6048.9 6059.9 6098.5 6120.6 6143.0 6571.3 6583.3 6627.1 6673.4 6681.6 6588.9 6651.3 6710.7 6749.9 6761.9 6184.1 6230.6 6239.8 6251.1 6255.2 6731.3 6851.0 6940.9 6944.9 6968.7 6490.1 6492.4 6504.0 6509.2 6516.5 6618.3 6630.3 6631.7 6635.2 6635.6 6565.2 6572.4 6592.0 6698.6 6730.6 6679.8 6755.8 6779.9 6782.5 6809.1 5433.8 5480.1 5517.0 5544.1 5545.5 4545.4 4604.8 4665.0 4712.5 4742.5 5708.1 5773.9 5787.7 5788.3 5792.1 6720.2 6747.1 6765.7 6786.3 6787.3 5725.0 5733.5 5809.3 5816.0 5833.0 5834.4 5899.6 5924.3 6001.3 6003.0 6448.5 6459.5 6463.1 6463.9 6520.9 6598.9 6700.4 6708.2 6716.7 6719.9 6057.9 6444.9 6468.5 6473.4 6503.4 6522.0 6555.9 6616.8 6621.7 6641.9 6651.8 6670.6 6734.4 6751.6 6780.4 6315.7 6416.8 6452.3 6455.7 6458.0 6392.6 6479.2 6502.2 6563.0 6564.0 6134.0 6405.6 6480.7 6490.0 6530.5 6453.1 6549.9 6590.1 6609.6 6626.4 6171.8 6284.7 6289.0 6329.5 6334.9 16:57:23 INFO - PID 16464 | 16:57:23 INFO - PID 16464 | [#1] ext.html Cycles:180 Average:39829.60 Median:3643.34 stddev:58198.24 (1597.4%) stddev-sans-first:58287.85 16:57:23 INFO - PID 16464 | Values: 835.9 858.2 887.7 891.3 1144.2 32033.7 32292.8 42587.0 43197.0 43216.0 42677.0 42992.0 43001.4 43004.8 43026.0 7337.6 7685.6 7940.3 7941.4 7943.2 7772.3 7852.9 7868.9 7873.4 7895.3 7845.0 7847.9 7848.5 7852.1 7864.7 7840.8 7847.2 7847.5 7856.0 7911.9 7740.6 7808.1 7816.7 7819.6 7820.1 39030.4 39158.2 39178.0 39409.6 39446.8 3594.1 3613.5 3634.8 3641.2 3645.5 31946.8 31969.0 32010.0 32226.4 32254.2 4933.2 4940.0 4989.6 4994.4 5031.5 191296.0 193968.0 194318.0 194358.0 194427.0 49975.8 50029.0 50073.5 50114.7 50151.2 52183.2 52259.7 52291.7 52320.2 52334.7 13850.4 15320.8 15435.2 15493.1 15511.3 11131.8 11376.3 11397.0 11429.7 11431.9 14460.8 14506.3 14544.9 14552.0 14622.1 5677.8 5793.8 5870.9 5873.4 5914.0 1001.8 1007.4 1021.3 1042.0 1045.9 23412.6 23737.7 23937.0 30613.7 30956.4 1092.1 1128.7 1135.4 1140.3 1142.3 12556.2 12845.9 12855.9 12881.5 12891.7 248590.0 249877.0 250491.0 250746.0 250867.0 53007.0 53291.2 53449.0 53490.7 53572.0 1525.8 1531.6 1556.8 1558.5 1563.7 23275.5 23514.9 23519.9 23530.3 23574.3 38215.0 38372.4 38382.2 38509.6 38525.0 223827.0 224349.0 225474.0 226281.0 226651.0 36838.0 39140.4 39747.6 39824.2 39911.8 46766.0 48586.5 48694.0 49018.8 49031.0 35431.0 35789.8 35885.6 36265.8 36679.6 34546.3 34955.1 35109.1 35113.5 35321.3 38234.6 38339.4 38465.4 38767.6 38822.8 33592.0 33894.8 33942.0 34238.5 34456.1 23926.5 24556.5 24607.5 24810.1 25191.1 16:57:23 INFO - PID 16464 | 16:57:23 INFO - PID 16464 | [#2] jquery.html Cycles:180 Average:38415.37 Median:23283.69 stddev:99543.56 (427.5%) stddev-sans-first:99782.25 16:57:23 INFO - PID 16464 | Values: 568.4 577.0 583.4 598.7 603.9 22496.0 23235.0 23276.3 23291.1 23329.2 23807.0 25988.6 26049.0 26060.3 26084.7 6520.2 6683.7 6687.6 6691.1 6694.4 5944.0 6475.4 6503.7 6562.5 6562.6 6428.1 6435.1 6449.7 6450.2 6451.6 6441.0 6441.2 6453.6 6458.4 6461.5 6005.2 6022.3 6024.2 6024.6 6034.6 28519.0 29063.6 29462.7 29523.7 29891.7 1969.2 2005.6 2011.4 2013.4 2018.9 19923.1 20014.8 20204.7 20266.4 20970.4 2428.9 2448.3 2486.4 2497.9 2506.1 135701.0 138843.0 139304.0 139664.0 139856.0 14699.3 15043.8 15088.5 15242.4 15536.7 24033.8 24059.3 24060.6 24094.0 24122.3 9824.9 10093.3 10156.9 10163.9 10278.3 9158.8 9272.7 9329.1 9329.5 9416.2 8260.7 9521.2 12074.6 12177.2 12258.4 4143.6 4230.5 4403.9 4408.5 4453.8 946.5 948.1 965.3 987.8 1001.7 19620.4 19800.8 19826.9 20176.9 20314.9 1024.1 1030.1 1033.1 1044.6 1045.1 10961.3 10984.7 11098.2 11107.5 11144.6 575153.0 582161.0 597457.0 613255.0 614906.0 126843.0 128861.0 129922.0 130677.0 130998.3 1219.4 1229.5 1236.9 1238.0 1240.6 17346.6 17392.7 17398.5 17570.0 17720.9 53333.5 53666.7 54565.9 55339.0 56063.0 74462.0 74925.6 75197.6 75639.0 77460.0 14647.2 14960.2 14964.7 15248.6 15266.6 23488.8 23752.3 23941.2 23969.2 24089.0 18045.4 18465.0 18631.3 18786.0 18790.8 16601.3 17042.8 17057.8 17720.0 17787.8 18957.8 19042.8 19232.2 19287.1 19307.3 14732.4 14745.6 14774.4 14777.8 14911.7 18464.4 18598.4 18648.3 18739.4 18764.0 16:57:23 INFO - PID 16464 | 16:57:23 INFO - PID 16464 | [#3] mootools.html Cycles:180 Average:8787.44 Median:2579.79 stddev:6053.74 (234.7%) stddev-sans-first:6045.10 16:57:23 INFO - PID 16464 | Values: 1375.4 1404.9 1411.2 1419.4 1432.6 12424.5 13855.4 14353.4 14444.2 14486.3 12334.2 14197.9 14742.8 14803.6 14876.6 2615.9 2663.9 2677.7 2680.4 2684.8 2510.6 2527.5 2605.9 2636.9 2702.6 2619.1 2647.1 2647.4 2648.1 2648.7 2573.1 2578.5 2583.5 2596.2 2649.1 2540.7 2572.2 2581.1 2583.6 2592.1 13534.0 13826.2 13844.4 13906.0 13907.0 7510.5 7781.0 7785.8 7796.6 7820.1 4986.5 5070.4 5134.9 5137.2 5192.4 1882.0 1883.4 1900.0 1926.8 1930.1 23632.0 24135.0 24184.5 24186.3 24204.9 6982.8 7034.3 7313.3 7314.3 7360.6 16132.7 16177.7 16219.4 16247.0 16311.6 7399.3 7604.6 7611.9 7614.3 7616.7 6856.6 7009.8 7014.7 7082.8 7128.3 5117.3 5246.3 5254.5 5287.7 5290.5 1386.6 1401.4 1492.4 1499.0 1509.2 869.3 888.1 897.5 901.4 903.0 8415.5 8903.7 8914.6 9081.5 9156.5 990.2 996.2 999.2 1004.4 1014.2 5038.0 5218.6 5393.2 5405.8 5483.6 19151.8 19433.0 19496.5 19819.5 20027.8 17942.9 19462.8 19974.9 20014.1 20021.9 10281.4 10377.5 10620.6 10627.1 10631.4 7724.8 7863.8 8301.1 8340.9 8486.2 16470.6 17232.9 17245.2 17271.7 17440.6 17640.5 17835.4 18090.5 18225.5 18240.3 11513.3 11547.1 11561.9 11683.1 11705.5 12749.8 12890.9 12899.5 12906.5 12959.3 10097.4 10117.3 10137.0 10211.2 10332.4 9826.4 9987.7 10102.1 10211.2 10276.2 8827.0 8860.2 8889.8 8938.5 8946.4 6686.7 6767.5 6840.4 6842.1 6843.5 6947.7 7069.0 7070.9 7086.6 7095.9 16:57:23 INFO - PID 16464 | 16:57:23 INFO - PID 16464 | [#4] prototype.html Cycles:180 Average:5546.50 Median:6092.10 stddev:1561.84 (25.6%) stddev-sans-first:1519.62 16:57:23 INFO - PID 16464 | Values: 501.3 508.3 528.8 533.2 534.3 6188.8 6194.6 6269.2 6338.2 6346.0 5869.7 6054.6 6075.8 6088.4 6155.8 4954.6 4987.5 4989.8 5044.6 5054.2 4977.8 4998.2 5013.3 5031.0 5060.8 4827.3 4929.5 4954.3 4980.4 5027.4 4913.1 4936.8 4992.3 5010.1 5011.2 4450.2 4499.1 4504.4 4508.3 4516.8 5982.9 6076.9 6095.8 6115.0 6134.2 5709.6 5725.3 5797.7 5811.3 5836.4 6476.2 6554.4 6589.0 6593.6 6656.1 4878.1 4915.2 4918.1 4924.4 4974.4 6948.9 7000.6 7003.4 7058.6 7095.3 4932.9 4987.9 5019.8 5036.1 5046.6 5115.2 5118.9 5132.6 5143.9 5153.5 5705.7 5716.4 5721.9 5740.0 5774.1 6519.3 6553.8 6617.8 6626.6 6655.9 1693.5 1715.8 1725.9 1767.0 1783.4 1201.7 1219.9 1231.4 1236.1 1242.7 5722.4 5724.3 5764.5 5768.0 5811.0 6579.7 6655.8 6685.3 6737.9 6772.5 5680.0 5753.2 5768.1 5793.9 5808.2 3544.1 3596.2 3615.6 3624.8 3643.9 6503.6 6524.4 6570.2 6583.8 6634.8 6863.4 6985.8 6986.4 7008.9 7012.9 6551.1 6599.9 6599.9 6601.2 6616.9 6649.3 6677.9 6706.7 6757.0 6764.3 6642.8 6674.3 6685.4 6738.9 6775.3 6529.2 6570.6 6586.9 6605.6 6680.2 5038.4 5059.0 5064.2 5083.0 5087.4 6836.8 6844.4 6849.5 6863.2 6867.2 6632.3 6646.8 6665.3 6683.0 6691.6 6360.5 6645.5 6654.3 6668.0 6696.3 6310.7 6448.3 6458.3 6506.8 6543.7 6589.5 6635.0 6639.9 6643.2 6653.7 6299.4 6352.6 6396.1 6404.9 6446.4 16:57:23 INFO - PID 16464 | 16:57:23 INFO - PID 16464 | [#5] yui.html Cycles:180 Average:24140.07 Median:20078.75 stddev:33356.31 (166.1%) stddev-sans-first:33404.23 16:57:23 INFO - PID 16464 | Values: 899.3 904.8 914.1 923.9 925.7 19031.0 20036.0 20127.9 20157.1 22124.2 20622.3 20923.5 21012.6 21063.4 21071.4 1006.8 1033.2 1033.6 1034.2 1038.2 1036.7 1037.1 1037.5 1037.7 1038.3 967.9 1036.3 1051.1 1051.7 1117.6 1050.4 1052.3 1053.4 1054.2 1054.8 775.9 779.0 780.4 780.6 780.7 17792.7 17889.6 18042.3 18218.7 21030.7 20877.4 20891.3 21312.6 21328.6 21953.2 16574.9 16716.6 16733.0 16968.3 16981.0 3551.3 3553.2 3560.0 3561.1 3582.7 129416.0 130051.0 131303.3 134096.7 134623.3 16239.6 16379.6 16608.3 16676.6 16747.6 25987.5 26617.9 26686.0 26729.6 27057.3 7939.7 8251.8 8276.6 8678.3 8849.4 3584.3 4180.0 4339.7 4344.4 4398.4 5035.8 5112.7 5122.5 5138.2 5150.3 961.2 967.9 975.4 983.2 988.8 666.2 667.9 678.6 688.5 690.5 11572.5 12057.3 12635.2 13074.5 13080.7 692.4 695.2 701.7 708.7 710.3 5444.1 5524.3 5530.1 6391.4 6437.5 108115.4 108804.0 111859.4 118196.0 120391.0 97151.3 101995.5 102372.0 103887.0 105056.5 86541.6 86581.0 86917.6 88263.0 89989.0 11232.4 11994.0 12008.4 12063.0 12308.7 38651.2 40238.0 40381.0 41355.8 41581.6 68456.7 71833.0 72548.0 73594.0 76576.6 16843.0 17521.6 17541.0 17550.6 17681.1 19092.0 20013.1 20121.5 20310.6 22582.2 16690.5 16949.1 17457.6 17787.4 18058.4 17792.7 18032.2 18151.3 18288.6 18417.1 17740.7 17834.1 18927.2 18983.4 19191.9 13170.2 13647.2 14121.0 14230.5 14269.9 13866.9 14260.4 14262.9 14508.7 14651.5 16:57:23 INFO - PID 16464 | -------- Summary: end -------- 16:57:23 INFO - PID 16464 | 16:57:23 INFO - TEST-INFO | 16464: exit 0 16:57:23 INFO - TEST-OK | dromaeo_css | took 1113271ms 16:57:23 INFO - TEST-START | kraken 16:57:23 INFO - Initialising browser for kraken test... 16:57:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:32798/getInfo.html -profile /tmp/tmpQ_dIPs/profile 16:57:23 INFO - TEST-INFO | started process 16842 (/builds/slave/test/build/application/firefox/firefox http://localhost:32798/getInfo.html) 16:57:30 INFO - TEST-INFO | 16842: exit 0 16:57:30 INFO - Browser initialized. 16:57:30 INFO - Running cycle 1/1 for kraken test... 16:57:30 INFO - TEST-INFO | started process 17036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ_dIPs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:57:31 INFO - PID 17036 | 16:57:31 INFO - PID 17036 | (/builds/slave/test/build/application/firefox/firefox:17090): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:57:31 INFO - PID 17036 | 16:57:41 INFO - PID 17036 | RSS: Main: 166391808 16:57:41 INFO - PID 17036 | 16:57:44 INFO - PID 17036 | Cycle 1(1): loaded http://localhost:32798/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32798/tests/kraken/driver.html?testName=audio-beat-detection) 16:57:45 INFO - PID 17036 | RSS: Main: 172621824 16:57:45 INFO - PID 17036 | 16:57:48 INFO - PID 17036 | Cycle 1(1): loaded http://localhost:32798/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32798/tests/kraken/driver.html?testName=audio-dft) 16:57:48 INFO - PID 17036 | RSS: Main: 172933120 16:57:48 INFO - PID 17036 | 16:57:51 INFO - PID 17036 | Cycle 1(1): loaded http://localhost:32798/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32798/tests/kraken/driver.html?testName=audio-fft) 16:57:52 INFO - PID 17036 | RSS: Main: 167735296 16:57:52 INFO - PID 17036 | 16:57:54 INFO - PID 17036 | Cycle 1(1): loaded http://localhost:32798/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32798/tests/kraken/driver.html?testName=audio-oscillator) 16:57:55 INFO - PID 17036 | RSS: Main: 168411136 16:57:55 INFO - PID 17036 | 16:57:57 INFO - PID 17036 | Cycle 1(1): loaded http://localhost:32798/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32798/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:57:58 INFO - PID 17036 | RSS: Main: 169095168 16:57:58 INFO - PID 17036 | 16:58:01 INFO - PID 17036 | Cycle 1(1): loaded http://localhost:32798/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32798/tests/kraken/driver.html?testName=imaging-darkroom) 16:58:01 INFO - PID 17036 | RSS: Main: 171511808 16:58:01 INFO - PID 17036 | 16:58:05 INFO - PID 17036 | Cycle 1(1): loaded http://localhost:32798/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32798/tests/kraken/driver.html?testName=imaging-desaturate) 16:58:06 INFO - PID 17036 | RSS: Main: 171302912 16:58:06 INFO - PID 17036 | 16:58:08 INFO - PID 17036 | Cycle 1(1): loaded http://localhost:32798/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32798/tests/kraken/driver.html?testName=json-parse-financial) 16:58:09 INFO - PID 17036 | RSS: Main: 172003328 16:58:09 INFO - PID 17036 | 16:58:11 INFO - PID 17036 | Cycle 1(1): loaded http://localhost:32798/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32798/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:58:11 INFO - PID 17036 | RSS: Main: 171630592 16:58:11 INFO - PID 17036 | 16:58:13 INFO - PID 17036 | Cycle 1(1): loaded http://localhost:32798/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32798/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:58:14 INFO - PID 17036 | RSS: Main: 171982848 16:58:14 INFO - PID 17036 | 16:58:16 INFO - PID 17036 | Cycle 1(1): loaded http://localhost:32798/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32798/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:58:17 INFO - PID 17036 | RSS: Main: 171565056 16:58:17 INFO - PID 17036 | 16:58:19 INFO - PID 17036 | Cycle 1(1): loaded http://localhost:32798/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32798/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:58:20 INFO - PID 17036 | RSS: Main: 172167168 16:58:20 INFO - PID 17036 | 16:58:23 INFO - PID 17036 | Cycle 1(1): loaded http://localhost:32798/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32798/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:58:24 INFO - PID 17036 | RSS: Main: 172019712 16:58:24 INFO - PID 17036 | 16:58:26 INFO - PID 17036 | Cycle 1(1): loaded http://localhost:32798/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32798/tests/kraken/driver.html?testName=ai-astar) 16:58:26 INFO - PID 17036 | RSS: Main: 173699072 16:58:26 INFO - PID 17036 | 16:58:26 INFO - PID 17036 | __start_tp_report 16:58:26 INFO - PID 17036 | _x_x_mozilla_page_load 16:58:26 INFO - PID 17036 | _x_x_mozilla_page_load_details 16:58:26 INFO - PID 17036 | |i|pagename|runs| 16:58:26 INFO - PID 17036 | |0;ai-astar;98;106;102;108;110;109;109;98;108;108 16:58:26 INFO - PID 17036 | |1;audio-beat-detection;152;116;140;168;117;148;154;120;171;117 16:58:26 INFO - PID 17036 | |2;audio-dft;169;168;160;162;166;162;172;167;169;168 16:58:26 INFO - PID 17036 | |3;audio-fft;74;76;75;179;76;78;75;74;160;76 16:58:26 INFO - PID 17036 | |4;audio-oscillator;79;80;135;79;78;80;129;82;79;139 16:58:26 INFO - PID 17036 | |5;imaging-gaussian-blur;122;119;114;114;113;114;113;114;116;114 16:58:26 INFO - PID 17036 | |6;imaging-darkroom;150;152;150;149;154;152;152;150;150;151 16:58:26 INFO - PID 17036 | |7;imaging-desaturate;94;94;93;94;95;98;98;99;97;98 16:58:26 INFO - PID 17036 | |8;json-parse-financial;54;54;54;54;55;53;62;54;54;62 16:58:26 INFO - PID 17036 | |9;json-stringify-tinderbox;53;54;58;53;54;54;54;54;53;60 16:58:26 INFO - PID 17036 | |10;stanford-crypto-aes;78;77;77;78;76;79;75;76;74;76 16:58:26 INFO - PID 17036 | |11;stanford-crypto-ccm;124;123;121;132;123;132;128;122;121;167 16:58:26 INFO - PID 17036 | |12;stanford-crypto-pbkdf2;177;185;174;172;176;176;175;182;178;181 16:58:26 INFO - PID 17036 | |13;stanford-crypto-sha256-iterative;69;68;67;69;65;66;65;74;67;64 16:58:26 INFO - PID 17036 | __end_tp_report 16:58:26 INFO - PID 17036 | __start_cc_report 16:58:26 INFO - PID 17036 | _x_x_mozilla_cycle_collect,941 16:58:26 INFO - PID 17036 | __end_cc_report 16:58:26 INFO - PID 17036 | __startTimestamp1503014306367__endTimestamp 16:58:26 INFO - PID 17036 | 16:58:26 INFO - PID 17036 | ------- Summary: start ------- 16:58:26 INFO - PID 17036 | Number of tests: 14 16:58:26 INFO - PID 17036 | 16:58:26 INFO - PID 17036 | [#0] ai-astar Cycles:10 Average:105.60 Median:109.00 stddev:4.58 (4.2%) stddev-sans-first:3.94 16:58:26 INFO - PID 17036 | Values: 98.0 106.0 102.0 108.0 110.0 109.0 109.0 98.0 108.0 108.0 16:58:26 INFO - PID 17036 | 16:58:26 INFO - PID 17036 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:150.00 stddev:21.56 (14.4%) stddev-sans-first:22.44 16:58:26 INFO - PID 17036 | Values: 152.0 116.0 140.0 168.0 117.0 148.0 154.0 120.0 171.0 117.0 16:58:26 INFO - PID 17036 | 16:58:26 INFO - PID 17036 | [#2] audio-dft Cycles:10 Average:166.30 Median:168.00 stddev:3.80 (2.3%) stddev-sans-first:3.91 16:58:26 INFO - PID 17036 | Values: 169.0 168.0 160.0 162.0 166.0 162.0 172.0 167.0 169.0 168.0 16:58:26 INFO - PID 17036 | 16:58:26 INFO - PID 17036 | [#3] audio-fft Cycles:10 Average:94.30 Median:75.50 stddev:39.90 (52.9%) stddev-sans-first:41.64 16:58:26 INFO - PID 17036 | Values: 74.0 76.0 75.0 179.0 76.0 78.0 75.0 74.0 160.0 76.0 16:58:26 INFO - PID 17036 | 16:58:26 INFO - PID 17036 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:79.00 stddev:26.58 (33.6%) stddev-sans-first:27.47 16:58:26 INFO - PID 17036 | Values: 79.0 80.0 135.0 79.0 78.0 80.0 129.0 82.0 79.0 139.0 16:58:26 INFO - PID 17036 | 16:58:26 INFO - PID 17036 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:114.00 stddev:2.95 (2.6%) stddev-sans-first:1.88 16:58:26 INFO - PID 17036 | Values: 122.0 119.0 114.0 114.0 113.0 114.0 113.0 114.0 116.0 114.0 16:58:26 INFO - PID 17036 | 16:58:26 INFO - PID 17036 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.50 stddev:1.49 (1.0%) stddev-sans-first:1.54 16:58:26 INFO - PID 17036 | Values: 150.0 152.0 150.0 149.0 154.0 152.0 152.0 150.0 150.0 151.0 16:58:26 INFO - PID 17036 | 16:58:26 INFO - PID 17036 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:97.50 stddev:2.21 (2.3%) stddev-sans-first:2.22 16:58:26 INFO - PID 17036 | Values: 94.0 94.0 93.0 94.0 95.0 98.0 98.0 99.0 97.0 98.0 16:58:26 INFO - PID 17036 | 16:58:26 INFO - PID 17036 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:54.00 stddev:3.41 (6.3%) stddev-sans-first:3.56 16:58:26 INFO - PID 17036 | Values: 54.0 54.0 54.0 54.0 55.0 53.0 62.0 54.0 54.0 62.0 16:58:26 INFO - PID 17036 | 16:58:26 INFO - PID 17036 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:54.00 stddev:2.36 (4.4%) stddev-sans-first:2.42 16:58:26 INFO - PID 17036 | Values: 53.0 54.0 58.0 53.0 54.0 54.0 54.0 54.0 53.0 60.0 16:58:26 INFO - PID 17036 | 16:58:26 INFO - PID 17036 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:77.00 stddev:1.51 (2.0%) stddev-sans-first:1.51 16:58:26 INFO - PID 17036 | Values: 78.0 77.0 77.0 78.0 76.0 79.0 75.0 76.0 74.0 76.0 16:58:26 INFO - PID 17036 | 16:58:26 INFO - PID 17036 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:126.00 stddev:13.89 (11.0%) stddev-sans-first:14.60 16:58:26 INFO - PID 17036 | Values: 124.0 123.0 121.0 132.0 123.0 132.0 128.0 122.0 121.0 167.0 16:58:26 INFO - PID 17036 | 16:58:26 INFO - PID 17036 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.60 Median:177.50 stddev:3.98 (2.2%) stddev-sans-first:4.21 16:58:26 INFO - PID 17036 | Values: 177.0 185.0 174.0 172.0 176.0 176.0 175.0 182.0 178.0 181.0 16:58:26 INFO - PID 17036 | 16:58:26 INFO - PID 17036 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:2.88 (4.3%) stddev-sans-first:2.99 16:58:26 INFO - PID 17036 | Values: 69.0 68.0 67.0 69.0 65.0 66.0 65.0 74.0 67.0 64.0 16:58:26 INFO - PID 17036 | -------- Summary: end -------- 16:58:26 INFO - PID 17036 | 16:58:26 INFO - PID 17036 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:58:27 INFO - TEST-INFO | 17036: exit 0 16:58:27 INFO - TEST-OK | kraken | took 63258ms 16:58:27 INFO - SUITE-END | took 1176s 16:58:27 INFO - Completed test suite (00:19:36) 16:58:27 INFO - javascript benchmark 16:58:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8584.064552406437, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3150.2439414540518, 3179.3005538781467, 3192.9840350798236, 3201.3437245364703, 3232.628247751509, 6029.246344206974, 6094.390560943909, 6142.0, 6158.630482171062, 6219.595726277788, 6191.907121393183, 6214.0, 6221.377862213776, 6237.407446292606, 6300.810975670725, 5561.721913904309, 5609.439056094378, 5699.743511541969, 5728.455796699307, 5766.855828604276, 5603.775848966036, 5683.971580142093, 5686.857828554278, 5700.059490184135, 5775.624584402021, 5602.747876345574, 5639.915401268984, 5649.406812284692, 5740.425957404289, 5748.97125514374, 5462.481064298885, 5643.8589035274035, 5676.3188417389765, 5699.059655156894, 5728.198052272685, 5548.140038294071, 5560.165975103726, 5616.943830561683, 5655.915161272585, 5656.038473459481, 6048.939510604926, 6059.878802423971, 6098.451139397475, 6120.60216085953, 6143.047827586731, 6571.310012448672, 6583.275839657634, 6627.138471998657, 6673.399394054559, 6681.565698229648, 6588.934110658928, 6651.268360480343, 6710.7315707371645, 6749.93250067498, 6761.864762704768, 6184.134221209034, 6230.626162430269, 6239.750409983595, 6251.093591429218, 6255.186825712719, 6731.326867313327, 6850.965745171342, 6940.895886561706, 6944.930550694529, 6968.721251149897, 6490.123833282447, 6492.383223593751, 6504.024396340492, 6509.1863517060365, 6516.5112616553, 6618.338166183439, 6630.336966303331, 6631.668416579152, 6635.236947750974, 6635.6350400728425, 6565.24499682533, 6572.4084832365315, 6592.0, 6698.63157526331, 6730.596164230162, 6679.833004174934, 6755.763548275787, 6779.9322006780285, 6782.525223234425, 6809.148856392951, 5433.782648694087, 5480.095784195563, 5516.972415137979, 5544.140658197985, 5545.500904918496, 4545.36364908913, 4604.838830640979, 4664.976675116603, 4712.458067322234, 4742.478327383985, 5708.143778433268, 5773.88452230953, 5787.681677507778, 5788.27646544182, 5792.1311803229855, 6720.1599800025, 6747.05541224229, 6765.695543700545, 6786.321367863273, 6787.287334829871, 5724.971375143097, 5733.512651424592, 5809.302883653904, 5816.040353341651, 5832.970835145882, 5834.445727655866, 5899.587028908021, 5924.318703349084, 6001.309849367379, 6003.039513677791, 6448.516361272923, 6459.483241340681, 6463.095166676669, 6463.870722585522, 6520.869582608321, 6598.90101648466, 6700.43046341047, 6708.161479815023, 6716.697748601422, 6719.932800671931, 6057.939420605738, 6444.903326450013, 6468.514861385321, 6473.417392434703, 6503.382178693017, 6522.0, 6555.901661475177, 6616.801495955129, 6621.702023409054, 6641.900371494528, 6651.800445986628, 6670.633115178712, 6734.427573656294, 6751.628660423724, 6780.355866192901, 6315.747370105328, 6416.7754128605275, 6452.257990331172, 6455.709493072729, 6457.967710161419, 6392.648404337806, 6479.222493300834, 6502.219733631994, 6562.967185164043, 6563.967180164069, 6133.969330153499, 6405.615663060231, 6480.70836812354, 6490.0, 6530.510211734044, 6453.096566480603, 6549.8690026200165, 6590.143281373583, 6609.570377925419, 6626.403623673892, 6171.783987560414, 6284.74861005573, 6288.968555157195, 6329.525285603506, 6334.904976425265], "value": 6078.731306828505, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.9456635318704, 858.184724511714, 887.6937456577479, 891.2736120062153, 1144.19906065754, 32033.679663203362, 32292.838535807317, 42586.99999999996, 43197.0, 43216.0, 42677.0, 42992.0, 43001.35497967525, 43004.784976075156, 43026.0, 7337.559746415232, 7685.577293248869, 7940.325072368855, 7941.404394670423, 7943.165967573379, 7772.261635144652, 7852.882206766903, 7868.881966770503, 7873.409494287923, 7895.328897043758, 7845.0, 7847.9215207847765, 7848.45060845741, 7852.097008843999, 7864.685412583518, 7840.764777056697, 7847.176046515119, 7847.489913155627, 7856.0, 7911.920880791176, 7740.612969351566, 7808.063032436144, 7816.687332506693, 7819.6481158348015, 7820.139784623687, 39030.414543781866, 39158.21683566313, 39178.0, 39409.60590394088, 39446.80276598627, 3594.101474631342, 3613.4941108244866, 3634.7637403568683, 3641.18073433478, 3645.489631451599, 31946.840265798754, 31969.040928772174, 32010.039698809072, 32226.355472890646, 32254.193645158823, 4933.161362568336, 4939.975300123477, 4989.57588604969, 4994.375703037121, 5031.471695471996, 191296.0, 193968.0, 194318.0, 194358.0, 194427.0, 49975.75012124916, 50029.0, 50073.49926500761, 50114.74942625264, 50151.24773128406, 52183.217251741255, 52259.73870130625, 52291.73854130705, 52320.21519677208, 52334.738326308885, 13850.376733047036, 15320.846791532165, 15435.15106669144, 15493.07041577509, 15511.301991410413, 11131.777364452828, 11376.260543064674, 11397.031252343644, 11429.714257143472, 11431.942840285745, 14460.783088253685, 14506.274686265644, 14544.927275363767, 14552.0, 14622.122672639676, 5677.829665110054, 5793.797217097465, 5870.853228669317, 5873.353931067579, 5914.0, 1001.7746007148334, 1007.3804610164696, 1021.341234903483, 1041.9843702344472, 1045.8849526552074, 23412.64881026786, 23737.694426806345, 23937.0, 30613.69386306153, 30956.380872382426, 1092.1044743310408, 1128.700894263021, 1135.3868910788083, 1140.3101123820136, 1142.257532603814, 12556.246625202517, 12845.935770321088, 12855.935720321339, 12881.484740610458, 12891.677708057374, 248590.0, 249877.0, 250491.0, 250746.0, 250867.0, 53007.0, 53291.20063199055, 53449.0, 53490.73254633702, 53572.0, 1525.83978682239, 1531.5635044012627, 1556.7664850272324, 1558.5480210738986, 1563.7419825728855, 23275.53448930978, 23514.882425587763, 23519.88240058789, 23530.294091177293, 23574.29277121689, 38215.0, 38372.424413633256, 38382.23235535218, 38509.614903850605, 38525.036874078374, 223827.0, 224349.0, 225474.0, 226281.0, 226651.0, 36838.0, 39140.412893806046, 39747.60252397555, 39824.20351592894, 39911.800440997606, 46766.0, 48586.514134859615, 48694.0, 49018.77453063702, 49031.0, 35431.0, 35789.82105089458, 35885.64114358823, 36265.81867090753, 36679.633203667625, 34546.30907381788, 34955.12612184614, 35109.12227194341, 35113.473297901066, 35321.293574127856, 38234.61765382422, 38339.42490862695, 38465.42301865418, 38767.6123238764, 38822.80588597152, 33592.0, 33894.81368152103, 33942.0, 34238.48642270318, 34456.138596534285, 23926.52146957086, 24556.508869822148, 24607.50784984326, 24810.131645392325, 25191.11831085903], "value": 17762.430503002455, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.3776264989838, 576.9653820770751, 583.4136692623912, 598.6886818854194, 603.8520562462197, 22496.0, 23235.0, 23276.301710948697, 23291.06835726569, 23329.183478578252, 23807.0, 25988.610170847405, 26049.0, 26060.34849128773, 26084.739152608516, 6520.184976877878, 6683.732650693966, 6687.598744075347, 6691.063251144844, 6694.43097336727, 5944.0, 6475.417212450879, 6503.7073331700185, 6562.475001999828, 6562.606243625398, 6428.132202152697, 6435.066915297279, 6449.6775161241985, 6450.225972883237, 6451.612903225798, 6440.967795161041, 6441.227052753676, 6453.580517266386, 6458.3864532869775, 6461.547691661585, 6005.219321488223, 6022.277326720821, 6024.21685180928, 6024.638521688669, 6034.63792172471, 28519.0, 29063.56404653932, 29462.70537294621, 29523.70476295231, 29891.701082989108, 1969.202472998438, 2005.5988802239465, 2011.4367976966473, 2013.3758534854096, 2018.8788672679686, 19923.10346034432, 20014.79985200144, 20204.69692954607, 20266.392008239778, 20970.37088887336, 2428.9028438862424, 2448.302233863358, 2486.4405508760565, 2497.8501289922665, 2506.0978047902922, 135701.0, 138843.0, 139304.0, 139664.0, 139856.0, 14699.338529766186, 15043.849561504245, 15088.548878080992, 15242.390304387922, 15536.689266214838, 24033.759662403503, 24059.278221653378, 24060.639090413308, 24094.0, 24122.276331710076, 9824.852627210597, 10093.293469457214, 10156.949215253877, 10163.9491802542, 10278.280520363653, 9158.81682366349, 9272.72181834546, 9329.067093290616, 9329.486878221764, 9416.199623032118, 8260.719588463677, 9521.23830093591, 12074.637760867188, 12177.208481448677, 12258.44836982338, 4143.606357396043, 4230.471191101113, 4403.867883963486, 4408.4930233023615, 4453.755043472575, 946.4652471353663, 948.137195152408, 965.3001573858896, 987.8468837330225, 1001.6694490818013, 19620.411387658394, 19800.801991980185, 19826.909519976252, 20176.89911550433, 20314.898425507778, 1024.1236918264333, 1030.0986636692894, 1033.1012019542895, 1044.613493007592, 1045.0698877998586, 10961.287516311573, 10984.670459886216, 11098.223124381377, 11107.500162492708, 11144.554217831195, 575153.0, 582161.0, 597457.0, 613255.0, 614906.0, 126843.0, 128861.0, 129922.0, 130677.0, 130998.34500827435, 1219.3659297165425, 1229.489761748864, 1236.9010479161645, 1237.975240495203, 1240.6340129661771, 17346.5663358412, 17392.739108913123, 17398.478045658652, 17570.033648149474, 17720.911395443454, 53333.46666533285, 53666.73166634142, 54565.908681826935, 55339.0, 56063.0, 74462.0, 74925.62537187498, 75197.6240118796, 75639.0, 77460.0, 14647.19440430744, 14960.17719025464, 14964.700705986037, 15248.618784530476, 15266.618334541725, 23488.765112348658, 23752.287431377088, 23941.16205932784, 23969.16107936214, 24089.03643854226, 18045.368412105512, 18465.0, 18631.347902823338, 18786.0, 18790.812091878906, 16601.335946562, 17042.829571704126, 17057.829421705625, 17720.0, 17787.822121779132, 18957.810421896156, 19042.809571904105, 19232.23071077141, 19287.132079056755, 19307.324243651405, 14732.410703571737, 14745.557633271019, 14774.409023639364, 14777.778333324793, 14911.701765964837, 18464.446066618024, 18598.44204673862, 18648.34730784416, 18739.437816865517, 18764.0], "value": 12391.123411538041, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1375.4429456070293, 1404.9297535123242, 1411.1674112273756, 1419.354193841802, 1432.6275168456198, 12424.503019879217, 13855.376508057136, 14353.35409906554, 14444.205568693718, 14486.348114334854, 12334.198277111982, 14197.92901035496, 14742.778858317133, 14803.555893323191, 14876.553703388889, 2615.93460163496, 2663.866806659669, 2677.732226777326, 2680.437108207269, 2684.7986401019903, 2510.6108553174195, 2527.545041892459, 2605.9087931922386, 2636.9340766480896, 2702.6486556747595, 2619.1487766475875, 2647.0602935957745, 2647.4308023774884, 2648.1261183809393, 2648.682158141026, 2573.137998770405, 2578.458523710023, 2583.547879121156, 2596.247088344378, 2649.086065307466, 2540.695116586003, 2572.241188849294, 2581.1224183777604, 2583.6124581312765, 2592.079811666869, 13534.0, 13826.170429774245, 13844.446222151102, 13906.0, 13907.0, 7510.474266801326, 7780.988471498726, 7785.766427007199, 7796.610169491502, 7820.061592608867, 4986.4514903360605, 5070.442251352385, 5134.871628209287, 5137.17805151174, 5192.376914770214, 1881.9529511762178, 1883.4179289396836, 1900.0309841980688, 1926.807319268076, 1930.0735646889573, 23632.0, 24135.0, 24184.51630967371, 24186.274411767674, 24204.878975605185, 6982.79051628452, 7034.265227357422, 7313.305236002571, 7314.341709246193, 7360.631968401665, 16132.677346453005, 16177.676446471005, 16219.35122595083, 16247.0, 16311.592210194603, 7399.297066778755, 7604.581748003802, 7611.923880761232, 7614.2766437188375, 7616.7334143305825, 6856.6228857412325, 7009.7897063088185, 7014.684339204748, 7082.787516374517, 7128.251533589002, 5117.309163262987, 5246.344206974129, 5254.474552544715, 5287.68273903567, 5290.470952904679, 1386.5978866128912, 1401.3623801170443, 1492.3582859370358, 1499.0, 1509.2076659753498, 869.2524428991063, 888.0630934364308, 897.4884315939852, 901.369041670833, 903.0472851142108, 8415.45299555527, 8903.688370906988, 8914.643414263357, 9081.45511269326, 9156.450612963243, 990.2424645146468, 996.2428554298785, 999.1806718490913, 1004.3622299839508, 1014.2291858187831, 5037.999570851856, 5218.63469557135, 5393.164059570773, 5405.7837686492885, 5483.561315094783, 19151.808481915003, 19433.0, 19496.512587185432, 19819.513536484534, 20027.799722002885, 17942.910285448488, 19462.805371946382, 19974.90012549957, 20014.099365528586, 20021.899890500456, 10281.383117013153, 10377.533011014522, 10620.628278010232, 10627.096696780705, 10631.362118272928, 7724.806879827825, 7863.803404914923, 8301.128381519853, 8340.916590834257, 8486.151384861465, 16470.588235294214, 17232.913835430743, 17245.22396492136, 17271.654566908845, 17440.563985900455, 17640.470785876445, 17835.375761848274, 18090.45728628143, 18225.45323640293, 18240.270389184814, 11513.251638643462, 11547.076233901436, 11561.88438115608, 11683.123765717435, 11705.531778729097, 12749.8087528689, 12890.904273136888, 12899.484020639069, 12906.548270810477, 12959.287239201934, 10097.44464054484, 10117.29178957466, 10137.036981486746, 10211.23415743837, 10332.380057196291, 9826.4104153751, 9987.650432234837, 10102.09081182697, 10211.23415743837, 10276.17790576767, 8827.029026807175, 8860.202581767671, 8889.777755555904, 8938.46369217849, 8946.418482798597, 6686.732530698718, 6767.458603311625, 6840.41856442208, 6842.076319696777, 6843.486738494732, 6947.687354068978, 7069.0, 7070.893936591058, 7086.645667716697, 7095.929040709527], "value": 6410.943178960761, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.3282201849521, 508.3188527373319, 528.7541293298615, 533.2081858440216, 534.2520471340126, 6188.752449901998, 6194.597351172182, 6269.235381110355, 6338.239411270648, 6345.968270158654, 5869.7358618862145, 6054.576179667425, 6075.787347442841, 6088.421599948009, 6155.815325540229, 4954.603631709455, 4987.476314986929, 4989.825356112537, 5044.571211447032, 5054.241863720453, 4977.755561109722, 4998.150314446535, 5013.323201367805, 5031.0, 5060.84817455477, 4827.348307978431, 4929.531694489017, 4954.25686147079, 4980.377452818398, 5027.396712394499, 4913.06651736169, 4936.80252789888, 4992.251162325662, 5010.123228435009, 5011.248312753116, 4450.154470650598, 4499.122671079141, 4504.436945381827, 4508.301213311942, 4516.796744146522, 5982.8504287392725, 6076.878462430726, 6095.786647467362, 6115.021596544576, 6134.202553667995, 5709.571782116358, 5725.341585717654, 5797.652140871562, 5811.27359080115, 5836.445537673914, 6476.190476190476, 6554.377334153248, 6588.967055164693, 6593.571417857824, 6656.134702488694, 4878.146324393217, 4915.164422048225, 4918.139325618003, 4924.43369012561, 4974.4235303520845, 6948.930510694829, 7000.614966176859, 7003.404710599605, 7058.576485410892, 7095.325944035309, 4932.901341973212, 4987.875303117378, 5019.799208031638, 5036.11867923112, 5046.571041461517, 5115.18157094863, 5118.872028199325, 5132.615053870974, 5143.897122057538, 5153.484651534892, 5705.719211453431, 5716.399778023331, 5721.856953576111, 5740.0, 5774.0761478163295, 6519.282878883319, 6553.770618028346, 6617.7683781067435, 6626.635535045619, 6655.86688266232, 1693.4834875363133, 1715.7683712698627, 1725.9223334949957, 1766.9911650441666, 1783.3847322673657, 1201.741625550511, 1219.8780121987909, 1231.4212320209488, 1236.1285293867802, 1242.7203879127123, 5722.427757224327, 5724.25584673998, 5764.452377024176, 5768.048272035151, 5810.970945145332, 6579.671016449159, 6655.800325990228, 6685.264620891698, 6737.898931516032, 6772.492063095287, 5679.971600141973, 5753.223314852441, 5768.097117450134, 5793.94206057934, 5808.186853840466, 3544.149404142987, 3596.244788594372, 3615.620359862229, 3624.7643903146213, 3643.8521865612247, 6503.561164563289, 6524.412802847766, 6570.211574611078, 6583.80248592543, 6634.83412914681, 6863.38229559342, 6985.755498557628, 6986.4061554767395, 7008.894866577006, 7012.9129984852425, 6551.115599394021, 6599.868002640016, 6599.901001484982, 6601.240857301472, 6616.900746488806, 6649.335066493312, 6677.899831502628, 6706.698198580978, 6756.966215169089, 6764.289749576224, 6642.83392915181, 6674.26583075871, 6685.364890335411, 6738.865222695421, 6775.288594697486, 6529.183852018497, 6570.5729127606555, 6586.901196482152, 6605.57063790852, 6680.231773345933, 5038.420581633159, 5059.0, 5064.18972964324, 5082.974585127051, 5087.389513258433, 6836.760713375008, 6844.4182244509775, 6849.520533562602, 6863.245043045161, 6867.2145242238375, 6632.336766323329, 6646.833829154117, 6665.333466653296, 6682.966585167043, 6691.598504089576, 6360.459360954371, 6645.501587380869, 6654.268030516736, 6668.0, 6696.330366963265, 6310.6529140895855, 6448.290688024407, 6458.25627080695, 6506.837329066811, 6543.672816359258, 6589.4728421725185, 6634.966825166036, 6639.900401493885, 6643.2360278568585, 6653.667316634052, 6299.433051025429, 6352.618842869442, 6396.136521569529, 6404.935950640434, 6446.419822216023], "value": 5086.997775561465, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [899.3120262998806, 904.8326059678964, 914.0767824497256, 923.93070519711, 925.7269105613846, 19031.0, 20036.0, 20127.899360503194, 20157.09293081811, 22124.22565210218, 20622.278220262255, 20923.476913077182, 21012.57974840506, 21063.368098957057, 21071.367858964255, 1006.7583779892827, 1033.1631378583334, 1033.5659023210233, 1034.151995363802, 1038.210959670652, 1036.7200855768938, 1037.1132681557274, 1037.5434808684154, 1037.65238645054, 1038.2732087538716, 967.89837067108, 1036.3263878478974, 1051.0750539525245, 1051.6897515233024, 1117.5920788912028, 1050.4012712753733, 1052.3475445223933, 1053.389034360073, 1054.177741361739, 1054.7837693272938, 775.8564665536894, 779.0339978426766, 780.4107898536625, 780.5862892666896, 780.7462574663257, 17792.733109003377, 17889.642207155783, 18042.27830886763, 18218.726719099224, 21030.684539731916, 20877.37367878966, 20891.268805591884, 21312.573748525097, 21328.573428531497, 21953.231636892793, 16574.917125414297, 16716.58208544784, 16732.996020238825, 16968.3212671493, 16981.0, 3551.2897420516, 3553.236054248349, 3559.9644003559893, 3561.0741207286032, 3582.7133829293593, 129416.0, 130051.0, 131303.34348328292, 134096.6590334094, 134623.32688336496, 16239.59401014984, 16379.59051023734, 16608.335666573443, 16676.58308542272, 16747.581310467092, 25987.480250394885, 26617.86691066532, 26686.0, 26729.599056014176, 27057.323566910592, 7939.722109726132, 8251.752447426587, 8276.586170691442, 8678.349123815738, 8849.4247873888, 3584.301061293023, 4179.958200418017, 4339.7396156230725, 4344.391785150082, 4398.362237475548, 5035.823746168867, 5112.693238405707, 5122.513361230677, 5138.152204886227, 5150.330457040561, 961.2358175250693, 967.8596603492454, 975.4001289207087, 983.2183414185739, 988.8467287570438, 666.2038863558001, 667.8664267146493, 678.6097993653669, 688.4870771275432, 690.4752388185016, 11572.537098516133, 12057.336846473352, 12635.229333959549, 13074.542391016268, 13080.738385232433, 692.3699433515477, 695.1623293930801, 701.7087908517908, 708.6704682322745, 710.2790667472519, 5444.128939369761, 5524.254225679562, 5530.087535556588, 6391.392817682313, 6437.485001199892, 108115.40442040224, 108804.0, 111859.44070279597, 118196.0, 120391.0, 97151.28044971892, 101995.49002255089, 102372.0, 103887.0, 105056.47471762593, 86541.56729216313, 86581.0, 86917.5654121738, 88263.0, 89989.0, 11232.382218978035, 11994.0, 12008.39958002114, 12063.034957203226, 12308.692282692646, 38651.22697546089, 40238.0, 40381.0, 41355.7932210337, 41581.58418415777, 68456.6577167111, 71833.0, 72548.0, 73594.0, 76576.61711691406, 16843.0, 17521.561960950567, 17541.0, 17550.561235969202, 17681.115944202997, 19092.0, 20013.09941052627, 20121.496962576053, 20310.59378812386, 22582.20962266313, 16690.499285020982, 16949.067801270554, 17457.56356091108, 17787.377441789475, 18058.36795712196, 17792.733109003115, 18032.188551515475, 18151.273949042417, 18288.634227315113, 18417.079146042914, 17740.733888991417, 17834.10829458548, 18927.242910283436, 18983.430497085108, 19191.90404047971, 13170.209787412403, 13647.181169129884, 14121.0, 14230.501932432315, 14269.857301426853, 13866.861331386557, 14260.363607280076, 14262.857371426153, 14508.709825803213, 14651.487197948021], "value": 9168.968740316184, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 106.0, 102.0, 108.0, 110.0, 109.0, 109.0, 98.0, 108.0, 108.0], "value": 105.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 116.0, 140.0, 168.0, 117.0, 148.0, 154.0, 120.0, 171.0, 117.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 168.0, 160.0, 162.0, 166.0, 162.0, 172.0, 167.0, 169.0, 168.0], "value": 166.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 179.0, 76.0, 78.0, 75.0, 74.0, 160.0, 76.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 135.0, 79.0, 78.0, 80.0, 129.0, 82.0, 79.0, 139.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 119.0, 114.0, 114.0, 113.0, 114.0, 113.0, 114.0, 116.0, 114.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 150.0, 149.0, 154.0, 152.0, 152.0, 150.0, 150.0, 151.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 95.0, 98.0, 98.0, 99.0, 97.0, 98.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 55.0, 53.0, 62.0, 54.0, 54.0, 62.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 58.0, 53.0, 54.0, 54.0, 54.0, 54.0, 53.0, 60.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 77.0, 78.0, 76.0, 79.0, 75.0, 76.0, 74.0, 76.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 123.0, 121.0, 132.0, 123.0, 132.0, 128.0, 122.0, 121.0, 167.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 185.0, 174.0, 172.0, 176.0, 176.0, 175.0, 182.0, 178.0, 181.0], "value": 177.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 69.0, 65.0, 66.0, 65.0, 74.0, 67.0, 64.0], "value": 67.4, "unit": "score"}]}]} 16:58:27 INFO - Return code: 0 16:58:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:58:27 INFO - # TBPL SUCCESS # 16:58:27 INFO - Running post-action listener: _package_coverage_data 16:58:27 INFO - Running post-action listener: _resource_record_post_action 16:58:27 INFO - [mozharness: 2017-08-17 23:58:27.643981Z] Finished run-tests step (success) 16:58:27 INFO - Running post-run listener: _resource_record_post_run 16:58:27 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 212992; Write bytes: 430694400; Read time: 28; Write time: 793520 16:58:27 INFO - TinderboxPrint: CPU usage
13.2% 16:58:27 INFO - TinderboxPrint: I/O read bytes / time
212,992 / 28 16:58:27 INFO - TinderboxPrint: I/O write bytes / time
430,694,400 / 793,520 16:58:27 INFO - TinderboxPrint: CPU idle
8,283.2 (86.8%) 16:58:27 INFO - TinderboxPrint: CPU user
1,200.3 (12.6%) 16:58:27 INFO - TinderboxPrint: Swap in / out
0 / 0 16:58:27 INFO - install - Wall time: 20s; CPU: 13.0%; Read bytes: 0; Write bytes: 107094016; Read time: 0; Write time: 212104 16:58:27 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:58:27 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 212992; Write bytes: 320528384; Read time: 28; Write time: 580928 16:58:28 INFO - Running post-run listener: _upload_blobber_files 16:58:28 INFO - Blob upload gear active. 16:58:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:58:28 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 16:58:28 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'] 16:58:28 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 16:58:28 INFO - (blobuploader) - INFO - Open directory for files ... 16:58:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:58:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:58:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:58:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:58:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:58:29 INFO - (blobuploader) - INFO - Done attempting. 16:58:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:58:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:58:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:58:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:58:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:58:37 INFO - (blobuploader) - INFO - Done attempting. 16:58:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:58:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:58:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:58:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:58:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:58:37 INFO - (blobuploader) - INFO - Done attempting. 16:58:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:58:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:58:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:58:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:58:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:58:38 INFO - (blobuploader) - INFO - Done attempting. 16:58:38 INFO - (blobuploader) - INFO - Iteration through files over. 16:58:38 INFO - Return code: 0 16:58:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:58:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:58:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f9df7624dc29a9d9e496bd6b2c6e6ae169f4e719f9e63fd61e7849e2a98ad94fa1d9ca497eca3a2933c1e64b086b8cafcdb95b551996e62856f3597fcb9c451", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca4e93ffa00469a34d943cf439b74d7b96b867bf8d49780ded9619d3c9ea6fbcf2dc9f746b8241b4475e34610fab9f7b9b6fa40b6cf342163d19f299bd1daa5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72f3789510de319612bf85c496af8f7089fee232c7c19c7a9f7c52ff37e87283edc537215a68c5a66c7b6bda4e5a507fc9a2bb6b80b36d6156bb1e3dcf7805a5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbd6bdd8d021108db93b8ffe1b79c437a4924d77a70a5d038b5796edc02a9a281327f92b39cc356618bca731a7e17d9f54f2831fdf87bd0a5d84bb175f2cfab7"} 16:58:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:58:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:58:38 INFO - Contents: 16:58:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f9df7624dc29a9d9e496bd6b2c6e6ae169f4e719f9e63fd61e7849e2a98ad94fa1d9ca497eca3a2933c1e64b086b8cafcdb95b551996e62856f3597fcb9c451", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca4e93ffa00469a34d943cf439b74d7b96b867bf8d49780ded9619d3c9ea6fbcf2dc9f746b8241b4475e34610fab9f7b9b6fa40b6cf342163d19f299bd1daa5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72f3789510de319612bf85c496af8f7089fee232c7c19c7a9f7c52ff37e87283edc537215a68c5a66c7b6bda4e5a507fc9a2bb6b80b36d6156bb1e3dcf7805a5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbd6bdd8d021108db93b8ffe1b79c437a4924d77a70a5d038b5796edc02a9a281327f92b39cc356618bca731a7e17d9f54f2831fdf87bd0a5d84bb175f2cfab7"} 16:58:38 INFO - Running post-run listener: copy_logs_to_upload_dir 16:58:38 INFO - Copying logs to upload dir... 16:58:38 INFO - mkdir: /builds/slave/test/build/upload/logs 16:58:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.935014 ========= master_lag: -0.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-17 16:58:38.762456) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 16:58:38.767546) ========= 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=8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f9df7624dc29a9d9e496bd6b2c6e6ae169f4e719f9e63fd61e7849e2a98ad94fa1d9ca497eca3a2933c1e64b086b8cafcdb95b551996e62856f3597fcb9c451", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca4e93ffa00469a34d943cf439b74d7b96b867bf8d49780ded9619d3c9ea6fbcf2dc9f746b8241b4475e34610fab9f7b9b6fa40b6cf342163d19f299bd1daa5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72f3789510de319612bf85c496af8f7089fee232c7c19c7a9f7c52ff37e87283edc537215a68c5a66c7b6bda4e5a507fc9a2bb6b80b36d6156bb1e3dcf7805a5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbd6bdd8d021108db93b8ffe1b79c437a4924d77a70a5d038b5796edc02a9a281327f92b39cc356618bca731a7e17d9f54f2831fdf87bd0a5d84bb175f2cfab7"} build_url:https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011478 build_url: 'https://queue.taskcluster.net/v1/task/Fda-eMH8RpC4QtyvHDqLcA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f9df7624dc29a9d9e496bd6b2c6e6ae169f4e719f9e63fd61e7849e2a98ad94fa1d9ca497eca3a2933c1e64b086b8cafcdb95b551996e62856f3597fcb9c451", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca4e93ffa00469a34d943cf439b74d7b96b867bf8d49780ded9619d3c9ea6fbcf2dc9f746b8241b4475e34610fab9f7b9b6fa40b6cf342163d19f299bd1daa5a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72f3789510de319612bf85c496af8f7089fee232c7c19c7a9f7c52ff37e87283edc537215a68c5a66c7b6bda4e5a507fc9a2bb6b80b36d6156bb1e3dcf7805a5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbd6bdd8d021108db93b8ffe1b79c437a4924d77a70a5d038b5796edc02a9a281327f92b39cc356618bca731a7e17d9f54f2831fdf87bd0a5d84bb175f2cfab7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 16:58:38.797969) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:58:38.798395) ========= 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=8783db0840cc980e80bb0bd400000236-1503013058.11490-1060073537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004506 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:58:38.880343) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 16:58:38.880697) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 16:58:38.881079) ========= ========= Total master_lag: -0.02 =========