builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-059 starttime: 1495816342.83 results: success (0) revision: 1bfa4578aa56f768626ba278a6929e23fc48db54 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 09:32:22.831582) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 09:32:22.832056) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 09:32:22.832525) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 09:32:22.965812) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 09:32:22.966591) ========= 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=3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-26 09:32:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.0M=0s 2017-05-26 09:32:23 (40.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.199412 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 09:32:23.198985) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 09:32:23.199346) ========= 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=3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014527 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 09:32:23.263304) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-26 09:32:23.263605) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1bfa4578aa56f768626ba278a6929e23fc48db54 --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 1bfa4578aa56f768626ba278a6929e23fc48db54 --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=3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-26 09:32:23,777 truncating revision to first 12 chars 2017-05-26 09:32:23,777 Setting DEBUG logging. 2017-05-26 09:32:23,777 attempt 1/10 2017-05-26 09:32:23,777 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1bfa4578aa56?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-26 09:32:25,194 unpacking tar archive at: mozilla-central-1bfa4578aa56/testing/mozharness/ program finished with exit code 0 elapsedTime=1.737379 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-26 09:32:25.020902) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 09:32:25.021300) ========= script_repo_revision: 1bfa4578aa56f768626ba278a6929e23fc48db54 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 09:32:25.021732) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 09:32:25.022000) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 09:32:25.031788) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-05-26 09:32:25.032164) ========= /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=3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:32:25 INFO - MultiFileLogger online at 20170526 09:32:25 in /builds/slave/test 09:32:25 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 09:32:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:32:25 INFO - {'append_to_log': False, 09:32:25 INFO - 'base_work_dir': '/builds/slave/test', 09:32:25 INFO - 'blob_upload_branch': 'Firefox', 09:32:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:32:25 INFO - 'branch': 'Firefox', 09:32:25 INFO - 'buildbot_json_path': 'buildprops.json', 09:32:25 INFO - 'config_files': ('talos/linux_config.py',), 09:32:25 INFO - 'default_actions': ('clobber', 09:32:25 INFO - 'read-buildbot-config', 09:32:25 INFO - 'download-and-extract', 09:32:25 INFO - 'populate-webroot', 09:32:25 INFO - 'create-virtualenv', 09:32:25 INFO - 'install', 09:32:25 INFO - 'run-tests'), 09:32:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:32:25 INFO - 'download_minidump_stackwalk': True, 09:32:25 INFO - 'download_symbols': 'ondemand', 09:32:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:32:25 INFO - 'tooltool.py': '/tools/tooltool.py', 09:32:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:32:25 INFO - '/tools/misc-python/virtualenv.py')}, 09:32:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:32:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:32:25 INFO - 'gecko_profile': False, 09:32:25 INFO - 'gecko_profile_interval': 0, 09:32:25 INFO - 'installer_path': 'installer.exe', 09:32:25 INFO - 'log_level': 'info', 09:32:25 INFO - 'log_name': 'talos', 09:32:25 INFO - 'log_to_console': True, 09:32:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:32:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:32:25 INFO - 'opt_config_files': (), 09:32:25 INFO - 'pip_index': False, 09:32:25 INFO - 'suite': 'dromaeojs-e10s', 09:32:25 INFO - 'system_bits': '32', 09:32:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:32:25 INFO - 'title': 'talos-linux64-ix-059', 09:32:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:32:25 INFO - 'use_talos_json': True, 09:32:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:32:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:32:25 INFO - 'work_dir': 'build'} 09:32:25 INFO - [mozharness: 2017-05-26 16:32:25.648393Z] Running clobber step. 09:32:25 INFO - Running pre-action listener: _resource_record_pre_action 09:32:25 INFO - Running main action method: clobber 09:32:25 INFO - rmtree: /builds/slave/test/build 09:32:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:32:26 INFO - Running post-action listener: _resource_record_post_action 09:32:26 INFO - [mozharness: 2017-05-26 16:32:26.681878Z] Finished clobber step (success) 09:32:26 INFO - [mozharness: 2017-05-26 16:32:26.681979Z] Running read-buildbot-config step. 09:32:26 INFO - Running pre-action listener: _resource_record_pre_action 09:32:26 INFO - Running main action method: read_buildbot_config 09:32:26 INFO - Using buildbot properties: 09:32:26 INFO - { 09:32:26 INFO - "project": "", 09:32:26 INFO - "product": "firefox", 09:32:26 INFO - "who": "atolfsen@mozilla.com", 09:32:26 INFO - "installer_path": "public/build/target.tar.bz2", 09:32:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 09:32:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:32:26 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 09:32:26 INFO - "stage_platform": "linux64-stylosequential", 09:32:26 INFO - "basedir": "/builds/slave/test", 09:32:26 INFO - "buildnumber": 27, 09:32:26 INFO - "platform": "ubuntu64_hw_styloseq", 09:32:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:32:26 INFO - "slavebuilddir": "test", 09:32:26 INFO - "taskId": "f17J_Ms6R6KBM2uRPKTXag", 09:32:26 INFO - "branch": "mozilla-central", 09:32:26 INFO - "script_repo_revision": "production", 09:32:26 INFO - "revision": "1bfa4578aa56f768626ba278a6929e23fc48db54", 09:32:26 INFO - "slavename": "talos-linux64-ix-059", 09:32:26 INFO - "repo_path": "mozilla-central" 09:32:26 INFO - } 09:32:26 INFO - Finding installer, test and symbols from parent task. 09:32:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f17J_Ms6R6KBM2uRPKTXag'}, attempt #1 09:32:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f17J_Ms6R6KBM2uRPKTXag'}, attempt #1 09:32:27 INFO - Task dependencies: Rs7w24DMQ2C9hDdx9SSAgQ 09:32:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ'}, attempt #1 09:32:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.tar.bz2 09:32:28 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/test_packages.json 09:32:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.crashreporter-symbols.zip 09:32:28 INFO - Running post-action listener: _resource_record_post_action 09:32:28 INFO - [mozharness: 2017-05-26 16:32:28.200316Z] Finished read-buildbot-config step (success) 09:32:28 INFO - [mozharness: 2017-05-26 16:32:28.200535Z] Running download-and-extract step. 09:32:28 INFO - Running pre-action listener: _resource_record_pre_action 09:32:28 INFO - Running main action method: download_and_extract 09:32:28 INFO - mkdir: /builds/slave/test/build/tests 09:32: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')]} 09:32:28 INFO - trying https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.test_packages.json 09:32:28 INFO - Downloading https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:32:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:32:28 INFO - Downloaded 986 bytes. 09:32:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:32:28 INFO - Using the following test package requirements: 09:32:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:32:28 INFO - u'common': [u'target.common.tests.zip'], 09:32:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:32:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:32:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:32:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:32:28 INFO - u'mozbase': [u'target.common.tests.zip'], 09:32:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:32:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:32:28 INFO - u'web-platform': [u'target.common.tests.zip', 09:32:28 INFO - u'target.web-platform.tests.zip'], 09:32:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:32:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:32:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.common.tests.zip 09:32:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:32:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.common.tests.zip into memory 09:32:30 INFO - Content-Length response header: 63525239 09:32:30 INFO - Bytes received: 63525239 09:32:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:32:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.common.tests.zip 09:32:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:32:41 INFO - Fetch https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.common.tests.zip into memory 09:32:42 INFO - Content-Length response header: 63525239 09:32:42 INFO - Bytes received: 63525239 09:32:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.talos.tests.zip 09:32:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:32:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.talos.tests.zip into memory 09:32:55 INFO - Content-Length response header: 14411888 09:32:55 INFO - Bytes received: 14411888 09:32:55 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')]} 09:32:55 INFO - trying https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.tar.bz2 09:32:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:32:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:32:57 INFO - Downloaded 55808791 bytes. 09:32:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.tar.bz2 09:32:57 INFO - mkdir: /builds/slave/test/properties 09:32:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:32:57 INFO - Writing to file /builds/slave/test/properties/build_url 09:32:57 INFO - Contents: 09:32:57 INFO - build_url:https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.tar.bz2 09:32:57 INFO - Running post-action listener: _resource_record_post_action 09:32:57 INFO - Running post-action listener: set_extra_try_arguments 09:32:57 INFO - [mozharness: 2017-05-26 16:32:57.770004Z] Finished download-and-extract step (success) 09:32:57 INFO - [mozharness: 2017-05-26 16:32:57.770230Z] Running populate-webroot step. 09:32:57 INFO - Running pre-action listener: _resource_record_pre_action 09:32:57 INFO - Running main action method: populate_webroot 09:32:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:32:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:32:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:32:57 INFO - '--tppagecycles', 09:32:57 INFO - '7'], 09:32:57 INFO - 'tests': ['tsvgm']}}, 09:32:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:32:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:32:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:32:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:32:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:32:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:32:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:32:57 INFO - 'talos_options': ['--disable-e10s'], 09:32:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:32:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:32:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:32:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:32:57 INFO - 'talos_options': ['--disable-e10s'], 09:32:57 INFO - 'tests': ['damp', 'tps']}, 09:32:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:32:57 INFO - 'tests': ['damp', 'tps']}, 09:32:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:32:57 INFO - 'tests': ['dromaeo_dom']}, 09:32:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:32:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:32:57 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:32:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:32:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:32:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:32:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:32:57 INFO - 'tests': ['a11yr', 09:32:57 INFO - 'ts_paint', 09:32:57 INFO - 'tpaint', 09:32:57 INFO - 'sessionrestore', 09:32:57 INFO - 'sessionrestore_no_auto_restore', 09:32:57 INFO - 'tabpaint']}, 09:32:57 INFO - 'other-e10s': {'tests': ['a11yr', 09:32:57 INFO - 'ts_paint', 09:32:57 INFO - 'tpaint', 09:32:57 INFO - 'sessionrestore', 09:32:57 INFO - 'sessionrestore_no_auto_restore', 09:32:57 INFO - 'tabpaint']}, 09:32:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:32:57 INFO - 'ts_paint', 09:32:57 INFO - 'tpaint', 09:32:57 INFO - 'sessionrestore', 09:32:57 INFO - 'sessionrestore_no_auto_restore', 09:32:57 INFO - 'tabpaint']}, 09:32:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:32:57 INFO - 'ts_paint', 09:32:57 INFO - 'tpaint', 09:32:57 INFO - 'sessionrestore', 09:32:57 INFO - 'sessionrestore_no_auto_restore', 09:32:57 INFO - 'tabpaint']}, 09:32:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:32:57 INFO - 'tests': ['a11yr', 09:32:57 INFO - 'ts_paint', 09:32:57 INFO - 'tpaint', 09:32:57 INFO - 'sessionrestore', 09:32:57 INFO - 'sessionrestore_no_auto_restore', 09:32:57 INFO - 'tabpaint']}, 09:32:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:32:57 INFO - 'tests': ['a11yr', 09:32:57 INFO - 'ts_paint', 09:32:57 INFO - 'tpaint', 09:32:57 INFO - 'sessionrestore', 09:32:57 INFO - 'sessionrestore_no_auto_restore', 09:32:57 INFO - 'tabpaint']}, 09:32:57 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:32:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:32:57 INFO - 'bloom_basic_ref']}, 09:32:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:32:57 INFO - 'tests': ['tsvgx', 09:32:57 INFO - 'tsvgr_opacity', 09:32:57 INFO - 'tart', 09:32:57 INFO - 'tscrollx', 09:32:57 INFO - 'cart', 09:32:57 INFO - 'tsvg_static']}, 09:32:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:32:57 INFO - 'tsvgr_opacity', 09:32:57 INFO - 'tart', 09:32:57 INFO - 'tscrollx', 09:32:57 INFO - 'cart', 09:32:57 INFO - 'tsvg_static']}, 09:32:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:32:57 INFO - 'talos_options': ['--disable-e10s'], 09:32:57 INFO - 'tests': ['tp5o']}, 09:32:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:32:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:32:57 INFO - 'talos_options': ['--disable-e10s', 09:32:57 INFO - '--xperf_path', 09:32:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:32:57 INFO - 'tests': ['tp5n']}, 09:32:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:32:57 INFO - 'talos_options': ['--xperf_path', 09:32:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:32:57 INFO - 'tests': ['tp5n']}}, 09:32:57 INFO - 'talos.zip': {'path': '', 09:32:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:32:57 INFO - Running post-action listener: _resource_record_post_action 09:32:57 INFO - [mozharness: 2017-05-26 16:32:57.792462Z] Finished populate-webroot step (success) 09:32:57 INFO - [mozharness: 2017-05-26 16:32:57.792551Z] Running create-virtualenv step. 09:32:57 INFO - Running pre-action listener: _resource_record_pre_action 09:32:57 INFO - Running main action method: create_virtualenv 09:32:57 INFO - Creating virtualenv /builds/slave/test/build/venv 09:32:57 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 09:32:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:32:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:32:57 INFO - Using real prefix '/usr' 09:32:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:32:58 INFO - Installing distribute.............................................................................................................................................................................................done. 09:33:00 INFO - Installing pip.................done. 09:33:00 INFO - Return code: 0 09:33:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:33:00 INFO - Reading from file tmpfile_stdout 09:33:00 INFO - Output received: 09:33:00 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) 09:33:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:33:00 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')]} 09:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:00 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')]} 09:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:00 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 0x191b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b7a0>, '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 0x1c8c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8cb30>, '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': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', '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 09:33:00 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 09:33:00 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 09:33:00 INFO - Using env: {'DISPLAY': ':0', 09:33:00 INFO - 'HOME': '/home/cltbld', 09:33:00 INFO - 'LANG': 'en_US.UTF-8', 09:33:00 INFO - 'LANGUAGE': 'en_US:en', 09:33:00 INFO - 'LOGNAME': 'cltbld', 09:33:00 INFO - 'MAIL': '/var/mail/cltbld', 09:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:00 INFO - 'MOZ_NO_REMOTE': '1', 09:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:00 INFO - 'NO_EM_RESTART': '1', 09:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:00 INFO - 'PWD': '/builds/slave/test', 09:33:00 INFO - 'SHELL': '/bin/bash', 09:33:00 INFO - 'SHLVL': '1', 09:33:00 INFO - 'TERM': 'linux', 09:33:00 INFO - 'TMOUT': '86400', 09:33:00 INFO - 'USER': 'cltbld', 09:33:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', 09:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:00 INFO - '_': '/tools/buildbot/bin/python'} 09:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:00 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 09:33:00 INFO - Cleaning up... 09:33:00 INFO - Return code: 0 09:33:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:33:00 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')]} 09:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:00 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')]} 09:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:00 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 0x191b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b7a0>, '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 0x1c8c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8cb30>, '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': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', '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 09:33:00 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 09:33:00 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 09:33:00 INFO - Using env: {'DISPLAY': ':0', 09:33:00 INFO - 'HOME': '/home/cltbld', 09:33:00 INFO - 'LANG': 'en_US.UTF-8', 09:33:00 INFO - 'LANGUAGE': 'en_US:en', 09:33:00 INFO - 'LOGNAME': 'cltbld', 09:33:00 INFO - 'MAIL': '/var/mail/cltbld', 09:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:00 INFO - 'MOZ_NO_REMOTE': '1', 09:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:00 INFO - 'NO_EM_RESTART': '1', 09:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:00 INFO - 'PWD': '/builds/slave/test', 09:33:00 INFO - 'SHELL': '/bin/bash', 09:33:00 INFO - 'SHLVL': '1', 09:33:00 INFO - 'TERM': 'linux', 09:33:00 INFO - 'TMOUT': '86400', 09:33:00 INFO - 'USER': 'cltbld', 09:33:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', 09:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:00 INFO - '_': '/tools/buildbot/bin/python'} 09:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:01 INFO - Downloading/unpacking psutil>=3.1.1 09:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:33:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:02 INFO - Installing collected packages: psutil 09:33:02 INFO - Running setup.py install for psutil 09:33:02 INFO - building 'psutil._psutil_linux' extension 09:33:02 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 09:33:02 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 09:33:02 INFO - building 'psutil._psutil_posix' extension 09:33:02 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 09:33:02 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 09:33:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:02 INFO - Successfully installed psutil 09:33:02 INFO - Cleaning up... 09:33:02 INFO - Return code: 0 09:33:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x191b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b7a0>, '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 0x1c8c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8cb30>, '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': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', '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 09:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:33:02 INFO - Using env: {'DISPLAY': ':0', 09:33:02 INFO - 'HOME': '/home/cltbld', 09:33:02 INFO - 'LANG': 'en_US.UTF-8', 09:33:02 INFO - 'LANGUAGE': 'en_US:en', 09:33:02 INFO - 'LOGNAME': 'cltbld', 09:33:02 INFO - 'MAIL': '/var/mail/cltbld', 09:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:02 INFO - 'MOZ_NO_REMOTE': '1', 09:33:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:02 INFO - 'NO_EM_RESTART': '1', 09:33:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:02 INFO - 'PWD': '/builds/slave/test', 09:33:02 INFO - 'SHELL': '/bin/bash', 09:33:02 INFO - 'SHLVL': '1', 09:33:02 INFO - 'TERM': 'linux', 09:33:02 INFO - 'TMOUT': '86400', 09:33:02 INFO - 'USER': 'cltbld', 09:33:02 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', 09:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:02 INFO - '_': '/tools/buildbot/bin/python'} 09:33:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:33:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:33:04 INFO - Installing collected packages: mozsystemmonitor 09:33:04 INFO - Running setup.py install for mozsystemmonitor 09:33:04 INFO - Successfully installed mozsystemmonitor 09:33:04 INFO - Cleaning up... 09:33:04 INFO - Return code: 0 09:33:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x191b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b7a0>, '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 0x1c8c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8cb30>, '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': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', '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 09:33:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:33:04 INFO - Using env: {'DISPLAY': ':0', 09:33:04 INFO - 'HOME': '/home/cltbld', 09:33:04 INFO - 'LANG': 'en_US.UTF-8', 09:33:04 INFO - 'LANGUAGE': 'en_US:en', 09:33:04 INFO - 'LOGNAME': 'cltbld', 09:33:04 INFO - 'MAIL': '/var/mail/cltbld', 09:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:04 INFO - 'MOZ_NO_REMOTE': '1', 09:33:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:04 INFO - 'NO_EM_RESTART': '1', 09:33:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:04 INFO - 'PWD': '/builds/slave/test', 09:33:04 INFO - 'SHELL': '/bin/bash', 09:33:04 INFO - 'SHLVL': '1', 09:33:04 INFO - 'TERM': 'linux', 09:33:04 INFO - 'TMOUT': '86400', 09:33:04 INFO - 'USER': 'cltbld', 09:33:04 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', 09:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:04 INFO - '_': '/tools/buildbot/bin/python'} 09:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:04 INFO - Downloading/unpacking jsonschema==2.5.1 09:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:33:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:05 INFO - Downloading functools32-3.2.3-2.tar.gz 09:33:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:33:05 INFO - warning: no files found matching '*.txt' 09:33:05 INFO - no previously-included directories found matching 'build' 09:33:05 INFO - no previously-included directories found matching 'dist' 09:33:05 INFO - no previously-included directories found matching '.git*' 09:33:05 INFO - Installing collected packages: jsonschema, functools32 09:33:05 INFO - Running setup.py install for functools32 09:33:05 INFO - warning: no files found matching '*.txt' 09:33:05 INFO - no previously-included directories found matching 'build' 09:33:05 INFO - no previously-included directories found matching 'dist' 09:33:05 INFO - no previously-included directories found matching '.git*' 09:33:05 INFO - Successfully installed jsonschema functools32 09:33:05 INFO - Cleaning up... 09:33:05 INFO - Return code: 0 09:33:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x191b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b7a0>, '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 0x1c8c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8cb30>, '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': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', '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 09:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:33:05 INFO - Using env: {'DISPLAY': ':0', 09:33:05 INFO - 'HOME': '/home/cltbld', 09:33:05 INFO - 'LANG': 'en_US.UTF-8', 09:33:05 INFO - 'LANGUAGE': 'en_US:en', 09:33:05 INFO - 'LOGNAME': 'cltbld', 09:33:05 INFO - 'MAIL': '/var/mail/cltbld', 09:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:05 INFO - 'MOZ_NO_REMOTE': '1', 09:33:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:05 INFO - 'NO_EM_RESTART': '1', 09:33:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:05 INFO - 'PWD': '/builds/slave/test', 09:33:05 INFO - 'SHELL': '/bin/bash', 09:33:05 INFO - 'SHLVL': '1', 09:33:05 INFO - 'TERM': 'linux', 09:33:05 INFO - 'TMOUT': '86400', 09:33:05 INFO - 'USER': 'cltbld', 09:33:05 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', 09:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:05 INFO - '_': '/tools/buildbot/bin/python'} 09:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:33:06 INFO - Cleaning up... 09:33:06 INFO - Return code: 0 09:33:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:06 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 0x191b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b7a0>, '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 0x1c8c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8cb30>, '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': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', '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 09:33:06 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 09:33:06 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 09:33:06 INFO - Using env: {'DISPLAY': ':0', 09:33:06 INFO - 'HOME': '/home/cltbld', 09:33:06 INFO - 'LANG': 'en_US.UTF-8', 09:33:06 INFO - 'LANGUAGE': 'en_US:en', 09:33:06 INFO - 'LOGNAME': 'cltbld', 09:33:06 INFO - 'MAIL': '/var/mail/cltbld', 09:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:06 INFO - 'MOZ_NO_REMOTE': '1', 09:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:06 INFO - 'NO_EM_RESTART': '1', 09:33:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:06 INFO - 'PWD': '/builds/slave/test', 09:33:06 INFO - 'SHELL': '/bin/bash', 09:33:06 INFO - 'SHLVL': '1', 09:33:06 INFO - 'TERM': 'linux', 09:33:06 INFO - 'TMOUT': '86400', 09:33:06 INFO - 'USER': 'cltbld', 09:33:06 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', 09:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:06 INFO - '_': '/tools/buildbot/bin/python'} 09:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:06 INFO - Downloading/unpacking blobuploader==1.2.4 09:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:07 INFO - Downloading blobuploader-1.2.4.tar.gz 09:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:33:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:33:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:07 INFO - Downloading docopt-0.6.1.tar.gz 09:33:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:33:08 INFO - Installing collected packages: blobuploader, requests, docopt 09:33:08 INFO - Running setup.py install for blobuploader 09:33:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:33:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:33:08 INFO - Running setup.py install for requests 09:33:08 INFO - Running setup.py install for docopt 09:33:08 INFO - Successfully installed blobuploader requests docopt 09:33:08 INFO - Cleaning up... 09:33:08 INFO - Return code: 0 09:33:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:08 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')]} 09:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:08 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')]} 09:33:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:08 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 0x191b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b7a0>, '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 0x1c8c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8cb30>, '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': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', '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 09:33:08 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 09:33:08 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 09:33:08 INFO - Using env: {'DISPLAY': ':0', 09:33:08 INFO - 'HOME': '/home/cltbld', 09:33:08 INFO - 'LANG': 'en_US.UTF-8', 09:33:08 INFO - 'LANGUAGE': 'en_US:en', 09:33:08 INFO - 'LOGNAME': 'cltbld', 09:33:08 INFO - 'MAIL': '/var/mail/cltbld', 09:33:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:08 INFO - 'MOZ_NO_REMOTE': '1', 09:33:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:08 INFO - 'NO_EM_RESTART': '1', 09:33:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:08 INFO - 'PWD': '/builds/slave/test', 09:33:08 INFO - 'SHELL': '/bin/bash', 09:33:08 INFO - 'SHLVL': '1', 09:33:08 INFO - 'TERM': 'linux', 09:33:08 INFO - 'TMOUT': '86400', 09:33:08 INFO - 'USER': 'cltbld', 09:33:08 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', 09:33:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:08 INFO - '_': '/tools/buildbot/bin/python'} 09:33:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:08 INFO - Running setup.py (path:/tmp/pip-nceORb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:08 INFO - Running setup.py (path:/tmp/pip-r1dyz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:09 INFO - Running setup.py (path:/tmp/pip-kMmHG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:09 INFO - Running setup.py (path:/tmp/pip-TluvbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:09 INFO - Running setup.py (path:/tmp/pip-pXieiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:09 INFO - Running setup.py (path:/tmp/pip-Wsz5IW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:09 INFO - Running setup.py (path:/tmp/pip-cN3xsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:09 INFO - Running setup.py (path:/tmp/pip-0S86Rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:09 INFO - Running setup.py (path:/tmp/pip-atMKcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:09 INFO - Running setup.py (path:/tmp/pip-CszpXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:09 INFO - Running setup.py (path:/tmp/pip-1fcCJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:09 INFO - Running setup.py (path:/tmp/pip-TTplGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:09 INFO - Running setup.py (path:/tmp/pip-8Y7D5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:09 INFO - Running setup.py (path:/tmp/pip-7zy1xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:09 INFO - Running setup.py (path:/tmp/pip-XpSrHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:09 INFO - Running setup.py (path:/tmp/pip-rZGRVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:10 INFO - Running setup.py (path:/tmp/pip-88O6YQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:33:10 INFO - Running setup.py install for manifestparser 09:33:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:33:10 INFO - Running setup.py install for mozcrash 09:33:10 INFO - Running setup.py install for mozdebug 09:33:10 INFO - Running setup.py install for mozdevice 09:33:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:33:10 INFO - Running setup.py install for mozfile 09:33:10 INFO - Running setup.py install for mozhttpd 09:33:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:33:10 INFO - Running setup.py install for mozinfo 09:33:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:33:10 INFO - Running setup.py install for mozInstall 09:33:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:33:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:33:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:33:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:33:10 INFO - Running setup.py install for mozleak 09:33:10 INFO - Running setup.py install for mozlog 09:33:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:33:11 INFO - Running setup.py install for moznetwork 09:33:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:33:11 INFO - Running setup.py install for mozprocess 09:33:11 INFO - Running setup.py install for mozprofile 09:33:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:33:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:33:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:33:11 INFO - Running setup.py install for mozrunner 09:33:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:33:11 INFO - Running setup.py install for mozscreenshot 09:33:11 INFO - Running setup.py install for moztest 09:33:11 INFO - Running setup.py install for mozversion 09:33:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:33:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:33:11 INFO - Cleaning up... 09:33:11 INFO - Return code: 0 09:33:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:11 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')]} 09:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:11 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')]} 09:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:11 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 0x191b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b7a0>, '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 0x1c8c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8cb30>, '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': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', '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 09:33:11 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 09:33:11 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 09:33:11 INFO - Using env: {'DISPLAY': ':0', 09:33:11 INFO - 'HOME': '/home/cltbld', 09:33:11 INFO - 'LANG': 'en_US.UTF-8', 09:33:11 INFO - 'LANGUAGE': 'en_US:en', 09:33:11 INFO - 'LOGNAME': 'cltbld', 09:33:11 INFO - 'MAIL': '/var/mail/cltbld', 09:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:11 INFO - 'MOZ_NO_REMOTE': '1', 09:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:11 INFO - 'NO_EM_RESTART': '1', 09:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:11 INFO - 'PWD': '/builds/slave/test', 09:33:11 INFO - 'SHELL': '/bin/bash', 09:33:11 INFO - 'SHLVL': '1', 09:33:11 INFO - 'TERM': 'linux', 09:33:11 INFO - 'TMOUT': '86400', 09:33:11 INFO - 'USER': 'cltbld', 09:33:11 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', 09:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:11 INFO - '_': '/tools/buildbot/bin/python'} 09:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:12 INFO - Running setup.py (path:/tmp/pip-oZYzk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:12 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)) 09:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:12 INFO - Running setup.py (path:/tmp/pip-5UJ7Dk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:12 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)) 09:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:12 INFO - Running setup.py (path:/tmp/pip-mXGQng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:12 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)) 09:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:12 INFO - Running setup.py (path:/tmp/pip-AafWNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:12 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)) 09:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:12 INFO - Running setup.py (path:/tmp/pip-6tImID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:12 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)) 09:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:12 INFO - Running setup.py (path:/tmp/pip-izQCDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:12 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)) 09:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:12 INFO - Running setup.py (path:/tmp/pip-M3rG0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 09:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:12 INFO - Running setup.py (path:/tmp/pip-G4g68L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 09:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:12 INFO - Running setup.py (path:/tmp/pip-VjTXCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:12 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)) 09:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:12 INFO - Running setup.py (path:/tmp/pip-P5mbtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:12 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)) 09:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:12 INFO - Running setup.py (path:/tmp/pip-8GOz65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:12 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)) 09:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:12 INFO - Running setup.py (path:/tmp/pip-L5l98w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:12 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)) 09:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:12 INFO - Running setup.py (path:/tmp/pip-pb4dm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:13 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)) 09:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:13 INFO - Running setup.py (path:/tmp/pip-NQiqXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:13 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)) 09:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:13 INFO - Running setup.py (path:/tmp/pip-t9PsHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:13 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)) 09:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:13 INFO - Running setup.py (path:/tmp/pip-xTM0mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:13 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)) 09:33:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:13 INFO - Running setup.py (path:/tmp/pip-QvS8g6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:13 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)) 09:33:13 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)) 09:33:13 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)) 09:33:13 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)) 09:33:13 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)) 09:33:13 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)) 09:33:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:14 INFO - Downloading blessings-1.6.tar.gz 09:33:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:33:14 INFO - Installing collected packages: blessings 09:33:14 INFO - Running setup.py install for blessings 09:33:14 INFO - Successfully installed blessings 09:33:14 INFO - Cleaning up... 09:33:14 INFO - Return code: 0 09:33:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:33:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:14 INFO - Reading from file tmpfile_stdout 09:33:14 INFO - Current package versions: 09:33:14 INFO - argparse == 1.2.1 09:33:14 INFO - blessings == 1.6 09:33:14 INFO - blobuploader == 1.2.4 09:33:14 INFO - docopt == 0.6.1 09:33:14 INFO - functools32 == 3.2.3-2 09:33:14 INFO - jsonschema == 2.5.1 09:33:14 INFO - manifestparser == 1.1 09:33:14 INFO - mozInstall == 1.12 09:33:14 INFO - mozcrash == 1.0 09:33:14 INFO - mozdebug == 0.1 09:33:14 INFO - mozdevice == 0.51 09:33:14 INFO - mozfile == 1.2 09:33:14 INFO - mozhttpd == 0.7 09:33:14 INFO - mozinfo == 0.9 09:33:14 INFO - mozleak == 0.1 09:33:14 INFO - mozlog == 3.4 09:33:14 INFO - moznetwork == 0.27 09:33:14 INFO - mozprocess == 0.25 09:33:14 INFO - mozprofile == 0.28 09:33:14 INFO - mozrunner == 6.13 09:33:14 INFO - mozscreenshot == 0.1 09:33:14 INFO - mozsystemmonitor == 0.3 09:33:14 INFO - moztest == 0.8 09:33:14 INFO - mozversion == 1.4 09:33:14 INFO - psutil == 3.1.1 09:33:14 INFO - requests == 1.2.3 09:33:14 INFO - wsgiref == 0.1.2 09:33:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:14 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 0x191b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b7a0>, '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 0x1c8c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8cb30>, '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': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', '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 09:33:14 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 09:33:14 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 09:33:14 INFO - Using env: {'DISPLAY': ':0', 09:33:14 INFO - 'HOME': '/home/cltbld', 09:33:14 INFO - 'LANG': 'en_US.UTF-8', 09:33:14 INFO - 'LANGUAGE': 'en_US:en', 09:33:14 INFO - 'LOGNAME': 'cltbld', 09:33:14 INFO - 'MAIL': '/var/mail/cltbld', 09:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:14 INFO - 'MOZ_NO_REMOTE': '1', 09:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:14 INFO - 'NO_EM_RESTART': '1', 09:33:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:14 INFO - 'PWD': '/builds/slave/test', 09:33:14 INFO - 'SHELL': '/bin/bash', 09:33:14 INFO - 'SHLVL': '1', 09:33:14 INFO - 'TERM': 'linux', 09:33:14 INFO - 'TMOUT': '86400', 09:33:14 INFO - 'USER': 'cltbld', 09:33:14 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', 09:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:14 INFO - '_': '/tools/buildbot/bin/python'} 09:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:15 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)) 09:33:15 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)) 09:33:15 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)) 09:33:15 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)) 09:33:15 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)) 09:33:15 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)) 09:33:15 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)) 09:33:15 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)) 09:33:15 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)) 09:33:15 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:16 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:33:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:33:16 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)) 09:33:16 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)) 09:33:16 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)) 09:33:16 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)) 09:33:16 INFO - Installing collected packages: marionette-driver 09:33:16 INFO - Running setup.py install for marionette-driver 09:33:16 INFO - Successfully installed marionette-driver 09:33:16 INFO - Cleaning up... 09:33:16 INFO - Return code: 0 09:33:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:16 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 0x191b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c8e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c8b7a0>, '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 0x1c8c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8cb30>, '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': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', '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 09:33:16 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 09:33:16 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 09:33:16 INFO - Using env: {'DISPLAY': ':0', 09:33:16 INFO - 'HOME': '/home/cltbld', 09:33:16 INFO - 'LANG': 'en_US.UTF-8', 09:33:16 INFO - 'LANGUAGE': 'en_US:en', 09:33:16 INFO - 'LOGNAME': 'cltbld', 09:33:16 INFO - 'MAIL': '/var/mail/cltbld', 09:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:16 INFO - 'MOZ_NO_REMOTE': '1', 09:33:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:16 INFO - 'NO_EM_RESTART': '1', 09:33:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:16 INFO - 'PWD': '/builds/slave/test', 09:33:16 INFO - 'SHELL': '/bin/bash', 09:33:16 INFO - 'SHLVL': '1', 09:33:16 INFO - 'TERM': 'linux', 09:33:16 INFO - 'TMOUT': '86400', 09:33:16 INFO - 'USER': 'cltbld', 09:33:16 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', 09:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:16 INFO - '_': '/tools/buildbot/bin/python'} 09:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:33:16 INFO - Cleaning up... 09:33:16 INFO - Return code: 0 09:33:16 INFO - Running post-action listener: _resource_record_post_action 09:33:16 INFO - Running post-action listener: _start_resource_monitoring 09:33:16 INFO - Starting resource monitoring. 09:33:16 INFO - [mozharness: 2017-05-26 16:33:16.734432Z] Finished create-virtualenv step (success) 09:33:16 INFO - [mozharness: 2017-05-26 16:33:16.734884Z] Running install step. 09:33:16 INFO - Running pre-action listener: _resource_record_pre_action 09:33:16 INFO - Running main action method: install 09:33:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:16 INFO - Reading from file tmpfile_stdout 09:33:16 INFO - Detecting whether we're running mozinstall >=1.0... 09:33:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:33:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:33:17 INFO - Reading from file tmpfile_stdout 09:33:17 INFO - Output received: 09:33:17 INFO - Usage: mozinstall [options] installer 09:33:17 INFO - Options: 09:33:17 INFO - -h, --help show this help message and exit 09:33:17 INFO - -d DEST, --destination=DEST 09:33:17 INFO - Directory to install application into. [default: 09:33:17 INFO - "/builds/slave/test"] 09:33:17 INFO - --app=APP Application being installed. [default: firefox] 09:33:17 INFO - mkdir: /builds/slave/test/build/application 09:33:17 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'] 09:33:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:33:33 INFO - Reading from file tmpfile_stdout 09:33:33 INFO - Output received: 09:33:33 INFO - /builds/slave/test/build/application/firefox/firefox 09:33:33 INFO - Running post-action listener: _resource_record_post_action 09:33:33 INFO - [mozharness: 2017-05-26 16:33:33.067692Z] Finished install step (success) 09:33:33 INFO - [mozharness: 2017-05-26 16:33:33.067974Z] Running run-tests step. 09:33:33 INFO - Running pre-action listener: _resource_record_pre_action 09:33:33 INFO - Running main action method: run_tests 09:33:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:33:33 INFO - Python 2.7.3 09:33:33 INFO - Return code: 0 09:33:33 INFO - grabbing minidump binary from tooltool 09:33: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')]} 09:33:33 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 0x1c8b7a0>, '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 0x1c8c6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c8cb30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:33:33 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 09:33:33 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 09:33:33 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 09:33:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:33:33 INFO - Return code: 0 09:33:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:33:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:33:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:33:33 INFO - ENV: RUST_BACKTRACE is now 1 09:33:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:33:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:33:33 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/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 09:33:33 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/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 09:33:33 INFO - Using env: {'DISPLAY': ':0', 09:33:33 INFO - 'HOME': '/home/cltbld', 09:33:33 INFO - 'LANG': 'en_US.UTF-8', 09:33:33 INFO - 'LANGUAGE': 'en_US:en', 09:33:33 INFO - 'LOGNAME': 'cltbld', 09:33:33 INFO - 'MAIL': '/var/mail/cltbld', 09:33:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:33:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:33 INFO - 'MOZ_NO_REMOTE': '1', 09:33:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:33:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:33 INFO - 'NO_EM_RESTART': '1', 09:33:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:33 INFO - 'PWD': '/builds/slave/test', 09:33:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:33:33 INFO - 'RUST_BACKTRACE': '1', 09:33:33 INFO - 'SHELL': '/bin/bash', 09:33:33 INFO - 'SHLVL': '1', 09:33:33 INFO - 'TERM': 'linux', 09:33:33 INFO - 'TMOUT': '86400', 09:33:33 INFO - 'USER': 'cltbld', 09:33:33 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081', 09:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:33 INFO - '_': '/tools/buildbot/bin/python'} 09:33:33 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/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 09:33:33 INFO - mozversion application_buildid: 20170526155511 09:33:33 INFO - mozversion application_changeset: 1bfa4578aa56f768626ba278a6929e23fc48db54 09:33:33 INFO - mozversion application_display_name: Nightly 09:33:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:33:33 INFO - mozversion application_name: Firefox 09:33:33 INFO - mozversion application_remotingname: firefox 09:33:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:33:33 INFO - mozversion application_vendor: Mozilla 09:33:33 INFO - mozversion application_version: 55.0a1 09:33:33 INFO - mozversion platform_buildid: 20170526155511 09:33:33 INFO - mozversion platform_changeset: 1bfa4578aa56f768626ba278a6929e23fc48db54 09:33:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:33:33 INFO - mozversion platform_version: 55.0a1 09:33:33 INFO - using testdate: 1495816413 09:33:33 INFO - actual date: 1495816413 09:33:33 INFO - starting webserver on 'localhost:38603' 09:33:33 INFO - SUITE-START | Running 2 tests 09:33:33 INFO - TEST-START | dromaeo_css 09:33:33 INFO - operating with platform_type : linux_ 09:33:33 INFO - Initialising browser for dromaeo_css test... 09:33:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38603/getInfo.html -profile /tmp/tmpn4QdGT/profile 09:33:33 INFO - TEST-INFO | started process 5889 (/builds/slave/test/build/application/firefox/firefox http://localhost:38603/getInfo.html) 09:34:07 INFO - TEST-INFO | 5889: killed by SIGTERM 09:34:07 INFO - Browser initialized. 09:34:07 INFO - Running cycle 1/1 for dromaeo_css test... 09:34:07 INFO - TEST-INFO | started process 6108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpn4QdGT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:19 INFO - PID 6108 | RSS: Main: 173400064 09:34:19 INFO - PID 6108 | 09:37:24 INFO - PID 6108 | Cycle 1(1): loaded http://localhost:38603/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38603/tests/dromaeo/cssquery-ext.html) 09:37:25 INFO - PID 6108 | RSS: Main: 171917312 09:37:25 INFO - PID 6108 | 09:40:27 INFO - PID 6108 | Cycle 1(1): loaded http://localhost:38603/tests/dromaeo/cssquery-ext.html (next: http://localhost:38603/tests/dromaeo/cssquery-jquery.html) 09:40:28 INFO - PID 6108 | RSS: Main: 177135616 09:40:28 INFO - PID 6108 | 09:43:30 INFO - PID 6108 | Cycle 1(1): loaded http://localhost:38603/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38603/tests/dromaeo/cssquery-mootools.html) 09:43:30 INFO - PID 6108 | RSS: Main: 176648192 09:43:30 INFO - PID 6108 | 09:46:32 INFO - PID 6108 | Cycle 1(1): loaded http://localhost:38603/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38603/tests/dromaeo/cssquery-prototype.html) 09:46:33 INFO - PID 6108 | RSS: Main: 180690944 09:46:33 INFO - PID 6108 | 09:49:36 INFO - PID 6108 | Cycle 1(1): loaded http://localhost:38603/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38603/tests/dromaeo/cssquery-yui.html) 09:49:36 INFO - PID 6108 | RSS: Main: 176865280 09:49:36 INFO - PID 6108 | 09:52:38 INFO - PID 6108 | Cycle 1(1): loaded http://localhost:38603/tests/dromaeo/cssquery-yui.html (next: http://localhost:38603/tests/dromaeo/cssquery-dojo.html) 09:52:38 INFO - PID 6108 | RSS: Main: 175255552 09:52:38 INFO - PID 6108 | 09:52:38 INFO - PID 6108 | __start_tp_report 09:52:38 INFO - PID 6108 | _x_x_mozilla_page_load 09:52:38 INFO - PID 6108 | _x_x_mozilla_page_load_details 09:52:38 INFO - PID 6108 | |i|pagename|runs| 09:52:38 INFO - PID 6108 | |0;dojo.html;2718.22530578785;2718.8912443502263;2729.849858257795;2732.439849830785;2768.197222805385;5242.475752424765;5321.547668448177;5331.253624492574;5331.360236771588;5396.622236443451;5260.921086183701;5312.362516498016;5344.412114667383;5354.544863686581;5411.080116380215;4461.888452788674;4662.254814284858;4718.504557021523;4742.715437073769;4746.074515469485;4800.231962885939;4831.975840120795;4839.830605928793;4860.368152140217;4884.5848102911295;4680.485146633868;4729.905401891943;4736.668433209677;4764.6426518011285;4775.403074615673;4692.202325604655;4694.201985662446;4738.928916066227;4756.3816703828625;4773.976130119362;4629.699069560468;4680.180968330563;4680.625549956029;4682.157211701892;4686.53134686532;5232.633715639907;5315.840524784263;5319.0957537218765;5320.574354051667;5368.355797304349;5777.046787280094;5849.298084229919;5850.590458667895;5860.560457965669;5862.50168735658;5854.531637468992;5857.736401861926;5865.413458654143;5867.207926929896;5881.529477641779;5434.8913021739345;5442.210879422461;5445.727713614304;5457.645253058538;5461.726913654302;5864.325602555676;5935.317438494542;5942.049272116441;5943.58394912352;5978.611390259619;5649;5679.346875109415;5704.22992895962;5713.714314284269;5720.399358067426;5613.158026296088;5735.369109397963;5748.396418376094;5770.624909380961;5781.479666829921;5600.383957764642;5675.943240567542;5715.5427565794635;5746.683932383676;5747.310322761212;5727.513161381329;5747.3677895431465;5758.539316854642;5787.421257874179;5813.82558523245;4844.685095468783;4845.63657725672;4847.2729090636685;4857.975710121426;4897.216445368724;4052.452918855976;4137.317342638491;4148.357004664282;4165.562615925345;4185.937210941838;4818.590419814355;4846.224604063333;4863.294822250754;4891.192953162759;4900.509949005071;5721.742521586539;5755.712214389264;5778.133280007948;5794.82615521535;5797.391273916178;4859.586935110485;4865;4866.7079975201605;4876.049170411807;4884.4871288514905;5017.874553136127;5059.342285502935;5091.821786237538;5147.2279158126585;5165.1735722285;5409.729513524387;5411.269478620336;5419.674819510842;5424.267723857387;5457.754401052041;5650.943490565041;5706.144078388275;5759.424057594207;5814.360420353673;5818.912716309174;5375.5162035417;5383.67697938125;5398.892022159456;5413.188021796762;5429.104197807317;5669.5180909621495;5713.742881570256;5730.312362516524;5740.483356497768;5745.8563535911935;5712.514436272963;5838.12428135766;5844.386339434468;5850.882982340415;5858.326292476419;5607.186957891165;5619.129034999582;5652.802151924828;5654.886902261849;5684.9431505684415;5586.441355864381;5616.6068375213345;5639.210510528447;5644.435556444323;5645.379008309001;5406.939968821497;5490.176473529003;5500.7524661391135;5519.420460851713;5524.088525393426;5508.338999320107;5616.466435688603;5621.690807005654;5649.802256920988;5657.32112146545;5426.375966763872;5453.754581043783;5499.312585926759;5546.251256080377;5546.278983732089 09:52:38 INFO - PID 6108 | |1;ext.html;674.7503423733219;738.9556626602405;751.9323260906517;1147.713071732067;1192.183354402234;33718.49422258668;35217.47173792395;35319.4702079469;35346.823265883664;35361.29277414457;33427.33145337092;33486.66513334866;33751.662483375156;33841.153971150736;33938.32123357531;5388.865278368053;5401.4328495508;5477.917831232535;6280.309165991737;6416.550841441101;6709.36261055199;6808.387245147936;6818.897716534256;6823.488238382116;6834.521583489158;6780.186377634691;6822;6822.7953161404985;6839.9316006840045;6856.965715171442;6794.422474089708;6811.21671007833;6815.114035175396;6818.727250909958;6829.93170068298;6688.297728738461;6700.83247918801;6718.126643536358;6720;6725;31529.36941261162;31689.683103168903;31799.841000794848;31809;31842.36315273705;3033.848307584612;3063.816171029723;3065.73941214997;3067.7852550321486;3067.907962761121;24559;24560.508789824104;24689.38276543083;24767.25698229038;24837.379065523324;2741.684706258766;2745.011795753527;2745.6156138140677;2752.8073034887566;2755.9862200688867;148610;148986;152195;156790;157167.2141639296;38734;38787.22425551473;38962.61037389647;39032.414513782314;39164.80417597894;40317.59682403197;40607.18785624271;42750.57249427528;43371;43518;12967.870321296856;13006.154599950973;13100.606981790372;13153.53962611304;13168.341582920815;10304.845427318596;10325.690229293134;10327.122194613543;10382.688519344432;10418.374897506174;12795.424205910756;12821;12871.22772633645;12937.223766574036;12974.599699055705;5336.653117547347;5393.271908292409;5398;5440.809571664972;5452.6183167177915;834.837206744679;892.7054072156172;909.8953620333614;913.2876356441986;920.2453987730131;20713.482162945744;21279.255226067013;21406.57186856254;21490.677639835416;21519.569608608053;939.248601119102;997.3567049253336;1001.9749506262256;1002.8044531316323;1003.6186249225248;10526.894731052591;11205.60780372683;11327.207095503236;11417.086633069335;11527.48126334317;177894;178418;178692;178785;178949;40299.79850100731;40346.79826600848;40374.798126009184;40377.39433908435;40489;1222.5109956017664;1245.7134858982486;1251.612000279898;1254.7239607286383;1254.7615952968906;19309.613807724047;19853.503662407977;20291.492712682302;20594;20681.379558612665;28725.28186795263;29101.85449072826;29126.417471650024;29173.41653166967;29183;159842;160982;161623;162332.18833905755;162404;27562.310942226606;27721.44557108887;27783.305417363918;27799.861000694866;27825.44349113047;33094.66905330916;33682;34485.827570861984;34523.65476345205;34745.30509389748;26219.868900655376;26459.206223813315;26471.470570588866;26630.93476260928;27564.86217568899;26636.467270654866;26641.067562635213;26868.86565567238;26882.596761048208;26903.192904212905;28663.140105796858;28889.988850390135;28970.27574310659;28994;29051.12846614605;25434.364140896625;25530.617040744033;25927.481450371266;26190.476190476464;26784.33039174036;20780.480487987923;21123.471913202295;21359.359219223446;21449;21533.35399937942 09:52:38 INFO - PID 6108 | |2;jquery.html;405.5863019719886;408.5097882540948;428.9120730250297;429.1824075136864;431.94816622005357;16842.242099105555;17263.91368043158;17297.394591189295;17454.476365709033;18389;18314.267429302847;18698.71951920722;18953.715694264596;19121.71317430236;19226.13482393292;5175.223716442526;5229.241759944815;5351.812686555972;5389.083855744513;5397.217403476494;5155.278261043457;5287.894242115155;5288.233206185101;5291.629585928987;5305.495977882095;5232.398274198459;5260.395054568716;5262.7631756571045;5271.15661494161;5276.2085687146855;4984.202527595586;5181.740912954356;5187.870303242411;5222.556082732972;5230.712310822903;4699.765011749433;4707.8587642370785;4712.269598212282;4717.386739723848;4737.644676649231;20958.476038099016;21169.47076323089;21257.574848503096;21286.467838304012;21483.570328593498;1557.166915700095;1561.4378823623485;1597.18543542794;1598.5603958911277;1602.407109369529;14241.857581424158;14642.853571464362;14701.92649036748;14726.70546589073;15007.699846003019;1985.463924740312;2001.259533972425;2049.1291201239565;2054.4863784053987;2092.5396412789164;80594;81100.59449702773;81660.59169704113;81763.5911820443;83099;10586.629467968583;10809.83785243222;10994.505247263893;11060.557577696802;11105.83341249882;15209.163496007826;15287.159206243763;15292.617684557752;15295.082295062331;15308.234588270541;7862.567558784207;7868.055833299926;8025.919740802634;8055.824927269605;8077.636506357228;7299.854002919912;7325.963370183115;7445.516041457288;7573.015507984037;7616.809579760439;6594.373534514213;6643;6705.664716764142;6739.123913891261;6768.357006084414;2003.6493613617558;2017.4768050122357;2030.421329920995;2063.9896800516203;2074.4399012266904;858.3176374782063;891.8974317953518;892.5403417240127;893.4282059481936;926.1109335038439;16857.57856053584;16879.071651059065;16973.199422095215;16990.660186796442;17896.28414863391;904.1952662130709;906.1934877958622;907.3920473282916;908.6002159049997;914.7438717159206;9186.908130918606;9516.048395160567;9581.425114493153;9683.080107389787;9736.659216927374;382520;385666;387534;389595;395609;81632;84404.15595843963;84559.57720211359;85678;87191.56404217938;1041.146260066738;1073.0825144501496;1104.5857803323754;1116.5924437580225;1118.2228351295935;16917.830821691627;17099.658006840044;17406.39077632277;17788.199531021393;17987.280508779502;40242.59757402389;40249.798751006056;40577.18845623012;40594.18811623692;42183.156336873704;48489;48900.266496001874;51135;51288.48711512837;53121.734391327795;8348.666053357798;8555.443896146731;8575.656973720981;8610.354223433142;8633.784155396166;12214.75570488603;13121.803172952223;13549.119307244997;13726;13824.86175138276;10357.4303413313;10375.740606484898;10548.367097974146;10636.09593184557;10860.891391086305;10536.473176341306;10559.208059395422;10610.204234682275;11150.888491114985;11210.943945280222;10922.56309747633;11079.501422436171;11525.769484610093;11555.711107222387;12049.156559041134;7646.9617651911385;7803.892948903877;7954.363650908029;8186.7953301167945;8794.340424468062;10428.687139385831;10536.157107431234;10587.682369528926;10591.152707783513;10980.450977451255 09:52:38 INFO - PID 6108 | |3;mootools.html;1222.7676741419132;1279.2899940533;1286.8906142977846;1290.238759132112;1299.9740005199899;10238.846417303746;10729.302595331297;10736.78526429472;10795.29830561015;11012.17408694347;10759.946200269007;10905;10963.780724385508;10965.671029869116;10969.616063437781;2190.5180860210767;2233.1848875160613;2242.585121752473;2254.8534345267585;2256.0750092462094;2146.2809958663865;2189.638709612912;2189.9343019709436;2191.1345018717598;2196.923107691231;2120.5228823514663;2155.3749412670386;2156.1914282144194;2159.298228075874;2159.406163305096;2111.8521703480765;2119.162930642395;2129.4037669452578;2131.9040643171093;2137.1130980643015;1890.253349926785;1952.2288695965015;2063.607914496241;2087.9478013049643;2140.7431108267106;10499.107575855985;10558.366498010144;10597.205209609234;10613.57545698171;10624.362538247653;5642.069058605325;5803.941960580424;5833.79581714638;5835.416458354131;5876;3133.263683034485;3235.1750303672648;3316;3320.8505617247283;3327.88352407667;966.6375109334;984.9064338887795;1017.4099022566968;1036.264252380803;1047.1047254597363;15570.922145389313;15688.843111568853;15779.526614201592;15783.684326313525;15855.682886342209;4726.456457507362;4765.544216157903;4896.730679812645;4921.163402221631;4929.06347793918;11373.488193031333;11397.088232941345;11475.598354057567;11483.483243254073;11490.080793536497;5534.280543529396;5610.747516361692;5633.352164501135;5666.688332141772;5687.8862422752145;5124.103281925648;5152;5169.715665638426;5173.275741396207;5178.275041494194;3924.3328634132267;4020.4572382728543;4038.9798051009557;4071.5521292657786;4117.855875044359;1135;1142.3203194099497;1149.2300158893395;1158.3744777820052;1164.6622479481025;689.4587748617312;721.5959062924779;722.4040166862254;726.3680597879878;732.5201992694793;5674.375818659944;5710.400407957105;5774.971125144348;5836.270466191726;5855.619384739978;529.4996228564047;551.7406818795159;554.6588847858538;563.4309347558994;571.3286887906693;3482.2861313430685;3701.5002974598624;3703.666669999659;3712.2204337088974;3838.1939792643857;13344.933275333755;13837.446502140003;13939.512117075854;14188.503402381073;14207.502737404142;13652.65868353299;13862.792058119136;14095.083819551697;14163.575092747235;14164.291785410689;7570.432217583593;7783.610819459118;7799.610019499002;7803.609819509002;7819.726309579251;5693.5160511357;5911.822645320647;5929.673867937305;6009.128676341818;6105.877882442415;12308.569200077955;12486.625401237978;12565.434555444845;12778.87221127814;12796.61610151697;12370.381480926098;12769.170003949714;12812.974962003203;12983.35083245853;13023.544175954175;8512.574371281287;8783.604737786687;8803.075677054074;8821.161989610977;8839.60221790034;9672;9712.854307185256;9813.411195328303;9829.066238707312;9845.212383009486;8366.748997530083;8511.574421279036;8569.143085691381;8579.742607721779;8803.691870784492;8347.12355202695;8371.748847534584;8517.44636598619;8579.227869491775;8581.227689507974;7411.1477180124975;7581.128170260491;7586.886196707164;7592.050993625797;7615.1242607098675;5401.081816091352;5449.891002180014;5506.724663766876;5550.7779688812;5605.859853503695;5562.527185189304;5570.777168913198;5606.607537472338;5614.803481878114;5706.857328566819 09:52:38 INFO - PID 6108 | |4;prototype.html;371.1019333213624;379.81958569679404;392.20186919618584;392.8546437818007;394.81838354356995;5446.836594902149;5580.637258578189;5611.494965453108;5616.606837521375;5634.239377684012;5364.892702145965;5420.159875219348;5426.945730542703;5431.321084864392;5437.34751829781;4134.173165366924;4155.6883233757435;4160.084781348099;4162.604552567509;4171.416001759756;4092.4270602115726;4118.691098167635;4142.544320124784;4149.336106223005;4167.083141754796;4084;4103.589641035903;4108.239975604508;4112.383142528614;4135.0902801383645;4052.2705912935658;4074.3073677474754;4089.3661482469965;4094.160697057111;4102.261592913274;3608.025833025095;3609.6463826065224;3614.5301110855685;3628.7459877808565;3629.620744117245;5155.458676838953;5322.414534401213;5349;5351.411344752074;5373.301470808769;4863.929935414203;4889.853304400874;4893.730844803535;4905.2887331337115;4909.558139767402;5688.943110568883;5793.275840519935;5844.094165404369;5852.502537284336;5855.443732845373;4052.3516237401873;4086.223617512663;4103.630673239393;4116.711830171889;4116.91766164675;6009.429104235091;6067.484263837579;6106.786262480836;6196.473299769525;6274.968625156845;4582.335561343653;4628.67599268048;4640.257558790578;4647.907041859144;4657.534246575316;4676.415448068991;4681.6020638245445;4684.180268453075;4694.718316900997;4697.248440249544;5040.36995375578;5109.156989096832;5149.098907691214;5161.896762064737;5165.302684137669;5893.14549390336;5897.882042359129;5901.380355062743;5949.434803693643;5955.910661340084;1596.4811436283255;1599.2083918460205;1620.66776310856;1626.5852207686964;1630.2989714422674;1176.2942234659306;1178.7288923547633;1179.1451197881638;1187.619961612293;1202.9338386388833;5049.697018178921;5057.393112826484;5068.695878247243;5078.7460626968505;5112.667676601009;5910.704464776744;5960.225170727865;6023.578349515492;6060.757569697251;6103.481204097701;5000.67495612784;5010.019038671984;5046.21783623539;5048.116579598555;5051.848444546669;3201.3757317322898;3218.4850423932526;3221.6134063912014;3240.8333000119937;3242.4325742994884;5368.731563421813;5574.777008919679;5588.30146231721;5638.802641907513;5639.830805075854;6196.628202307786;6210.782622608187;6224.533160013018;6238.282597501255;6254.124422580842;5476.342838859362;5605.383407825218;5636.3799982002765;5639.6444115751065;5642.492175704207;6037.335893051849;6058.182145410313;6063.242094738158;6067.787627433018;6073.787417440369;5761.510271626791;5934.219734079673;6008.218931538872;6009.699515024144;6012.6392416455155;5562.972185139049;5577.191307260344;5605.523530499953;5608.186812912187;5634.32388113429;4184.832606695698;4197.391378250076;4212.262854000476;4229.788510574397;4233.301505251599;5936.257967754031;6049.213602231682;6070.150178974859;6115.724792384264;6157.661328626789;5794.681292528951;5835.649861008353;5853.795117170878;5872.735726892385;5873.882522349614;5765.221695071112;5857.560682948882;5868.23712917318;5894.528437724886;5909.8227053188475;5727.6849773262875;5757.3954734753925;5773.8556536086935;5820.30156381237;5826.73779679907;5905.675187864708;5910.881782364243;5918.194950540126;5937.821865344046;5945.881082378415;5592.2170896075395;5674.57440691958;5688.345840228427;5706.543476521785;5712.371639119777 09:52:38 INFO - PID 6108 | |5;yui.html;652.7421668440966;660.3363619562339;663.5421559124203;711.950163488556;715.4920006795176;13342.199468031913;13696.041277110606;13706.314684265797;15725.292361843716;16792.83207167928;15560.610984725388;15564.37742490302;15754.291056902439;15774.369025239006;15818;891.6700820696335;903.9864402033942;910.7632015675939;912.2200518556638;913.0139449394638;864.7449002544264;890.679355432044;901.2159421303443;901.9594118264661;901.9954900225523;938.6902322233681;942.8774259346276;942.9768700959468;943.8961714211465;944.1502647617131;923.8568021956607;928.4986107502008;929.9953500232523;934.7195841247633;935.2658163341778;683.3917813146304;684.0628339175312;684.4968947823346;685.1025157044288;690.3752104345525;14104.506342277971;14311.212883291415;14399.78400323996;14453.421863125463;14460.783088253685;15970.281337339848;16448.83551164497;16452.83547164525;16474;16480.09359485228;12855.857656937207;13077.542286019943;13202.141860779115;13242.139260948008;13255.801162982563;2951.099914526069;2960.407918416325;2966.7774916881103;2971.0938163860014;2977.1961570376093;83377.16622833755;84898;85446;85544;86109.99999999937;11772.352520611277;11798.233114847508;11842.585509507126;11950.103742219368;11968.640940771791;17664;18542.165602547648;22061.227857024925;22744.65883011756;22844.543109138056;6223.937760622426;6254.937450625435;6361.236651601837;6362.1093046973465;6381.968090159519;2902.230908809125;2985.1939976206736;2991.536311871663;3004.3390454100063;3006.9325389486853;3524.7356448266482;3622.619624939396;3625.9818700906326;3633.7274704397278;3642.6721595056574;723.1214074899023;735.2684079340983;739.1758189618537;745.8806590945422;746.1344839985591;574.6839238418853;585.0785013603592;599.0893841361107;599.95800293979;612.6109920200615;10115.039071288216;10617.309874858109;11153.776924461628;11189.832152517718;11473.71315717097;588.3146134752965;594.9494292985145;602.8492876780805;609.58852774378;624.0857144283647;4513.684042117086;4590.150822097922;4696.1546921554445;4701.435827700698;4892.412910450697;73082.26917730861;73779.63110184415;73924.63037684777;74073;76129.619351904;67464.32535674679;68222.65888670624;68526.65736671384;69289.65355173191;70384;59024;59859.700701496215;60763;61903;63972.68013659902;9745.805083898424;9773.41359518431;9999.650012249536;10013.349132306377;10285.125764310118;27298.181054568395;27559.31101722473;27676;28107.718922811328;28721.13836584906;34558.82720586381;34614.480782787774;35392.82303588569;35416.46875296924;35901.820490898426;12685.112042157329;12894.613161605166;13009.609711708665;13187.142835716031;13220.933895330847;14235.217063061631;14541.27293635335;15923.283452244445;16939.23773430223;17093.230804613573;14848.554543363716;15486.148261845256;15987.521934100234;16067.919660401623;16219.35122595083;15025.624359390666;15207.31567079462;15450.381984720485;15966.361345546513;16240.431584894472;14936.775948361;15141.470048548248;15517.379304828131;15547.531662184398;15811;10886.67339979802;11017.83473247886;11138.053265472201;11405.600803972153;11917.34454605005;11245.550177992789;11450.08399328035;12154.1492095556;12166.513339466323;12199 09:52:38 INFO - PID 6108 | __end_tp_report 09:52:38 INFO - PID 6108 | __start_cc_report 09:52:38 INFO - PID 6108 | _x_x_mozilla_cycle_collect,337 09:52:38 INFO - PID 6108 | __end_cc_report 09:52:38 INFO - PID 6108 | __startTimestamp1495817558783__endTimestamp 09:52:38 INFO - PID 6108 | 09:52:38 INFO - PID 6108 | ------- Summary: start ------- 09:52:38 INFO - PID 6108 | Number of tests: 6 09:52:38 INFO - PID 6108 | 09:52:38 INFO - PID 6108 | [#0] dojo.html Cycles:165 Average:5269.87 Median:5442.21 stddev:635.86 (11.7%) stddev-sans-first:605.48 09:52:38 INFO - PID 6108 | Values: 2718.2 2718.9 2729.8 2732.4 2768.2 5242.5 5321.5 5331.3 5331.4 5396.6 5260.9 5312.4 5344.4 5354.5 5411.1 4461.9 4662.3 4718.5 4742.7 4746.1 4800.2 4832.0 4839.8 4860.4 4884.6 4680.5 4729.9 4736.7 4764.6 4775.4 4692.2 4694.2 4738.9 4756.4 4774.0 4629.7 4680.2 4680.6 4682.2 4686.5 5232.6 5315.8 5319.1 5320.6 5368.4 5777.0 5849.3 5850.6 5860.6 5862.5 5854.5 5857.7 5865.4 5867.2 5881.5 5434.9 5442.2 5445.7 5457.6 5461.7 5864.3 5935.3 5942.0 5943.6 5978.6 5649.0 5679.3 5704.2 5713.7 5720.4 5613.2 5735.4 5748.4 5770.6 5781.5 5600.4 5675.9 5715.5 5746.7 5747.3 5727.5 5747.4 5758.5 5787.4 5813.8 4844.7 4845.6 4847.3 4858.0 4897.2 4052.5 4137.3 4148.4 4165.6 4185.9 4818.6 4846.2 4863.3 4891.2 4900.5 5721.7 5755.7 5778.1 5794.8 5797.4 4859.6 4865.0 4866.7 4876.0 4884.5 5017.9 5059.3 5091.8 5147.2 5165.2 5409.7 5411.3 5419.7 5424.3 5457.8 5650.9 5706.1 5759.4 5814.4 5818.9 5375.5 5383.7 5398.9 5413.2 5429.1 5669.5 5713.7 5730.3 5740.5 5745.9 5712.5 5838.1 5844.4 5850.9 5858.3 5607.2 5619.1 5652.8 5654.9 5684.9 5586.4 5616.6 5639.2 5644.4 5645.4 5406.9 5490.2 5500.8 5519.4 5524.1 5508.3 5616.5 5621.7 5649.8 5657.3 5426.4 5453.8 5499.3 5546.3 5546.3 09:52:38 INFO - PID 6108 | 09:52:38 INFO - PID 6108 | [#1] ext.html Cycles:180 Average:30468.91 Median:28694.21 stddev:42489.43 (148.1%) stddev-sans-first:42549.73 09:52:38 INFO - PID 6108 | Values: 674.8 739.0 751.9 1147.7 1192.2 33718.5 35217.5 35319.5 35346.8 35361.3 33427.3 33486.7 33751.7 33841.2 33938.3 5388.9 5401.4 5477.9 6280.3 6416.6 6709.4 6808.4 6818.9 6823.5 6834.5 6780.2 6822.0 6822.8 6839.9 6857.0 6794.4 6811.2 6815.1 6818.7 6829.9 6688.3 6700.8 6718.1 6720.0 6725.0 31529.4 31689.7 31799.8 31809.0 31842.4 3033.8 3063.8 3065.7 3067.8 3067.9 24559.0 24560.5 24689.4 24767.3 24837.4 2741.7 2745.0 2745.6 2752.8 2756.0 148610.0 148986.0 152195.0 156790.0 157167.2 38734.0 38787.2 38962.6 39032.4 39164.8 40317.6 40607.2 42750.6 43371.0 43518.0 12967.9 13006.2 13100.6 13153.5 13168.3 10304.8 10325.7 10327.1 10382.7 10418.4 12795.4 12821.0 12871.2 12937.2 12974.6 5336.7 5393.3 5398.0 5440.8 5452.6 834.8 892.7 909.9 913.3 920.2 20713.5 21279.3 21406.6 21490.7 21519.6 939.2 997.4 1002.0 1002.8 1003.6 10526.9 11205.6 11327.2 11417.1 11527.5 177894.0 178418.0 178692.0 178785.0 178949.0 40299.8 40346.8 40374.8 40377.4 40489.0 1222.5 1245.7 1251.6 1254.7 1254.8 19309.6 19853.5 20291.5 20594.0 20681.4 28725.3 29101.9 29126.4 29173.4 29183.0 159842.0 160982.0 161623.0 162332.2 162404.0 27562.3 27721.4 27783.3 27799.9 27825.4 33094.7 33682.0 34485.8 34523.7 34745.3 26219.9 26459.2 26471.5 26630.9 27564.9 26636.5 26641.1 26868.9 26882.6 26903.2 28663.1 28890.0 28970.3 28994.0 29051.1 25434.4 25530.6 25927.5 26190.5 26784.3 20780.5 21123.5 21359.4 21449.0 21533.4 09:52:38 INFO - PID 6108 | 09:52:38 INFO - PID 6108 | [#2] jquery.html Cycles:180 Average:25514.08 Median:40246.20 stddev:64471.28 (160.2%) stddev-sans-first:64624.58 09:52:38 INFO - PID 6108 | Values: 405.6 408.5 428.9 429.2 431.9 16842.2 17263.9 17297.4 17454.5 18389.0 18314.3 18698.7 18953.7 19121.7 19226.1 5175.2 5229.2 5351.8 5389.1 5397.2 5155.3 5287.9 5288.2 5291.6 5305.5 5232.4 5260.4 5262.8 5271.2 5276.2 4984.2 5181.7 5187.9 5222.6 5230.7 4699.8 4707.9 4712.3 4717.4 4737.6 20958.5 21169.5 21257.6 21286.5 21483.6 1557.2 1561.4 1597.2 1598.6 1602.4 14241.9 14642.9 14701.9 14726.7 15007.7 1985.5 2001.3 2049.1 2054.5 2092.5 80594.0 81100.6 81660.6 81763.6 83099.0 10586.6 10809.8 10994.5 11060.6 11105.8 15209.2 15287.2 15292.6 15295.1 15308.2 7862.6 7868.1 8025.9 8055.8 8077.6 7299.9 7326.0 7445.5 7573.0 7616.8 6594.4 6643.0 6705.7 6739.1 6768.4 2003.6 2017.5 2030.4 2064.0 2074.4 858.3 891.9 892.5 893.4 926.1 16857.6 16879.1 16973.2 16990.7 17896.3 904.2 906.2 907.4 908.6 914.7 9186.9 9516.0 9581.4 9683.1 9736.7 382520.0 385666.0 387534.0 389595.0 395609.0 81632.0 84404.2 84559.6 85678.0 87191.6 1041.1 1073.1 1104.6 1116.6 1118.2 16917.8 17099.7 17406.4 17788.2 17987.3 40242.6 40249.8 40577.2 40594.2 42183.2 48489.0 48900.3 51135.0 51288.5 53121.7 8348.7 8555.4 8575.7 8610.4 8633.8 12214.8 13121.8 13549.1 13726.0 13824.9 10357.4 10375.7 10548.4 10636.1 10860.9 10536.5 10559.2 10610.2 11150.9 11210.9 10922.6 11079.5 11525.8 11555.7 12049.2 7647.0 7803.9 7954.4 8186.8 8794.3 10428.7 10536.2 10587.7 10591.2 10980.5 09:52:38 INFO - PID 6108 | 09:52:38 INFO - PID 6108 | [#3] mootools.html Cycles:180 Average:6505.42 Median:3707.94 stddev:4296.10 (115.9%) stddev-sans-first:4289.82 09:52:38 INFO - PID 6108 | Values: 1222.8 1279.3 1286.9 1290.2 1300.0 10238.8 10729.3 10736.8 10795.3 11012.2 10759.9 10905.0 10963.8 10965.7 10969.6 2190.5 2233.2 2242.6 2254.9 2256.1 2146.3 2189.6 2189.9 2191.1 2196.9 2120.5 2155.4 2156.2 2159.3 2159.4 2111.9 2119.2 2129.4 2131.9 2137.1 1890.3 1952.2 2063.6 2087.9 2140.7 10499.1 10558.4 10597.2 10613.6 10624.4 5642.1 5803.9 5833.8 5835.4 5876.0 3133.3 3235.2 3316.0 3320.9 3327.9 966.6 984.9 1017.4 1036.3 1047.1 15570.9 15688.8 15779.5 15783.7 15855.7 4726.5 4765.5 4896.7 4921.2 4929.1 11373.5 11397.1 11475.6 11483.5 11490.1 5534.3 5610.7 5633.4 5666.7 5687.9 5124.1 5152.0 5169.7 5173.3 5178.3 3924.3 4020.5 4039.0 4071.6 4117.9 1135.0 1142.3 1149.2 1158.4 1164.7 689.5 721.6 722.4 726.4 732.5 5674.4 5710.4 5775.0 5836.3 5855.6 529.5 551.7 554.7 563.4 571.3 3482.3 3701.5 3703.7 3712.2 3838.2 13344.9 13837.4 13939.5 14188.5 14207.5 13652.7 13862.8 14095.1 14163.6 14164.3 7570.4 7783.6 7799.6 7803.6 7819.7 5693.5 5911.8 5929.7 6009.1 6105.9 12308.6 12486.6 12565.4 12778.9 12796.6 12370.4 12769.2 12813.0 12983.4 13023.5 8512.6 8783.6 8803.1 8821.2 8839.6 9672.0 9712.9 9813.4 9829.1 9845.2 8366.7 8511.6 8569.1 8579.7 8803.7 8347.1 8371.7 8517.4 8579.2 8581.2 7411.1 7581.1 7586.9 7592.1 7615.1 5401.1 5449.9 5506.7 5550.8 5605.9 5562.5 5570.8 5606.6 5614.8 5706.9 09:52:38 INFO - PID 6108 | 09:52:38 INFO - PID 6108 | [#4] prototype.html Cycles:180 Average:4849.23 Median:5371.02 stddev:1397.19 (26.0%) stddev-sans-first:1360.08 09:52:38 INFO - PID 6108 | Values: 371.1 379.8 392.2 392.9 394.8 5446.8 5580.6 5611.5 5616.6 5634.2 5364.9 5420.2 5426.9 5431.3 5437.3 4134.2 4155.7 4160.1 4162.6 4171.4 4092.4 4118.7 4142.5 4149.3 4167.1 4084.0 4103.6 4108.2 4112.4 4135.1 4052.3 4074.3 4089.4 4094.2 4102.3 3608.0 3609.6 3614.5 3628.7 3629.6 5155.5 5322.4 5349.0 5351.4 5373.3 4863.9 4889.9 4893.7 4905.3 4909.6 5688.9 5793.3 5844.1 5852.5 5855.4 4052.4 4086.2 4103.6 4116.7 4116.9 6009.4 6067.5 6106.8 6196.5 6275.0 4582.3 4628.7 4640.3 4647.9 4657.5 4676.4 4681.6 4684.2 4694.7 4697.2 5040.4 5109.2 5149.1 5161.9 5165.3 5893.1 5897.9 5901.4 5949.4 5955.9 1596.5 1599.2 1620.7 1626.6 1630.3 1176.3 1178.7 1179.1 1187.6 1202.9 5049.7 5057.4 5068.7 5078.7 5112.7 5910.7 5960.2 6023.6 6060.8 6103.5 5000.7 5010.0 5046.2 5048.1 5051.8 3201.4 3218.5 3221.6 3240.8 3242.4 5368.7 5574.8 5588.3 5638.8 5639.8 6196.6 6210.8 6224.5 6238.3 6254.1 5476.3 5605.4 5636.4 5639.6 5642.5 6037.3 6058.2 6063.2 6067.8 6073.8 5761.5 5934.2 6008.2 6009.7 6012.6 5563.0 5577.2 5605.5 5608.2 5634.3 4184.8 4197.4 4212.3 4229.8 4233.3 5936.3 6049.2 6070.2 6115.7 6157.7 5794.7 5835.6 5853.8 5872.7 5873.9 5765.2 5857.6 5868.2 5894.5 5909.8 5727.7 5757.4 5773.9 5820.3 5826.7 5905.7 5910.9 5918.2 5937.8 5945.9 5592.2 5674.6 5688.3 5706.5 5712.4 09:52:38 INFO - PID 6108 | 09:52:38 INFO - PID 6108 | [#5] yui.html Cycles:180 Average:16832.66 Median:3005.64 stddev:21431.77 (713.1%) stddev-sans-first:21457.45 09:52:38 INFO - PID 6108 | Values: 652.7 660.3 663.5 712.0 715.5 13342.2 13696.0 13706.3 15725.3 16792.8 15560.6 15564.4 15754.3 15774.4 15818.0 891.7 904.0 910.8 912.2 913.0 864.7 890.7 901.2 902.0 902.0 938.7 942.9 943.0 943.9 944.2 923.9 928.5 930.0 934.7 935.3 683.4 684.1 684.5 685.1 690.4 14104.5 14311.2 14399.8 14453.4 14460.8 15970.3 16448.8 16452.8 16474.0 16480.1 12855.9 13077.5 13202.1 13242.1 13255.8 2951.1 2960.4 2966.8 2971.1 2977.2 83377.2 84898.0 85446.0 85544.0 86110.0 11772.4 11798.2 11842.6 11950.1 11968.6 17664.0 18542.2 22061.2 22744.7 22844.5 6223.9 6254.9 6361.2 6362.1 6382.0 2902.2 2985.2 2991.5 3004.3 3006.9 3524.7 3622.6 3626.0 3633.7 3642.7 723.1 735.3 739.2 745.9 746.1 574.7 585.1 599.1 600.0 612.6 10115.0 10617.3 11153.8 11189.8 11473.7 588.3 594.9 602.8 609.6 624.1 4513.7 4590.2 4696.2 4701.4 4892.4 73082.3 73779.6 73924.6 74073.0 76129.6 67464.3 68222.7 68526.7 69289.7 70384.0 59024.0 59859.7 60763.0 61903.0 63972.7 9745.8 9773.4 9999.7 10013.3 10285.1 27298.2 27559.3 27676.0 28107.7 28721.1 34558.8 34614.5 35392.8 35416.5 35901.8 12685.1 12894.6 13009.6 13187.1 13220.9 14235.2 14541.3 15923.3 16939.2 17093.2 14848.6 15486.1 15987.5 16067.9 16219.4 15025.6 15207.3 15450.4 15966.4 16240.4 14936.8 15141.5 15517.4 15547.5 15811.0 10886.7 11017.8 11138.1 11405.6 11917.3 11245.6 11450.1 12154.1 12166.5 12199.0 09:52:38 INFO - PID 6108 | -------- Summary: end -------- 09:52:38 INFO - PID 6108 | 09:52:39 INFO - TEST-INFO | 6108: exit 0 09:52:39 INFO - TEST-OK | dromaeo_css | took 1146157ms 09:52:39 INFO - TEST-START | kraken 09:52:39 INFO - operating with platform_type : linux_ 09:52:39 INFO - Initialising browser for kraken test... 09:52:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38603/getInfo.html -profile /tmp/tmpFfJRb8/profile 09:52:39 INFO - TEST-INFO | started process 6528 (/builds/slave/test/build/application/firefox/firefox http://localhost:38603/getInfo.html) 09:53:13 INFO - TEST-INFO | 6528: killed by SIGTERM 09:53:14 INFO - Browser initialized. 09:53:14 INFO - Running cycle 1/1 for kraken test... 09:53:14 INFO - TEST-INFO | started process 6747 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFfJRb8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:53:26 INFO - PID 6747 | RSS: Main: 172216320 09:53:26 INFO - PID 6747 | 09:53:28 INFO - PID 6747 | Cycle 1(1): loaded http://localhost:38603/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38603/tests/kraken/driver.html?testName=audio-beat-detection) 09:53:29 INFO - PID 6747 | RSS: Main: 178528256 09:53:29 INFO - PID 6747 | 09:53:32 INFO - PID 6747 | Cycle 1(1): loaded http://localhost:38603/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38603/tests/kraken/driver.html?testName=audio-dft) 09:53:32 INFO - PID 6747 | RSS: Main: 177266688 09:53:32 INFO - PID 6747 | 09:53:35 INFO - PID 6747 | Cycle 1(1): loaded http://localhost:38603/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38603/tests/kraken/driver.html?testName=audio-fft) 09:53:36 INFO - PID 6747 | RSS: Main: 175054848 09:53:36 INFO - PID 6747 | 09:53:38 INFO - PID 6747 | Cycle 1(1): loaded http://localhost:38603/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38603/tests/kraken/driver.html?testName=audio-oscillator) 09:53:39 INFO - PID 6747 | RSS: Main: 175300608 09:53:39 INFO - PID 6747 | 09:53:41 INFO - PID 6747 | Cycle 1(1): loaded http://localhost:38603/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38603/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:53:42 INFO - PID 6747 | RSS: Main: 176369664 09:53:42 INFO - PID 6747 | 09:53:45 INFO - PID 6747 | Cycle 1(1): loaded http://localhost:38603/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38603/tests/kraken/driver.html?testName=imaging-darkroom) 09:53:45 INFO - PID 6747 | RSS: Main: 176390144 09:53:45 INFO - PID 6747 | 09:53:49 INFO - PID 6747 | Cycle 1(1): loaded http://localhost:38603/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38603/tests/kraken/driver.html?testName=imaging-desaturate) 09:53:49 INFO - PID 6747 | RSS: Main: 176422912 09:53:49 INFO - PID 6747 | 09:53:52 INFO - PID 6747 | Cycle 1(1): loaded http://localhost:38603/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38603/tests/kraken/driver.html?testName=json-parse-financial) 09:53:53 INFO - PID 6747 | RSS: Main: 176828416 09:53:53 INFO - PID 6747 | 09:53:55 INFO - PID 6747 | Cycle 1(1): loaded http://localhost:38603/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38603/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:53:55 INFO - PID 6747 | RSS: Main: 176967680 09:53:55 INFO - PID 6747 | 09:53:57 INFO - PID 6747 | Cycle 1(1): loaded http://localhost:38603/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38603/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:53:58 INFO - PID 6747 | RSS: Main: 176644096 09:53:58 INFO - PID 6747 | 09:54:00 INFO - PID 6747 | Cycle 1(1): loaded http://localhost:38603/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38603/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:54:01 INFO - PID 6747 | RSS: Main: 176623616 09:54:01 INFO - PID 6747 | 09:54:03 INFO - PID 6747 | Cycle 1(1): loaded http://localhost:38603/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38603/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:54:04 INFO - PID 6747 | RSS: Main: 177049600 09:54:04 INFO - PID 6747 | 09:54:07 INFO - PID 6747 | Cycle 1(1): loaded http://localhost:38603/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38603/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:54:08 INFO - PID 6747 | RSS: Main: 176635904 09:54:08 INFO - PID 6747 | 09:54:10 INFO - PID 6747 | Cycle 1(1): loaded http://localhost:38603/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38603/tests/kraken/driver.html?testName=ai-astar) 09:54:10 INFO - PID 6747 | RSS: Main: 178208768 09:54:10 INFO - PID 6747 | 09:54:10 INFO - PID 6747 | __start_tp_report 09:54:10 INFO - PID 6747 | _x_x_mozilla_page_load 09:54:10 INFO - PID 6747 | _x_x_mozilla_page_load_details 09:54:10 INFO - PID 6747 | |i|pagename|runs| 09:54:10 INFO - PID 6747 | |0;ai-astar;105;111;111;111;110;110;110;110;111;110 09:54:10 INFO - PID 6747 | |1;audio-beat-detection;162;125;123;169;125;123;129;129;151;123 09:54:10 INFO - PID 6747 | |2;audio-dft;165;163;166;168;165;169;172;164;165;166 09:54:10 INFO - PID 6747 | |3;audio-fft;74;75;74;120;74;74;75;78;95;76 09:54:10 INFO - PID 6747 | |4;audio-oscillator;83;84;106;85;83;83;96;83;82;113 09:54:10 INFO - PID 6747 | |5;imaging-gaussian-blur;113;115;113;114;114;114;115;115;115;113 09:54:10 INFO - PID 6747 | |6;imaging-darkroom;151;151;152;158;151;152;151;150;151;154 09:54:10 INFO - PID 6747 | |7;imaging-desaturate;94;95;95;94;94;94;99;94;94;95 09:54:10 INFO - PID 6747 | |8;json-parse-financial;58;55;53;60;60;56;55;57;60;59 09:54:10 INFO - PID 6747 | |9;json-stringify-tinderbox;57;56;56;56;57;56;58;56;59;56 09:54:10 INFO - PID 6747 | |10;stanford-crypto-aes;93;88;89;89;88;88;88;92;124;88 09:54:10 INFO - PID 6747 | |11;stanford-crypto-ccm;134;136;144;136;137;132;134;131;136;133 09:54:10 INFO - PID 6747 | |12;stanford-crypto-pbkdf2;188;193;193;194;194;201;188;188;193;191 09:54:10 INFO - PID 6747 | |13;stanford-crypto-sha256-iterative;75;77;73;73;78;75;75;75;76;76 09:54:10 INFO - PID 6747 | __end_tp_report 09:54:10 INFO - PID 6747 | __start_cc_report 09:54:10 INFO - PID 6747 | _x_x_mozilla_cycle_collect,911 09:54:10 INFO - PID 6747 | __end_cc_report 09:54:10 INFO - PID 6747 | __startTimestamp1495817650502__endTimestamp 09:54:10 INFO - PID 6747 | 09:54:10 INFO - PID 6747 | ------- Summary: start ------- 09:54:10 INFO - PID 6747 | Number of tests: 14 09:54:10 INFO - PID 6747 | 09:54:10 INFO - PID 6747 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.50 stddev:1.79 (1.6%) stddev-sans-first:0.53 09:54:10 INFO - PID 6747 | Values: 105.0 111.0 111.0 111.0 110.0 110.0 110.0 110.0 111.0 110.0 09:54:10 INFO - PID 6747 | 09:54:10 INFO - PID 6747 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:129.00 stddev:17.75 (13.8%) stddev-sans-first:16.12 09:54:10 INFO - PID 6747 | Values: 162.0 125.0 123.0 169.0 125.0 123.0 129.0 129.0 151.0 123.0 09:54:10 INFO - PID 6747 | 09:54:10 INFO - PID 6747 | [#2] audio-dft Cycles:10 Average:166.30 Median:166.00 stddev:2.67 (1.6%) stddev-sans-first:2.79 09:54:10 INFO - PID 6747 | Values: 165.0 163.0 166.0 168.0 165.0 169.0 172.0 164.0 165.0 166.0 09:54:10 INFO - PID 6747 | 09:54:10 INFO - PID 6747 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.00 stddev:14.97 (20.0%) stddev-sans-first:15.63 09:54:10 INFO - PID 6747 | Values: 74.0 75.0 74.0 120.0 74.0 74.0 75.0 78.0 95.0 76.0 09:54:10 INFO - PID 6747 | 09:54:10 INFO - PID 6747 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:83.00 stddev:11.26 (13.6%) stddev-sans-first:11.67 09:54:10 INFO - PID 6747 | Values: 83.0 84.0 106.0 85.0 83.0 83.0 96.0 83.0 82.0 113.0 09:54:10 INFO - PID 6747 | 09:54:10 INFO - PID 6747 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.50 stddev:0.88 (0.8%) stddev-sans-first:0.83 09:54:10 INFO - PID 6747 | Values: 113.0 115.0 113.0 114.0 114.0 114.0 115.0 115.0 115.0 113.0 09:54:10 INFO - PID 6747 | 09:54:10 INFO - PID 6747 | [#6] imaging-darkroom Cycles:10 Average:152.10 Median:151.50 stddev:2.33 (1.5%) stddev-sans-first:2.44 09:54:10 INFO - PID 6747 | Values: 151.0 151.0 152.0 158.0 151.0 152.0 151.0 150.0 151.0 154.0 09:54:10 INFO - PID 6747 | 09:54:10 INFO - PID 6747 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.50 stddev:1.55 (1.6%) stddev-sans-first:1.62 09:54:10 INFO - PID 6747 | Values: 94.0 95.0 95.0 94.0 94.0 94.0 99.0 94.0 94.0 95.0 09:54:10 INFO - PID 6747 | 09:54:10 INFO - PID 6747 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:58.50 stddev:2.50 (4.3%) stddev-sans-first:2.64 09:54:10 INFO - PID 6747 | Values: 58.0 55.0 53.0 60.0 60.0 56.0 55.0 57.0 60.0 59.0 09:54:10 INFO - PID 6747 | 09:54:10 INFO - PID 6747 | [#9] json-stringify-tinderbox Cycles:10 Average:56.70 Median:56.50 stddev:1.06 (1.9%) stddev-sans-first:1.12 09:54:10 INFO - PID 6747 | Values: 57.0 56.0 56.0 56.0 57.0 56.0 58.0 56.0 59.0 56.0 09:54:10 INFO - PID 6747 | 09:54:10 INFO - PID 6747 | [#10] stanford-crypto-aes Cycles:10 Average:92.70 Median:88.50 stddev:11.15 (12.6%) stddev-sans-first:11.82 09:54:10 INFO - PID 6747 | Values: 93.0 88.0 89.0 89.0 88.0 88.0 88.0 92.0 124.0 88.0 09:54:10 INFO - PID 6747 | 09:54:10 INFO - PID 6747 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:136.00 stddev:3.62 (2.7%) stddev-sans-first:3.81 09:54:10 INFO - PID 6747 | Values: 134.0 136.0 144.0 136.0 137.0 132.0 134.0 131.0 136.0 133.0 09:54:10 INFO - PID 6747 | 09:54:10 INFO - PID 6747 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.30 Median:193.00 stddev:3.95 (2.0%) stddev-sans-first:3.87 09:54:10 INFO - PID 6747 | Values: 188.0 193.0 193.0 194.0 194.0 201.0 188.0 188.0 193.0 191.0 09:54:10 INFO - PID 6747 | 09:54:10 INFO - PID 6747 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.30 Median:75.50 stddev:1.57 (2.1%) stddev-sans-first:1.66 09:54:10 INFO - PID 6747 | Values: 75.0 77.0 73.0 73.0 78.0 75.0 75.0 75.0 76.0 76.0 09:54:10 INFO - PID 6747 | -------- Summary: end -------- 09:54:10 INFO - PID 6747 | 09:54:11 INFO - TEST-INFO | 6747: exit 0 09:54:11 INFO - TEST-OK | kraken | took 92061ms 09:54:11 INFO - SUITE-END | took 1238s 09:54:11 INFO - Completed test suite (00:20:38) 09:54:11 INFO - javascript benchmark 09:54:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6804.349575492066, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2718.22530578785, 2718.8912443502263, 2729.849858257795, 2732.439849830785, 2768.197222805385, 5242.475752424765, 5321.547668448177, 5331.253624492574, 5331.360236771588, 5396.622236443451, 5260.921086183701, 5312.362516498016, 5344.412114667383, 5354.544863686581, 5411.080116380215, 4461.888452788674, 4662.254814284858, 4718.504557021523, 4742.715437073769, 4746.074515469485, 4800.231962885939, 4831.975840120795, 4839.830605928793, 4860.368152140217, 4884.5848102911295, 4680.485146633868, 4729.905401891943, 4736.668433209677, 4764.6426518011285, 4775.403074615673, 4692.202325604655, 4694.201985662446, 4738.928916066227, 4756.3816703828625, 4773.976130119362, 4629.699069560468, 4680.180968330563, 4680.625549956029, 4682.157211701892, 4686.53134686532, 5232.633715639907, 5315.840524784263, 5319.0957537218765, 5320.574354051667, 5368.355797304349, 5777.046787280094, 5849.298084229919, 5850.590458667895, 5860.560457965669, 5862.50168735658, 5854.531637468992, 5857.736401861926, 5865.413458654143, 5867.207926929896, 5881.529477641779, 5434.8913021739345, 5442.210879422461, 5445.727713614304, 5457.645253058538, 5461.726913654302, 5864.325602555676, 5935.317438494542, 5942.049272116441, 5943.58394912352, 5978.611390259619, 5649.0, 5679.346875109415, 5704.22992895962, 5713.714314284269, 5720.399358067426, 5613.158026296088, 5735.369109397963, 5748.396418376094, 5770.624909380961, 5781.479666829921, 5600.383957764642, 5675.943240567542, 5715.5427565794635, 5746.683932383676, 5747.310322761212, 5727.513161381329, 5747.3677895431465, 5758.539316854642, 5787.421257874179, 5813.82558523245, 4844.685095468783, 4845.63657725672, 4847.2729090636685, 4857.975710121426, 4897.216445368724, 4052.452918855976, 4137.317342638491, 4148.357004664282, 4165.562615925345, 4185.937210941838, 4818.590419814355, 4846.224604063333, 4863.294822250754, 4891.192953162759, 4900.509949005071, 5721.742521586539, 5755.712214389264, 5778.133280007948, 5794.82615521535, 5797.391273916178, 4859.586935110485, 4865.0, 4866.7079975201605, 4876.049170411807, 4884.4871288514905, 5017.874553136127, 5059.342285502935, 5091.821786237538, 5147.2279158126585, 5165.1735722285, 5409.729513524387, 5411.269478620336, 5419.674819510842, 5424.267723857387, 5457.754401052041, 5650.943490565041, 5706.144078388275, 5759.424057594207, 5814.360420353673, 5818.912716309174, 5375.5162035417, 5383.67697938125, 5398.892022159456, 5413.188021796762, 5429.104197807317, 5669.5180909621495, 5713.742881570256, 5730.312362516524, 5740.483356497768, 5745.8563535911935, 5712.514436272963, 5838.12428135766, 5844.386339434468, 5850.882982340415, 5858.326292476419, 5607.186957891165, 5619.129034999582, 5652.802151924828, 5654.886902261849, 5684.9431505684415, 5586.441355864381, 5616.6068375213345, 5639.210510528447, 5644.435556444323, 5645.379008309001, 5406.939968821497, 5490.176473529003, 5500.7524661391135, 5519.420460851713, 5524.088525393426, 5508.338999320107, 5616.466435688603, 5621.690807005654, 5649.802256920988, 5657.32112146545, 5426.375966763872, 5453.754581043783, 5499.312585926759, 5546.251256080377, 5546.278983732089], "value": 5222.213131944965, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.7503423733219, 738.9556626602405, 751.9323260906517, 1147.713071732067, 1192.183354402234, 33718.49422258668, 35217.47173792395, 35319.4702079469, 35346.823265883664, 35361.29277414457, 33427.33145337092, 33486.66513334866, 33751.662483375156, 33841.153971150736, 33938.32123357531, 5388.865278368053, 5401.4328495508, 5477.917831232535, 6280.309165991737, 6416.550841441101, 6709.36261055199, 6808.387245147936, 6818.897716534256, 6823.488238382116, 6834.521583489158, 6780.186377634691, 6822.0, 6822.7953161404985, 6839.9316006840045, 6856.965715171442, 6794.422474089708, 6811.21671007833, 6815.114035175396, 6818.727250909958, 6829.93170068298, 6688.297728738461, 6700.83247918801, 6718.126643536358, 6720.0, 6725.0, 31529.36941261162, 31689.683103168903, 31799.841000794848, 31809.0, 31842.36315273705, 3033.848307584612, 3063.816171029723, 3065.73941214997, 3067.7852550321486, 3067.907962761121, 24559.0, 24560.508789824104, 24689.38276543083, 24767.25698229038, 24837.379065523324, 2741.684706258766, 2745.011795753527, 2745.6156138140677, 2752.8073034887566, 2755.9862200688867, 148610.0, 148986.0, 152195.0, 156790.0, 157167.2141639296, 38734.0, 38787.22425551473, 38962.61037389647, 39032.414513782314, 39164.80417597894, 40317.59682403197, 40607.18785624271, 42750.57249427528, 43371.0, 43518.0, 12967.870321296856, 13006.154599950973, 13100.606981790372, 13153.53962611304, 13168.341582920815, 10304.845427318596, 10325.690229293134, 10327.122194613543, 10382.688519344432, 10418.374897506174, 12795.424205910756, 12821.0, 12871.22772633645, 12937.223766574036, 12974.599699055705, 5336.653117547347, 5393.271908292409, 5398.0, 5440.809571664972, 5452.6183167177915, 834.837206744679, 892.7054072156172, 909.8953620333614, 913.2876356441986, 920.2453987730131, 20713.482162945744, 21279.255226067013, 21406.57186856254, 21490.677639835416, 21519.569608608053, 939.248601119102, 997.3567049253336, 1001.9749506262256, 1002.8044531316323, 1003.6186249225248, 10526.894731052591, 11205.60780372683, 11327.207095503236, 11417.086633069335, 11527.48126334317, 177894.0, 178418.0, 178692.0, 178785.0, 178949.0, 40299.79850100731, 40346.79826600848, 40374.798126009184, 40377.39433908435, 40489.0, 1222.5109956017664, 1245.7134858982486, 1251.612000279898, 1254.7239607286383, 1254.7615952968906, 19309.613807724047, 19853.503662407977, 20291.492712682302, 20594.0, 20681.379558612665, 28725.28186795263, 29101.85449072826, 29126.417471650024, 29173.41653166967, 29183.0, 159842.0, 160982.0, 161623.0, 162332.18833905755, 162404.0, 27562.310942226606, 27721.44557108887, 27783.305417363918, 27799.861000694866, 27825.44349113047, 33094.66905330916, 33682.0, 34485.827570861984, 34523.65476345205, 34745.30509389748, 26219.868900655376, 26459.206223813315, 26471.470570588866, 26630.93476260928, 27564.86217568899, 26636.467270654866, 26641.067562635213, 26868.86565567238, 26882.596761048208, 26903.192904212905, 28663.140105796858, 28889.988850390135, 28970.27574310659, 28994.0, 29051.12846614605, 25434.364140896625, 25530.617040744033, 25927.481450371266, 26190.476190476464, 26784.33039174036, 20780.480487987923, 21123.471913202295, 21359.359219223446, 21449.0, 21533.35399937942], "value": 14302.504346094549, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.5863019719886, 408.5097882540948, 428.9120730250297, 429.1824075136864, 431.94816622005357, 16842.242099105555, 17263.91368043158, 17297.394591189295, 17454.476365709033, 18389.0, 18314.267429302847, 18698.71951920722, 18953.715694264596, 19121.71317430236, 19226.13482393292, 5175.223716442526, 5229.241759944815, 5351.812686555972, 5389.083855744513, 5397.217403476494, 5155.278261043457, 5287.894242115155, 5288.233206185101, 5291.629585928987, 5305.495977882095, 5232.398274198459, 5260.395054568716, 5262.7631756571045, 5271.15661494161, 5276.2085687146855, 4984.202527595586, 5181.740912954356, 5187.870303242411, 5222.556082732972, 5230.712310822903, 4699.765011749433, 4707.8587642370785, 4712.269598212282, 4717.386739723848, 4737.644676649231, 20958.476038099016, 21169.47076323089, 21257.574848503096, 21286.467838304012, 21483.570328593498, 1557.166915700095, 1561.4378823623485, 1597.18543542794, 1598.5603958911277, 1602.407109369529, 14241.857581424158, 14642.853571464362, 14701.92649036748, 14726.70546589073, 15007.699846003019, 1985.463924740312, 2001.259533972425, 2049.1291201239565, 2054.4863784053987, 2092.5396412789164, 80594.0, 81100.59449702773, 81660.59169704113, 81763.5911820443, 83099.0, 10586.629467968583, 10809.83785243222, 10994.505247263893, 11060.557577696802, 11105.83341249882, 15209.163496007826, 15287.159206243763, 15292.617684557752, 15295.082295062331, 15308.234588270541, 7862.567558784207, 7868.055833299926, 8025.919740802634, 8055.824927269605, 8077.636506357228, 7299.854002919912, 7325.963370183115, 7445.516041457288, 7573.015507984037, 7616.809579760439, 6594.373534514213, 6643.0, 6705.664716764142, 6739.123913891261, 6768.357006084414, 2003.6493613617558, 2017.4768050122357, 2030.421329920995, 2063.9896800516203, 2074.4399012266904, 858.3176374782063, 891.8974317953518, 892.5403417240127, 893.4282059481936, 926.1109335038439, 16857.57856053584, 16879.071651059065, 16973.199422095215, 16990.660186796442, 17896.28414863391, 904.1952662130709, 906.1934877958622, 907.3920473282916, 908.6002159049997, 914.7438717159206, 9186.908130918606, 9516.048395160567, 9581.425114493153, 9683.080107389787, 9736.659216927374, 382520.0, 385666.0, 387534.0, 389595.0, 395609.0, 81632.0, 84404.15595843963, 84559.57720211359, 85678.0, 87191.56404217938, 1041.146260066738, 1073.0825144501496, 1104.5857803323754, 1116.5924437580225, 1118.2228351295935, 16917.830821691627, 17099.658006840044, 17406.39077632277, 17788.199531021393, 17987.280508779502, 40242.59757402389, 40249.798751006056, 40577.18845623012, 40594.18811623692, 42183.156336873704, 48489.0, 48900.266496001874, 51135.0, 51288.48711512837, 53121.734391327795, 8348.666053357798, 8555.443896146731, 8575.656973720981, 8610.354223433142, 8633.784155396166, 12214.75570488603, 13121.803172952223, 13549.119307244997, 13726.0, 13824.86175138276, 10357.4303413313, 10375.740606484898, 10548.367097974146, 10636.09593184557, 10860.891391086305, 10536.473176341306, 10559.208059395422, 10610.204234682275, 11150.888491114985, 11210.943945280222, 10922.56309747633, 11079.501422436171, 11525.769484610093, 11555.711107222387, 12049.156559041134, 7646.9617651911385, 7803.892948903877, 7954.363650908029, 8186.7953301167945, 8794.340424468062, 10428.687139385831, 10536.157107431234, 10587.682369528926, 10591.152707783513, 10980.450977451255], "value": 8843.573624077884, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1222.7676741419132, 1279.2899940533, 1286.8906142977846, 1290.238759132112, 1299.9740005199899, 10238.846417303746, 10729.302595331297, 10736.78526429472, 10795.29830561015, 11012.17408694347, 10759.946200269007, 10905.0, 10963.780724385508, 10965.671029869116, 10969.616063437781, 2190.5180860210767, 2233.1848875160613, 2242.585121752473, 2254.8534345267585, 2256.0750092462094, 2146.2809958663865, 2189.638709612912, 2189.9343019709436, 2191.1345018717598, 2196.923107691231, 2120.5228823514663, 2155.3749412670386, 2156.1914282144194, 2159.298228075874, 2159.406163305096, 2111.8521703480765, 2119.162930642395, 2129.4037669452578, 2131.9040643171093, 2137.1130980643015, 1890.253349926785, 1952.2288695965015, 2063.607914496241, 2087.9478013049643, 2140.7431108267106, 10499.107575855985, 10558.366498010144, 10597.205209609234, 10613.57545698171, 10624.362538247653, 5642.069058605325, 5803.941960580424, 5833.79581714638, 5835.416458354131, 5876.0, 3133.263683034485, 3235.1750303672648, 3316.0, 3320.8505617247283, 3327.88352407667, 966.6375109334, 984.9064338887795, 1017.4099022566968, 1036.264252380803, 1047.1047254597363, 15570.922145389313, 15688.843111568853, 15779.526614201592, 15783.684326313525, 15855.682886342209, 4726.456457507362, 4765.544216157903, 4896.730679812645, 4921.163402221631, 4929.06347793918, 11373.488193031333, 11397.088232941345, 11475.598354057567, 11483.483243254073, 11490.080793536497, 5534.280543529396, 5610.747516361692, 5633.352164501135, 5666.688332141772, 5687.8862422752145, 5124.103281925648, 5152.0, 5169.715665638426, 5173.275741396207, 5178.275041494194, 3924.3328634132267, 4020.4572382728543, 4038.9798051009557, 4071.5521292657786, 4117.855875044359, 1135.0, 1142.3203194099497, 1149.2300158893395, 1158.3744777820052, 1164.6622479481025, 689.4587748617312, 721.5959062924779, 722.4040166862254, 726.3680597879878, 732.5201992694793, 5674.375818659944, 5710.400407957105, 5774.971125144348, 5836.270466191726, 5855.619384739978, 529.4996228564047, 551.7406818795159, 554.6588847858538, 563.4309347558994, 571.3286887906693, 3482.2861313430685, 3701.5002974598624, 3703.666669999659, 3712.2204337088974, 3838.1939792643857, 13344.933275333755, 13837.446502140003, 13939.512117075854, 14188.503402381073, 14207.502737404142, 13652.65868353299, 13862.792058119136, 14095.083819551697, 14163.575092747235, 14164.291785410689, 7570.432217583593, 7783.610819459118, 7799.610019499002, 7803.609819509002, 7819.726309579251, 5693.5160511357, 5911.822645320647, 5929.673867937305, 6009.128676341818, 6105.877882442415, 12308.569200077955, 12486.625401237978, 12565.434555444845, 12778.87221127814, 12796.61610151697, 12370.381480926098, 12769.170003949714, 12812.974962003203, 12983.35083245853, 13023.544175954175, 8512.574371281287, 8783.604737786687, 8803.075677054074, 8821.161989610977, 8839.60221790034, 9672.0, 9712.854307185256, 9813.411195328303, 9829.066238707312, 9845.212383009486, 8366.748997530083, 8511.574421279036, 8569.143085691381, 8579.742607721779, 8803.691870784492, 8347.12355202695, 8371.748847534584, 8517.44636598619, 8579.227869491775, 8581.227689507974, 7411.1477180124975, 7581.128170260491, 7586.886196707164, 7592.050993625797, 7615.1242607098675, 5401.081816091352, 5449.891002180014, 5506.724663766876, 5550.7779688812, 5605.859853503695, 5562.527185189304, 5570.777168913198, 5606.607537472338, 5614.803481878114, 5706.857328566819], "value": 4778.596931816271, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.1019333213624, 379.81958569679404, 392.20186919618584, 392.8546437818007, 394.81838354356995, 5446.836594902149, 5580.637258578189, 5611.494965453108, 5616.606837521375, 5634.239377684012, 5364.892702145965, 5420.159875219348, 5426.945730542703, 5431.321084864392, 5437.34751829781, 4134.173165366924, 4155.6883233757435, 4160.084781348099, 4162.604552567509, 4171.416001759756, 4092.4270602115726, 4118.691098167635, 4142.544320124784, 4149.336106223005, 4167.083141754796, 4084.0, 4103.589641035903, 4108.239975604508, 4112.383142528614, 4135.0902801383645, 4052.2705912935658, 4074.3073677474754, 4089.3661482469965, 4094.160697057111, 4102.261592913274, 3608.025833025095, 3609.6463826065224, 3614.5301110855685, 3628.7459877808565, 3629.620744117245, 5155.458676838953, 5322.414534401213, 5349.0, 5351.411344752074, 5373.301470808769, 4863.929935414203, 4889.853304400874, 4893.730844803535, 4905.2887331337115, 4909.558139767402, 5688.943110568883, 5793.275840519935, 5844.094165404369, 5852.502537284336, 5855.443732845373, 4052.3516237401873, 4086.223617512663, 4103.630673239393, 4116.711830171889, 4116.91766164675, 6009.429104235091, 6067.484263837579, 6106.786262480836, 6196.473299769525, 6274.968625156845, 4582.335561343653, 4628.67599268048, 4640.257558790578, 4647.907041859144, 4657.534246575316, 4676.415448068991, 4681.6020638245445, 4684.180268453075, 4694.718316900997, 4697.248440249544, 5040.36995375578, 5109.156989096832, 5149.098907691214, 5161.896762064737, 5165.302684137669, 5893.14549390336, 5897.882042359129, 5901.380355062743, 5949.434803693643, 5955.910661340084, 1596.4811436283255, 1599.2083918460205, 1620.66776310856, 1626.5852207686964, 1630.2989714422674, 1176.2942234659306, 1178.7288923547633, 1179.1451197881638, 1187.619961612293, 1202.9338386388833, 5049.697018178921, 5057.393112826484, 5068.695878247243, 5078.7460626968505, 5112.667676601009, 5910.704464776744, 5960.225170727865, 6023.578349515492, 6060.757569697251, 6103.481204097701, 5000.67495612784, 5010.019038671984, 5046.21783623539, 5048.116579598555, 5051.848444546669, 3201.3757317322898, 3218.4850423932526, 3221.6134063912014, 3240.8333000119937, 3242.4325742994884, 5368.731563421813, 5574.777008919679, 5588.30146231721, 5638.802641907513, 5639.830805075854, 6196.628202307786, 6210.782622608187, 6224.533160013018, 6238.282597501255, 6254.124422580842, 5476.342838859362, 5605.383407825218, 5636.3799982002765, 5639.6444115751065, 5642.492175704207, 6037.335893051849, 6058.182145410313, 6063.242094738158, 6067.787627433018, 6073.787417440369, 5761.510271626791, 5934.219734079673, 6008.218931538872, 6009.699515024144, 6012.6392416455155, 5562.972185139049, 5577.191307260344, 5605.523530499953, 5608.186812912187, 5634.32388113429, 4184.832606695698, 4197.391378250076, 4212.262854000476, 4229.788510574397, 4233.301505251599, 5936.257967754031, 6049.213602231682, 6070.150178974859, 6115.724792384264, 6157.661328626789, 5794.681292528951, 5835.649861008353, 5853.795117170878, 5872.735726892385, 5873.882522349614, 5765.221695071112, 5857.560682948882, 5868.23712917318, 5894.528437724886, 5909.8227053188475, 5727.6849773262875, 5757.3954734753925, 5773.8556536086935, 5820.30156381237, 5826.73779679907, 5905.675187864708, 5910.881782364243, 5918.194950540126, 5937.821865344046, 5945.881082378415, 5592.2170896075395, 5674.57440691958, 5688.345840228427, 5706.543476521785, 5712.371639119777], "value": 4433.337054060629, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.7421668440966, 660.3363619562339, 663.5421559124203, 711.950163488556, 715.4920006795176, 13342.199468031913, 13696.041277110606, 13706.314684265797, 15725.292361843716, 16792.83207167928, 15560.610984725388, 15564.37742490302, 15754.291056902439, 15774.369025239006, 15818.0, 891.6700820696335, 903.9864402033942, 910.7632015675939, 912.2200518556638, 913.0139449394638, 864.7449002544264, 890.679355432044, 901.2159421303443, 901.9594118264661, 901.9954900225523, 938.6902322233681, 942.8774259346276, 942.9768700959468, 943.8961714211465, 944.1502647617131, 923.8568021956607, 928.4986107502008, 929.9953500232523, 934.7195841247633, 935.2658163341778, 683.3917813146304, 684.0628339175312, 684.4968947823346, 685.1025157044288, 690.3752104345525, 14104.506342277971, 14311.212883291415, 14399.78400323996, 14453.421863125463, 14460.783088253685, 15970.281337339848, 16448.83551164497, 16452.83547164525, 16474.0, 16480.09359485228, 12855.857656937207, 13077.542286019943, 13202.141860779115, 13242.139260948008, 13255.801162982563, 2951.099914526069, 2960.407918416325, 2966.7774916881103, 2971.0938163860014, 2977.1961570376093, 83377.16622833755, 84898.0, 85446.0, 85544.0, 86109.99999999937, 11772.352520611277, 11798.233114847508, 11842.585509507126, 11950.103742219368, 11968.640940771791, 17664.0, 18542.165602547648, 22061.227857024925, 22744.65883011756, 22844.543109138056, 6223.937760622426, 6254.937450625435, 6361.236651601837, 6362.1093046973465, 6381.968090159519, 2902.230908809125, 2985.1939976206736, 2991.536311871663, 3004.3390454100063, 3006.9325389486853, 3524.7356448266482, 3622.619624939396, 3625.9818700906326, 3633.7274704397278, 3642.6721595056574, 723.1214074899023, 735.2684079340983, 739.1758189618537, 745.8806590945422, 746.1344839985591, 574.6839238418853, 585.0785013603592, 599.0893841361107, 599.95800293979, 612.6109920200615, 10115.039071288216, 10617.309874858109, 11153.776924461628, 11189.832152517718, 11473.71315717097, 588.3146134752965, 594.9494292985145, 602.8492876780805, 609.58852774378, 624.0857144283647, 4513.684042117086, 4590.150822097922, 4696.1546921554445, 4701.435827700698, 4892.412910450697, 73082.26917730861, 73779.63110184415, 73924.63037684777, 74073.0, 76129.619351904, 67464.32535674679, 68222.65888670624, 68526.65736671384, 69289.65355173191, 70384.0, 59024.0, 59859.700701496215, 60763.0, 61903.0, 63972.68013659902, 9745.805083898424, 9773.41359518431, 9999.650012249536, 10013.349132306377, 10285.125764310118, 27298.181054568395, 27559.31101722473, 27676.0, 28107.718922811328, 28721.13836584906, 34558.82720586381, 34614.480782787774, 35392.82303588569, 35416.46875296924, 35901.820490898426, 12685.112042157329, 12894.613161605166, 13009.609711708665, 13187.142835716031, 13220.933895330847, 14235.217063061631, 14541.27293635335, 15923.283452244445, 16939.23773430223, 17093.230804613573, 14848.554543363716, 15486.148261845256, 15987.521934100234, 16067.919660401623, 16219.35122595083, 15025.624359390666, 15207.31567079462, 15450.381984720485, 15966.361345546513, 16240.431584894472, 14936.775948361, 15141.470048548248, 15517.379304828131, 15547.531662184398, 15811.0, 10886.67339979802, 11017.83473247886, 11138.053265472201, 11405.600803972153, 11917.34454605005, 11245.550177992789, 11450.08399328035, 12154.1492095556, 12166.513339466323, 12199.0], "value": 7091.928098960082, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 111.0, 111.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 125.0, 123.0, 169.0, 125.0, 123.0, 129.0, 129.0, 151.0, 123.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 166.0, 168.0, 165.0, 169.0, 172.0, 164.0, 165.0, 166.0], "value": 166.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 120.0, 74.0, 74.0, 75.0, 78.0, 95.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 106.0, 85.0, 83.0, 83.0, 96.0, 83.0, 82.0, 113.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 113.0, 114.0, 114.0, 114.0, 115.0, 115.0, 115.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 152.0, 158.0, 151.0, 152.0, 151.0, 150.0, 151.0, 154.0], "value": 152.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 99.0, 94.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 53.0, 60.0, 60.0, 56.0, 55.0, 57.0, 60.0, 59.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 56.0, 57.0, 56.0, 58.0, 56.0, 59.0, 56.0], "value": 56.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 88.0, 89.0, 89.0, 88.0, 88.0, 88.0, 92.0, 124.0, 88.0], "value": 92.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 136.0, 144.0, 136.0, 137.0, 132.0, 134.0, 131.0, 136.0, 133.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 193.0, 193.0, 194.0, 194.0, 201.0, 188.0, 188.0, 193.0, 191.0], "value": 192.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 73.0, 73.0, 78.0, 75.0, 75.0, 75.0, 76.0, 76.0], "value": 75.3, "unit": "score"}]}]} 09:54:11 INFO - Return code: 0 09:54:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:54:11 INFO - # TBPL SUCCESS # 09:54:11 INFO - Running post-action listener: _resource_record_post_action 09:54:11 INFO - [mozharness: 2017-05-26 16:54:11.781418Z] Finished run-tests step (success) 09:54:11 INFO - Running post-run listener: _resource_record_post_run 09:54:11 INFO - Total resource usage - Wall time: 1254s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409878528; Read time: 16; Write time: 267012 09:54:11 INFO - TinderboxPrint: CPU usage
12.7% 09:54:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 09:54:11 INFO - TinderboxPrint: I/O write bytes / time
409,878,528 / 267,012 09:54:11 INFO - TinderboxPrint: CPU idle
8,740.5 (87.3%) 09:54:11 INFO - TinderboxPrint: CPU user
1,218.4 (12.2%) 09:54:11 INFO - TinderboxPrint: Swap in / out
0 / 0 09:54:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 95535104; Read time: 0; Write time: 80888 09:54:11 INFO - run-tests - Wall time: 1239s; CPU: 13.0%; Read bytes: 0; Write bytes: 309948416; Read time: 0; Write time: 185544 09:54:12 INFO - Running post-run listener: _upload_blobber_files 09:54:12 INFO - Blob upload gear active. 09:54:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:54:12 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 09:54:12 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'] 09:54:12 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 09:54:12 INFO - (blobuploader) - INFO - Open directory for files ... 09:54:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:54:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:54:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:13 INFO - (blobuploader) - INFO - Done attempting. 09:54:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:54:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:54:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:19 INFO - (blobuploader) - INFO - Done attempting. 09:54:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:54:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:54:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:20 INFO - (blobuploader) - INFO - Done attempting. 09:54:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:54:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:54:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:20 INFO - (blobuploader) - INFO - Done attempting. 09:54:20 INFO - (blobuploader) - INFO - Iteration through files over. 09:54:20 INFO - Return code: 0 09:54:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:54:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:54:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/504e04cabaa775cb5beebfa95866716c5cfaeff0689c565ecbe529067d4f2f28f1ef159c6019204c2be5a583ccc73b9221b4b6467f38ca3279189a7e2400e8da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/728c32931a5f55c3425721078ae4966995aa79f68212be394242859a2476b7709641c7f430f1a5f60b26a980a1893286aff6c8f6e24064580d942fc678d60285", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ce86f205f2034bab933b6dffeca8895f6263258420820ce2611ea6ee420b9cc494b105eac0e3f57cd0ec1210e14bc87927f32fd1222e349d5eec5202ed9c035", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7022826abee3bc8f7d1c1972bcb4567a1b1f8ab973abc469ef0c8d89f9f319c8563e2afb913569b305f21531eb57f96310b6715f2fe34bc9342d46e63a5d9c99"} 09:54:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:54:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:54:20 INFO - Contents: 09:54:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/504e04cabaa775cb5beebfa95866716c5cfaeff0689c565ecbe529067d4f2f28f1ef159c6019204c2be5a583ccc73b9221b4b6467f38ca3279189a7e2400e8da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/728c32931a5f55c3425721078ae4966995aa79f68212be394242859a2476b7709641c7f430f1a5f60b26a980a1893286aff6c8f6e24064580d942fc678d60285", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ce86f205f2034bab933b6dffeca8895f6263258420820ce2611ea6ee420b9cc494b105eac0e3f57cd0ec1210e14bc87927f32fd1222e349d5eec5202ed9c035", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7022826abee3bc8f7d1c1972bcb4567a1b1f8ab973abc469ef0c8d89f9f319c8563e2afb913569b305f21531eb57f96310b6715f2fe34bc9342d46e63a5d9c99"} 09:54:20 INFO - Running post-run listener: copy_logs_to_upload_dir 09:54:20 INFO - Copying logs to upload dir... 09:54:20 INFO - mkdir: /builds/slave/test/build/upload/logs 09:54:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1315.459815 ========= master_lag: -0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-05-26 09:54:20.237165) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 09:54:20.245830) ========= 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=3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/504e04cabaa775cb5beebfa95866716c5cfaeff0689c565ecbe529067d4f2f28f1ef159c6019204c2be5a583ccc73b9221b4b6467f38ca3279189a7e2400e8da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/728c32931a5f55c3425721078ae4966995aa79f68212be394242859a2476b7709641c7f430f1a5f60b26a980a1893286aff6c8f6e24064580d942fc678d60285", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ce86f205f2034bab933b6dffeca8895f6263258420820ce2611ea6ee420b9cc494b105eac0e3f57cd0ec1210e14bc87927f32fd1222e349d5eec5202ed9c035", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7022826abee3bc8f7d1c1972bcb4567a1b1f8ab973abc469ef0c8d89f9f319c8563e2afb913569b305f21531eb57f96310b6715f2fe34bc9342d46e63a5d9c99"} build_url:https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/Rs7w24DMQ2C9hDdx9SSAgQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/504e04cabaa775cb5beebfa95866716c5cfaeff0689c565ecbe529067d4f2f28f1ef159c6019204c2be5a583ccc73b9221b4b6467f38ca3279189a7e2400e8da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/728c32931a5f55c3425721078ae4966995aa79f68212be394242859a2476b7709641c7f430f1a5f60b26a980a1893286aff6c8f6e24064580d942fc678d60285", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ce86f205f2034bab933b6dffeca8895f6263258420820ce2611ea6ee420b9cc494b105eac0e3f57cd0ec1210e14bc87927f32fd1222e349d5eec5202ed9c035", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7022826abee3bc8f7d1c1972bcb4567a1b1f8ab973abc469ef0c8d89f9f319c8563e2afb913569b305f21531eb57f96310b6715f2fe34bc9342d46e63a5d9c99"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 09:54:20.270059) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 09:54:20.272412) ========= 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=3a3620fb28aea1604ab609ef000001d2-1495815195.150037-1226368081 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 09:54:20.355267) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 09:54:20.357620) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 09:54:20.357924) ========= ========= Total master_lag: -0.06 =========