builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1498213601.49 results: success (0) revision: 3b468193c933806339fa4a8dee73d03a09e635ab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-23 03:26:41.492611) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-23 03:26:41.493097) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-23 03:26:41.493380) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-23 03:26:41.508902) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 03:26:41.509282) ========= 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=bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-23 03:26:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 216M=0s 2017-06-23 03:26:41 (216 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124893 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 03:26:41.646767) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 03:26:41.647075) ========= 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=bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018058 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 03:26:41.696250) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 03:26:41.696592) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3b468193c933806339fa4a8dee73d03a09e635ab --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 3b468193c933806339fa4a8dee73d03a09e635ab --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=bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-23 03:26:41,873 truncating revision to first 12 chars 2017-06-23 03:26:41,873 Setting DEBUG logging. 2017-06-23 03:26:41,873 attempt 1/10 2017-06-23 03:26:41,873 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3b468193c933?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-23 03:26:42,170 unpacking tar archive at: mozilla-central-3b468193c933/testing/mozharness/ program finished with exit code 0 elapsedTime=0.603577 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 03:26:42.312299) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-23 03:26:42.312824) ========= script_repo_revision: 3b468193c933806339fa4a8dee73d03a09e635ab ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-23 03:26:42.313221) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-23 03:26:42.313538) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-23 03:26:42.321832) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-06-23 03:26:42.322358) ========= /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=bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:26:42 INFO - MultiFileLogger online at 20170623 03:26:42 in /builds/slave/test 03:26:42 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 03:26:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:26:42 INFO - {'append_to_log': False, 03:26:42 INFO - 'base_work_dir': '/builds/slave/test', 03:26:42 INFO - 'blob_upload_branch': 'Firefox', 03:26:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:26:42 INFO - 'branch': 'Firefox', 03:26:42 INFO - 'buildbot_json_path': 'buildprops.json', 03:26:42 INFO - 'config_files': ('talos/linux_config.py',), 03:26:42 INFO - 'default_actions': ('clobber', 03:26:42 INFO - 'read-buildbot-config', 03:26:42 INFO - 'download-and-extract', 03:26:42 INFO - 'populate-webroot', 03:26:42 INFO - 'create-virtualenv', 03:26:42 INFO - 'install', 03:26:42 INFO - 'setup-mitmproxy', 03:26:42 INFO - 'run-tests'), 03:26:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:26:42 INFO - 'download_minidump_stackwalk': True, 03:26:42 INFO - 'download_symbols': 'ondemand', 03:26:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:26:42 INFO - 'tooltool.py': '/tools/tooltool.py', 03:26:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:26:42 INFO - '/tools/misc-python/virtualenv.py')}, 03:26:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:26:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:26:42 INFO - 'gecko_profile': False, 03:26:42 INFO - 'gecko_profile_interval': 0, 03:26:42 INFO - 'installer_path': 'installer.exe', 03:26:42 INFO - 'log_level': 'info', 03:26:42 INFO - 'log_name': 'talos', 03:26:42 INFO - 'log_to_console': True, 03:26:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:26:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:26:42 INFO - 'opt_config_files': (), 03:26:42 INFO - 'pip_index': False, 03:26:42 INFO - 'suite': 'dromaeojs-e10s', 03:26:42 INFO - 'system_bits': '32', 03:26:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:26:42 INFO - 'title': 'talos-linux64-ix-055', 03:26:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:26:42 INFO - 'use_talos_json': True, 03:26:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:26:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:26:42 INFO - 'work_dir': 'build'} 03:26:42 INFO - [mozharness: 2017-06-23 10:26:42.599910Z] Running clobber step. 03:26:42 INFO - Running pre-action listener: _resource_record_pre_action 03:26:42 INFO - Running main action method: clobber 03:26:42 INFO - rmtree: /builds/slave/test/build 03:26:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:26:43 INFO - Running post-action listener: _resource_record_post_action 03:26:43 INFO - [mozharness: 2017-06-23 10:26:43.638093Z] Finished clobber step (success) 03:26:43 INFO - [mozharness: 2017-06-23 10:26:43.638195Z] Running read-buildbot-config step. 03:26:43 INFO - Running pre-action listener: _resource_record_pre_action 03:26:43 INFO - Running main action method: read_buildbot_config 03:26:43 INFO - Using buildbot properties: 03:26:43 INFO - { 03:26:43 INFO - "project": "", 03:26:43 INFO - "product": "firefox", 03:26:43 INFO - "who": "cbook@mozilla.com", 03:26:43 INFO - "installer_path": "public/build/target.tar.bz2", 03:26:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:26:43 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 03:26:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:26:43 INFO - "stage_platform": "linux64-pgo", 03:26:43 INFO - "basedir": "/builds/slave/test", 03:26:43 INFO - "buildnumber": 29, 03:26:43 INFO - "platform": "ubuntu64_hw", 03:26:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:26:43 INFO - "slavebuilddir": "test", 03:26:43 INFO - "taskId": "YIDKQgqKSTKieSVvndl07w", 03:26:43 INFO - "branch": "mozilla-central", 03:26:43 INFO - "script_repo_revision": "production", 03:26:43 INFO - "revision": "3b468193c933806339fa4a8dee73d03a09e635ab", 03:26:43 INFO - "slavename": "talos-linux64-ix-055", 03:26:43 INFO - "repo_path": "mozilla-central" 03:26:43 INFO - } 03:26:43 INFO - Finding installer, test and symbols from parent task. 03:26:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YIDKQgqKSTKieSVvndl07w'}, attempt #1 03:26:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YIDKQgqKSTKieSVvndl07w'}, attempt #1 03:26:44 INFO - Task dependencies: TaONX0HITkeQhhuHNqnG1w 03:26:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w'}, attempt #1 03:26:44 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.tar.bz2 03:26:44 INFO - Set test_url: https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/test_packages.json 03:26:44 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.crashreporter-symbols.zip 03:26:44 INFO - Running post-action listener: _resource_record_post_action 03:26:44 INFO - [mozharness: 2017-06-23 10:26:44.970521Z] Finished read-buildbot-config step (success) 03:26:44 INFO - [mozharness: 2017-06-23 10:26:44.970741Z] Running download-and-extract step. 03:26:44 INFO - Running pre-action listener: _resource_record_pre_action 03:26:44 INFO - Running main action method: download_and_extract 03:26:44 INFO - mkdir: /builds/slave/test/build/tests 03:26:44 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')]} 03:26:44 INFO - trying https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.test_packages.json 03:26:44 INFO - Downloading https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:26:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:26:45 INFO - Downloaded 989 bytes. 03:26:45 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:26:45 INFO - Using the following test package requirements: 03:26:45 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:26:45 INFO - u'common': [u'target.common.tests.zip'], 03:26:45 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:26:45 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:26:45 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:26:45 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:26:45 INFO - u'mozbase': [u'target.common.tests.zip'], 03:26:45 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:26:45 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:26:45 INFO - u'web-platform': [u'target.common.tests.zip', 03:26:45 INFO - u'target.web-platform.tests.tar.gz'], 03:26:45 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:26:45 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:26:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.common.tests.zip 03:26:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:26:45 INFO - Fetch https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.common.tests.zip into memory 03:26:47 INFO - Content-Length response header: 68371416 03:26:47 INFO - Bytes received: 68371416 03:26:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:26:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.common.tests.zip 03:26:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:26:58 INFO - Fetch https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.common.tests.zip into memory 03:26:59 INFO - Content-Length response header: 68371416 03:26:59 INFO - Bytes received: 68371416 03:27:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.talos.tests.zip 03:27:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:27:11 INFO - Fetch https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.talos.tests.zip into memory 03:27:12 INFO - Content-Length response header: 14441306 03:27:12 INFO - Bytes received: 14441306 03:27:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:13 INFO - trying https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.tar.bz2 03:27:13 INFO - Downloading https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:27:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:27:14 INFO - Downloaded 62740615 bytes. 03:27:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.tar.bz2 03:27:14 INFO - mkdir: /builds/slave/test/properties 03:27:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:27:14 INFO - Writing to file /builds/slave/test/properties/build_url 03:27:14 INFO - Contents: 03:27:14 INFO - build_url:https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.tar.bz2 03:27:14 INFO - Running post-action listener: _resource_record_post_action 03:27:14 INFO - Running post-action listener: set_extra_try_arguments 03:27:14 INFO - [mozharness: 2017-06-23 10:27:14.643244Z] Finished download-and-extract step (success) 03:27:14 INFO - [mozharness: 2017-06-23 10:27:14.643342Z] Running populate-webroot step. 03:27:14 INFO - Running pre-action listener: _resource_record_pre_action 03:27:14 INFO - Running main action method: populate_webroot 03:27:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:27:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:27:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:27:14 INFO - '--tppagecycles', 03:27:14 INFO - '7'], 03:27:14 INFO - 'tests': ['tsvgm']}}, 03:27:14 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:27:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:27:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:27:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:27:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:27:14 INFO - 'talos_options': ['--disable-e10s'], 03:27:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:27:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:27:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:27:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:27:14 INFO - 'talos_options': ['--disable-e10s'], 03:27:14 INFO - 'tests': ['damp', 'tps']}, 03:27:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:27:14 INFO - 'tests': ['damp', 'tps']}, 03:27:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:27:14 INFO - 'tests': ['dromaeo_dom']}, 03:27:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:27:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:27:14 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:27:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:27:14 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:27:14 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:27:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:27:14 INFO - 'tests': ['a11yr', 03:27:14 INFO - 'ts_paint', 03:27:14 INFO - 'tpaint', 03:27:14 INFO - 'sessionrestore', 03:27:14 INFO - 'sessionrestore_no_auto_restore', 03:27:14 INFO - 'tabpaint']}, 03:27:14 INFO - 'other-e10s': {'tests': ['a11yr', 03:27:14 INFO - 'ts_paint', 03:27:14 INFO - 'tpaint', 03:27:14 INFO - 'sessionrestore', 03:27:14 INFO - 'sessionrestore_no_auto_restore', 03:27:14 INFO - 'tabpaint']}, 03:27:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:27:14 INFO - 'ts_paint', 03:27:14 INFO - 'tpaint', 03:27:14 INFO - 'sessionrestore', 03:27:14 INFO - 'sessionrestore_no_auto_restore', 03:27:14 INFO - 'tabpaint']}, 03:27:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:27:14 INFO - 'ts_paint', 03:27:14 INFO - 'tpaint', 03:27:14 INFO - 'sessionrestore', 03:27:14 INFO - 'sessionrestore_no_auto_restore', 03:27:14 INFO - 'tabpaint']}, 03:27:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:27:14 INFO - 'tests': ['a11yr', 03:27:14 INFO - 'ts_paint', 03:27:14 INFO - 'tpaint', 03:27:14 INFO - 'sessionrestore', 03:27:14 INFO - 'sessionrestore_no_auto_restore', 03:27:14 INFO - 'tabpaint']}, 03:27:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:27:14 INFO - 'tests': ['a11yr', 03:27:14 INFO - 'ts_paint', 03:27:14 INFO - 'tpaint', 03:27:14 INFO - 'sessionrestore', 03:27:14 INFO - 'sessionrestore_no_auto_restore', 03:27:14 INFO - 'tabpaint']}, 03:27:14 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:27:14 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:27:14 INFO - 'bloom_basic_ref']}, 03:27:14 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:27:14 INFO - 'talos_options': ['--mitmproxy', 03:27:14 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:27:14 INFO - '--firstNonBlankPaint'], 03:27:14 INFO - 'tests': ['quantum_pageload_google', 03:27:14 INFO - 'quantum_pageload_youtube', 03:27:14 INFO - 'quantum_pageload_amazon', 03:27:14 INFO - 'quantum_pageload_facebook']}, 03:27:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:27:14 INFO - 'tests': ['tsvgx', 03:27:14 INFO - 'tsvgr_opacity', 03:27:14 INFO - 'tart', 03:27:14 INFO - 'tscrollx', 03:27:14 INFO - 'cart', 03:27:14 INFO - 'tsvg_static']}, 03:27:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:27:14 INFO - 'tsvgr_opacity', 03:27:14 INFO - 'tart', 03:27:14 INFO - 'tscrollx', 03:27:14 INFO - 'cart', 03:27:14 INFO - 'tsvg_static']}, 03:27:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:27:14 INFO - 'talos_options': ['--disable-e10s'], 03:27:14 INFO - 'tests': ['tp5o']}, 03:27:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:27:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:27:14 INFO - 'talos_options': ['--disable-e10s', 03:27:14 INFO - '--xperf_path', 03:27:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:27:14 INFO - 'tests': ['tp5n']}, 03:27:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:27:14 INFO - 'talos_options': ['--xperf_path', 03:27:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:27:14 INFO - 'tests': ['tp5n']}}, 03:27:14 INFO - 'talos.zip': {'path': '', 03:27:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:27:14 INFO - Running post-action listener: _resource_record_post_action 03:27:14 INFO - [mozharness: 2017-06-23 10:27:14.658299Z] Finished populate-webroot step (success) 03:27:14 INFO - [mozharness: 2017-06-23 10:27:14.658390Z] Running create-virtualenv step. 03:27:14 INFO - Running pre-action listener: _resource_record_pre_action 03:27:14 INFO - Running main action method: create_virtualenv 03:27:14 INFO - Creating virtualenv /builds/slave/test/build/venv 03:27:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:27:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:27:14 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:27:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:27:14 INFO - Using real prefix '/usr' 03:27:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:27:15 INFO - Installing distribute.............................................................................................................................................................................................done. 03:27:17 INFO - Installing pip.................done. 03:27:17 INFO - Return code: 0 03:27:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:27:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:27:17 INFO - Reading from file tmpfile_stdout 03:27:17 INFO - Output received: 03:27:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:27:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27: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')]} 03:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27: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 0x254f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cd9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cb140>, '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 0x28cba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cbed0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', '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 03:27: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 03:27: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 03:27:17 INFO - Using env: {'DISPLAY': ':0', 03:27:17 INFO - 'HOME': '/home/cltbld', 03:27:17 INFO - 'LANG': 'en_US.UTF-8', 03:27:17 INFO - 'LANGUAGE': 'en_US:en', 03:27:17 INFO - 'LOGNAME': 'cltbld', 03:27:17 INFO - 'MAIL': '/var/mail/cltbld', 03:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:17 INFO - 'MOZ_NO_REMOTE': '1', 03:27:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:17 INFO - 'NO_EM_RESTART': '1', 03:27:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:17 INFO - 'PWD': '/builds/slave/test', 03:27:17 INFO - 'SHELL': '/bin/bash', 03:27:17 INFO - 'SHLVL': '1', 03:27:17 INFO - 'TERM': 'linux', 03:27:17 INFO - 'TMOUT': '86400', 03:27:17 INFO - 'USER': 'cltbld', 03:27:17 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', 03:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:17 INFO - '_': '/tools/buildbot/bin/python'} 03:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:27:17 INFO - Cleaning up... 03:27:17 INFO - Return code: 0 03:27:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27: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')]} 03:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27: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', '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 0x254f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cd9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cb140>, '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 0x28cba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cbed0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', '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 03:27: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:27: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 psutil>=3.1.1 03:27:17 INFO - Using env: {'DISPLAY': ':0', 03:27:17 INFO - 'HOME': '/home/cltbld', 03:27:17 INFO - 'LANG': 'en_US.UTF-8', 03:27:17 INFO - 'LANGUAGE': 'en_US:en', 03:27:17 INFO - 'LOGNAME': 'cltbld', 03:27:17 INFO - 'MAIL': '/var/mail/cltbld', 03:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:17 INFO - 'MOZ_NO_REMOTE': '1', 03:27:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:17 INFO - 'NO_EM_RESTART': '1', 03:27:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:17 INFO - 'PWD': '/builds/slave/test', 03:27:17 INFO - 'SHELL': '/bin/bash', 03:27:17 INFO - 'SHLVL': '1', 03:27:17 INFO - 'TERM': 'linux', 03:27:17 INFO - 'TMOUT': '86400', 03:27:17 INFO - 'USER': 'cltbld', 03:27:17 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', 03:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:17 INFO - '_': '/tools/buildbot/bin/python'} 03:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:17 INFO - Downloading/unpacking psutil>=3.1.1 03:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:27:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:19 INFO - Installing collected packages: psutil 03:27:19 INFO - Running setup.py install for psutil 03:27:19 INFO - building 'psutil._psutil_linux' extension 03:27:19 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 03:27:19 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 03:27:19 INFO - building 'psutil._psutil_posix' extension 03:27:19 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 03:27:19 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 03:27:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:19 INFO - Successfully installed psutil 03:27:19 INFO - Cleaning up... 03:27:19 INFO - Return code: 0 03:27:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:27:19 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')]} 03:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:19 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')]} 03:27:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:19 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 0x254f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cd9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cb140>, '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 0x28cba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cbed0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', '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 03:27:19 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 03:27:19 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 03:27:19 INFO - Using env: {'DISPLAY': ':0', 03:27:19 INFO - 'HOME': '/home/cltbld', 03:27:19 INFO - 'LANG': 'en_US.UTF-8', 03:27:19 INFO - 'LANGUAGE': 'en_US:en', 03:27:19 INFO - 'LOGNAME': 'cltbld', 03:27:19 INFO - 'MAIL': '/var/mail/cltbld', 03:27:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:19 INFO - 'MOZ_NO_REMOTE': '1', 03:27:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:19 INFO - 'NO_EM_RESTART': '1', 03:27:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:19 INFO - 'PWD': '/builds/slave/test', 03:27:19 INFO - 'SHELL': '/bin/bash', 03:27:19 INFO - 'SHLVL': '1', 03:27:19 INFO - 'TERM': 'linux', 03:27:19 INFO - 'TMOUT': '86400', 03:27:19 INFO - 'USER': 'cltbld', 03:27:19 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', 03:27:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:19 INFO - '_': '/tools/buildbot/bin/python'} 03:27:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:27:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:27:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:27:20 INFO - Installing collected packages: mozsystemmonitor 03:27:20 INFO - Running setup.py install for mozsystemmonitor 03:27:21 INFO - Successfully installed mozsystemmonitor 03:27:21 INFO - Cleaning up... 03:27:21 INFO - Return code: 0 03:27:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:21 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 0x254f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cd9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cb140>, '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 0x28cba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cbed0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', '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 03:27:21 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 03:27:21 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 03:27:21 INFO - Using env: {'DISPLAY': ':0', 03:27:21 INFO - 'HOME': '/home/cltbld', 03:27:21 INFO - 'LANG': 'en_US.UTF-8', 03:27:21 INFO - 'LANGUAGE': 'en_US:en', 03:27:21 INFO - 'LOGNAME': 'cltbld', 03:27:21 INFO - 'MAIL': '/var/mail/cltbld', 03:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:21 INFO - 'MOZ_NO_REMOTE': '1', 03:27:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:21 INFO - 'NO_EM_RESTART': '1', 03:27:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:21 INFO - 'PWD': '/builds/slave/test', 03:27:21 INFO - 'SHELL': '/bin/bash', 03:27:21 INFO - 'SHLVL': '1', 03:27:21 INFO - 'TERM': 'linux', 03:27:21 INFO - 'TMOUT': '86400', 03:27:21 INFO - 'USER': 'cltbld', 03:27:21 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', 03:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:21 INFO - '_': '/tools/buildbot/bin/python'} 03:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:21 INFO - Downloading/unpacking jsonschema==2.5.1 03:27:21 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 03:27:21 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 03:27:21 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 03:27:21 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 03:27:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:27:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:27: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 03:27: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 03:27: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 03:27: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 03:27:22 INFO - Downloading functools32-3.2.3-2.tar.gz 03:27:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:27:22 INFO - warning: no files found matching '*.txt' 03:27:22 INFO - no previously-included directories found matching 'build' 03:27:22 INFO - no previously-included directories found matching 'dist' 03:27:22 INFO - no previously-included directories found matching '.git*' 03:27:22 INFO - Installing collected packages: jsonschema, functools32 03:27:22 INFO - Running setup.py install for functools32 03:27:22 INFO - warning: no files found matching '*.txt' 03:27:22 INFO - no previously-included directories found matching 'build' 03:27:22 INFO - no previously-included directories found matching 'dist' 03:27:22 INFO - no previously-included directories found matching '.git*' 03:27:22 INFO - Successfully installed jsonschema functools32 03:27:22 INFO - Cleaning up... 03:27:22 INFO - Return code: 0 03:27:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27: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')]} 03:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27: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', '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 0x254f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cd9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cb140>, '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 0x28cba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cbed0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', '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 03:27: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:27: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 functools32==3.2.3-2 03:27:22 INFO - Using env: {'DISPLAY': ':0', 03:27:22 INFO - 'HOME': '/home/cltbld', 03:27:22 INFO - 'LANG': 'en_US.UTF-8', 03:27:22 INFO - 'LANGUAGE': 'en_US:en', 03:27:22 INFO - 'LOGNAME': 'cltbld', 03:27:22 INFO - 'MAIL': '/var/mail/cltbld', 03:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:22 INFO - 'MOZ_NO_REMOTE': '1', 03:27:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:22 INFO - 'NO_EM_RESTART': '1', 03:27:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:22 INFO - 'PWD': '/builds/slave/test', 03:27:22 INFO - 'SHELL': '/bin/bash', 03:27:22 INFO - 'SHLVL': '1', 03:27:22 INFO - 'TERM': 'linux', 03:27:22 INFO - 'TMOUT': '86400', 03:27:22 INFO - 'USER': 'cltbld', 03:27:22 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', 03:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:22 INFO - '_': '/tools/buildbot/bin/python'} 03:27:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:27:22 INFO - Cleaning up... 03:27:22 INFO - Return code: 0 03:27:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:27: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')]} 03:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27: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')]} 03:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27: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 0x254f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cd9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cb140>, '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 0x28cba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cbed0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', '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 03:27: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 03:27: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 03:27:23 INFO - Using env: {'DISPLAY': ':0', 03:27:23 INFO - 'HOME': '/home/cltbld', 03:27:23 INFO - 'LANG': 'en_US.UTF-8', 03:27:23 INFO - 'LANGUAGE': 'en_US:en', 03:27:23 INFO - 'LOGNAME': 'cltbld', 03:27:23 INFO - 'MAIL': '/var/mail/cltbld', 03:27:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:23 INFO - 'MOZ_NO_REMOTE': '1', 03:27:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:23 INFO - 'NO_EM_RESTART': '1', 03:27:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:23 INFO - 'PWD': '/builds/slave/test', 03:27:23 INFO - 'SHELL': '/bin/bash', 03:27:23 INFO - 'SHLVL': '1', 03:27:23 INFO - 'TERM': 'linux', 03:27:23 INFO - 'TMOUT': '86400', 03:27:23 INFO - 'USER': 'cltbld', 03:27:23 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', 03:27:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:23 INFO - '_': '/tools/buildbot/bin/python'} 03:27:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:23 INFO - Downloading/unpacking blobuploader==1.2.4 03:27: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 03:27: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 03:27: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 03:27: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 03:27:24 INFO - Downloading blobuploader-1.2.4.tar.gz 03:27:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:27:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:27: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 03:27: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 03:27: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 03:27: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 03:27:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:27:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:27: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 03:27: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 03:27: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 03:27: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 03:27:24 INFO - Downloading docopt-0.6.1.tar.gz 03:27:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:27:24 INFO - Installing collected packages: blobuploader, requests, docopt 03:27:24 INFO - Running setup.py install for blobuploader 03:27:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:27:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:27:24 INFO - Running setup.py install for requests 03:27:25 INFO - Running setup.py install for docopt 03:27:25 INFO - Successfully installed blobuploader requests docopt 03:27:25 INFO - Cleaning up... 03:27:25 INFO - Return code: 0 03:27:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:25 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 0x254f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cd9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cb140>, '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 0x28cba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cbed0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', '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 03:27:25 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 03:27:25 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 03:27:25 INFO - Using env: {'DISPLAY': ':0', 03:27:25 INFO - 'HOME': '/home/cltbld', 03:27:25 INFO - 'LANG': 'en_US.UTF-8', 03:27:25 INFO - 'LANGUAGE': 'en_US:en', 03:27:25 INFO - 'LOGNAME': 'cltbld', 03:27:25 INFO - 'MAIL': '/var/mail/cltbld', 03:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:25 INFO - 'MOZ_NO_REMOTE': '1', 03:27:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:25 INFO - 'NO_EM_RESTART': '1', 03:27:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:25 INFO - 'PWD': '/builds/slave/test', 03:27:25 INFO - 'SHELL': '/bin/bash', 03:27:25 INFO - 'SHLVL': '1', 03:27:25 INFO - 'TERM': 'linux', 03:27:25 INFO - 'TMOUT': '86400', 03:27:25 INFO - 'USER': 'cltbld', 03:27:25 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', 03:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:25 INFO - '_': '/tools/buildbot/bin/python'} 03:27:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:25 INFO - Running setup.py (path:/tmp/pip-mBt675-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:25 INFO - Running setup.py (path:/tmp/pip-ROAhNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:25 INFO - Running setup.py (path:/tmp/pip-_e_9cO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:25 INFO - Running setup.py (path:/tmp/pip-d8VFQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:25 INFO - Running setup.py (path:/tmp/pip-TkH2d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:26 INFO - Running setup.py (path:/tmp/pip-jQW5N6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:26 INFO - Running setup.py (path:/tmp/pip-rnLDUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:26 INFO - Running setup.py (path:/tmp/pip-Bqsez8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:26 INFO - Running setup.py (path:/tmp/pip-pvglOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:26 INFO - Running setup.py (path:/tmp/pip-ehss87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:26 INFO - Running setup.py (path:/tmp/pip-18U2oK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:26 INFO - Running setup.py (path:/tmp/pip-Q4Bxk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:26 INFO - Running setup.py (path:/tmp/pip-z74nBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:26 INFO - Running setup.py (path:/tmp/pip-Nm0KDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:26 INFO - Running setup.py (path:/tmp/pip-bHycqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:26 INFO - Running setup.py (path:/tmp/pip-KX4TL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:26 INFO - Running setup.py (path:/tmp/pip-rgy1Po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:27:26 INFO - Running setup.py install for manifestparser 03:27:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:27:27 INFO - Running setup.py install for mozcrash 03:27:27 INFO - Running setup.py install for mozdebug 03:27:27 INFO - Running setup.py install for mozdevice 03:27:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:27:27 INFO - Running setup.py install for mozfile 03:27:27 INFO - Running setup.py install for mozhttpd 03:27:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:27:27 INFO - Running setup.py install for mozinfo 03:27:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:27:27 INFO - Running setup.py install for mozInstall 03:27:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:27:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:27:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:27:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:27:27 INFO - Running setup.py install for mozleak 03:27:27 INFO - Running setup.py install for mozlog 03:27:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:27:27 INFO - Running setup.py install for moznetwork 03:27:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:27:28 INFO - Running setup.py install for mozprocess 03:27:28 INFO - Running setup.py install for mozprofile 03:27:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:27:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:27:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:27:28 INFO - Running setup.py install for mozrunner 03:27:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:27:28 INFO - Running setup.py install for mozscreenshot 03:27:28 INFO - Running setup.py install for moztest 03:27:28 INFO - Running setup.py install for mozversion 03:27:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:27:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:27:28 INFO - Cleaning up... 03:27:28 INFO - Return code: 0 03:27:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:28 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')]} 03:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:28 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')]} 03:27:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:28 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 0x254f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cd9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cb140>, '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 0x28cba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cbed0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', '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 03:27:28 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 03:27:28 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 03:27:28 INFO - Using env: {'DISPLAY': ':0', 03:27:28 INFO - 'HOME': '/home/cltbld', 03:27:28 INFO - 'LANG': 'en_US.UTF-8', 03:27:28 INFO - 'LANGUAGE': 'en_US:en', 03:27:28 INFO - 'LOGNAME': 'cltbld', 03:27:28 INFO - 'MAIL': '/var/mail/cltbld', 03:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:28 INFO - 'MOZ_NO_REMOTE': '1', 03:27:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:28 INFO - 'NO_EM_RESTART': '1', 03:27:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:28 INFO - 'PWD': '/builds/slave/test', 03:27:28 INFO - 'SHELL': '/bin/bash', 03:27:28 INFO - 'SHLVL': '1', 03:27:28 INFO - 'TERM': 'linux', 03:27:28 INFO - 'TMOUT': '86400', 03:27:28 INFO - 'USER': 'cltbld', 03:27:28 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', 03:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:28 INFO - '_': '/tools/buildbot/bin/python'} 03:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:28 INFO - Running setup.py (path:/tmp/pip-GrwTlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:28 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)) 03:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:28 INFO - Running setup.py (path:/tmp/pip-zUYmSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27: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)) 03:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:29 INFO - Running setup.py (path:/tmp/pip-z8fCIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:29 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)) 03:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:29 INFO - Running setup.py (path:/tmp/pip-FeWrG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:29 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)) 03:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:29 INFO - Running setup.py (path:/tmp/pip-MJ5Exq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:29 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)) 03:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:29 INFO - Running setup.py (path:/tmp/pip-Ii_YrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:29 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)) 03:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:29 INFO - Running setup.py (path:/tmp/pip-ftirV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:29 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)) 03:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:29 INFO - Running setup.py (path:/tmp/pip-xFmZpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:29 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)) 03:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:29 INFO - Running setup.py (path:/tmp/pip-EV2_zo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:29 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)) 03:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:29 INFO - Running setup.py (path:/tmp/pip-6A_T1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 03:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:29 INFO - Running setup.py (path:/tmp/pip-VXhRTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:29 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)) 03:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:29 INFO - Running setup.py (path:/tmp/pip-E6vUe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:29 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)) 03:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:29 INFO - Running setup.py (path:/tmp/pip-Iiu54Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:29 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)) 03:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:29 INFO - Running setup.py (path:/tmp/pip-rUJEEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:29 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)) 03:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:29 INFO - Running setup.py (path:/tmp/pip-IIyfd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:29 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)) 03:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:29 INFO - Running setup.py (path:/tmp/pip-hqXMGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27: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)) 03:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:30 INFO - Running setup.py (path:/tmp/pip-Pqojga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:30 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)) 03:27:30 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)) 03:27:30 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)) 03:27:30 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)) 03:27:30 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)) 03:27:30 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)) 03:27:30 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)) 03:27:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:27:30 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 03:27:30 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 03:27:30 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 03:27:30 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 03:27:31 INFO - Downloading blessings-1.6.tar.gz 03:27:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:27:31 INFO - Installing collected packages: blessings 03:27:31 INFO - Running setup.py install for blessings 03:27:31 INFO - Successfully installed blessings 03:27:31 INFO - Cleaning up... 03:27:31 INFO - Return code: 0 03:27:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:27:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:31 INFO - Reading from file tmpfile_stdout 03:27:31 INFO - Current package versions: 03:27:31 INFO - argparse == 1.2.1 03:27:31 INFO - blessings == 1.6 03:27:31 INFO - blobuploader == 1.2.4 03:27:31 INFO - docopt == 0.6.1 03:27:31 INFO - functools32 == 3.2.3-2 03:27:31 INFO - jsonschema == 2.5.1 03:27:31 INFO - manifestparser == 1.1 03:27:31 INFO - mozInstall == 1.13 03:27:31 INFO - mozcrash == 1.0 03:27:31 INFO - mozdebug == 0.1 03:27:31 INFO - mozdevice == 0.51 03:27:31 INFO - mozfile == 1.2 03:27:31 INFO - mozhttpd == 0.7 03:27:31 INFO - mozinfo == 0.10 03:27:31 INFO - mozleak == 0.1 03:27:31 INFO - mozlog == 3.4 03:27:31 INFO - moznetwork == 0.27 03:27:31 INFO - mozprocess == 0.25 03:27:31 INFO - mozprofile == 0.28 03:27:31 INFO - mozrunner == 6.13 03:27:31 INFO - mozscreenshot == 0.1 03:27:31 INFO - mozsystemmonitor == 0.3 03:27:31 INFO - moztest == 0.8 03:27:31 INFO - mozversion == 1.4 03:27:31 INFO - psutil == 3.1.1 03:27:31 INFO - requests == 1.2.3 03:27:31 INFO - wsgiref == 0.1.2 03:27:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:31 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')]} 03:27:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:31 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')]} 03:27:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:31 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 0x254f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cd9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cb140>, '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 0x28cba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cbed0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', '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 03:27:31 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 03:27:31 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 03:27:31 INFO - Using env: {'DISPLAY': ':0', 03:27:31 INFO - 'HOME': '/home/cltbld', 03:27:31 INFO - 'LANG': 'en_US.UTF-8', 03:27:31 INFO - 'LANGUAGE': 'en_US:en', 03:27:31 INFO - 'LOGNAME': 'cltbld', 03:27:31 INFO - 'MAIL': '/var/mail/cltbld', 03:27:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:31 INFO - 'MOZ_NO_REMOTE': '1', 03:27:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:31 INFO - 'NO_EM_RESTART': '1', 03:27:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:31 INFO - 'PWD': '/builds/slave/test', 03:27:31 INFO - 'SHELL': '/bin/bash', 03:27:31 INFO - 'SHLVL': '1', 03:27:31 INFO - 'TERM': 'linux', 03:27:31 INFO - 'TMOUT': '86400', 03:27:31 INFO - 'USER': 'cltbld', 03:27:31 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', 03:27:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:31 INFO - '_': '/tools/buildbot/bin/python'} 03:27:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:31 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)) 03:27:31 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)) 03:27:31 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)) 03:27:31 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)) 03:27:31 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)) 03:27:31 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)) 03:27:31 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)) 03:27:31 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)) 03:27:31 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)) 03:27:31 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:27: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 03:27: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 03:27: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 03:27: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 03:27:32 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:27:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:27: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)) 03:27: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)) 03:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:27:33 INFO - Installing collected packages: marionette-driver 03:27:33 INFO - Running setup.py install for marionette-driver 03:27:33 INFO - Successfully installed marionette-driver 03:27:33 INFO - Cleaning up... 03:27:33 INFO - Return code: 0 03:27:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:27:33 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')]} 03:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:33 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')]} 03:27:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:33 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 0x254f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2729a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cd9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cb140>, '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 0x28cba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cbed0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', '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 03:27:33 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 03:27:33 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 03:27:33 INFO - Using env: {'DISPLAY': ':0', 03:27:33 INFO - 'HOME': '/home/cltbld', 03:27:33 INFO - 'LANG': 'en_US.UTF-8', 03:27:33 INFO - 'LANGUAGE': 'en_US:en', 03:27:33 INFO - 'LOGNAME': 'cltbld', 03:27:33 INFO - 'MAIL': '/var/mail/cltbld', 03:27:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:33 INFO - 'MOZ_NO_REMOTE': '1', 03:27:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:33 INFO - 'NO_EM_RESTART': '1', 03:27:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:33 INFO - 'PWD': '/builds/slave/test', 03:27:33 INFO - 'SHELL': '/bin/bash', 03:27:33 INFO - 'SHLVL': '1', 03:27:33 INFO - 'TERM': 'linux', 03:27:33 INFO - 'TMOUT': '86400', 03:27:33 INFO - 'USER': 'cltbld', 03:27:33 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', 03:27:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:33 INFO - '_': '/tools/buildbot/bin/python'} 03:27:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:27:33 INFO - Cleaning up... 03:27:33 INFO - Return code: 0 03:27:33 INFO - Running post-action listener: _resource_record_post_action 03:27:33 INFO - Running post-action listener: _start_resource_monitoring 03:27:33 INFO - Starting resource monitoring. 03:27:33 INFO - [mozharness: 2017-06-23 10:27:33.451501Z] Finished create-virtualenv step (success) 03:27:33 INFO - [mozharness: 2017-06-23 10:27:33.452009Z] Running install step. 03:27:33 INFO - Running pre-action listener: _resource_record_pre_action 03:27:33 INFO - Running main action method: install 03:27:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:33 INFO - Reading from file tmpfile_stdout 03:27:33 INFO - Detecting whether we're running mozinstall >=1.0... 03:27:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:27:33 INFO - Reading from file tmpfile_stdout 03:27:33 INFO - Output received: 03:27:33 INFO - Usage: mozinstall [options] installer 03:27:33 INFO - Options: 03:27:33 INFO - -h, --help show this help message and exit 03:27:33 INFO - -d DEST, --destination=DEST 03:27:33 INFO - Directory to install application into. [default: 03:27:33 INFO - "/builds/slave/test"] 03:27:33 INFO - --app=APP Application being installed. [default: firefox] 03:27:33 INFO - mkdir: /builds/slave/test/build/application 03:27:33 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'] 03:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:27:51 INFO - Reading from file tmpfile_stdout 03:27:51 INFO - Output received: 03:27:51 INFO - /builds/slave/test/build/application/firefox/firefox 03:27:51 INFO - Running post-action listener: _resource_record_post_action 03:27:51 INFO - [mozharness: 2017-06-23 10:27:51.534130Z] Finished install step (success) 03:27:51 INFO - [mozharness: 2017-06-23 10:27:51.534416Z] Running setup-mitmproxy step. 03:27:51 INFO - Running pre-action listener: _resource_record_pre_action 03:27:51 INFO - Running main action method: setup_mitmproxy 03:27:51 INFO - Skipping: mitmproxy is not required 03:27:51 INFO - Running post-action listener: _resource_record_post_action 03:27:51 INFO - [mozharness: 2017-06-23 10:27:51.535555Z] Finished setup-mitmproxy step (success) 03:27:51 INFO - [mozharness: 2017-06-23 10:27:51.535791Z] Running run-tests step. 03:27:51 INFO - Running pre-action listener: _resource_record_pre_action 03:27:51 INFO - Running main action method: run_tests 03:27:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:27:51 INFO - Python 2.7.3 03:27:51 INFO - Return code: 0 03:27:51 INFO - grabbing minidump binary from tooltool 03:27:51 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')]} 03:27:51 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28cb140>, '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 0x28cba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28cbed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:27:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:27:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:27:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:27:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:27:51 INFO - Return code: 0 03:27:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:27:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:27:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:27:51 INFO - ENV: RUST_BACKTRACE is now 1 03:27:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:27:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:27:51 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/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 03:27:51 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/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 03:27:51 INFO - Using env: {'DISPLAY': ':0', 03:27:51 INFO - 'HOME': '/home/cltbld', 03:27:51 INFO - 'LANG': 'en_US.UTF-8', 03:27:51 INFO - 'LANGUAGE': 'en_US:en', 03:27:51 INFO - 'LOGNAME': 'cltbld', 03:27:51 INFO - 'MAIL': '/var/mail/cltbld', 03:27:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:27:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:51 INFO - 'MOZ_NO_REMOTE': '1', 03:27:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:27:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:51 INFO - 'NO_EM_RESTART': '1', 03:27:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:51 INFO - 'PWD': '/builds/slave/test', 03:27:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:27:51 INFO - 'RUST_BACKTRACE': '1', 03:27:51 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:27:51 INFO - 'SHELL': '/bin/bash', 03:27:51 INFO - 'SHLVL': '1', 03:27:51 INFO - 'TERM': 'linux', 03:27:51 INFO - 'TMOUT': '86400', 03:27:51 INFO - 'USER': 'cltbld', 03:27:51 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072', 03:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:51 INFO - '_': '/tools/buildbot/bin/python'} 03:27:51 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/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 03:27:51 INFO - mozversion application_buildid: 20170623091643 03:27:51 INFO - mozversion application_changeset: 3b468193c933806339fa4a8dee73d03a09e635ab 03:27:51 INFO - mozversion application_display_name: Nightly 03:27:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:27:51 INFO - mozversion application_name: Firefox 03:27:51 INFO - mozversion application_remotingname: firefox 03:27:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:27:51 INFO - mozversion application_vendor: Mozilla 03:27:51 INFO - mozversion application_version: 56.0a1 03:27:51 INFO - mozversion platform_buildid: 20170623091643 03:27:51 INFO - mozversion platform_changeset: 3b468193c933806339fa4a8dee73d03a09e635ab 03:27:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:27:51 INFO - mozversion platform_version: 56.0a1 03:27:51 INFO - using testdate: 1498213671 03:27:51 INFO - actual date: 1498213671 03:27:51 INFO - starting webserver on 'localhost:42830' 03:27:51 INFO - SUITE-START | Running 2 tests 03:27:51 INFO - TEST-START | dromaeo_css 03:27:51 INFO - operating with platform_type : linux_ 03:27:51 INFO - Initialising browser for dromaeo_css test... 03:27:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42830/getInfo.html -profile /tmp/tmp2wKYVa/profile 03:27:51 INFO - TEST-INFO | started process 14099 (/builds/slave/test/build/application/firefox/firefox http://localhost:42830/getInfo.html) 03:27:57 INFO - TEST-INFO | 14099: exit 0 03:27:57 INFO - Browser initialized. 03:27:57 INFO - Running cycle 1/1 for dromaeo_css test... 03:27:57 INFO - TEST-INFO | started process 14332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2wKYVa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:28:09 INFO - PID 14332 | RSS: Main: 169373696 03:28:09 INFO - PID 14332 | 03:31:11 INFO - PID 14332 | Cycle 1(1): loaded http://localhost:42830/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42830/tests/dromaeo/cssquery-ext.html) 03:31:13 INFO - PID 14332 | RSS: Main: 177864704 03:31:13 INFO - PID 14332 | 03:34:15 INFO - PID 14332 | Cycle 1(1): loaded http://localhost:42830/tests/dromaeo/cssquery-ext.html (next: http://localhost:42830/tests/dromaeo/cssquery-jquery.html) 03:34:15 INFO - PID 14332 | RSS: Main: 173707264 03:34:15 INFO - PID 14332 | 03:37:17 INFO - PID 14332 | Cycle 1(1): loaded http://localhost:42830/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42830/tests/dromaeo/cssquery-mootools.html) 03:37:17 INFO - PID 14332 | RSS: Main: 175468544 03:37:17 INFO - PID 14332 | 03:40:19 INFO - PID 14332 | Cycle 1(1): loaded http://localhost:42830/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42830/tests/dromaeo/cssquery-prototype.html) 03:40:20 INFO - PID 14332 | RSS: Main: 174280704 03:40:20 INFO - PID 14332 | 03:43:22 INFO - PID 14332 | Cycle 1(1): loaded http://localhost:42830/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42830/tests/dromaeo/cssquery-yui.html) 03:43:23 INFO - PID 14332 | RSS: Main: 175603712 03:43:23 INFO - PID 14332 | 03:46:24 INFO - PID 14332 | Cycle 1(1): loaded http://localhost:42830/tests/dromaeo/cssquery-yui.html (next: http://localhost:42830/tests/dromaeo/cssquery-dojo.html) 03:46:25 INFO - PID 14332 | RSS: Main: 174759936 03:46:25 INFO - PID 14332 | 03:46:25 INFO - PID 14332 | __start_tp_report 03:46:25 INFO - PID 14332 | _x_x_mozilla_page_load 03:46:25 INFO - PID 14332 | _x_x_mozilla_page_load_details 03:46:25 INFO - PID 14332 | |i|pagename|runs| 03:46:25 INFO - PID 14332 | |0;dojo.html;3376.8818091366807;3444.2250493638935;3466.324066806973;3468.2543253200556;3495.2659941412303;6093.299270583884;6121.920360241886;6140.412224875365;6146.754129834812;6173.228346456698;6267.780627678032;6282.811515654537;6314.336994615556;6341.556091073627;6358.586691865025;5547.55619550437;5568.805091821787;5578.497935185833;5598.692071936042;5645.887082258352;5592;5592.245046918675;5593.776248950037;5654.038813401731;5675.177099320596;5378.220158077057;5412.972935135338;5430.91853622196;5471.452854714496;5581.190727344512;5457.263269458612;5524.4199359067525;5540.722963851832;5584.0507113790345;5590.552755779528;5450;5508.504234618864;5512.33851937766;5523.033469142924;5532.75102620383;6125.111858780452;6217.067439884008;6232.844178895519;6259.655718935457;6295;6640.800775976729;6709.832254193635;6727.66361681914;6826;6856.588604683735;6707.262201157869;6796.150481189851;6832.419244364185;6834.453243740489;6846.520743547953;6306.9684651576445;6353.364663533702;6354.777582784581;6371.139896114011;6381.968090159519;6870.519063665495;6948.756793512202;7039.155301363767;7077.752278670222;7081.185663648644;6567.080608714784;6591.0442985766795;6605.900911486331;6626.801195964129;6647.534672572873;6835.829104272333;6837.487188460886;6851.862962740817;6852.794416167523;6855.07456493367;6760.459163266927;6810.523263371616;6810.693518791666;6813.693383797741;6839.316068393121;6813;6832;6838.692258848364;6849.828754281183;6854.383105520527;4969.428515720666;5020.3724534433195;5036.64743467961;5135.768890399941;5136.8715782105;4484.484284307281;4540.72755634663;4553.2942393929;4593.058423023273;4605.309203619484;6389.169407976933;6402.199725034371;6453.80638580834;6461.64460954652;6464.870702586016;6901.344372284625;6917.204521479994;6920.5847649140205;6922.134733158356;6931.965340173267;6247.406496382927;6273.560850740404;6357.872842543124;6382.936170638327;6436.259830119502;5728.226689396962;5744.253247077937;5755.740991655385;5761.251037365116;5769.596128271065;7146.142462904277;7190.460715446363;7208.35124838767;7243.275672432715;7244.529105608224;6908;6926.411255043377;6936.965315173392;6949.478789090939;6972.372486476242;6980.7905762827195;7054.08296921397;7237.095363079615;7246.746363877239;7265.382442492447;6636;6667.19993600771;6722.865542689216;6763.93236067633;6772.11962444879;6860.622665753232;6872.140982377203;6892.620905850226;6935.479839012195;6954.374106330454;6647.634380108947;6685.331466853276;6689.364510371507;6690.096836926952;6691.5650482718465;6493.675316234075;6654.101696271135;6709.127813384229;6722.831929201809;6732.495062870402;6522.315156908457;6545.37818907203;6548.541602087808;6664.233613134552;6692.899606505809;6707.228668703162;6708.83227919306;6762.222344430256;6790.490713196431;6798.082258894986;6547.836304092436;6566.868662626625;6588.242352129567;6592.505562082959;6602.8349291268105 03:46:25 INFO - PID 14332 | |1;ext.html;873.9742804654009;903.7830920579058;933.7898972731132;936.2135805923025;968.5641461342393;38294.234115317675;40796;40859.79570102145;40961.180776384455;41093.17813643733;35991;36098.458523122106;36246.63753362466;36473.81763091187;36537.086572835695;6665.666716664159;6770.627615481147;6772.627505487197;6809.897851532231;6851.177858656968;6679.231888332831;6797.388235058844;6799.218089919673;6807.659617019154;6820.761273355433;6732.394084532391;6800.183977922631;6800.945853392732;6804.523683342168;6805.931940680579;6739.528233023641;6776.356246156632;6783.796486105425;6806.353396427381;6815.454763618924;6147.72335244915;6213.906791398133;6244.906326405107;6246.531510136712;6264.530160237955;32970;33037.66962330394;33130.17174570655;33263.16842078943;33337.33325333504;3317.6350601433824;3363.596368435779;3366.192113892648;3417.128632198798;3494.947575786365;29932.850335748182;29941.700582994326;30073.849630751924;30079.849600751855;30114.397712045855;3561.661642143992;3604.6215147409407;3612.8735494257576;3625.329314076904;3655.141041855162;201035;203351;204590;207353;209617;48934.75532622385;49046.75476622594;49130;49240.261396079084;50840.74579627152;50751.492485074676;51072;51124.74437627788;51171;51374;15377.615559611098;15456.149911754961;15474.071555706694;15476.148811815234;15493.302801373966;12603.306818125091;12633.557825476064;12637.178583392233;12658.81011784824;12677.366131693563;14365.209913454652;14368.784468232985;14388.784168237486;14490.927545362205;14627.707445851023;5753.827385178452;5822.854428639318;5831.737571809279;5860.531157507389;5928.822135335947;1073.1361254190451;1084.6745976207105;1090.6618948126106;1104;1119.620805787701;24112;24989.125380611593;25248.873755631103;25308;25336.366590835376;1170.9121815863843;1219.2623462805052;1230.163488827588;1240.9813852792215;1245.4084309952882;13290.800637990438;13326.133801303078;13434.865651343556;13563.525276615272;13610.387532561059;274403;275532;276605;276608;276810;52766;53027.469725303024;53078.46921530813;53222;53237.7338113307;1475.1223022301713;1516.0600427734876;1529.2277399912973;1532.2032543077537;1540.4454396417282;23163.88418057899;23610;23623.29130126099;23642.52714945657;23717;37526;37797.811010944766;37820.43269350907;38012.80993595014;38123.618763813116;206554;207198;208429;208620;208890;33004.66995330016;36951;37082;37146;37830.62169378381;42786.14427711491;43860.78069609631;44863.775681121384;44979.32531011972;44996.10007799891;30658.84670576633;31205.68794312028;32288.515672265406;32511.18722031968;33674;33224;33658.831705841316;33783.49324760081;34229.48655770116;34547.48178777371;37974.62025379711;39636.2072758549;39764.40353394643;39863.60136398599;39924.80037599793;30097.3980520384;32097.839510802296;32597.674023260413;33155.66844331622;34089;24790;26234.475310494065;26309.736902631495;26485.470290594465;26518.602220966313 03:46:25 INFO - PID 14332 | |2;jquery.html;554.3901708121069;556.9554435645149;560.2688491518571;574.8735278238788;592.1443514122094;20596.38210853675;21921.890390548066;21929.12283508662;21940.561188776213;21940.780592194074;24740.628890566655;25561.233163005094;26608;26698.332541686468;26773.464530709374;6183.288921773986;6286.3713628637;6306.1486699295465;6333.08170315304;6343.524235682342;6266.091416744569;6361;6362.045693146042;6362.681865906709;6380.202474690664;5839.474447299742;6296.087067375228;6320.431161195492;6339.11252424661;6342;6293.370662933693;6363.681815909233;6386.361363863576;6386.968065159667;6387.808365749035;5944.673042982634;5956.7319470623925;5972.044472884318;5975.790847320323;5978.701064946736;27534.173974780788;27742.861285693645;28311.433771324664;28314.150575482767;28320.716792832012;2177.575372802304;2229.4092065602626;2242.7757224277607;2256.5261295128043;2266.4900397410615;18452.169652365676;18715.90642046781;18854.15156317969;18923.337683181024;19002.334918277793;2351.400392899817;2361.881905904715;2404.9158279460135;2447.0823441209545;2450.0689737899484;133593;134994;136246;136333.999999999;136505;14454;15023.248837558078;15388.846111538965;15855.286512106983;15912.76130858038;23806;23869.641955370684;23908.760912390655;23932;23948.161814336414;10058.145057670034;10141.492925353703;10234.897651023542;10370.792584148276;10474.214433917487;9252.722418327461;9305.953470232605;9357.90642093584;9372.828396450444;9379.718608441757;9172.357934944623;9267.44395336282;9589.089036541518;9720.513974301257;10072.949635251776;2750.7799376049866;2818.718128187165;2888.768898488116;2916.7812414068603;2957.659869115036;1032.76762728387;1045.7124290820086;1062.792755412687;1075.2688172043086;1082.9241953063367;20526.38420847347;20712.378628641163;21366.679499807517;21945;22082.22712205065;1057.5558265528343;1063.122923588043;1063.872335319751;1087.6791346552786;1093.9552727145556;11341.716457088638;11351.262167959056;11575.942120289345;11624.360660163604;11790.23363481371;544299;547107;555721;565428;566801;105397;107949.4602526998;108098;108136;108739.45630271798;1170.5610396101463;1172.4137931034484;1210.6211294805748;1211.7455334379704;1215.3497878634887;17539.386121485688;18580.907095464438;18668.906655466635;18829;19219.135138918504;52135;53169;53608.92782144413;54088.45911540834;54791;67615;68108.31891681218;68157.65921170561;68172.3182768166;68818;12205.389730513616;12510;12784.872151278369;12820.358982051046;12832.230066196058;18600.06999650039;18738.344157954405;18846.623067538847;19242.23031078797;19351.612967740846;14446.277686115862;14988.700225995637;15238.31427585739;15324.846751532788;15349.539513814603;13751.724965500835;13807.654808629864;14107.153570785786;14196.716065678835;14710.705785884436;14433.711325773636;14979.251037447866;14998.925005374904;15122.39510419571;15138.167400793061;12862.935685321514;12920.676983075498;12933.482660693844;13001.024923130613;13033.804492932803;13604;14443.78334325007;14473.276336183359;14496.637584060483;14506.274686265433 03:46:25 INFO - PID 14332 | |3;mootools.html;1420.4034305591651;1445.6530432696156;1456.5484699743074;1485.4058376649343;1486.7844162596416;14905.403783848647;15490.535283941499;15522.767158492617;15570.610734731637;15607.843921560781;15148.394064237416;15205.77191342128;15216.315265813037;15244.390224391038;15255.313510892009;2608.3087981684916;2690.5291573974573;2691.2733561938267;2692.8788204530842;2702.7702645275076;2494.4387512809562;2592.261205556417;2595.610658401236;2596.065416450086;2598.558245098338;2556.18202175304;2574.3306740247576;2583.160472846323;2585.03061351993;2590.171145233526;2502.074232533965;2520.4707011527507;2523.835950663201;2525.255049760325;2528.228890188501;2460.225029115823;2461.753824617542;2491.2401717476164;2561.871906404691;2643.6827580690247;15116.09303441797;15116.622084447978;15177;15199.468018619405;15236.162011089385;7822.452428330019;8105.675772969074;8144.6334914928375;8149.918500815034;8153.95923020387;4583.335416364608;4691.437027556681;4816.301636262722;4820.301056346845;4835.492273311322;1543.4212170436087;1550.4650895441055;1559.5477311579627;1575.3934735126943;1590.4592438570942;23487.88256058726;24116.999999999825;25393.238202853758;25829.095981640552;25854.224373268833;6488.967555162289;6737.9663101685155;7022.894656580155;7287.344139027513;7324.743633972786;17631.64736705259;17633;17639.206235719423;17694.115294235493;17705.7344139838;7946.404019698546;8086.353091752646;8219.383546234056;8256.25693687571;8265.710700125466;7387.076615423072;7428.405727541784;7433.033705618235;7448.739294124788;7477;5300.893982120336;5348.786048558092;5508.862278443071;5522.751476183581;5554.944450555443;1605.1252067623172;1610.4041504643358;1612.1939030484757;1629.7881275434354;1633.207894171326;899.2356496977517;908.8954770201511;915.33638112368;919.72868003939;946.0066929723763;7469.760552949889;7560;7594.772156835304;7595.924040759633;7756.883646745303;736.7716008037419;999.7650552120245;1020.1226944827442;1029.6832127712646;1050.7058023753361;5543.916841247385;5635.548536386685;5679.290088738908;5790.01569733138;5866.2373891393845;21493.57012859734;22207.1117155312;22227.555448890933;22273;22359.776402236093;21330.89334553317;21473;21677.78322216789;21937.01283442249;22249.44376390603;11316.490757915913;11554.133439992034;11742.823857642143;11756.05951523893;12139.575114871113;8286.627101780314;8341.624626891684;8385.371097167616;8475;8520.872186917077;18127.81872181261;18429.447116586525;18576.071196440393;19051.999540048095;19098.904505477385;18290.26838926428;18824;19256;19542.120604572545;19591.118399672334;12211.69470763238;12283.938580307042;12298.631041068782;12448.377581121089;12560.874391255971;14081.859181408056;14230.861531077697;14355.066920650124;14360.497382591559;14370.640733981734;10588.311759735592;10779.299345542515;10810.459477026274;11061.723456913642;11186.272892261977;10819.891801081889;10943;11135.554577816796;11325.773484530428;11551.942240288745;9945.80650321966;10099.04059114383;10189.54147063369;10221.080102790784;10238.078572928473;7236.674349654383;7262.055932728711;7346;7452.441066920112;7626.122995855548;7623.695052198072;7661.080670319598;7699.923000769921;7710.228977102469;7782.221777822172 03:46:25 INFO - PID 14332 | |4;prototype.html;512.3058256063032;517.6117911566326;531.9573635674078;536.8121157594842;539.9358639719591;6255.6559389233635;6293.748250069997;6318.905216421757;6362.650054247015;6385.744570217197;6213.161223234862;6228.512033261377;6245.875082498347;6248.250209974798;6265.715528316696;4951;4979.60163186946;4983.9782844516785;4992.525710057557;4999.650024498268;4980.4272508661425;4994.225894986264;5004.299398084271;5007.173816320303;5011;4983.327250821148;4996.375453068366;4996.950030499703;5006.4492905780335;5007.949920500785;4971.651984361096;4994.175960966436;5015.0972824891505;5016.247562865581;5022.17134172861;4196.838628106528;4359.869203923856;4376.671749618759;4379.423502439958;4601.493835678073;6060.33336333003;6073.908891366633;6084;6103.938960610381;6104.725287362079;5838.532917366643;5846.152307915371;5852.092925596539;5854.531637468992;5856.443637854397;6630.370114839083;6670.4997125215805;6675.265720770712;6696.263411024784;6701.396874281338;4963.652544321899;4979.925301120486;4995.650304478688;5002.098782706058;5012.674176178573;6692.899606505906;6831.28271531487;6982.965085174593;6994.971458277094;7041.612711300876;4912.410510738663;4934.975325123423;5112.233165025276;5153.3558305211845;5163.3545806774155;5172;5225.4774522548205;5229.398619158769;5240.4759524047295;5251.133562962144;5800.564957628195;5822.388649191774;5826.708664566755;5837.29952405714;5845.678487683218;6595.373439523238;6607.4383677386995;6685.39831415175;6687.164104486939;6694.665266736741;1790.274938649849;1817.1096162880094;1821.9726704099448;1822.835944764951;1830.0941034188163;1205.8054341099291;1251.9311437870822;1260.9873901261053;1283.6149155253386;1291.3672300572653;6246.125542424064;6275.552534511544;6293.811185664437;6323.399277068671;6339.96830015847;6809.897851532231;6818.659067046628;6833.453323734089;6869.690863911136;6878.518503704692;6209.410106039919;6266.624002559861;6279.560430769893;6299.811005669837;6313.9368606314265;3547.2373439710586;3591.802450865175;3596.8741094061584;3600.747947643692;3606.8016259106003;6651.3681200286865;7114.430845532345;7133.82165445868;7136.714531418789;7142.357187853118;6966.407855332353;6982.162140543167;6984.580925144508;6991.23096459389;7041.5422997505;7070.338470459438;7080.185778635523;7126.608036558039;7127.4298056155385;7159.749408770772;6850.143732033496;6856.588604683735;6857.382835544626;6866.725330986705;6872.175338959357;6708.865822683617;6727.764528241488;6755.527113102035;6771.695273712793;6777.491688123509;7106.253843346374;7107.431405487652;7108.786736397917;7111.964440177766;7136.393406560501;5161.329027226437;5168.638195326291;5172.689638621695;5180.145276029413;5201.895962080813;6638.601683898982;6737.292584278776;6744.69648865812;6843.320044363067;6857.691403886737;6239.220097487814;6515;6593.263795524996;6596.868062638816;6620.205575330799;6546.18172728409;6557.409833115043;6571.310012448624;6602.1747281589805;6619.50353723463;6563.901541476977;6621.742453381508;6625.635590042401;6628.27089020217;6644.607941141088;6641.306466851115;6661.866762664817;6685.53201275906;6700.731970721116;6710.83222919431;6445.6454894981225;6445.9033114504255;6469.611823290617;6471.935280647322;6503.674816259074 03:46:25 INFO - PID 14332 | |5;yui.html;853.9188777066176;873.5282947208508;876.5222953490347;881.0440671871021;883.7878909061823;15372.84627153728;16060.678786424265;16491.75262371064;16526.752098718527;16538.33846646136;16282.185890705447;16793.160341982883;18372.26510939564;18512.537186570342;18891.811081889176;1002.8545860850172;1005.5726316315573;1006.9980369532326;1007.5214273220236;1053.662827895072;990.4898977026837;990.6285143071349;992.3896803465852;994.9950250248775;1057.2704833664748;839.9916000839975;859.1751918158575;1105.5909313553996;1116.97207569811;1119.44027986007;843.9367047471434;1055.0715370473972;1084.349390365782;1086.6305456144948;1089.4716062709579;795.6300320351064;804.5454318310136;807.9596020198967;808.8988876390451;808.9029316482001;15790.763138552817;15873.841261587351;15974.60063498422;15979.920100399424;15981.28084236212;18771.812281877144;20029.49926251841;20091.799082009285;20151.09320080585;20306.796932030637;15192.620184495365;15270;15295;15332.463363782213;15369.462068827537;3223.06531105979;3484.0418884806627;3513.1568423578415;3537;3548.1661809474754;114432.42783786028;114436.42781786121;117269;122368;122974;12757.55348562796;13526.661833454045;13617;13681.452741890413;13995.51015714445;25908.611370829454;26027.089051883093;26035.479290414085;28318;29246.7075329244;8176.795580110426;8342.749717508363;8441.746747597459;8453.577321133918;8459.111793261742;3653.8173091345325;3913.4716813229848;3956.228535435562;3989.1822176453757;4016.036151323661;4488.192125417456;4502.594766470967;4504.963858312606;4535.659825513099;4559.658025648089;1050.7635781949152;1075.8762742284737;1090.8200146975819;1091.683411810582;1097.6158344579333;645.6223109480912;681.9318068193141;710.9040279562296;732.5165390842125;734.1227233455969;10610.363378197333;11582.710432239093;11964.82052769209;12050.638480845588;12057.155999080156;661.7253839656489;688.710741488576;707.0560801330282;712.3944647049966;717.7487879242328;5170.482951704799;5400.405955344909;5512.6968016759465;5539.169124631338;5618.2415373924;107517;112092;114080;114693;115016;89016;96129.96596740978;98158;99072.50463747635;99587;82500;84827.57586212154;86237;89991.55004224936;94797.52601236949;11839.940800295943;12069.57756478519;12598.622041338775;13321.13412628176;13380.598582042554;39029.609703903734;40148;41272.587274126876;42219;42383.1523369537;72348.63825681049;77143;77811;79212.20787792279;81197.18802811897;17334.82665173332;18599.628007440046;19516.512087197934;19745.40763777089;19846.90076549608;18690.158942847876;19695.212191512754;21391.57216855623;21601.567968640855;21865.125394984658;15761.605959851095;17635;17701.291948321923;19465.610687786448;19721.211151553776;16396.83603163953;18638.53403664919;20145.093470793556;20394.082266297755;20429;16547.66904661876;18050.638987220445;18184;18227.362042328456;18426.447206583824;11503;12661.366931653565;12804.743905122032;12821.679458013625;13138.540151094665;14216.21810800416;14901.956863019484;14978.850211497745;15160.241987900781;15167.317470713624 03:46:25 INFO - PID 14332 | __end_tp_report 03:46:25 INFO - PID 14332 | __start_cc_report 03:46:25 INFO - PID 14332 | _x_x_mozilla_cycle_collect,314 03:46:25 INFO - PID 14332 | __end_cc_report 03:46:25 INFO - PID 14332 | __startTimestamp1498214785011__endTimestamp 03:46:25 INFO - PID 14332 | 03:46:25 INFO - PID 14332 | ------- Summary: start ------- 03:46:25 INFO - PID 14332 | Number of tests: 6 03:46:25 INFO - PID 14332 | 03:46:25 INFO - PID 14332 | [#0] dojo.html Cycles:165 Average:6275.54 Median:6588.24 stddev:808.35 (12.3%) stddev-sans-first:778.18 03:46:25 INFO - PID 14332 | Values: 3376.9 3444.2 3466.3 3468.3 3495.3 6093.3 6121.9 6140.4 6146.8 6173.2 6267.8 6282.8 6314.3 6341.6 6358.6 5547.6 5568.8 5578.5 5598.7 5645.9 5592.0 5592.2 5593.8 5654.0 5675.2 5378.2 5413.0 5430.9 5471.5 5581.2 5457.3 5524.4 5540.7 5584.1 5590.6 5450.0 5508.5 5512.3 5523.0 5532.8 6125.1 6217.1 6232.8 6259.7 6295.0 6640.8 6709.8 6727.7 6826.0 6856.6 6707.3 6796.2 6832.4 6834.5 6846.5 6307.0 6353.4 6354.8 6371.1 6382.0 6870.5 6948.8 7039.2 7077.8 7081.2 6567.1 6591.0 6605.9 6626.8 6647.5 6835.8 6837.5 6851.9 6852.8 6855.1 6760.5 6810.5 6810.7 6813.7 6839.3 6813.0 6832.0 6838.7 6849.8 6854.4 4969.4 5020.4 5036.6 5135.8 5136.9 4484.5 4540.7 4553.3 4593.1 4605.3 6389.2 6402.2 6453.8 6461.6 6464.9 6901.3 6917.2 6920.6 6922.1 6932.0 6247.4 6273.6 6357.9 6382.9 6436.3 5728.2 5744.3 5755.7 5761.3 5769.6 7146.1 7190.5 7208.4 7243.3 7244.5 6908.0 6926.4 6937.0 6949.5 6972.4 6980.8 7054.1 7237.1 7246.7 7265.4 6636.0 6667.2 6722.9 6763.9 6772.1 6860.6 6872.1 6892.6 6935.5 6954.4 6647.6 6685.3 6689.4 6690.1 6691.6 6493.7 6654.1 6709.1 6722.8 6732.5 6522.3 6545.4 6548.5 6664.2 6692.9 6707.2 6708.8 6762.2 6790.5 6798.1 6547.8 6566.9 6588.2 6592.5 6602.8 03:46:25 INFO - PID 14332 | 03:46:25 INFO - PID 14332 | [#1] ext.html Cycles:180 Average:39457.86 Median:33936.25 stddev:60431.44 (178.1%) stddev-sans-first:60531.52 03:46:25 INFO - PID 14332 | Values: 874.0 903.8 933.8 936.2 968.6 38294.2 40796.0 40859.8 40961.2 41093.2 35991.0 36098.5 36246.6 36473.8 36537.1 6665.7 6770.6 6772.6 6809.9 6851.2 6679.2 6797.4 6799.2 6807.7 6820.8 6732.4 6800.2 6800.9 6804.5 6805.9 6739.5 6776.4 6783.8 6806.4 6815.5 6147.7 6213.9 6244.9 6246.5 6264.5 32970.0 33037.7 33130.2 33263.2 33337.3 3317.6 3363.6 3366.2 3417.1 3494.9 29932.9 29941.7 30073.8 30079.8 30114.4 3561.7 3604.6 3612.9 3625.3 3655.1 201035.0 203351.0 204590.0 207353.0 209617.0 48934.8 49046.8 49130.0 49240.3 50840.7 50751.5 51072.0 51124.7 51171.0 51374.0 15377.6 15456.1 15474.1 15476.1 15493.3 12603.3 12633.6 12637.2 12658.8 12677.4 14365.2 14368.8 14388.8 14490.9 14627.7 5753.8 5822.9 5831.7 5860.5 5928.8 1073.1 1084.7 1090.7 1104.0 1119.6 24112.0 24989.1 25248.9 25308.0 25336.4 1170.9 1219.3 1230.2 1241.0 1245.4 13290.8 13326.1 13434.9 13563.5 13610.4 274403.0 275532.0 276605.0 276608.0 276810.0 52766.0 53027.5 53078.5 53222.0 53237.7 1475.1 1516.1 1529.2 1532.2 1540.4 23163.9 23610.0 23623.3 23642.5 23717.0 37526.0 37797.8 37820.4 38012.8 38123.6 206554.0 207198.0 208429.0 208620.0 208890.0 33004.7 36951.0 37082.0 37146.0 37830.6 42786.1 43860.8 44863.8 44979.3 44996.1 30658.8 31205.7 32288.5 32511.2 33674.0 33224.0 33658.8 33783.5 34229.5 34547.5 37974.6 39636.2 39764.4 39863.6 39924.8 30097.4 32097.8 32597.7 33155.7 34089.0 24790.0 26234.5 26309.7 26485.5 26518.6 03:46:25 INFO - PID 14332 | 03:46:25 INFO - PID 14332 | [#2] jquery.html Cycles:180 Average:35576.06 Median:12049.73 stddev:92613.61 (768.6%) stddev-sans-first:92836.09 03:46:25 INFO - PID 14332 | Values: 554.4 557.0 560.3 574.9 592.1 20596.4 21921.9 21929.1 21940.6 21940.8 24740.6 25561.2 26608.0 26698.3 26773.5 6183.3 6286.4 6306.1 6333.1 6343.5 6266.1 6361.0 6362.0 6362.7 6380.2 5839.5 6296.1 6320.4 6339.1 6342.0 6293.4 6363.7 6386.4 6387.0 6387.8 5944.7 5956.7 5972.0 5975.8 5978.7 27534.2 27742.9 28311.4 28314.2 28320.7 2177.6 2229.4 2242.8 2256.5 2266.5 18452.2 18715.9 18854.2 18923.3 19002.3 2351.4 2361.9 2404.9 2447.1 2450.1 133593.0 134994.0 136246.0 136334.0 136505.0 14454.0 15023.2 15388.8 15855.3 15912.8 23806.0 23869.6 23908.8 23932.0 23948.2 10058.1 10141.5 10234.9 10370.8 10474.2 9252.7 9306.0 9357.9 9372.8 9379.7 9172.4 9267.4 9589.1 9720.5 10072.9 2750.8 2818.7 2888.8 2916.8 2957.7 1032.8 1045.7 1062.8 1075.3 1082.9 20526.4 20712.4 21366.7 21945.0 22082.2 1057.6 1063.1 1063.9 1087.7 1094.0 11341.7 11351.3 11575.9 11624.4 11790.2 544299.0 547107.0 555721.0 565428.0 566801.0 105397.0 107949.5 108098.0 108136.0 108739.5 1170.6 1172.4 1210.6 1211.7 1215.3 17539.4 18580.9 18668.9 18829.0 19219.1 52135.0 53169.0 53608.9 54088.5 54791.0 67615.0 68108.3 68157.7 68172.3 68818.0 12205.4 12510.0 12784.9 12820.4 12832.2 18600.1 18738.3 18846.6 19242.2 19351.6 14446.3 14988.7 15238.3 15324.8 15349.5 13751.7 13807.7 14107.2 14196.7 14710.7 14433.7 14979.3 14998.9 15122.4 15138.2 12862.9 12920.7 12933.5 13001.0 13033.8 13604.0 14443.8 14473.3 14496.6 14506.3 03:46:25 INFO - PID 14332 | 03:46:25 INFO - PID 14332 | [#3] mootools.html Cycles:180 Average:9376.09 Median:2476.50 stddev:6660.95 (269.0%) stddev-sans-first:6652.81 03:46:25 INFO - PID 14332 | Values: 1420.4 1445.7 1456.5 1485.4 1486.8 14905.4 15490.5 15522.8 15570.6 15607.8 15148.4 15205.8 15216.3 15244.4 15255.3 2608.3 2690.5 2691.3 2692.9 2702.8 2494.4 2592.3 2595.6 2596.1 2598.6 2556.2 2574.3 2583.2 2585.0 2590.2 2502.1 2520.5 2523.8 2525.3 2528.2 2460.2 2461.8 2491.2 2561.9 2643.7 15116.1 15116.6 15177.0 15199.5 15236.2 7822.5 8105.7 8144.6 8149.9 8154.0 4583.3 4691.4 4816.3 4820.3 4835.5 1543.4 1550.5 1559.5 1575.4 1590.5 23487.9 24117.0 25393.2 25829.1 25854.2 6489.0 6738.0 7022.9 7287.3 7324.7 17631.6 17633.0 17639.2 17694.1 17705.7 7946.4 8086.4 8219.4 8256.3 8265.7 7387.1 7428.4 7433.0 7448.7 7477.0 5300.9 5348.8 5508.9 5522.8 5554.9 1605.1 1610.4 1612.2 1629.8 1633.2 899.2 908.9 915.3 919.7 946.0 7469.8 7560.0 7594.8 7595.9 7756.9 736.8 999.8 1020.1 1029.7 1050.7 5543.9 5635.5 5679.3 5790.0 5866.2 21493.6 22207.1 22227.6 22273.0 22359.8 21330.9 21473.0 21677.8 21937.0 22249.4 11316.5 11554.1 11742.8 11756.1 12139.6 8286.6 8341.6 8385.4 8475.0 8520.9 18127.8 18429.4 18576.1 19052.0 19098.9 18290.3 18824.0 19256.0 19542.1 19591.1 12211.7 12283.9 12298.6 12448.4 12560.9 14081.9 14230.9 14355.1 14360.5 14370.6 10588.3 10779.3 10810.5 11061.7 11186.3 10819.9 10943.0 11135.6 11325.8 11551.9 9945.8 10099.0 10189.5 10221.1 10238.1 7236.7 7262.1 7346.0 7452.4 7626.1 7623.7 7661.1 7699.9 7710.2 7782.2 03:46:25 INFO - PID 14332 | 03:46:25 INFO - PID 14332 | [#4] prototype.html Cycles:180 Average:5651.78 Median:6277.56 stddev:1605.07 (25.6%) stddev-sans-first:1562.53 03:46:25 INFO - PID 14332 | Values: 512.3 517.6 532.0 536.8 539.9 6255.7 6293.7 6318.9 6362.7 6385.7 6213.2 6228.5 6245.9 6248.3 6265.7 4951.0 4979.6 4984.0 4992.5 4999.7 4980.4 4994.2 5004.3 5007.2 5011.0 4983.3 4996.4 4997.0 5006.4 5007.9 4971.7 4994.2 5015.1 5016.2 5022.2 4196.8 4359.9 4376.7 4379.4 4601.5 6060.3 6073.9 6084.0 6103.9 6104.7 5838.5 5846.2 5852.1 5854.5 5856.4 6630.4 6670.5 6675.3 6696.3 6701.4 4963.7 4979.9 4995.7 5002.1 5012.7 6692.9 6831.3 6983.0 6995.0 7041.6 4912.4 4935.0 5112.2 5153.4 5163.4 5172.0 5225.5 5229.4 5240.5 5251.1 5800.6 5822.4 5826.7 5837.3 5845.7 6595.4 6607.4 6685.4 6687.2 6694.7 1790.3 1817.1 1822.0 1822.8 1830.1 1205.8 1251.9 1261.0 1283.6 1291.4 6246.1 6275.6 6293.8 6323.4 6340.0 6809.9 6818.7 6833.5 6869.7 6878.5 6209.4 6266.6 6279.6 6299.8 6313.9 3547.2 3591.8 3596.9 3600.7 3606.8 6651.4 7114.4 7133.8 7136.7 7142.4 6966.4 6982.2 6984.6 6991.2 7041.5 7070.3 7080.2 7126.6 7127.4 7159.7 6850.1 6856.6 6857.4 6866.7 6872.2 6708.9 6727.8 6755.5 6771.7 6777.5 7106.3 7107.4 7108.8 7112.0 7136.4 5161.3 5168.6 5172.7 5180.1 5201.9 6638.6 6737.3 6744.7 6843.3 6857.7 6239.2 6515.0 6593.3 6596.9 6620.2 6546.2 6557.4 6571.3 6602.2 6619.5 6563.9 6621.7 6625.6 6628.3 6644.6 6641.3 6661.9 6685.5 6700.7 6710.8 6445.6 6445.9 6469.6 6471.9 6503.7 03:46:25 INFO - PID 14332 | 03:46:25 INFO - PID 14332 | [#5] yui.html Cycles:180 Average:23326.69 Median:19733.31 stddev:32088.74 (162.6%) stddev-sans-first:32134.39 03:46:25 INFO - PID 14332 | Values: 853.9 873.5 876.5 881.0 883.8 15372.8 16060.7 16491.8 16526.8 16538.3 16282.2 16793.2 18372.3 18512.5 18891.8 1002.9 1005.6 1007.0 1007.5 1053.7 990.5 990.6 992.4 995.0 1057.3 840.0 859.2 1105.6 1117.0 1119.4 843.9 1055.1 1084.3 1086.6 1089.5 795.6 804.5 808.0 808.9 808.9 15790.8 15873.8 15974.6 15979.9 15981.3 18771.8 20029.5 20091.8 20151.1 20306.8 15192.6 15270.0 15295.0 15332.5 15369.5 3223.1 3484.0 3513.2 3537.0 3548.2 114432.4 114436.4 117269.0 122368.0 122974.0 12757.6 13526.7 13617.0 13681.5 13995.5 25908.6 26027.1 26035.5 28318.0 29246.7 8176.8 8342.7 8441.7 8453.6 8459.1 3653.8 3913.5 3956.2 3989.2 4016.0 4488.2 4502.6 4505.0 4535.7 4559.7 1050.8 1075.9 1090.8 1091.7 1097.6 645.6 681.9 710.9 732.5 734.1 10610.4 11582.7 11964.8 12050.6 12057.2 661.7 688.7 707.1 712.4 717.7 5170.5 5400.4 5512.7 5539.2 5618.2 107517.0 112092.0 114080.0 114693.0 115016.0 89016.0 96130.0 98158.0 99072.5 99587.0 82500.0 84827.6 86237.0 89991.6 94797.5 11839.9 12069.6 12598.6 13321.1 13380.6 39029.6 40148.0 41272.6 42219.0 42383.2 72348.6 77143.0 77811.0 79212.2 81197.2 17334.8 18599.6 19516.5 19745.4 19846.9 18690.2 19695.2 21391.6 21601.6 21865.1 15761.6 17635.0 17701.3 19465.6 19721.2 16396.8 18638.5 20145.1 20394.1 20429.0 16547.7 18050.6 18184.0 18227.4 18426.4 11503.0 12661.4 12804.7 12821.7 13138.5 14216.2 14902.0 14978.9 15160.2 15167.3 03:46:25 INFO - PID 14332 | -------- Summary: end -------- 03:46:25 INFO - PID 14332 | 03:46:25 INFO - TEST-INFO | 14332: exit 0 03:46:25 INFO - TEST-OK | dromaeo_css | took 1113690ms 03:46:25 INFO - TEST-START | kraken 03:46:25 INFO - operating with platform_type : linux_ 03:46:25 INFO - Initialising browser for kraken test... 03:46:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42830/getInfo.html -profile /tmp/tmpy8TOYY/profile 03:46:25 INFO - TEST-INFO | started process 14754 (/builds/slave/test/build/application/firefox/firefox http://localhost:42830/getInfo.html) 03:46:31 INFO - TEST-INFO | 14754: exit 0 03:46:31 INFO - Browser initialized. 03:46:31 INFO - Running cycle 1/1 for kraken test... 03:46:31 INFO - TEST-INFO | started process 14985 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy8TOYY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:46:42 INFO - PID 14985 | RSS: Main: 162435072 03:46:42 INFO - PID 14985 | 03:46:44 INFO - PID 14985 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42830/tests/kraken/driver.html?testName=audio-beat-detection) 03:46:45 INFO - PID 14985 | RSS: Main: 166891520 03:46:45 INFO - PID 14985 | 03:46:48 INFO - PID 14985 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42830/tests/kraken/driver.html?testName=audio-dft) 03:46:49 INFO - PID 14985 | RSS: Main: 167739392 03:46:49 INFO - PID 14985 | 03:46:51 INFO - PID 14985 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42830/tests/kraken/driver.html?testName=audio-fft) 03:46:52 INFO - PID 14985 | RSS: Main: 162615296 03:46:52 INFO - PID 14985 | 03:46:54 INFO - PID 14985 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42830/tests/kraken/driver.html?testName=audio-oscillator) 03:46:55 INFO - PID 14985 | RSS: Main: 163778560 03:46:55 INFO - PID 14985 | 03:46:57 INFO - PID 14985 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42830/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:46:57 INFO - PID 14985 | RSS: Main: 163659776 03:46:57 INFO - PID 14985 | 03:47:00 INFO - PID 14985 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42830/tests/kraken/driver.html?testName=imaging-darkroom) 03:47:01 INFO - PID 14985 | RSS: Main: 164560896 03:47:01 INFO - PID 14985 | 03:47:04 INFO - PID 14985 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42830/tests/kraken/driver.html?testName=imaging-desaturate) 03:47:05 INFO - PID 14985 | RSS: Main: 167383040 03:47:05 INFO - PID 14985 | 03:47:08 INFO - PID 14985 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42830/tests/kraken/driver.html?testName=json-parse-financial) 03:47:08 INFO - PID 14985 | RSS: Main: 168161280 03:47:08 INFO - PID 14985 | 03:47:10 INFO - PID 14985 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42830/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:47:11 INFO - PID 14985 | RSS: Main: 167071744 03:47:11 INFO - PID 14985 | 03:47:12 INFO - PID 14985 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42830/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:47:13 INFO - PID 14985 | RSS: Main: 166957056 03:47:13 INFO - PID 14985 | 03:47:15 INFO - PID 14985 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42830/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:47:15 INFO - PID 14985 | RSS: Main: 166850560 03:47:15 INFO - PID 14985 | 03:47:18 INFO - PID 14985 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42830/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:47:19 INFO - PID 14985 | RSS: Main: 167329792 03:47:19 INFO - PID 14985 | 03:47:21 INFO - PID 14985 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42830/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:47:22 INFO - PID 14985 | RSS: Main: 166858752 03:47:22 INFO - PID 14985 | 03:47:24 INFO - PID 14985 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42830/tests/kraken/driver.html?testName=ai-astar) 03:47:24 INFO - PID 14985 | RSS: Main: 168738816 03:47:24 INFO - PID 14985 | 03:47:24 INFO - PID 14985 | __start_tp_report 03:47:24 INFO - PID 14985 | _x_x_mozilla_page_load 03:47:24 INFO - PID 14985 | _x_x_mozilla_page_load_details 03:47:24 INFO - PID 14985 | |i|pagename|runs| 03:47:24 INFO - PID 14985 | |0;ai-astar;98;106;106;104;108;106;107;109;106;105 03:47:24 INFO - PID 14985 | |1;audio-beat-detection;142;120;138;167;115;142;146;117;161;116 03:47:24 INFO - PID 14985 | |2;audio-dft;162;161;161;160;159;167;163;161;160;168 03:47:24 INFO - PID 14985 | |3;audio-fft;74;74;72;162;73;76;73;73;95;74 03:47:24 INFO - PID 14985 | |4;audio-oscillator;79;79;138;81;81;81;130;81;80;127 03:47:24 INFO - PID 14985 | |5;imaging-gaussian-blur;113;113;113;114;113;113;114;114;114;115 03:47:24 INFO - PID 14985 | |6;imaging-darkroom;146;148;147;148;148;147;147;148;147;147 03:47:24 INFO - PID 14985 | |7;imaging-desaturate;94;95;94;95;94;95;93;94;94;94 03:47:24 INFO - PID 14985 | |8;json-parse-financial;48;47;52;46;46;45;57;49;46;55 03:47:24 INFO - PID 14985 | |9;json-stringify-tinderbox;54;53;53;53;53;55;54;53;53;53 03:47:24 INFO - PID 14985 | |10;stanford-crypto-aes;73;73;74;76;76;76;75;75;75;74 03:47:24 INFO - PID 14985 | |11;stanford-crypto-ccm;120;119;122;123;120;120;119;121;117;151 03:47:24 INFO - PID 14985 | |12;stanford-crypto-pbkdf2;171;174;176;167;173;171;168;165;168;169 03:47:24 INFO - PID 14985 | |13;stanford-crypto-sha256-iterative;60;61;60;61;62;61;60;58;60;62 03:47:24 INFO - PID 14985 | __end_tp_report 03:47:24 INFO - PID 14985 | __start_cc_report 03:47:24 INFO - PID 14985 | _x_x_mozilla_cycle_collect,812 03:47:24 INFO - PID 14985 | __end_cc_report 03:47:24 INFO - PID 14985 | __startTimestamp1498214844487__endTimestamp 03:47:24 INFO - PID 14985 | 03:47:24 INFO - PID 14985 | ------- Summary: start ------- 03:47:24 INFO - PID 14985 | Number of tests: 14 03:47:24 INFO - PID 14985 | 03:47:24 INFO - PID 14985 | [#0] ai-astar Cycles:10 Average:105.50 Median:106.50 stddev:2.99 (2.8%) stddev-sans-first:1.50 03:47:24 INFO - PID 14985 | Values: 98.0 106.0 106.0 104.0 108.0 106.0 107.0 109.0 106.0 105.0 03:47:24 INFO - PID 14985 | 03:47:24 INFO - PID 14985 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:142.00 stddev:18.91 (13.3%) stddev-sans-first:19.95 03:47:24 INFO - PID 14985 | Values: 142.0 120.0 138.0 167.0 115.0 142.0 146.0 117.0 161.0 116.0 03:47:24 INFO - PID 14985 | 03:47:24 INFO - PID 14985 | [#2] audio-dft Cycles:10 Average:162.20 Median:161.50 stddev:3.01 (1.9%) stddev-sans-first:3.19 03:47:24 INFO - PID 14985 | Values: 162.0 161.0 161.0 160.0 159.0 167.0 163.0 161.0 160.0 168.0 03:47:24 INFO - PID 14985 | 03:47:24 INFO - PID 14985 | [#3] audio-fft Cycles:10 Average:84.60 Median:74.00 stddev:28.03 (37.9%) stddev-sans-first:29.47 03:47:24 INFO - PID 14985 | Values: 74.0 74.0 72.0 162.0 73.0 76.0 73.0 73.0 95.0 74.0 03:47:24 INFO - PID 14985 | 03:47:24 INFO - PID 14985 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:80.50 stddev:24.98 (31.0%) stddev-sans-first:25.75 03:47:24 INFO - PID 14985 | Values: 79.0 79.0 138.0 81.0 81.0 81.0 130.0 81.0 80.0 127.0 03:47:24 INFO - PID 14985 | 03:47:24 INFO - PID 14985 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 03:47:24 INFO - PID 14985 | Values: 113.0 113.0 113.0 114.0 113.0 113.0 114.0 114.0 114.0 115.0 03:47:24 INFO - PID 14985 | 03:47:24 INFO - PID 14985 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.53 03:47:24 INFO - PID 14985 | Values: 146.0 148.0 147.0 148.0 148.0 147.0 147.0 148.0 147.0 147.0 03:47:24 INFO - PID 14985 | 03:47:24 INFO - PID 14985 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 03:47:24 INFO - PID 14985 | Values: 94.0 95.0 94.0 95.0 94.0 95.0 93.0 94.0 94.0 94.0 03:47:24 INFO - PID 14985 | 03:47:24 INFO - PID 14985 | [#8] json-parse-financial Cycles:10 Average:49.10 Median:48.50 stddev:4.18 (8.6%) stddev-sans-first:4.41 03:47:24 INFO - PID 14985 | Values: 48.0 47.0 52.0 46.0 46.0 45.0 57.0 49.0 46.0 55.0 03:47:24 INFO - PID 14985 | 03:47:24 INFO - PID 14985 | [#9] json-stringify-tinderbox Cycles:10 Average:53.40 Median:53.00 stddev:0.70 (1.3%) stddev-sans-first:0.71 03:47:24 INFO - PID 14985 | Values: 54.0 53.0 53.0 53.0 53.0 55.0 54.0 53.0 53.0 53.0 03:47:24 INFO - PID 14985 | 03:47:24 INFO - PID 14985 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:75.00 stddev:1.16 (1.5%) stddev-sans-first:1.05 03:47:24 INFO - PID 14985 | Values: 73.0 73.0 74.0 76.0 76.0 76.0 75.0 75.0 75.0 74.0 03:47:24 INFO - PID 14985 | 03:47:24 INFO - PID 14985 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:120.50 stddev:9.91 (8.2%) stddev-sans-first:10.44 03:47:24 INFO - PID 14985 | Values: 120.0 119.0 122.0 123.0 120.0 120.0 119.0 121.0 117.0 151.0 03:47:24 INFO - PID 14985 | 03:47:24 INFO - PID 14985 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:171.00 stddev:3.43 (2.0%) stddev-sans-first:3.62 03:47:24 INFO - PID 14985 | Values: 171.0 174.0 176.0 167.0 173.0 171.0 168.0 165.0 168.0 169.0 03:47:24 INFO - PID 14985 | 03:47:24 INFO - PID 14985 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:61.00 stddev:1.18 (1.9%) stddev-sans-first:1.24 03:47:24 INFO - PID 14985 | Values: 60.0 61.0 60.0 61.0 62.0 61.0 60.0 58.0 60.0 62.0 03:47:24 INFO - PID 14985 | -------- Summary: end -------- 03:47:24 INFO - PID 14985 | 03:47:25 INFO - TEST-INFO | 14985: exit 0 03:47:25 INFO - TEST-OK | kraken | took 59658ms 03:47:25 INFO - SUITE-END | took 1173s 03:47:25 INFO - Completed test suite (00:19:33) 03:47:25 INFO - javascript benchmark 03:47:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8496.533243140173, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3376.8818091366807, 3444.2250493638935, 3466.324066806973, 3468.2543253200556, 3495.2659941412303, 6093.299270583884, 6121.920360241886, 6140.412224875365, 6146.754129834812, 6173.228346456698, 6267.780627678032, 6282.811515654537, 6314.336994615556, 6341.556091073627, 6358.586691865025, 5547.55619550437, 5568.805091821787, 5578.497935185833, 5598.692071936042, 5645.887082258352, 5592.0, 5592.245046918675, 5593.776248950037, 5654.038813401731, 5675.177099320596, 5378.220158077057, 5412.972935135338, 5430.91853622196, 5471.452854714496, 5581.190727344512, 5457.263269458612, 5524.4199359067525, 5540.722963851832, 5584.0507113790345, 5590.552755779528, 5450.0, 5508.504234618864, 5512.33851937766, 5523.033469142924, 5532.75102620383, 6125.111858780452, 6217.067439884008, 6232.844178895519, 6259.655718935457, 6295.0, 6640.800775976729, 6709.832254193635, 6727.66361681914, 6826.0, 6856.588604683735, 6707.262201157869, 6796.150481189851, 6832.419244364185, 6834.453243740489, 6846.520743547953, 6306.9684651576445, 6353.364663533702, 6354.777582784581, 6371.139896114011, 6381.968090159519, 6870.519063665495, 6948.756793512202, 7039.155301363767, 7077.752278670222, 7081.185663648644, 6567.080608714784, 6591.0442985766795, 6605.900911486331, 6626.801195964129, 6647.534672572873, 6835.829104272333, 6837.487188460886, 6851.862962740817, 6852.794416167523, 6855.07456493367, 6760.459163266927, 6810.523263371616, 6810.693518791666, 6813.693383797741, 6839.316068393121, 6813.0, 6832.0, 6838.692258848364, 6849.828754281183, 6854.383105520527, 4969.428515720666, 5020.3724534433195, 5036.64743467961, 5135.768890399941, 5136.8715782105, 4484.484284307281, 4540.72755634663, 4553.2942393929, 4593.058423023273, 4605.309203619484, 6389.169407976933, 6402.199725034371, 6453.80638580834, 6461.64460954652, 6464.870702586016, 6901.344372284625, 6917.204521479994, 6920.5847649140205, 6922.134733158356, 6931.965340173267, 6247.406496382927, 6273.560850740404, 6357.872842543124, 6382.936170638327, 6436.259830119502, 5728.226689396962, 5744.253247077937, 5755.740991655385, 5761.251037365116, 5769.596128271065, 7146.142462904277, 7190.460715446363, 7208.35124838767, 7243.275672432715, 7244.529105608224, 6908.0, 6926.411255043377, 6936.965315173392, 6949.478789090939, 6972.372486476242, 6980.7905762827195, 7054.08296921397, 7237.095363079615, 7246.746363877239, 7265.382442492447, 6636.0, 6667.19993600771, 6722.865542689216, 6763.93236067633, 6772.11962444879, 6860.622665753232, 6872.140982377203, 6892.620905850226, 6935.479839012195, 6954.374106330454, 6647.634380108947, 6685.331466853276, 6689.364510371507, 6690.096836926952, 6691.5650482718465, 6493.675316234075, 6654.101696271135, 6709.127813384229, 6722.831929201809, 6732.495062870402, 6522.315156908457, 6545.37818907203, 6548.541602087808, 6664.233613134552, 6692.899606505809, 6707.228668703162, 6708.83227919306, 6762.222344430256, 6790.490713196431, 6798.082258894986, 6547.836304092436, 6566.868662626625, 6588.242352129567, 6592.505562082959, 6602.8349291268105], "value": 6213.554544516453, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.9742804654009, 903.7830920579058, 933.7898972731132, 936.2135805923025, 968.5641461342393, 38294.234115317675, 40796.0, 40859.79570102145, 40961.180776384455, 41093.17813643733, 35991.0, 36098.458523122106, 36246.63753362466, 36473.81763091187, 36537.086572835695, 6665.666716664159, 6770.627615481147, 6772.627505487197, 6809.897851532231, 6851.177858656968, 6679.231888332831, 6797.388235058844, 6799.218089919673, 6807.659617019154, 6820.761273355433, 6732.394084532391, 6800.183977922631, 6800.945853392732, 6804.523683342168, 6805.931940680579, 6739.528233023641, 6776.356246156632, 6783.796486105425, 6806.353396427381, 6815.454763618924, 6147.72335244915, 6213.906791398133, 6244.906326405107, 6246.531510136712, 6264.530160237955, 32970.0, 33037.66962330394, 33130.17174570655, 33263.16842078943, 33337.33325333504, 3317.6350601433824, 3363.596368435779, 3366.192113892648, 3417.128632198798, 3494.947575786365, 29932.850335748182, 29941.700582994326, 30073.849630751924, 30079.849600751855, 30114.397712045855, 3561.661642143992, 3604.6215147409407, 3612.8735494257576, 3625.329314076904, 3655.141041855162, 201035.0, 203351.0, 204590.0, 207353.0, 209617.0, 48934.75532622385, 49046.75476622594, 49130.0, 49240.261396079084, 50840.74579627152, 50751.492485074676, 51072.0, 51124.74437627788, 51171.0, 51374.0, 15377.615559611098, 15456.149911754961, 15474.071555706694, 15476.148811815234, 15493.302801373966, 12603.306818125091, 12633.557825476064, 12637.178583392233, 12658.81011784824, 12677.366131693563, 14365.209913454652, 14368.784468232985, 14388.784168237486, 14490.927545362205, 14627.707445851023, 5753.827385178452, 5822.854428639318, 5831.737571809279, 5860.531157507389, 5928.822135335947, 1073.1361254190451, 1084.6745976207105, 1090.6618948126106, 1104.0, 1119.620805787701, 24112.0, 24989.125380611593, 25248.873755631103, 25308.0, 25336.366590835376, 1170.9121815863843, 1219.2623462805052, 1230.163488827588, 1240.9813852792215, 1245.4084309952882, 13290.800637990438, 13326.133801303078, 13434.865651343556, 13563.525276615272, 13610.387532561059, 274403.0, 275532.0, 276605.0, 276608.0, 276810.0, 52766.0, 53027.469725303024, 53078.46921530813, 53222.0, 53237.7338113307, 1475.1223022301713, 1516.0600427734876, 1529.2277399912973, 1532.2032543077537, 1540.4454396417282, 23163.88418057899, 23610.0, 23623.29130126099, 23642.52714945657, 23717.0, 37526.0, 37797.811010944766, 37820.43269350907, 38012.80993595014, 38123.618763813116, 206554.0, 207198.0, 208429.0, 208620.0, 208890.0, 33004.66995330016, 36951.0, 37082.0, 37146.0, 37830.62169378381, 42786.14427711491, 43860.78069609631, 44863.775681121384, 44979.32531011972, 44996.10007799891, 30658.84670576633, 31205.68794312028, 32288.515672265406, 32511.18722031968, 33674.0, 33224.0, 33658.831705841316, 33783.49324760081, 34229.48655770116, 34547.48178777371, 37974.62025379711, 39636.2072758549, 39764.40353394643, 39863.60136398599, 39924.80037599793, 30097.3980520384, 32097.839510802296, 32597.674023260413, 33155.66844331622, 34089.0, 24790.0, 26234.475310494065, 26309.736902631495, 26485.470290594465, 26518.602220966313], "value": 17008.73000008024, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.3901708121069, 556.9554435645149, 560.2688491518571, 574.8735278238788, 592.1443514122094, 20596.38210853675, 21921.890390548066, 21929.12283508662, 21940.561188776213, 21940.780592194074, 24740.628890566655, 25561.233163005094, 26608.0, 26698.332541686468, 26773.464530709374, 6183.288921773986, 6286.3713628637, 6306.1486699295465, 6333.08170315304, 6343.524235682342, 6266.091416744569, 6361.0, 6362.045693146042, 6362.681865906709, 6380.202474690664, 5839.474447299742, 6296.087067375228, 6320.431161195492, 6339.11252424661, 6342.0, 6293.370662933693, 6363.681815909233, 6386.361363863576, 6386.968065159667, 6387.808365749035, 5944.673042982634, 5956.7319470623925, 5972.044472884318, 5975.790847320323, 5978.701064946736, 27534.173974780788, 27742.861285693645, 28311.433771324664, 28314.150575482767, 28320.716792832012, 2177.575372802304, 2229.4092065602626, 2242.7757224277607, 2256.5261295128043, 2266.4900397410615, 18452.169652365676, 18715.90642046781, 18854.15156317969, 18923.337683181024, 19002.334918277793, 2351.400392899817, 2361.881905904715, 2404.9158279460135, 2447.0823441209545, 2450.0689737899484, 133593.0, 134994.0, 136246.0, 136333.999999999, 136505.0, 14454.0, 15023.248837558078, 15388.846111538965, 15855.286512106983, 15912.76130858038, 23806.0, 23869.641955370684, 23908.760912390655, 23932.0, 23948.161814336414, 10058.145057670034, 10141.492925353703, 10234.897651023542, 10370.792584148276, 10474.214433917487, 9252.722418327461, 9305.953470232605, 9357.90642093584, 9372.828396450444, 9379.718608441757, 9172.357934944623, 9267.44395336282, 9589.089036541518, 9720.513974301257, 10072.949635251776, 2750.7799376049866, 2818.718128187165, 2888.768898488116, 2916.7812414068603, 2957.659869115036, 1032.76762728387, 1045.7124290820086, 1062.792755412687, 1075.2688172043086, 1082.9241953063367, 20526.38420847347, 20712.378628641163, 21366.679499807517, 21945.0, 22082.22712205065, 1057.5558265528343, 1063.122923588043, 1063.872335319751, 1087.6791346552786, 1093.9552727145556, 11341.716457088638, 11351.262167959056, 11575.942120289345, 11624.360660163604, 11790.23363481371, 544299.0, 547107.0, 555721.0, 565428.0, 566801.0, 105397.0, 107949.4602526998, 108098.0, 108136.0, 108739.45630271798, 1170.5610396101463, 1172.4137931034484, 1210.6211294805748, 1211.7455334379704, 1215.3497878634887, 17539.386121485688, 18580.907095464438, 18668.906655466635, 18829.0, 19219.135138918504, 52135.0, 53169.0, 53608.92782144413, 54088.45911540834, 54791.0, 67615.0, 68108.31891681218, 68157.65921170561, 68172.3182768166, 68818.0, 12205.389730513616, 12510.0, 12784.872151278369, 12820.358982051046, 12832.230066196058, 18600.06999650039, 18738.344157954405, 18846.623067538847, 19242.23031078797, 19351.612967740846, 14446.277686115862, 14988.700225995637, 15238.31427585739, 15324.846751532788, 15349.539513814603, 13751.724965500835, 13807.654808629864, 14107.153570785786, 14196.716065678835, 14710.705785884436, 14433.711325773636, 14979.251037447866, 14998.925005374904, 15122.39510419571, 15138.167400793061, 12862.935685321514, 12920.676983075498, 12933.482660693844, 13001.024923130613, 13033.804492932803, 13604.0, 14443.78334325007, 14473.276336183359, 14496.637584060483, 14506.274686265433], "value": 11608.178254114084, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.4034305591651, 1445.6530432696156, 1456.5484699743074, 1485.4058376649343, 1486.7844162596416, 14905.403783848647, 15490.535283941499, 15522.767158492617, 15570.610734731637, 15607.843921560781, 15148.394064237416, 15205.77191342128, 15216.315265813037, 15244.390224391038, 15255.313510892009, 2608.3087981684916, 2690.5291573974573, 2691.2733561938267, 2692.8788204530842, 2702.7702645275076, 2494.4387512809562, 2592.261205556417, 2595.610658401236, 2596.065416450086, 2598.558245098338, 2556.18202175304, 2574.3306740247576, 2583.160472846323, 2585.03061351993, 2590.171145233526, 2502.074232533965, 2520.4707011527507, 2523.835950663201, 2525.255049760325, 2528.228890188501, 2460.225029115823, 2461.753824617542, 2491.2401717476164, 2561.871906404691, 2643.6827580690247, 15116.09303441797, 15116.622084447978, 15177.0, 15199.468018619405, 15236.162011089385, 7822.452428330019, 8105.675772969074, 8144.6334914928375, 8149.918500815034, 8153.95923020387, 4583.335416364608, 4691.437027556681, 4816.301636262722, 4820.301056346845, 4835.492273311322, 1543.4212170436087, 1550.4650895441055, 1559.5477311579627, 1575.3934735126943, 1590.4592438570942, 23487.88256058726, 24116.999999999825, 25393.238202853758, 25829.095981640552, 25854.224373268833, 6488.967555162289, 6737.9663101685155, 7022.894656580155, 7287.344139027513, 7324.743633972786, 17631.64736705259, 17633.0, 17639.206235719423, 17694.115294235493, 17705.7344139838, 7946.404019698546, 8086.353091752646, 8219.383546234056, 8256.25693687571, 8265.710700125466, 7387.076615423072, 7428.405727541784, 7433.033705618235, 7448.739294124788, 7477.0, 5300.893982120336, 5348.786048558092, 5508.862278443071, 5522.751476183581, 5554.944450555443, 1605.1252067623172, 1610.4041504643358, 1612.1939030484757, 1629.7881275434354, 1633.207894171326, 899.2356496977517, 908.8954770201511, 915.33638112368, 919.72868003939, 946.0066929723763, 7469.760552949889, 7560.0, 7594.772156835304, 7595.924040759633, 7756.883646745303, 736.7716008037419, 999.7650552120245, 1020.1226944827442, 1029.6832127712646, 1050.7058023753361, 5543.916841247385, 5635.548536386685, 5679.290088738908, 5790.01569733138, 5866.2373891393845, 21493.57012859734, 22207.1117155312, 22227.555448890933, 22273.0, 22359.776402236093, 21330.89334553317, 21473.0, 21677.78322216789, 21937.01283442249, 22249.44376390603, 11316.490757915913, 11554.133439992034, 11742.823857642143, 11756.05951523893, 12139.575114871113, 8286.627101780314, 8341.624626891684, 8385.371097167616, 8475.0, 8520.872186917077, 18127.81872181261, 18429.447116586525, 18576.071196440393, 19051.999540048095, 19098.904505477385, 18290.26838926428, 18824.0, 19256.0, 19542.120604572545, 19591.118399672334, 12211.69470763238, 12283.938580307042, 12298.631041068782, 12448.377581121089, 12560.874391255971, 14081.859181408056, 14230.861531077697, 14355.066920650124, 14360.497382591559, 14370.640733981734, 10588.311759735592, 10779.299345542515, 10810.459477026274, 11061.723456913642, 11186.272892261977, 10819.891801081889, 10943.0, 11135.554577816796, 11325.773484530428, 11551.942240288745, 9945.80650321966, 10099.04059114383, 10189.54147063369, 10221.080102790784, 10238.078572928473, 7236.674349654383, 7262.055932728711, 7346.0, 7452.441066920112, 7626.122995855548, 7623.695052198072, 7661.080670319598, 7699.923000769921, 7710.228977102469, 7782.221777822172], "value": 6668.903927407826, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [512.3058256063032, 517.6117911566326, 531.9573635674078, 536.8121157594842, 539.9358639719591, 6255.6559389233635, 6293.748250069997, 6318.905216421757, 6362.650054247015, 6385.744570217197, 6213.161223234862, 6228.512033261377, 6245.875082498347, 6248.250209974798, 6265.715528316696, 4951.0, 4979.60163186946, 4983.9782844516785, 4992.525710057557, 4999.650024498268, 4980.4272508661425, 4994.225894986264, 5004.299398084271, 5007.173816320303, 5011.0, 4983.327250821148, 4996.375453068366, 4996.950030499703, 5006.4492905780335, 5007.949920500785, 4971.651984361096, 4994.175960966436, 5015.0972824891505, 5016.247562865581, 5022.17134172861, 4196.838628106528, 4359.869203923856, 4376.671749618759, 4379.423502439958, 4601.493835678073, 6060.33336333003, 6073.908891366633, 6084.0, 6103.938960610381, 6104.725287362079, 5838.532917366643, 5846.152307915371, 5852.092925596539, 5854.531637468992, 5856.443637854397, 6630.370114839083, 6670.4997125215805, 6675.265720770712, 6696.263411024784, 6701.396874281338, 4963.652544321899, 4979.925301120486, 4995.650304478688, 5002.098782706058, 5012.674176178573, 6692.899606505906, 6831.28271531487, 6982.965085174593, 6994.971458277094, 7041.612711300876, 4912.410510738663, 4934.975325123423, 5112.233165025276, 5153.3558305211845, 5163.3545806774155, 5172.0, 5225.4774522548205, 5229.398619158769, 5240.4759524047295, 5251.133562962144, 5800.564957628195, 5822.388649191774, 5826.708664566755, 5837.29952405714, 5845.678487683218, 6595.373439523238, 6607.4383677386995, 6685.39831415175, 6687.164104486939, 6694.665266736741, 1790.274938649849, 1817.1096162880094, 1821.9726704099448, 1822.835944764951, 1830.0941034188163, 1205.8054341099291, 1251.9311437870822, 1260.9873901261053, 1283.6149155253386, 1291.3672300572653, 6246.125542424064, 6275.552534511544, 6293.811185664437, 6323.399277068671, 6339.96830015847, 6809.897851532231, 6818.659067046628, 6833.453323734089, 6869.690863911136, 6878.518503704692, 6209.410106039919, 6266.624002559861, 6279.560430769893, 6299.811005669837, 6313.9368606314265, 3547.2373439710586, 3591.802450865175, 3596.8741094061584, 3600.747947643692, 3606.8016259106003, 6651.3681200286865, 7114.430845532345, 7133.82165445868, 7136.714531418789, 7142.357187853118, 6966.407855332353, 6982.162140543167, 6984.580925144508, 6991.23096459389, 7041.5422997505, 7070.338470459438, 7080.185778635523, 7126.608036558039, 7127.4298056155385, 7159.749408770772, 6850.143732033496, 6856.588604683735, 6857.382835544626, 6866.725330986705, 6872.175338959357, 6708.865822683617, 6727.764528241488, 6755.527113102035, 6771.695273712793, 6777.491688123509, 7106.253843346374, 7107.431405487652, 7108.786736397917, 7111.964440177766, 7136.393406560501, 5161.329027226437, 5168.638195326291, 5172.689638621695, 5180.145276029413, 5201.895962080813, 6638.601683898982, 6737.292584278776, 6744.69648865812, 6843.320044363067, 6857.691403886737, 6239.220097487814, 6515.0, 6593.263795524996, 6596.868062638816, 6620.205575330799, 6546.18172728409, 6557.409833115043, 6571.310012448624, 6602.1747281589805, 6619.50353723463, 6563.901541476977, 6621.742453381508, 6625.635590042401, 6628.27089020217, 6644.607941141088, 6641.306466851115, 6661.866762664817, 6685.53201275906, 6700.731970721116, 6710.83222919431, 6445.6454894981225, 6445.9033114504255, 6469.611823290617, 6471.935280647322, 6503.674816259074], "value": 5181.082751754089, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.9188777066176, 873.5282947208508, 876.5222953490347, 881.0440671871021, 883.7878909061823, 15372.84627153728, 16060.678786424265, 16491.75262371064, 16526.752098718527, 16538.33846646136, 16282.185890705447, 16793.160341982883, 18372.26510939564, 18512.537186570342, 18891.811081889176, 1002.8545860850172, 1005.5726316315573, 1006.9980369532326, 1007.5214273220236, 1053.662827895072, 990.4898977026837, 990.6285143071349, 992.3896803465852, 994.9950250248775, 1057.2704833664748, 839.9916000839975, 859.1751918158575, 1105.5909313553996, 1116.97207569811, 1119.44027986007, 843.9367047471434, 1055.0715370473972, 1084.349390365782, 1086.6305456144948, 1089.4716062709579, 795.6300320351064, 804.5454318310136, 807.9596020198967, 808.8988876390451, 808.9029316482001, 15790.763138552817, 15873.841261587351, 15974.60063498422, 15979.920100399424, 15981.28084236212, 18771.812281877144, 20029.49926251841, 20091.799082009285, 20151.09320080585, 20306.796932030637, 15192.620184495365, 15270.0, 15295.0, 15332.463363782213, 15369.462068827537, 3223.06531105979, 3484.0418884806627, 3513.1568423578415, 3537.0, 3548.1661809474754, 114432.42783786028, 114436.42781786121, 117269.0, 122368.0, 122974.0, 12757.55348562796, 13526.661833454045, 13617.0, 13681.452741890413, 13995.51015714445, 25908.611370829454, 26027.089051883093, 26035.479290414085, 28318.0, 29246.7075329244, 8176.795580110426, 8342.749717508363, 8441.746747597459, 8453.577321133918, 8459.111793261742, 3653.8173091345325, 3913.4716813229848, 3956.228535435562, 3989.1822176453757, 4016.036151323661, 4488.192125417456, 4502.594766470967, 4504.963858312606, 4535.659825513099, 4559.658025648089, 1050.7635781949152, 1075.8762742284737, 1090.8200146975819, 1091.683411810582, 1097.6158344579333, 645.6223109480912, 681.9318068193141, 710.9040279562296, 732.5165390842125, 734.1227233455969, 10610.363378197333, 11582.710432239093, 11964.82052769209, 12050.638480845588, 12057.155999080156, 661.7253839656489, 688.710741488576, 707.0560801330282, 712.3944647049966, 717.7487879242328, 5170.482951704799, 5400.405955344909, 5512.6968016759465, 5539.169124631338, 5618.2415373924, 107517.0, 112092.0, 114080.0, 114693.0, 115016.0, 89016.0, 96129.96596740978, 98158.0, 99072.50463747635, 99587.0, 82500.0, 84827.57586212154, 86237.0, 89991.55004224936, 94797.52601236949, 11839.940800295943, 12069.57756478519, 12598.622041338775, 13321.13412628176, 13380.598582042554, 39029.609703903734, 40148.0, 41272.587274126876, 42219.0, 42383.1523369537, 72348.63825681049, 77143.0, 77811.0, 79212.20787792279, 81197.18802811897, 17334.82665173332, 18599.628007440046, 19516.512087197934, 19745.40763777089, 19846.90076549608, 18690.158942847876, 19695.212191512754, 21391.57216855623, 21601.567968640855, 21865.125394984658, 15761.605959851095, 17635.0, 17701.291948321923, 19465.610687786448, 19721.211151553776, 16396.83603163953, 18638.53403664919, 20145.093470793556, 20394.082266297755, 20429.0, 16547.66904661876, 18050.638987220445, 18184.0, 18227.362042328456, 18426.447206583824, 11503.0, 12661.366931653565, 12804.743905122032, 12821.679458013625, 13138.540151094665, 14216.21810800416, 14901.956863019484, 14978.850211497745, 15160.241987900781, 15167.317470713624], "value": 8875.145393323231, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1470.6000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 106.0, 106.0, 104.0, 108.0, 106.0, 107.0, 109.0, 106.0, 105.0], "value": 105.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 120.0, 138.0, 167.0, 115.0, 142.0, 146.0, 117.0, 161.0, 116.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 160.0, 159.0, 167.0, 163.0, 161.0, 160.0, 168.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 72.0, 162.0, 73.0, 76.0, 73.0, 73.0, 95.0, 74.0], "value": 84.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 138.0, 81.0, 81.0, 81.0, 130.0, 81.0, 80.0, 127.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 113.0, 113.0, 114.0, 114.0, 114.0, 115.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 148.0, 148.0, 147.0, 147.0, 148.0, 147.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 93.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 47.0, 52.0, 46.0, 46.0, 45.0, 57.0, 49.0, 46.0, 55.0], "value": 49.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 53.0, 55.0, 54.0, 53.0, 53.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 76.0, 76.0, 76.0, 75.0, 75.0, 75.0, 74.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 119.0, 122.0, 123.0, 120.0, 120.0, 119.0, 121.0, 117.0, 151.0], "value": 123.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 174.0, 176.0, 167.0, 173.0, 171.0, 168.0, 165.0, 168.0, 169.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 61.0, 62.0, 61.0, 60.0, 58.0, 60.0, 62.0], "value": 60.5, "unit": "score"}]}]} 03:47:25 INFO - Return code: 0 03:47:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:47:25 INFO - # TBPL SUCCESS # 03:47:25 INFO - Running post-action listener: _resource_record_post_action 03:47:25 INFO - [mozharness: 2017-06-23 10:47:25.861728Z] Finished run-tests step (success) 03:47:25 INFO - Running post-run listener: _resource_record_post_run 03:47:25 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 443506688; Read time: 16; Write time: 296184 03:47:25 INFO - TinderboxPrint: CPU usage
13.1% 03:47:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 03:47:25 INFO - TinderboxPrint: I/O write bytes / time
443,506,688 / 296,184 03:47:25 INFO - TinderboxPrint: CPU idle
8,259.1 (86.9%) 03:47:25 INFO - TinderboxPrint: CPU user
1,198.9 (12.6%) 03:47:25 INFO - TinderboxPrint: Swap in / out
0 / 0 03:47:25 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 118226944; Read time: 0; Write time: 89416 03:47:25 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:47:25 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 325279744; Read time: 0; Write time: 206768 03:47:26 INFO - Running post-run listener: _upload_blobber_files 03:47:26 INFO - Blob upload gear active. 03:47:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:47:26 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 03:47:26 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'] 03:47:26 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 03:47:26 INFO - (blobuploader) - INFO - Open directory for files ... 03:47:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:47:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:47:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:27 INFO - (blobuploader) - INFO - Done attempting. 03:47:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:47:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:47:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:34 INFO - (blobuploader) - INFO - Done attempting. 03:47:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:47:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:47:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:34 INFO - (blobuploader) - INFO - Done attempting. 03:47:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:47:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:47:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:35 INFO - (blobuploader) - INFO - Done attempting. 03:47:35 INFO - (blobuploader) - INFO - Iteration through files over. 03:47:35 INFO - Return code: 0 03:47:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:47:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:47:35 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ba5e62399e9eaa2ef26c045830538421fb251be0e779b5544dc5624f1ced6f317e9fe0d147a8c70269018a1bc29098c98416f9bbb684ac783bf1577b3f826fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ba81294c6152e033ebd1d8f83a299236112198fddee3e0ddde9981737b92861d7338dcab6326bfe24538358951c1d3d06ed154c2c9e65734b60a5c0432c9857", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fd75a2802edacc067546584cc1f16f85d7efd64cac449f0a3f58fb722ae78b86cc29308d8dfa7a6222ba3eb932fc5e7d6b6dd544a08bfe2d129d963f7a8f8d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7934c104f4827526e463458e242bf517cd592c2449b95927ed32b064c4ba58f7655daa439088dea179600c4999e3af7952c745698f1e256b41b0d695cc6b8105"} 03:47:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:47:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:47:35 INFO - Contents: 03:47:35 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ba5e62399e9eaa2ef26c045830538421fb251be0e779b5544dc5624f1ced6f317e9fe0d147a8c70269018a1bc29098c98416f9bbb684ac783bf1577b3f826fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ba81294c6152e033ebd1d8f83a299236112198fddee3e0ddde9981737b92861d7338dcab6326bfe24538358951c1d3d06ed154c2c9e65734b60a5c0432c9857", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fd75a2802edacc067546584cc1f16f85d7efd64cac449f0a3f58fb722ae78b86cc29308d8dfa7a6222ba3eb932fc5e7d6b6dd544a08bfe2d129d963f7a8f8d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7934c104f4827526e463458e242bf517cd592c2449b95927ed32b064c4ba58f7655daa439088dea179600c4999e3af7952c745698f1e256b41b0d695cc6b8105"} 03:47:35 INFO - Running post-run listener: copy_logs_to_upload_dir 03:47:35 INFO - Copying logs to upload dir... 03:47:35 INFO - mkdir: /builds/slave/test/build/upload/logs 03:47:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.347774 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-06-23 03:47:35.675426) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-23 03:47:35.679006) ========= 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=bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ba5e62399e9eaa2ef26c045830538421fb251be0e779b5544dc5624f1ced6f317e9fe0d147a8c70269018a1bc29098c98416f9bbb684ac783bf1577b3f826fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ba81294c6152e033ebd1d8f83a299236112198fddee3e0ddde9981737b92861d7338dcab6326bfe24538358951c1d3d06ed154c2c9e65734b60a5c0432c9857", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fd75a2802edacc067546584cc1f16f85d7efd64cac449f0a3f58fb722ae78b86cc29308d8dfa7a6222ba3eb932fc5e7d6b6dd544a08bfe2d129d963f7a8f8d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7934c104f4827526e463458e242bf517cd592c2449b95927ed32b064c4ba58f7655daa439088dea179600c4999e3af7952c745698f1e256b41b0d695cc6b8105"} build_url:https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/TaONX0HITkeQhhuHNqnG1w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ba5e62399e9eaa2ef26c045830538421fb251be0e779b5544dc5624f1ced6f317e9fe0d147a8c70269018a1bc29098c98416f9bbb684ac783bf1577b3f826fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ba81294c6152e033ebd1d8f83a299236112198fddee3e0ddde9981737b92861d7338dcab6326bfe24538358951c1d3d06ed154c2c9e65734b60a5c0432c9857", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8fd75a2802edacc067546584cc1f16f85d7efd64cac449f0a3f58fb722ae78b86cc29308d8dfa7a6222ba3eb932fc5e7d6b6dd544a08bfe2d129d963f7a8f8d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7934c104f4827526e463458e242bf517cd592c2449b95927ed32b064c4ba58f7655daa439088dea179600c4999e3af7952c745698f1e256b41b0d695cc6b8105"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-23 03:47:35.703255) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 03:47:35.703608) ========= 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=bb9b54edd4a927dc735d112f000001d9-1498213601.152845-1517531072 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-23 03:47:35.788420) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-23 03:47:35.788798) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-23 03:47:35.789159) ========= ========= Total master_lag: 0.15 =========