builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1503539861.5 results: success (0) revision: d1c70c20e7b52f7295411343e4dc5db8ee7c92b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 18:57:41.500879) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 18:57:41.501358) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2017-08-23 18:57:41.503662) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2017-08-23 18:57:42.839208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 18:57:42.839585) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-23 18:57:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 109M=0s 2017-08-23 18:57:42 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094532 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 18:57:43.059989) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 18:57:43.060433) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019993 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 18:57:43.094272) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-23 18:57:43.094966) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d1c70c20e7b52f7295411343e4dc5db8ee7c92b9 --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 d1c70c20e7b52f7295411343e4dc5db8ee7c92b9 --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=9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-23 18:57:43,189 truncating revision to first 12 chars 2017-08-23 18:57:43,189 Setting DEBUG logging. 2017-08-23 18:57:43,189 attempt 1/10 2017-08-23 18:57:43,189 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d1c70c20e7b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-23 18:57:44,403 unpacking tar archive at: mozilla-central-d1c70c20e7b5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.617606 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-23 18:57:44.733420) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 18:57:44.733730) ========= script_repo_revision: d1c70c20e7b52f7295411343e4dc5db8ee7c92b9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 18:57:44.734145) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 18:57:44.741493) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 18:57:44.756928) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-23 18:57:44.757287) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:57:44 INFO - MultiFileLogger online at 20170823 18:57:44 in /builds/slave/test 18:57:44 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:57:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:57:44 INFO - {'append_to_log': False, 18:57:44 INFO - 'base_work_dir': '/builds/slave/test', 18:57:44 INFO - 'blob_upload_branch': 'Firefox', 18:57:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:57:44 INFO - 'branch': 'Firefox', 18:57:44 INFO - 'buildbot_json_path': 'buildprops.json', 18:57:44 INFO - 'code_coverage': False, 18:57:44 INFO - 'config_files': ('talos/linux_config.py',), 18:57:44 INFO - 'default_actions': ('clobber', 18:57:44 INFO - 'read-buildbot-config', 18:57:44 INFO - 'download-and-extract', 18:57:44 INFO - 'populate-webroot', 18:57:44 INFO - 'create-virtualenv', 18:57:44 INFO - 'install', 18:57:44 INFO - 'setup-mitmproxy', 18:57:44 INFO - 'run-tests'), 18:57:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:57:44 INFO - 'disable_ccov_upload': False, 18:57:44 INFO - 'download_minidump_stackwalk': True, 18:57:44 INFO - 'download_symbols': 'ondemand', 18:57:44 INFO - 'enable_stylo': False, 18:57:44 INFO - 'enable_webrender': False, 18:57:44 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 18:57:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:57:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:57:44 INFO - 'gecko_profile': False, 18:57:44 INFO - 'gecko_profile_interval': 0, 18:57:44 INFO - 'installer_path': 'installer.exe', 18:57:44 INFO - 'log_level': 'info', 18:57:44 INFO - 'log_name': 'talos', 18:57:44 INFO - 'log_to_console': True, 18:57:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:57:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:57:44 INFO - 'opt_config_files': (), 18:57:44 INFO - 'pip_index': False, 18:57:44 INFO - 'suite': 'dromaeojs-e10s', 18:57:44 INFO - 'system_bits': '32', 18:57:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:57:44 INFO - 'title': 'talos-linux64-ix-013', 18:57:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:57:44 INFO - 'use_talos_json': True, 18:57:44 INFO - 'verify': 'False', 18:57:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:57:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:57:44 INFO - 'work_dir': 'build'} 18:57:44 INFO - [mozharness: 2017-08-24 01:57:44.994055Z] Running clobber step. 18:57:44 INFO - Running pre-action listener: _resource_record_pre_action 18:57:44 INFO - Running main action method: clobber 18:57:44 INFO - rmtree: /builds/slave/test/build 18:57:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:57:46 INFO - Running post-action listener: _resource_record_post_action 18:57:46 INFO - [mozharness: 2017-08-24 01:57:46.700770Z] Finished clobber step (success) 18:57:46 INFO - [mozharness: 2017-08-24 01:57:46.701002Z] Running read-buildbot-config step. 18:57:46 INFO - Running pre-action listener: _resource_record_pre_action 18:57:46 INFO - Running main action method: read_buildbot_config 18:57:46 INFO - Using buildbot properties: 18:57:46 INFO - { 18:57:46 INFO - "project": "", 18:57:46 INFO - "product": "firefox", 18:57:46 INFO - "who": "kwierso@gmail.com", 18:57:46 INFO - "installer_path": "public/build/target.tar.bz2", 18:57:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 18:57:46 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:57:46 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 18:57:46 INFO - "stage_platform": "linux64-stylo", 18:57:46 INFO - "basedir": "/builds/slave/test", 18:57:46 INFO - "buildnumber": 53, 18:57:46 INFO - "platform": "ubuntu64_hw_stylo", 18:57:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:57:46 INFO - "slavebuilddir": "test", 18:57:46 INFO - "taskId": "OH1ZdnKJQeycsL5Nv-_HAA", 18:57:46 INFO - "branch": "mozilla-central", 18:57:46 INFO - "script_repo_revision": "production", 18:57:46 INFO - "revision": "d1c70c20e7b52f7295411343e4dc5db8ee7c92b9", 18:57:46 INFO - "slavename": "talos-linux64-ix-013", 18:57:46 INFO - "repo_path": "mozilla-central" 18:57:46 INFO - } 18:57:46 INFO - Finding installer, test and symbols from parent task. 18:57:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OH1ZdnKJQeycsL5Nv-_HAA'}, attempt #1 18:57:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OH1ZdnKJQeycsL5Nv-_HAA'}, attempt #1 18:57:47 INFO - Task dependencies: LUZZ1SOYRVeP5njBkcTVNw 18:57:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw'}, attempt #1 18:57:48 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.tar.bz2 18:57:48 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.test_packages.json 18:57:48 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.crashreporter-symbols.zip 18:57:48 INFO - Running post-action listener: _resource_record_post_action 18:57:48 INFO - [mozharness: 2017-08-24 01:57:48.283604Z] Finished read-buildbot-config step (success) 18:57:48 INFO - [mozharness: 2017-08-24 01:57:48.283822Z] Running download-and-extract step. 18:57:48 INFO - Running pre-action listener: _resource_record_pre_action 18:57:48 INFO - Running main action method: download_and_extract 18:57:48 INFO - mkdir: /builds/slave/test/build/tests 18:57:48 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:57:48 INFO - trying https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.test_packages.json 18:57:48 INFO - Downloading https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:57:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:57:48 INFO - Downloaded 989 bytes. 18:57:48 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:57:48 INFO - Using the following test package requirements: 18:57:48 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:57:48 INFO - u'common': [u'target.common.tests.zip'], 18:57:48 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:57:48 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:57:48 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:57:48 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:57:48 INFO - u'mozbase': [u'target.common.tests.zip'], 18:57:48 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:57:48 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:57:48 INFO - u'web-platform': [u'target.common.tests.zip', 18:57:48 INFO - u'target.web-platform.tests.tar.gz'], 18:57:48 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:57:48 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:57:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.common.tests.zip 18:57:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:57:48 INFO - Fetch https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.common.tests.zip into memory 18:57:49 INFO - Content-Length response header: 54950783 18:57:49 INFO - Bytes received: 54950783 18:58:00 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:58:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.common.tests.zip 18:58:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:58:00 INFO - Fetch https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.common.tests.zip into memory 18:58:01 INFO - Content-Length response header: 54950783 18:58:01 INFO - Bytes received: 54950783 18:58:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.talos.tests.zip 18:58:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:58:13 INFO - Fetch https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.talos.tests.zip into memory 18:58:14 INFO - Content-Length response header: 14496384 18:58:14 INFO - Bytes received: 14496384 18:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:14 INFO - trying https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.tar.bz2 18:58:14 INFO - Downloading https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:58:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:58:16 INFO - Downloaded 61057864 bytes. 18:58:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.tar.bz2 18:58:16 INFO - mkdir: /builds/slave/test/properties 18:58:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:58:16 INFO - Writing to file /builds/slave/test/properties/build_url 18:58:16 INFO - Contents: 18:58:16 INFO - build_url:https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.tar.bz2 18:58:16 INFO - Running post-action listener: _resource_record_post_action 18:58:16 INFO - Running post-action listener: find_tests_for_verification 18:58:16 INFO - Running post-action listener: set_extra_try_arguments 18:58:16 INFO - [mozharness: 2017-08-24 01:58:16.073910Z] Finished download-and-extract step (success) 18:58:16 INFO - [mozharness: 2017-08-24 01:58:16.074006Z] Running populate-webroot step. 18:58:16 INFO - Running pre-action listener: _resource_record_pre_action 18:58:16 INFO - Running main action method: populate_webroot 18:58:16 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:58:16 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 18:58:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:58:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:58:16 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 18:58:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:58:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:58:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:58:16 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:58:16 INFO - 'talos_options': ['--stylo'], 18:58:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:58:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:58:16 INFO - 'tests': ['damp', 'tps']}, 18:58:16 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:58:16 INFO - 'talos_options': ['--stylo'], 18:58:16 INFO - 'tests': ['damp', 'tps']}, 18:58:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:58:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:58:16 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 18:58:16 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:58:16 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:58:16 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:58:16 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:58:16 INFO - 'talos_options': ['--stylo'], 18:58:16 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:58:16 INFO - 'other-e10s': {'tests': ['a11yr', 18:58:16 INFO - 'ts_paint', 18:58:16 INFO - 'tpaint', 18:58:16 INFO - 'sessionrestore', 18:58:16 INFO - 'sessionrestore_many_windows', 18:58:16 INFO - 'sessionrestore_no_auto_restore', 18:58:16 INFO - 'tabpaint']}, 18:58:16 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 18:58:16 INFO - 'tests': ['a11yr', 18:58:16 INFO - 'ts_paint', 18:58:16 INFO - 'tpaint', 18:58:16 INFO - 'sessionrestore', 18:58:16 INFO - 'sessionrestore_many_windows', 18:58:16 INFO - 'sessionrestore_no_auto_restore', 18:58:16 INFO - 'tabpaint']}, 18:58:16 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:58:16 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:58:16 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 18:58:16 INFO - 'tests': ['bloom_basic_singleton']}, 18:58:16 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 18:58:16 INFO - 'tests': ['bloom_basic']}, 18:58:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:58:16 INFO - 'tsvgr_opacity', 18:58:16 INFO - 'tart', 18:58:16 INFO - 'tscrollx', 18:58:16 INFO - 'tsvg_static']}, 18:58:16 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 18:58:16 INFO - 'tests': ['tsvgx', 18:58:16 INFO - 'tsvgr_opacity', 18:58:16 INFO - 'tart', 18:58:16 INFO - 'tscrollx', 18:58:16 INFO - 'tsvg_static']}, 18:58:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:58:16 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:58:16 INFO - 'talos_options': ['--stylo'], 18:58:16 INFO - 'tests': ['tp5o']}, 18:58:16 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:58:16 INFO - 'talos_options': ['--mitmproxy', 18:58:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:58:16 INFO - '--firstNonBlankPaint'], 18:58:16 INFO - 'tests': ['tp6_google', 18:58:16 INFO - 'tp6_youtube', 18:58:16 INFO - 'tp6_amazon', 18:58:16 INFO - 'tp6_facebook']}, 18:58:16 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:58:16 INFO - 'talos_options': ['--stylo', 18:58:16 INFO - '--mitmproxy', 18:58:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:58:16 INFO - '--firstNonBlankPaint'], 18:58:16 INFO - 'tests': ['tp6_google', 18:58:16 INFO - 'tp6_youtube', 18:58:16 INFO - 'tp6_amazon', 18:58:16 INFO - 'tp6_facebook']}, 18:58:16 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:58:16 INFO - 'talos_options': ['--stylo', 18:58:16 INFO - '--stylo-threads=1', 18:58:16 INFO - '--mitmproxy', 18:58:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:58:16 INFO - '--firstNonBlankPaint'], 18:58:16 INFO - 'tests': ['tp6_google', 18:58:16 INFO - 'tp6_youtube', 18:58:16 INFO - 'tp6_amazon', 18:58:16 INFO - 'tp6_facebook']}, 18:58:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:58:16 INFO - 'talos_options': ['--xperf_path', 18:58:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:58:16 INFO - 'tests': ['tp5n']}, 18:58:16 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:58:16 INFO - 'talos_options': ['--stylo', 18:58:16 INFO - '--xperf_path', 18:58:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:58:16 INFO - 'tests': ['tp5n']}}} 18:58:16 INFO - Running post-action listener: _resource_record_post_action 18:58:16 INFO - [mozharness: 2017-08-24 01:58:16.088249Z] Finished populate-webroot step (success) 18:58:16 INFO - [mozharness: 2017-08-24 01:58:16.088339Z] Running create-virtualenv step. 18:58:16 INFO - Running pre-action listener: _resource_record_pre_action 18:58:16 INFO - Running main action method: create_virtualenv 18:58:16 INFO - Creating virtualenv /builds/slave/test/build/venv 18:58:16 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:58:16 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 18:58:16 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:58:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:58:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:58:16 INFO - Installing distribute.............................................................................................................................................................................................done. 18:58:17 INFO - Installing pip...............done. 18:58:17 INFO - Return code: 0 18:58:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:58:17 INFO - Reading from file tmpfile_stdout 18:58:17 INFO - Output received: 18:58:17 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 18:58:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1af90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18130>, '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 0xf19030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf194c0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', '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:58:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:58:17 INFO - Using env: {'DISPLAY': ':0', 18:58:17 INFO - 'HOME': '/home/cltbld', 18:58:17 INFO - 'LANG': 'en_US.UTF-8', 18:58:17 INFO - 'LANGUAGE': 'en_US:en', 18:58:17 INFO - 'LOGNAME': 'cltbld', 18:58:17 INFO - 'MAIL': '/var/mail/cltbld', 18:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:17 INFO - 'MOZ_NO_REMOTE': '1', 18:58:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:17 INFO - 'NO_EM_RESTART': '1', 18:58:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:17 INFO - 'PWD': '/builds/slave/test', 18:58:17 INFO - 'SHELL': '/bin/bash', 18:58:17 INFO - 'SHLVL': '1', 18:58:17 INFO - 'TERM': 'linux', 18:58:17 INFO - 'TMOUT': '86400', 18:58:17 INFO - 'USER': 'cltbld', 18:58:17 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', 18:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:17 INFO - '_': '/tools/buildbot/bin/python'} 18:58:18 INFO - Ignoring indexes: http://pypi.python.org/simple/ 18:58:18 INFO - Downloading/unpacking pip>=1.5 18:58:18 INFO - Running setup.py egg_info for package pip 18:58:18 INFO - warning: no files found matching 'pip/cacert.pem' 18:58:18 INFO - warning: no files found matching '*.html' under directory 'docs' 18:58:18 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:58:18 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:58:18 INFO - Installing collected packages: pip 18:58:18 INFO - Found existing installation: pip 1.1 18:58:18 INFO - Uninstalling pip: 18:58:18 INFO - Successfully uninstalled pip 18:58:18 INFO - Running setup.py install for pip 18:58:18 INFO - warning: no files found matching 'pip/cacert.pem' 18:58:18 INFO - warning: no files found matching '*.html' under directory 'docs' 18:58:18 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 18:58:18 INFO - no previously-included directories found matching 'docs/_build/_sources' 18:58:18 INFO - Installing pip script to /builds/slave/test/build/venv/bin 18:58:18 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 18:58:18 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 18:58:18 INFO - Successfully installed pip 18:58:18 INFO - Cleaning up... 18:58:18 INFO - Return code: 0 18:58:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:58: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:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58: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:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58: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', '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 0xbac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1af90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18130>, '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 0xf19030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf194c0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', '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:58: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', 'psutil>=3.1.1'] in /builds/slave/test/build 18:58: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 psutil>=3.1.1 18:58:18 INFO - Using env: {'DISPLAY': ':0', 18:58:18 INFO - 'HOME': '/home/cltbld', 18:58:18 INFO - 'LANG': 'en_US.UTF-8', 18:58:18 INFO - 'LANGUAGE': 'en_US:en', 18:58:18 INFO - 'LOGNAME': 'cltbld', 18:58:18 INFO - 'MAIL': '/var/mail/cltbld', 18:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:18 INFO - 'MOZ_NO_REMOTE': '1', 18:58:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:18 INFO - 'NO_EM_RESTART': '1', 18:58:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:18 INFO - 'PWD': '/builds/slave/test', 18:58:18 INFO - 'SHELL': '/bin/bash', 18:58:18 INFO - 'SHLVL': '1', 18:58:18 INFO - 'TERM': 'linux', 18:58:18 INFO - 'TMOUT': '86400', 18:58:18 INFO - 'USER': 'cltbld', 18:58:18 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', 18:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:18 INFO - '_': '/tools/buildbot/bin/python'} 18:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:18 INFO - Downloading/unpacking psutil>=3.1.1 18:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:58:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:58:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:58:19 INFO - Installing collected packages: psutil 18:58:19 INFO - Running setup.py install for psutil 18:58:20 INFO - building 'psutil._psutil_linux' extension 18:58:20 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:58:20 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:58:20 INFO - building 'psutil._psutil_posix' extension 18:58:20 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:58:20 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:58:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:58:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:58:20 INFO - Successfully installed psutil 18:58:20 INFO - Cleaning up... 18:58:20 INFO - Return code: 0 18:58:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:20 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 0xbac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1af90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18130>, '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 0xf19030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf194c0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', '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:58:20 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:58:20 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:58:20 INFO - Using env: {'DISPLAY': ':0', 18:58:20 INFO - 'HOME': '/home/cltbld', 18:58:20 INFO - 'LANG': 'en_US.UTF-8', 18:58:20 INFO - 'LANGUAGE': 'en_US:en', 18:58:20 INFO - 'LOGNAME': 'cltbld', 18:58:20 INFO - 'MAIL': '/var/mail/cltbld', 18:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:20 INFO - 'MOZ_NO_REMOTE': '1', 18:58:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:20 INFO - 'NO_EM_RESTART': '1', 18:58:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:20 INFO - 'PWD': '/builds/slave/test', 18:58:20 INFO - 'SHELL': '/bin/bash', 18:58:20 INFO - 'SHLVL': '1', 18:58:20 INFO - 'TERM': 'linux', 18:58:20 INFO - 'TMOUT': '86400', 18:58:20 INFO - 'USER': 'cltbld', 18:58:20 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', 18:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:20 INFO - '_': '/tools/buildbot/bin/python'} 18:58:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:58:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:58:21 INFO - Installing collected packages: mozsystemmonitor 18:58:21 INFO - Running setup.py install for mozsystemmonitor 18:58:21 INFO - Successfully installed mozsystemmonitor 18:58:21 INFO - Cleaning up... 18:58:22 INFO - Return code: 0 18:58:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1af90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18130>, '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 0xf19030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf194c0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', '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:58:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:58:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:58:22 INFO - Using env: {'DISPLAY': ':0', 18:58:22 INFO - 'HOME': '/home/cltbld', 18:58:22 INFO - 'LANG': 'en_US.UTF-8', 18:58:22 INFO - 'LANGUAGE': 'en_US:en', 18:58:22 INFO - 'LOGNAME': 'cltbld', 18:58:22 INFO - 'MAIL': '/var/mail/cltbld', 18:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:22 INFO - 'MOZ_NO_REMOTE': '1', 18:58:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:22 INFO - 'NO_EM_RESTART': '1', 18:58:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:22 INFO - 'PWD': '/builds/slave/test', 18:58:22 INFO - 'SHELL': '/bin/bash', 18:58:22 INFO - 'SHLVL': '1', 18:58:22 INFO - 'TERM': 'linux', 18:58:22 INFO - 'TMOUT': '86400', 18:58:22 INFO - 'USER': 'cltbld', 18:58:22 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', 18:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:22 INFO - '_': '/tools/buildbot/bin/python'} 18:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:22 INFO - Downloading/unpacking jsonschema==2.5.1 18:58:22 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:58:22 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:58:22 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:58:22 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:58:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:58:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:58:23 INFO - Downloading functools32-3.2.3-2.tar.gz 18:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:58:23 INFO - warning: no files found matching '*.txt' 18:58:23 INFO - no previously-included directories found matching 'build' 18:58:23 INFO - no previously-included directories found matching 'dist' 18:58:23 INFO - no previously-included directories found matching '.git*' 18:58:23 INFO - Installing collected packages: jsonschema, functools32 18:58:23 INFO - Running setup.py install for functools32 18:58:23 INFO - warning: no files found matching '*.txt' 18:58:23 INFO - no previously-included directories found matching 'build' 18:58:23 INFO - no previously-included directories found matching 'dist' 18:58:23 INFO - no previously-included directories found matching '.git*' 18:58:23 INFO - Successfully installed jsonschema functools32 18:58:23 INFO - Cleaning up... 18:58:23 INFO - Return code: 0 18:58:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:58:23 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:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:23 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:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:23 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 0xbac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1af90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18130>, '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 0xf19030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf194c0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', '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:58:23 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:58:23 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:58:23 INFO - Using env: {'DISPLAY': ':0', 18:58:23 INFO - 'HOME': '/home/cltbld', 18:58:23 INFO - 'LANG': 'en_US.UTF-8', 18:58:23 INFO - 'LANGUAGE': 'en_US:en', 18:58:23 INFO - 'LOGNAME': 'cltbld', 18:58:23 INFO - 'MAIL': '/var/mail/cltbld', 18:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:23 INFO - 'MOZ_NO_REMOTE': '1', 18:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:23 INFO - 'NO_EM_RESTART': '1', 18:58:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:23 INFO - 'PWD': '/builds/slave/test', 18:58:23 INFO - 'SHELL': '/bin/bash', 18:58:23 INFO - 'SHLVL': '1', 18:58:23 INFO - 'TERM': 'linux', 18:58:23 INFO - 'TMOUT': '86400', 18:58:23 INFO - 'USER': 'cltbld', 18:58:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', 18:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:23 INFO - '_': '/tools/buildbot/bin/python'} 18:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:58:23 INFO - Cleaning up... 18:58:23 INFO - Return code: 0 18:58:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:58:23 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:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:23 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:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:23 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 0xbac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1af90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18130>, '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 0xf19030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf194c0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', '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:58:23 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:58:23 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:58:23 INFO - Using env: {'DISPLAY': ':0', 18:58:23 INFO - 'HOME': '/home/cltbld', 18:58:23 INFO - 'LANG': 'en_US.UTF-8', 18:58:23 INFO - 'LANGUAGE': 'en_US:en', 18:58:23 INFO - 'LOGNAME': 'cltbld', 18:58:23 INFO - 'MAIL': '/var/mail/cltbld', 18:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:23 INFO - 'MOZ_NO_REMOTE': '1', 18:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:23 INFO - 'NO_EM_RESTART': '1', 18:58:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:23 INFO - 'PWD': '/builds/slave/test', 18:58:23 INFO - 'SHELL': '/bin/bash', 18:58:23 INFO - 'SHLVL': '1', 18:58:23 INFO - 'TERM': 'linux', 18:58:23 INFO - 'TMOUT': '86400', 18:58:23 INFO - 'USER': 'cltbld', 18:58:23 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', 18:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:23 INFO - '_': '/tools/buildbot/bin/python'} 18:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:24 INFO - Downloading/unpacking blobuploader==1.2.4 18:58:24 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:58:24 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:58:24 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:58:24 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:58:25 INFO - Downloading blobuploader-1.2.4.tar.gz 18:58:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:58:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:58:25 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:58:25 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:58:25 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:58:25 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:58:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:58:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:58:25 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:58:25 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:58:25 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:58:25 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:58:25 INFO - Downloading docopt-0.6.1.tar.gz 18:58:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:58:25 INFO - Installing collected packages: blobuploader, requests, docopt 18:58:25 INFO - Running setup.py install for blobuploader 18:58:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:58:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:58:25 INFO - Running setup.py install for requests 18:58:26 INFO - Running setup.py install for docopt 18:58:26 INFO - Successfully installed blobuploader requests docopt 18:58:26 INFO - Cleaning up... 18:58:26 INFO - Return code: 0 18:58:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:58:26 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:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:26 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:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:26 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 0xbac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1af90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18130>, '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 0xf19030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf194c0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', '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:58:26 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:58:26 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:58:26 INFO - Using env: {'DISPLAY': ':0', 18:58:26 INFO - 'HOME': '/home/cltbld', 18:58:26 INFO - 'LANG': 'en_US.UTF-8', 18:58:26 INFO - 'LANGUAGE': 'en_US:en', 18:58:26 INFO - 'LOGNAME': 'cltbld', 18:58:26 INFO - 'MAIL': '/var/mail/cltbld', 18:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:26 INFO - 'MOZ_NO_REMOTE': '1', 18:58:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:26 INFO - 'NO_EM_RESTART': '1', 18:58:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:26 INFO - 'PWD': '/builds/slave/test', 18:58:26 INFO - 'SHELL': '/bin/bash', 18:58:26 INFO - 'SHLVL': '1', 18:58:26 INFO - 'TERM': 'linux', 18:58:26 INFO - 'TMOUT': '86400', 18:58:26 INFO - 'USER': 'cltbld', 18:58:26 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', 18:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:26 INFO - '_': '/tools/buildbot/bin/python'} 18:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:58:26 INFO - Running setup.py (path:/tmp/pip-e_GZAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:58:26 INFO - Running setup.py (path:/tmp/pip-BBP2d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:58:26 INFO - Running setup.py (path:/tmp/pip-hs35Oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:58:26 INFO - Running setup.py (path:/tmp/pip-AjcwuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:58:26 INFO - Running setup.py (path:/tmp/pip-_DBZxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:58:26 INFO - Running setup.py (path:/tmp/pip-b5qwFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:58:27 INFO - Running setup.py (path:/tmp/pip-83u3H8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:58:27 INFO - Running setup.py (path:/tmp/pip-KRZPyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:58:27 INFO - Running setup.py (path:/tmp/pip-ZyeDQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:58:27 INFO - Running setup.py (path:/tmp/pip-QUv2Or-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:58:27 INFO - Running setup.py (path:/tmp/pip-4uknDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:58:27 INFO - Running setup.py (path:/tmp/pip-wVuhG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:58:27 INFO - Running setup.py (path:/tmp/pip-4_Mhca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:58:27 INFO - Running setup.py (path:/tmp/pip-Na3Vjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:58:27 INFO - Running setup.py (path:/tmp/pip-HN89Sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:58:27 INFO - Running setup.py (path:/tmp/pip-58KeBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:58:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:58:27 INFO - Running setup.py (path:/tmp/pip-YnV2Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:58:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:58:27 INFO - Running setup.py install for manifestparser 18:58:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:58:27 INFO - Running setup.py install for mozcrash 18:58:28 INFO - Running setup.py install for mozdebug 18:58:28 INFO - Running setup.py install for mozdevice 18:58:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:58:28 INFO - Running setup.py install for mozfile 18:58:28 INFO - Running setup.py install for mozhttpd 18:58:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:58:28 INFO - Running setup.py install for mozinfo 18:58:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:58:28 INFO - Running setup.py install for mozInstall 18:58:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:58:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:58:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:58:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:58:28 INFO - Running setup.py install for mozleak 18:58:28 INFO - Running setup.py install for mozlog 18:58:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:58:28 INFO - Running setup.py install for moznetwork 18:58:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:58:28 INFO - Running setup.py install for mozprocess 18:58:29 INFO - Running setup.py install for mozprofile 18:58:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:58:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:58:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:58:29 INFO - Running setup.py install for mozrunner 18:58:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:58:29 INFO - Running setup.py install for mozscreenshot 18:58:29 INFO - Running setup.py install for moztest 18:58:29 INFO - Running setup.py install for mozversion 18:58:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:58:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:58:29 INFO - Cleaning up... 18:58:29 INFO - Return code: 0 18:58:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:58:29 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:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:29 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:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:29 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 0xbac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1af90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18130>, '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 0xf19030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf194c0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', '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:58:29 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:58:29 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:58:29 INFO - Using env: {'DISPLAY': ':0', 18:58:29 INFO - 'HOME': '/home/cltbld', 18:58:29 INFO - 'LANG': 'en_US.UTF-8', 18:58:29 INFO - 'LANGUAGE': 'en_US:en', 18:58:29 INFO - 'LOGNAME': 'cltbld', 18:58:29 INFO - 'MAIL': '/var/mail/cltbld', 18:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:29 INFO - 'MOZ_NO_REMOTE': '1', 18:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:29 INFO - 'NO_EM_RESTART': '1', 18:58:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:29 INFO - 'PWD': '/builds/slave/test', 18:58:29 INFO - 'SHELL': '/bin/bash', 18:58:29 INFO - 'SHLVL': '1', 18:58:29 INFO - 'TERM': 'linux', 18:58:29 INFO - 'TMOUT': '86400', 18:58:29 INFO - 'USER': 'cltbld', 18:58:29 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', 18:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:29 INFO - '_': '/tools/buildbot/bin/python'} 18:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:58:29 INFO - Running setup.py (path:/tmp/pip-AK6P3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:58:29 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:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:58:29 INFO - Running setup.py (path:/tmp/pip-FVrS5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:58:29 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:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:58:29 INFO - Running setup.py (path:/tmp/pip-4RrdLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:58:30 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:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:58:30 INFO - Running setup.py (path:/tmp/pip-pLBrqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:58:30 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:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:58:30 INFO - Running setup.py (path:/tmp/pip-OBaeNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:58:30 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:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:58:30 INFO - Running setup.py (path:/tmp/pip-YntTXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:58:30 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:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:58:30 INFO - Running setup.py (path:/tmp/pip-eYGR6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:58:30 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:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:58:30 INFO - Running setup.py (path:/tmp/pip-6Ksk5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:58:30 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:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:58:30 INFO - Running setup.py (path:/tmp/pip-LGFSUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:58:30 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:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:58:30 INFO - Running setup.py (path:/tmp/pip-YlWxP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:58:30 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:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:58:30 INFO - Running setup.py (path:/tmp/pip-0DZJly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:58:30 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:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:58:30 INFO - Running setup.py (path:/tmp/pip-aest8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:58:30 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:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:58:30 INFO - Running setup.py (path:/tmp/pip-EykeGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:58:30 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:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:58:30 INFO - Running setup.py (path:/tmp/pip-0pXxOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:58:30 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:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:58:30 INFO - Running setup.py (path:/tmp/pip-6a9nrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:58:30 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:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:58:30 INFO - Running setup.py (path:/tmp/pip-eaYnTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:58:30 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:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:58:30 INFO - Running setup.py (path:/tmp/pip-qdGRhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:58:31 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:58:31 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:58:31 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:58:31 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:58:31 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:58:31 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:58:31 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:58:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:58:31 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:58:31 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:58:31 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:58:31 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:58:32 INFO - Downloading blessings-1.6.tar.gz 18:58:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:58:32 INFO - Installing collected packages: blessings 18:58:32 INFO - Running setup.py install for blessings 18:58:32 INFO - Successfully installed blessings 18:58:32 INFO - Cleaning up... 18:58:32 INFO - Return code: 0 18:58:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:58:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:58:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:58:32 INFO - Reading from file tmpfile_stdout 18:58:32 INFO - Current package versions: 18:58:32 INFO - argparse == 1.2.1 18:58:32 INFO - blessings == 1.6 18:58:32 INFO - blobuploader == 1.2.4 18:58:32 INFO - docopt == 0.6.1 18:58:32 INFO - functools32 == 3.2.3-2 18:58:32 INFO - jsonschema == 2.5.1 18:58:32 INFO - manifestparser == 1.1 18:58:32 INFO - mozInstall == 1.13 18:58:32 INFO - mozcrash == 1.0 18:58:32 INFO - mozdebug == 0.1 18:58:32 INFO - mozdevice == 0.51 18:58:32 INFO - mozfile == 1.2 18:58:32 INFO - mozhttpd == 0.7 18:58:32 INFO - mozinfo == 0.10 18:58:32 INFO - mozleak == 0.1 18:58:32 INFO - mozlog == 3.5 18:58:32 INFO - moznetwork == 0.27 18:58:32 INFO - mozprocess == 0.25 18:58:32 INFO - mozprofile == 0.28 18:58:32 INFO - mozrunner == 6.13 18:58:32 INFO - mozscreenshot == 0.1 18:58:32 INFO - mozsystemmonitor == 0.3 18:58:32 INFO - moztest == 0.8 18:58:32 INFO - mozversion == 1.4 18:58:32 INFO - psutil == 3.1.1 18:58:32 INFO - requests == 1.2.3 18:58:32 INFO - wsgiref == 0.1.2 18:58:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:32 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 0xbac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1af90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18130>, '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 0xf19030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf194c0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', '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:58:32 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:58:32 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:58:32 INFO - Using env: {'DISPLAY': ':0', 18:58:32 INFO - 'HOME': '/home/cltbld', 18:58:32 INFO - 'LANG': 'en_US.UTF-8', 18:58:32 INFO - 'LANGUAGE': 'en_US:en', 18:58:32 INFO - 'LOGNAME': 'cltbld', 18:58:32 INFO - 'MAIL': '/var/mail/cltbld', 18:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:32 INFO - 'MOZ_NO_REMOTE': '1', 18:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:32 INFO - 'NO_EM_RESTART': '1', 18:58:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:32 INFO - 'PWD': '/builds/slave/test', 18:58:32 INFO - 'SHELL': '/bin/bash', 18:58:32 INFO - 'SHLVL': '1', 18:58:32 INFO - 'TERM': 'linux', 18:58:32 INFO - 'TMOUT': '86400', 18:58:32 INFO - 'USER': 'cltbld', 18:58:32 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', 18:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:32 INFO - '_': '/tools/buildbot/bin/python'} 18:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:32 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:58:32 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:58:32 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:58:32 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:58:32 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:58:32 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:58:32 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:58:32 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:58:32 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:58:32 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:58:32 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:58:32 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:58:32 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:58:32 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:58:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:58:33 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:58:33 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:58:33 INFO - Installing collected packages: simplejson 18:58:33 INFO - Running setup.py install for simplejson 18:58:34 INFO - building 'simplejson._speedups' extension 18:58:34 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:58:34 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:58:34 INFO - Successfully installed simplejson 18:58:34 INFO - Cleaning up... 18:58:35 INFO - Return code: 0 18:58:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:58:35 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:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:58:35 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:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:58:35 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 0xbac1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd77a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf1af90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18130>, '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 0xf19030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf194c0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', '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:58:35 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:58:35 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:58:35 INFO - Using env: {'DISPLAY': ':0', 18:58:35 INFO - 'HOME': '/home/cltbld', 18:58:35 INFO - 'LANG': 'en_US.UTF-8', 18:58:35 INFO - 'LANGUAGE': 'en_US:en', 18:58:35 INFO - 'LOGNAME': 'cltbld', 18:58:35 INFO - 'MAIL': '/var/mail/cltbld', 18:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:35 INFO - 'MOZ_NO_REMOTE': '1', 18:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:35 INFO - 'NO_EM_RESTART': '1', 18:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:35 INFO - 'PWD': '/builds/slave/test', 18:58:35 INFO - 'SHELL': '/bin/bash', 18:58:35 INFO - 'SHLVL': '1', 18:58:35 INFO - 'TERM': 'linux', 18:58:35 INFO - 'TMOUT': '86400', 18:58:35 INFO - 'USER': 'cltbld', 18:58:35 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', 18:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:35 INFO - '_': '/tools/buildbot/bin/python'} 18:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:58:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:58:35 INFO - Cleaning up... 18:58:35 INFO - Return code: 0 18:58:35 INFO - Running post-action listener: _resource_record_post_action 18:58:35 INFO - Running post-action listener: _start_resource_monitoring 18:58:35 INFO - Starting resource monitoring. 18:58:35 INFO - [mozharness: 2017-08-24 01:58:35.270738Z] Finished create-virtualenv step (success) 18:58:35 INFO - [mozharness: 2017-08-24 01:58:35.271252Z] Running install step. 18:58:35 INFO - Running pre-action listener: _resource_record_pre_action 18:58:35 INFO - Running main action method: install 18:58:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:58:35 INFO - Reading from file tmpfile_stdout 18:58:35 INFO - Detecting whether we're running mozinstall >=1.0... 18:58:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:58:35 INFO - Reading from file tmpfile_stdout 18:58:35 INFO - Output received: 18:58:35 INFO - Usage: mozinstall [options] installer 18:58:35 INFO - Options: 18:58:35 INFO - -h, --help show this help message and exit 18:58:35 INFO - -d DEST, --destination=DEST 18:58:35 INFO - Directory to install application into. [default: 18:58:35 INFO - "/builds/slave/test"] 18:58:35 INFO - --app=APP Application being installed. [default: firefox] 18:58:35 INFO - mkdir: /builds/slave/test/build/application 18:58:35 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:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:58:53 INFO - Reading from file tmpfile_stdout 18:58:53 INFO - Output received: 18:58:53 INFO - /builds/slave/test/build/application/firefox/firefox 18:58:53 INFO - Running post-action listener: _resource_record_post_action 18:58:53 INFO - [mozharness: 2017-08-24 01:58:53.318074Z] Finished install step (success) 18:58:53 INFO - [mozharness: 2017-08-24 01:58:53.318355Z] Running setup-mitmproxy step. 18:58:53 INFO - Running pre-action listener: _resource_record_pre_action 18:58:53 INFO - Running main action method: setup_mitmproxy 18:58:53 INFO - Skipping: mitmproxy is not required 18:58:53 INFO - Running post-action listener: _resource_record_post_action 18:58:53 INFO - [mozharness: 2017-08-24 01:58:53.319484Z] Finished setup-mitmproxy step (success) 18:58:53 INFO - [mozharness: 2017-08-24 01:58:53.319704Z] Running run-tests step. 18:58:53 INFO - Running pre-action listener: _resource_record_pre_action 18:58:53 INFO - Running pre-action listener: _set_gcov_prefix 18:58:53 INFO - Running main action method: run_tests 18:58:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:58:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:58:53 INFO - Python 2.7.3 18:58:53 INFO - Return code: 0 18:58:53 INFO - grabbing minidump binary from tooltool 18:58:53 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:58:53 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf18130>, '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 0xf19030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf194c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:58:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:58:53 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:58:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:58:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:58:53 INFO - Return code: 0 18:58:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:58:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:58:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:58:53 INFO - ENV: RUST_BACKTRACE is now full 18:58:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:58:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:58:53 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/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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:58:53 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/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --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:58:53 INFO - Using env: {'DISPLAY': ':0', 18:58:53 INFO - 'HOME': '/home/cltbld', 18:58:53 INFO - 'LANG': 'en_US.UTF-8', 18:58:53 INFO - 'LANGUAGE': 'en_US:en', 18:58:53 INFO - 'LOGNAME': 'cltbld', 18:58:53 INFO - 'MAIL': '/var/mail/cltbld', 18:58:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:58:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:53 INFO - 'MOZ_NO_REMOTE': '1', 18:58:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:53 INFO - 'NO_EM_RESTART': '1', 18:58:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:53 INFO - 'PWD': '/builds/slave/test', 18:58:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:58:53 INFO - 'RUST_BACKTRACE': 'full', 18:58:53 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:58:53 INFO - 'SHELL': '/bin/bash', 18:58:53 INFO - 'SHLVL': '1', 18:58:53 INFO - 'STYLO_FORCE_ENABLED': '1', 18:58:53 INFO - 'TERM': 'linux', 18:58:53 INFO - 'TMOUT': '86400', 18:58:53 INFO - 'USER': 'cltbld', 18:58:53 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289', 18:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:53 INFO - '_': '/tools/buildbot/bin/python'} 18:58:53 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/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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:58:53 INFO - mozversion application_buildid: 20170824010741 18:58:53 INFO - mozversion application_changeset: d1c70c20e7b52f7295411343e4dc5db8ee7c92b9 18:58:53 INFO - mozversion application_display_name: Nightly 18:58:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:58:53 INFO - mozversion application_name: Firefox 18:58:53 INFO - mozversion application_remotingname: firefox 18:58:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:58:53 INFO - mozversion application_vendor: Mozilla 18:58:53 INFO - mozversion application_version: 57.0a1 18:58:53 INFO - mozversion platform_buildid: 20170824010741 18:58:53 INFO - mozversion platform_changeset: d1c70c20e7b52f7295411343e4dc5db8ee7c92b9 18:58:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:58:53 INFO - mozversion platform_version: 57.0a1 18:58:53 INFO - using testdate: 1503539933 18:58:53 INFO - actual date: 1503539933 18:58:53 INFO - starting webserver on 'localhost:35005' 18:58:53 INFO - SUITE-START | Running 2 tests 18:58:53 INFO - TEST-START | dromaeo_css 18:58:53 INFO - Initialising browser for dromaeo_css test... 18:58:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35005/getInfo.html -profile /tmp/tmpCdRZhS/profile 18:58:53 INFO - TEST-INFO | started process 31505 (/builds/slave/test/build/application/firefox/firefox http://localhost:35005/getInfo.html) 18:58:59 INFO - TEST-INFO | 31505: exit 0 18:58:59 INFO - Browser initialized. 18:58:59 INFO - Running cycle 1/1 for dromaeo_css test... 18:58:59 INFO - TEST-INFO | started process 31691 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCdRZhS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:59:00 INFO - PID 31691 | 18:59:00 INFO - PID 31691 | (/builds/slave/test/build/application/firefox/firefox:31741): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:59:00 INFO - PID 31691 | 18:59:01 INFO - PID 31691 | 18:59:01 INFO - PID 31691 | (/builds/slave/test/build/application/firefox/firefox:31799): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:59:01 INFO - PID 31691 | 18:59:01 INFO - PID 31691 | __metrics Screen width/height:1600/1200 18:59:01 INFO - PID 31691 | colorDepth:24 18:59:01 INFO - PID 31691 | Browser inner width/height: 1024/768 18:59:01 INFO - PID 31691 | __metrics 18:59:10 INFO - PID 31691 | RSS: Main: 174936064 18:59:10 INFO - PID 31691 | 19:02:09 INFO - PID 31691 | Cycle 1(1): loaded http://localhost:35005/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35005/tests/dromaeo/cssquery-ext.html) 19:02:10 INFO - PID 31691 | RSS: Main: 178331648 19:02:10 INFO - PID 31691 | 19:05:12 INFO - PID 31691 | Cycle 1(1): loaded http://localhost:35005/tests/dromaeo/cssquery-ext.html (next: http://localhost:35005/tests/dromaeo/cssquery-jquery.html) 19:05:12 INFO - PID 31691 | RSS: Main: 175534080 19:05:12 INFO - PID 31691 | 19:08:14 INFO - PID 31691 | Cycle 1(1): loaded http://localhost:35005/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35005/tests/dromaeo/cssquery-mootools.html) 19:08:15 INFO - PID 31691 | RSS: Main: 177606656 19:08:15 INFO - PID 31691 | 19:11:17 INFO - PID 31691 | Cycle 1(1): loaded http://localhost:35005/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35005/tests/dromaeo/cssquery-prototype.html) 19:11:17 INFO - PID 31691 | RSS: Main: 175894528 19:11:17 INFO - PID 31691 | 19:14:21 INFO - PID 31691 | Cycle 1(1): loaded http://localhost:35005/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35005/tests/dromaeo/cssquery-yui.html) 19:14:22 INFO - PID 31691 | RSS: Main: 179539968 19:14:22 INFO - PID 31691 | 19:17:23 INFO - PID 31691 | Cycle 1(1): loaded http://localhost:35005/tests/dromaeo/cssquery-yui.html (next: http://localhost:35005/tests/dromaeo/cssquery-dojo.html) 19:17:24 INFO - PID 31691 | RSS: Main: 179924992 19:17:24 INFO - PID 31691 | 19:17:24 INFO - PID 31691 | __start_tp_report 19:17:24 INFO - PID 31691 | _x_x_mozilla_page_load 19:17:24 INFO - PID 31691 | _x_x_mozilla_page_load_details 19:17:24 INFO - PID 31691 | |i|pagename|runs| 19:17:24 INFO - PID 31691 | |0;dojo.html;3254.2027203335188;3290.226796702775;3296.3901678189527;3300.9174770630716;3308.090275174327;6190.8142755717345;6224.377562243779;6227.626342419447;6283.994560870256;6301.653409062511;6097.817065488042;6206.751729930797;6214.564980451359;6216.533759968009;6248.437640612344;5658.292713410824;5681.943180568203;5712.143178523234;5728.971355143219;5774.81616268666;5784.797532086378;5823.359430462646;5829.912551311733;5841.532677385799;5852.268466441695;5612.41069687681;5740.138979153118;5800.651960882339;5873.911891321633;5894.322152952423;5696.287964004499;5708.257926469574;5773.220615216934;5782.45066718661;5803.419658034205;5712.971435142839;5740.913886291709;5812.622179558315;5816.6219195752565;5837.824865254049;6067.878642427127;6163.198784158076;6193.969030154865;6314.400131987454;6314.831756125086;6612.834679133012;6637;6639.369259920348;6656.134702488694;6686.83282917926;6636.634985075819;6710.5302628816;6726;6727.29363416844;6732;6130.509559235251;6136.294326152505;6232;6268.871603111484;6296.1500197473215;6732.225794033651;6799.1161149051295;6824.283450237753;6832.385085342343;6911.9308806912295;6511.023346497968;6526.151600292027;6551.901721474182;6553.180852393451;6641.236257830411;6642.1033160523675;6662.700178491979;6745.9662701686175;6748.257691653914;6754.18949726036;6424.775132870421;6564.80305590833;6618.040384144272;6659.433948114464;6719.294474080249;6613.437857782046;6643.202815662152;6650.135482387259;6660.433863121689;6668.666566671647;4928.310036594879;4963.429205641325;4978.6763860348965;4987.376577927759;5003.224500202475;4274.316109422478;4289.935650965238;4326.567343265649;4329.826806927751;4331.805068771912;5828.388019258002;5834.095715164156;5877.471027607536;5880.382559831241;5885;6620.172478440195;6663.633500157441;6679.56582822115;6682.832929176712;6686.364795344434;5857.297124345021;5916.911246331309;5960.314563825129;5969.761209551656;5978;5694.572907031989;5732.254806875079;5772.278465191851;5772.769089236467;5801.767929282866;6300.464460520907;6343.302236753953;6364.49084073273;6439.839004024843;6441.935580644227;6635.867282654416;6680.465562754871;6684.16447944007;6686.732530698718;6693.933060669331;6416.550841441054;6442.420182183626;6448;6473.320301368289;6497.382748638872;6524.706388212447;6545.6399898004165;6564.179477565304;6612.140421745335;6624.205095388585;6547.214334279917;6640.136782218281;6711.697973591103;6736.73053077891;6745.325467453412;6432.839179020562;6518.608883467007;6520.967395162994;6528.183977002875;6538.542302038812;6484.157059582224;6520.3805638466165;6540.149780528501;6588.769393071219;6605.306442823435;6388.776392826228;6431.807045788634;6475.902861456988;6500.479961602966;6518.152640156749;6540.574862633914;6540.738370465318;6553.639549824615;6607.603543787388;6626.83432914181;6188.845278868064;6261.718222680081;6284.780032699016;6340.4927605792345;6351.618902865843 19:17:24 INFO - PID 31691 | |1;ext.html;788.5820515126985;790.3835008693221;822.9917700822992;836.7113345895667;852.13933926734;39181;39915.20169596606;40058;40171.39742903855;40262.59737402625;36998.445023324675;37205.62794372055;37336.81331593338;37349;37361.626383736155;7060.046893669353;7177.318154775288;7178.066851309322;7180.066591343144;7189.281071892821;7035.190953040389;7127.85744285114;7130.964345178293;7134.892976605355;7145.821354466154;7063.964680176592;7077.044598979149;7082.397996170306;7091.468139889503;7112.78661640149;7050.6827192776445;7065.470089743264;7113.110861142357;7117.323854233891;7118.359347658709;6459.031145328191;6466.094746735461;6492.383223593751;6512.6092434454085;6521.250056243545;32473.51289730656;33048.50427243593;33125.503117453256;33134.502982455284;33148.6685133148;3391.643877392863;3392.1689186149306;3405.455127179664;3406.9659303406897;3411.385950528904;27259.182224533295;27274.863625681945;27343.316417089532;27423.725762742317;27523.587146192822;4451.866444006685;4529.592336689714;4571.679982401233;4586.1744885920525;4611.9077618447445;186836;188514;188522;189324;189496;20697.482562936046;20938.267160649306;20947.476313092295;21008.05463754104;48799.756001219765;50102.49897500978;50477.49522504801;50643.24035139476;50784;50833;15698.529044128694;16133.919330403272;16151.919240403722;16183.514494565183;16313.918430407772;13248.602541923758;13337.26645034513;13343.332833358294;13356.131851429625;13361.599152025456;13679.726405472034;13840.93079534616;13845.792313115311;13873.236971966639;14032.158070515801;5577.832665019975;5627.943720562824;5665.206871038058;5682.829515114553;5711.257536520309;995.2833959549113;996.7209181429066;999.9850002249972;1019.8215312320463;1036.233187441303;22706.545869082525;22719.88640056789;22801.657975130387;22948.885255573616;23198.1880634177;1109.7114750165015;1113.560143743217;1115.3029356652091;1116.8548088748573;1139.6467095200514;12080.697982550506;12113;12140.514379424902;12163.635090947286;12180.939095304468;234258;236336;236540;236730;236922;44510.77744611256;45028;45080.54919450829;51122.233166502534;51602.22596661053;1439.3379045638915;1448.4423496953748;1448.66680663448;1451.7822326651087;1457.1257245652523;26887.86556067207;27017.324566885985;27289.48495929732;27312.72687273102;27642.861785690944;32311;32731.836340818143;36542.086447839014;36562.08594785045;36566.26867462689;178128;179106;179193;179300;179372;33977.49033764446;34058.65941340555;34088.82955585206;34111.31777364389;34303;40917.59082409257;42280.365794513724;42617.36073958955;42675;42710.78644606757;30990.69009309968;30992;31282.843585781924;31356.372872542877;31406.68593314129;29905.850470747508;30683.232919176306;30691.2327191822;31219;31253.218669533442;34437;34693.653063470054;34857;34959.475607865395;35045.47431788576;30258.092257232318;30424.239394014443;30451.390972180874;30913.845430773603;30959.845200773852;22152;22779.494255631536;22958.540829182988;23615.173468928504;24264.1507547235 19:17:24 INFO - PID 31691 | |2;jquery.html;551.310861423221;555.2365497441018;558.9608727389084;571.6113043130672;578.9942100578994;21946.45133871654;22044.559108817815;22760.88619556902;22771.089156433743;22982.19562315319;24751.25746227616;24947;25137.49725005499;25287.62068568973;25295.873520632416;6471.870562588745;6646.10277612521;6650.900236496456;6651.8337041574105;6653.667316634173;6446.419822215999;6534.54258201926;6587.670616469181;7037.577745335297;7071.151461824588;7061.964690176542;7064.25825288345;7064.576125432491;7068.82327941803;7071.964640176792;7006.509544331899;7046.9647651761925;7055.506114571982;7056.117985251869;7059.082319298458;6867.725290988405;6880.208775990775;6884.827879303008;6895.862082758316;6927.134108236471;29911.252218694488;30318.84840575805;30534.694653053408;30539.541906871415;30830.075097747103;2091.7176181215495;2135.47680818199;2137.8931053447423;2139.5079131799775;2141.389703934371;20347.79652203474;20761.688574671392;20817.271395501237;20997.26509572173;21012;2547.847129172256;2563.7564431378987;2624.39638883058;2644.3256969472855;2651;136226;139161;139464.30267848697;142796;143314.99999999895;19250.8074919249;21414.57170856574;21491.355259342246;21869.234576789735;22498.550028999656;21323.573528529654;22225.444363890707;22436;22594.09623615037;42681;9564.856527152098;9623.903760962441;9789.51052447389;9873.703788886345;9906.157976572073;9029.954850225708;9104.8634270486;9126;9206.447613143098;9243.306751993627;8873.423227490193;8981.416207946462;8997.235235005099;9199.862002069975;9308.767280817898;2581.6385706001174;2627.8160528763187;2660;2686.8925242990454;2700.3789128500557;963.3304853127149;972.1202311907734;977.8728765260613;991.9950400247952;994.6021591363512;19362.515937101685;19544.12051457688;19834.305799296955;19906.90046549787;23853.403664908168;988.5699720621552;1027.9331843430152;1035.5288343803552;1038.9688309350731;1055.1295181475314;10707.518161682743;10818.783624327469;10825.188110891715;10999.560017599366;13042.282674452996;506971;513053;524732;525304;533561;121137.39431302786;122081;126713.36643316725;127264;127659;1185.3480585678014;1217.8234156047502;1226.4174517104304;1240.3674126195524;1241.6585439004346;20264.392068237976;20331.491712707302;20333.796662033783;21133.154673812875;21341.893290533448;58448;58557;59940;61273;61486.69256653688;68150;68639.65680171567;68735.31264687289;69263.30736692568;69734.65132674304;14488.348024338718;14515.274236288355;14552.85447145515;14766.704665906836;14794.260286985393;23550.646740299253;23658.763412365657;23746.525069498166;23802.64296035526;23818.88090559536;18287.359942401952;18565.535861603566;18621.348252811087;18640.81359186391;18662.34681786131;15288.235588220767;16626.584335391228;16667.3333066676;17239.482815515556;17260.223289952235;18067.54831129232;18792.248310067444;19102.617947641247;19187.616247675247;19197.616047679247;14560;14563.126212427289;14643.70712585721;14644.41422343137;14658.560243192722;18087.18607662632;18512.259509619464;18540.629187416445;18705.625887482445;18770.71843922315 19:17:24 INFO - PID 31691 | |3;mootools.html;1326.3368315842079;1369.6781256404743;1377.5109836008216;1392.0951381601965;1404.59968908861;14453;15071.849281507182;15117.773233401507;15151.848481515182;15155.848441515582;14366.640833979129;14777.261136943136;15338.846611533882;15366.23168841559;15367.15480648564;2683.2755156107887;2729.3858881751644;2730.959035614467;2732.562789953608;2736.644236249285;2593.0405749872575;2675.6789185297794;2681.7452342027477;2730.494858451183;2733.603627474015;2702.702702702701;2716.2258756254473;2718.864056797162;2719.619253304529;2724.441489494649;2653.548896687558;2664.8667566621784;2666.799990000748;2674.104175101353;2674.6924103728124;2602.1803132013542;2623.27859838544;2630.224083895236;2633.2626864477975;2636.209137258834;14210;14504;14506.492272770507;14515.419383224658;14524.782128268085;7701.19137490561;7875.409344299143;7951.880721789178;7963.203679632048;7966.800829979239;5140.948590514085;5289.18017707256;5461.777551244784;5506.284183056217;5507.201455788928;1945.8346040586566;1965.4398496428591;1995.750531183602;2037.5721098569318;2049.661805802041;22708.205212817473;24998;25266.747332526807;25345.239642810746;25364.746352536422;5893.616914900604;6500.674966251669;6624;6658.4673226141795;6701.899471507932;16526.091064991302;16575.502734917973;16638.50084497467;16640;16648.25082871274;7680.923190768132;7685;7692.423068269902;7972.641231144612;8160;7154.713811447484;7269.8546029079125;7327.303906128909;7336.559806411632;7350.19147893742;4960.578350840146;5044.672096313728;5055.191169412877;5103.464136265713;5105.897882042413;1500.3098574655562;1502.8121484814399;1522.7944227529142;1526.8396818333915;1528.9694206116037;899.9325050621229;927.1562877781187;927.2257664849791;927.7726956895469;937.1940131486916;7736.2650548197835;7800.804979875548;7825.334846537994;7842.254985776342;7943.523388596703;719.8200449887528;721.3003386714878;721.6608194148741;733.8715724748148;735.5219107580116;4953.851384458472;5240.816571419982;5408.972955135199;5463.672179669233;5562.610617256753;19965.401037968884;20997.370078897657;21034.158633654788;21176.152953881672;21181.152753889673;20137.899310503646;20622.793772062087;20768.961551922344;20826;20875.895620521802;10253.948730256301;10290.845637315446;10324.587016519405;10330.380177189392;10345.068943794944;7942.960285198537;8182.095356148481;8264.586770661323;8400.663973440995;8403.495790252604;17938.5515362117;18439.72340414868;18443.170057347183;18640.81359186445;18686.719699204794;15467.690646187239;16844.15779211059;17556.648867022843;18934.242630294633;19113.426597202106;10593.258471906893;10694.572217111228;10695.144388448749;10699.8930010702;10703.678889633324;13279;13529.458821647419;13602.523911663044;13678.247696376795;13678.521251756141;10712.571497140027;10712.625058122929;10715.57137714514;10879.673609791718;11009.61466348674;10621.628243011457;10681.57273709074;10710.732231693959;10804.40575768309;10918.29031113007;9347.859782103409;9466.195373393339;9485.66800161991;9541.236701064037;9599.904000959901;6859.382655561023;7027.508074434741;7053.858922821618;7078.1506219254015;7147.85704285901;7263.745768898063;7372.225916278713;7401.259874012556;7422.14645315774;7457.850842983218 19:17:24 INFO - PID 31691 | |4;prototype.html;493.8543129776718;498.54881332394183;515.9406668233153;520.9296744939433;531.2827682628453;6251.843703907399;6329.588576742509;6372.522060845432;6402.615843049414;6403.807885763435;6009.158717779504;6195.380461953802;6207.317195108534;6220.325260138139;6255.843603909893;5002.924956125661;5035.295058691786;5075.299774575522;5076.593872490211;5084.3390359253335;5014.373203349582;5017.322661440695;5022.623303252252;5038.521340472649;5074.27474658616;4798.568128868401;4924.2121260598315;5012.598992080625;5019.121653710586;5048.7223202723835;4916.041371932474;4968.205087186069;5003.2245002024565;5005.849824505234;5056.570191533724;4422.071365013351;4448.821062418462;4460.241758900995;4475.695017066214;4496.303073023687;5998.550108741862;6001.609895356832;6020.110347033405;6052.606580572248;6095.573309868311;5743.597948143632;5744.942550574483;5751.712414379306;5772.451617096369;5779.768809247625;6507.772227972046;6508.446782023534;6538.444232240217;6571.211454625475;6575.506836987197;4871.318015477836;4880.658353915227;4900.730459824708;4903.338049363361;4904.656674032819;6910.861782764367;6959.826004349881;6985.5808651481075;7007.194172670157;7007.92992070083;5003;5014.648974571745;5014.899702006012;5017.698938063728;5085.644004919694;5005.499450054966;5078.314427552307;5097.209932460474;5113.181890897438;5116.513931176532;5612.270404847343;5638.323401191883;5684;5731.484166425042;5742.971285143631;6479;6510.3489651034515;6540.378664027005;6641.435477984329;6658.86682266352;1654.139847279408;1714.7256438969705;1748.204566922073;1751.5621094726318;1753.824617538236;1149.9252548584316;1191.386435985468;1217.8964787992943;1226.337777600104;1235.839340885697;5711.228984087178;5712.485876271156;5731.7420716067045;5749.741261643152;5803.65178089316;6504.365731878502;6569.605823650596;6590.3080176581725;6611.768588099393;6644.568103073381;5737.3975732548315;5782.2194003808945;5814.360420353758;5834;5866.2373891393845;3529.241213139136;3553.236054248349;3587.587427445877;3609.566851977727;3640.472131540912;6339.562306385548;6348.682565871688;6404.7117879695525;6405.743770249231;6451.870882608728;6898.793036208922;6922.550034247758;6966.9651651741415;6987.965060174768;7044.330788575077;6366.745330186741;6408.180400623711;6446.419822216023;6473.967630161819;6551.4103730664465;6633.834154145992;6644.867102658017;6676.866462670817;6722.563033402813;6786.253512113763;6639.568428052161;6648.335166483506;6669.499787515859;6685.69914353865;6713.885126185236;6409.4231519163495;6492.220933488012;6497.707603157964;6516;6541.247756508063;4950.920613342333;4979.0290893276915;5015;5059.494050594911;5059.974700126623;6690.230623478362;6710;6720;6754.121964144826;6819.318068193141;6517.9245424504425;6528.314526974599;6549.901751473636;6630.90053649186;6634.83412914681;6552.770653027121;6552.770653027312;6555.6066636002;6625.635590042594;6680.131582894192;6065.696715164136;6486.318936511599;6552.6068435894;6567.44176744982;6569.4744420447205;6465.903011454738;6491.740330386731;6532.706028228836;6594.637294948824;6605.801825945037;6294.433500984934;6340.556161068866;6376.968115159394;6391.712372943136;6418.358164183544 19:17:24 INFO - PID 31691 | |5;yui.html;859.3640705877652;877.3945977275679;889.3818795936827;890.7327801659501;897.3001059173845;17841.28634854606;18537.443876683687;18545.35091271806;18563.16465759041;21735.565288694215;20528;21036.263730769428;21104.68342974853;21128.577428451423;21202.575948481022;891.4339394484516;917.5733284022928;919.2370332623906;919.4253591505309;919.8850143732034;918.4626993208981;956.3162338927665;970.9757256068619;973.0221127766584;976.8534719792052;1014.371089924248;1017.0744622393623;1017.6692574913183;1017.6896046705751;1018.6129270877057;1003.6537394598852;1007.4408703169738;1007.9244056695741;1008.8638033865408;1008.9596416143382;730.817295676081;732.5714457042636;735.5880706804153;739.8483310921303;740.9962950185269;19340.613187736308;19620.313289034817;19790.90104549468;19926.202951881907;20054.799452005438;20901.477463063395;20946.266880659103;21195.576088478145;21496.78503214979;21536.676949845765;16275.267612957445;16664.333426662917;16915.492535223962;16926.23831927566;16928.91535542327;3653.9086522836874;3679.0618392310057;3679.2825399047197;3682.061074426031;3689.741718079709;120153.39923300415;120349.39825300904;121613.39193304065;123206;123412;16339;16412.589685257724;16800.663986720196;16815.579610509834;16881.915590422213;28249.435011299658;28982.710172898;29073;29074.273143171165;29221.41557168845;8505.532195729294;8598.87101693475;8611.95694021526;8616.569171541398;8626.78433039179;4153.563875793058;4226.070264541796;4235.894102647459;4236.915261694749;4242.087951090469;4979.477154898684;5034.421041580192;5055.266986286968;5064.442911279756;5080.669756465818;902.2240872849344;919.6137622198693;920.0753242990885;927.4110939553432;928.1461055828654;667.4526887951832;679.3546131175403;679.8742232686968;680.8502129531495;684.5310961991051;11128;11318.434078296052;11319.264247823865;11544.711382215344;12146.210496317888;691.2741621297617;692.875282449164;697.2504557600599;706.3254591864757;710.5559025608994;5718.227349521661;5747.885042299131;5830.067189249785;5839.357670656224;6488.513361497812;111703;112985;113142;113219;114748;94400;95118.5244073789;95709.52145239229;96100;96373.51813240889;83843;85136.57431712802;86350;86984.13015869887;89746.10253897509;12934.159279646792;13029.543965961146;13140.934295328461;13174.473021079433;13177.868221317663;38719.80640096781;39799;41031.58968410278;41180.1763964725;42020.1595968085;50770.492295076576;51624.741876290376;51756.741216293674;51815.74092129515;51863.48136518738;17053.57366065858;17110.572235694206;17191.484255472355;17294.135293235035;17311.3941012064;20743.1702731889;20991.895040524698;21057.368278951657;21061.789382106595;21539.784602154406;18602.255909764;19151.808481915003;19205.8079419204;19452;19489.805101949365;19032.1435535404;19307.324243651405;19435.902820485808;19449.31927382535;19617.80382196217;18281.177347019682;18453.261869525606;18836.905815470836;18925.337613183474;19083.713744293567;13445.596632101053;13447.529336473177;13507.864921350661;13745.862541374858;14301.141931484144;13256.93371533136;13282.800757988445;13432.39554220043;13446.731065378443;13465.192088474723 19:17:24 INFO - PID 31691 | __end_tp_report 19:17:24 INFO - PID 31691 | __start_cc_report 19:17:24 INFO - PID 31691 | _x_x_mozilla_cycle_collect,376 19:17:24 INFO - PID 31691 | __end_cc_report 19:17:24 INFO - PID 31691 | __startTimestamp1503541044114__endTimestamp 19:17:24 INFO - PID 31691 | 19:17:24 INFO - PID 31691 | ------- Summary: start ------- 19:17:24 INFO - PID 31691 | Number of tests: 6 19:17:24 INFO - PID 31691 | 19:17:24 INFO - PID 31691 | [#0] dojo.html Cycles:165 Average:6131.49 Median:6364.49 stddev:734.78 (11.5%) stddev-sans-first:701.51 19:17:24 INFO - PID 31691 | Values: 3254.2 3290.2 3296.4 3300.9 3308.1 6190.8 6224.4 6227.6 6284.0 6301.7 6097.8 6206.8 6214.6 6216.5 6248.4 5658.3 5681.9 5712.1 5729.0 5774.8 5784.8 5823.4 5829.9 5841.5 5852.3 5612.4 5740.1 5800.7 5873.9 5894.3 5696.3 5708.3 5773.2 5782.5 5803.4 5713.0 5740.9 5812.6 5816.6 5837.8 6067.9 6163.2 6194.0 6314.4 6314.8 6612.8 6637.0 6639.4 6656.1 6686.8 6636.6 6710.5 6726.0 6727.3 6732.0 6130.5 6136.3 6232.0 6268.9 6296.2 6732.2 6799.1 6824.3 6832.4 6911.9 6511.0 6526.2 6551.9 6553.2 6641.2 6642.1 6662.7 6746.0 6748.3 6754.2 6424.8 6564.8 6618.0 6659.4 6719.3 6613.4 6643.2 6650.1 6660.4 6668.7 4928.3 4963.4 4978.7 4987.4 5003.2 4274.3 4289.9 4326.6 4329.8 4331.8 5828.4 5834.1 5877.5 5880.4 5885.0 6620.2 6663.6 6679.6 6682.8 6686.4 5857.3 5916.9 5960.3 5969.8 5978.0 5694.6 5732.3 5772.3 5772.8 5801.8 6300.5 6343.3 6364.5 6439.8 6441.9 6635.9 6680.5 6684.2 6686.7 6693.9 6416.6 6442.4 6448.0 6473.3 6497.4 6524.7 6545.6 6564.2 6612.1 6624.2 6547.2 6640.1 6711.7 6736.7 6745.3 6432.8 6518.6 6521.0 6528.2 6538.5 6484.2 6520.4 6540.1 6588.8 6605.3 6388.8 6431.8 6475.9 6500.5 6518.2 6540.6 6540.7 6553.6 6607.6 6626.8 6188.8 6261.7 6284.8 6340.5 6351.6 19:17:24 INFO - PID 31691 | 19:17:24 INFO - PID 31691 | [#1] ext.html Cycles:180 Average:35722.57 Median:33130.00 stddev:52592.91 (158.7%) stddev-sans-first:52675.04 19:17:24 INFO - PID 31691 | Values: 788.6 790.4 823.0 836.7 852.1 39181.0 39915.2 40058.0 40171.4 40262.6 36998.4 37205.6 37336.8 37349.0 37361.6 7060.0 7177.3 7178.1 7180.1 7189.3 7035.2 7127.9 7131.0 7134.9 7145.8 7064.0 7077.0 7082.4 7091.5 7112.8 7050.7 7065.5 7113.1 7117.3 7118.4 6459.0 6466.1 6492.4 6512.6 6521.3 32473.5 33048.5 33125.5 33134.5 33148.7 3391.6 3392.2 3405.5 3407.0 3411.4 27259.2 27274.9 27343.3 27423.7 27523.6 4451.9 4529.6 4571.7 4586.2 4611.9 186836.0 188514.0 188522.0 189324.0 189496.0 20697.5 20938.3 20947.5 21008.1 48799.8 50102.5 50477.5 50643.2 50784.0 50833.0 15698.5 16133.9 16151.9 16183.5 16313.9 13248.6 13337.3 13343.3 13356.1 13361.6 13679.7 13840.9 13845.8 13873.2 14032.2 5577.8 5627.9 5665.2 5682.8 5711.3 995.3 996.7 1000.0 1019.8 1036.2 22706.5 22719.9 22801.7 22948.9 23198.2 1109.7 1113.6 1115.3 1116.9 1139.6 12080.7 12113.0 12140.5 12163.6 12180.9 234258.0 236336.0 236540.0 236730.0 236922.0 44510.8 45028.0 45080.5 51122.2 51602.2 1439.3 1448.4 1448.7 1451.8 1457.1 26887.9 27017.3 27289.5 27312.7 27642.9 32311.0 32731.8 36542.1 36562.1 36566.3 178128.0 179106.0 179193.0 179300.0 179372.0 33977.5 34058.7 34088.8 34111.3 34303.0 40917.6 42280.4 42617.4 42675.0 42710.8 30990.7 30992.0 31282.8 31356.4 31406.7 29905.9 30683.2 30691.2 31219.0 31253.2 34437.0 34693.7 34857.0 34959.5 35045.5 30258.1 30424.2 30451.4 30913.8 30959.8 22152.0 22779.5 22958.5 23615.2 24264.2 19:17:24 INFO - PID 31691 | 19:17:24 INFO - PID 31691 | [#2] jquery.html Cycles:180 Average:36460.18 Median:23810.76 stddev:87569.69 (367.8%) stddev-sans-first:87773.84 19:17:24 INFO - PID 31691 | Values: 551.3 555.2 559.0 571.6 579.0 21946.5 22044.6 22760.9 22771.1 22982.2 24751.3 24947.0 25137.5 25287.6 25295.9 6471.9 6646.1 6650.9 6651.8 6653.7 6446.4 6534.5 6587.7 7037.6 7071.2 7062.0 7064.3 7064.6 7068.8 7072.0 7006.5 7047.0 7055.5 7056.1 7059.1 6867.7 6880.2 6884.8 6895.9 6927.1 29911.3 30318.8 30534.7 30539.5 30830.1 2091.7 2135.5 2137.9 2139.5 2141.4 20347.8 20761.7 20817.3 20997.3 21012.0 2547.8 2563.8 2624.4 2644.3 2651.0 136226.0 139161.0 139464.3 142796.0 143315.0 19250.8 21414.6 21491.4 21869.2 22498.6 21323.6 22225.4 22436.0 22594.1 42681.0 9564.9 9623.9 9789.5 9873.7 9906.2 9030.0 9104.9 9126.0 9206.4 9243.3 8873.4 8981.4 8997.2 9199.9 9308.8 2581.6 2627.8 2660.0 2686.9 2700.4 963.3 972.1 977.9 992.0 994.6 19362.5 19544.1 19834.3 19906.9 23853.4 988.6 1027.9 1035.5 1039.0 1055.1 10707.5 10818.8 10825.2 10999.6 13042.3 506971.0 513053.0 524732.0 525304.0 533561.0 121137.4 122081.0 126713.4 127264.0 127659.0 1185.3 1217.8 1226.4 1240.4 1241.7 20264.4 20331.5 20333.8 21133.2 21341.9 58448.0 58557.0 59940.0 61273.0 61486.7 68150.0 68639.7 68735.3 69263.3 69734.7 14488.3 14515.3 14552.9 14766.7 14794.3 23550.6 23658.8 23746.5 23802.6 23818.9 18287.4 18565.5 18621.3 18640.8 18662.3 15288.2 16626.6 16667.3 17239.5 17260.2 18067.5 18792.2 19102.6 19187.6 19197.6 14560.0 14563.1 14643.7 14644.4 14658.6 18087.2 18512.3 18540.6 18705.6 18770.7 19:17:24 INFO - PID 31691 | 19:17:24 INFO - PID 31691 | [#3] mootools.html Cycles:180 Average:9017.56 Median:2644.88 stddev:6344.96 (239.9%) stddev-sans-first:6336.44 19:17:24 INFO - PID 31691 | Values: 1326.3 1369.7 1377.5 1392.1 1404.6 14453.0 15071.8 15117.8 15151.8 15155.8 14366.6 14777.3 15338.8 15366.2 15367.2 2683.3 2729.4 2731.0 2732.6 2736.6 2593.0 2675.7 2681.7 2730.5 2733.6 2702.7 2716.2 2718.9 2719.6 2724.4 2653.5 2664.9 2666.8 2674.1 2674.7 2602.2 2623.3 2630.2 2633.3 2636.2 14210.0 14504.0 14506.5 14515.4 14524.8 7701.2 7875.4 7951.9 7963.2 7966.8 5140.9 5289.2 5461.8 5506.3 5507.2 1945.8 1965.4 1995.8 2037.6 2049.7 22708.2 24998.0 25266.7 25345.2 25364.7 5893.6 6500.7 6624.0 6658.5 6701.9 16526.1 16575.5 16638.5 16640.0 16648.3 7680.9 7685.0 7692.4 7972.6 8160.0 7154.7 7269.9 7327.3 7336.6 7350.2 4960.6 5044.7 5055.2 5103.5 5105.9 1500.3 1502.8 1522.8 1526.8 1529.0 899.9 927.2 927.2 927.8 937.2 7736.3 7800.8 7825.3 7842.3 7943.5 719.8 721.3 721.7 733.9 735.5 4953.9 5240.8 5409.0 5463.7 5562.6 19965.4 20997.4 21034.2 21176.2 21181.2 20137.9 20622.8 20769.0 20826.0 20875.9 10253.9 10290.8 10324.6 10330.4 10345.1 7943.0 8182.1 8264.6 8400.7 8403.5 17938.6 18439.7 18443.2 18640.8 18686.7 15467.7 16844.2 17556.6 18934.2 19113.4 10593.3 10694.6 10695.1 10699.9 10703.7 13279.0 13529.5 13602.5 13678.2 13678.5 10712.6 10712.6 10715.6 10879.7 11009.6 10621.6 10681.6 10710.7 10804.4 10918.3 9347.9 9466.2 9485.7 9541.2 9599.9 6859.4 7027.5 7053.9 7078.2 7147.9 7263.7 7372.2 7401.3 7422.1 7457.9 19:17:24 INFO - PID 31691 | 19:17:24 INFO - PID 31691 | [#4] prototype.html Cycles:180 Average:5518.62 Median:6080.64 stddev:1549.18 (25.5%) stddev-sans-first:1506.92 19:17:24 INFO - PID 31691 | Values: 493.9 498.5 515.9 520.9 531.3 6251.8 6329.6 6372.5 6402.6 6403.8 6009.2 6195.4 6207.3 6220.3 6255.8 5002.9 5035.3 5075.3 5076.6 5084.3 5014.4 5017.3 5022.6 5038.5 5074.3 4798.6 4924.2 5012.6 5019.1 5048.7 4916.0 4968.2 5003.2 5005.8 5056.6 4422.1 4448.8 4460.2 4475.7 4496.3 5998.6 6001.6 6020.1 6052.6 6095.6 5743.6 5744.9 5751.7 5772.5 5779.8 6507.8 6508.4 6538.4 6571.2 6575.5 4871.3 4880.7 4900.7 4903.3 4904.7 6910.9 6959.8 6985.6 7007.2 7007.9 5003.0 5014.6 5014.9 5017.7 5085.6 5005.5 5078.3 5097.2 5113.2 5116.5 5612.3 5638.3 5684.0 5731.5 5743.0 6479.0 6510.3 6540.4 6641.4 6658.9 1654.1 1714.7 1748.2 1751.6 1753.8 1149.9 1191.4 1217.9 1226.3 1235.8 5711.2 5712.5 5731.7 5749.7 5803.7 6504.4 6569.6 6590.3 6611.8 6644.6 5737.4 5782.2 5814.4 5834.0 5866.2 3529.2 3553.2 3587.6 3609.6 3640.5 6339.6 6348.7 6404.7 6405.7 6451.9 6898.8 6922.6 6967.0 6988.0 7044.3 6366.7 6408.2 6446.4 6474.0 6551.4 6633.8 6644.9 6676.9 6722.6 6786.3 6639.6 6648.3 6669.5 6685.7 6713.9 6409.4 6492.2 6497.7 6516.0 6541.2 4950.9 4979.0 5015.0 5059.5 5060.0 6690.2 6710.0 6720.0 6754.1 6819.3 6517.9 6528.3 6549.9 6630.9 6634.8 6552.8 6552.8 6555.6 6625.6 6680.1 6065.7 6486.3 6552.6 6567.4 6569.5 6465.9 6491.7 6532.7 6594.6 6605.8 6294.4 6340.6 6377.0 6391.7 6418.4 19:17:24 INFO - PID 31691 | 19:17:24 INFO - PID 31691 | [#5] yui.html Cycles:180 Average:23187.43 Median:21349.68 stddev:31220.50 (146.2%) stddev-sans-first:31263.06 19:17:24 INFO - PID 31691 | Values: 859.4 877.4 889.4 890.7 897.3 17841.3 18537.4 18545.4 18563.2 21735.6 20528.0 21036.3 21104.7 21128.6 21202.6 891.4 917.6 919.2 919.4 919.9 918.5 956.3 971.0 973.0 976.9 1014.4 1017.1 1017.7 1017.7 1018.6 1003.7 1007.4 1007.9 1008.9 1009.0 730.8 732.6 735.6 739.8 741.0 19340.6 19620.3 19790.9 19926.2 20054.8 20901.5 20946.3 21195.6 21496.8 21536.7 16275.3 16664.3 16915.5 16926.2 16928.9 3653.9 3679.1 3679.3 3682.1 3689.7 120153.4 120349.4 121613.4 123206.0 123412.0 16339.0 16412.6 16800.7 16815.6 16881.9 28249.4 28982.7 29073.0 29074.3 29221.4 8505.5 8598.9 8612.0 8616.6 8626.8 4153.6 4226.1 4235.9 4236.9 4242.1 4979.5 5034.4 5055.3 5064.4 5080.7 902.2 919.6 920.1 927.4 928.1 667.5 679.4 679.9 680.9 684.5 11128.0 11318.4 11319.3 11544.7 12146.2 691.3 692.9 697.3 706.3 710.6 5718.2 5747.9 5830.1 5839.4 6488.5 111703.0 112985.0 113142.0 113219.0 114748.0 94400.0 95118.5 95709.5 96100.0 96373.5 83843.0 85136.6 86350.0 86984.1 89746.1 12934.2 13029.5 13140.9 13174.5 13177.9 38719.8 39799.0 41031.6 41180.2 42020.2 50770.5 51624.7 51756.7 51815.7 51863.5 17053.6 17110.6 17191.5 17294.1 17311.4 20743.2 20991.9 21057.4 21061.8 21539.8 18602.3 19151.8 19205.8 19452.0 19489.8 19032.1 19307.3 19435.9 19449.3 19617.8 18281.2 18453.3 18836.9 18925.3 19083.7 13445.6 13447.5 13507.9 13745.9 14301.1 13256.9 13282.8 13432.4 13446.7 13465.2 19:17:24 INFO - PID 31691 | -------- Summary: end -------- 19:17:24 INFO - PID 31691 | 19:17:24 INFO - TEST-INFO | 31691: exit 0 19:17:24 INFO - TEST-OK | dromaeo_css | took 1111105ms 19:17:24 INFO - TEST-START | kraken 19:17:24 INFO - Initialising browser for kraken test... 19:17:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35005/getInfo.html -profile /tmp/tmpvQtUra/profile 19:17:24 INFO - TEST-INFO | started process 32112 (/builds/slave/test/build/application/firefox/firefox http://localhost:35005/getInfo.html) 19:17:30 INFO - TEST-INFO | 32112: exit 0 19:17:30 INFO - Browser initialized. 19:17:30 INFO - Running cycle 1/1 for kraken test... 19:17:30 INFO - TEST-INFO | started process 32295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvQtUra/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:17:31 INFO - PID 32295 | 19:17:31 INFO - PID 32295 | (/builds/slave/test/build/application/firefox/firefox:32344): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:17:31 INFO - PID 32295 | 19:17:32 INFO - PID 32295 | 19:17:32 INFO - PID 32295 | (/builds/slave/test/build/application/firefox/firefox:32402): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:17:32 INFO - PID 32295 | 19:17:32 INFO - PID 32295 | __metrics Screen width/height:1600/1200 19:17:32 INFO - PID 32295 | colorDepth:24 19:17:32 INFO - PID 32295 | Browser inner width/height: 1024/768 19:17:32 INFO - PID 32295 | __metrics 19:17:41 INFO - PID 32295 | RSS: Main: 174460928 19:17:41 INFO - PID 32295 | 19:17:44 INFO - PID 32295 | Cycle 1(1): loaded http://localhost:35005/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35005/tests/kraken/driver.html?testName=audio-beat-detection) 19:17:45 INFO - PID 32295 | RSS: Main: 179654656 19:17:45 INFO - PID 32295 | 19:17:48 INFO - PID 32295 | Cycle 1(1): loaded http://localhost:35005/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35005/tests/kraken/driver.html?testName=audio-dft) 19:17:49 INFO - PID 32295 | RSS: Main: 181792768 19:17:49 INFO - PID 32295 | 19:17:52 INFO - PID 32295 | Cycle 1(1): loaded http://localhost:35005/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35005/tests/kraken/driver.html?testName=audio-fft) 19:17:52 INFO - PID 32295 | RSS: Main: 174469120 19:17:52 INFO - PID 32295 | 19:17:54 INFO - PID 32295 | Cycle 1(1): loaded http://localhost:35005/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35005/tests/kraken/driver.html?testName=audio-oscillator) 19:17:55 INFO - PID 32295 | RSS: Main: 174735360 19:17:55 INFO - PID 32295 | 19:17:57 INFO - PID 32295 | Cycle 1(1): loaded http://localhost:35005/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35005/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:17:58 INFO - PID 32295 | RSS: Main: 175226880 19:17:58 INFO - PID 32295 | 19:18:01 INFO - PID 32295 | Cycle 1(1): loaded http://localhost:35005/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35005/tests/kraken/driver.html?testName=imaging-darkroom) 19:18:02 INFO - PID 32295 | RSS: Main: 176287744 19:18:02 INFO - PID 32295 | 19:18:05 INFO - PID 32295 | Cycle 1(1): loaded http://localhost:35005/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35005/tests/kraken/driver.html?testName=imaging-desaturate) 19:18:06 INFO - PID 32295 | RSS: Main: 175509504 19:18:06 INFO - PID 32295 | 19:18:09 INFO - PID 32295 | Cycle 1(1): loaded http://localhost:35005/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35005/tests/kraken/driver.html?testName=json-parse-financial) 19:18:09 INFO - PID 32295 | RSS: Main: 176656384 19:18:09 INFO - PID 32295 | 19:18:11 INFO - PID 32295 | Cycle 1(1): loaded http://localhost:35005/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35005/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:18:12 INFO - PID 32295 | RSS: Main: 176529408 19:18:12 INFO - PID 32295 | 19:18:14 INFO - PID 32295 | Cycle 1(1): loaded http://localhost:35005/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35005/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:18:14 INFO - PID 32295 | RSS: Main: 176779264 19:18:14 INFO - PID 32295 | 19:18:16 INFO - PID 32295 | Cycle 1(1): loaded http://localhost:35005/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35005/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:18:17 INFO - PID 32295 | RSS: Main: 175947776 19:18:17 INFO - PID 32295 | 19:18:20 INFO - PID 32295 | Cycle 1(1): loaded http://localhost:35005/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35005/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:18:21 INFO - PID 32295 | RSS: Main: 176775168 19:18:21 INFO - PID 32295 | 19:18:24 INFO - PID 32295 | Cycle 1(1): loaded http://localhost:35005/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35005/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:18:24 INFO - PID 32295 | RSS: Main: 177143808 19:18:24 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | Cycle 1(1): loaded http://localhost:35005/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35005/tests/kraken/driver.html?testName=ai-astar) 19:18:26 INFO - PID 32295 | RSS: Main: 178405376 19:18:26 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | __start_tp_report 19:18:26 INFO - PID 32295 | _x_x_mozilla_page_load 19:18:26 INFO - PID 32295 | _x_x_mozilla_page_load_details 19:18:26 INFO - PID 32295 | |i|pagename|runs| 19:18:26 INFO - PID 32295 | |0;ai-astar;102;108;99;106;112;108;110;100;111;112 19:18:26 INFO - PID 32295 | |1;audio-beat-detection;145;129;147;181;117;157;152;119;177;118 19:18:26 INFO - PID 32295 | |2;audio-dft;163;161;169;164;167;166;164;163;164;173 19:18:26 INFO - PID 32295 | |3;audio-fft;74;73;74;169;75;73;75;89;103;73 19:18:26 INFO - PID 32295 | |4;audio-oscillator;79;80;133;79;78;79;125;80;87;137 19:18:26 INFO - PID 32295 | |5;imaging-gaussian-blur;113;118;114;117;113;115;121;117;115;114 19:18:26 INFO - PID 32295 | |6;imaging-darkroom;148;147;151;149;148;148;148;148;153;149 19:18:26 INFO - PID 32295 | |7;imaging-desaturate;93;96;94;94;93;95;94;96;94;94 19:18:26 INFO - PID 32295 | |8;json-parse-financial;55;52;54;52;54;52;53;62;53;51 19:18:26 INFO - PID 32295 | |9;json-stringify-tinderbox;54;57;56;56;60;59;59;55;55;54 19:18:26 INFO - PID 32295 | |10;stanford-crypto-aes;81;78;76;72;75;78;74;73;78;77 19:18:26 INFO - PID 32295 | |11;stanford-crypto-ccm;132;121;131;131;119;124;122;129;126;169 19:18:26 INFO - PID 32295 | |12;stanford-crypto-pbkdf2;176;170;169;182;171;169;165;176;167;173 19:18:26 INFO - PID 32295 | |13;stanford-crypto-sha256-iterative;66;63;66;68;64;70;64;64;68;62 19:18:26 INFO - PID 32295 | __end_tp_report 19:18:26 INFO - PID 32295 | __start_cc_report 19:18:26 INFO - PID 32295 | _x_x_mozilla_cycle_collect,969 19:18:26 INFO - PID 32295 | __end_cc_report 19:18:26 INFO - PID 32295 | __startTimestamp1503541106690__endTimestamp 19:18:26 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | ------- Summary: start ------- 19:18:26 INFO - PID 32295 | Number of tests: 14 19:18:26 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | [#0] ai-astar Cycles:10 Average:106.80 Median:110.50 stddev:4.89 (4.4%) stddev-sans-first:4.87 19:18:26 INFO - PID 32295 | Values: 102.0 108.0 99.0 106.0 112.0 108.0 110.0 100.0 111.0 112.0 19:18:26 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | [#1] audio-beat-detection Cycles:10 Average:144.20 Median:149.50 stddev:23.47 (15.7%) stddev-sans-first:24.89 19:18:26 INFO - PID 32295 | Values: 145.0 129.0 147.0 181.0 117.0 157.0 152.0 119.0 177.0 118.0 19:18:26 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.00 stddev:3.50 (2.1%) stddev-sans-first:3.61 19:18:26 INFO - PID 32295 | Values: 163.0 161.0 169.0 164.0 167.0 166.0 164.0 163.0 164.0 173.0 19:18:26 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | [#3] audio-fft Cycles:10 Average:87.80 Median:74.00 stddev:30.17 (40.8%) stddev-sans-first:31.58 19:18:26 INFO - PID 32295 | Values: 74.0 73.0 74.0 169.0 75.0 73.0 75.0 89.0 103.0 73.0 19:18:26 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:79.00 stddev:25.11 (31.8%) stddev-sans-first:25.89 19:18:26 INFO - PID 32295 | Values: 79.0 80.0 133.0 79.0 78.0 79.0 125.0 80.0 87.0 137.0 19:18:26 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:116.00 stddev:2.54 (2.2%) stddev-sans-first:2.50 19:18:26 INFO - PID 32295 | Values: 113.0 118.0 114.0 117.0 113.0 115.0 121.0 117.0 115.0 114.0 19:18:26 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:148.50 stddev:1.79 (1.2%) stddev-sans-first:1.87 19:18:26 INFO - PID 32295 | Values: 148.0 147.0 151.0 149.0 148.0 148.0 148.0 148.0 153.0 149.0 19:18:26 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:1.06 (1.1%) stddev-sans-first:1.01 19:18:26 INFO - PID 32295 | Values: 93.0 96.0 94.0 94.0 93.0 95.0 94.0 96.0 94.0 94.0 19:18:26 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:53.50 stddev:3.12 (5.8%) stddev-sans-first:3.28 19:18:26 INFO - PID 32295 | Values: 55.0 52.0 54.0 52.0 54.0 52.0 53.0 62.0 53.0 51.0 19:18:26 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:56.50 stddev:2.17 (3.8%) stddev-sans-first:2.11 19:18:26 INFO - PID 32295 | Values: 54.0 57.0 56.0 56.0 60.0 59.0 59.0 55.0 55.0 54.0 19:18:26 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:77.50 stddev:2.74 (3.5%) stddev-sans-first:2.29 19:18:26 INFO - PID 32295 | Values: 81.0 78.0 76.0 72.0 75.0 78.0 74.0 73.0 78.0 77.0 19:18:26 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:130.00 stddev:14.32 (11.0%) stddev-sans-first:15.17 19:18:26 INFO - PID 32295 | Values: 132.0 121.0 131.0 131.0 119.0 124.0 122.0 129.0 126.0 169.0 19:18:26 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:172.00 stddev:5.05 (2.9%) stddev-sans-first:5.12 19:18:26 INFO - PID 32295 | Values: 176.0 170.0 169.0 182.0 171.0 169.0 165.0 176.0 167.0 173.0 19:18:26 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:2.55 (3.9%) stddev-sans-first:2.70 19:18:26 INFO - PID 32295 | Values: 66.0 63.0 66.0 68.0 64.0 70.0 64.0 64.0 68.0 62.0 19:18:26 INFO - PID 32295 | -------- Summary: end -------- 19:18:26 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150081,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 19:18:26 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | 19:18:26 INFO - PID 32295 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 19:18:26 INFO - PID 32295 | 19:18:27 INFO - PID 32295 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:18:27 INFO - TEST-INFO | 32295: exit 0 19:18:27 INFO - TEST-OK | kraken | took 62646ms 19:18:27 INFO - SUITE-END | took 1173s 19:18:27 INFO - Completed test suite (00:19:34) 19:18:27 INFO - javascript benchmark 19:18:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8440.530821049879, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3254.2027203335188, 3290.226796702775, 3296.3901678189527, 3300.9174770630716, 3308.090275174327, 6190.8142755717345, 6224.377562243779, 6227.626342419447, 6283.994560870256, 6301.653409062511, 6097.817065488042, 6206.751729930797, 6214.564980451359, 6216.533759968009, 6248.437640612344, 5658.292713410824, 5681.943180568203, 5712.143178523234, 5728.971355143219, 5774.81616268666, 5784.797532086378, 5823.359430462646, 5829.912551311733, 5841.532677385799, 5852.268466441695, 5612.41069687681, 5740.138979153118, 5800.651960882339, 5873.911891321633, 5894.322152952423, 5696.287964004499, 5708.257926469574, 5773.220615216934, 5782.45066718661, 5803.419658034205, 5712.971435142839, 5740.913886291709, 5812.622179558315, 5816.6219195752565, 5837.824865254049, 6067.878642427127, 6163.198784158076, 6193.969030154865, 6314.400131987454, 6314.831756125086, 6612.834679133012, 6637.0, 6639.369259920348, 6656.134702488694, 6686.83282917926, 6636.634985075819, 6710.5302628816, 6726.0, 6727.29363416844, 6732.0, 6130.509559235251, 6136.294326152505, 6232.0, 6268.871603111484, 6296.1500197473215, 6732.225794033651, 6799.1161149051295, 6824.283450237753, 6832.385085342343, 6911.9308806912295, 6511.023346497968, 6526.151600292027, 6551.901721474182, 6553.180852393451, 6641.236257830411, 6642.1033160523675, 6662.700178491979, 6745.9662701686175, 6748.257691653914, 6754.18949726036, 6424.775132870421, 6564.80305590833, 6618.040384144272, 6659.433948114464, 6719.294474080249, 6613.437857782046, 6643.202815662152, 6650.135482387259, 6660.433863121689, 6668.666566671647, 4928.310036594879, 4963.429205641325, 4978.6763860348965, 4987.376577927759, 5003.224500202475, 4274.316109422478, 4289.935650965238, 4326.567343265649, 4329.826806927751, 4331.805068771912, 5828.388019258002, 5834.095715164156, 5877.471027607536, 5880.382559831241, 5885.0, 6620.172478440195, 6663.633500157441, 6679.56582822115, 6682.832929176712, 6686.364795344434, 5857.297124345021, 5916.911246331309, 5960.314563825129, 5969.761209551656, 5978.0, 5694.572907031989, 5732.254806875079, 5772.278465191851, 5772.769089236467, 5801.767929282866, 6300.464460520907, 6343.302236753953, 6364.49084073273, 6439.839004024843, 6441.935580644227, 6635.867282654416, 6680.465562754871, 6684.16447944007, 6686.732530698718, 6693.933060669331, 6416.550841441054, 6442.420182183626, 6448.0, 6473.320301368289, 6497.382748638872, 6524.706388212447, 6545.6399898004165, 6564.179477565304, 6612.140421745335, 6624.205095388585, 6547.214334279917, 6640.136782218281, 6711.697973591103, 6736.73053077891, 6745.325467453412, 6432.839179020562, 6518.608883467007, 6520.967395162994, 6528.183977002875, 6538.542302038812, 6484.157059582224, 6520.3805638466165, 6540.149780528501, 6588.769393071219, 6605.306442823435, 6388.776392826228, 6431.807045788634, 6475.902861456988, 6500.479961602966, 6518.152640156749, 6540.574862633914, 6540.738370465318, 6553.639549824615, 6607.603543787388, 6626.83432914181, 6188.845278868064, 6261.718222680081, 6284.780032699016, 6340.4927605792345, 6351.618902865843], "value": 6076.415795725174, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [788.5820515126985, 790.3835008693221, 822.9917700822992, 836.7113345895667, 852.13933926734, 39181.0, 39915.20169596606, 40058.0, 40171.39742903855, 40262.59737402625, 36998.445023324675, 37205.62794372055, 37336.81331593338, 37349.0, 37361.626383736155, 7060.046893669353, 7177.318154775288, 7178.066851309322, 7180.066591343144, 7189.281071892821, 7035.190953040389, 7127.85744285114, 7130.964345178293, 7134.892976605355, 7145.821354466154, 7063.964680176592, 7077.044598979149, 7082.397996170306, 7091.468139889503, 7112.78661640149, 7050.6827192776445, 7065.470089743264, 7113.110861142357, 7117.323854233891, 7118.359347658709, 6459.031145328191, 6466.094746735461, 6492.383223593751, 6512.6092434454085, 6521.250056243545, 32473.51289730656, 33048.50427243593, 33125.503117453256, 33134.502982455284, 33148.6685133148, 3391.643877392863, 3392.1689186149306, 3405.455127179664, 3406.9659303406897, 3411.385950528904, 27259.182224533295, 27274.863625681945, 27343.316417089532, 27423.725762742317, 27523.587146192822, 4451.866444006685, 4529.592336689714, 4571.679982401233, 4586.1744885920525, 4611.9077618447445, 186836.0, 188514.0, 188522.0, 189324.0, 189496.0, 20697.482562936046, 20938.267160649306, 20947.476313092295, 21008.05463754104, 48799.756001219765, 50102.49897500978, 50477.49522504801, 50643.24035139476, 50784.0, 50833.0, 15698.529044128694, 16133.919330403272, 16151.919240403722, 16183.514494565183, 16313.918430407772, 13248.602541923758, 13337.26645034513, 13343.332833358294, 13356.131851429625, 13361.599152025456, 13679.726405472034, 13840.93079534616, 13845.792313115311, 13873.236971966639, 14032.158070515801, 5577.832665019975, 5627.943720562824, 5665.206871038058, 5682.829515114553, 5711.257536520309, 995.2833959549113, 996.7209181429066, 999.9850002249972, 1019.8215312320463, 1036.233187441303, 22706.545869082525, 22719.88640056789, 22801.657975130387, 22948.885255573616, 23198.1880634177, 1109.7114750165015, 1113.560143743217, 1115.3029356652091, 1116.8548088748573, 1139.6467095200514, 12080.697982550506, 12113.0, 12140.514379424902, 12163.635090947286, 12180.939095304468, 234258.0, 236336.0, 236540.0, 236730.0, 236922.0, 44510.77744611256, 45028.0, 45080.54919450829, 51122.233166502534, 51602.22596661053, 1439.3379045638915, 1448.4423496953748, 1448.66680663448, 1451.7822326651087, 1457.1257245652523, 26887.86556067207, 27017.324566885985, 27289.48495929732, 27312.72687273102, 27642.861785690944, 32311.0, 32731.836340818143, 36542.086447839014, 36562.08594785045, 36566.26867462689, 178128.0, 179106.0, 179193.0, 179300.0, 179372.0, 33977.49033764446, 34058.65941340555, 34088.82955585206, 34111.31777364389, 34303.0, 40917.59082409257, 42280.365794513724, 42617.36073958955, 42675.0, 42710.78644606757, 30990.69009309968, 30992.0, 31282.843585781924, 31356.372872542877, 31406.68593314129, 29905.850470747508, 30683.232919176306, 30691.2327191822, 31219.0, 31253.218669533442, 34437.0, 34693.653063470054, 34857.0, 34959.475607865395, 35045.47431788576, 30258.092257232318, 30424.239394014443, 30451.390972180874, 30913.845430773603, 30959.845200773852, 22152.0, 22779.494255631536, 22958.540829182988, 23615.173468928504, 24264.1507547235], "value": 16208.741868414383, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.310861423221, 555.2365497441018, 558.9608727389084, 571.6113043130672, 578.9942100578994, 21946.45133871654, 22044.559108817815, 22760.88619556902, 22771.089156433743, 22982.19562315319, 24751.25746227616, 24947.0, 25137.49725005499, 25287.62068568973, 25295.873520632416, 6471.870562588745, 6646.10277612521, 6650.900236496456, 6651.8337041574105, 6653.667316634173, 6446.419822215999, 6534.54258201926, 6587.670616469181, 7037.577745335297, 7071.151461824588, 7061.964690176542, 7064.25825288345, 7064.576125432491, 7068.82327941803, 7071.964640176792, 7006.509544331899, 7046.9647651761925, 7055.506114571982, 7056.117985251869, 7059.082319298458, 6867.725290988405, 6880.208775990775, 6884.827879303008, 6895.862082758316, 6927.134108236471, 29911.252218694488, 30318.84840575805, 30534.694653053408, 30539.541906871415, 30830.075097747103, 2091.7176181215495, 2135.47680818199, 2137.8931053447423, 2139.5079131799775, 2141.389703934371, 20347.79652203474, 20761.688574671392, 20817.271395501237, 20997.26509572173, 21012.0, 2547.847129172256, 2563.7564431378987, 2624.39638883058, 2644.3256969472855, 2651.0, 136226.0, 139161.0, 139464.30267848697, 142796.0, 143314.99999999895, 19250.8074919249, 21414.57170856574, 21491.355259342246, 21869.234576789735, 22498.550028999656, 21323.573528529654, 22225.444363890707, 22436.0, 22594.09623615037, 42681.0, 9564.856527152098, 9623.903760962441, 9789.51052447389, 9873.703788886345, 9906.157976572073, 9029.954850225708, 9104.8634270486, 9126.0, 9206.447613143098, 9243.306751993627, 8873.423227490193, 8981.416207946462, 8997.235235005099, 9199.862002069975, 9308.767280817898, 2581.6385706001174, 2627.8160528763187, 2660.0, 2686.8925242990454, 2700.3789128500557, 963.3304853127149, 972.1202311907734, 977.8728765260613, 991.9950400247952, 994.6021591363512, 19362.515937101685, 19544.12051457688, 19834.305799296955, 19906.90046549787, 23853.403664908168, 988.5699720621552, 1027.9331843430152, 1035.5288343803552, 1038.9688309350731, 1055.1295181475314, 10707.518161682743, 10818.783624327469, 10825.188110891715, 10999.560017599366, 13042.282674452996, 506971.0, 513053.0, 524732.0, 525304.0, 533561.0, 121137.39431302786, 122081.0, 126713.36643316725, 127264.0, 127659.0, 1185.3480585678014, 1217.8234156047502, 1226.4174517104304, 1240.3674126195524, 1241.6585439004346, 20264.392068237976, 20331.491712707302, 20333.796662033783, 21133.154673812875, 21341.893290533448, 58448.0, 58557.0, 59940.0, 61273.0, 61486.69256653688, 68150.0, 68639.65680171567, 68735.31264687289, 69263.30736692568, 69734.65132674304, 14488.348024338718, 14515.274236288355, 14552.85447145515, 14766.704665906836, 14794.260286985393, 23550.646740299253, 23658.763412365657, 23746.525069498166, 23802.64296035526, 23818.88090559536, 18287.359942401952, 18565.535861603566, 18621.348252811087, 18640.81359186391, 18662.34681786131, 15288.235588220767, 16626.584335391228, 16667.3333066676, 17239.482815515556, 17260.223289952235, 18067.54831129232, 18792.248310067444, 19102.617947641247, 19187.616247675247, 19197.616047679247, 14560.0, 14563.126212427289, 14643.70712585721, 14644.41422343137, 14658.560243192722, 18087.18607662632, 18512.259509619464, 18540.629187416445, 18705.625887482445, 18770.71843922315], "value": 12426.703776626078, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1326.3368315842079, 1369.6781256404743, 1377.5109836008216, 1392.0951381601965, 1404.59968908861, 14453.0, 15071.849281507182, 15117.773233401507, 15151.848481515182, 15155.848441515582, 14366.640833979129, 14777.261136943136, 15338.846611533882, 15366.23168841559, 15367.15480648564, 2683.2755156107887, 2729.3858881751644, 2730.959035614467, 2732.562789953608, 2736.644236249285, 2593.0405749872575, 2675.6789185297794, 2681.7452342027477, 2730.494858451183, 2733.603627474015, 2702.702702702701, 2716.2258756254473, 2718.864056797162, 2719.619253304529, 2724.441489494649, 2653.548896687558, 2664.8667566621784, 2666.799990000748, 2674.104175101353, 2674.6924103728124, 2602.1803132013542, 2623.27859838544, 2630.224083895236, 2633.2626864477975, 2636.209137258834, 14210.0, 14504.0, 14506.492272770507, 14515.419383224658, 14524.782128268085, 7701.19137490561, 7875.409344299143, 7951.880721789178, 7963.203679632048, 7966.800829979239, 5140.948590514085, 5289.18017707256, 5461.777551244784, 5506.284183056217, 5507.201455788928, 1945.8346040586566, 1965.4398496428591, 1995.750531183602, 2037.5721098569318, 2049.661805802041, 22708.205212817473, 24998.0, 25266.747332526807, 25345.239642810746, 25364.746352536422, 5893.616914900604, 6500.674966251669, 6624.0, 6658.4673226141795, 6701.899471507932, 16526.091064991302, 16575.502734917973, 16638.50084497467, 16640.0, 16648.25082871274, 7680.923190768132, 7685.0, 7692.423068269902, 7972.641231144612, 8160.0, 7154.713811447484, 7269.8546029079125, 7327.303906128909, 7336.559806411632, 7350.19147893742, 4960.578350840146, 5044.672096313728, 5055.191169412877, 5103.464136265713, 5105.897882042413, 1500.3098574655562, 1502.8121484814399, 1522.7944227529142, 1526.8396818333915, 1528.9694206116037, 899.9325050621229, 927.1562877781187, 927.2257664849791, 927.7726956895469, 937.1940131486916, 7736.2650548197835, 7800.804979875548, 7825.334846537994, 7842.254985776342, 7943.523388596703, 719.8200449887528, 721.3003386714878, 721.6608194148741, 733.8715724748148, 735.5219107580116, 4953.851384458472, 5240.816571419982, 5408.972955135199, 5463.672179669233, 5562.610617256753, 19965.401037968884, 20997.370078897657, 21034.158633654788, 21176.152953881672, 21181.152753889673, 20137.899310503646, 20622.793772062087, 20768.961551922344, 20826.0, 20875.895620521802, 10253.948730256301, 10290.845637315446, 10324.587016519405, 10330.380177189392, 10345.068943794944, 7942.960285198537, 8182.095356148481, 8264.586770661323, 8400.663973440995, 8403.495790252604, 17938.5515362117, 18439.72340414868, 18443.170057347183, 18640.81359186445, 18686.719699204794, 15467.690646187239, 16844.15779211059, 17556.648867022843, 18934.242630294633, 19113.426597202106, 10593.258471906893, 10694.572217111228, 10695.144388448749, 10699.8930010702, 10703.678889633324, 13279.0, 13529.458821647419, 13602.523911663044, 13678.247696376795, 13678.521251756141, 10712.571497140027, 10712.625058122929, 10715.57137714514, 10879.673609791718, 11009.61466348674, 10621.628243011457, 10681.57273709074, 10710.732231693959, 10804.40575768309, 10918.29031113007, 9347.859782103409, 9466.195373393339, 9485.66800161991, 9541.236701064037, 9599.904000959901, 6859.382655561023, 7027.508074434741, 7053.858922821618, 7078.1506219254015, 7147.85704285901, 7263.745768898063, 7372.225916278713, 7401.259874012556, 7422.14645315774, 7457.850842983218], "value": 6485.219501613314, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.8543129776718, 498.54881332394183, 515.9406668233153, 520.9296744939433, 531.2827682628453, 6251.843703907399, 6329.588576742509, 6372.522060845432, 6402.615843049414, 6403.807885763435, 6009.158717779504, 6195.380461953802, 6207.317195108534, 6220.325260138139, 6255.843603909893, 5002.924956125661, 5035.295058691786, 5075.299774575522, 5076.593872490211, 5084.3390359253335, 5014.373203349582, 5017.322661440695, 5022.623303252252, 5038.521340472649, 5074.27474658616, 4798.568128868401, 4924.2121260598315, 5012.598992080625, 5019.121653710586, 5048.7223202723835, 4916.041371932474, 4968.205087186069, 5003.2245002024565, 5005.849824505234, 5056.570191533724, 4422.071365013351, 4448.821062418462, 4460.241758900995, 4475.695017066214, 4496.303073023687, 5998.550108741862, 6001.609895356832, 6020.110347033405, 6052.606580572248, 6095.573309868311, 5743.597948143632, 5744.942550574483, 5751.712414379306, 5772.451617096369, 5779.768809247625, 6507.772227972046, 6508.446782023534, 6538.444232240217, 6571.211454625475, 6575.506836987197, 4871.318015477836, 4880.658353915227, 4900.730459824708, 4903.338049363361, 4904.656674032819, 6910.861782764367, 6959.826004349881, 6985.5808651481075, 7007.194172670157, 7007.92992070083, 5003.0, 5014.648974571745, 5014.899702006012, 5017.698938063728, 5085.644004919694, 5005.499450054966, 5078.314427552307, 5097.209932460474, 5113.181890897438, 5116.513931176532, 5612.270404847343, 5638.323401191883, 5684.0, 5731.484166425042, 5742.971285143631, 6479.0, 6510.3489651034515, 6540.378664027005, 6641.435477984329, 6658.86682266352, 1654.139847279408, 1714.7256438969705, 1748.204566922073, 1751.5621094726318, 1753.824617538236, 1149.9252548584316, 1191.386435985468, 1217.8964787992943, 1226.337777600104, 1235.839340885697, 5711.228984087178, 5712.485876271156, 5731.7420716067045, 5749.741261643152, 5803.65178089316, 6504.365731878502, 6569.605823650596, 6590.3080176581725, 6611.768588099393, 6644.568103073381, 5737.3975732548315, 5782.2194003808945, 5814.360420353758, 5834.0, 5866.2373891393845, 3529.241213139136, 3553.236054248349, 3587.587427445877, 3609.566851977727, 3640.472131540912, 6339.562306385548, 6348.682565871688, 6404.7117879695525, 6405.743770249231, 6451.870882608728, 6898.793036208922, 6922.550034247758, 6966.9651651741415, 6987.965060174768, 7044.330788575077, 6366.745330186741, 6408.180400623711, 6446.419822216023, 6473.967630161819, 6551.4103730664465, 6633.834154145992, 6644.867102658017, 6676.866462670817, 6722.563033402813, 6786.253512113763, 6639.568428052161, 6648.335166483506, 6669.499787515859, 6685.69914353865, 6713.885126185236, 6409.4231519163495, 6492.220933488012, 6497.707603157964, 6516.0, 6541.247756508063, 4950.920613342333, 4979.0290893276915, 5015.0, 5059.494050594911, 5059.974700126623, 6690.230623478362, 6710.0, 6720.0, 6754.121964144826, 6819.318068193141, 6517.9245424504425, 6528.314526974599, 6549.901751473636, 6630.90053649186, 6634.83412914681, 6552.770653027121, 6552.770653027312, 6555.6066636002, 6625.635590042594, 6680.131582894192, 6065.696715164136, 6486.318936511599, 6552.6068435894, 6567.44176744982, 6569.4744420447205, 6465.903011454738, 6491.740330386731, 6532.706028228836, 6594.637294948824, 6605.801825945037, 6294.433500984934, 6340.556161068866, 6376.968115159394, 6391.712372943136, 6418.358164183544], "value": 5059.752141534735, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [859.3640705877652, 877.3945977275679, 889.3818795936827, 890.7327801659501, 897.3001059173845, 17841.28634854606, 18537.443876683687, 18545.35091271806, 18563.16465759041, 21735.565288694215, 20528.0, 21036.263730769428, 21104.68342974853, 21128.577428451423, 21202.575948481022, 891.4339394484516, 917.5733284022928, 919.2370332623906, 919.4253591505309, 919.8850143732034, 918.4626993208981, 956.3162338927665, 970.9757256068619, 973.0221127766584, 976.8534719792052, 1014.371089924248, 1017.0744622393623, 1017.6692574913183, 1017.6896046705751, 1018.6129270877057, 1003.6537394598852, 1007.4408703169738, 1007.9244056695741, 1008.8638033865408, 1008.9596416143382, 730.817295676081, 732.5714457042636, 735.5880706804153, 739.8483310921303, 740.9962950185269, 19340.613187736308, 19620.313289034817, 19790.90104549468, 19926.202951881907, 20054.799452005438, 20901.477463063395, 20946.266880659103, 21195.576088478145, 21496.78503214979, 21536.676949845765, 16275.267612957445, 16664.333426662917, 16915.492535223962, 16926.23831927566, 16928.91535542327, 3653.9086522836874, 3679.0618392310057, 3679.2825399047197, 3682.061074426031, 3689.741718079709, 120153.39923300415, 120349.39825300904, 121613.39193304065, 123206.0, 123412.0, 16339.0, 16412.589685257724, 16800.663986720196, 16815.579610509834, 16881.915590422213, 28249.435011299658, 28982.710172898, 29073.0, 29074.273143171165, 29221.41557168845, 8505.532195729294, 8598.87101693475, 8611.95694021526, 8616.569171541398, 8626.78433039179, 4153.563875793058, 4226.070264541796, 4235.894102647459, 4236.915261694749, 4242.087951090469, 4979.477154898684, 5034.421041580192, 5055.266986286968, 5064.442911279756, 5080.669756465818, 902.2240872849344, 919.6137622198693, 920.0753242990885, 927.4110939553432, 928.1461055828654, 667.4526887951832, 679.3546131175403, 679.8742232686968, 680.8502129531495, 684.5310961991051, 11128.0, 11318.434078296052, 11319.264247823865, 11544.711382215344, 12146.210496317888, 691.2741621297617, 692.875282449164, 697.2504557600599, 706.3254591864757, 710.5559025608994, 5718.227349521661, 5747.885042299131, 5830.067189249785, 5839.357670656224, 6488.513361497812, 111703.0, 112985.0, 113142.0, 113219.0, 114748.0, 94400.0, 95118.5244073789, 95709.52145239229, 96100.0, 96373.51813240889, 83843.0, 85136.57431712802, 86350.0, 86984.13015869887, 89746.10253897509, 12934.159279646792, 13029.543965961146, 13140.934295328461, 13174.473021079433, 13177.868221317663, 38719.80640096781, 39799.0, 41031.58968410278, 41180.1763964725, 42020.1595968085, 50770.492295076576, 51624.741876290376, 51756.741216293674, 51815.74092129515, 51863.48136518738, 17053.57366065858, 17110.572235694206, 17191.484255472355, 17294.135293235035, 17311.3941012064, 20743.1702731889, 20991.895040524698, 21057.368278951657, 21061.789382106595, 21539.784602154406, 18602.255909764, 19151.808481915003, 19205.8079419204, 19452.0, 19489.805101949365, 19032.1435535404, 19307.324243651405, 19435.902820485808, 19449.31927382535, 19617.80382196217, 18281.177347019682, 18453.261869525606, 18836.905815470836, 18925.337613183474, 19083.713744293567, 13445.596632101053, 13447.529336473177, 13507.864921350661, 13745.862541374858, 14301.141931484144, 13256.93371533136, 13282.800757988445, 13432.39554220043, 13446.731065378443, 13465.192088474723], "value": 9002.981859730438, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1513.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 108.0, 99.0, 106.0, 112.0, 108.0, 110.0, 100.0, 111.0, 112.0], "value": 106.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 129.0, 147.0, 181.0, 117.0, 157.0, 152.0, 119.0, 177.0, 118.0], "value": 144.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 169.0, 164.0, 167.0, 166.0, 164.0, 163.0, 164.0, 173.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 74.0, 169.0, 75.0, 73.0, 75.0, 89.0, 103.0, 73.0], "value": 87.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 133.0, 79.0, 78.0, 79.0, 125.0, 80.0, 87.0, 137.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 118.0, 114.0, 117.0, 113.0, 115.0, 121.0, 117.0, 115.0, 114.0], "value": 115.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 151.0, 149.0, 148.0, 148.0, 148.0, 148.0, 153.0, 149.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 96.0, 94.0, 94.0, 93.0, 95.0, 94.0, 96.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 54.0, 52.0, 54.0, 52.0, 53.0, 62.0, 53.0, 51.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 56.0, 56.0, 60.0, 59.0, 59.0, 55.0, 55.0, 54.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 76.0, 72.0, 75.0, 78.0, 74.0, 73.0, 78.0, 77.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 121.0, 131.0, 131.0, 119.0, 124.0, 122.0, 129.0, 126.0, 169.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 170.0, 169.0, 182.0, 171.0, 169.0, 165.0, 176.0, 167.0, 173.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 66.0, 68.0, 64.0, 70.0, 64.0, 64.0, 68.0, 62.0], "value": 65.5, "unit": "score"}]}]} 19:18:27 INFO - Return code: 0 19:18:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:18:27 INFO - # TBPL SUCCESS # 19:18:27 INFO - Running post-action listener: _package_coverage_data 19:18:27 INFO - Running post-action listener: _resource_record_post_action 19:18:27 INFO - [mozharness: 2017-08-24 02:18:27.991423Z] Finished run-tests step (success) 19:18:27 INFO - Running post-run listener: _resource_record_post_run 19:18:28 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 448999424; Read time: 12; Write time: 320920 19:18:28 INFO - TinderboxPrint: CPU usage
13.1% 19:18:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 19:18:28 INFO - TinderboxPrint: I/O write bytes / time
448,999,424 / 320,920 19:18:28 INFO - TinderboxPrint: CPU idle
8,255.7 (86.9%) 19:18:28 INFO - TinderboxPrint: CPU user
1,197.4 (12.6%) 19:18:28 INFO - TinderboxPrint: Swap in / out
0 / 0 19:18:28 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 118722560; Read time: 0; Write time: 84644 19:18:28 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:18:28 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 327282688; Read time: 0; Write time: 236232 19:18:28 INFO - Running post-run listener: _upload_blobber_files 19:18:28 INFO - Blob upload gear active. 19:18:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:18:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:18:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:18:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:18:29 INFO - (blobuploader) - INFO - Open directory for files ... 19:18:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:18:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:18:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:18:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:18:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:18:29 INFO - (blobuploader) - INFO - Done attempting. 19:18:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:18:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:18:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:18:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:18:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:18:30 INFO - (blobuploader) - INFO - Done attempting. 19:18:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:18:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:18:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:18:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:18:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:18:34 INFO - (blobuploader) - INFO - Done attempting. 19:18:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:18:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:18:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:18:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:18:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:18:35 INFO - (blobuploader) - INFO - Done attempting. 19:18:35 INFO - (blobuploader) - INFO - Iteration through files over. 19:18:35 INFO - Return code: 0 19:18:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:18:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:18:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6fbbe46070d72ebb49b838da22b6b5e6fd0255f25cc033e335f7a61f71e70278b131a6d68fdccbb895ef0ebc140421ccbca6af48977dc14221bfd4ce5d77a6f3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/feb014a3291cff52e2fb75043ea84ac0aed299611487ee754801fcf2c6057862c514e3b49abf63dbe005e6875072d4ee0c231e423ac57d958eab343ac015ffdc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee8028eefec1b364678de9e08d701e9ee6d74a61e2693666e77849f6318b7411802e0cd4b5364a72254f32edda15d80ca939c19a397a8e3d49af5a3d7b16e59f", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18b4eaee7eb11960d0114ed3f4ec8d7c63a4e5c9c4b31d23af62b42d14b1effc9d6ea153554fcd0bb43fad97e99fac92cfe61eff88d8a76d8851d21970aaa421"} 19:18:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:18:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:18:35 INFO - Contents: 19:18:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6fbbe46070d72ebb49b838da22b6b5e6fd0255f25cc033e335f7a61f71e70278b131a6d68fdccbb895ef0ebc140421ccbca6af48977dc14221bfd4ce5d77a6f3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/feb014a3291cff52e2fb75043ea84ac0aed299611487ee754801fcf2c6057862c514e3b49abf63dbe005e6875072d4ee0c231e423ac57d958eab343ac015ffdc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee8028eefec1b364678de9e08d701e9ee6d74a61e2693666e77849f6318b7411802e0cd4b5364a72254f32edda15d80ca939c19a397a8e3d49af5a3d7b16e59f", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18b4eaee7eb11960d0114ed3f4ec8d7c63a4e5c9c4b31d23af62b42d14b1effc9d6ea153554fcd0bb43fad97e99fac92cfe61eff88d8a76d8851d21970aaa421"} 19:18:35 INFO - Running post-run listener: copy_logs_to_upload_dir 19:18:35 INFO - Copying logs to upload dir... 19:18:35 INFO - mkdir: /builds/slave/test/build/upload/logs 19:18:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.910225 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-23 19:18:35.703338) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 19:18:35.707725) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6fbbe46070d72ebb49b838da22b6b5e6fd0255f25cc033e335f7a61f71e70278b131a6d68fdccbb895ef0ebc140421ccbca6af48977dc14221bfd4ce5d77a6f3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/feb014a3291cff52e2fb75043ea84ac0aed299611487ee754801fcf2c6057862c514e3b49abf63dbe005e6875072d4ee0c231e423ac57d958eab343ac015ffdc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee8028eefec1b364678de9e08d701e9ee6d74a61e2693666e77849f6318b7411802e0cd4b5364a72254f32edda15d80ca939c19a397a8e3d49af5a3d7b16e59f", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18b4eaee7eb11960d0114ed3f4ec8d7c63a4e5c9c4b31d23af62b42d14b1effc9d6ea153554fcd0bb43fad97e99fac92cfe61eff88d8a76d8851d21970aaa421"} build_url:https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011329 build_url: 'https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6fbbe46070d72ebb49b838da22b6b5e6fd0255f25cc033e335f7a61f71e70278b131a6d68fdccbb895ef0ebc140421ccbca6af48977dc14221bfd4ce5d77a6f3", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/feb014a3291cff52e2fb75043ea84ac0aed299611487ee754801fcf2c6057862c514e3b49abf63dbe005e6875072d4ee0c231e423ac57d958eab343ac015ffdc", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee8028eefec1b364678de9e08d701e9ee6d74a61e2693666e77849f6318b7411802e0cd4b5364a72254f32edda15d80ca939c19a397a8e3d49af5a3d7b16e59f", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18b4eaee7eb11960d0114ed3f4ec8d7c63a4e5c9c4b31d23af62b42d14b1effc9d6ea153554fcd0bb43fad97e99fac92cfe61eff88d8a76d8851d21970aaa421"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 19:18:35.738034) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 19:18:35.738314) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1503539854.404981-1765439289 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 19:18:35.818904) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 19:18:35.819173) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 19:18:35.822414) ========= ========= Total master_lag: 0.29 =========