builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-089 starttime: 1500687404.73 results: success (0) revision: a8bb5530a0925ac0823bdb6d525cbc6f304f8928 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:44.734250) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:44.734768) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:44.735103) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:44.760088) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:44.760384) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-21 18:36:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 17.4M=0.001s 2017-07-21 18:36:45 (17.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123060 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:44.897154) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:44.897500) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021226 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:44.949503) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:44.949962) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a8bb5530a0925ac0823bdb6d525cbc6f304f8928 --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 a8bb5530a0925ac0823bdb6d525cbc6f304f8928 --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=8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-21 18:36:45,284 truncating revision to first 12 chars 2017-07-21 18:36:45,284 Setting DEBUG logging. 2017-07-21 18:36:45,284 attempt 1/10 2017-07-21 18:36:45,284 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a8bb5530a092?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-21 18:36:45,659 unpacking tar archive at: mozilla-central-a8bb5530a092/testing/mozharness/ program finished with exit code 0 elapsedTime=0.773906 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:45.736670) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:45.737036) ========= script_repo_revision: a8bb5530a0925ac0823bdb6d525cbc6f304f8928 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:45.737454) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:45.737762) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-21 18:36:45.746388) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-21 18:36:45.746697) ========= /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=8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:36:46 INFO - MultiFileLogger online at 20170721 18:36:46 in /builds/slave/test 18:36:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:36:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:36:46 INFO - {'append_to_log': False, 18:36:46 INFO - 'base_work_dir': '/builds/slave/test', 18:36:46 INFO - 'blob_upload_branch': 'Firefox', 18:36:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:36:46 INFO - 'branch': 'Firefox', 18:36:46 INFO - 'buildbot_json_path': 'buildprops.json', 18:36:46 INFO - 'code_coverage': False, 18:36:46 INFO - 'config_files': ('talos/linux_config.py',), 18:36:46 INFO - 'default_actions': ('clobber', 18:36:46 INFO - 'read-buildbot-config', 18:36:46 INFO - 'download-and-extract', 18:36:46 INFO - 'populate-webroot', 18:36:46 INFO - 'create-virtualenv', 18:36:46 INFO - 'install', 18:36:46 INFO - 'setup-mitmproxy', 18:36:46 INFO - 'run-tests'), 18:36:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:36:46 INFO - 'disable_ccov_upload': False, 18:36:46 INFO - 'download_minidump_stackwalk': True, 18:36:46 INFO - 'download_symbols': 'ondemand', 18:36:46 INFO - 'enable_stylo': False, 18:36:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:36:46 INFO - 'tooltool.py': '/tools/tooltool.py', 18:36:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:36:46 INFO - '/tools/misc-python/virtualenv.py')}, 18:36:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:36:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:36:46 INFO - 'gecko_profile': False, 18:36:46 INFO - 'gecko_profile_interval': 0, 18:36:46 INFO - 'installer_path': 'installer.exe', 18:36:46 INFO - 'log_level': 'info', 18:36:46 INFO - 'log_name': 'talos', 18:36:46 INFO - 'log_to_console': True, 18:36:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:36:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:36:46 INFO - 'opt_config_files': (), 18:36:46 INFO - 'pip_index': False, 18:36:46 INFO - 'suite': 'dromaeojs-e10s', 18:36:46 INFO - 'system_bits': '32', 18:36:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:36:46 INFO - 'title': 'talos-linux64-ix-089', 18:36:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:36:46 INFO - 'use_talos_json': True, 18:36:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:36:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:36:46 INFO - 'work_dir': 'build'} 18:36:46 INFO - [mozharness: 2017-07-22 01:36:46.188803Z] Running clobber step. 18:36:46 INFO - Running pre-action listener: _resource_record_pre_action 18:36:46 INFO - Running main action method: clobber 18:36:46 INFO - rmtree: /builds/slave/test/build 18:36:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:36:47 INFO - Running post-action listener: _resource_record_post_action 18:36:47 INFO - [mozharness: 2017-07-22 01:36:47.722673Z] Finished clobber step (success) 18:36:47 INFO - [mozharness: 2017-07-22 01:36:47.722775Z] Running read-buildbot-config step. 18:36:47 INFO - Running pre-action listener: _resource_record_pre_action 18:36:47 INFO - Running main action method: read_buildbot_config 18:36:47 INFO - Using buildbot properties: 18:36:47 INFO - { 18:36:47 INFO - "project": "", 18:36:47 INFO - "product": "firefox", 18:36:47 INFO - "who": "kwierso@gmail.com", 18:36:47 INFO - "installer_path": "public/build/target.tar.bz2", 18:36:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 18:36:47 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:36:47 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 18:36:47 INFO - "stage_platform": "linux64-stylo", 18:36:47 INFO - "basedir": "/builds/slave/test", 18:36:47 INFO - "buildnumber": 226, 18:36:47 INFO - "platform": "ubuntu64_hw_stylo", 18:36:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:36:47 INFO - "slavebuilddir": "test", 18:36:47 INFO - "taskId": "MYte2NJ_RZKLk_1RJQtaaA", 18:36:47 INFO - "branch": "mozilla-central", 18:36:47 INFO - "script_repo_revision": "production", 18:36:47 INFO - "revision": "a8bb5530a0925ac0823bdb6d525cbc6f304f8928", 18:36:47 INFO - "slavename": "talos-linux64-ix-089", 18:36:47 INFO - "repo_path": "mozilla-central" 18:36:47 INFO - } 18:36:47 INFO - Finding installer, test and symbols from parent task. 18:36:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MYte2NJ_RZKLk_1RJQtaaA'}, attempt #1 18:36:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MYte2NJ_RZKLk_1RJQtaaA'}, attempt #1 18:36:48 INFO - Task dependencies: Y8YpW8kQQ-CotAK7YQIfmQ 18:36:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ'}, attempt #1 18:36:49 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.tar.bz2 18:36:49 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/test_packages.json 18:36:49 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.crashreporter-symbols.zip 18:36:49 INFO - Running post-action listener: _resource_record_post_action 18:36:49 INFO - [mozharness: 2017-07-22 01:36:49.072229Z] Finished read-buildbot-config step (success) 18:36:49 INFO - [mozharness: 2017-07-22 01:36:49.072449Z] Running download-and-extract step. 18:36:49 INFO - Running pre-action listener: _resource_record_pre_action 18:36:49 INFO - Running main action method: download_and_extract 18:36:49 INFO - mkdir: /builds/slave/test/build/tests 18:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:36:49 INFO - trying https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.test_packages.json 18:36:49 INFO - Downloading https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:36:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:36:49 INFO - Downloaded 989 bytes. 18:36:49 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:36:49 INFO - Using the following test package requirements: 18:36:49 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:36:49 INFO - u'common': [u'target.common.tests.zip'], 18:36:49 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:36:49 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:36:49 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:36:49 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:36:49 INFO - u'mozbase': [u'target.common.tests.zip'], 18:36:49 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:36:49 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:36:49 INFO - u'web-platform': [u'target.common.tests.zip', 18:36:49 INFO - u'target.web-platform.tests.tar.gz'], 18:36:49 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:36:49 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:36:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.common.tests.zip 18:36:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:36:49 INFO - Fetch https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.common.tests.zip into memory 18:36:51 INFO - Content-Length response header: 72760468 18:36:51 INFO - Bytes received: 72760468 18:37:02 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:37:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.common.tests.zip 18:37:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:37:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.common.tests.zip into memory 18:37:03 INFO - Content-Length response header: 72760468 18:37:03 INFO - Bytes received: 72760468 18:37:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.talos.tests.zip 18:37:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:37:15 INFO - Fetch https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.talos.tests.zip into memory 18:37:16 INFO - Content-Length response header: 14498971 18:37:16 INFO - Bytes received: 14498971 18:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:16 INFO - trying https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.tar.bz2 18:37:16 INFO - Downloading https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:37:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:37:18 INFO - Downloaded 61946351 bytes. 18:37:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.tar.bz2 18:37:18 INFO - mkdir: /builds/slave/test/properties 18:37:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:37:18 INFO - Writing to file /builds/slave/test/properties/build_url 18:37:18 INFO - Contents: 18:37:18 INFO - build_url:https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.tar.bz2 18:37:18 INFO - Running post-action listener: _resource_record_post_action 18:37:18 INFO - Running post-action listener: set_extra_try_arguments 18:37:18 INFO - [mozharness: 2017-07-22 01:37:18.228543Z] Finished download-and-extract step (success) 18:37:18 INFO - [mozharness: 2017-07-22 01:37:18.228671Z] Running populate-webroot step. 18:37:18 INFO - Running pre-action listener: _resource_record_pre_action 18:37:18 INFO - Running main action method: populate_webroot 18:37:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:37:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:37:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:37:18 INFO - '--tppagecycles', 18:37:18 INFO - '7'], 18:37:18 INFO - 'tests': ['tsvgm']}}, 18:37:18 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:37:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:37:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:37:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:37:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:37:18 INFO - 'talos_options': ['--disable-e10s'], 18:37:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:37:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:37:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:37:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:37:18 INFO - 'talos_options': ['--disable-e10s'], 18:37:18 INFO - 'tests': ['damp', 'tps']}, 18:37:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:37:18 INFO - 'tests': ['damp', 'tps']}, 18:37:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:37:18 INFO - 'tests': ['dromaeo_dom']}, 18:37:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:37:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:37:18 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:37:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:37:18 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:37:18 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:37:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:37:18 INFO - 'tests': ['a11yr', 18:37:18 INFO - 'ts_paint', 18:37:18 INFO - 'tpaint', 18:37:18 INFO - 'sessionrestore', 18:37:18 INFO - 'sessionrestore_no_auto_restore', 18:37:18 INFO - 'tabpaint']}, 18:37:18 INFO - 'other-e10s': {'tests': ['a11yr', 18:37:18 INFO - 'ts_paint', 18:37:18 INFO - 'tpaint', 18:37:18 INFO - 'sessionrestore', 18:37:18 INFO - 'sessionrestore_many_windows', 18:37:18 INFO - 'sessionrestore_no_auto_restore', 18:37:18 INFO - 'tabpaint']}, 18:37:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:37:18 INFO - 'ts_paint', 18:37:18 INFO - 'tpaint', 18:37:18 INFO - 'sessionrestore', 18:37:18 INFO - 'sessionrestore_many_windows', 18:37:18 INFO - 'sessionrestore_no_auto_restore', 18:37:18 INFO - 'tabpaint']}, 18:37:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:37:18 INFO - 'ts_paint', 18:37:18 INFO - 'tpaint', 18:37:18 INFO - 'sessionrestore', 18:37:18 INFO - 'sessionrestore_many_windows', 18:37:18 INFO - 'sessionrestore_no_auto_restore', 18:37:18 INFO - 'tabpaint']}, 18:37:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:37:18 INFO - 'tests': ['a11yr', 18:37:18 INFO - 'ts_paint', 18:37:18 INFO - 'tpaint', 18:37:18 INFO - 'sessionrestore', 18:37:18 INFO - 'sessionrestore_no_auto_restore', 18:37:18 INFO - 'tabpaint']}, 18:37:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:37:18 INFO - 'tests': ['a11yr', 18:37:18 INFO - 'ts_paint', 18:37:18 INFO - 'tpaint', 18:37:18 INFO - 'sessionrestore', 18:37:18 INFO - 'sessionrestore_no_auto_restore', 18:37:18 INFO - 'tabpaint']}, 18:37:18 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 18:37:18 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:37:18 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:37:18 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:37:18 INFO - 'talos_options': ['--mitmproxy', 18:37:18 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:37:18 INFO - '--firstNonBlankPaint'], 18:37:18 INFO - 'tests': ['quantum_pageload_google', 18:37:18 INFO - 'quantum_pageload_youtube', 18:37:18 INFO - 'quantum_pageload_amazon', 18:37:18 INFO - 'quantum_pageload_facebook']}, 18:37:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:37:18 INFO - 'tests': ['tsvgx', 18:37:18 INFO - 'tsvgr_opacity', 18:37:18 INFO - 'tart', 18:37:18 INFO - 'tscrollx', 18:37:18 INFO - 'cart', 18:37:18 INFO - 'tsvg_static']}, 18:37:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:37:18 INFO - 'tsvgr_opacity', 18:37:18 INFO - 'tart', 18:37:18 INFO - 'tscrollx', 18:37:18 INFO - 'cart', 18:37:18 INFO - 'tsvg_static']}, 18:37:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:37:18 INFO - 'talos_options': ['--disable-e10s'], 18:37:18 INFO - 'tests': ['tp5o']}, 18:37:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:37:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:37:18 INFO - 'talos_options': ['--disable-e10s', 18:37:18 INFO - '--xperf_path', 18:37:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:37:18 INFO - 'tests': ['tp5n']}, 18:37:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:37:18 INFO - 'talos_options': ['--xperf_path', 18:37:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:37:18 INFO - 'tests': ['tp5n']}}, 18:37:18 INFO - 'talos.zip': {'path': '', 18:37:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:37:18 INFO - Running post-action listener: _resource_record_post_action 18:37:18 INFO - [mozharness: 2017-07-22 01:37:18.245816Z] Finished populate-webroot step (success) 18:37:18 INFO - [mozharness: 2017-07-22 01:37:18.245906Z] Running create-virtualenv step. 18:37:18 INFO - Running pre-action listener: _resource_record_pre_action 18:37:18 INFO - Running main action method: create_virtualenv 18:37:18 INFO - Creating virtualenv /builds/slave/test/build/venv 18:37:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:37:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:37:18 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:37:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:37:18 INFO - Using real prefix '/usr' 18:37:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:37:18 INFO - Installing distribute.............................................................................................................................................................................................done. 18:37:20 INFO - Installing pip.................done. 18:37:20 INFO - Return code: 0 18:37:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:37:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:37:21 INFO - Reading from file tmpfile_stdout 18:37:21 INFO - Output received: 18:37:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:37:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1591a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1734d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1731eb0>, '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 0x1732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1733240>, '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': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:37:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:37:21 INFO - Using env: {'DISPLAY': ':0', 18:37:21 INFO - 'HOME': '/home/cltbld', 18:37:21 INFO - 'LANG': 'en_US.UTF-8', 18:37:21 INFO - 'LANGUAGE': 'en_US:en', 18:37:21 INFO - 'LOGNAME': 'cltbld', 18:37:21 INFO - 'MAIL': '/var/mail/cltbld', 18:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:21 INFO - 'MOZ_NO_REMOTE': '1', 18:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:21 INFO - 'NO_EM_RESTART': '1', 18:37:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:21 INFO - 'PWD': '/builds/slave/test', 18:37:21 INFO - 'SHELL': '/bin/bash', 18:37:21 INFO - 'SHLVL': '1', 18:37:21 INFO - 'TERM': 'linux', 18:37:21 INFO - 'TMOUT': '86400', 18:37:21 INFO - 'USER': 'cltbld', 18:37:21 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 18:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:21 INFO - '_': '/tools/buildbot/bin/python'} 18:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:37:21 INFO - Cleaning up... 18:37:21 INFO - Return code: 0 18:37:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13c51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1591a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1734d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1731eb0>, '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 0x1732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1733240>, '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': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:37:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:37:21 INFO - Using env: {'DISPLAY': ':0', 18:37:21 INFO - 'HOME': '/home/cltbld', 18:37:21 INFO - 'LANG': 'en_US.UTF-8', 18:37:21 INFO - 'LANGUAGE': 'en_US:en', 18:37:21 INFO - 'LOGNAME': 'cltbld', 18:37:21 INFO - 'MAIL': '/var/mail/cltbld', 18:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:21 INFO - 'MOZ_NO_REMOTE': '1', 18:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:21 INFO - 'NO_EM_RESTART': '1', 18:37:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:21 INFO - 'PWD': '/builds/slave/test', 18:37:21 INFO - 'SHELL': '/bin/bash', 18:37:21 INFO - 'SHLVL': '1', 18:37:21 INFO - 'TERM': 'linux', 18:37:21 INFO - 'TMOUT': '86400', 18:37:21 INFO - 'USER': 'cltbld', 18:37:21 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 18:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:21 INFO - '_': '/tools/buildbot/bin/python'} 18:37:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:21 INFO - Downloading/unpacking psutil>=3.1.1 18:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:37:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:37:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:37:22 INFO - Installing collected packages: psutil 18:37:22 INFO - Running setup.py install for psutil 18:37:22 INFO - building 'psutil._psutil_linux' extension 18:37:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:37:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:37:22 INFO - building 'psutil._psutil_posix' extension 18:37:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:37:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:37:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:37:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:37:23 INFO - Successfully installed psutil 18:37:23 INFO - Cleaning up... 18:37:23 INFO - Return code: 0 18:37:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13c51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1591a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1734d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1731eb0>, '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 0x1732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1733240>, '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': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:37:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:37:23 INFO - Using env: {'DISPLAY': ':0', 18:37:23 INFO - 'HOME': '/home/cltbld', 18:37:23 INFO - 'LANG': 'en_US.UTF-8', 18:37:23 INFO - 'LANGUAGE': 'en_US:en', 18:37:23 INFO - 'LOGNAME': 'cltbld', 18:37:23 INFO - 'MAIL': '/var/mail/cltbld', 18:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:23 INFO - 'MOZ_NO_REMOTE': '1', 18:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:23 INFO - 'NO_EM_RESTART': '1', 18:37:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:23 INFO - 'PWD': '/builds/slave/test', 18:37:23 INFO - 'SHELL': '/bin/bash', 18:37:23 INFO - 'SHLVL': '1', 18:37:23 INFO - 'TERM': 'linux', 18:37:23 INFO - 'TMOUT': '86400', 18:37:23 INFO - 'USER': 'cltbld', 18:37:23 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 18:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:23 INFO - '_': '/tools/buildbot/bin/python'} 18:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:37:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:37:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:37:24 INFO - Installing collected packages: mozsystemmonitor 18:37:24 INFO - Running setup.py install for mozsystemmonitor 18:37:24 INFO - Successfully installed mozsystemmonitor 18:37:24 INFO - Cleaning up... 18:37:24 INFO - Return code: 0 18:37:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:24 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 0x13c51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1591a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1734d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1731eb0>, '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 0x1732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1733240>, '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': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:37:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:37:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:37:24 INFO - Using env: {'DISPLAY': ':0', 18:37:24 INFO - 'HOME': '/home/cltbld', 18:37:24 INFO - 'LANG': 'en_US.UTF-8', 18:37:24 INFO - 'LANGUAGE': 'en_US:en', 18:37:24 INFO - 'LOGNAME': 'cltbld', 18:37:24 INFO - 'MAIL': '/var/mail/cltbld', 18:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:24 INFO - 'MOZ_NO_REMOTE': '1', 18:37:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:24 INFO - 'NO_EM_RESTART': '1', 18:37:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:24 INFO - 'PWD': '/builds/slave/test', 18:37:24 INFO - 'SHELL': '/bin/bash', 18:37:24 INFO - 'SHLVL': '1', 18:37:24 INFO - 'TERM': 'linux', 18:37:24 INFO - 'TMOUT': '86400', 18:37:24 INFO - 'USER': 'cltbld', 18:37:24 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 18:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:24 INFO - '_': '/tools/buildbot/bin/python'} 18:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:24 INFO - Downloading/unpacking jsonschema==2.5.1 18:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:37:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:26 INFO - Downloading functools32-3.2.3-2.tar.gz 18:37:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:37:26 INFO - warning: no files found matching '*.txt' 18:37:26 INFO - no previously-included directories found matching 'build' 18:37:26 INFO - no previously-included directories found matching 'dist' 18:37:26 INFO - no previously-included directories found matching '.git*' 18:37:26 INFO - Installing collected packages: jsonschema, functools32 18:37:26 INFO - Running setup.py install for functools32 18:37:26 INFO - warning: no files found matching '*.txt' 18:37:26 INFO - no previously-included directories found matching 'build' 18:37:26 INFO - no previously-included directories found matching 'dist' 18:37:26 INFO - no previously-included directories found matching '.git*' 18:37:26 INFO - Successfully installed jsonschema functools32 18:37:26 INFO - Cleaning up... 18:37:26 INFO - Return code: 0 18:37:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:26 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 0x13c51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1591a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1734d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1731eb0>, '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 0x1732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1733240>, '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': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:37:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:37:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:37:26 INFO - Using env: {'DISPLAY': ':0', 18:37:26 INFO - 'HOME': '/home/cltbld', 18:37:26 INFO - 'LANG': 'en_US.UTF-8', 18:37:26 INFO - 'LANGUAGE': 'en_US:en', 18:37:26 INFO - 'LOGNAME': 'cltbld', 18:37:26 INFO - 'MAIL': '/var/mail/cltbld', 18:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:26 INFO - 'MOZ_NO_REMOTE': '1', 18:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:26 INFO - 'NO_EM_RESTART': '1', 18:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:26 INFO - 'PWD': '/builds/slave/test', 18:37:26 INFO - 'SHELL': '/bin/bash', 18:37:26 INFO - 'SHLVL': '1', 18:37:26 INFO - 'TERM': 'linux', 18:37:26 INFO - 'TMOUT': '86400', 18:37:26 INFO - 'USER': 'cltbld', 18:37:26 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 18:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:26 INFO - '_': '/tools/buildbot/bin/python'} 18:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:37:26 INFO - Cleaning up... 18:37:26 INFO - Return code: 0 18:37:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:26 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 0x13c51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1591a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1734d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1731eb0>, '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 0x1732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1733240>, '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': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:37:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:37:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:37:26 INFO - Using env: {'DISPLAY': ':0', 18:37:26 INFO - 'HOME': '/home/cltbld', 18:37:26 INFO - 'LANG': 'en_US.UTF-8', 18:37:26 INFO - 'LANGUAGE': 'en_US:en', 18:37:26 INFO - 'LOGNAME': 'cltbld', 18:37:26 INFO - 'MAIL': '/var/mail/cltbld', 18:37:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:26 INFO - 'MOZ_NO_REMOTE': '1', 18:37:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:26 INFO - 'NO_EM_RESTART': '1', 18:37:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:26 INFO - 'PWD': '/builds/slave/test', 18:37:26 INFO - 'SHELL': '/bin/bash', 18:37:26 INFO - 'SHLVL': '1', 18:37:26 INFO - 'TERM': 'linux', 18:37:26 INFO - 'TMOUT': '86400', 18:37:26 INFO - 'USER': 'cltbld', 18:37:26 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 18:37:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:26 INFO - '_': '/tools/buildbot/bin/python'} 18:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:26 INFO - Downloading/unpacking blobuploader==1.2.4 18:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:27 INFO - Downloading blobuploader-1.2.4.tar.gz 18:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:37:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:37:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:28 INFO - Downloading docopt-0.6.1.tar.gz 18:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:37:28 INFO - Installing collected packages: blobuploader, requests, docopt 18:37:28 INFO - Running setup.py install for blobuploader 18:37:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:37:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:37:28 INFO - Running setup.py install for requests 18:37:28 INFO - Running setup.py install for docopt 18:37:29 INFO - Successfully installed blobuploader requests docopt 18:37:29 INFO - Cleaning up... 18:37:29 INFO - Return code: 0 18:37:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:29 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 0x13c51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1591a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1734d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1731eb0>, '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 0x1732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1733240>, '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': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:37:29 INFO - Using env: {'DISPLAY': ':0', 18:37:29 INFO - 'HOME': '/home/cltbld', 18:37:29 INFO - 'LANG': 'en_US.UTF-8', 18:37:29 INFO - 'LANGUAGE': 'en_US:en', 18:37:29 INFO - 'LOGNAME': 'cltbld', 18:37:29 INFO - 'MAIL': '/var/mail/cltbld', 18:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:29 INFO - 'MOZ_NO_REMOTE': '1', 18:37:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:29 INFO - 'NO_EM_RESTART': '1', 18:37:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:29 INFO - 'PWD': '/builds/slave/test', 18:37:29 INFO - 'SHELL': '/bin/bash', 18:37:29 INFO - 'SHLVL': '1', 18:37:29 INFO - 'TERM': 'linux', 18:37:29 INFO - 'TMOUT': '86400', 18:37:29 INFO - 'USER': 'cltbld', 18:37:29 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 18:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:29 INFO - '_': '/tools/buildbot/bin/python'} 18:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:37:29 INFO - Running setup.py (path:/tmp/pip-c13nQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:37:29 INFO - Running setup.py (path:/tmp/pip-XGsqGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:37:29 INFO - Running setup.py (path:/tmp/pip-BD7xOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:37:29 INFO - Running setup.py (path:/tmp/pip-JK8qlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:37:29 INFO - Running setup.py (path:/tmp/pip-_CH0yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:37:29 INFO - Running setup.py (path:/tmp/pip-EM3IaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:37:29 INFO - Running setup.py (path:/tmp/pip-dvfrAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:37:29 INFO - Running setup.py (path:/tmp/pip-naEwAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:37:29 INFO - Running setup.py (path:/tmp/pip-QKstSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:37:29 INFO - Running setup.py (path:/tmp/pip-vLd_EX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:37:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:37:29 INFO - Running setup.py (path:/tmp/pip-UtfCpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:37:30 INFO - Running setup.py (path:/tmp/pip-M1SI7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:37:30 INFO - Running setup.py (path:/tmp/pip-HjBYKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:37:30 INFO - Running setup.py (path:/tmp/pip-LxF1ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:37:30 INFO - Running setup.py (path:/tmp/pip-HY9svl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:37:30 INFO - Running setup.py (path:/tmp/pip-HNFT5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:37:30 INFO - Running setup.py (path:/tmp/pip-tPqjZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:37:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:37:30 INFO - Running setup.py install for manifestparser 18:37:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:37:30 INFO - Running setup.py install for mozcrash 18:37:30 INFO - Running setup.py install for mozdebug 18:37:30 INFO - Running setup.py install for mozdevice 18:37:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:37:30 INFO - Running setup.py install for mozfile 18:37:30 INFO - Running setup.py install for mozhttpd 18:37:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:37:31 INFO - Running setup.py install for mozinfo 18:37:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:37:31 INFO - Running setup.py install for mozInstall 18:37:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:37:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:37:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:37:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:37:31 INFO - Running setup.py install for mozleak 18:37:31 INFO - Running setup.py install for mozlog 18:37:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:37:31 INFO - Running setup.py install for moznetwork 18:37:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:37:31 INFO - Running setup.py install for mozprocess 18:37:31 INFO - Running setup.py install for mozprofile 18:37:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:37:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:37:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:37:31 INFO - Running setup.py install for mozrunner 18:37:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:37:31 INFO - Running setup.py install for mozscreenshot 18:37:32 INFO - Running setup.py install for moztest 18:37:32 INFO - Running setup.py install for mozversion 18:37:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:37:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:37:32 INFO - Cleaning up... 18:37:32 INFO - Return code: 0 18:37:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:32 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 0x13c51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1591a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1734d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1731eb0>, '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 0x1732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1733240>, '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': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:37:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:37:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:37:32 INFO - Using env: {'DISPLAY': ':0', 18:37:32 INFO - 'HOME': '/home/cltbld', 18:37:32 INFO - 'LANG': 'en_US.UTF-8', 18:37:32 INFO - 'LANGUAGE': 'en_US:en', 18:37:32 INFO - 'LOGNAME': 'cltbld', 18:37:32 INFO - 'MAIL': '/var/mail/cltbld', 18:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:32 INFO - 'MOZ_NO_REMOTE': '1', 18:37:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:32 INFO - 'NO_EM_RESTART': '1', 18:37:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:32 INFO - 'PWD': '/builds/slave/test', 18:37:32 INFO - 'SHELL': '/bin/bash', 18:37:32 INFO - 'SHLVL': '1', 18:37:32 INFO - 'TERM': 'linux', 18:37:32 INFO - 'TMOUT': '86400', 18:37:32 INFO - 'USER': 'cltbld', 18:37:32 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 18:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:32 INFO - '_': '/tools/buildbot/bin/python'} 18:37:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:37:32 INFO - Running setup.py (path:/tmp/pip-IrjIQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:37:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:37:32 INFO - Running setup.py (path:/tmp/pip-k1XELJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:37:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:37:32 INFO - Running setup.py (path:/tmp/pip-i0XjvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:37:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:37:32 INFO - Running setup.py (path:/tmp/pip-idYylY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:37:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:37:32 INFO - Running setup.py (path:/tmp/pip-TddzTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:37:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:37:32 INFO - Running setup.py (path:/tmp/pip-PNe_JH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:37:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:37:32 INFO - Running setup.py (path:/tmp/pip-I_j9zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:37:33 INFO - Running setup.py (path:/tmp/pip-oIdtgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:37:33 INFO - Running setup.py (path:/tmp/pip-Ii07XK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:37:33 INFO - Running setup.py (path:/tmp/pip-iwSHVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:37:33 INFO - Running setup.py (path:/tmp/pip-ghtTOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:37:33 INFO - Running setup.py (path:/tmp/pip-XcAW4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:37:33 INFO - Running setup.py (path:/tmp/pip-2qC6K8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:37:33 INFO - Running setup.py (path:/tmp/pip-eWpDcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:37:33 INFO - Running setup.py (path:/tmp/pip-WIQ_ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:37:33 INFO - Running setup.py (path:/tmp/pip-tnS9bS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:37:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:37:33 INFO - Running setup.py (path:/tmp/pip-umpngl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:37:33 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:37:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:34 INFO - Downloading blessings-1.6.tar.gz 18:37:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:37:34 INFO - Installing collected packages: blessings 18:37:34 INFO - Running setup.py install for blessings 18:37:34 INFO - Successfully installed blessings 18:37:34 INFO - Cleaning up... 18:37:35 INFO - Return code: 0 18:37:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:37:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:37:35 INFO - Reading from file tmpfile_stdout 18:37:35 INFO - Current package versions: 18:37:35 INFO - argparse == 1.2.1 18:37:35 INFO - blessings == 1.6 18:37:35 INFO - blobuploader == 1.2.4 18:37:35 INFO - docopt == 0.6.1 18:37:35 INFO - functools32 == 3.2.3-2 18:37:35 INFO - jsonschema == 2.5.1 18:37:35 INFO - manifestparser == 1.1 18:37:35 INFO - mozInstall == 1.13 18:37:35 INFO - mozcrash == 1.0 18:37:35 INFO - mozdebug == 0.1 18:37:35 INFO - mozdevice == 0.51 18:37:35 INFO - mozfile == 1.2 18:37:35 INFO - mozhttpd == 0.7 18:37:35 INFO - mozinfo == 0.10 18:37:35 INFO - mozleak == 0.1 18:37:35 INFO - mozlog == 3.5 18:37:35 INFO - moznetwork == 0.27 18:37:35 INFO - mozprocess == 0.25 18:37:35 INFO - mozprofile == 0.28 18:37:35 INFO - mozrunner == 6.13 18:37:35 INFO - mozscreenshot == 0.1 18:37:35 INFO - mozsystemmonitor == 0.3 18:37:35 INFO - moztest == 0.8 18:37:35 INFO - mozversion == 1.4 18:37:35 INFO - psutil == 3.1.1 18:37:35 INFO - requests == 1.2.3 18:37:35 INFO - wsgiref == 0.1.2 18:37:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:35 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 0x13c51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1591a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1734d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1731eb0>, '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 0x1732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1733240>, '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': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:37:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:37:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:37:35 INFO - Using env: {'DISPLAY': ':0', 18:37:35 INFO - 'HOME': '/home/cltbld', 18:37:35 INFO - 'LANG': 'en_US.UTF-8', 18:37:35 INFO - 'LANGUAGE': 'en_US:en', 18:37:35 INFO - 'LOGNAME': 'cltbld', 18:37:35 INFO - 'MAIL': '/var/mail/cltbld', 18:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:35 INFO - 'MOZ_NO_REMOTE': '1', 18:37:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:35 INFO - 'NO_EM_RESTART': '1', 18:37:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:35 INFO - 'PWD': '/builds/slave/test', 18:37:35 INFO - 'SHELL': '/bin/bash', 18:37:35 INFO - 'SHLVL': '1', 18:37:35 INFO - 'TERM': 'linux', 18:37:35 INFO - 'TMOUT': '86400', 18:37:35 INFO - 'USER': 'cltbld', 18:37:35 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 18:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:35 INFO - '_': '/tools/buildbot/bin/python'} 18:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:37:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:37:35 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:36 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:37:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:37:36 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 18:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:37:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:37:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:37:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:37:36 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)) 18:37:36 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)) 18:37:36 INFO - Installing collected packages: marionette-driver, simplejson 18:37:36 INFO - Running setup.py install for marionette-driver 18:37:36 INFO - Running setup.py install for simplejson 18:37:37 INFO - building 'simplejson._speedups' extension 18:37:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 18:37:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 18:37:38 INFO - Successfully installed marionette-driver simplejson 18:37:38 INFO - Cleaning up... 18:37:38 INFO - Return code: 0 18:37:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:37:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:37:38 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 0x13c51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1591a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1734d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1731eb0>, '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 0x1732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1733240>, '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': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:37:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:37:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:37:38 INFO - Using env: {'DISPLAY': ':0', 18:37:38 INFO - 'HOME': '/home/cltbld', 18:37:38 INFO - 'LANG': 'en_US.UTF-8', 18:37:38 INFO - 'LANGUAGE': 'en_US:en', 18:37:38 INFO - 'LOGNAME': 'cltbld', 18:37:38 INFO - 'MAIL': '/var/mail/cltbld', 18:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:38 INFO - 'MOZ_NO_REMOTE': '1', 18:37:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:38 INFO - 'NO_EM_RESTART': '1', 18:37:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:38 INFO - 'PWD': '/builds/slave/test', 18:37:38 INFO - 'SHELL': '/bin/bash', 18:37:38 INFO - 'SHLVL': '1', 18:37:38 INFO - 'TERM': 'linux', 18:37:38 INFO - 'TMOUT': '86400', 18:37:38 INFO - 'USER': 'cltbld', 18:37:38 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 18:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:38 INFO - '_': '/tools/buildbot/bin/python'} 18:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:37:38 INFO - Cleaning up... 18:37:38 INFO - Return code: 0 18:37:38 INFO - Running post-action listener: _resource_record_post_action 18:37:38 INFO - Running post-action listener: _start_resource_monitoring 18:37:38 INFO - Starting resource monitoring. 18:37:38 INFO - [mozharness: 2017-07-22 01:37:38.313531Z] Finished create-virtualenv step (success) 18:37:38 INFO - [mozharness: 2017-07-22 01:37:38.314041Z] Running install step. 18:37:38 INFO - Running pre-action listener: _resource_record_pre_action 18:37:38 INFO - Running main action method: install 18:37:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:37:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:37:38 INFO - Reading from file tmpfile_stdout 18:37:38 INFO - Detecting whether we're running mozinstall >=1.0... 18:37:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:37:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:37:38 INFO - Reading from file tmpfile_stdout 18:37:38 INFO - Output received: 18:37:38 INFO - Usage: mozinstall [options] installer 18:37:38 INFO - Options: 18:37:38 INFO - -h, --help show this help message and exit 18:37:38 INFO - -d DEST, --destination=DEST 18:37:38 INFO - Directory to install application into. [default: 18:37:38 INFO - "/builds/slave/test"] 18:37:38 INFO - --app=APP Application being installed. [default: firefox] 18:37:38 INFO - mkdir: /builds/slave/test/build/application 18:37:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:37:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:37:56 INFO - Reading from file tmpfile_stdout 18:37:56 INFO - Output received: 18:37:56 INFO - /builds/slave/test/build/application/firefox/firefox 18:37:56 INFO - Running post-action listener: _resource_record_post_action 18:37:56 INFO - [mozharness: 2017-07-22 01:37:56.600387Z] Finished install step (success) 18:37:56 INFO - [mozharness: 2017-07-22 01:37:56.600766Z] Running setup-mitmproxy step. 18:37:56 INFO - Running pre-action listener: _resource_record_pre_action 18:37:56 INFO - Running main action method: setup_mitmproxy 18:37:56 INFO - Skipping: mitmproxy is not required 18:37:56 INFO - Running post-action listener: _resource_record_post_action 18:37:56 INFO - [mozharness: 2017-07-22 01:37:56.601922Z] Finished setup-mitmproxy step (success) 18:37:56 INFO - [mozharness: 2017-07-22 01:37:56.602143Z] Running run-tests step. 18:37:56 INFO - Running pre-action listener: _resource_record_pre_action 18:37:56 INFO - Running pre-action listener: _set_gcov_prefix 18:37:56 INFO - Running main action method: run_tests 18:37:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:37:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:37:56 INFO - Python 2.7.3 18:37:56 INFO - Return code: 0 18:37:56 INFO - grabbing minidump binary from tooltool 18:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:37:56 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 0x1731eb0>, '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 0x1732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1733240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:37:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:37:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:37:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:37:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:37:56 INFO - Return code: 0 18:37:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:37:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:37:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:37:56 INFO - ENV: RUST_BACKTRACE is now 1 18:37:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:37:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:37:56 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/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:37:56 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/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-089 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:37:56 INFO - Using env: {'DISPLAY': ':0', 18:37:56 INFO - 'HOME': '/home/cltbld', 18:37:56 INFO - 'LANG': 'en_US.UTF-8', 18:37:56 INFO - 'LANGUAGE': 'en_US:en', 18:37:56 INFO - 'LOGNAME': 'cltbld', 18:37:56 INFO - 'MAIL': '/var/mail/cltbld', 18:37:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:37:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:37:56 INFO - 'MOZ_NO_REMOTE': '1', 18:37:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:37:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:37:56 INFO - 'NO_EM_RESTART': '1', 18:37:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:37:56 INFO - 'PWD': '/builds/slave/test', 18:37:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:37:56 INFO - 'RUST_BACKTRACE': '1', 18:37:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:37:56 INFO - 'SHELL': '/bin/bash', 18:37:56 INFO - 'SHLVL': '1', 18:37:56 INFO - 'STYLO_FORCE_ENABLED': '1', 18:37:56 INFO - 'TERM': 'linux', 18:37:56 INFO - 'TMOUT': '86400', 18:37:56 INFO - 'USER': 'cltbld', 18:37:56 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402', 18:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:37:56 INFO - '_': '/tools/buildbot/bin/python'} 18:37:56 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/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:37:56 INFO - mozversion application_buildid: 20170722005116 18:37:56 INFO - mozversion application_changeset: a8bb5530a0925ac0823bdb6d525cbc6f304f8928 18:37:56 INFO - mozversion application_display_name: Nightly 18:37:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:37:56 INFO - mozversion application_name: Firefox 18:37:56 INFO - mozversion application_remotingname: firefox 18:37:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:37:56 INFO - mozversion application_vendor: Mozilla 18:37:56 INFO - mozversion application_version: 56.0a1 18:37:56 INFO - mozversion platform_buildid: 20170722005116 18:37:56 INFO - mozversion platform_changeset: a8bb5530a0925ac0823bdb6d525cbc6f304f8928 18:37:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:37:56 INFO - mozversion platform_version: 56.0a1 18:37:56 INFO - using testdate: 1500687476 18:37:56 INFO - actual date: 1500687476 18:37:56 INFO - starting webserver on 'localhost:53396' 18:37:56 INFO - SUITE-START | Running 2 tests 18:37:56 INFO - TEST-START | dromaeo_css 18:37:56 INFO - Initialising browser for dromaeo_css test... 18:37:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53396/getInfo.html -profile /tmp/tmpbxQ3nS/profile 18:37:56 INFO - TEST-INFO | started process 21883 (/builds/slave/test/build/application/firefox/firefox http://localhost:53396/getInfo.html) 18:38:03 INFO - TEST-INFO | 21883: exit 0 18:38:03 INFO - Browser initialized. 18:38:03 INFO - Running cycle 1/1 for dromaeo_css test... 18:38:03 INFO - TEST-INFO | started process 22113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbxQ3nS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:38:15 INFO - PID 22113 | RSS: Main: 176910336 18:38:15 INFO - PID 22113 | 18:41:14 INFO - PID 22113 | Cycle 1(1): loaded http://localhost:53396/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53396/tests/dromaeo/cssquery-ext.html) 18:41:15 INFO - PID 22113 | RSS: Main: 182038528 18:41:15 INFO - PID 22113 | 18:44:17 INFO - PID 22113 | Cycle 1(1): loaded http://localhost:53396/tests/dromaeo/cssquery-ext.html (next: http://localhost:53396/tests/dromaeo/cssquery-jquery.html) 18:44:18 INFO - PID 22113 | RSS: Main: 179982336 18:44:18 INFO - PID 22113 | 18:47:20 INFO - PID 22113 | Cycle 1(1): loaded http://localhost:53396/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53396/tests/dromaeo/cssquery-mootools.html) 18:47:20 INFO - PID 22113 | RSS: Main: 181714944 18:47:20 INFO - PID 22113 | 18:50:22 INFO - PID 22113 | Cycle 1(1): loaded http://localhost:53396/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53396/tests/dromaeo/cssquery-prototype.html) 18:50:23 INFO - PID 22113 | RSS: Main: 180371456 18:50:23 INFO - PID 22113 | 18:53:27 INFO - PID 22113 | Cycle 1(1): loaded http://localhost:53396/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53396/tests/dromaeo/cssquery-yui.html) 18:53:27 INFO - PID 22113 | RSS: Main: 181854208 18:53:27 INFO - PID 22113 | 18:56:29 INFO - PID 22113 | Cycle 1(1): loaded http://localhost:53396/tests/dromaeo/cssquery-yui.html (next: http://localhost:53396/tests/dromaeo/cssquery-dojo.html) 18:56:30 INFO - PID 22113 | RSS: Main: 184168448 18:56:30 INFO - PID 22113 | 18:56:30 INFO - PID 22113 | __start_tp_report 18:56:30 INFO - PID 22113 | _x_x_mozilla_page_load 18:56:30 INFO - PID 22113 | _x_x_mozilla_page_load_details 18:56:30 INFO - PID 22113 | |i|pagename|runs| 18:56:30 INFO - PID 22113 | |0;dojo.html;3136.372725454908;3154.5425913242575;3156.352947645733;3157.7631677624177;3187.82466964317;6051.939480605198;6094;6119.204503414556;6149.969250153743;6178.04240342747;5996.3404025557265;6123.540734444912;6125.785597504088;6138.693065346737;6148.262208534971;5611.130274807411;5619.943800561993;5664.122061080539;5671.092625179972;5673.659580425187;5622.859428514279;5695.401982791809;5706.800261990831;5717.085266357383;5753.1082682184115;5658.971705141489;5675.772969081232;5711.942880571203;5716.8856622867515;5731.083026715726;5555.805546805883;5566.2207290979295;5647.519960803336;5691.971540142315;5741.511971482429;5471.151971444432;5473.151661492475;5526.392096869341;5526.613137080406;5601.691906945116;5979.073243647242;6009.038553831366;6046.486048685867;6158.291796443422;6161;6548;6637;6644.402003819631;6646.60120392778;6651.434628056621;6431.742730290783;6572.145621069279;6575.243846957614;6584.440322572587;6624.205095388536;6144.139820425144;6215.2541694996435;6227.065940108974;6238.189035425366;6255.468285195719;6659.200895892427;6761.594304341756;6764.695588698521;6806.863862722717;6814.454843612499;6286.277078135981;6413.518986076063;6425.036244563353;6478.093066970628;6502.837429064311;6413.0701048348665;6483.286838447767;6495.577787443801;6509.218893732687;6511.902321465182;6406.327335629785;6487.7080531376205;6571.211454625475;6586.27550969393;6593.934060659332;6552.754976554535;6678.365555272241;6689.632070236086;6697.028930805006;6698.698558564876;5292.153255479105;5368.1679339702405;5374.355077390738;5379.731013449312;5380.623356365095;4490.865274041784;4511.075229577928;4511.548845115528;4516.661250406232;4610.423697037871;5658.971705141448;5677.801276955287;5691.288588926384;5705.5435565154685;5721.628094173865;6571;6575.572587781779;6580.045893345534;6661.134052573135;6669.833254168685;5596.664200148004;5642.097264437671;5688.488036076773;5732.77068917247;5733.967885780517;5780.739866706008;5834.124881267844;5854.941450585525;5864.618799778001;5873.119032145127;6318.968405158037;6419.679016049179;6443.323451037667;6444.903326450107;6448.999999999906;6553.475721942138;6557.114789503356;6633.6351500666;6639.170103737033;6649.368310010541;6245.6252624842655;6349.365063493614;6388.201474815648;6389.648569328546;6461.966085426309;6470.935290647033;6484.059811327425;6513.218413790186;6519.674016299071;6554.377334153248;6496.285408604956;6578.868422631616;6675.03212034262;6679.265280819203;6686.53194276396;6217.440430361289;6322;6341.048842673636;6406.295307516077;6444.420002199825;6391.424771770563;6423;6485.221773387224;6488.675566221765;6499.122618446639;6256.405641464054;6267.122602835698;6329.968350158404;6356.841078973062;6359.96820015897;6382.489400848014;6384.936150638434;6394.4564712;6414.518911081781;6448.935510645021;6206.100115483139;6208.0998255253635;6216.658083805434;6220.688965551795;6233.96883015582 18:56:30 INFO - PID 22113 | |1;ext.html;787.9921200787994;827.3257295304327;846.8475674378611;858.570714642679;1177.8586569611648;32326.353472930557;32754.508682369753;32858.342833143324;43972.780136099274;44656.106877862425;44269.33595996063;44520.77739611305;44540.3318950216;44541.55458445415;44569.55430445694;7786.7663970080985;7909;7952.522848629072;7987.5606841623685;7987.920120798804;7711.4216433767415;7932.762017139495;7934.365250779923;7937.920620793805;7938.722144724936;7797.142314345418;7875.803104922394;7881.7241396551135;7911.2088791121005;7912.327452166573;7782.0661520617605;7819.944307518526;7845.76462706114;7875.724349647792;7882.448228623999;7775.377969762406;7792.142864284924;7841.96079019607;7842;7844.37245020397;40209.39685904714;40613.79693101515;40620.39069413961;40747.38878916819;40789.18421631551;3532.205253817896;3575.945096196628;3576.409892367756;3577.3203091412806;3587.820608969541;32798.18004549881;32868.34263314744;32877.671223287936;32960;32988.6701132988;4864.659473836833;4869.780859861315;4901.754912254373;4917.483664215241;4954.083494553483;190076;190700;190835;190953;190977;50999;51037;51139.744301279;51264.23103653448;51422;52522.73738631282;52540;52786.20820687693;52823;53036.469635303925;16377.508674739776;16715.331386744394;16719;16745.07902065374;16795.664086718196;12329.691757706129;12442.253464792142;13573.660658483617;13629.522966696119;13920.234387108807;14945.103293802407;15071.4724984625;15181.696366072616;15204.16377099248;15242.618934526725;5773.336066352424;5787.797427090031;5873.442023007808;5930.466258036711;5947.851303717442;987.5309228116587;991.7371896447447;1010.4796030044533;1035.5547114740584;1044.749260177567;22862.085516579482;28965.42069158605;29651.258718532208;29772.851135744182;30222;1060.1162260259134;1089.2375337263948;1091.4215465803138;1099.115212254143;1106.9723256918642;16434.424795132352;16560.17199140038;16706.49880503587;16887.96225172817;17019.659606807796;221527;225081;239620;240372;241164;60552.39447605555;61004;61013.08480372798;61031.6948415264;61354.69322653358;1450.5285782120852;1479.5931118942162;1482.762757958743;1487.2712370938161;1487.9479218227527;27645.447091057664;28189;28401;28423.573646394907;28469.288267793472;57760.71119644375;58906.41093589009;58977.70511147417;58981;59001.40998590131;219633;221253;221804;221961;222184;39889.80055099706;40097.39853902136;40098.79950600345;40167.799161004004;40685.59314406818;49569;49948;50141;50350.24474632957;50465.24302135398;33945.3210935775;35202.59189632386;36035.27929441449;36329.81835090808;36667.26665466729;34150.65849341475;35091.64908350884;35387.64612353947;35949.1012724684;36009.459858101625;40151.1969760609;40153;40161.799191003855;40173;40532.79733601313;34718.65281347255;34771.304573908885;34814;35472.82263588665;35604;24884.626730598695;25732.8713356432;25966.740332597186;25994.74005259923;26512.602310965736 18:56:30 INFO - PID 22113 | |2;jquery.html;572.7708916433426;577.4427677291413;580.4891695308128;587.6914619824591;612.3019757476476;22322.10262127719;23185.884070579665;23210.4197395065;23217.76782232177;23247.186348477808;24220.515589688195;26723.465530689373;26740.732592674067;26803.19590412286;26907.192784216506;6431.067495213203;6588.802335929906;6599.736010559572;6603.834904127411;6613.735450581971;6317.652529110897;6489.578177418476;6515.51133664977;6523.119378883861;6599.208095028604;6540.215174179081;6556.18047744032;6566;6576.539642225046;6599.67001649918;6582.5063120265695;6616.106825578533;6620.337966203389;6621.205455345389;6621.735130594794;6092.908606370908;6092.939070609282;6110.602810817282;6112.786052488142;6129.356417576135;29078.559656395104;29644.70355296441;29995.250118746986;30130;30180.24549386261;1911.8661693681447;1934.8258656720964;1958.3635318521538;1958.8530860185401;1958.921643134273;18160.364387246384;18825.811741882542;18884.716729249074;18933.76930499513;18936.43190704281;2240.4286906838815;2308.3956650128166;2352.2002519143575;2357.163207061503;2357.3752955466816;127337;133386;133476;133764.6623533762;134146;13512.93243533776;15003.249837508081;15075.54773356801;15265.313060912285;15478;23378.53242935132;23515.941782619822;23620.645690314657;23658.171963981524;23673.40816479602;9940.850887236697;10036.899631003742;10202.327162221594;10240.262304258891;10264.332818366782;9261.120193581599;9350.251979841596;9413.388129771543;9454.101860323259;9464.19554337889;7844.725434609875;9098;9274.860877086849;9289.489078100634;9309;2549.541082605149;2582.9354266143496;2660.2418310781336;2666.546776965197;2715.8506282154276;955.460165006769;962.3359881681617;964.3827950111934;976.9706908792748;983.7098056073332;19729.802701973083;19789.60420791576;19808.90095549513;19842.801571984095;20692.068856901475;1015.5886865819355;1016.3089099412323;1036.2849633752687;1055.039913678564;1055.2613170780485;10839.891601084046;11011.61459348919;11056.74315388565;11217.71955701114;11278.436078196057;437860;439615;455117;461532;470446;116947.41526292314;119399;122474;122519.38740306241;124318.37840810738;1261.6656586004717;1278.6931136527353;1327.4889167670517;1328.1168023264613;1331.2345401394236;19827.900860495603;20530.38408847737;20736.688949665466;20776.851016307402;21543.78456215418;55369;57213.42786572081;57436.71281643565;57798.42201578098;57962.71018645049;70220;71140.64429677819;71158;71245;71471.28528714646;14993.17537535446;15124.243787810785;15249.542513724606;15252;15253.08481491114;23448.413789655395;23691.644625330977;23709.407264818517;23773.167939122046;23925.16261930824;18585.34951276699;18800.153993070617;18872.716909246647;18890.33883814115;18892.905535472233;15867.444639437565;16049;16661.50015499537;16663.416780412626;17384.913075434542;18934.337298194496;19108.140133694294;19375.8062419374;19420.028998549733;20490.385288440775;15201.847981520043;15268.541943741706;15294.694106117593;15303.387864485296;15312.464063757716;18129.45611631653;19070.237190512224;19095.427137185907;19098.7135192975;19349.806501935363 18:56:30 INFO - PID 22113 | |3;mootools.html;1357.8099066130742;1427.1651084115792;1437.3316407870345;1439.7192547453237;1441.956741297761;13160.802587961189;13534.593962181138;14049.929750351259;14138;14168.57494275172;13612.591622251324;13839.930800345985;13902.09636373635;13913.58259252224;13924;2688.301041729145;2718.320419895026;2726.5910113482937;2728.3315587681045;2749;2538.3019669590826;2748.1343376836335;2749.175247425774;2766.2669392610874;2766.4467106578763;2650.7084220735705;2672.1048448769684;2689.4352186040855;2696.298962269814;2697.878595463199;2611.3962731430693;2633.6839579250423;2634.9341266468396;2643.2466746977116;2648;2496.151308555082;2508.5986242201343;2523.6719226500622;2532.037825626269;2536.606825941982;13380.397882095232;13495.190288582717;13710.314484275847;13716.148319976875;13738.175709457464;7551.24487551246;7849.843003139905;7875.251851074138;7877.369810415153;7878.606069696492;5145.279660847485;5260.079486089957;5304;5309.65487243328;5358.303420555342;1859.3864024871896;1874.3158747057225;1905.5236190952262;1936.0513348459294;1949.541857663448;21045.789542104383;22972.54054918909;23051.962661680096;23166.073357065867;23185.652215216785;5950.196723442366;6585.209774827052;6758.256591774901;6772.153480814898;6870.175578930561;16099.597510062342;16102.03387796736;16131.677366452604;16131.758023629654;16149;7411.703531858773;7740.303372696371;7747.147813740484;7750.883736743954;7753.418493613001;7011;7095.0421693070775;7096.858062838714;7138.607376594233;7143.285671432919;5088.847334579968;5136.743162841918;5155.072087024297;5169.431362550116;5238.790448382022;1473.3517252408906;1508.1554329575254;1516.2039929037344;1522.0259034218109;1539.4842727686128;874;884.5930871798915;896.7533928169805;931.8415869302235;935.1677007463363;7458.5151965122095;8332.250097491255;8416;8617.612207450555;8635.050144484101;964.5563041001218;968.6948611187454;989.8416253399565;1009.9646512372032;1032.7934413117407;4839.346688197048;5144.074066668036;5147.253648220987;5149.6910185389;5251.973740131351;17460.214290356966;18275.177617007266;19085.904570477058;19179.32872349461;19185.136668849937;16528.504144875675;17720.291188352323;18137.274509019757;18168.1824317906;18176.545586360182;10550.577976880839;10781.245312828027;10790.67627971162;10794.73013174677;10816.296940698829;7627.8855817161675;7653.119891212582;8084.717034903751;8374.83250335002;8460.619272132892;15407.97000525316;15700.528984130495;15879.12664803447;16364.181790910645;16730.749038764672;15883;16474.341026358812;16559.17204139764;16667;16670.416535421202;10724.946375268073;10909.127269818237;10926.836097458385;10952.835707464235;10957.890421096006;12154.574589889311;12289.631311060682;12374.443150058449;12440.626781196217;12470.5011799527;9983.550740216562;10432.165426765689;10487.580496780043;10563.419011954416;10570.947145264532;9646.469444180637;10169.745756356151;10210.285280030326;10312.690619281433;10352.844707329547;9025.954870225607;9281.953590232275;9367.484788336435;9368.765780855261;9370.437773733598;6444.226692796894;6771.492138089565;6849.4177994871;6991.091158149408;7052.259512751088;6836.521443499107;6861.279565645735;6961.6519174042105;7044.577325360495;7110.217876033736 18:56:30 INFO - PID 22113 | |4;prototype.html;499.5304413850982;499.77305714470975;526.6839896062365;528.8915772266686;533.586470485374;6154.507639388849;6176.166217560639;6184.598001129923;6197.659128747922;6218.564700470969;5895.263092113486;6017.51859851212;6075.939240607592;6083.543734219929;6086.573939824214;5059.671121377108;5067.113255180328;5088.1350170471105;5156.175011998081;5176.818811341604;4916.746229711419;5040.924386134193;5139;5145.30538377318;5146.9485305146845;5079.720615366154;5082.974585127069;5083.389993200821;5117.923231151536;5123.257127716479;5130.153524668425;5132.923006154911;5137.2037334213255;5146.691198528063;5185.585153187736;4751.976240118812;4788.736619485927;4799.424069111694;4817.590504807095;4834.879128021792;5995.7901473448655;6024.87885297498;6092.116643086772;6092.421219984139;6096.390360963913;5863.296404431496;5894.882102357972;5897.203877476529;5930.940690593082;5957.612755170943;6492.577982431127;6498;6515.674216289167;6526.934730652728;6542.345765423467;5138.332016837825;5166.4575219601775;5256.50063243995;5282.366116066059;5283.1546952487415;6766.120404347453;6774.593524388552;6838.63227354531;6850.725970961155;6850.897236541456;5398;5409.29679141709;5417.783288668409;5430.348358197041;5457.890842183214;5410.648307860055;5429.484199001088;5453.672779633234;5487.451254874561;5495.477929596682;5834.824955251349;5888.205092312569;5894.322152952465;5924.0379810094955;5935.465808077293;6387.393197646216;6418.229812422539;6426;6445.677716114175;6524.347565243438;1806.2774890043825;1843.8524918006526;1867.1971052447577;1881.8212269834344;1931.94204173875;1393.881520070785;1401.6355747505722;1413.300416293941;1453.2488351536374;1466.7166229549146;5575.358833734092;5604.719764011783;5612.97193514038;5627.352854421794;5683.715814209273;6470.1588793457495;6621.635810030398;6636.6726654669255;6656.900146497806;6722.9663851680425;5553.972230138905;5657.971710141423;5669.659820410789;5673.517750991129;5706.42935706426;3525.629808870032;3529.3823830573865;3532.3994920863515;3575.1955809943074;3599;6348.365163483615;6365.809025729235;6393.136926514954;6497.252815926229;6531.281559028503;6717.462602991749;6746.561473504305;6780.525363224626;6848.828779280459;6853.657317134123;6314.842128946813;6414.454771344394;6420.1974753155855;6448.258450278278;6489.383508566679;6639.2696803352555;6653.301403352578;6672.499562532732;6683.283300283184;6721.663916804238;6485.708143133665;6561;6581.276059633532;6612;6648.675662168916;6391.548563775509;6424.261209960914;6446.129772480655;6458.257300410513;6520.869582608227;4947.233178857283;4963.627727920348;4968.552830245295;5007.974960125176;5009.198528235464;6307.747690092345;6601.9009714853355;6608.5374023819795;6635.435987940886;6688.799336019927;6020.608660437058;6265.843353916189;6336.809895703136;6355.618662880242;6400.199975003125;6375.4262116409745;6377.92954601084;6406.807795766134;6441.68253349516;6481.0926470295135;6189.84525386869;6323.557350985387;6360.519397435097;6367.363263673596;6385.584936979081;6423.518236132402;6447.2263328400895;6459.483241340776;6478.1578394808375;6501.642409667514;6155.322914479493;6157.722902469489;6179.196704428576;6199.752009919553;6224.315325314121 18:56:30 INFO - PID 22113 | |5;yui.html;898.2140626951417;913.9360244782864;924.0528458330207;928.986065209022;933.0249888866134;17506.387276445326;18839.24643014281;18847.1518781655;18864.434066977978;20010.399688009384;20533.589328213464;21383.67924481134;21713.457163570918;21854.235101771443;21856.235031773893;966.5747071288628;994.9502524873727;995.7261753017906;998.5606333213362;1000.7948370584013;1021.0963297481708;1057.2070946789909;1070.4968664727567;1071.8660167479065;1071.9464026798669;1099.8570185875824;1105.9778804423906;1107.3245320354577;1107.8338249262595;1110.6945589962784;1103.906167975723;1104.845321654969;1105.950232239551;1107.545906178463;1108.3239224073309;808.6522795198063;811.525257724232;812.2364976921675;812.475953010311;812.6424373275739;19268.710969335472;19765.30821421258;19800.207991680316;19865.10607022673;20082.79917200824;19967.30114446002;20104.79895201044;20451.693224601495;20455.28406505765;20817.791822081886;15512.14683192424;15543.455979040793;15553.300101495346;15659.217039147998;16999.83000169995;3496.7727097738566;3515.824208789576;3523.3834079036064;3539.94690079649;3542.6634469725336;121460.39269803683;123773.38113309376;127466.362668187;129249.35375323064;130476;16228.675426491403;16511.926724762852;16633.50099497017;16714.08072555997;16740.330386784393;29226.41547169087;30991.535126973115;31619.84190079035;31775.364492710018;31864.522032169534;8719.346049046348;9023.4134781239;9038.86441703375;9039.23166530839;9048.366614336934;4041.373587094005;4183.414321994923;4201.579842015835;4205.11692544563;4309.741415515079;5150.150225212873;5264.052470555337;5267.683938963674;5269.604779641542;5272.9736351318;893.097971049245;947.7820101376722;952.7713348796239;959.5058544849409;966.0387914025589;680.4794332335767;680.608650026227;699.9545029573061;707.2997732245143;722.6350692900052;11265.662030139109;11646.650600481998;12001.279923204636;12288.754224915452;12892.742145157044;656.4420242793587;694.6630884021246;696.1159327653952;703.0438603499236;707.9681414336367;5093.414257360451;5395.3525576931015;5487.533559647474;5564.638298510665;5707.600467967285;103160.48419757854;105324.47337763416;108296.45851770691;110206.44896775625;111721.44139279414;95233.63711277797;96125.51937240269;98425;99682.50158749305;104842;80949;84505;86498;87341.56329218441;88818.9999999987;10265.281430299807;10291.382517049002;10326.122279606017;10434.582616695247;10761.892381076403;34009;35849.64150358463;36089;36398.27203455863;37715.62284377121;44882;45832.77083614694;46033.76983115063;46583.76708116438;47435.52564474311;17791.377301794375;18372.448826535227;18392.908035460274;18419.447416577525;18520.907395462935;18534.44396668102;18546.350877719215;18991.33530326432;19029.904850475657;21500.462488437915;16769.832301676826;17086.48740537786;17207.655846882742;18968;19716.901415493405;18583.628327433646;18619.162137703566;18823.435296941112;19244.518887027378;19324.710129348354;17692.646147077245;18026.459206223833;18198.45404637863;18248.908755456137;18573.81426185721;12237.143399961917;12853.871461285267;13342.533011344945;13489.2580908051;13833.930830345784;13711.382987765375;14013.439462421797;14192.787108193592;14221.715565688835;14420.711585768435 18:56:30 INFO - PID 22113 | __end_tp_report 18:56:30 INFO - PID 22113 | __start_cc_report 18:56:30 INFO - PID 22113 | _x_x_mozilla_cycle_collect,376 18:56:30 INFO - PID 22113 | __end_cc_report 18:56:30 INFO - PID 22113 | __startTimestamp1500688590114__endTimestamp 18:56:30 INFO - PID 22113 | 18:56:30 INFO - PID 22113 | ------- Summary: start ------- 18:56:30 INFO - PID 22113 | Number of tests: 6 18:56:30 INFO - PID 22113 | 18:56:30 INFO - PID 22113 | [#0] dojo.html Cycles:165 Average:6057.20 Median:6256.41 stddev:705.78 (11.3%) stddev-sans-first:669.71 18:56:30 INFO - PID 22113 | Values: 3136.4 3154.5 3156.4 3157.8 3187.8 6051.9 6094.0 6119.2 6150.0 6178.0 5996.3 6123.5 6125.8 6138.7 6148.3 5611.1 5619.9 5664.1 5671.1 5673.7 5622.9 5695.4 5706.8 5717.1 5753.1 5659.0 5675.8 5711.9 5716.9 5731.1 5555.8 5566.2 5647.5 5692.0 5741.5 5471.2 5473.2 5526.4 5526.6 5601.7 5979.1 6009.0 6046.5 6158.3 6161.0 6548.0 6637.0 6644.4 6646.6 6651.4 6431.7 6572.1 6575.2 6584.4 6624.2 6144.1 6215.3 6227.1 6238.2 6255.5 6659.2 6761.6 6764.7 6806.9 6814.5 6286.3 6413.5 6425.0 6478.1 6502.8 6413.1 6483.3 6495.6 6509.2 6511.9 6406.3 6487.7 6571.2 6586.3 6593.9 6552.8 6678.4 6689.6 6697.0 6698.7 5292.2 5368.2 5374.4 5379.7 5380.6 4490.9 4511.1 4511.5 4516.7 4610.4 5659.0 5677.8 5691.3 5705.5 5721.6 6571.0 6575.6 6580.0 6661.1 6669.8 5596.7 5642.1 5688.5 5732.8 5734.0 5780.7 5834.1 5854.9 5864.6 5873.1 6319.0 6419.7 6443.3 6444.9 6449.0 6553.5 6557.1 6633.6 6639.2 6649.4 6245.6 6349.4 6388.2 6389.6 6462.0 6470.9 6484.1 6513.2 6519.7 6554.4 6496.3 6578.9 6675.0 6679.3 6686.5 6217.4 6322.0 6341.0 6406.3 6444.4 6391.4 6423.0 6485.2 6488.7 6499.1 6256.4 6267.1 6330.0 6356.8 6360.0 6382.5 6384.9 6394.5 6414.5 6448.9 6206.1 6208.1 6216.7 6220.7 6234.0 18:56:30 INFO - PID 22113 | 18:56:30 INFO - PID 22113 | [#1] ext.html Cycles:180 Average:40647.44 Median:36498.54 stddev:56014.71 (153.5%) stddev-sans-first:56091.89 18:56:30 INFO - PID 22113 | Values: 788.0 827.3 846.8 858.6 1177.9 32326.4 32754.5 32858.3 43972.8 44656.1 44269.3 44520.8 44540.3 44541.6 44569.6 7786.8 7909.0 7952.5 7987.6 7987.9 7711.4 7932.8 7934.4 7937.9 7938.7 7797.1 7875.8 7881.7 7911.2 7912.3 7782.1 7819.9 7845.8 7875.7 7882.4 7775.4 7792.1 7842.0 7842.0 7844.4 40209.4 40613.8 40620.4 40747.4 40789.2 3532.2 3575.9 3576.4 3577.3 3587.8 32798.2 32868.3 32877.7 32960.0 32988.7 4864.7 4869.8 4901.8 4917.5 4954.1 190076.0 190700.0 190835.0 190953.0 190977.0 50999.0 51037.0 51139.7 51264.2 51422.0 52522.7 52540.0 52786.2 52823.0 53036.5 16377.5 16715.3 16719.0 16745.1 16795.7 12329.7 12442.3 13573.7 13629.5 13920.2 14945.1 15071.5 15181.7 15204.2 15242.6 5773.3 5787.8 5873.4 5930.5 5947.9 987.5 991.7 1010.5 1035.6 1044.7 22862.1 28965.4 29651.3 29772.9 30222.0 1060.1 1089.2 1091.4 1099.1 1107.0 16434.4 16560.2 16706.5 16888.0 17019.7 221527.0 225081.0 239620.0 240372.0 241164.0 60552.4 61004.0 61013.1 61031.7 61354.7 1450.5 1479.6 1482.8 1487.3 1487.9 27645.4 28189.0 28401.0 28423.6 28469.3 57760.7 58906.4 58977.7 58981.0 59001.4 219633.0 221253.0 221804.0 221961.0 222184.0 39889.8 40097.4 40098.8 40167.8 40685.6 49569.0 49948.0 50141.0 50350.2 50465.2 33945.3 35202.6 36035.3 36329.8 36667.3 34150.7 35091.6 35387.6 35949.1 36009.5 40151.2 40153.0 40161.8 40173.0 40532.8 34718.7 34771.3 34814.0 35472.8 35604.0 24884.6 25732.9 25966.7 25994.7 26512.6 18:56:30 INFO - PID 22113 | 18:56:30 INFO - PID 22113 | [#2] jquery.html Cycles:180 Average:33951.47 Median:23312.86 stddev:76846.24 (329.6%) stddev-sans-first:77020.95 18:56:30 INFO - PID 22113 | Values: 572.8 577.4 580.5 587.7 612.3 22322.1 23185.9 23210.4 23217.8 23247.2 24220.5 26723.5 26740.7 26803.2 26907.2 6431.1 6588.8 6599.7 6603.8 6613.7 6317.7 6489.6 6515.5 6523.1 6599.2 6540.2 6556.2 6566.0 6576.5 6599.7 6582.5 6616.1 6620.3 6621.2 6621.7 6092.9 6092.9 6110.6 6112.8 6129.4 29078.6 29644.7 29995.3 30130.0 30180.2 1911.9 1934.8 1958.4 1958.9 1958.9 18160.4 18825.8 18884.7 18933.8 18936.4 2240.4 2308.4 2352.2 2357.2 2357.4 127337.0 133386.0 133476.0 133764.7 134146.0 13512.9 15003.2 15075.5 15265.3 15478.0 23378.5 23515.9 23620.6 23658.2 23673.4 9940.9 10036.9 10202.3 10240.3 10264.3 9261.1 9350.3 9413.4 9454.1 9464.2 7844.7 9098.0 9274.9 9289.5 9309.0 2549.5 2582.9 2660.2 2666.5 2715.9 955.5 962.3 964.4 977.0 983.7 19729.8 19789.6 19808.9 19842.8 20692.1 1015.6 1016.3 1036.3 1055.0 1055.3 10839.9 11011.6 11056.7 11217.7 11278.4 437860.0 439615.0 455117.0 461532.0 470446.0 116947.4 119399.0 122474.0 122519.4 124318.4 1261.7 1278.7 1327.5 1328.1 1331.2 19827.9 20530.4 20736.7 20776.9 21543.8 55369.0 57213.4 57436.7 57798.4 57962.7 70220.0 71140.6 71158.0 71245.0 71471.3 14993.2 15124.2 15249.5 15252.0 15253.1 23448.4 23691.6 23709.4 23773.2 23925.2 18585.3 18800.2 18872.7 18890.3 18892.9 15867.4 16049.0 16661.5 16663.4 17384.9 18934.3 19108.1 19375.8 19420.0 20490.4 15201.8 15268.5 15294.7 15303.4 15312.5 18129.5 19070.2 19095.4 19098.7 19349.8 18:56:30 INFO - PID 22113 | 18:56:30 INFO - PID 22113 | [#3] mootools.html Cycles:180 Average:8543.45 Median:2574.85 stddev:5687.24 (220.9%) stddev-sans-first:5677.56 18:56:30 INFO - PID 22113 | Values: 1357.8 1427.2 1437.3 1439.7 1442.0 13160.8 13534.6 14049.9 14138.0 14168.6 13612.6 13839.9 13902.1 13913.6 13924.0 2688.3 2718.3 2726.6 2728.3 2749.0 2538.3 2748.1 2749.2 2766.3 2766.4 2650.7 2672.1 2689.4 2696.3 2697.9 2611.4 2633.7 2634.9 2643.2 2648.0 2496.2 2508.6 2523.7 2532.0 2536.6 13380.4 13495.2 13710.3 13716.1 13738.2 7551.2 7849.8 7875.3 7877.4 7878.6 5145.3 5260.1 5304.0 5309.7 5358.3 1859.4 1874.3 1905.5 1936.1 1949.5 21045.8 22972.5 23052.0 23166.1 23185.7 5950.2 6585.2 6758.3 6772.2 6870.2 16099.6 16102.0 16131.7 16131.8 16149.0 7411.7 7740.3 7747.1 7750.9 7753.4 7011.0 7095.0 7096.9 7138.6 7143.3 5088.8 5136.7 5155.1 5169.4 5238.8 1473.4 1508.2 1516.2 1522.0 1539.5 874.0 884.6 896.8 931.8 935.2 7458.5 8332.3 8416.0 8617.6 8635.1 964.6 968.7 989.8 1010.0 1032.8 4839.3 5144.1 5147.3 5149.7 5252.0 17460.2 18275.2 19085.9 19179.3 19185.1 16528.5 17720.3 18137.3 18168.2 18176.5 10550.6 10781.2 10790.7 10794.7 10816.3 7627.9 7653.1 8084.7 8374.8 8460.6 15408.0 15700.5 15879.1 16364.2 16730.7 15883.0 16474.3 16559.2 16667.0 16670.4 10724.9 10909.1 10926.8 10952.8 10957.9 12154.6 12289.6 12374.4 12440.6 12470.5 9983.6 10432.2 10487.6 10563.4 10570.9 9646.5 10169.7 10210.3 10312.7 10352.8 9026.0 9282.0 9367.5 9368.8 9370.4 6444.2 6771.5 6849.4 6991.1 7052.3 6836.5 6861.3 6961.7 7044.6 7110.2 18:56:30 INFO - PID 22113 | 18:56:30 INFO - PID 22113 | [#4] prototype.html Cycles:180 Average:5527.47 Median:6079.74 stddev:1473.79 (24.2%) stddev-sans-first:1428.79 18:56:30 INFO - PID 22113 | Values: 499.5 499.8 526.7 528.9 533.6 6154.5 6176.2 6184.6 6197.7 6218.6 5895.3 6017.5 6075.9 6083.5 6086.6 5059.7 5067.1 5088.1 5156.2 5176.8 4916.7 5040.9 5139.0 5145.3 5146.9 5079.7 5083.0 5083.4 5117.9 5123.3 5130.2 5132.9 5137.2 5146.7 5185.6 4752.0 4788.7 4799.4 4817.6 4834.9 5995.8 6024.9 6092.1 6092.4 6096.4 5863.3 5894.9 5897.2 5930.9 5957.6 6492.6 6498.0 6515.7 6526.9 6542.3 5138.3 5166.5 5256.5 5282.4 5283.2 6766.1 6774.6 6838.6 6850.7 6850.9 5398.0 5409.3 5417.8 5430.3 5457.9 5410.6 5429.5 5453.7 5487.5 5495.5 5834.8 5888.2 5894.3 5924.0 5935.5 6387.4 6418.2 6426.0 6445.7 6524.3 1806.3 1843.9 1867.2 1881.8 1931.9 1393.9 1401.6 1413.3 1453.2 1466.7 5575.4 5604.7 5613.0 5627.4 5683.7 6470.2 6621.6 6636.7 6656.9 6723.0 5554.0 5658.0 5669.7 5673.5 5706.4 3525.6 3529.4 3532.4 3575.2 3599.0 6348.4 6365.8 6393.1 6497.3 6531.3 6717.5 6746.6 6780.5 6848.8 6853.7 6314.8 6414.5 6420.2 6448.3 6489.4 6639.3 6653.3 6672.5 6683.3 6721.7 6485.7 6561.0 6581.3 6612.0 6648.7 6391.5 6424.3 6446.1 6458.3 6520.9 4947.2 4963.6 4968.6 5008.0 5009.2 6307.7 6601.9 6608.5 6635.4 6688.8 6020.6 6265.8 6336.8 6355.6 6400.2 6375.4 6377.9 6406.8 6441.7 6481.1 6189.8 6323.6 6360.5 6367.4 6385.6 6423.5 6447.2 6459.5 6478.2 6501.6 6155.3 6157.7 6179.2 6199.8 6224.3 18:56:30 INFO - PID 22113 | 18:56:30 INFO - PID 22113 | [#5] yui.html Cycles:180 Average:22856.45 Median:20046.60 stddev:31272.16 (156.0%) stddev-sans-first:31316.42 18:56:30 INFO - PID 22113 | Values: 898.2 913.9 924.1 929.0 933.0 17506.4 18839.2 18847.2 18864.4 20010.4 20533.6 21383.7 21713.5 21854.2 21856.2 966.6 995.0 995.7 998.6 1000.8 1021.1 1057.2 1070.5 1071.9 1071.9 1099.9 1106.0 1107.3 1107.8 1110.7 1103.9 1104.8 1106.0 1107.5 1108.3 808.7 811.5 812.2 812.5 812.6 19268.7 19765.3 19800.2 19865.1 20082.8 19967.3 20104.8 20451.7 20455.3 20817.8 15512.1 15543.5 15553.3 15659.2 16999.8 3496.8 3515.8 3523.4 3539.9 3542.7 121460.4 123773.4 127466.4 129249.4 130476.0 16228.7 16511.9 16633.5 16714.1 16740.3 29226.4 30991.5 31619.8 31775.4 31864.5 8719.3 9023.4 9038.9 9039.2 9048.4 4041.4 4183.4 4201.6 4205.1 4309.7 5150.2 5264.1 5267.7 5269.6 5273.0 893.1 947.8 952.8 959.5 966.0 680.5 680.6 700.0 707.3 722.6 11265.7 11646.7 12001.3 12288.8 12892.7 656.4 694.7 696.1 703.0 708.0 5093.4 5395.4 5487.5 5564.6 5707.6 103160.5 105324.5 108296.5 110206.4 111721.4 95233.6 96125.5 98425.0 99682.5 104842.0 80949.0 84505.0 86498.0 87341.6 88819.0 10265.3 10291.4 10326.1 10434.6 10761.9 34009.0 35849.6 36089.0 36398.3 37715.6 44882.0 45832.8 46033.8 46583.8 47435.5 17791.4 18372.4 18392.9 18419.4 18520.9 18534.4 18546.4 18991.3 19029.9 21500.5 16769.8 17086.5 17207.7 18968.0 19716.9 18583.6 18619.2 18823.4 19244.5 19324.7 17692.6 18026.5 18198.5 18248.9 18573.8 12237.1 12853.9 13342.5 13489.3 13833.9 13711.4 14013.4 14192.8 14221.7 14420.7 18:56:30 INFO - PID 22113 | -------- Summary: end -------- 18:56:30 INFO - PID 22113 | 18:56:30 INFO - TEST-INFO | 22113: exit 0 18:56:30 INFO - TEST-OK | dromaeo_css | took 1113881ms 18:56:30 INFO - TEST-START | kraken 18:56:30 INFO - Initialising browser for kraken test... 18:56:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53396/getInfo.html -profile /tmp/tmpm7wta0/profile 18:56:30 INFO - TEST-INFO | started process 22495 (/builds/slave/test/build/application/firefox/firefox http://localhost:53396/getInfo.html) 18:56:36 INFO - TEST-INFO | 22495: exit 0 18:56:37 INFO - Browser initialized. 18:56:37 INFO - Running cycle 1/1 for kraken test... 18:56:37 INFO - TEST-INFO | started process 22727 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm7wta0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:56:48 INFO - PID 22727 | RSS: Main: 177086464 18:56:48 INFO - PID 22727 | 18:56:51 INFO - PID 22727 | Cycle 1(1): loaded http://localhost:53396/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53396/tests/kraken/driver.html?testName=audio-beat-detection) 18:56:52 INFO - PID 22727 | RSS: Main: 181231616 18:56:52 INFO - PID 22727 | 18:56:54 INFO - PID 22727 | Cycle 1(1): loaded http://localhost:53396/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53396/tests/kraken/driver.html?testName=audio-dft) 18:56:55 INFO - PID 22727 | RSS: Main: 181903360 18:56:55 INFO - PID 22727 | 18:56:58 INFO - PID 22727 | Cycle 1(1): loaded http://localhost:53396/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53396/tests/kraken/driver.html?testName=audio-fft) 18:56:59 INFO - PID 22727 | RSS: Main: 176283648 18:56:59 INFO - PID 22727 | 18:57:01 INFO - PID 22727 | Cycle 1(1): loaded http://localhost:53396/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53396/tests/kraken/driver.html?testName=audio-oscillator) 18:57:01 INFO - PID 22727 | RSS: Main: 177258496 18:57:01 INFO - PID 22727 | 18:57:03 INFO - PID 22727 | Cycle 1(1): loaded http://localhost:53396/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53396/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:57:04 INFO - PID 22727 | RSS: Main: 177291264 18:57:04 INFO - PID 22727 | 18:57:07 INFO - PID 22727 | Cycle 1(1): loaded http://localhost:53396/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53396/tests/kraken/driver.html?testName=imaging-darkroom) 18:57:08 INFO - PID 22727 | RSS: Main: 180264960 18:57:08 INFO - PID 22727 | 18:57:11 INFO - PID 22727 | Cycle 1(1): loaded http://localhost:53396/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53396/tests/kraken/driver.html?testName=imaging-desaturate) 18:57:12 INFO - PID 22727 | RSS: Main: 179449856 18:57:12 INFO - PID 22727 | 18:57:15 INFO - PID 22727 | Cycle 1(1): loaded http://localhost:53396/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53396/tests/kraken/driver.html?testName=json-parse-financial) 18:57:15 INFO - PID 22727 | RSS: Main: 180019200 18:57:15 INFO - PID 22727 | 18:57:17 INFO - PID 22727 | Cycle 1(1): loaded http://localhost:53396/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53396/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:57:18 INFO - PID 22727 | RSS: Main: 180191232 18:57:18 INFO - PID 22727 | 18:57:20 INFO - PID 22727 | Cycle 1(1): loaded http://localhost:53396/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53396/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:57:20 INFO - PID 22727 | RSS: Main: 180051968 18:57:20 INFO - PID 22727 | 18:57:22 INFO - PID 22727 | Cycle 1(1): loaded http://localhost:53396/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53396/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:57:23 INFO - PID 22727 | RSS: Main: 180641792 18:57:23 INFO - PID 22727 | 18:57:26 INFO - PID 22727 | Cycle 1(1): loaded http://localhost:53396/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:57:26 INFO - PID 22727 | RSS: Main: 180903936 18:57:26 INFO - PID 22727 | 18:57:29 INFO - PID 22727 | Cycle 1(1): loaded http://localhost:53396/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:57:30 INFO - PID 22727 | RSS: Main: 180543488 18:57:30 INFO - PID 22727 | 18:57:32 INFO - PID 22727 | Cycle 1(1): loaded http://localhost:53396/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53396/tests/kraken/driver.html?testName=ai-astar) 18:57:32 INFO - PID 22727 | RSS: Main: 182263808 18:57:32 INFO - PID 22727 | 18:57:32 INFO - PID 22727 | __start_tp_report 18:57:32 INFO - PID 22727 | _x_x_mozilla_page_load 18:57:32 INFO - PID 22727 | _x_x_mozilla_page_load_details 18:57:32 INFO - PID 22727 | |i|pagename|runs| 18:57:32 INFO - PID 22727 | |0;ai-astar;101;111;107;110;110;116;110;99;110;110 18:57:32 INFO - PID 22727 | |1;audio-beat-detection;148;120;147;181;122;145;144;118;186;120 18:57:32 INFO - PID 22727 | |2;audio-dft;164;164;165;166;163;161;165;163;165;166 18:57:32 INFO - PID 22727 | |3;audio-fft;77;75;75;143;76;74;77;89;96;76 18:57:32 INFO - PID 22727 | |4;audio-oscillator;81;81;132;81;81;81;130;81;82;128 18:57:32 INFO - PID 22727 | |5;imaging-gaussian-blur;114;115;114;114;114;124;114;114;114;117 18:57:32 INFO - PID 22727 | |6;imaging-darkroom;152;151;150;151;149;149;151;152;150;150 18:57:32 INFO - PID 22727 | |7;imaging-desaturate;94;93;93;93;94;94;94;94;94;95 18:57:32 INFO - PID 22727 | |8;json-parse-financial;55;55;55;55;62;56;59;54;54;57 18:57:32 INFO - PID 22727 | |9;json-stringify-tinderbox;54;54;54;55;55;55;54;55;55;55 18:57:32 INFO - PID 22727 | |10;stanford-crypto-aes;76;79;80;81;82;79;87;79;79;79 18:57:32 INFO - PID 22727 | |11;stanford-crypto-ccm;128;128;128;141;135;127;125;139;125;171 18:57:32 INFO - PID 22727 | |12;stanford-crypto-pbkdf2;176;176;176;178;181;178;174;176;174;176 18:57:32 INFO - PID 22727 | |13;stanford-crypto-sha256-iterative;69;72;68;72;68;67;69;68;69;68 18:57:32 INFO - PID 22727 | __end_tp_report 18:57:32 INFO - PID 22727 | __start_cc_report 18:57:32 INFO - PID 22727 | _x_x_mozilla_cycle_collect,997 18:57:32 INFO - PID 22727 | __end_cc_report 18:57:32 INFO - PID 22727 | __startTimestamp1500688652652__endTimestamp 18:57:32 INFO - PID 22727 | 18:57:32 INFO - PID 22727 | ------- Summary: start ------- 18:57:32 INFO - PID 22727 | Number of tests: 14 18:57:32 INFO - PID 22727 | 18:57:32 INFO - PID 22727 | [#0] ai-astar Cycles:10 Average:108.40 Median:110.00 stddev:4.97 (4.5%) stddev-sans-first:4.49 18:57:32 INFO - PID 22727 | Values: 101.0 111.0 107.0 110.0 110.0 116.0 110.0 99.0 110.0 110.0 18:57:32 INFO - PID 22727 | 18:57:32 INFO - PID 22727 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:146.00 stddev:24.64 (16.9%) stddev-sans-first:26.07 18:57:32 INFO - PID 22727 | Values: 148.0 120.0 147.0 181.0 122.0 145.0 144.0 118.0 186.0 120.0 18:57:32 INFO - PID 22727 | 18:57:32 INFO - PID 22727 | [#2] audio-dft Cycles:10 Average:164.20 Median:165.00 stddev:1.55 (0.9%) stddev-sans-first:1.64 18:57:32 INFO - PID 22727 | Values: 164.0 164.0 165.0 166.0 163.0 161.0 165.0 163.0 165.0 166.0 18:57:32 INFO - PID 22727 | 18:57:32 INFO - PID 22727 | [#3] audio-fft Cycles:10 Average:85.80 Median:76.50 stddev:21.36 (27.9%) stddev-sans-first:22.42 18:57:32 INFO - PID 22727 | Values: 77.0 75.0 75.0 143.0 76.0 74.0 77.0 89.0 96.0 76.0 18:57:32 INFO - PID 22727 | 18:57:32 INFO - PID 22727 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:81.00 stddev:23.62 (29.2%) stddev-sans-first:24.44 18:57:32 INFO - PID 22727 | Values: 81.0 81.0 132.0 81.0 81.0 81.0 130.0 81.0 82.0 128.0 18:57:32 INFO - PID 22727 | 18:57:32 INFO - PID 22727 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:114.00 stddev:3.17 (2.8%) stddev-sans-first:3.32 18:57:32 INFO - PID 22727 | Values: 114.0 115.0 114.0 114.0 114.0 124.0 114.0 114.0 114.0 117.0 18:57:32 INFO - PID 22727 | 18:57:32 INFO - PID 22727 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 18:57:32 INFO - PID 22727 | Values: 152.0 151.0 150.0 151.0 149.0 149.0 151.0 152.0 150.0 150.0 18:57:32 INFO - PID 22727 | 18:57:32 INFO - PID 22727 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 18:57:32 INFO - PID 22727 | Values: 94.0 93.0 93.0 93.0 94.0 94.0 94.0 94.0 94.0 95.0 18:57:32 INFO - PID 22727 | 18:57:32 INFO - PID 22727 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:55.50 stddev:2.53 (4.6%) stddev-sans-first:2.65 18:57:32 INFO - PID 22727 | Values: 55.0 55.0 55.0 55.0 62.0 56.0 59.0 54.0 54.0 57.0 18:57:32 INFO - PID 22727 | 18:57:32 INFO - PID 22727 | [#9] json-stringify-tinderbox Cycles:10 Average:54.60 Median:55.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 18:57:32 INFO - PID 22727 | Values: 54.0 54.0 54.0 55.0 55.0 55.0 54.0 55.0 55.0 55.0 18:57:32 INFO - PID 22727 | 18:57:32 INFO - PID 22727 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:79.50 stddev:2.88 (3.6%) stddev-sans-first:2.65 18:57:32 INFO - PID 22727 | Values: 76.0 79.0 80.0 81.0 82.0 79.0 87.0 79.0 79.0 79.0 18:57:32 INFO - PID 22727 | 18:57:32 INFO - PID 22727 | [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:131.50 stddev:13.98 (10.6%) stddev-sans-first:14.61 18:57:32 INFO - PID 22727 | Values: 128.0 128.0 128.0 141.0 135.0 127.0 125.0 139.0 125.0 171.0 18:57:32 INFO - PID 22727 | 18:57:32 INFO - PID 22727 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.50 Median:176.00 stddev:2.07 (1.2%) stddev-sans-first:2.19 18:57:32 INFO - PID 22727 | Values: 176.0 176.0 176.0 178.0 181.0 178.0 174.0 176.0 174.0 176.0 18:57:32 INFO - PID 22727 | 18:57:32 INFO - PID 22727 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.70 (2.5%) stddev-sans-first:1.80 18:57:32 INFO - PID 22727 | Values: 69.0 72.0 68.0 72.0 68.0 67.0 69.0 68.0 69.0 68.0 18:57:32 INFO - PID 22727 | -------- Summary: end -------- 18:57:32 INFO - PID 22727 | 18:57:33 INFO - PID 22727 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:57:33 INFO - TEST-INFO | 22727: exit 0 18:57:33 INFO - TEST-OK | kraken | took 62636ms 18:57:33 INFO - SUITE-END | took 1176s 18:57:33 INFO - Completed test suite (00:19:36) 18:57:33 INFO - javascript benchmark 18:57:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8544.487521313795, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3136.372725454908, 3154.5425913242575, 3156.352947645733, 3157.7631677624177, 3187.82466964317, 6051.939480605198, 6094.0, 6119.204503414556, 6149.969250153743, 6178.04240342747, 5996.3404025557265, 6123.540734444912, 6125.785597504088, 6138.693065346737, 6148.262208534971, 5611.130274807411, 5619.943800561993, 5664.122061080539, 5671.092625179972, 5673.659580425187, 5622.859428514279, 5695.401982791809, 5706.800261990831, 5717.085266357383, 5753.1082682184115, 5658.971705141489, 5675.772969081232, 5711.942880571203, 5716.8856622867515, 5731.083026715726, 5555.805546805883, 5566.2207290979295, 5647.519960803336, 5691.971540142315, 5741.511971482429, 5471.151971444432, 5473.151661492475, 5526.392096869341, 5526.613137080406, 5601.691906945116, 5979.073243647242, 6009.038553831366, 6046.486048685867, 6158.291796443422, 6161.0, 6548.0, 6637.0, 6644.402003819631, 6646.60120392778, 6651.434628056621, 6431.742730290783, 6572.145621069279, 6575.243846957614, 6584.440322572587, 6624.205095388536, 6144.139820425144, 6215.2541694996435, 6227.065940108974, 6238.189035425366, 6255.468285195719, 6659.200895892427, 6761.594304341756, 6764.695588698521, 6806.863862722717, 6814.454843612499, 6286.277078135981, 6413.518986076063, 6425.036244563353, 6478.093066970628, 6502.837429064311, 6413.0701048348665, 6483.286838447767, 6495.577787443801, 6509.218893732687, 6511.902321465182, 6406.327335629785, 6487.7080531376205, 6571.211454625475, 6586.27550969393, 6593.934060659332, 6552.754976554535, 6678.365555272241, 6689.632070236086, 6697.028930805006, 6698.698558564876, 5292.153255479105, 5368.1679339702405, 5374.355077390738, 5379.731013449312, 5380.623356365095, 4490.865274041784, 4511.075229577928, 4511.548845115528, 4516.661250406232, 4610.423697037871, 5658.971705141448, 5677.801276955287, 5691.288588926384, 5705.5435565154685, 5721.628094173865, 6571.0, 6575.572587781779, 6580.045893345534, 6661.134052573135, 6669.833254168685, 5596.664200148004, 5642.097264437671, 5688.488036076773, 5732.77068917247, 5733.967885780517, 5780.739866706008, 5834.124881267844, 5854.941450585525, 5864.618799778001, 5873.119032145127, 6318.968405158037, 6419.679016049179, 6443.323451037667, 6444.903326450107, 6448.999999999906, 6553.475721942138, 6557.114789503356, 6633.6351500666, 6639.170103737033, 6649.368310010541, 6245.6252624842655, 6349.365063493614, 6388.201474815648, 6389.648569328546, 6461.966085426309, 6470.935290647033, 6484.059811327425, 6513.218413790186, 6519.674016299071, 6554.377334153248, 6496.285408604956, 6578.868422631616, 6675.03212034262, 6679.265280819203, 6686.53194276396, 6217.440430361289, 6322.0, 6341.048842673636, 6406.295307516077, 6444.420002199825, 6391.424771770563, 6423.0, 6485.221773387224, 6488.675566221765, 6499.122618446639, 6256.405641464054, 6267.122602835698, 6329.968350158404, 6356.841078973062, 6359.96820015897, 6382.489400848014, 6384.936150638434, 6394.4564712, 6414.518911081781, 6448.935510645021, 6206.100115483139, 6208.0998255253635, 6216.658083805434, 6220.688965551795, 6233.96883015582], "value": 6005.155124587697, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [787.9921200787994, 827.3257295304327, 846.8475674378611, 858.570714642679, 1177.8586569611648, 32326.353472930557, 32754.508682369753, 32858.342833143324, 43972.780136099274, 44656.106877862425, 44269.33595996063, 44520.77739611305, 44540.3318950216, 44541.55458445415, 44569.55430445694, 7786.7663970080985, 7909.0, 7952.522848629072, 7987.5606841623685, 7987.920120798804, 7711.4216433767415, 7932.762017139495, 7934.365250779923, 7937.920620793805, 7938.722144724936, 7797.142314345418, 7875.803104922394, 7881.7241396551135, 7911.2088791121005, 7912.327452166573, 7782.0661520617605, 7819.944307518526, 7845.76462706114, 7875.724349647792, 7882.448228623999, 7775.377969762406, 7792.142864284924, 7841.96079019607, 7842.0, 7844.37245020397, 40209.39685904714, 40613.79693101515, 40620.39069413961, 40747.38878916819, 40789.18421631551, 3532.205253817896, 3575.945096196628, 3576.409892367756, 3577.3203091412806, 3587.820608969541, 32798.18004549881, 32868.34263314744, 32877.671223287936, 32960.0, 32988.6701132988, 4864.659473836833, 4869.780859861315, 4901.754912254373, 4917.483664215241, 4954.083494553483, 190076.0, 190700.0, 190835.0, 190953.0, 190977.0, 50999.0, 51037.0, 51139.744301279, 51264.23103653448, 51422.0, 52522.73738631282, 52540.0, 52786.20820687693, 52823.0, 53036.469635303925, 16377.508674739776, 16715.331386744394, 16719.0, 16745.07902065374, 16795.664086718196, 12329.691757706129, 12442.253464792142, 13573.660658483617, 13629.522966696119, 13920.234387108807, 14945.103293802407, 15071.4724984625, 15181.696366072616, 15204.16377099248, 15242.618934526725, 5773.336066352424, 5787.797427090031, 5873.442023007808, 5930.466258036711, 5947.851303717442, 987.5309228116587, 991.7371896447447, 1010.4796030044533, 1035.5547114740584, 1044.749260177567, 22862.085516579482, 28965.42069158605, 29651.258718532208, 29772.851135744182, 30222.0, 1060.1162260259134, 1089.2375337263948, 1091.4215465803138, 1099.115212254143, 1106.9723256918642, 16434.424795132352, 16560.17199140038, 16706.49880503587, 16887.96225172817, 17019.659606807796, 221527.0, 225081.0, 239620.0, 240372.0, 241164.0, 60552.39447605555, 61004.0, 61013.08480372798, 61031.6948415264, 61354.69322653358, 1450.5285782120852, 1479.5931118942162, 1482.762757958743, 1487.2712370938161, 1487.9479218227527, 27645.447091057664, 28189.0, 28401.0, 28423.573646394907, 28469.288267793472, 57760.71119644375, 58906.41093589009, 58977.70511147417, 58981.0, 59001.40998590131, 219633.0, 221253.0, 221804.0, 221961.0, 222184.0, 39889.80055099706, 40097.39853902136, 40098.79950600345, 40167.799161004004, 40685.59314406818, 49569.0, 49948.0, 50141.0, 50350.24474632957, 50465.24302135398, 33945.3210935775, 35202.59189632386, 36035.27929441449, 36329.81835090808, 36667.26665466729, 34150.65849341475, 35091.64908350884, 35387.64612353947, 35949.1012724684, 36009.459858101625, 40151.1969760609, 40153.0, 40161.799191003855, 40173.0, 40532.79733601313, 34718.65281347255, 34771.304573908885, 34814.0, 35472.82263588665, 35604.0, 24884.626730598695, 25732.8713356432, 25966.740332597186, 25994.74005259923, 26512.602310965736], "value": 18475.016468621976, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.7708916433426, 577.4427677291413, 580.4891695308128, 587.6914619824591, 612.3019757476476, 22322.10262127719, 23185.884070579665, 23210.4197395065, 23217.76782232177, 23247.186348477808, 24220.515589688195, 26723.465530689373, 26740.732592674067, 26803.19590412286, 26907.192784216506, 6431.067495213203, 6588.802335929906, 6599.736010559572, 6603.834904127411, 6613.735450581971, 6317.652529110897, 6489.578177418476, 6515.51133664977, 6523.119378883861, 6599.208095028604, 6540.215174179081, 6556.18047744032, 6566.0, 6576.539642225046, 6599.67001649918, 6582.5063120265695, 6616.106825578533, 6620.337966203389, 6621.205455345389, 6621.735130594794, 6092.908606370908, 6092.939070609282, 6110.602810817282, 6112.786052488142, 6129.356417576135, 29078.559656395104, 29644.70355296441, 29995.250118746986, 30130.0, 30180.24549386261, 1911.8661693681447, 1934.8258656720964, 1958.3635318521538, 1958.8530860185401, 1958.921643134273, 18160.364387246384, 18825.811741882542, 18884.716729249074, 18933.76930499513, 18936.43190704281, 2240.4286906838815, 2308.3956650128166, 2352.2002519143575, 2357.163207061503, 2357.3752955466816, 127337.0, 133386.0, 133476.0, 133764.6623533762, 134146.0, 13512.93243533776, 15003.249837508081, 15075.54773356801, 15265.313060912285, 15478.0, 23378.53242935132, 23515.941782619822, 23620.645690314657, 23658.171963981524, 23673.40816479602, 9940.850887236697, 10036.899631003742, 10202.327162221594, 10240.262304258891, 10264.332818366782, 9261.120193581599, 9350.251979841596, 9413.388129771543, 9454.101860323259, 9464.19554337889, 7844.725434609875, 9098.0, 9274.860877086849, 9289.489078100634, 9309.0, 2549.541082605149, 2582.9354266143496, 2660.2418310781336, 2666.546776965197, 2715.8506282154276, 955.460165006769, 962.3359881681617, 964.3827950111934, 976.9706908792748, 983.7098056073332, 19729.802701973083, 19789.60420791576, 19808.90095549513, 19842.801571984095, 20692.068856901475, 1015.5886865819355, 1016.3089099412323, 1036.2849633752687, 1055.039913678564, 1055.2613170780485, 10839.891601084046, 11011.61459348919, 11056.74315388565, 11217.71955701114, 11278.436078196057, 437860.0, 439615.0, 455117.0, 461532.0, 470446.0, 116947.41526292314, 119399.0, 122474.0, 122519.38740306241, 124318.37840810738, 1261.6656586004717, 1278.6931136527353, 1327.4889167670517, 1328.1168023264613, 1331.2345401394236, 19827.900860495603, 20530.38408847737, 20736.688949665466, 20776.851016307402, 21543.78456215418, 55369.0, 57213.42786572081, 57436.71281643565, 57798.42201578098, 57962.71018645049, 70220.0, 71140.64429677819, 71158.0, 71245.0, 71471.28528714646, 14993.17537535446, 15124.243787810785, 15249.542513724606, 15252.0, 15253.08481491114, 23448.413789655395, 23691.644625330977, 23709.407264818517, 23773.167939122046, 23925.16261930824, 18585.34951276699, 18800.153993070617, 18872.716909246647, 18890.33883814115, 18892.905535472233, 15867.444639437565, 16049.0, 16661.50015499537, 16663.416780412626, 17384.913075434542, 18934.337298194496, 19108.140133694294, 19375.8062419374, 19420.028998549733, 20490.385288440775, 15201.847981520043, 15268.541943741706, 15294.694106117593, 15303.387864485296, 15312.464063757716, 18129.45611631653, 19070.237190512224, 19095.427137185907, 19098.7135192975, 19349.806501935363], "value": 12077.220057358656, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.8099066130742, 1427.1651084115792, 1437.3316407870345, 1439.7192547453237, 1441.956741297761, 13160.802587961189, 13534.593962181138, 14049.929750351259, 14138.0, 14168.57494275172, 13612.591622251324, 13839.930800345985, 13902.09636373635, 13913.58259252224, 13924.0, 2688.301041729145, 2718.320419895026, 2726.5910113482937, 2728.3315587681045, 2749.0, 2538.3019669590826, 2748.1343376836335, 2749.175247425774, 2766.2669392610874, 2766.4467106578763, 2650.7084220735705, 2672.1048448769684, 2689.4352186040855, 2696.298962269814, 2697.878595463199, 2611.3962731430693, 2633.6839579250423, 2634.9341266468396, 2643.2466746977116, 2648.0, 2496.151308555082, 2508.5986242201343, 2523.6719226500622, 2532.037825626269, 2536.606825941982, 13380.397882095232, 13495.190288582717, 13710.314484275847, 13716.148319976875, 13738.175709457464, 7551.24487551246, 7849.843003139905, 7875.251851074138, 7877.369810415153, 7878.606069696492, 5145.279660847485, 5260.079486089957, 5304.0, 5309.65487243328, 5358.303420555342, 1859.3864024871896, 1874.3158747057225, 1905.5236190952262, 1936.0513348459294, 1949.541857663448, 21045.789542104383, 22972.54054918909, 23051.962661680096, 23166.073357065867, 23185.652215216785, 5950.196723442366, 6585.209774827052, 6758.256591774901, 6772.153480814898, 6870.175578930561, 16099.597510062342, 16102.03387796736, 16131.677366452604, 16131.758023629654, 16149.0, 7411.703531858773, 7740.303372696371, 7747.147813740484, 7750.883736743954, 7753.418493613001, 7011.0, 7095.0421693070775, 7096.858062838714, 7138.607376594233, 7143.285671432919, 5088.847334579968, 5136.743162841918, 5155.072087024297, 5169.431362550116, 5238.790448382022, 1473.3517252408906, 1508.1554329575254, 1516.2039929037344, 1522.0259034218109, 1539.4842727686128, 874.0, 884.5930871798915, 896.7533928169805, 931.8415869302235, 935.1677007463363, 7458.5151965122095, 8332.250097491255, 8416.0, 8617.612207450555, 8635.050144484101, 964.5563041001218, 968.6948611187454, 989.8416253399565, 1009.9646512372032, 1032.7934413117407, 4839.346688197048, 5144.074066668036, 5147.253648220987, 5149.6910185389, 5251.973740131351, 17460.214290356966, 18275.177617007266, 19085.904570477058, 19179.32872349461, 19185.136668849937, 16528.504144875675, 17720.291188352323, 18137.274509019757, 18168.1824317906, 18176.545586360182, 10550.577976880839, 10781.245312828027, 10790.67627971162, 10794.73013174677, 10816.296940698829, 7627.8855817161675, 7653.119891212582, 8084.717034903751, 8374.83250335002, 8460.619272132892, 15407.97000525316, 15700.528984130495, 15879.12664803447, 16364.181790910645, 16730.749038764672, 15883.0, 16474.341026358812, 16559.17204139764, 16667.0, 16670.416535421202, 10724.946375268073, 10909.127269818237, 10926.836097458385, 10952.835707464235, 10957.890421096006, 12154.574589889311, 12289.631311060682, 12374.443150058449, 12440.626781196217, 12470.5011799527, 9983.550740216562, 10432.165426765689, 10487.580496780043, 10563.419011954416, 10570.947145264532, 9646.469444180637, 10169.745756356151, 10210.285280030326, 10312.690619281433, 10352.844707329547, 9025.954870225607, 9281.953590232275, 9367.484788336435, 9368.765780855261, 9370.437773733598, 6444.226692796894, 6771.492138089565, 6849.4177994871, 6991.091158149408, 7052.259512751088, 6836.521443499107, 6861.279565645735, 6961.6519174042105, 7044.577325360495, 7110.217876033736], "value": 6328.154325704063, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.5304413850982, 499.77305714470975, 526.6839896062365, 528.8915772266686, 533.586470485374, 6154.507639388849, 6176.166217560639, 6184.598001129923, 6197.659128747922, 6218.564700470969, 5895.263092113486, 6017.51859851212, 6075.939240607592, 6083.543734219929, 6086.573939824214, 5059.671121377108, 5067.113255180328, 5088.1350170471105, 5156.175011998081, 5176.818811341604, 4916.746229711419, 5040.924386134193, 5139.0, 5145.30538377318, 5146.9485305146845, 5079.720615366154, 5082.974585127069, 5083.389993200821, 5117.923231151536, 5123.257127716479, 5130.153524668425, 5132.923006154911, 5137.2037334213255, 5146.691198528063, 5185.585153187736, 4751.976240118812, 4788.736619485927, 4799.424069111694, 4817.590504807095, 4834.879128021792, 5995.7901473448655, 6024.87885297498, 6092.116643086772, 6092.421219984139, 6096.390360963913, 5863.296404431496, 5894.882102357972, 5897.203877476529, 5930.940690593082, 5957.612755170943, 6492.577982431127, 6498.0, 6515.674216289167, 6526.934730652728, 6542.345765423467, 5138.332016837825, 5166.4575219601775, 5256.50063243995, 5282.366116066059, 5283.1546952487415, 6766.120404347453, 6774.593524388552, 6838.63227354531, 6850.725970961155, 6850.897236541456, 5398.0, 5409.29679141709, 5417.783288668409, 5430.348358197041, 5457.890842183214, 5410.648307860055, 5429.484199001088, 5453.672779633234, 5487.451254874561, 5495.477929596682, 5834.824955251349, 5888.205092312569, 5894.322152952465, 5924.0379810094955, 5935.465808077293, 6387.393197646216, 6418.229812422539, 6426.0, 6445.677716114175, 6524.347565243438, 1806.2774890043825, 1843.8524918006526, 1867.1971052447577, 1881.8212269834344, 1931.94204173875, 1393.881520070785, 1401.6355747505722, 1413.300416293941, 1453.2488351536374, 1466.7166229549146, 5575.358833734092, 5604.719764011783, 5612.97193514038, 5627.352854421794, 5683.715814209273, 6470.1588793457495, 6621.635810030398, 6636.6726654669255, 6656.900146497806, 6722.9663851680425, 5553.972230138905, 5657.971710141423, 5669.659820410789, 5673.517750991129, 5706.42935706426, 3525.629808870032, 3529.3823830573865, 3532.3994920863515, 3575.1955809943074, 3599.0, 6348.365163483615, 6365.809025729235, 6393.136926514954, 6497.252815926229, 6531.281559028503, 6717.462602991749, 6746.561473504305, 6780.525363224626, 6848.828779280459, 6853.657317134123, 6314.842128946813, 6414.454771344394, 6420.1974753155855, 6448.258450278278, 6489.383508566679, 6639.2696803352555, 6653.301403352578, 6672.499562532732, 6683.283300283184, 6721.663916804238, 6485.708143133665, 6561.0, 6581.276059633532, 6612.0, 6648.675662168916, 6391.548563775509, 6424.261209960914, 6446.129772480655, 6458.257300410513, 6520.869582608227, 4947.233178857283, 4963.627727920348, 4968.552830245295, 5007.974960125176, 5009.198528235464, 6307.747690092345, 6601.9009714853355, 6608.5374023819795, 6635.435987940886, 6688.799336019927, 6020.608660437058, 6265.843353916189, 6336.809895703136, 6355.618662880242, 6400.199975003125, 6375.4262116409745, 6377.92954601084, 6406.807795766134, 6441.68253349516, 6481.0926470295135, 6189.84525386869, 6323.557350985387, 6360.519397435097, 6367.363263673596, 6385.584936979081, 6423.518236132402, 6447.2263328400895, 6459.483241340776, 6478.1578394808375, 6501.642409667514, 6155.322914479493, 6157.722902469489, 6179.196704428576, 6199.752009919553, 6224.315325314121], "value": 5105.931397023799, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [898.2140626951417, 913.9360244782864, 924.0528458330207, 928.986065209022, 933.0249888866134, 17506.387276445326, 18839.24643014281, 18847.1518781655, 18864.434066977978, 20010.399688009384, 20533.589328213464, 21383.67924481134, 21713.457163570918, 21854.235101771443, 21856.235031773893, 966.5747071288628, 994.9502524873727, 995.7261753017906, 998.5606333213362, 1000.7948370584013, 1021.0963297481708, 1057.2070946789909, 1070.4968664727567, 1071.8660167479065, 1071.9464026798669, 1099.8570185875824, 1105.9778804423906, 1107.3245320354577, 1107.8338249262595, 1110.6945589962784, 1103.906167975723, 1104.845321654969, 1105.950232239551, 1107.545906178463, 1108.3239224073309, 808.6522795198063, 811.525257724232, 812.2364976921675, 812.475953010311, 812.6424373275739, 19268.710969335472, 19765.30821421258, 19800.207991680316, 19865.10607022673, 20082.79917200824, 19967.30114446002, 20104.79895201044, 20451.693224601495, 20455.28406505765, 20817.791822081886, 15512.14683192424, 15543.455979040793, 15553.300101495346, 15659.217039147998, 16999.83000169995, 3496.7727097738566, 3515.824208789576, 3523.3834079036064, 3539.94690079649, 3542.6634469725336, 121460.39269803683, 123773.38113309376, 127466.362668187, 129249.35375323064, 130476.0, 16228.675426491403, 16511.926724762852, 16633.50099497017, 16714.08072555997, 16740.330386784393, 29226.41547169087, 30991.535126973115, 31619.84190079035, 31775.364492710018, 31864.522032169534, 8719.346049046348, 9023.4134781239, 9038.86441703375, 9039.23166530839, 9048.366614336934, 4041.373587094005, 4183.414321994923, 4201.579842015835, 4205.11692544563, 4309.741415515079, 5150.150225212873, 5264.052470555337, 5267.683938963674, 5269.604779641542, 5272.9736351318, 893.097971049245, 947.7820101376722, 952.7713348796239, 959.5058544849409, 966.0387914025589, 680.4794332335767, 680.608650026227, 699.9545029573061, 707.2997732245143, 722.6350692900052, 11265.662030139109, 11646.650600481998, 12001.279923204636, 12288.754224915452, 12892.742145157044, 656.4420242793587, 694.6630884021246, 696.1159327653952, 703.0438603499236, 707.9681414336367, 5093.414257360451, 5395.3525576931015, 5487.533559647474, 5564.638298510665, 5707.600467967285, 103160.48419757854, 105324.47337763416, 108296.45851770691, 110206.44896775625, 111721.44139279414, 95233.63711277797, 96125.51937240269, 98425.0, 99682.50158749305, 104842.0, 80949.0, 84505.0, 86498.0, 87341.56329218441, 88818.9999999987, 10265.281430299807, 10291.382517049002, 10326.122279606017, 10434.582616695247, 10761.892381076403, 34009.0, 35849.64150358463, 36089.0, 36398.27203455863, 37715.62284377121, 44882.0, 45832.77083614694, 46033.76983115063, 46583.76708116438, 47435.52564474311, 17791.377301794375, 18372.448826535227, 18392.908035460274, 18419.447416577525, 18520.907395462935, 18534.44396668102, 18546.350877719215, 18991.33530326432, 19029.904850475657, 21500.462488437915, 16769.832301676826, 17086.48740537786, 17207.655846882742, 18968.0, 19716.901415493405, 18583.628327433646, 18619.162137703566, 18823.435296941112, 19244.518887027378, 19324.710129348354, 17692.646147077245, 18026.459206223833, 18198.45404637863, 18248.908755456137, 18573.81426185721, 12237.143399961917, 12853.871461285267, 13342.533011344945, 13489.2580908051, 13833.930830345784, 13711.382987765375, 14013.439462421797, 14192.787108193592, 14221.715565688835, 14420.711585768435], "value": 8987.920373897448, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 107.0, 110.0, 110.0, 116.0, 110.0, 99.0, 110.0, 110.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 120.0, 147.0, 181.0, 122.0, 145.0, 144.0, 118.0, 186.0, 120.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 166.0, 163.0, 161.0, 165.0, 163.0, 165.0, 166.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 143.0, 76.0, 74.0, 77.0, 89.0, 96.0, 76.0], "value": 85.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 132.0, 81.0, 81.0, 81.0, 130.0, 81.0, 82.0, 128.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 124.0, 114.0, 114.0, 114.0, 117.0], "value": 115.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 150.0, 151.0, 149.0, 149.0, 151.0, 152.0, 150.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 62.0, 56.0, 59.0, 54.0, 54.0, 57.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 55.0, 55.0, 54.0, 55.0, 55.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 80.0, 81.0, 82.0, 79.0, 87.0, 79.0, 79.0, 79.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 128.0, 141.0, 135.0, 127.0, 125.0, 139.0, 125.0, 171.0], "value": 134.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 176.0, 176.0, 178.0, 181.0, 178.0, 174.0, 176.0, 174.0, 176.0], "value": 176.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 68.0, 72.0, 68.0, 67.0, 69.0, 68.0, 69.0, 68.0], "value": 69.0, "unit": "score"}]}]} 18:57:33 INFO - Return code: 0 18:57:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:57:33 INFO - # TBPL SUCCESS # 18:57:33 INFO - Running post-action listener: _package_coverage_data 18:57:33 INFO - Running post-action listener: _resource_record_post_action 18:57:33 INFO - [mozharness: 2017-07-22 01:57:33.925509Z] Finished run-tests step (success) 18:57:33 INFO - Running post-run listener: _resource_record_post_run 18:57:34 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 437309440; Read time: 12; Write time: 313960 18:57:34 INFO - TinderboxPrint: CPU usage
13.2% 18:57:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:57:34 INFO - TinderboxPrint: I/O write bytes / time
437,309,440 / 313,960 18:57:34 INFO - TinderboxPrint: CPU idle
8,273.1 (86.8%) 18:57:34 INFO - TinderboxPrint: CPU user
1,203.2 (12.6%) 18:57:34 INFO - TinderboxPrint: Swap in / out
0 / 0 18:57:34 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107450368; Read time: 0; Write time: 91380 18:57:34 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:57:34 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 329859072; Read time: 0; Write time: 222580 18:57:34 INFO - Running post-run listener: _upload_blobber_files 18:57:34 INFO - Blob upload gear active. 18:57:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:57:34 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 18:57:34 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'] 18:57:34 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 18:57:34 INFO - (blobuploader) - INFO - Open directory for files ... 18:57:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:57:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:57:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:57:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:57:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:57:35 INFO - (blobuploader) - INFO - Done attempting. 18:57:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:57:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:57:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:57:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:57:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:57:36 INFO - (blobuploader) - INFO - Done attempting. 18:57:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:57:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:57:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:57:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:57:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:57:37 INFO - (blobuploader) - INFO - Done attempting. 18:57:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:57:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:57:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:57:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:57:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:57:40 INFO - (blobuploader) - INFO - Done attempting. 18:57:40 INFO - (blobuploader) - INFO - Iteration through files over. 18:57:40 INFO - Return code: 0 18:57:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:57:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:57:40 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e22435d7223efd3bc85e4bad7c41f281ce7dcdddeb204006b3f114a7d1d0ef0c1992735da1eb24c8e1694d5c18cf64625a577584001aa9e72feb8b17f4b820a1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6351781a415569a242094e22588e14e926d809c9de45681cb294c108884012fabf1d233713f4cda81d97ac81bbc47fb144dba22fabee3769bccd93cb46bb68c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bedd26f9156e7d8c56e52f523c35983bd14e0f0b7cfb43a30b8d0e45177f6284cf1bffacd7164b4f627c1188300bba925ca47159ec88a63904e7894c737c9ae8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30a07d4f9b72d61757ffe885102e10f820d1525df6dffb1cb303f7a6218cf9c23bc637a0afd0da2ac4ab0cbbd47538d4b1c0ee42045980213113c348909fdfa6"} 18:57:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:57:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:57:40 INFO - Contents: 18:57:40 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e22435d7223efd3bc85e4bad7c41f281ce7dcdddeb204006b3f114a7d1d0ef0c1992735da1eb24c8e1694d5c18cf64625a577584001aa9e72feb8b17f4b820a1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6351781a415569a242094e22588e14e926d809c9de45681cb294c108884012fabf1d233713f4cda81d97ac81bbc47fb144dba22fabee3769bccd93cb46bb68c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bedd26f9156e7d8c56e52f523c35983bd14e0f0b7cfb43a30b8d0e45177f6284cf1bffacd7164b4f627c1188300bba925ca47159ec88a63904e7894c737c9ae8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30a07d4f9b72d61757ffe885102e10f820d1525df6dffb1cb303f7a6218cf9c23bc637a0afd0da2ac4ab0cbbd47538d4b1c0ee42045980213113c348909fdfa6"} 18:57:40 INFO - Running post-run listener: copy_logs_to_upload_dir 18:57:40 INFO - Copying logs to upload dir... 18:57:40 INFO - mkdir: /builds/slave/test/build/upload/logs 18:57:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.583590 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-21 18:57:40.518866) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-21 18:57:40.522308) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e22435d7223efd3bc85e4bad7c41f281ce7dcdddeb204006b3f114a7d1d0ef0c1992735da1eb24c8e1694d5c18cf64625a577584001aa9e72feb8b17f4b820a1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6351781a415569a242094e22588e14e926d809c9de45681cb294c108884012fabf1d233713f4cda81d97ac81bbc47fb144dba22fabee3769bccd93cb46bb68c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bedd26f9156e7d8c56e52f523c35983bd14e0f0b7cfb43a30b8d0e45177f6284cf1bffacd7164b4f627c1188300bba925ca47159ec88a63904e7894c737c9ae8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30a07d4f9b72d61757ffe885102e10f820d1525df6dffb1cb303f7a6218cf9c23bc637a0afd0da2ac4ab0cbbd47538d4b1c0ee42045980213113c348909fdfa6"} build_url:https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/Y8YpW8kQQ-CotAK7YQIfmQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e22435d7223efd3bc85e4bad7c41f281ce7dcdddeb204006b3f114a7d1d0ef0c1992735da1eb24c8e1694d5c18cf64625a577584001aa9e72feb8b17f4b820a1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a6351781a415569a242094e22588e14e926d809c9de45681cb294c108884012fabf1d233713f4cda81d97ac81bbc47fb144dba22fabee3769bccd93cb46bb68c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bedd26f9156e7d8c56e52f523c35983bd14e0f0b7cfb43a30b8d0e45177f6284cf1bffacd7164b4f627c1188300bba925ca47159ec88a63904e7894c737c9ae8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30a07d4f9b72d61757ffe885102e10f820d1525df6dffb1cb303f7a6218cf9c23bc637a0afd0da2ac4ab0cbbd47538d4b1c0ee42045980213113c348909fdfa6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-21 18:57:40.550726) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-21 18:57:40.551492) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1500684205.121726-1442466402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004371 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-21 18:57:40.632125) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-21 18:57:40.632474) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-21 18:57:40.632815) ========= ========= Total master_lag: 0.34 =========