builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-049 starttime: 1501811263.02 results: success (0) revision: 32083f24a1bb2c33050b4c972783f066432194eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 18:47:43.017044) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 18:47:43.017490) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 18:47:43.017771) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 18:47:43.033712) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 18:47:43.034001) ========= 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=db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-03 18:47:43-- 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% 42.6M=0s 2017-08-03 18:47:43 (42.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115823 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 18:47:43.163118) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 18:47:43.163423) ========= 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=db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023700 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 18:47:43.212351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 mins, 41 secs) (at 2017-08-03 18:47:43.212663) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 32083f24a1bb2c33050b4c972783f066432194eb --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 32083f24a1bb2c33050b4c972783f066432194eb --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=db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-03 18:47:43,718 truncating revision to first 12 chars 2017-08-03 18:47:43,718 Setting DEBUG logging. 2017-08-03 18:47:43,718 attempt 1/10 2017-08-03 18:47:43,718 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/32083f24a1bb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-03 18:47:44,094 attempt 1/10 2017-08-03 18:47:44,627 current task status: no status available at this point. state: PENDING 2017-08-03 18:47:44,627 sleeping for 11.00s (attempt 1/10) 2017-08-03 18:47:55,639 attempt 2/10 2017-08-03 18:47:56,213 current task status: no status available at this point. state: PENDING 2017-08-03 18:47:56,213 sleeping for 17.50s (attempt 2/10) 2017-08-03 18:48:13,731 attempt 3/10 2017-08-03 18:48:14,223 current task status: no status available at this point. state: PENDING 2017-08-03 18:48:14,223 sleeping for 27.25s (attempt 3/10) 2017-08-03 18:48:41,500 attempt 4/10 2017-08-03 18:48:42,009 current task status: no status available at this point. state: PENDING 2017-08-03 18:48:42,009 sleeping for 41.88s (attempt 4/10) 2017-08-03 18:49:23,926 attempt 5/10 2017-08-03 18:49:24,243 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-03 18:49:24,461 unpacking tar archive at: mozilla-central-32083f24a1bb/testing/mozharness/ program finished with exit code 0 elapsedTime=101.088417 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 mins, 41 secs) (at 2017-08-03 18:49:24.321016) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 18:49:24.321382) ========= script_repo_revision: 32083f24a1bb2c33050b4c972783f066432194eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 18:49:24.321798) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 18:49:24.322062) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 18:49:24.331865) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-08-03 18:49:24.332243) ========= /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=db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:49:24 INFO - MultiFileLogger online at 20170803 18:49:24 in /builds/slave/test 18:49:24 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 18:49:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:49:24 INFO - {'append_to_log': False, 18:49:24 INFO - 'base_work_dir': '/builds/slave/test', 18:49:24 INFO - 'blob_upload_branch': 'Firefox', 18:49:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:49:24 INFO - 'branch': 'Firefox', 18:49:24 INFO - 'buildbot_json_path': 'buildprops.json', 18:49:24 INFO - 'code_coverage': False, 18:49:24 INFO - 'config_files': ('talos/linux_config.py',), 18:49:24 INFO - 'default_actions': ('clobber', 18:49:24 INFO - 'read-buildbot-config', 18:49:24 INFO - 'download-and-extract', 18:49:24 INFO - 'populate-webroot', 18:49:24 INFO - 'create-virtualenv', 18:49:24 INFO - 'install', 18:49:24 INFO - 'setup-mitmproxy', 18:49:24 INFO - 'run-tests'), 18:49:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:49:24 INFO - 'disable_ccov_upload': False, 18:49:24 INFO - 'download_minidump_stackwalk': True, 18:49:24 INFO - 'download_symbols': 'ondemand', 18:49:24 INFO - 'enable_stylo': False, 18:49:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:49:24 INFO - 'tooltool.py': '/tools/tooltool.py', 18:49:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:49:24 INFO - '/tools/misc-python/virtualenv.py')}, 18:49:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:49:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:49:24 INFO - 'gecko_profile': False, 18:49:24 INFO - 'gecko_profile_interval': 0, 18:49:24 INFO - 'installer_path': 'installer.exe', 18:49:24 INFO - 'log_level': 'info', 18:49:24 INFO - 'log_name': 'talos', 18:49:24 INFO - 'log_to_console': True, 18:49:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:49:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:49:24 INFO - 'opt_config_files': (), 18:49:24 INFO - 'pip_index': False, 18:49:24 INFO - 'suite': 'dromaeojs-e10s', 18:49:24 INFO - 'system_bits': '32', 18:49:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:49:24 INFO - 'title': 'talos-linux64-ix-049', 18:49:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:49:24 INFO - 'use_talos_json': True, 18:49:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:49:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:49:24 INFO - 'work_dir': 'build'} 18:49:24 INFO - [mozharness: 2017-08-04 01:49:24.945047Z] Running clobber step. 18:49:24 INFO - Running pre-action listener: _resource_record_pre_action 18:49:24 INFO - Running main action method: clobber 18:49:24 INFO - rmtree: /builds/slave/test/build 18:49:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:49:25 INFO - Running post-action listener: _resource_record_post_action 18:49:25 INFO - [mozharness: 2017-08-04 01:49:25.978573Z] Finished clobber step (success) 18:49:25 INFO - [mozharness: 2017-08-04 01:49:25.978676Z] Running read-buildbot-config step. 18:49:25 INFO - Running pre-action listener: _resource_record_pre_action 18:49:25 INFO - Running main action method: read_buildbot_config 18:49:25 INFO - Using buildbot properties: 18:49:25 INFO - { 18:49:25 INFO - "project": "", 18:49:25 INFO - "product": "firefox", 18:49:25 INFO - "who": "kwierso@gmail.com", 18:49:25 INFO - "installer_path": "public/build/target.tar.bz2", 18:49:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 18:49:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:49:25 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 18:49:25 INFO - "stage_platform": "linux64-stylo", 18:49:25 INFO - "basedir": "/builds/slave/test", 18:49:25 INFO - "buildnumber": 15, 18:49:25 INFO - "platform": "ubuntu64_hw_stylo", 18:49:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:49:25 INFO - "slavebuilddir": "test", 18:49:25 INFO - "taskId": "QSZvH57-StKKwzaXqfJXhw", 18:49:25 INFO - "branch": "mozilla-central", 18:49:25 INFO - "script_repo_revision": "production", 18:49:25 INFO - "revision": "32083f24a1bb2c33050b4c972783f066432194eb", 18:49:25 INFO - "slavename": "talos-linux64-ix-049", 18:49:25 INFO - "repo_path": "mozilla-central" 18:49:25 INFO - } 18:49:25 INFO - Finding installer, test and symbols from parent task. 18:49:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QSZvH57-StKKwzaXqfJXhw'}, attempt #1 18:49:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QSZvH57-StKKwzaXqfJXhw'}, attempt #1 18:49:26 INFO - Task dependencies: H5B5IEnwSEm76TFIhWTsdQ 18:49:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ'}, attempt #1 18:49:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.tar.bz2 18:49:27 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.test_packages.json 18:49:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.crashreporter-symbols.zip 18:49:27 INFO - Running post-action listener: _resource_record_post_action 18:49:27 INFO - [mozharness: 2017-08-04 01:49:27.351528Z] Finished read-buildbot-config step (success) 18:49:27 INFO - [mozharness: 2017-08-04 01:49:27.351750Z] Running download-and-extract step. 18:49:27 INFO - Running pre-action listener: _resource_record_pre_action 18:49:27 INFO - Running main action method: download_and_extract 18:49:27 INFO - mkdir: /builds/slave/test/build/tests 18:49: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')]} 18:49:27 INFO - trying https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.test_packages.json 18:49:27 INFO - Downloading https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:49:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:49:28 INFO - Downloaded 989 bytes. 18:49:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:49:28 INFO - Using the following test package requirements: 18:49:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:49:28 INFO - u'common': [u'target.common.tests.zip'], 18:49:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:49:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:49:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:49:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:49:28 INFO - u'mozbase': [u'target.common.tests.zip'], 18:49:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:49:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:49:28 INFO - u'web-platform': [u'target.common.tests.zip', 18:49:28 INFO - u'target.web-platform.tests.tar.gz'], 18:49:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:49:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:49:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.common.tests.zip 18:49:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:49:28 INFO - Fetch https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.common.tests.zip into memory 18:49:29 INFO - Content-Length response header: 54278817 18:49:30 INFO - Bytes received: 54278817 18:49:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:49:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.common.tests.zip 18:49:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:49:41 INFO - Fetch https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.common.tests.zip into memory 18:49:42 INFO - Content-Length response header: 54278817 18:49:42 INFO - Bytes received: 54278817 18:49:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.talos.tests.zip 18:49:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:49:53 INFO - Fetch https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.talos.tests.zip into memory 18:49:54 INFO - Content-Length response header: 14496012 18:49:54 INFO - Bytes received: 14496012 18:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:49:54 INFO - trying https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.tar.bz2 18:49:54 INFO - Downloading https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:49:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:49:59 INFO - Downloaded 62304218 bytes. 18:49:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.tar.bz2 18:49:59 INFO - mkdir: /builds/slave/test/properties 18:49:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:49:59 INFO - Writing to file /builds/slave/test/properties/build_url 18:49:59 INFO - Contents: 18:49:59 INFO - build_url:https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.tar.bz2 18:49:59 INFO - Running post-action listener: _resource_record_post_action 18:49:59 INFO - Running post-action listener: set_extra_try_arguments 18:49:59 INFO - [mozharness: 2017-08-04 01:49:59.023347Z] Finished download-and-extract step (success) 18:49:59 INFO - [mozharness: 2017-08-04 01:49:59.023446Z] Running populate-webroot step. 18:49:59 INFO - Running pre-action listener: _resource_record_pre_action 18:49:59 INFO - Running main action method: populate_webroot 18:49:59 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:49:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:49:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:49:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:49:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:49:59 INFO - 'tests': ['damp', 'tps']}, 18:49:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:49:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:49:59 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:49:59 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:49:59 INFO - 'other-e10s': {'tests': ['a11yr', 18:49:59 INFO - 'ts_paint', 18:49:59 INFO - 'tpaint', 18:49:59 INFO - 'sessionrestore', 18:49:59 INFO - 'sessionrestore_many_windows', 18:49:59 INFO - 'sessionrestore_no_auto_restore', 18:49:59 INFO - 'tabpaint']}, 18:49:59 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:49:59 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:49:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:49:59 INFO - 'tsvgr_opacity', 18:49:59 INFO - 'tart', 18:49:59 INFO - 'tscrollx', 18:49:59 INFO - 'cart', 18:49:59 INFO - 'tsvg_static']}, 18:49:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:49:59 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:49:59 INFO - 'talos_options': ['--mitmproxy', 18:49:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:49:59 INFO - '--firstNonBlankPaint'], 18:49:59 INFO - 'tests': ['tp6_google', 18:49:59 INFO - 'tp6_youtube', 18:49:59 INFO - 'tp6_amazon', 18:49:59 INFO - 'tp6_facebook']}, 18:49:59 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:49:59 INFO - 'talos_options': ['--stylo', 18:49:59 INFO - '--mitmproxy', 18:49:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:49:59 INFO - '--firstNonBlankPaint'], 18:49:59 INFO - 'tests': ['tp6_google', 18:49:59 INFO - 'tp6_youtube', 18:49:59 INFO - 'tp6_amazon', 18:49:59 INFO - 'tp6_facebook']}, 18:49:59 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:49:59 INFO - 'talos_options': ['--stylo', 18:49:59 INFO - '--stylo-threads=1', 18:49:59 INFO - '--mitmproxy', 18:49:59 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:49:59 INFO - '--firstNonBlankPaint'], 18:49:59 INFO - 'tests': ['tp6_google', 18:49:59 INFO - 'tp6_youtube', 18:49:59 INFO - 'tp6_amazon', 18:49:59 INFO - 'tp6_facebook']}, 18:49:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:49:59 INFO - 'talos_options': ['--xperf_path', 18:49:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:49:59 INFO - 'tests': ['tp5n']}}} 18:49:59 INFO - Running post-action listener: _resource_record_post_action 18:49:59 INFO - [mozharness: 2017-08-04 01:49:59.031978Z] Finished populate-webroot step (success) 18:49:59 INFO - [mozharness: 2017-08-04 01:49:59.032068Z] Running create-virtualenv step. 18:49:59 INFO - Running pre-action listener: _resource_record_pre_action 18:49:59 INFO - Running main action method: create_virtualenv 18:49:59 INFO - Creating virtualenv /builds/slave/test/build/venv 18:49:59 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:49:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:49:59 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:49:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:49:59 INFO - Using real prefix '/usr' 18:49:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:49:59 INFO - Installing distribute.............................................................................................................................................................................................done. 18:50:01 INFO - Installing pip.................done. 18:50:01 INFO - Return code: 0 18:50:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:50:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:50:01 INFO - Reading from file tmpfile_stdout 18:50:01 INFO - Output received: 18:50:01 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:50:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbcd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9eb0>, '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 0x1dbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbb240>, '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': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', '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 18:50:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:50:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:50:01 INFO - Using env: {'DISPLAY': ':0', 18:50:01 INFO - 'HOME': '/home/cltbld', 18:50:01 INFO - 'LANG': 'en_US.UTF-8', 18:50:01 INFO - 'LANGUAGE': 'en_US:en', 18:50:01 INFO - 'LOGNAME': 'cltbld', 18:50:01 INFO - 'MAIL': '/var/mail/cltbld', 18:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:01 INFO - 'MOZ_NO_REMOTE': '1', 18:50:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:01 INFO - 'NO_EM_RESTART': '1', 18:50:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:01 INFO - 'PWD': '/builds/slave/test', 18:50:01 INFO - 'SHELL': '/bin/bash', 18:50:01 INFO - 'SHLVL': '1', 18:50:01 INFO - 'TERM': 'linux', 18:50:01 INFO - 'TMOUT': '86400', 18:50:01 INFO - 'USER': 'cltbld', 18:50:01 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', 18:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:01 INFO - '_': '/tools/buildbot/bin/python'} 18:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:50:02 INFO - Cleaning up... 18:50:02 INFO - Return code: 0 18:50:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbcd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9eb0>, '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 0x1dbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbb240>, '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': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', '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 18:50:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:50:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:50:02 INFO - Using env: {'DISPLAY': ':0', 18:50:02 INFO - 'HOME': '/home/cltbld', 18:50:02 INFO - 'LANG': 'en_US.UTF-8', 18:50:02 INFO - 'LANGUAGE': 'en_US:en', 18:50:02 INFO - 'LOGNAME': 'cltbld', 18:50:02 INFO - 'MAIL': '/var/mail/cltbld', 18:50:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:02 INFO - 'MOZ_NO_REMOTE': '1', 18:50:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:02 INFO - 'NO_EM_RESTART': '1', 18:50:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:02 INFO - 'PWD': '/builds/slave/test', 18:50:02 INFO - 'SHELL': '/bin/bash', 18:50:02 INFO - 'SHLVL': '1', 18:50:02 INFO - 'TERM': 'linux', 18:50:02 INFO - 'TMOUT': '86400', 18:50:02 INFO - 'USER': 'cltbld', 18:50:02 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', 18:50:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:02 INFO - '_': '/tools/buildbot/bin/python'} 18:50:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:02 INFO - Downloading/unpacking psutil>=3.1.1 18:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:50:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:50:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:50:03 INFO - Installing collected packages: psutil 18:50:03 INFO - Running setup.py install for psutil 18:50:03 INFO - building 'psutil._psutil_linux' extension 18:50:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:50:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:50:03 INFO - building 'psutil._psutil_posix' extension 18:50:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:50:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:50:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:50:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:50:03 INFO - Successfully installed psutil 18:50:03 INFO - Cleaning up... 18:50:03 INFO - Return code: 0 18:50:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:03 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 0x1a4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbcd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9eb0>, '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 0x1dbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbb240>, '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': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', '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 18:50:03 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 18:50:03 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 18:50:03 INFO - Using env: {'DISPLAY': ':0', 18:50:03 INFO - 'HOME': '/home/cltbld', 18:50:03 INFO - 'LANG': 'en_US.UTF-8', 18:50:03 INFO - 'LANGUAGE': 'en_US:en', 18:50:03 INFO - 'LOGNAME': 'cltbld', 18:50:03 INFO - 'MAIL': '/var/mail/cltbld', 18:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:03 INFO - 'MOZ_NO_REMOTE': '1', 18:50:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:03 INFO - 'NO_EM_RESTART': '1', 18:50:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:03 INFO - 'PWD': '/builds/slave/test', 18:50:03 INFO - 'SHELL': '/bin/bash', 18:50:03 INFO - 'SHLVL': '1', 18:50:03 INFO - 'TERM': 'linux', 18:50:03 INFO - 'TMOUT': '86400', 18:50:03 INFO - 'USER': 'cltbld', 18:50:03 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', 18:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:03 INFO - '_': '/tools/buildbot/bin/python'} 18:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:50:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:50:05 INFO - Installing collected packages: mozsystemmonitor 18:50:05 INFO - Running setup.py install for mozsystemmonitor 18:50:05 INFO - Successfully installed mozsystemmonitor 18:50:05 INFO - Cleaning up... 18:50:05 INFO - Return code: 0 18:50:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbcd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9eb0>, '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 0x1dbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbb240>, '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': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', '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 18:50:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:50:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:50:05 INFO - Using env: {'DISPLAY': ':0', 18:50:05 INFO - 'HOME': '/home/cltbld', 18:50:05 INFO - 'LANG': 'en_US.UTF-8', 18:50:05 INFO - 'LANGUAGE': 'en_US:en', 18:50:05 INFO - 'LOGNAME': 'cltbld', 18:50:05 INFO - 'MAIL': '/var/mail/cltbld', 18:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:05 INFO - 'MOZ_NO_REMOTE': '1', 18:50:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:05 INFO - 'NO_EM_RESTART': '1', 18:50:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:05 INFO - 'PWD': '/builds/slave/test', 18:50:05 INFO - 'SHELL': '/bin/bash', 18:50:05 INFO - 'SHLVL': '1', 18:50:05 INFO - 'TERM': 'linux', 18:50:05 INFO - 'TMOUT': '86400', 18:50:05 INFO - 'USER': 'cltbld', 18:50:05 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', 18:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:05 INFO - '_': '/tools/buildbot/bin/python'} 18:50:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:05 INFO - Downloading/unpacking jsonschema==2.5.1 18:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:50:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:06 INFO - Downloading functools32-3.2.3-2.tar.gz 18:50:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:50:06 INFO - warning: no files found matching '*.txt' 18:50:06 INFO - no previously-included directories found matching 'build' 18:50:06 INFO - no previously-included directories found matching 'dist' 18:50:06 INFO - no previously-included directories found matching '.git*' 18:50:06 INFO - Installing collected packages: jsonschema, functools32 18:50:06 INFO - Running setup.py install for functools32 18:50:07 INFO - warning: no files found matching '*.txt' 18:50:07 INFO - no previously-included directories found matching 'build' 18:50:07 INFO - no previously-included directories found matching 'dist' 18:50:07 INFO - no previously-included directories found matching '.git*' 18:50:07 INFO - Successfully installed jsonschema functools32 18:50:07 INFO - Cleaning up... 18:50:07 INFO - Return code: 0 18:50:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbcd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9eb0>, '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 0x1dbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbb240>, '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': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', '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 18:50:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:50:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:50:07 INFO - Using env: {'DISPLAY': ':0', 18:50:07 INFO - 'HOME': '/home/cltbld', 18:50:07 INFO - 'LANG': 'en_US.UTF-8', 18:50:07 INFO - 'LANGUAGE': 'en_US:en', 18:50:07 INFO - 'LOGNAME': 'cltbld', 18:50:07 INFO - 'MAIL': '/var/mail/cltbld', 18:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:07 INFO - 'MOZ_NO_REMOTE': '1', 18:50:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:07 INFO - 'NO_EM_RESTART': '1', 18:50:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:07 INFO - 'PWD': '/builds/slave/test', 18:50:07 INFO - 'SHELL': '/bin/bash', 18:50:07 INFO - 'SHLVL': '1', 18:50:07 INFO - 'TERM': 'linux', 18:50:07 INFO - 'TMOUT': '86400', 18:50:07 INFO - 'USER': 'cltbld', 18:50:07 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', 18:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:07 INFO - '_': '/tools/buildbot/bin/python'} 18:50:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:50:07 INFO - Cleaning up... 18:50:07 INFO - Return code: 0 18:50:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbcd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9eb0>, '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 0x1dbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbb240>, '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': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', '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 18:50:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:50:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:50:07 INFO - Using env: {'DISPLAY': ':0', 18:50:07 INFO - 'HOME': '/home/cltbld', 18:50:07 INFO - 'LANG': 'en_US.UTF-8', 18:50:07 INFO - 'LANGUAGE': 'en_US:en', 18:50:07 INFO - 'LOGNAME': 'cltbld', 18:50:07 INFO - 'MAIL': '/var/mail/cltbld', 18:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:07 INFO - 'MOZ_NO_REMOTE': '1', 18:50:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:07 INFO - 'NO_EM_RESTART': '1', 18:50:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:07 INFO - 'PWD': '/builds/slave/test', 18:50:07 INFO - 'SHELL': '/bin/bash', 18:50:07 INFO - 'SHLVL': '1', 18:50:07 INFO - 'TERM': 'linux', 18:50:07 INFO - 'TMOUT': '86400', 18:50:07 INFO - 'USER': 'cltbld', 18:50:07 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', 18:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:07 INFO - '_': '/tools/buildbot/bin/python'} 18:50:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:07 INFO - Downloading/unpacking blobuploader==1.2.4 18:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:08 INFO - Downloading blobuploader-1.2.4.tar.gz 18:50:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:50:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:50:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:09 INFO - Downloading docopt-0.6.1.tar.gz 18:50:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:50:09 INFO - Installing collected packages: blobuploader, requests, docopt 18:50:09 INFO - Running setup.py install for blobuploader 18:50:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:50:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:50:09 INFO - Running setup.py install for requests 18:50:09 INFO - Running setup.py install for docopt 18:50:09 INFO - Successfully installed blobuploader requests docopt 18:50:09 INFO - Cleaning up... 18:50:09 INFO - Return code: 0 18:50:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:50: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')]} 18:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50: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')]} 18:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbcd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9eb0>, '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 0x1dbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbb240>, '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': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', '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 18:50:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:50:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:50:09 INFO - Using env: {'DISPLAY': ':0', 18:50:09 INFO - 'HOME': '/home/cltbld', 18:50:09 INFO - 'LANG': 'en_US.UTF-8', 18:50:09 INFO - 'LANGUAGE': 'en_US:en', 18:50:09 INFO - 'LOGNAME': 'cltbld', 18:50:09 INFO - 'MAIL': '/var/mail/cltbld', 18:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:09 INFO - 'MOZ_NO_REMOTE': '1', 18:50:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:09 INFO - 'NO_EM_RESTART': '1', 18:50:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:09 INFO - 'PWD': '/builds/slave/test', 18:50:09 INFO - 'SHELL': '/bin/bash', 18:50:09 INFO - 'SHLVL': '1', 18:50:09 INFO - 'TERM': 'linux', 18:50:09 INFO - 'TMOUT': '86400', 18:50:09 INFO - 'USER': 'cltbld', 18:50:09 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', 18:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:09 INFO - '_': '/tools/buildbot/bin/python'} 18:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:50:10 INFO - Running setup.py (path:/tmp/pip-2uOtnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:50:10 INFO - Running setup.py (path:/tmp/pip-szPS7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:50:10 INFO - Running setup.py (path:/tmp/pip-ijkspX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:50:10 INFO - Running setup.py (path:/tmp/pip-N2wlj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:50:10 INFO - Running setup.py (path:/tmp/pip-hwd0H9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:50:10 INFO - Running setup.py (path:/tmp/pip-tM13rd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:50:10 INFO - Running setup.py (path:/tmp/pip-QaFOoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:50:10 INFO - Running setup.py (path:/tmp/pip-V5dV0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:50:10 INFO - Running setup.py (path:/tmp/pip-x7abRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:50:10 INFO - Running setup.py (path:/tmp/pip-y5Z3YV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:50:10 INFO - Running setup.py (path:/tmp/pip-PRoWsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:50:10 INFO - Running setup.py (path:/tmp/pip-vhOiJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:50:10 INFO - Running setup.py (path:/tmp/pip-geMRsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:50:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:50:10 INFO - Running setup.py (path:/tmp/pip-qDupl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:11 INFO - Running setup.py (path:/tmp/pip-74pznq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:50:11 INFO - Running setup.py (path:/tmp/pip-JgZK0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:50:11 INFO - Running setup.py (path:/tmp/pip-pUWGNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:50:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:50:11 INFO - Running setup.py install for manifestparser 18:50:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:50:11 INFO - Running setup.py install for mozcrash 18:50:11 INFO - Running setup.py install for mozdebug 18:50:11 INFO - Running setup.py install for mozdevice 18:50:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:50:11 INFO - Running setup.py install for mozfile 18:50:11 INFO - Running setup.py install for mozhttpd 18:50:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:50:11 INFO - Running setup.py install for mozinfo 18:50:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:50:11 INFO - Running setup.py install for mozInstall 18:50:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:50:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:50:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:50:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:50:12 INFO - Running setup.py install for mozleak 18:50:12 INFO - Running setup.py install for mozlog 18:50:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:50:12 INFO - Running setup.py install for moznetwork 18:50:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:50:12 INFO - Running setup.py install for mozprocess 18:50:12 INFO - Running setup.py install for mozprofile 18:50:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:50:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:50:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:50:12 INFO - Running setup.py install for mozrunner 18:50:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:50:12 INFO - Running setup.py install for mozscreenshot 18:50:12 INFO - Running setup.py install for moztest 18:50:12 INFO - Running setup.py install for mozversion 18:50:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:50:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:50:13 INFO - Cleaning up... 18:50:13 INFO - Return code: 0 18:50:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:50: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')]} 18:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50: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')]} 18:50:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbcd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9eb0>, '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 0x1dbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbb240>, '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': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', '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 18:50:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:50:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:50:13 INFO - Using env: {'DISPLAY': ':0', 18:50:13 INFO - 'HOME': '/home/cltbld', 18:50:13 INFO - 'LANG': 'en_US.UTF-8', 18:50:13 INFO - 'LANGUAGE': 'en_US:en', 18:50:13 INFO - 'LOGNAME': 'cltbld', 18:50:13 INFO - 'MAIL': '/var/mail/cltbld', 18:50:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:13 INFO - 'MOZ_NO_REMOTE': '1', 18:50:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:13 INFO - 'NO_EM_RESTART': '1', 18:50:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:13 INFO - 'PWD': '/builds/slave/test', 18:50:13 INFO - 'SHELL': '/bin/bash', 18:50:13 INFO - 'SHLVL': '1', 18:50:13 INFO - 'TERM': 'linux', 18:50:13 INFO - 'TMOUT': '86400', 18:50:13 INFO - 'USER': 'cltbld', 18:50:13 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', 18:50:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:13 INFO - '_': '/tools/buildbot/bin/python'} 18:50:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:50:13 INFO - Running setup.py (path:/tmp/pip-xiStm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:50:13 INFO - Running setup.py (path:/tmp/pip-fezvFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:50:13 INFO - Running setup.py (path:/tmp/pip-LyFqpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:50:13 INFO - Running setup.py (path:/tmp/pip-Sv2nv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:50:13 INFO - Running setup.py (path:/tmp/pip-0sKtd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:50:13 INFO - Running setup.py (path:/tmp/pip-wUFjUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:50:13 INFO - Running setup.py (path:/tmp/pip-ZyQU7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:50:13 INFO - Running setup.py (path:/tmp/pip-lLrC1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:50:13 INFO - Running setup.py (path:/tmp/pip-NrkUDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:50:13 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)) 18:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:50:13 INFO - Running setup.py (path:/tmp/pip-hvCjo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:50:13 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)) 18:50:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:50:13 INFO - Running setup.py (path:/tmp/pip-XJgscH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:50:14 INFO - Running setup.py (path:/tmp/pip-4fCXlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:50:14 INFO - Running setup.py (path:/tmp/pip-MDQW7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:50:14 INFO - Running setup.py (path:/tmp/pip-D8CNU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:14 INFO - Running setup.py (path:/tmp/pip-fv0ZhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:50:14 INFO - Running setup.py (path:/tmp/pip-SBzAeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:50:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:50:14 INFO - Running setup.py (path:/tmp/pip-Jgyfq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:50:14 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:50:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:15 INFO - Downloading blessings-1.6.tar.gz 18:50:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:50:15 INFO - Installing collected packages: blessings 18:50:15 INFO - Running setup.py install for blessings 18:50:15 INFO - Successfully installed blessings 18:50:15 INFO - Cleaning up... 18:50:15 INFO - Return code: 0 18:50:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:50:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:50:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:50:16 INFO - Reading from file tmpfile_stdout 18:50:16 INFO - Current package versions: 18:50:16 INFO - argparse == 1.2.1 18:50:16 INFO - blessings == 1.6 18:50:16 INFO - blobuploader == 1.2.4 18:50:16 INFO - docopt == 0.6.1 18:50:16 INFO - functools32 == 3.2.3-2 18:50:16 INFO - jsonschema == 2.5.1 18:50:16 INFO - manifestparser == 1.1 18:50:16 INFO - mozInstall == 1.13 18:50:16 INFO - mozcrash == 1.0 18:50:16 INFO - mozdebug == 0.1 18:50:16 INFO - mozdevice == 0.51 18:50:16 INFO - mozfile == 1.2 18:50:16 INFO - mozhttpd == 0.7 18:50:16 INFO - mozinfo == 0.10 18:50:16 INFO - mozleak == 0.1 18:50:16 INFO - mozlog == 3.5 18:50:16 INFO - moznetwork == 0.27 18:50:16 INFO - mozprocess == 0.25 18:50:16 INFO - mozprofile == 0.28 18:50:16 INFO - mozrunner == 6.13 18:50:16 INFO - mozscreenshot == 0.1 18:50:16 INFO - mozsystemmonitor == 0.3 18:50:16 INFO - moztest == 0.8 18:50:16 INFO - mozversion == 1.4 18:50:16 INFO - psutil == 3.1.1 18:50:16 INFO - requests == 1.2.3 18:50:16 INFO - wsgiref == 0.1.2 18:50:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:50: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')]} 18:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50: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')]} 18:50:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbcd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9eb0>, '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 0x1dbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbb240>, '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': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', '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 18:50:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:50:16 INFO - Using env: {'DISPLAY': ':0', 18:50:16 INFO - 'HOME': '/home/cltbld', 18:50:16 INFO - 'LANG': 'en_US.UTF-8', 18:50:16 INFO - 'LANGUAGE': 'en_US:en', 18:50:16 INFO - 'LOGNAME': 'cltbld', 18:50:16 INFO - 'MAIL': '/var/mail/cltbld', 18:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:16 INFO - 'MOZ_NO_REMOTE': '1', 18:50:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:16 INFO - 'NO_EM_RESTART': '1', 18:50:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:16 INFO - 'PWD': '/builds/slave/test', 18:50:16 INFO - 'SHELL': '/bin/bash', 18:50:16 INFO - 'SHLVL': '1', 18:50:16 INFO - 'TERM': 'linux', 18:50:16 INFO - 'TMOUT': '86400', 18:50:16 INFO - 'USER': 'cltbld', 18:50:16 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', 18:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:16 INFO - '_': '/tools/buildbot/bin/python'} 18:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:50:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:50:16 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:50:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:50:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:50:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:50:17 INFO - Installing collected packages: simplejson 18:50:17 INFO - Running setup.py install for simplejson 18:50:17 INFO - building 'simplejson._speedups' extension 18:50:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 18:50:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 18:50:18 INFO - Successfully installed simplejson 18:50:18 INFO - Cleaning up... 18:50:18 INFO - Return code: 0 18:50:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:50: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')]} 18:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:50: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')]} 18:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:50:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c19a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbcd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9eb0>, '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 0x1dbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbb240>, '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': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', '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 18:50:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:50:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:50:18 INFO - Using env: {'DISPLAY': ':0', 18:50:18 INFO - 'HOME': '/home/cltbld', 18:50:18 INFO - 'LANG': 'en_US.UTF-8', 18:50:18 INFO - 'LANGUAGE': 'en_US:en', 18:50:18 INFO - 'LOGNAME': 'cltbld', 18:50:18 INFO - 'MAIL': '/var/mail/cltbld', 18:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:18 INFO - 'MOZ_NO_REMOTE': '1', 18:50:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:18 INFO - 'NO_EM_RESTART': '1', 18:50:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:18 INFO - 'PWD': '/builds/slave/test', 18:50:18 INFO - 'SHELL': '/bin/bash', 18:50:18 INFO - 'SHLVL': '1', 18:50:18 INFO - 'TERM': 'linux', 18:50:18 INFO - 'TMOUT': '86400', 18:50:18 INFO - 'USER': 'cltbld', 18:50:18 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', 18:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:18 INFO - '_': '/tools/buildbot/bin/python'} 18:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:50:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:50:18 INFO - Cleaning up... 18:50:18 INFO - Return code: 0 18:50:18 INFO - Running post-action listener: _resource_record_post_action 18:50:18 INFO - Running post-action listener: _start_resource_monitoring 18:50:18 INFO - Starting resource monitoring. 18:50:18 INFO - [mozharness: 2017-08-04 01:50:18.857198Z] Finished create-virtualenv step (success) 18:50:18 INFO - [mozharness: 2017-08-04 01:50:18.857773Z] Running install step. 18:50:18 INFO - Running pre-action listener: _resource_record_pre_action 18:50:18 INFO - Running main action method: install 18:50:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:50:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:50:19 INFO - Reading from file tmpfile_stdout 18:50:19 INFO - Detecting whether we're running mozinstall >=1.0... 18:50:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:50:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:50:19 INFO - Reading from file tmpfile_stdout 18:50:19 INFO - Output received: 18:50:19 INFO - Usage: mozinstall [options] installer 18:50:19 INFO - Options: 18:50:19 INFO - -h, --help show this help message and exit 18:50:19 INFO - -d DEST, --destination=DEST 18:50:19 INFO - Directory to install application into. [default: 18:50:19 INFO - "/builds/slave/test"] 18:50:19 INFO - --app=APP Application being installed. [default: firefox] 18:50:19 INFO - mkdir: /builds/slave/test/build/application 18:50:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:50:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:50:37 INFO - Reading from file tmpfile_stdout 18:50:37 INFO - Output received: 18:50:37 INFO - /builds/slave/test/build/application/firefox/firefox 18:50:37 INFO - Running post-action listener: _resource_record_post_action 18:50:37 INFO - [mozharness: 2017-08-04 01:50:37.286932Z] Finished install step (success) 18:50:37 INFO - [mozharness: 2017-08-04 01:50:37.287217Z] Running setup-mitmproxy step. 18:50:37 INFO - Running pre-action listener: _resource_record_pre_action 18:50:37 INFO - Running main action method: setup_mitmproxy 18:50:37 INFO - Skipping: mitmproxy is not required 18:50:37 INFO - Running post-action listener: _resource_record_post_action 18:50:37 INFO - [mozharness: 2017-08-04 01:50:37.288383Z] Finished setup-mitmproxy step (success) 18:50:37 INFO - [mozharness: 2017-08-04 01:50:37.288603Z] Running run-tests step. 18:50:37 INFO - Running pre-action listener: _resource_record_pre_action 18:50:37 INFO - Running pre-action listener: _set_gcov_prefix 18:50:37 INFO - Running main action method: run_tests 18:50:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:50:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:50:37 INFO - Python 2.7.3 18:50:37 INFO - Return code: 0 18:50:37 INFO - grabbing minidump binary from tooltool 18:50:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:50:37 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db9eb0>, '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 0x1dbadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1dbb240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:50:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:50:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:50:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:50:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:50:37 INFO - Return code: 0 18:50:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:50:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:50:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:50:37 INFO - ENV: RUST_BACKTRACE is now 1 18:50:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:50:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:50:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 18:50:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 18:50:37 INFO - Using env: {'DISPLAY': ':0', 18:50:37 INFO - 'HOME': '/home/cltbld', 18:50:37 INFO - 'LANG': 'en_US.UTF-8', 18:50:37 INFO - 'LANGUAGE': 'en_US:en', 18:50:37 INFO - 'LOGNAME': 'cltbld', 18:50:37 INFO - 'MAIL': '/var/mail/cltbld', 18:50:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:50:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:50:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:50:37 INFO - 'MOZ_NO_REMOTE': '1', 18:50:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:50:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:50:37 INFO - 'NO_EM_RESTART': '1', 18:50:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:50:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:50:37 INFO - 'PWD': '/builds/slave/test', 18:50:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:50:37 INFO - 'RUST_BACKTRACE': '1', 18:50:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:50:37 INFO - 'SHELL': '/bin/bash', 18:50:37 INFO - 'SHLVL': '1', 18:50:37 INFO - 'STYLO_FORCE_ENABLED': '1', 18:50:37 INFO - 'TERM': 'linux', 18:50:37 INFO - 'TMOUT': '86400', 18:50:37 INFO - 'USER': 'cltbld', 18:50:37 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859', 18:50:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:50:37 INFO - '_': '/tools/buildbot/bin/python'} 18:50:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 18:50:37 INFO - mozversion application_buildid: 20170804010714 18:50:37 INFO - mozversion application_changeset: 32083f24a1bb2c33050b4c972783f066432194eb 18:50:37 INFO - mozversion application_display_name: Nightly 18:50:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:50:37 INFO - mozversion application_name: Firefox 18:50:37 INFO - mozversion application_remotingname: firefox 18:50:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:50:37 INFO - mozversion application_vendor: Mozilla 18:50:37 INFO - mozversion application_version: 57.0a1 18:50:37 INFO - mozversion platform_buildid: 20170804010714 18:50:37 INFO - mozversion platform_changeset: 32083f24a1bb2c33050b4c972783f066432194eb 18:50:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:50:37 INFO - mozversion platform_version: 57.0a1 18:50:37 INFO - using testdate: 1501811437 18:50:37 INFO - actual date: 1501811437 18:50:37 INFO - starting webserver on 'localhost:60007' 18:50:37 INFO - SUITE-START | Running 2 tests 18:50:37 INFO - TEST-START | dromaeo_css 18:50:37 INFO - Initialising browser for dromaeo_css test... 18:50:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60007/getInfo.html -profile /tmp/tmpgAjamL/profile 18:50:37 INFO - TEST-INFO | started process 29260 (/builds/slave/test/build/application/firefox/firefox http://localhost:60007/getInfo.html) 18:50:43 INFO - TEST-INFO | 29260: exit 0 18:50:44 INFO - Browser initialized. 18:50:44 INFO - Running cycle 1/1 for dromaeo_css test... 18:50:44 INFO - TEST-INFO | started process 29487 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgAjamL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:50:45 INFO - PID 29487 | 18:50:45 INFO - PID 29487 | (/builds/slave/test/build/application/firefox/firefox:29541): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:50:45 INFO - PID 29487 | 18:50:55 INFO - PID 29487 | RSS: Main: 173580288 18:50:55 INFO - PID 29487 | 18:53:55 INFO - PID 29487 | Cycle 1(1): loaded http://localhost:60007/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60007/tests/dromaeo/cssquery-ext.html) 18:53:56 INFO - PID 29487 | RSS: Main: 175550464 18:53:56 INFO - PID 29487 | 18:56:58 INFO - PID 29487 | Cycle 1(1): loaded http://localhost:60007/tests/dromaeo/cssquery-ext.html (next: http://localhost:60007/tests/dromaeo/cssquery-jquery.html) 18:56:59 INFO - PID 29487 | RSS: Main: 173391872 18:56:59 INFO - PID 29487 | 19:00:01 INFO - PID 29487 | Cycle 1(1): loaded http://localhost:60007/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60007/tests/dromaeo/cssquery-mootools.html) 19:00:01 INFO - PID 29487 | RSS: Main: 175329280 19:00:01 INFO - PID 29487 | 19:03:03 INFO - PID 29487 | Cycle 1(1): loaded http://localhost:60007/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60007/tests/dromaeo/cssquery-prototype.html) 19:03:04 INFO - PID 29487 | RSS: Main: 173776896 19:03:04 INFO - PID 29487 | 19:06:08 INFO - PID 29487 | Cycle 1(1): loaded http://localhost:60007/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60007/tests/dromaeo/cssquery-yui.html) 19:06:08 INFO - PID 29487 | RSS: Main: 176893952 19:06:08 INFO - PID 29487 | 19:09:10 INFO - PID 29487 | Cycle 1(1): loaded http://localhost:60007/tests/dromaeo/cssquery-yui.html (next: http://localhost:60007/tests/dromaeo/cssquery-dojo.html) 19:09:10 INFO - PID 29487 | RSS: Main: 177127424 19:09:10 INFO - PID 29487 | 19:09:10 INFO - PID 29487 | __start_tp_report 19:09:10 INFO - PID 29487 | _x_x_mozilla_page_load 19:09:10 INFO - PID 29487 | _x_x_mozilla_page_load_details 19:09:10 INFO - PID 29487 | |i|pagename|runs| 19:09:10 INFO - PID 29487 | |0;dojo.html;3106.1458099022766;3133.7022982816625;3166.445871972405;3170.3183815479674;3188.585483887096;6038.728257228424;6070.150178974947;6087.20866287382;6111.7249723762425;6117.480014198793;6105.633661980273;6247.562670613048;6255.906161407583;6264.498840092793;6282.623042617446;5606.803761868336;5663.490285874271;5724.284464441945;5730.083186690131;5772.509336706385;5539.224508568784;5574.832755017356;5610.102383618621;5660.943390566083;5674.432556744334;5673.971630141844;5684.971575142118;5687.203791469197;5688.374278829326;5689.772409103631;5534.280543529356;5611.7474713637985;5653.8586535336535;5675.659460432346;5678.772849086032;5524.558035357162;5541.307336582927;5546.972265138689;5563.5271001964475;5602.60781745278;6027.78902738402;6055.7274922628585;6059.424354686298;6082.270127584674;6099.664518451484;6565.244996825379;6598.8350291243105;6602.702878370437;6643.93356066438;6645;6609.272979972199;6612.933870661328;6623;6727;6737.427318677918;6066.4540191382985;6142.907856382158;6158.168647232566;6159.630422174684;6183.690815459254;6703.631300278532;6725.2602213756445;6759.493038022168;6761.5604985676755;6795.014722865157;6419.775307864203;6501.9674901625185;6520.380563846427;6545.083688283644;6553.737850485927;6539.313372095957;6556.114924485133;6567.901481477782;6628.270890202074;6648.83377915556;6430.324815894263;6530.967345163243;6531.934680653228;6532.706028228741;6533.934660653427;6477.967610162013;6547.639879806657;6557.606543607399;6558.147440832661;6565.868682626417;5280.524752772269;5377.7311134443125;5382.78468861249;5396.811111611075;5420.268263784417;4562.338460923148;4607.3319368691355;4625.7687115644085;4627.6066534344955;4631.282151266559;5644.153376993484;5725.942740572625;5752.913706294409;5831.94168058314;5839.620424672383;6602.735890564323;6612.404883560503;6668.066470694107;6683.365080317362;6685.799426017227;5691.630044047124;5742.942570574241;5762.279715035621;5795.39148389413;5799.043157878987;5846.94153058464;5883.882322353529;5891.057430811135;5893.233879595711;5910.468057874812;6405.167328247391;6428.164338636041;6479.384458476531;6501.804945851632;6521.021846722934;6481.4166724994975;6618.536702430976;6628.734850606114;6631.303713110054;6751.628660423527;6395.7121929514215;6408.29508754046;6422.2614399344675;6428.646424446701;6436.645984470899;6423.678816059085;6456.386643268882;6494.123293355526;6506.089147519446;6512.153420055552;6547.279799221987;6598.637074960923;6629.105070815378;6630.237522684953;6631.1379520662;6382.489400847828;6408.967955160194;6429.357064293533;6507.674616269073;6517.3808488193545;6236.812895613139;6419.614823110628;6499.415052645285;6515.641639709862;6523.054157147282;6285.057241413824;6352.110704501281;6374.075759014824;6383.776567820104;6394.648294343856;6475.708593113227;6478.060681201294;6565.474762018932;6570.868582628225;6572.539922205591;6248.094026366242;6290.21372328459;6336.683165841598;6351.364863513611;6358.046293056079 19:09:10 INFO - PID 29487 | |1;ext.html;808.5593351623364;864.5979619476942;891.3983061433535;891.6879092317688;1143.919925605208;29374.265643358925;30503;40880.18239635206;41804;41857.37213941786;41258;41713;41723;41791.37312940301;41811.16377672445;7150.284971502861;7256.274372562728;7663.655135518887;7674.232576742337;7676.923230767705;7599.848003039936;7705.383569314441;7710.807229819244;7713.845723085535;7803;7716.9614151929445;7747.535147891144;7781.2996830285265;7801.921980780205;7804.648790804427;7660.2722741339485;7664.770056898246;7687.846243075135;7709.807254818675;7734.033245844297;7572.318491335806;7632.961835190844;7667.156612772591;7678.462507624468;7679.808004799869;38245.808770956246;38367.232655346736;38399.04002399935;38544.614553854386;38619.03452413684;3590.120420496995;3628.963710362915;3629.1108678373967;3629.401148810443;3636.163682353047;31260.843695781605;31292.53061204084;31303.84348078245;31325.373492530023;31401.685983140334;4852.636052296092;5023.397192336906;5052.69683818972;5054.9241761373605;5134.717590532519;183234;183292;183489;183860;184099;47307.763461182476;47488;47541;47544.2868356968;47627.28559071547;49529.25706114411;54443;55652.44347556554;55881.44118558844;55886;14699.41202351894;16222.35110595563;16330.265138068815;16333.346666133222;16338.591535211715;12191.939040304742;13278.203307801563;13512.59462216135;13575.185488870698;13594.32028398576;14608.269586520631;14613.634659133395;14643.267836608127;14694.338754756061;14790.186539740418;5955.37468565803;6062.757489700451;6102.755889764359;6103.664298463627;6138.324784273726;999.0608827701936;1021.2544842265039;1024.2522958240377;1026.9281150319555;1031.0771859186136;22206.77793222047;23209.53580928372;29213.7078629211;29476.852615736785;30170.396592068475;1093.704699731068;1096.331237944853;1101.862267216598;1105.6959336182615;1121.725177331559;12307.815382769266;12470.563530276397;12485.750284994248;12522.248665080124;12682.365881705879;229708;230042;231385;232071;233891;50838;51326.74336628293;51347;51456.74271628618;51584;1398.6643205630576;1427.4789701758784;1439.0933711761732;1456.5266288456294;1471.8454562271022;22169.66745498851;22476;22694.432639184153;22880.199193028166;22892.771072289732;37368.81315593405;37592.2481550362;37602.24795504129;37620.62379376171;37708.81145594364;195556;196294;197044;197123;198446;29833;30452.543211851396;32405.18987025249;32766.50850237296;32937.83531082425;40764.796176020114;42046.57953420549;42535.787321063195;42578.78710606427;42717.35923961205;31382;31572.210694732814;31625.36749264956;32064.198395040312;32121.678783211868;30837;30879;31322.21694457657;31736.841315793274;31895.681043190198;33510.49734253939;34305;34493.310133797684;34586.82706586451;34595.48106778451;29899.103026909226;30235.69764302329;30301.393972119993;30358.392832143676;30442.695573043988;22179.556408872057;22787.27775306322;23097.769022309563;23142.76857231406;23570.646440303753 19:09:10 INFO - PID 29487 | |2;jquery.html;573.2748073686785;574.1301927579717;577.780443431496;582.8863371642531;598.6497898729243;21667.566648667016;22372.32883013508;22869;22899.885500572516;22900;26838.194854154357;27150.32124196896;27249.318767030833;27423.31441713958;27566.5865012025;6362.618242905429;6503.219613646345;6522.1195138656385;6539.738410463599;6552.737890484399;6249.2500899892075;6499.512536559753;6578.539502234846;6876.484263680244;6885.4491640668875;6845.657717114149;6885.208201056867;6892.655367231619;6903.827404314882;6904.827379315532;6872.072270243503;6878.071460352863;6884.724611015554;6889.345512176335;6889.414399776;6779.898301525481;6804.897926531056;6805.2173999989645;6808.183018037867;6816.863662726767;31470.37059258802;32013.679863201534;32293.192670183198;33709.32581348384;33977.66022339794;2019.929302474421;2063.6801295799173;2071.0887209627867;2071.3682326890294;2073.2743539761113;20064.59870802576;20911.790882091136;21280.46798830026;21336.786632133637;21376.679349809765;2523.028633975914;2539.3397716593818;2606.530824451598;2611.099170786076;2617.5811870100692;145616;149443.25278373648;149984;150085;150359.24820375827;19666.70499942502;22098.33704988853;22104.778952210592;22497.212597559006;22915.885420573122;45097.32354014692;45186.096278074256;45408.772956135006;45510;45677.314840277424;11568.942155289338;11918.510186226722;12180.81728774069;12212.57255996036;12275.69310767238;10106.090451859369;10180.490975451197;10221.284510084222;10221.897781022095;10323.174146068446;8609.526476043879;9274.965390055348;9382.202512786489;9428.292878034037;11392.430378481044;2641.4320921002077;2671.492416440909;2724.3325385280336;2764.25365151408;2767.1283545683045;940.1397721085131;972.1202311907734;973.9870534644033;984.4093543873619;988.3476905242649;19955.900220499094;20122.496937576678;20319.593608127754;20951.79048209529;21019.68470472944;1038.3302769713493;1042.890496497872;1045.8640376751125;1050.7425680708275;1054.0566193257146;11352.14858885587;11384.316940983568;11457.885421145682;11486.59796907121;11566.884331156749;432271;435938;438702;439440;449168;113658.43170784094;116595;118215;123059.3847030759;129882;1253.385840937952;1258.4148371007343;1299.1944994103906;1307.7115048664837;1314.677903913528;21094.683579746008;21355.35933921985;21364.359069227947;21406.892965535073;21697.240596579042;57182.42679079535;58207.417925821894;58595.70702146462;60571.69714151401;60912;70537;70631;70706.29293706997;70952;70962;14983.77524337114;15375.923120384774;15492.612684682974;15494.992825466308;15537.45618903333;23694.52610947737;24156.87921560381;24198.758012420356;24265.757342427056;24266.272011839672;18179.18193681314;18895.338663146726;19226.7115993263;19227.80772192316;19260.903695481433;16982.40561580339;17041.23314450828;17150.914245428692;17651.205695743465;17804.575633948993;19067.237310507426;19082.61834763269;19141.521461963006;19418;19429.02854857223;14494.275286235857;15180.696386071995;15247.542573722805;15254.161021143944;15461.149636770086;18874.43376698701;19002.809971900657;19061.714074289175;19360.70958935589;19410.611787764446 19:09:10 INFO - PID 29487 | |3;mootools.html;1358.8029735688326;1407.359651358632;1410.407628795906;1416.5042235217668;1433.1329545624897;13532.729345413085;14122.929385353085;14129.434822607109;14138.929305353471;14164.220967846764;14716.117032978029;14864.702705945874;14912;14962.251887405613;14980.775288370656;2753.5869619557025;2800.9439811203865;2805.3547684032583;2810.339570201001;2817.6618805743337;2693.4478431921407;2721.006832506131;2752;2752.229375774786;2766.7786577073884;2683.758461738443;2702.310910717774;2717.605947137664;2717.6738791345065;2742.6708794944534;2595.909143179989;2606.3093280280646;2627.947441051178;2629.9079532216474;2630.631711560383;2537.1500547316673;2556.5014822109697;2556.6292887531204;2569.743025697434;2573.2537564106387;13745;14029.368678409393;14039.157650541;14090.365933533016;14099.577012689635;7429.591372474511;7899.091604465445;7901.09137449195;7907.9604601976625;7910.485818421784;4934;5099.541041306263;5139.460356662571;5193.350831146106;5203.791848326063;1893.914773835167;1897.1462841721143;1912.139537208248;1941.6407964526609;1959.3925882976323;22196.445088872744;22505.887470562706;22551.661725074136;22554.77445225543;22675.206367777213;6358.523110766619;6380.55336126476;6467.417932386108;6619.569727967667;6642.202935647753;15469.14919679406;15482.922585387001;15488.845111548966;15500.379984800482;15509.224538773016;7267;7452.366548843409;7454.925450745423;7456.32893039629;7462.10454745434;5742.138679198154;5937.881242375129;6139.539534534839;6153.569250152446;6155.199824022849;4974.552290293818;5090.185570308807;5189.636725429259;5214.374275086938;5252.79185787271;1445.8337291211644;1482.0070552729696;1511.9017263877813;1519.8860085493632;1535.2170393099377;876.8684697295329;889.0442774017828;904.3036861616519;907.9286441998505;909.5861383070687;7050.612216328152;7143.107111611049;7151.2491188424465;7249.492535522569;7981.2018798119725;966.8888077870994;993.2600212841479;1019.5004447820663;1025.9384436933808;1037.0770014686934;4690.3433519306645;4819.445763737215;4834.395700537433;4924.261360795909;5000.89998200034;18352.174152163185;18858.434246972614;18864.434066977738;18992.050397480347;19002.61994760097;18463.90768046151;19648.90175549113;19700.113494892765;19854.60290794176;19873;10840.837387439195;10963.780724385468;10976.506057227285;10987.890121098846;11038.503267352988;7834.1382447929545;7840.490368126054;8044.517328960281;8067.394945379003;8096.109427962801;16455.917720411322;16829.495115146565;16841.831581684026;17189.65620687554;17197.742033869752;16809.663806724042;16976.23606937666;17217;17280.395186168425;17630.382936597158;11327.32036077805;11520.366379849189;11524.250923689933;11538.07695384384;11545.48045337945;13203.66990825237;13275.734485310433;13296.468141274241;13310.866891330963;13414.329283535979;10561.788764224826;10865.348079115278;10989.791122976627;11056.226064175431;11111.666550024585;10643.467826608794;10746.46267686597;10834.566617335533;10841.403722795321;10875.782484350428;9055.320850936338;9119.954400227956;9125.361224714206;9126.726198214064;9190.31072669539;6924.896126558005;6974;6981.5461994970165;6991.755288564876;7000.649967501707;6854.9657251713425;6937.895931561132;6961.965190174017;7033.507654464343;7070.68181931804 19:09:10 INFO - PID 29487 | |4;prototype.html;476.8569429171248;490.2578213562507;513.7174553995302;516.0221380483982;516.5376987596102;5929.703514824263;6099.298580663225;6108.694565271735;6129.693515324233;6174.969125154379;5863.442972917566;5954.70226488676;5995.3405125436275;6007.939920600804;6013.248343957005;4812.326274321597;4818.373611430509;4818.855434336975;4826.420829500465;4888.951110488885;4628.143793398232;4790.209615413452;4791.185498465252;4822.300766388871;4828.927566086511;4738.691985020962;4755.5244475552345;4803.495632958541;4818.759062046901;4838.806447742104;4719.268513380432;4751.643626727992;4812.639052071108;4837.879053023667;4884.511548845087;4239.47006624172;4251.97874010631;4276.465441819772;4346.76092814895;4384.802683879233;5929.132323318184;5955.702214889238;5955.987482128048;5966.3138739045135;5999.580029397944;5567.805126820542;5596.244506991545;5617.719114044281;5630.296212973379;5631.802886898939;6239.968800156015;6260.561760676755;6333.271673757531;6385.659011607568;6386.190076366431;4675.13510000651;4709.293605959099;4729.929051064237;4742.312364707098;4773.260144677581;6511.93488065118;6620.933790662128;6713.932860671429;6729.798106056777;6772;4820.68665536739;4856.562909338177;4863.732494712754;4865.318855360252;4887.780049897692;4950.232713929347;4952.306677065214;4962.032403681247;4969.478204788517;4993.550580447777;5498;5537.197106419547;5568.55451563882;5574.191742197439;5593.692346920959;6361.522885783585;6434.935650643527;6485.578437401554;6498.902516462257;6522.673866306665;1607.847254510843;1640.6226567889214;1676.4719113479216;1715.9656806863793;1735.514056064304;1191.541256616209;1192.928424294545;1196.8683444821063;1212.6180253220207;1221.7190046289404;5570.944290557123;5577.386487486373;5598.636088654224;5606.775728970795;5741.913871291934;6326.746930122744;6486.119025482557;6491.397274512597;6568.8357791055605;6576.80269591913;5613.58615795212;5690.430956904276;5692.288463942007;5756.539476841843;5768.509676677446;3482.231625857449;3485.2680937003515;3491.755577109578;3510.297940411877;3538;6292.930201865694;6336.936630633727;6339.904901426482;6421.422072013541;6457.257415397289;6759.594424334556;6764.932350676529;6784.762533311409;6786.355296246848;6788.7284508619105;6336.718781238843;6405;6413.518986075969;6478.611283323015;6523.315051919575;6597.340265973365;6603.603783772989;6623.3376662333385;6642.368974947372;6686.598804071771;6452.677366131768;6453.386928241809;6457.612543247233;6503.382178693017;6507.5683349662995;6424.807255782334;6455.9677201613695;6457.515686323451;6485.254195767548;6529.738810447719;4872.14737420957;4883.462819089827;4901.362822833152;4924.803007879645;4935.654504184673;6502.544821862424;6544.8363790905605;6556.704948277435;6615.966920165369;6621.27166011748;6217.96891015542;6296.590721603081;6360.713767880549;6367.617942923254;6374.948133558097;6357.427831495188;6403.807885763435;6409.4231519163495;6416.967915160394;6442.967785161044;6081.5742897996715;6155.937760850165;6261.373862613885;6276.340984196776;6312.715927783169;6193.194884664965;6240.375962403723;6352.142460767737;6373;6424.743010279536;6249.750009999549;6268.247810262797;6269.871423143878;6293.590916590407;6296.710762959136 19:09:10 INFO - PID 29487 | |5;yui.html;905.0994260710589;913.8720579118923;925.0841666749917;930.9441433513986;934.112593036615;18313.267469301227;19013.904930475364;19036.33372831953;19055.809441905578;21731.13075476983;21292.680609790867;22051.558968820653;22181.1127554898;22219.333419997387;22231.555368892612;1026.7279171019686;1062.044160255772;1062.8140075486758;1063.0645032371501;1063.4363787192801;1021.6219998600528;1065.9946700266487;1066.6426747039711;1067.8718553773558;1068.3216157739853;1119.9104071674287;1122.6463663945872;1122.7698321844043;1122.9157813164004;1123.2418117770512;1114.3592434350242;1117.1509652663992;1118.0943435816932;1119.12148963064;1121.960731374398;819.1071731812353;819.6024927909959;820.2453742556802;820.3519219816338;822.1696086952162;19602.90198548998;19698;19874;20074.096665650082;20522;21189.258375956768;21501.46246343854;21818.345449636538;22027.66958495624;22076.33770986873;16481.91759041209;16517;16677.833221667748;16689.49931502057;16790.41233556832;3549.7870127792157;3578.8926332209817;3581.856725730968;3589.533360663097;3600.531930848973;127202;127681;131637.34181329128;132156.99999999904;133284.33357833244;15985.60035999086;16511.09188994593;16671.166441677866;16990.49028529146;17194.656106877792;30786.076417707503;31177.8441107793;31327.37345253082;32248.193795155308;32292.192695182337;7703.57630330326;8094.919050809534;8428.241458268663;8525.531095789791;8842.867356989651;4299.9570004300185;4364.258076127066;4379.430674012422;4384.846530371422;4392.07766369066;5327.680339179662;5344.251804747339;5353.81261655848;5417.10617748075;5458.754356053987;1048.3866937841296;1048.984265236022;1051.3429106808244;1073.350622873166;1084.1218612923558;664.1001443044702;686.5983399711125;702.1328659106;705.8976448415053;707.2361849202952;11424.257423267461;11483.368414737102;11650.941745291218;11880.168388212742;12316.692082698004;637.079420237752;638.7476946606065;651.9022146678036;653.3270731146927;654.6922946215271;5425.294711687534;5752.511036561939;5824.534037277008;6435.6138631681315;6441.516886233551;102868;103817.48091259495;104895;104970;106580.73677052987;89032;91023.54488227516;91653.54173229224;92322;93145.53427232821;77495;77551.61224193843;79692.20307796847;80157.59921200473;80837.19162808296;12157.574484893341;12659.367031648564;12676.87323126757;12716.554920578106;13211.867881321064;34301.142471437415;34308.65691343154;35840.566377344614;37021.62978370182;37234.813825930694;64761;65858;67373.66313168402;69829.65085174542;70003.29996699968;19215.711764323267;19564.706529402356;19870.701939471208;20099.095540700997;20200.29298974529;21660.891695542054;21706.34880953574;22400.663990040488;22524.887375563674;22622.208222712125;19475.415737527896;19975.800241997393;20134.993250337717;20456.181752729724;20475.488112796702;19640;20015.899920500306;20313;20348.389548313575;20550.897245513675;18855.24579016879;19181.040947952824;19747.605047899247;19843.900780496584;19987;14181.929090354895;14424.495142669955;14523.201223932785;14628.122312661275;14819.25903704832;13492.797608035691;14369.56891293263;14550.85449145495;14677.853221467649;15010.324535395715 19:09:10 INFO - PID 29487 | __end_tp_report 19:09:10 INFO - PID 29487 | __start_cc_report 19:09:10 INFO - PID 29487 | _x_x_mozilla_cycle_collect,405 19:09:10 INFO - PID 29487 | __end_cc_report 19:09:10 INFO - PID 29487 | __startTimestamp1501812550960__endTimestamp 19:09:10 INFO - PID 29487 | 19:09:10 INFO - PID 29487 | ------- Summary: start ------- 19:09:10 INFO - PID 29487 | Number of tests: 6 19:09:10 INFO - PID 29487 | 19:09:10 INFO - PID 29487 | [#0] dojo.html Cycles:165 Average:6083.49 Median:6358.05 stddev:707.12 (11.1%) stddev-sans-first:669.61 19:09:10 INFO - PID 29487 | Values: 3106.1 3133.7 3166.4 3170.3 3188.6 6038.7 6070.2 6087.2 6111.7 6117.5 6105.6 6247.6 6255.9 6264.5 6282.6 5606.8 5663.5 5724.3 5730.1 5772.5 5539.2 5574.8 5610.1 5660.9 5674.4 5674.0 5685.0 5687.2 5688.4 5689.8 5534.3 5611.7 5653.9 5675.7 5678.8 5524.6 5541.3 5547.0 5563.5 5602.6 6027.8 6055.7 6059.4 6082.3 6099.7 6565.2 6598.8 6602.7 6643.9 6645.0 6609.3 6612.9 6623.0 6727.0 6737.4 6066.5 6142.9 6158.2 6159.6 6183.7 6703.6 6725.3 6759.5 6761.6 6795.0 6419.8 6502.0 6520.4 6545.1 6553.7 6539.3 6556.1 6567.9 6628.3 6648.8 6430.3 6531.0 6531.9 6532.7 6533.9 6478.0 6547.6 6557.6 6558.1 6565.9 5280.5 5377.7 5382.8 5396.8 5420.3 4562.3 4607.3 4625.8 4627.6 4631.3 5644.2 5725.9 5752.9 5831.9 5839.6 6602.7 6612.4 6668.1 6683.4 6685.8 5691.6 5742.9 5762.3 5795.4 5799.0 5846.9 5883.9 5891.1 5893.2 5910.5 6405.2 6428.2 6479.4 6501.8 6521.0 6481.4 6618.5 6628.7 6631.3 6751.6 6395.7 6408.3 6422.3 6428.6 6436.6 6423.7 6456.4 6494.1 6506.1 6512.2 6547.3 6598.6 6629.1 6630.2 6631.1 6382.5 6409.0 6429.4 6507.7 6517.4 6236.8 6419.6 6499.4 6515.6 6523.1 6285.1 6352.1 6374.1 6383.8 6394.6 6475.7 6478.1 6565.5 6570.9 6572.5 6248.1 6290.2 6336.7 6351.4 6358.0 19:09:10 INFO - PID 29487 | 19:09:10 INFO - PID 29487 | [#1] ext.html Cycles:180 Average:37184.03 Median:32852.17 stddev:53090.82 (161.6%) stddev-sans-first:53169.50 19:09:10 INFO - PID 29487 | Values: 808.6 864.6 891.4 891.7 1143.9 29374.3 30503.0 40880.2 41804.0 41857.4 41258.0 41713.0 41723.0 41791.4 41811.2 7150.3 7256.3 7663.7 7674.2 7676.9 7599.8 7705.4 7710.8 7713.8 7803.0 7717.0 7747.5 7781.3 7801.9 7804.6 7660.3 7664.8 7687.8 7709.8 7734.0 7572.3 7633.0 7667.2 7678.5 7679.8 38245.8 38367.2 38399.0 38544.6 38619.0 3590.1 3629.0 3629.1 3629.4 3636.2 31260.8 31292.5 31303.8 31325.4 31401.7 4852.6 5023.4 5052.7 5054.9 5134.7 183234.0 183292.0 183489.0 183860.0 184099.0 47307.8 47488.0 47541.0 47544.3 47627.3 49529.3 54443.0 55652.4 55881.4 55886.0 14699.4 16222.4 16330.3 16333.3 16338.6 12191.9 13278.2 13512.6 13575.2 13594.3 14608.3 14613.6 14643.3 14694.3 14790.2 5955.4 6062.8 6102.8 6103.7 6138.3 999.1 1021.3 1024.3 1026.9 1031.1 22206.8 23209.5 29213.7 29476.9 30170.4 1093.7 1096.3 1101.9 1105.7 1121.7 12307.8 12470.6 12485.8 12522.2 12682.4 229708.0 230042.0 231385.0 232071.0 233891.0 50838.0 51326.7 51347.0 51456.7 51584.0 1398.7 1427.5 1439.1 1456.5 1471.8 22169.7 22476.0 22694.4 22880.2 22892.8 37368.8 37592.2 37602.2 37620.6 37708.8 195556.0 196294.0 197044.0 197123.0 198446.0 29833.0 30452.5 32405.2 32766.5 32937.8 40764.8 42046.6 42535.8 42578.8 42717.4 31382.0 31572.2 31625.4 32064.2 32121.7 30837.0 30879.0 31322.2 31736.8 31895.7 33510.5 34305.0 34493.3 34586.8 34595.5 29899.1 30235.7 30301.4 30358.4 30442.7 22179.6 22787.3 23097.8 23142.8 23570.6 19:09:10 INFO - PID 29487 | 19:09:10 INFO - PID 29487 | [#2] jquery.html Cycles:180 Average:35233.56 Median:22434.77 stddev:75251.84 (335.4%) stddev-sans-first:75417.95 19:09:10 INFO - PID 29487 | Values: 573.3 574.1 577.8 582.9 598.6 21667.6 22372.3 22869.0 22899.9 22900.0 26838.2 27150.3 27249.3 27423.3 27566.6 6362.6 6503.2 6522.1 6539.7 6552.7 6249.3 6499.5 6578.5 6876.5 6885.4 6845.7 6885.2 6892.7 6903.8 6904.8 6872.1 6878.1 6884.7 6889.3 6889.4 6779.9 6804.9 6805.2 6808.2 6816.9 31470.4 32013.7 32293.2 33709.3 33977.7 2019.9 2063.7 2071.1 2071.4 2073.3 20064.6 20911.8 21280.5 21336.8 21376.7 2523.0 2539.3 2606.5 2611.1 2617.6 145616.0 149443.3 149984.0 150085.0 150359.2 19666.7 22098.3 22104.8 22497.2 22915.9 45097.3 45186.1 45408.8 45510.0 45677.3 11568.9 11918.5 12180.8 12212.6 12275.7 10106.1 10180.5 10221.3 10221.9 10323.2 8609.5 9275.0 9382.2 9428.3 11392.4 2641.4 2671.5 2724.3 2764.3 2767.1 940.1 972.1 974.0 984.4 988.3 19955.9 20122.5 20319.6 20951.8 21019.7 1038.3 1042.9 1045.9 1050.7 1054.1 11352.1 11384.3 11457.9 11486.6 11566.9 432271.0 435938.0 438702.0 439440.0 449168.0 113658.4 116595.0 118215.0 123059.4 129882.0 1253.4 1258.4 1299.2 1307.7 1314.7 21094.7 21355.4 21364.4 21406.9 21697.2 57182.4 58207.4 58595.7 60571.7 60912.0 70537.0 70631.0 70706.3 70952.0 70962.0 14983.8 15375.9 15492.6 15495.0 15537.5 23694.5 24156.9 24198.8 24265.8 24266.3 18179.2 18895.3 19226.7 19227.8 19260.9 16982.4 17041.2 17150.9 17651.2 17804.6 19067.2 19082.6 19141.5 19418.0 19429.0 14494.3 15180.7 15247.5 15254.2 15461.1 18874.4 19002.8 19061.7 19360.7 19410.6 19:09:10 INFO - PID 29487 | 19:09:10 INFO - PID 29487 | [#3] mootools.html Cycles:180 Average:8670.41 Median:2563.19 stddev:5906.72 (230.4%) stddev-sans-first:5897.74 19:09:10 INFO - PID 29487 | Values: 1358.8 1407.4 1410.4 1416.5 1433.1 13532.7 14122.9 14129.4 14138.9 14164.2 14716.1 14864.7 14912.0 14962.3 14980.8 2753.6 2800.9 2805.4 2810.3 2817.7 2693.4 2721.0 2752.0 2752.2 2766.8 2683.8 2702.3 2717.6 2717.7 2742.7 2595.9 2606.3 2627.9 2629.9 2630.6 2537.2 2556.5 2556.6 2569.7 2573.3 13745.0 14029.4 14039.2 14090.4 14099.6 7429.6 7899.1 7901.1 7908.0 7910.5 4934.0 5099.5 5139.5 5193.4 5203.8 1893.9 1897.1 1912.1 1941.6 1959.4 22196.4 22505.9 22551.7 22554.8 22675.2 6358.5 6380.6 6467.4 6619.6 6642.2 15469.1 15482.9 15488.8 15500.4 15509.2 7267.0 7452.4 7454.9 7456.3 7462.1 5742.1 5937.9 6139.5 6153.6 6155.2 4974.6 5090.2 5189.6 5214.4 5252.8 1445.8 1482.0 1511.9 1519.9 1535.2 876.9 889.0 904.3 907.9 909.6 7050.6 7143.1 7151.2 7249.5 7981.2 966.9 993.3 1019.5 1025.9 1037.1 4690.3 4819.4 4834.4 4924.3 5000.9 18352.2 18858.4 18864.4 18992.1 19002.6 18463.9 19648.9 19700.1 19854.6 19873.0 10840.8 10963.8 10976.5 10987.9 11038.5 7834.1 7840.5 8044.5 8067.4 8096.1 16455.9 16829.5 16841.8 17189.7 17197.7 16809.7 16976.2 17217.0 17280.4 17630.4 11327.3 11520.4 11524.3 11538.1 11545.5 13203.7 13275.7 13296.5 13310.9 13414.3 10561.8 10865.3 10989.8 11056.2 11111.7 10643.5 10746.5 10834.6 10841.4 10875.8 9055.3 9120.0 9125.4 9126.7 9190.3 6924.9 6974.0 6981.5 6991.8 7000.6 6855.0 6937.9 6962.0 7033.5 7070.7 19:09:10 INFO - PID 29487 | 19:09:10 INFO - PID 29487 | [#4] prototype.html Cycles:180 Average:5376.13 Median:5961.15 stddev:1516.22 (25.4%) stddev-sans-first:1475.21 19:09:10 INFO - PID 29487 | Values: 476.9 490.3 513.7 516.0 516.5 5929.7 6099.3 6108.7 6129.7 6175.0 5863.4 5954.7 5995.3 6007.9 6013.2 4812.3 4818.4 4818.9 4826.4 4889.0 4628.1 4790.2 4791.2 4822.3 4828.9 4738.7 4755.5 4803.5 4818.8 4838.8 4719.3 4751.6 4812.6 4837.9 4884.5 4239.5 4252.0 4276.5 4346.8 4384.8 5929.1 5955.7 5956.0 5966.3 5999.6 5567.8 5596.2 5617.7 5630.3 5631.8 6240.0 6260.6 6333.3 6385.7 6386.2 4675.1 4709.3 4729.9 4742.3 4773.3 6511.9 6620.9 6713.9 6729.8 6772.0 4820.7 4856.6 4863.7 4865.3 4887.8 4950.2 4952.3 4962.0 4969.5 4993.6 5498.0 5537.2 5568.6 5574.2 5593.7 6361.5 6434.9 6485.6 6498.9 6522.7 1607.8 1640.6 1676.5 1716.0 1735.5 1191.5 1192.9 1196.9 1212.6 1221.7 5570.9 5577.4 5598.6 5606.8 5741.9 6326.7 6486.1 6491.4 6568.8 6576.8 5613.6 5690.4 5692.3 5756.5 5768.5 3482.2 3485.3 3491.8 3510.3 3538.0 6292.9 6336.9 6339.9 6421.4 6457.3 6759.6 6764.9 6784.8 6786.4 6788.7 6336.7 6405.0 6413.5 6478.6 6523.3 6597.3 6603.6 6623.3 6642.4 6686.6 6452.7 6453.4 6457.6 6503.4 6507.6 6424.8 6456.0 6457.5 6485.3 6529.7 4872.1 4883.5 4901.4 4924.8 4935.7 6502.5 6544.8 6556.7 6616.0 6621.3 6218.0 6296.6 6360.7 6367.6 6374.9 6357.4 6403.8 6409.4 6417.0 6443.0 6081.6 6155.9 6261.4 6276.3 6312.7 6193.2 6240.4 6352.1 6373.0 6424.7 6249.8 6268.2 6269.9 6293.6 6296.7 19:09:10 INFO - PID 29487 | 19:09:10 INFO - PID 29487 | [#5] yui.html Cycles:180 Average:23559.43 Median:20465.83 stddev:31135.65 (152.1%) stddev-sans-first:31176.52 19:09:10 INFO - PID 29487 | Values: 905.1 913.9 925.1 930.9 934.1 18313.3 19013.9 19036.3 19055.8 21731.1 21292.7 22051.6 22181.1 22219.3 22231.6 1026.7 1062.0 1062.8 1063.1 1063.4 1021.6 1066.0 1066.6 1067.9 1068.3 1119.9 1122.6 1122.8 1122.9 1123.2 1114.4 1117.2 1118.1 1119.1 1122.0 819.1 819.6 820.2 820.4 822.2 19602.9 19698.0 19874.0 20074.1 20522.0 21189.3 21501.5 21818.3 22027.7 22076.3 16481.9 16517.0 16677.8 16689.5 16790.4 3549.8 3578.9 3581.9 3589.5 3600.5 127202.0 127681.0 131637.3 132157.0 133284.3 15985.6 16511.1 16671.2 16990.5 17194.7 30786.1 31177.8 31327.4 32248.2 32292.2 7703.6 8094.9 8428.2 8525.5 8842.9 4300.0 4364.3 4379.4 4384.8 4392.1 5327.7 5344.3 5353.8 5417.1 5458.8 1048.4 1049.0 1051.3 1073.4 1084.1 664.1 686.6 702.1 705.9 707.2 11424.3 11483.4 11650.9 11880.2 12316.7 637.1 638.7 651.9 653.3 654.7 5425.3 5752.5 5824.5 6435.6 6441.5 102868.0 103817.5 104895.0 104970.0 106580.7 89032.0 91023.5 91653.5 92322.0 93145.5 77495.0 77551.6 79692.2 80157.6 80837.2 12157.6 12659.4 12676.9 12716.6 13211.9 34301.1 34308.7 35840.6 37021.6 37234.8 64761.0 65858.0 67373.7 69829.7 70003.3 19215.7 19564.7 19870.7 20099.1 20200.3 21660.9 21706.3 22400.7 22524.9 22622.2 19475.4 19975.8 20135.0 20456.2 20475.5 19640.0 20015.9 20313.0 20348.4 20550.9 18855.2 19181.0 19747.6 19843.9 19987.0 14181.9 14424.5 14523.2 14628.1 14819.3 13492.8 14369.6 14550.9 14677.9 15010.3 19:09:10 INFO - PID 29487 | -------- Summary: end -------- 19:09:10 INFO - PID 29487 | 19:09:11 INFO - TEST-INFO | 29487: exit 0 19:09:11 INFO - TEST-OK | dromaeo_css | took 1113981ms 19:09:11 INFO - TEST-START | kraken 19:09:11 INFO - Initialising browser for kraken test... 19:09:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60007/getInfo.html -profile /tmp/tmp6HQvZT/profile 19:09:11 INFO - TEST-INFO | started process 29860 (/builds/slave/test/build/application/firefox/firefox http://localhost:60007/getInfo.html) 19:09:17 INFO - TEST-INFO | 29860: exit 0 19:09:17 INFO - Browser initialized. 19:09:17 INFO - Running cycle 1/1 for kraken test... 19:09:17 INFO - TEST-INFO | started process 30087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6HQvZT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:09:18 INFO - PID 30087 | 19:09:18 INFO - PID 30087 | (/builds/slave/test/build/application/firefox/firefox:30142): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:09:18 INFO - PID 30087 | 19:09:29 INFO - PID 30087 | RSS: Main: 173998080 19:09:29 INFO - PID 30087 | 19:09:31 INFO - PID 30087 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60007/tests/kraken/driver.html?testName=audio-beat-detection) 19:09:32 INFO - PID 30087 | RSS: Main: 178970624 19:09:32 INFO - PID 30087 | 19:09:35 INFO - PID 30087 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60007/tests/kraken/driver.html?testName=audio-dft) 19:09:36 INFO - PID 30087 | RSS: Main: 179302400 19:09:36 INFO - PID 30087 | 19:09:39 INFO - PID 30087 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60007/tests/kraken/driver.html?testName=audio-fft) 19:09:39 INFO - PID 30087 | RSS: Main: 174637056 19:09:39 INFO - PID 30087 | 19:09:42 INFO - PID 30087 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60007/tests/kraken/driver.html?testName=audio-oscillator) 19:09:42 INFO - PID 30087 | RSS: Main: 174759936 19:09:42 INFO - PID 30087 | 19:09:44 INFO - PID 30087 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60007/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:09:45 INFO - PID 30087 | RSS: Main: 175247360 19:09:45 INFO - PID 30087 | 19:09:48 INFO - PID 30087 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60007/tests/kraken/driver.html?testName=imaging-darkroom) 19:09:49 INFO - PID 30087 | RSS: Main: 178171904 19:09:49 INFO - PID 30087 | 19:09:52 INFO - PID 30087 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60007/tests/kraken/driver.html?testName=imaging-desaturate) 19:09:53 INFO - PID 30087 | RSS: Main: 177070080 19:09:53 INFO - PID 30087 | 19:09:56 INFO - PID 30087 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60007/tests/kraken/driver.html?testName=json-parse-financial) 19:09:57 INFO - PID 30087 | RSS: Main: 178196480 19:09:57 INFO - PID 30087 | 19:09:58 INFO - PID 30087 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60007/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:09:59 INFO - PID 30087 | RSS: Main: 177991680 19:09:59 INFO - PID 30087 | 19:10:01 INFO - PID 30087 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60007/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:10:01 INFO - PID 30087 | RSS: Main: 174886912 19:10:01 INFO - PID 30087 | 19:10:04 INFO - PID 30087 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60007/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:10:04 INFO - PID 30087 | RSS: Main: 174841856 19:10:04 INFO - PID 30087 | 19:10:07 INFO - PID 30087 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:10:08 INFO - PID 30087 | RSS: Main: 175427584 19:10:08 INFO - PID 30087 | 19:10:11 INFO - PID 30087 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:10:11 INFO - PID 30087 | RSS: Main: 175493120 19:10:11 INFO - PID 30087 | 19:10:13 INFO - PID 30087 | Cycle 1(1): loaded http://localhost:60007/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60007/tests/kraken/driver.html?testName=ai-astar) 19:10:14 INFO - PID 30087 | RSS: Main: 176619520 19:10:14 INFO - PID 30087 | 19:10:14 INFO - PID 30087 | __start_tp_report 19:10:14 INFO - PID 30087 | _x_x_mozilla_page_load 19:10:14 INFO - PID 30087 | _x_x_mozilla_page_load_details 19:10:14 INFO - PID 30087 | |i|pagename|runs| 19:10:14 INFO - PID 30087 | |0;ai-astar;100;120;102;109;109;109;115;100;109;110 19:10:14 INFO - PID 30087 | |1;audio-beat-detection;158;128;142;165;121;159;144;123;174;119 19:10:14 INFO - PID 30087 | |2;audio-dft;167;163;163;163;171;166;172;174;166;169 19:10:14 INFO - PID 30087 | |3;audio-fft;80;75;75;161;76;78;77;89;100;81 19:10:14 INFO - PID 30087 | |4;audio-oscillator;80;81;134;85;86;80;131;78;79;129 19:10:14 INFO - PID 30087 | |5;imaging-gaussian-blur;113;114;117;117;121;114;115;119;115;114 19:10:14 INFO - PID 30087 | |6;imaging-darkroom;153;153;153;150;152;151;151;150;153;150 19:10:14 INFO - PID 30087 | |7;imaging-desaturate;94;95;95;97;95;94;94;99;96;94 19:10:14 INFO - PID 30087 | |8;json-parse-financial;55;53;54;55;54;57;54;54;55;55 19:10:14 INFO - PID 30087 | |9;json-stringify-tinderbox;55;54;60;54;53;54;54;53;63;58 19:10:14 INFO - PID 30087 | |10;stanford-crypto-aes;83;80;80;79;82;78;79;89;79;96 19:10:14 INFO - PID 30087 | |11;stanford-crypto-ccm;139;137;144;138;128;125;128;140;131;171 19:10:14 INFO - PID 30087 | |12;stanford-crypto-pbkdf2;181;172;170;177;177;178;173;170;184;183 19:10:14 INFO - PID 30087 | |13;stanford-crypto-sha256-iterative;71;68;70;67;67;66;66;67;71;73 19:10:14 INFO - PID 30087 | __end_tp_report 19:10:14 INFO - PID 30087 | __start_cc_report 19:10:14 INFO - PID 30087 | _x_x_mozilla_cycle_collect,979 19:10:14 INFO - PID 30087 | __end_cc_report 19:10:14 INFO - PID 30087 | __startTimestamp1501812614080__endTimestamp 19:10:14 INFO - PID 30087 | 19:10:14 INFO - PID 30087 | ------- Summary: start ------- 19:10:14 INFO - PID 30087 | Number of tests: 14 19:10:14 INFO - PID 30087 | 19:10:14 INFO - PID 30087 | [#0] ai-astar Cycles:10 Average:108.30 Median:109.00 stddev:6.36 (5.8%) stddev-sans-first:6.00 19:10:14 INFO - PID 30087 | Values: 100.0 120.0 102.0 109.0 109.0 109.0 115.0 100.0 109.0 110.0 19:10:14 INFO - PID 30087 | 19:10:14 INFO - PID 30087 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:151.00 stddev:20.03 (13.3%) stddev-sans-first:20.53 19:10:14 INFO - PID 30087 | Values: 158.0 128.0 142.0 165.0 121.0 159.0 144.0 123.0 174.0 119.0 19:10:14 INFO - PID 30087 | 19:10:14 INFO - PID 30087 | [#2] audio-dft Cycles:10 Average:167.40 Median:168.00 stddev:3.98 (2.4%) stddev-sans-first:4.22 19:10:14 INFO - PID 30087 | Values: 167.0 163.0 163.0 163.0 171.0 166.0 172.0 174.0 166.0 169.0 19:10:14 INFO - PID 30087 | 19:10:14 INFO - PID 30087 | [#3] audio-fft Cycles:10 Average:89.20 Median:77.50 stddev:26.41 (34.1%) stddev-sans-first:27.80 19:10:14 INFO - PID 30087 | Values: 80.0 75.0 75.0 161.0 76.0 78.0 77.0 89.0 100.0 81.0 19:10:14 INFO - PID 30087 | 19:10:14 INFO - PID 30087 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:80.00 stddev:24.33 (30.4%) stddev-sans-first:25.08 19:10:14 INFO - PID 30087 | Values: 80.0 81.0 134.0 85.0 86.0 80.0 131.0 78.0 79.0 129.0 19:10:14 INFO - PID 30087 | 19:10:14 INFO - PID 30087 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:116.00 stddev:2.56 (2.2%) stddev-sans-first:2.49 19:10:14 INFO - PID 30087 | Values: 113.0 114.0 117.0 117.0 121.0 114.0 115.0 119.0 115.0 114.0 19:10:14 INFO - PID 30087 | 19:10:14 INFO - PID 30087 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:152.50 stddev:1.35 (0.9%) stddev-sans-first:1.33 19:10:14 INFO - PID 30087 | Values: 153.0 153.0 153.0 150.0 152.0 151.0 151.0 150.0 153.0 150.0 19:10:14 INFO - PID 30087 | 19:10:14 INFO - PID 30087 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.64 (1.7%) stddev-sans-first:1.67 19:10:14 INFO - PID 30087 | Values: 94.0 95.0 95.0 97.0 95.0 94.0 94.0 99.0 96.0 94.0 19:10:14 INFO - PID 30087 | 19:10:14 INFO - PID 30087 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:1.07 (2.0%) stddev-sans-first:1.13 19:10:14 INFO - PID 30087 | Values: 55.0 53.0 54.0 55.0 54.0 57.0 54.0 54.0 55.0 55.0 19:10:14 INFO - PID 30087 | 19:10:14 INFO - PID 30087 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:54.50 stddev:3.39 (6.2%) stddev-sans-first:3.59 19:10:14 INFO - PID 30087 | Values: 55.0 54.0 60.0 54.0 53.0 54.0 54.0 53.0 63.0 58.0 19:10:14 INFO - PID 30087 | 19:10:14 INFO - PID 30087 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:81.00 stddev:5.72 (7.1%) stddev-sans-first:6.06 19:10:14 INFO - PID 30087 | Values: 83.0 80.0 80.0 79.0 82.0 78.0 79.0 89.0 79.0 96.0 19:10:14 INFO - PID 30087 | 19:10:14 INFO - PID 30087 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:138.50 stddev:13.12 (9.5%) stddev-sans-first:13.91 19:10:14 INFO - PID 30087 | Values: 139.0 137.0 144.0 138.0 128.0 125.0 128.0 140.0 131.0 171.0 19:10:14 INFO - PID 30087 | 19:10:14 INFO - PID 30087 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.50 Median:177.50 stddev:5.15 (2.9%) stddev-sans-first:5.20 19:10:14 INFO - PID 30087 | Values: 181.0 172.0 170.0 177.0 177.0 178.0 173.0 170.0 184.0 183.0 19:10:14 INFO - PID 30087 | 19:10:14 INFO - PID 30087 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:2.46 (3.6%) stddev-sans-first:2.45 19:10:14 INFO - PID 30087 | Values: 71.0 68.0 70.0 67.0 67.0 66.0 66.0 67.0 71.0 73.0 19:10:14 INFO - PID 30087 | -------- Summary: end -------- 19:10:14 INFO - PID 30087 | 19:10:14 INFO - PID 30087 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:10:14 INFO - TEST-INFO | 30087: exit 0 19:10:14 INFO - TEST-OK | kraken | took 63175ms 19:10:14 INFO - SUITE-END | took 1177s 19:10:15 INFO - Completed test suite (00:19:37) 19:10:15 INFO - javascript benchmark 19:10:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8542.87951136616, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3106.1458099022766, 3133.7022982816625, 3166.445871972405, 3170.3183815479674, 3188.585483887096, 6038.728257228424, 6070.150178974947, 6087.20866287382, 6111.7249723762425, 6117.480014198793, 6105.633661980273, 6247.562670613048, 6255.906161407583, 6264.498840092793, 6282.623042617446, 5606.803761868336, 5663.490285874271, 5724.284464441945, 5730.083186690131, 5772.509336706385, 5539.224508568784, 5574.832755017356, 5610.102383618621, 5660.943390566083, 5674.432556744334, 5673.971630141844, 5684.971575142118, 5687.203791469197, 5688.374278829326, 5689.772409103631, 5534.280543529356, 5611.7474713637985, 5653.8586535336535, 5675.659460432346, 5678.772849086032, 5524.558035357162, 5541.307336582927, 5546.972265138689, 5563.5271001964475, 5602.60781745278, 6027.78902738402, 6055.7274922628585, 6059.424354686298, 6082.270127584674, 6099.664518451484, 6565.244996825379, 6598.8350291243105, 6602.702878370437, 6643.93356066438, 6645.0, 6609.272979972199, 6612.933870661328, 6623.0, 6727.0, 6737.427318677918, 6066.4540191382985, 6142.907856382158, 6158.168647232566, 6159.630422174684, 6183.690815459254, 6703.631300278532, 6725.2602213756445, 6759.493038022168, 6761.5604985676755, 6795.014722865157, 6419.775307864203, 6501.9674901625185, 6520.380563846427, 6545.083688283644, 6553.737850485927, 6539.313372095957, 6556.114924485133, 6567.901481477782, 6628.270890202074, 6648.83377915556, 6430.324815894263, 6530.967345163243, 6531.934680653228, 6532.706028228741, 6533.934660653427, 6477.967610162013, 6547.639879806657, 6557.606543607399, 6558.147440832661, 6565.868682626417, 5280.524752772269, 5377.7311134443125, 5382.78468861249, 5396.811111611075, 5420.268263784417, 4562.338460923148, 4607.3319368691355, 4625.7687115644085, 4627.6066534344955, 4631.282151266559, 5644.153376993484, 5725.942740572625, 5752.913706294409, 5831.94168058314, 5839.620424672383, 6602.735890564323, 6612.404883560503, 6668.066470694107, 6683.365080317362, 6685.799426017227, 5691.630044047124, 5742.942570574241, 5762.279715035621, 5795.39148389413, 5799.043157878987, 5846.94153058464, 5883.882322353529, 5891.057430811135, 5893.233879595711, 5910.468057874812, 6405.167328247391, 6428.164338636041, 6479.384458476531, 6501.804945851632, 6521.021846722934, 6481.4166724994975, 6618.536702430976, 6628.734850606114, 6631.303713110054, 6751.628660423527, 6395.7121929514215, 6408.29508754046, 6422.2614399344675, 6428.646424446701, 6436.645984470899, 6423.678816059085, 6456.386643268882, 6494.123293355526, 6506.089147519446, 6512.153420055552, 6547.279799221987, 6598.637074960923, 6629.105070815378, 6630.237522684953, 6631.1379520662, 6382.489400847828, 6408.967955160194, 6429.357064293533, 6507.674616269073, 6517.3808488193545, 6236.812895613139, 6419.614823110628, 6499.415052645285, 6515.641639709862, 6523.054157147282, 6285.057241413824, 6352.110704501281, 6374.075759014824, 6383.776567820104, 6394.648294343856, 6475.708593113227, 6478.060681201294, 6565.474762018932, 6570.868582628225, 6572.539922205591, 6248.094026366242, 6290.21372328459, 6336.683165841598, 6351.364863513611, 6358.046293056079], "value": 6031.24634945012, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.5593351623364, 864.5979619476942, 891.3983061433535, 891.6879092317688, 1143.919925605208, 29374.265643358925, 30503.0, 40880.18239635206, 41804.0, 41857.37213941786, 41258.0, 41713.0, 41723.0, 41791.37312940301, 41811.16377672445, 7150.284971502861, 7256.274372562728, 7663.655135518887, 7674.232576742337, 7676.923230767705, 7599.848003039936, 7705.383569314441, 7710.807229819244, 7713.845723085535, 7803.0, 7716.9614151929445, 7747.535147891144, 7781.2996830285265, 7801.921980780205, 7804.648790804427, 7660.2722741339485, 7664.770056898246, 7687.846243075135, 7709.807254818675, 7734.033245844297, 7572.318491335806, 7632.961835190844, 7667.156612772591, 7678.462507624468, 7679.808004799869, 38245.808770956246, 38367.232655346736, 38399.04002399935, 38544.614553854386, 38619.03452413684, 3590.120420496995, 3628.963710362915, 3629.1108678373967, 3629.401148810443, 3636.163682353047, 31260.843695781605, 31292.53061204084, 31303.84348078245, 31325.373492530023, 31401.685983140334, 4852.636052296092, 5023.397192336906, 5052.69683818972, 5054.9241761373605, 5134.717590532519, 183234.0, 183292.0, 183489.0, 183860.0, 184099.0, 47307.763461182476, 47488.0, 47541.0, 47544.2868356968, 47627.28559071547, 49529.25706114411, 54443.0, 55652.44347556554, 55881.44118558844, 55886.0, 14699.41202351894, 16222.35110595563, 16330.265138068815, 16333.346666133222, 16338.591535211715, 12191.939040304742, 13278.203307801563, 13512.59462216135, 13575.185488870698, 13594.32028398576, 14608.269586520631, 14613.634659133395, 14643.267836608127, 14694.338754756061, 14790.186539740418, 5955.37468565803, 6062.757489700451, 6102.755889764359, 6103.664298463627, 6138.324784273726, 999.0608827701936, 1021.2544842265039, 1024.2522958240377, 1026.9281150319555, 1031.0771859186136, 22206.77793222047, 23209.53580928372, 29213.7078629211, 29476.852615736785, 30170.396592068475, 1093.704699731068, 1096.331237944853, 1101.862267216598, 1105.6959336182615, 1121.725177331559, 12307.815382769266, 12470.563530276397, 12485.750284994248, 12522.248665080124, 12682.365881705879, 229708.0, 230042.0, 231385.0, 232071.0, 233891.0, 50838.0, 51326.74336628293, 51347.0, 51456.74271628618, 51584.0, 1398.6643205630576, 1427.4789701758784, 1439.0933711761732, 1456.5266288456294, 1471.8454562271022, 22169.66745498851, 22476.0, 22694.432639184153, 22880.199193028166, 22892.771072289732, 37368.81315593405, 37592.2481550362, 37602.24795504129, 37620.62379376171, 37708.81145594364, 195556.0, 196294.0, 197044.0, 197123.0, 198446.0, 29833.0, 30452.543211851396, 32405.18987025249, 32766.50850237296, 32937.83531082425, 40764.796176020114, 42046.57953420549, 42535.787321063195, 42578.78710606427, 42717.35923961205, 31382.0, 31572.210694732814, 31625.36749264956, 32064.198395040312, 32121.678783211868, 30837.0, 30879.0, 31322.21694457657, 31736.841315793274, 31895.681043190198, 33510.49734253939, 34305.0, 34493.310133797684, 34586.82706586451, 34595.48106778451, 29899.103026909226, 30235.69764302329, 30301.393972119993, 30358.392832143676, 30442.695573043988, 22179.556408872057, 22787.27775306322, 23097.769022309563, 23142.76857231406, 23570.646440303753], "value": 17110.487021509878, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.2748073686785, 574.1301927579717, 577.780443431496, 582.8863371642531, 598.6497898729243, 21667.566648667016, 22372.32883013508, 22869.0, 22899.885500572516, 22900.0, 26838.194854154357, 27150.32124196896, 27249.318767030833, 27423.31441713958, 27566.5865012025, 6362.618242905429, 6503.219613646345, 6522.1195138656385, 6539.738410463599, 6552.737890484399, 6249.2500899892075, 6499.512536559753, 6578.539502234846, 6876.484263680244, 6885.4491640668875, 6845.657717114149, 6885.208201056867, 6892.655367231619, 6903.827404314882, 6904.827379315532, 6872.072270243503, 6878.071460352863, 6884.724611015554, 6889.345512176335, 6889.414399776, 6779.898301525481, 6804.897926531056, 6805.2173999989645, 6808.183018037867, 6816.863662726767, 31470.37059258802, 32013.679863201534, 32293.192670183198, 33709.32581348384, 33977.66022339794, 2019.929302474421, 2063.6801295799173, 2071.0887209627867, 2071.3682326890294, 2073.2743539761113, 20064.59870802576, 20911.790882091136, 21280.46798830026, 21336.786632133637, 21376.679349809765, 2523.028633975914, 2539.3397716593818, 2606.530824451598, 2611.099170786076, 2617.5811870100692, 145616.0, 149443.25278373648, 149984.0, 150085.0, 150359.24820375827, 19666.70499942502, 22098.33704988853, 22104.778952210592, 22497.212597559006, 22915.885420573122, 45097.32354014692, 45186.096278074256, 45408.772956135006, 45510.0, 45677.314840277424, 11568.942155289338, 11918.510186226722, 12180.81728774069, 12212.57255996036, 12275.69310767238, 10106.090451859369, 10180.490975451197, 10221.284510084222, 10221.897781022095, 10323.174146068446, 8609.526476043879, 9274.965390055348, 9382.202512786489, 9428.292878034037, 11392.430378481044, 2641.4320921002077, 2671.492416440909, 2724.3325385280336, 2764.25365151408, 2767.1283545683045, 940.1397721085131, 972.1202311907734, 973.9870534644033, 984.4093543873619, 988.3476905242649, 19955.900220499094, 20122.496937576678, 20319.593608127754, 20951.79048209529, 21019.68470472944, 1038.3302769713493, 1042.890496497872, 1045.8640376751125, 1050.7425680708275, 1054.0566193257146, 11352.14858885587, 11384.316940983568, 11457.885421145682, 11486.59796907121, 11566.884331156749, 432271.0, 435938.0, 438702.0, 439440.0, 449168.0, 113658.43170784094, 116595.0, 118215.0, 123059.3847030759, 129882.0, 1253.385840937952, 1258.4148371007343, 1299.1944994103906, 1307.7115048664837, 1314.677903913528, 21094.683579746008, 21355.35933921985, 21364.359069227947, 21406.892965535073, 21697.240596579042, 57182.42679079535, 58207.417925821894, 58595.70702146462, 60571.69714151401, 60912.0, 70537.0, 70631.0, 70706.29293706997, 70952.0, 70962.0, 14983.77524337114, 15375.923120384774, 15492.612684682974, 15494.992825466308, 15537.45618903333, 23694.52610947737, 24156.87921560381, 24198.758012420356, 24265.757342427056, 24266.272011839672, 18179.18193681314, 18895.338663146726, 19226.7115993263, 19227.80772192316, 19260.903695481433, 16982.40561580339, 17041.23314450828, 17150.914245428692, 17651.205695743465, 17804.575633948993, 19067.237310507426, 19082.61834763269, 19141.521461963006, 19418.0, 19429.02854857223, 14494.275286235857, 15180.696386071995, 15247.542573722805, 15254.161021143944, 15461.149636770086, 18874.43376698701, 19002.809971900657, 19061.714074289175, 19360.70958935589, 19410.611787764446], "value": 12855.06196651965, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.8029735688326, 1407.359651358632, 1410.407628795906, 1416.5042235217668, 1433.1329545624897, 13532.729345413085, 14122.929385353085, 14129.434822607109, 14138.929305353471, 14164.220967846764, 14716.117032978029, 14864.702705945874, 14912.0, 14962.251887405613, 14980.775288370656, 2753.5869619557025, 2800.9439811203865, 2805.3547684032583, 2810.339570201001, 2817.6618805743337, 2693.4478431921407, 2721.006832506131, 2752.0, 2752.229375774786, 2766.7786577073884, 2683.758461738443, 2702.310910717774, 2717.605947137664, 2717.6738791345065, 2742.6708794944534, 2595.909143179989, 2606.3093280280646, 2627.947441051178, 2629.9079532216474, 2630.631711560383, 2537.1500547316673, 2556.5014822109697, 2556.6292887531204, 2569.743025697434, 2573.2537564106387, 13745.0, 14029.368678409393, 14039.157650541, 14090.365933533016, 14099.577012689635, 7429.591372474511, 7899.091604465445, 7901.09137449195, 7907.9604601976625, 7910.485818421784, 4934.0, 5099.541041306263, 5139.460356662571, 5193.350831146106, 5203.791848326063, 1893.914773835167, 1897.1462841721143, 1912.139537208248, 1941.6407964526609, 1959.3925882976323, 22196.445088872744, 22505.887470562706, 22551.661725074136, 22554.77445225543, 22675.206367777213, 6358.523110766619, 6380.55336126476, 6467.417932386108, 6619.569727967667, 6642.202935647753, 15469.14919679406, 15482.922585387001, 15488.845111548966, 15500.379984800482, 15509.224538773016, 7267.0, 7452.366548843409, 7454.925450745423, 7456.32893039629, 7462.10454745434, 5742.138679198154, 5937.881242375129, 6139.539534534839, 6153.569250152446, 6155.199824022849, 4974.552290293818, 5090.185570308807, 5189.636725429259, 5214.374275086938, 5252.79185787271, 1445.8337291211644, 1482.0070552729696, 1511.9017263877813, 1519.8860085493632, 1535.2170393099377, 876.8684697295329, 889.0442774017828, 904.3036861616519, 907.9286441998505, 909.5861383070687, 7050.612216328152, 7143.107111611049, 7151.2491188424465, 7249.492535522569, 7981.2018798119725, 966.8888077870994, 993.2600212841479, 1019.5004447820663, 1025.9384436933808, 1037.0770014686934, 4690.3433519306645, 4819.445763737215, 4834.395700537433, 4924.261360795909, 5000.89998200034, 18352.174152163185, 18858.434246972614, 18864.434066977738, 18992.050397480347, 19002.61994760097, 18463.90768046151, 19648.90175549113, 19700.113494892765, 19854.60290794176, 19873.0, 10840.837387439195, 10963.780724385468, 10976.506057227285, 10987.890121098846, 11038.503267352988, 7834.1382447929545, 7840.490368126054, 8044.517328960281, 8067.394945379003, 8096.109427962801, 16455.917720411322, 16829.495115146565, 16841.831581684026, 17189.65620687554, 17197.742033869752, 16809.663806724042, 16976.23606937666, 17217.0, 17280.395186168425, 17630.382936597158, 11327.32036077805, 11520.366379849189, 11524.250923689933, 11538.07695384384, 11545.48045337945, 13203.66990825237, 13275.734485310433, 13296.468141274241, 13310.866891330963, 13414.329283535979, 10561.788764224826, 10865.348079115278, 10989.791122976627, 11056.226064175431, 11111.666550024585, 10643.467826608794, 10746.46267686597, 10834.566617335533, 10841.403722795321, 10875.782484350428, 9055.320850936338, 9119.954400227956, 9125.361224714206, 9126.726198214064, 9190.31072669539, 6924.896126558005, 6974.0, 6981.5461994970165, 6991.755288564876, 7000.649967501707, 6854.9657251713425, 6937.895931561132, 6961.965190174017, 7033.507654464343, 7070.68181931804], "value": 6355.740322512651, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.8569429171248, 490.2578213562507, 513.7174553995302, 516.0221380483982, 516.5376987596102, 5929.703514824263, 6099.298580663225, 6108.694565271735, 6129.693515324233, 6174.969125154379, 5863.442972917566, 5954.70226488676, 5995.3405125436275, 6007.939920600804, 6013.248343957005, 4812.326274321597, 4818.373611430509, 4818.855434336975, 4826.420829500465, 4888.951110488885, 4628.143793398232, 4790.209615413452, 4791.185498465252, 4822.300766388871, 4828.927566086511, 4738.691985020962, 4755.5244475552345, 4803.495632958541, 4818.759062046901, 4838.806447742104, 4719.268513380432, 4751.643626727992, 4812.639052071108, 4837.879053023667, 4884.511548845087, 4239.47006624172, 4251.97874010631, 4276.465441819772, 4346.76092814895, 4384.802683879233, 5929.132323318184, 5955.702214889238, 5955.987482128048, 5966.3138739045135, 5999.580029397944, 5567.805126820542, 5596.244506991545, 5617.719114044281, 5630.296212973379, 5631.802886898939, 6239.968800156015, 6260.561760676755, 6333.271673757531, 6385.659011607568, 6386.190076366431, 4675.13510000651, 4709.293605959099, 4729.929051064237, 4742.312364707098, 4773.260144677581, 6511.93488065118, 6620.933790662128, 6713.932860671429, 6729.798106056777, 6772.0, 4820.68665536739, 4856.562909338177, 4863.732494712754, 4865.318855360252, 4887.780049897692, 4950.232713929347, 4952.306677065214, 4962.032403681247, 4969.478204788517, 4993.550580447777, 5498.0, 5537.197106419547, 5568.55451563882, 5574.191742197439, 5593.692346920959, 6361.522885783585, 6434.935650643527, 6485.578437401554, 6498.902516462257, 6522.673866306665, 1607.847254510843, 1640.6226567889214, 1676.4719113479216, 1715.9656806863793, 1735.514056064304, 1191.541256616209, 1192.928424294545, 1196.8683444821063, 1212.6180253220207, 1221.7190046289404, 5570.944290557123, 5577.386487486373, 5598.636088654224, 5606.775728970795, 5741.913871291934, 6326.746930122744, 6486.119025482557, 6491.397274512597, 6568.8357791055605, 6576.80269591913, 5613.58615795212, 5690.430956904276, 5692.288463942007, 5756.539476841843, 5768.509676677446, 3482.231625857449, 3485.2680937003515, 3491.755577109578, 3510.297940411877, 3538.0, 6292.930201865694, 6336.936630633727, 6339.904901426482, 6421.422072013541, 6457.257415397289, 6759.594424334556, 6764.932350676529, 6784.762533311409, 6786.355296246848, 6788.7284508619105, 6336.718781238843, 6405.0, 6413.518986075969, 6478.611283323015, 6523.315051919575, 6597.340265973365, 6603.603783772989, 6623.3376662333385, 6642.368974947372, 6686.598804071771, 6452.677366131768, 6453.386928241809, 6457.612543247233, 6503.382178693017, 6507.5683349662995, 6424.807255782334, 6455.9677201613695, 6457.515686323451, 6485.254195767548, 6529.738810447719, 4872.14737420957, 4883.462819089827, 4901.362822833152, 4924.803007879645, 4935.654504184673, 6502.544821862424, 6544.8363790905605, 6556.704948277435, 6615.966920165369, 6621.27166011748, 6217.96891015542, 6296.590721603081, 6360.713767880549, 6367.617942923254, 6374.948133558097, 6357.427831495188, 6403.807885763435, 6409.4231519163495, 6416.967915160394, 6442.967785161044, 6081.5742897996715, 6155.937760850165, 6261.373862613885, 6276.340984196776, 6312.715927783169, 6193.194884664965, 6240.375962403723, 6352.142460767737, 6373.0, 6424.743010279536, 6249.750009999549, 6268.247810262797, 6269.871423143878, 6293.590916590407, 6296.710762959136], "value": 4930.110667554188, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [905.0994260710589, 913.8720579118923, 925.0841666749917, 930.9441433513986, 934.112593036615, 18313.267469301227, 19013.904930475364, 19036.33372831953, 19055.809441905578, 21731.13075476983, 21292.680609790867, 22051.558968820653, 22181.1127554898, 22219.333419997387, 22231.555368892612, 1026.7279171019686, 1062.044160255772, 1062.8140075486758, 1063.0645032371501, 1063.4363787192801, 1021.6219998600528, 1065.9946700266487, 1066.6426747039711, 1067.8718553773558, 1068.3216157739853, 1119.9104071674287, 1122.6463663945872, 1122.7698321844043, 1122.9157813164004, 1123.2418117770512, 1114.3592434350242, 1117.1509652663992, 1118.0943435816932, 1119.12148963064, 1121.960731374398, 819.1071731812353, 819.6024927909959, 820.2453742556802, 820.3519219816338, 822.1696086952162, 19602.90198548998, 19698.0, 19874.0, 20074.096665650082, 20522.0, 21189.258375956768, 21501.46246343854, 21818.345449636538, 22027.66958495624, 22076.33770986873, 16481.91759041209, 16517.0, 16677.833221667748, 16689.49931502057, 16790.41233556832, 3549.7870127792157, 3578.8926332209817, 3581.856725730968, 3589.533360663097, 3600.531930848973, 127202.0, 127681.0, 131637.34181329128, 132156.99999999904, 133284.33357833244, 15985.60035999086, 16511.09188994593, 16671.166441677866, 16990.49028529146, 17194.656106877792, 30786.076417707503, 31177.8441107793, 31327.37345253082, 32248.193795155308, 32292.192695182337, 7703.57630330326, 8094.919050809534, 8428.241458268663, 8525.531095789791, 8842.867356989651, 4299.9570004300185, 4364.258076127066, 4379.430674012422, 4384.846530371422, 4392.07766369066, 5327.680339179662, 5344.251804747339, 5353.81261655848, 5417.10617748075, 5458.754356053987, 1048.3866937841296, 1048.984265236022, 1051.3429106808244, 1073.350622873166, 1084.1218612923558, 664.1001443044702, 686.5983399711125, 702.1328659106, 705.8976448415053, 707.2361849202952, 11424.257423267461, 11483.368414737102, 11650.941745291218, 11880.168388212742, 12316.692082698004, 637.079420237752, 638.7476946606065, 651.9022146678036, 653.3270731146927, 654.6922946215271, 5425.294711687534, 5752.511036561939, 5824.534037277008, 6435.6138631681315, 6441.516886233551, 102868.0, 103817.48091259495, 104895.0, 104970.0, 106580.73677052987, 89032.0, 91023.54488227516, 91653.54173229224, 92322.0, 93145.53427232821, 77495.0, 77551.61224193843, 79692.20307796847, 80157.59921200473, 80837.19162808296, 12157.574484893341, 12659.367031648564, 12676.87323126757, 12716.554920578106, 13211.867881321064, 34301.142471437415, 34308.65691343154, 35840.566377344614, 37021.62978370182, 37234.813825930694, 64761.0, 65858.0, 67373.66313168402, 69829.65085174542, 70003.29996699968, 19215.711764323267, 19564.706529402356, 19870.701939471208, 20099.095540700997, 20200.29298974529, 21660.891695542054, 21706.34880953574, 22400.663990040488, 22524.887375563674, 22622.208222712125, 19475.415737527896, 19975.800241997393, 20134.993250337717, 20456.181752729724, 20475.488112796702, 19640.0, 20015.899920500306, 20313.0, 20348.389548313575, 20550.897245513675, 18855.24579016879, 19181.040947952824, 19747.605047899247, 19843.900780496584, 19987.0, 14181.929090354895, 14424.495142669955, 14523.201223932785, 14628.122312661275, 14819.25903704832, 13492.797608035691, 14369.56891293263, 14550.85449145495, 14677.853221467649, 15010.324535395715], "value": 9350.4012579931, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 120.0, 102.0, 109.0, 109.0, 109.0, 115.0, 100.0, 109.0, 110.0], "value": 108.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 128.0, 142.0, 165.0, 121.0, 159.0, 144.0, 123.0, 174.0, 119.0], "value": 143.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 163.0, 163.0, 171.0, 166.0, 172.0, 174.0, 166.0, 169.0], "value": 167.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 75.0, 161.0, 76.0, 78.0, 77.0, 89.0, 100.0, 81.0], "value": 89.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 134.0, 85.0, 86.0, 80.0, 131.0, 78.0, 79.0, 129.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 117.0, 117.0, 121.0, 114.0, 115.0, 119.0, 115.0, 114.0], "value": 115.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 153.0, 150.0, 152.0, 151.0, 151.0, 150.0, 153.0, 150.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 97.0, 95.0, 94.0, 94.0, 99.0, 96.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 54.0, 55.0, 54.0, 57.0, 54.0, 54.0, 55.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 60.0, 54.0, 53.0, 54.0, 54.0, 53.0, 63.0, 58.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 80.0, 79.0, 82.0, 78.0, 79.0, 89.0, 79.0, 96.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 144.0, 138.0, 128.0, 125.0, 128.0, 140.0, 131.0, 171.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 172.0, 170.0, 177.0, 177.0, 178.0, 173.0, 170.0, 184.0, 183.0], "value": 176.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 70.0, 67.0, 67.0, 66.0, 66.0, 67.0, 71.0, 73.0], "value": 68.6, "unit": "score"}]}]} 19:10:15 INFO - Return code: 0 19:10:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:10:15 INFO - # TBPL SUCCESS # 19:10:15 INFO - Running post-action listener: _package_coverage_data 19:10:15 INFO - Running post-action listener: _resource_record_post_action 19:10:15 INFO - [mozharness: 2017-08-04 02:10:15.379434Z] Finished run-tests step (success) 19:10:15 INFO - Running post-run listener: _resource_record_post_run 19:10:15 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 12288; Write bytes: 431706112; Read time: 252; Write time: 271112 19:10:15 INFO - TinderboxPrint: CPU usage
13.2% 19:10:15 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 252 19:10:15 INFO - TinderboxPrint: I/O write bytes / time
431,706,112 / 271,112 19:10:15 INFO - TinderboxPrint: CPU idle
8,279.0 (86.8%) 19:10:15 INFO - TinderboxPrint: CPU user
1,206.9 (12.7%) 19:10:15 INFO - TinderboxPrint: Swap in / out
0 / 0 19:10:15 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107651072; Read time: 0; Write time: 87332 19:10:15 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:10:15 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 8192; Write bytes: 324055040; Read time: 244; Write time: 183780 19:10:16 INFO - Running post-run listener: _upload_blobber_files 19:10:16 INFO - Blob upload gear active. 19:10:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:10:16 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 19:10:16 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'] 19:10:16 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 19:10:16 INFO - (blobuploader) - INFO - Open directory for files ... 19:10:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:10:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:10:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:10:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:10:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:10:17 INFO - (blobuploader) - INFO - Done attempting. 19:10:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:10:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:10:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:10:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:10:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:10:17 INFO - (blobuploader) - INFO - Done attempting. 19:10:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:10:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:10:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:10:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:10:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:10:18 INFO - (blobuploader) - INFO - Done attempting. 19:10:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:10:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:10:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:10:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:10:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:10:25 INFO - (blobuploader) - INFO - Done attempting. 19:10:25 INFO - (blobuploader) - INFO - Iteration through files over. 19:10:25 INFO - Return code: 0 19:10:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:10:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:10:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5813f9623c623648eee4632d2b5b2b40cc0a3c6080ee35e312e4656d293d1ef40e38e987464fa307c477bc8509d4e63d7adfacaa0d66ad81010d5eaf22b4589", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/256f9a79a2f54a496aed4b40ddd0323d128448ba40e61c6da878b340239287dbb539546ec1eb9056f148136217ceb911c399297ef9af8a2a65f967ef6bea3661", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5201338e9ea5dbc2184db305e91c89451daeefa32fe31139f3b60d410675a6539b6e372b47cecbdca18e56dc25e80555cf169686401657c6afa77b6ecdd6c5b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/871af448cf10a8f781110937a124ddb205fd7577aa40ace3020166ed3b8176af4c584299b2945d6a28fc91feeaab179b7f640018de8dd92ad7a76e3897ae1043"} 19:10:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:10:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:10:25 INFO - Contents: 19:10:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5813f9623c623648eee4632d2b5b2b40cc0a3c6080ee35e312e4656d293d1ef40e38e987464fa307c477bc8509d4e63d7adfacaa0d66ad81010d5eaf22b4589", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/256f9a79a2f54a496aed4b40ddd0323d128448ba40e61c6da878b340239287dbb539546ec1eb9056f148136217ceb911c399297ef9af8a2a65f967ef6bea3661", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5201338e9ea5dbc2184db305e91c89451daeefa32fe31139f3b60d410675a6539b6e372b47cecbdca18e56dc25e80555cf169686401657c6afa77b6ecdd6c5b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/871af448cf10a8f781110937a124ddb205fd7577aa40ace3020166ed3b8176af4c584299b2945d6a28fc91feeaab179b7f640018de8dd92ad7a76e3897ae1043"} 19:10:25 INFO - Running post-run listener: copy_logs_to_upload_dir 19:10:25 INFO - Copying logs to upload dir... 19:10:25 INFO - mkdir: /builds/slave/test/build/upload/logs 19:10:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.715735 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-08-03 19:10:25.116800) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 19:10:25.124147) ========= 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=db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859 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/b5813f9623c623648eee4632d2b5b2b40cc0a3c6080ee35e312e4656d293d1ef40e38e987464fa307c477bc8509d4e63d7adfacaa0d66ad81010d5eaf22b4589", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/256f9a79a2f54a496aed4b40ddd0323d128448ba40e61c6da878b340239287dbb539546ec1eb9056f148136217ceb911c399297ef9af8a2a65f967ef6bea3661", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5201338e9ea5dbc2184db305e91c89451daeefa32fe31139f3b60d410675a6539b6e372b47cecbdca18e56dc25e80555cf169686401657c6afa77b6ecdd6c5b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/871af448cf10a8f781110937a124ddb205fd7577aa40ace3020166ed3b8176af4c584299b2945d6a28fc91feeaab179b7f640018de8dd92ad7a76e3897ae1043"} build_url:https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011293 build_url: 'https://queue.taskcluster.net/v1/task/H5B5IEnwSEm76TFIhWTsdQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5813f9623c623648eee4632d2b5b2b40cc0a3c6080ee35e312e4656d293d1ef40e38e987464fa307c477bc8509d4e63d7adfacaa0d66ad81010d5eaf22b4589", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/256f9a79a2f54a496aed4b40ddd0323d128448ba40e61c6da878b340239287dbb539546ec1eb9056f148136217ceb911c399297ef9af8a2a65f967ef6bea3661", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5201338e9ea5dbc2184db305e91c89451daeefa32fe31139f3b60d410675a6539b6e372b47cecbdca18e56dc25e80555cf169686401657c6afa77b6ecdd6c5b7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/871af448cf10a8f781110937a124ddb205fd7577aa40ace3020166ed3b8176af4c584299b2945d6a28fc91feeaab179b7f640018de8dd92ad7a76e3897ae1043"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 19:10:25.154127) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 19:10:25.154487) ========= 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=db7e7c15f3ca076d53731445000001ba-1501806344.869480-130015859 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 19:10:25.239773) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 19:10:25.240134) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 19:10:25.240442) ========= ========= Total master_lag: 0.23 =========